builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0225 starttime: 1477756370.1 results: success (0) buildid: 20161029062122 builduid: 8b06b869042d4d7ebb666c6374145c2d revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 08:52:50.099770) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-29 08:52:50.100183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 08:52:50.100466) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-29 08:52:50.125177) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 08:52:50.125453) ========= 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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-29 08:52:50-- 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% 19.1M=0.001s 2016-10-29 08:52:50 (19.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140057 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 08:52:50.287829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 08:52:50.288143) ========= 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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.024381 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 08:52:50.336914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 08:52:50.337264) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1b170b39ed6bdbde366233ab84594bdaaa960a5a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1b170b39ed6bdbde366233ab84594bdaaa960a5a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F2c0lzCSKs/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.xRM2v7l5fa/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-29 08:52:50,423 truncating revision to first 12 chars 2016-10-29 08:52:50,424 Setting DEBUG logging. 2016-10-29 08:52:50,424 attempt 1/10 2016-10-29 08:52:50,424 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1b170b39ed6b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-29 08:52:51,502 unpacking tar archive at: mozilla-central-1b170b39ed6b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.338415 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-29 08:52:51.698794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 08:52:51.699187) ========= script_repo_revision: 1b170b39ed6bdbde366233ab84594bdaaa960a5a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-29 08:52:51.699630) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 08:52:51.699893) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-29 08:52:51.718655) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-29 08:52:51.718925) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.F2c0lzCSKs/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.xRM2v7l5fa/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 08:52:51 INFO - MultiFileLogger online at 20161029 08:52:51 in /builds/slave/test 08:52:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:52:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:51 INFO - {'append_to_log': False, 08:52:51 INFO - 'base_work_dir': '/builds/slave/test', 08:52:51 INFO - 'blob_upload_branch': 'Firefox', 08:52:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:51 INFO - 'branch': 'Firefox', 08:52:51 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:51 INFO - 'config_files': ('talos/mac_config.py',), 08:52:51 INFO - 'default_actions': ('clobber', 08:52:51 INFO - 'read-buildbot-config', 08:52:51 INFO - 'download-and-extract', 08:52:51 INFO - 'populate-webroot', 08:52:51 INFO - 'create-virtualenv', 08:52:51 INFO - 'install', 08:52:51 INFO - 'run-tests'), 08:52:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:51 INFO - 'download_minidump_stackwalk': True, 08:52:51 INFO - 'download_symbols': 'ondemand', 08:52:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:51 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:51 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:51 INFO - 'installer_path': 'installer.exe', 08:52:51 INFO - 'log_level': 'info', 08:52:51 INFO - 'log_name': 'talos', 08:52:51 INFO - 'log_to_console': True, 08:52:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:52:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:52:51 INFO - 'opt_config_files': (), 08:52:51 INFO - 'pip_index': False, 08:52:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:51 INFO - 'cmd': ('bash', 08:52:51 INFO - '-c', 08:52:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:51 INFO - 'enabled': True, 08:52:51 INFO - 'halt_on_failure': False, 08:52:51 INFO - 'name': 'check_screen_resolution'},), 08:52:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:51 INFO - 'cmd': ('bash', 08:52:51 INFO - '-c', 08:52:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:51 INFO - 'enabled': True, 08:52:51 INFO - 'halt_on_failure': False, 08:52:51 INFO - 'name': 'check_screen_resolution'},), 08:52:51 INFO - 'run_cmd_checks_enabled': True, 08:52:51 INFO - 'sps_profile': False, 08:52:51 INFO - 'sps_profile_interval': 0, 08:52:51 INFO - 'suite': 'dromaeojs', 08:52:51 INFO - 'system_bits': '32', 08:52:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:51 INFO - 'title': 't-yosemite-r7-0225', 08:52:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:51 INFO - 'use_talos_json': True, 08:52:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:51 INFO - 'work_dir': 'build'} 08:52:51 INFO - [mozharness: 2016-10-29 15:52:51.927458Z] Running clobber step. 08:52:51 INFO - Running pre-action listener: _resource_record_pre_action 08:52:51 INFO - Running main action method: clobber 08:52:51 INFO - rmtree: /builds/slave/test/build 08:52:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:52:53 INFO - Running post-action listener: _resource_record_post_action 08:52:53 INFO - [mozharness: 2016-10-29 15:52:53.938040Z] Finished clobber step (success) 08:52:53 INFO - [mozharness: 2016-10-29 15:52:53.938171Z] Running read-buildbot-config step. 08:52:53 INFO - Running pre-action listener: _resource_record_pre_action 08:52:53 INFO - Running main action method: read_buildbot_config 08:52:53 INFO - Using buildbot properties: 08:52:53 INFO - { 08:52:53 INFO - "project": "", 08:52:53 INFO - "product": "firefox", 08:52:53 INFO - "script_repo_revision": "production", 08:52:53 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:52:53 INFO - "repository": "", 08:52:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:52:53 INFO - "buildid": "20161029062122", 08:52:53 INFO - "pgo_build": "False", 08:52:53 INFO - "basedir": "/builds/slave/test", 08:52:53 INFO - "buildnumber": 20, 08:52:53 INFO - "slavename": "t-yosemite-r7-0225", 08:52:53 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:52:53 INFO - "platform": "yosemite_r7", 08:52:53 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:52:53 INFO - "branch": "mozilla-central", 08:52:53 INFO - "repo_path": "mozilla-central", 08:52:53 INFO - "revision": "1b170b39ed6bdbde366233ab84594bdaaa960a5a", 08:52:53 INFO - "stage_platform": "macosx64", 08:52:53 INFO - "builduid": "8b06b869042d4d7ebb666c6374145c2d", 08:52:53 INFO - "slavebuilddir": "test" 08:52:53 INFO - } 08:52:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 08:52:53 INFO - Running post-action listener: _resource_record_post_action 08:52:53 INFO - [mozharness: 2016-10-29 15:52:53.941286Z] Finished read-buildbot-config step (success) 08:52:53 INFO - [mozharness: 2016-10-29 15:52:53.941396Z] Running download-and-extract step. 08:52:53 INFO - Running pre-action listener: _resource_record_pre_action 08:52:53 INFO - Running main action method: download_and_extract 08:52:53 INFO - mkdir: /builds/slave/test/build/tests 08:52: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')]} 08:52:53 INFO - trying https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 08:52:53 INFO - Downloading https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 08:52:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 08:52:54 INFO - Downloaded 1199 bytes. 08:52:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 08:52:54 INFO - Using the following test package requirements: 08:52:54 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:52:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:52:54 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 08:52:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:52:54 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 08:52:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:52:54 INFO - u'jsshell-mac.zip'], 08:52:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:52:54 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 08:52:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 08:52:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:52:54 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 08:52:54 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:52:54 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 08:52:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:52:54 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 08:52:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 08:52:54 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 08:52:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:52:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:52:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:52:54 INFO - Fetch https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:52:55 INFO - Http code: 200 08:52:55 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 08:52:55 INFO - x-amz-cf-id: ji_RIMh22wQS9abqeh0IbBPVaFii0K2L0SJdCeoaipd7g9Yyl-dQ3A== 08:52:55 INFO - x-amz-version-id: riL0RovImF8I4TNNXrHzg2rdnF7KbNcS 08:52:55 INFO - Expected file size: 16391695 08:52:55 INFO - Obtained file size: 16391695 08:53:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:53:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 08:53:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:53:02 INFO - Fetch https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 08:53:03 INFO - Http code: 200 08:53:03 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 08:53:03 INFO - x-amz-cf-id: V4JDgmvlDsFNuw-MUIHKCaXu2jh2EkgHp-Qam7NwDhtsSVKRKbYQHA== 08:53:03 INFO - x-amz-version-id: riL0RovImF8I4TNNXrHzg2rdnF7KbNcS 08:53:03 INFO - Expected file size: 16391695 08:53:03 INFO - Obtained file size: 16391695 08:53:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 08:53:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:53:09 INFO - Fetch https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 08:53:11 INFO - Http code: 200 08:53:11 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 08:53:11 INFO - x-amz-cf-id: 1gfbcLegUqwuVbbfhE1BdWaf61eu11GAXSJ_ji4XpI0kjtiYwjQWhw== 08:53:11 INFO - x-amz-version-id: whW4IDo7th2As4EQ7.znchiQO8wJ8QtC 08:53:11 INFO - Expected file size: 14409038 08:53:11 INFO - Obtained file size: 14409038 08:53:11 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')]} 08:53:11 INFO - trying https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:53:11 INFO - Downloading https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 08:53:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 08:53:14 INFO - Downloaded 112035635 bytes. 08:53:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:53:14 INFO - mkdir: /builds/slave/test/properties 08:53:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:14 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:14 INFO - Contents: 08:53:14 INFO - build_url:https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 08:53:15 INFO - Running post-action listener: _resource_record_post_action 08:53:15 INFO - Running post-action listener: set_extra_try_arguments 08:53:15 INFO - [mozharness: 2016-10-29 15:53:15.395408Z] Finished download-and-extract step (success) 08:53:15 INFO - [mozharness: 2016-10-29 15:53:15.395529Z] Running populate-webroot step. 08:53:15 INFO - Running pre-action listener: _resource_record_pre_action 08:53:15 INFO - Running main action method: populate_webroot 08:53:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:15 INFO - '--tppagecycles', 08:53:15 INFO - '7'], 08:53:15 INFO - 'tests': ['tsvgm']}}, 08:53:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:53:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:53:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['damp', 'tps']}, 08:53:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'tests': ['damp', 'tps']}, 08:53:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['dromaeo_dom']}, 08:53:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['basic_compositor_video']}, 08:53:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:53:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['a11yr', 08:53:15 INFO - 'ts_paint', 08:53:15 INFO - 'tpaint', 08:53:15 INFO - 'sessionrestore', 08:53:15 INFO - 'sessionrestore_no_auto_restore', 08:53:15 INFO - 'tabpaint']}, 08:53:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['tsvgx', 08:53:15 INFO - 'tsvgr_opacity', 08:53:15 INFO - 'tart', 08:53:15 INFO - 'tscrollx', 08:53:15 INFO - 'cart']}, 08:53:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:53:15 INFO - 'tsvgr_opacity', 08:53:15 INFO - 'tart', 08:53:15 INFO - 'tscrollx', 08:53:15 INFO - 'cart']}, 08:53:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'talos_options': ['--disable-e10s'], 08:53:15 INFO - 'tests': ['tp5o']}, 08:53:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'tests': ['tp5o']}, 08:53:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'talos_options': ['--disable-e10s', 08:53:15 INFO - '--xperf_path', 08:53:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:15 INFO - 'tests': ['tp5n']}, 08:53:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:53:15 INFO - 'talos_options': ['--xperf_path', 08:53:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:15 INFO - 'tests': ['tp5n']}}, 08:53:15 INFO - 'talos.zip': {'path': '', 08:53:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:15 INFO - Running post-action listener: _resource_record_post_action 08:53:15 INFO - [mozharness: 2016-10-29 15:53:15.414559Z] Finished populate-webroot step (success) 08:53:15 INFO - [mozharness: 2016-10-29 15:53:15.414671Z] Running create-virtualenv step. 08:53:15 INFO - Running pre-action listener: _resource_record_pre_action 08:53:15 INFO - Running main action method: create_virtualenv 08:53:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:15 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 08:53:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:15 INFO - Using real prefix '/tools/python27' 08:53:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:19 INFO - Installing pip.................done. 08:53:19 INFO - Return code: 0 08:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:53:19 INFO - Reading from file tmpfile_stdout 08:53:19 INFO - Output received: 08:53:19 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) 08:53:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53:19 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')]} 08:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:19 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')]} 08:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:19 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 0x10e05a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccf8571d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6ed30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de66b20>, '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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 08:53:19 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 08:53:19 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 08:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F2c0lzCSKs/Render', 08:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:19 INFO - 'HOME': '/Users/cltbld', 08:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:19 INFO - 'LOGNAME': 'cltbld', 08:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:19 INFO - 'MOZ_NO_REMOTE': '1', 08:53:19 INFO - 'NO_EM_RESTART': '1', 08:53:19 INFO - 'PAGER': '/bin/cat', 08:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:19 INFO - 'PWD': '/builds/slave/test', 08:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:19 INFO - 'SHELL': '/bin/bash', 08:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRM2v7l5fa/Listeners', 08:53:19 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:19 INFO - 'USER': 'cltbld', 08:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:19 INFO - 'XPC_FLAGS': '0x0', 08:53:19 INFO - 'XPC_SERVICE_NAME': '0', 08:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:19 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 08:53:19 INFO - Cleaning up... 08:53:19 INFO - Return code: 0 08:53:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:53:19 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')]} 08:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:19 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')]} 08:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:19 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 0x10e05a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccf8571d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6ed30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de66b20>, '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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 08:53:19 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 08:53:19 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 08:53:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F2c0lzCSKs/Render', 08:53:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:19 INFO - 'HOME': '/Users/cltbld', 08:53:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:19 INFO - 'LOGNAME': 'cltbld', 08:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:19 INFO - 'MOZ_NO_REMOTE': '1', 08:53:19 INFO - 'NO_EM_RESTART': '1', 08:53:19 INFO - 'PAGER': '/bin/cat', 08:53:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:19 INFO - 'PWD': '/builds/slave/test', 08:53:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:19 INFO - 'SHELL': '/bin/bash', 08:53:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRM2v7l5fa/Listeners', 08:53:19 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:53:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:19 INFO - 'USER': 'cltbld', 08:53:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:19 INFO - 'XPC_FLAGS': '0x0', 08:53:19 INFO - 'XPC_SERVICE_NAME': '0', 08:53:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:19 INFO - Downloading/unpacking psutil>=3.1.1 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:23 INFO - Installing collected packages: psutil 08:53:23 INFO - Running setup.py install for psutil 08:53:23 INFO - building 'psutil._psutil_osx' extension 08:53:23 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 08:53:23 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 08:53:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:53:24 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 08:53:24 INFO - building 'psutil._psutil_posix' extension 08:53:24 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 08:53:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:53:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:53:24 INFO - ^ 08:53:24 INFO - 1 warning generated. 08:53:24 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 08:53:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:24 INFO - Successfully installed psutil 08:53:24 INFO - Cleaning up... 08:53:24 INFO - Return code: 0 08:53:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e05a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccf8571d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6ed30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de66b20>, '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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 08:53:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:53:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:53:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F2c0lzCSKs/Render', 08:53:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:24 INFO - 'HOME': '/Users/cltbld', 08:53:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:24 INFO - 'LOGNAME': 'cltbld', 08:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:24 INFO - 'MOZ_NO_REMOTE': '1', 08:53:24 INFO - 'NO_EM_RESTART': '1', 08:53:24 INFO - 'PAGER': '/bin/cat', 08:53:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:24 INFO - 'PWD': '/builds/slave/test', 08:53:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:24 INFO - 'SHELL': '/bin/bash', 08:53:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRM2v7l5fa/Listeners', 08:53:24 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:53:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:24 INFO - 'USER': 'cltbld', 08:53:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:24 INFO - 'XPC_FLAGS': '0x0', 08:53:24 INFO - 'XPC_SERVICE_NAME': '0', 08:53:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:53:24 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 08:53:24 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 08:53:24 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 08:53:24 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 08:53:24 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 08:53:24 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 08:53:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:53:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:53:27 INFO - Installing collected packages: mozsystemmonitor 08:53:27 INFO - Running setup.py install for mozsystemmonitor 08:53:27 INFO - Successfully installed mozsystemmonitor 08:53:27 INFO - Cleaning up... 08:53:27 INFO - Return code: 0 08:53:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:53:27 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')]} 08:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:27 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')]} 08:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:27 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 0x10e05a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccf8571d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6ed30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de66b20>, '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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 08:53:27 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 08:53:27 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 08:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F2c0lzCSKs/Render', 08:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:27 INFO - 'HOME': '/Users/cltbld', 08:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:27 INFO - 'LOGNAME': 'cltbld', 08:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:27 INFO - 'MOZ_NO_REMOTE': '1', 08:53:27 INFO - 'NO_EM_RESTART': '1', 08:53:27 INFO - 'PAGER': '/bin/cat', 08:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:27 INFO - 'PWD': '/builds/slave/test', 08:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:27 INFO - 'SHELL': '/bin/bash', 08:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRM2v7l5fa/Listeners', 08:53:27 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:27 INFO - 'USER': 'cltbld', 08:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:27 INFO - 'XPC_FLAGS': '0x0', 08:53:27 INFO - 'XPC_SERVICE_NAME': '0', 08:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:27 INFO - Downloading/unpacking jsonschema==2.5.1 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:30 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:30 INFO - warning: no files found matching '*.txt' 08:53:30 INFO - no previously-included directories found matching 'build' 08:53:30 INFO - no previously-included directories found matching 'dist' 08:53:30 INFO - no previously-included directories found matching '.git*' 08:53:30 INFO - Installing collected packages: jsonschema, functools32 08:53:31 INFO - Running setup.py install for functools32 08:53:31 INFO - warning: no files found matching '*.txt' 08:53:31 INFO - no previously-included directories found matching 'build' 08:53:31 INFO - no previously-included directories found matching 'dist' 08:53:31 INFO - no previously-included directories found matching '.git*' 08:53:31 INFO - Successfully installed jsonschema functools32 08:53:31 INFO - Cleaning up... 08:53:31 INFO - Return code: 0 08:53:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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', '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 0x10e05a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccf8571d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6ed30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de66b20>, '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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 08:53: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:53: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 functools32==3.2.3-2 08:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F2c0lzCSKs/Render', 08:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:31 INFO - 'HOME': '/Users/cltbld', 08:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:31 INFO - 'LOGNAME': 'cltbld', 08:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:31 INFO - 'MOZ_NO_REMOTE': '1', 08:53:31 INFO - 'NO_EM_RESTART': '1', 08:53:31 INFO - 'PAGER': '/bin/cat', 08:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:31 INFO - 'PWD': '/builds/slave/test', 08:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:31 INFO - 'SHELL': '/bin/bash', 08:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRM2v7l5fa/Listeners', 08:53:31 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:31 INFO - 'USER': 'cltbld', 08:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:31 INFO - 'XPC_FLAGS': '0x0', 08:53:31 INFO - 'XPC_SERVICE_NAME': '0', 08:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:53:31 INFO - Cleaning up... 08:53:31 INFO - Return code: 0 08:53:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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', '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 0x10e05a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccf8571d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6ed30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de66b20>, '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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 08:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:53: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 blobuploader==1.2.4 08:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F2c0lzCSKs/Render', 08:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:31 INFO - 'HOME': '/Users/cltbld', 08:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:31 INFO - 'LOGNAME': 'cltbld', 08:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:31 INFO - 'MOZ_NO_REMOTE': '1', 08:53:31 INFO - 'NO_EM_RESTART': '1', 08:53:31 INFO - 'PAGER': '/bin/cat', 08:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:31 INFO - 'PWD': '/builds/slave/test', 08:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:31 INFO - 'SHELL': '/bin/bash', 08:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRM2v7l5fa/Listeners', 08:53:31 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:31 INFO - 'USER': 'cltbld', 08:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:31 INFO - 'XPC_FLAGS': '0x0', 08:53:31 INFO - 'XPC_SERVICE_NAME': '0', 08:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:31 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:34 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 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 08:53:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:35 INFO - Downloading docopt-0.6.1.tar.gz 08:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:35 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:35 INFO - Running setup.py install for blobuploader 08:53:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:35 INFO - Running setup.py install for requests 08:53:36 INFO - Running setup.py install for docopt 08:53:36 INFO - Successfully installed blobuploader requests docopt 08:53:36 INFO - Cleaning up... 08:53:36 INFO - Return code: 0 08:53:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:36 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')]} 08:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:36 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')]} 08:53:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:36 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 0x10e05a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccf8571d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6ed30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de66b20>, '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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 08:53:36 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 08:53:36 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 08:53:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F2c0lzCSKs/Render', 08:53:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:36 INFO - 'HOME': '/Users/cltbld', 08:53:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:36 INFO - 'LOGNAME': 'cltbld', 08:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:36 INFO - 'MOZ_NO_REMOTE': '1', 08:53:36 INFO - 'NO_EM_RESTART': '1', 08:53:36 INFO - 'PAGER': '/bin/cat', 08:53:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:36 INFO - 'PWD': '/builds/slave/test', 08:53:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:36 INFO - 'SHELL': '/bin/bash', 08:53:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRM2v7l5fa/Listeners', 08:53:36 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:53:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:36 INFO - 'USER': 'cltbld', 08:53:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:36 INFO - 'XPC_FLAGS': '0x0', 08:53:36 INFO - 'XPC_SERVICE_NAME': '0', 08:53:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:36 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-WT8zam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:36 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-fJt_Vb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:36 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-HK0IwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:36 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-ZSpCkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:37 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-w2G3Rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:37 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-n8JDpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:37 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-2YIZQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:37 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-pUDftL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:37 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Yg2SM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:37 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-0OpK03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:37 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-SKKBWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:37 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-cGwH7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:37 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-OVyo93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:38 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-6vFDgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:38 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-U0qMRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:38 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Ue_5qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:38 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-PjNiVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:38 INFO - Running setup.py install for manifestparser 08:53:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:38 INFO - Running setup.py install for mozcrash 08:53:38 INFO - Running setup.py install for mozdebug 08:53:38 INFO - Running setup.py install for mozdevice 08:53:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Running setup.py install for mozfile 08:53:39 INFO - Running setup.py install for mozhttpd 08:53:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Running setup.py install for mozinfo 08:53:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Running setup.py install for mozInstall 08:53:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Running setup.py install for mozleak 08:53:39 INFO - Running setup.py install for mozlog 08:53:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Running setup.py install for moznetwork 08:53:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Running setup.py install for mozprocess 08:53:40 INFO - Running setup.py install for mozprofile 08:53:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Running setup.py install for mozrunner 08:53:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Running setup.py install for mozscreenshot 08:53:40 INFO - Running setup.py install for moztest 08:53:40 INFO - Running setup.py install for mozversion 08:53:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:40 INFO - Cleaning up... 08:53:41 INFO - Return code: 0 08:53:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:41 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')]} 08:53:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:41 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')]} 08:53:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:41 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 0x10e05a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccf8571d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6ed30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de66b20>, '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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 08:53:41 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 08:53:41 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 08:53:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F2c0lzCSKs/Render', 08:53:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:41 INFO - 'HOME': '/Users/cltbld', 08:53:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:41 INFO - 'LOGNAME': 'cltbld', 08:53:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:41 INFO - 'MOZ_NO_REMOTE': '1', 08:53:41 INFO - 'NO_EM_RESTART': '1', 08:53:41 INFO - 'PAGER': '/bin/cat', 08:53:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:41 INFO - 'PWD': '/builds/slave/test', 08:53:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:41 INFO - 'SHELL': '/bin/bash', 08:53:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRM2v7l5fa/Listeners', 08:53:41 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:53:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:41 INFO - 'USER': 'cltbld', 08:53:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:41 INFO - 'XPC_FLAGS': '0x0', 08:53:41 INFO - 'XPC_SERVICE_NAME': '0', 08:53:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:41 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Z2i1tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:41 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-Frfh21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:41 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-r6y2FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:41 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-k2MLyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:41 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-6AsymS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:41 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-_JNKuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:41 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-PbW8hI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:42 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-xJQFW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:42 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-NBuvzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:42 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-nMTv9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:42 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-uo63Tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:42 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-wlemFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:42 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-DnlwfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:42 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-aQ3nhX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:42 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-S8Pgi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:42 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-9cTSYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:42 INFO - Running setup.py (path:/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/pip-o82X2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:43 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)) 08:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:43 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)) 08:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:43 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 08:53:43 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 08:53:43 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 08:53:43 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 08:53:43 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 08:53:43 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 08:53:45 INFO - Downloading blessings-1.6.tar.gz 08:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:45 INFO - Installing collected packages: blessings 08:53:45 INFO - Running setup.py install for blessings 08:53:45 INFO - Successfully installed blessings 08:53:45 INFO - Cleaning up... 08:53:46 INFO - Return code: 0 08:53:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:46 INFO - Reading from file tmpfile_stdout 08:53:46 INFO - Current package versions: 08:53:46 INFO - blessings == 1.6 08:53:46 INFO - blobuploader == 1.2.4 08:53:46 INFO - docopt == 0.6.1 08:53:46 INFO - functools32 == 3.2.3-2 08:53:46 INFO - jsonschema == 2.5.1 08:53:46 INFO - manifestparser == 1.1 08:53:46 INFO - mozInstall == 1.12 08:53:46 INFO - mozcrash == 0.17 08:53:46 INFO - mozdebug == 0.1 08:53:46 INFO - mozdevice == 0.48 08:53:46 INFO - mozfile == 1.2 08:53:46 INFO - mozhttpd == 0.7 08:53:46 INFO - mozinfo == 0.9 08:53:46 INFO - mozleak == 0.1 08:53:46 INFO - mozlog == 3.4 08:53:46 INFO - moznetwork == 0.27 08:53:46 INFO - mozprocess == 0.23 08:53:46 INFO - mozprofile == 0.28 08:53:46 INFO - mozrunner == 6.12 08:53:46 INFO - mozscreenshot == 0.1 08:53:46 INFO - mozsystemmonitor == 0.3 08:53:46 INFO - moztest == 0.7 08:53:46 INFO - mozversion == 1.4 08:53:46 INFO - psutil == 3.1.1 08:53:46 INFO - requests == 1.2.3 08:53:46 INFO - wsgiref == 0.1.2 08:53:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:46 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')]} 08:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:46 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')]} 08:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:46 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 0x10e05a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccf8571d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6ed30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de66b20>, '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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 08:53:46 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 08:53:46 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 08:53:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F2c0lzCSKs/Render', 08:53:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:46 INFO - 'HOME': '/Users/cltbld', 08:53:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:46 INFO - 'LOGNAME': 'cltbld', 08:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:46 INFO - 'MOZ_NO_REMOTE': '1', 08:53:46 INFO - 'NO_EM_RESTART': '1', 08:53:46 INFO - 'PAGER': '/bin/cat', 08:53:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:46 INFO - 'PWD': '/builds/slave/test', 08:53:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:46 INFO - 'SHELL': '/bin/bash', 08:53:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRM2v7l5fa/Listeners', 08:53:46 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:53:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:46 INFO - 'USER': 'cltbld', 08:53:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:46 INFO - 'XPC_FLAGS': '0x0', 08:53:46 INFO - 'XPC_SERVICE_NAME': '0', 08:53:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:46 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)) 08:53:46 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)) 08:53:46 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)) 08:53:46 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)) 08:53:46 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)) 08:53:46 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)) 08:53:46 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)) 08:53:46 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)) 08:53:46 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)) 08:53:46 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)) 08:53:46 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)) 08:53:46 INFO - Cleaning up... 08:53:46 INFO - Return code: 0 08:53:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53:46 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')]} 08:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e05a490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dfd0570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccf8571d60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de6ed30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de66b20>, '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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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 08:53:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:53:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:53:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F2c0lzCSKs/Render', 08:53:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:47 INFO - 'HOME': '/Users/cltbld', 08:53:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:47 INFO - 'LOGNAME': 'cltbld', 08:53:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:47 INFO - 'MOZ_NO_REMOTE': '1', 08:53:47 INFO - 'NO_EM_RESTART': '1', 08:53:47 INFO - 'PAGER': '/bin/cat', 08:53:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:47 INFO - 'PWD': '/builds/slave/test', 08:53:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:47 INFO - 'SHELL': '/bin/bash', 08:53:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRM2v7l5fa/Listeners', 08:53:47 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:53:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:47 INFO - 'USER': 'cltbld', 08:53:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:47 INFO - 'XPC_FLAGS': '0x0', 08:53:47 INFO - 'XPC_SERVICE_NAME': '0', 08:53:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:47 INFO - Cleaning up... 08:53:47 INFO - Return code: 0 08:53:47 INFO - Running post-action listener: _resource_record_post_action 08:53:47 INFO - Running post-action listener: _start_resource_monitoring 08:53:47 INFO - Starting resource monitoring. 08:53:47 INFO - [mozharness: 2016-10-29 15:53:47.998943Z] Finished create-virtualenv step (success) 08:53:47 INFO - [mozharness: 2016-10-29 15:53:47.999958Z] Running install step. 08:53:48 INFO - Running pre-action listener: _resource_record_pre_action 08:53:48 INFO - Running main action method: install 08:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:48 INFO - Reading from file tmpfile_stdout 08:53:48 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:48 INFO - Reading from file tmpfile_stdout 08:53:48 INFO - Output received: 08:53:48 INFO - Usage: mozinstall [options] installer 08:53:48 INFO - Options: 08:53:48 INFO - -h, --help show this help message and exit 08:53:48 INFO - -d DEST, --destination=DEST 08:53:48 INFO - Directory to install application into. [default: 08:53:48 INFO - "/builds/slave/test"] 08:53:48 INFO - --app=APP Application being installed. [default: firefox] 08:53:48 INFO - mkdir: /builds/slave/test/build/application 08:53:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:53:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:54:23 INFO - Reading from file tmpfile_stdout 08:54:23 INFO - Output received: 08:54:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:54:23 INFO - Running post-action listener: _resource_record_post_action 08:54:23 INFO - [mozharness: 2016-10-29 15:54:23.009564Z] Finished install step (success) 08:54:23 INFO - [mozharness: 2016-10-29 15:54:23.009681Z] Running run-tests step. 08:54:23 INFO - Running pre-action listener: _resource_record_pre_action 08:54:23 INFO - Running main action method: run_tests 08:54:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:54:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:54:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:54:23 INFO - 2016-10-29 08:54:23.024 screenresolution[1641:7605] starting screenresolution argv=screenresolution get 08:54:23 INFO - 2016-10-29 08:54:23.026 screenresolution[1641:7605] Display 0: 1600x1200x32@60 08:54:23 INFO - 2016-10-29 08:54:23.032 screenresolution[1642:7607] starting screenresolution argv=screenresolution list 08:54:23 INFO - Available Modes on Display 0 08:54:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:54:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:54:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:54:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:54:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:54:23 INFO - Intel Iris: 08:54:23 INFO - Chipset Model: Intel Iris 08:54:23 INFO - Type: GPU 08:54:23 INFO - Bus: Built-In 08:54:23 INFO - VRAM (Dynamic, Max): 1536 MB 08:54:23 INFO - Vendor: Intel (0x8086) 08:54:23 INFO - Device ID: 0x0a2e 08:54:23 INFO - Revision ID: 0x0009 08:54:23 INFO - Displays: 08:54:23 INFO - Display: 08:54:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:54:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:54:23 INFO - Display Serial Number: 1600x1200 60 08:54:23 INFO - Main Display: Yes 08:54:23 INFO - Mirror: Off 08:54:23 INFO - Online: Yes 08:54:23 INFO - Rotation: Supported 08:54:23 INFO - Return code: 0 08:54:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:23 INFO - Python 2.7.3 08:54:23 INFO - Return code: 0 08:54:23 INFO - grabbing minidump binary from tooltool 08:54:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:23 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 0x10de6ed30>, '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 0x10dc94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de66b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:23 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 08:54:23 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 08:54:23 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 08:54:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:23 INFO - Return code: 0 08:54:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:54:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:54:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--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 08:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0225 --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 08:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.F2c0lzCSKs/Render', 08:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:23 INFO - 'HOME': '/Users/cltbld', 08:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:23 INFO - 'LOGNAME': 'cltbld', 08:54:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:23 INFO - 'MOZ_NO_REMOTE': '1', 08:54:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:23 INFO - 'NO_EM_RESTART': '1', 08:54:23 INFO - 'PAGER': '/bin/cat', 08:54:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:23 INFO - 'PWD': '/builds/slave/test', 08:54:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:23 INFO - 'SHELL': '/bin/bash', 08:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xRM2v7l5fa/Listeners', 08:54:23 INFO - 'TMPDIR': '/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/', 08:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:23 INFO - 'USER': 'cltbld', 08:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:23 INFO - 'XPC_FLAGS': '0x0', 08:54:23 INFO - 'XPC_SERVICE_NAME': '0', 08:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0225', '--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 08:54:23 INFO - mozversion application_buildid: 20161029062122 08:54:23 INFO - mozversion application_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 08:54:23 INFO - mozversion application_display_name: Nightly 08:54:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:23 INFO - mozversion application_name: Firefox 08:54:23 INFO - mozversion application_remotingname: firefox 08:54:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:54:23 INFO - mozversion application_vendor: Mozilla 08:54:23 INFO - mozversion application_version: 52.0a1 08:54:23 INFO - mozversion platform_buildid: 20161029062122 08:54:23 INFO - mozversion platform_changeset: 1b170b39ed6bdbde366233ab84594bdaaa960a5a 08:54:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:54:23 INFO - mozversion platform_version: 52.0a1 08:54:23 INFO - using testdate: 1477756463 08:54:23 INFO - actual date: 1477756463 08:54:23 INFO - starting webserver on 'localhost:49274' 08:54:23 INFO - SUITE-START | Running 2 tests 08:54:23 INFO - TEST-START | dromaeo_css 08:54:23 INFO - operating with platform_type : mac_ 08:54:23 INFO - Initialising browser for dromaeo_css test... 08:54:23 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpmdRTcB/profile http://localhost:49274/getInfo.html) 08:54:26 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 08:54:26 INFO - PROCESS | 1652 | colorDepth:24 08:54:26 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 08:54:26 INFO - PROCESS | 1652 | __metrics 08:54:26 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:54:26 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:27 INFO - TEST-INFO | 1652: exit 0 08:54:27 INFO - Browser initialized. 08:54:27 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:27 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpmdRTcB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:39 INFO - PROCESS | 1654 | RSS: Main: 241233920 08:54:39 INFO - PROCESS | 1654 | 08:55:30 INFO - PROCESS | 1654 | 1477756530649 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] 08:57:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 08:57:45 INFO - PROCESS | 1654 | RSS: Main: 345927680 08:57:45 INFO - PROCESS | 1654 | 09:00:48 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 09:00:48 INFO - PROCESS | 1654 | RSS: Main: 374394880 09:00:48 INFO - PROCESS | 1654 | 09:03:51 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 09:03:51 INFO - PROCESS | 1654 | RSS: Main: 340226048 09:03:51 INFO - PROCESS | 1654 | 09:06:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 09:06:54 INFO - PROCESS | 1654 | RSS: Main: 344719360 09:06:54 INFO - PROCESS | 1654 | 09:09:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 09:09:58 INFO - PROCESS | 1654 | RSS: Main: 327524352 09:09:58 INFO - PROCESS | 1654 | 09:13:01 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 09:13:02 INFO - PROCESS | 1654 | RSS: Main: 424783872 09:13:02 INFO - PROCESS | 1654 | 09:13:02 INFO - PROCESS | 1654 | __start_tp_report 09:13:02 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 09:13:02 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 09:13:02 INFO - PROCESS | 1654 | |i|pagename|runs| 09:13:02 INFO - PROCESS | 1654 | |0;dojo.html;3239.7732158748895;3247.2855971686226;3267.722243609294;3273.4598791199455;3295.1103202135423;5470.5623550116;5524.08852539331;5580.693061881595;5596.132599447087;5628.971855140724;5567.387587365387;5567.805126820562;5582.86042848929;5591.440855914407;5599.440055994409;5058.468860769631;5086.79652813887;5102.846914592549;5128.076946149691;5176.430592634807;5122;5122.743862806863;5205.687658740469;5212.921806172892;5225.581953443715;5129.28190053391;5135.794568217267;5141.922871156917;5146.099432599299;5170.612204084689;5203.4016088149965;5205.6616319939085;5219.739013049332;5226.5818734501145;5268.710220937847;5014.423341315759;5040.445550989388;5093.567046801027;5145.408278048035;5164.14791559396;4596.540345965377;5496;5558.944410555883;5582.553395728332;5591.7483713233005;6084.9351363511205;6093.817185484442;6097.69511524422;6098.32918378978;6099.725512351954;6026.3672314406795;6103.35914728956;6135.661410523283;6159.630422174639;6196.163517925068;5629.971850140723;5665.065264231397;5668.433156684298;5679.488846003879;5733.140028995684;6268.968655156787;6316.936830631635;6320.71556779946;6329.715162817684;6329.810105696836;4644.349791029259;5811.651300921873;5907.1434641976675;5957.344692083867;5976.073708575178;6019.157317975487;6095.015197869788;6105.48103411215;6114.908276375858;6123.679189354777;6094.360092190256;6105.755769769248;6112.41229444207;6112.633242005494;6117.480014198754;6116.302340284626;6131.96934015327;6149.754009839646;6156.199694039746;6161.199044124325;4693.037927224911;4794.232922732346;4818.229083346648;4820.34925285082;4855.44162421319;4350.2387082260475;4385.473743150842;4387.407699960529;4405.757683327448;4414.867553973386;5599.552035837123;5630.85922851932;5638.35158956717;5642;5642.830715078472;6021.217241758543;6122.479589234876;6223;6235.314115447297;6252.531060170414;4772.284157376422;5476.658218736435;5568.164775283659;5644.435556444405;5647.435256474402;4555.362249285103;5280;5324.121519949243;5336.519713225828;5352.170413585901;6342.270638876496;6350.809475715736;6367.936320636734;6371.23545174582;6374.808755737243;5980.34216236205;6081.179040829431;6089.421504957022;6142.017277235621;6191.721372538156;6292.528060395397;6343.048542718445;6343.492520598249;6358.364163583605;6392.712327945161;6037.275526936795;6048.758049677964;6050.878982420415;6054.243219597551;6054.727537260922;5944.970275148597;5995.130706047686;6111.938880611137;6198.659073750987;6206.131141640084;5857.033589457862;5910.290765108214;5991.580589358703;6012.158297838394;6044.153818465506;5923.822285331447;5979.073243647242;5987.940120598738;5988.101784732151;5997.16039754426;5649.180868773922;5756.934967031113;5812.854678632899;5820.76716931318;5841.386654401226;5888.440598143169;5911.7635294587735;5946.286445626552;5975.701214939322;6032.276126864629;5805.65166090019;5830;5833.008388574038;5842.152887831156;5892.351841297368 09:13:02 INFO - PROCESS | 1654 | |1;ext.html;478.6745013390894;485.3859867267907;509.4777852700983;531.5242857642412;532.5233915645497;31871.72513099476;32353.029409117706;33346.66653333466;41017.58982410175;41783.37324940128;42559;42959;42980.785096074556;43135.784321078354;43378;8163.714270000552;9476.715698529055;9661;9674.806503869919;9675.854862177073;8632.870506942401;8846.292296616255;9406.717798466023;9466.432014079177;11834.467448964817;11621.186516943817;11676.708082297968;11683.474243659013;11703.765924681502;11810.881891181065;11613.593524226611;11672.591459298968;11675.416229188506;11733.765324693544;11753.4710938008;8545;8797.516136612483;11308.264962777475;11656.358900260482;11673.533058677644;41121;41499;41528.75413737593;41541;41687.374689379685;3329.9833500832583;3422.8973130805866;3543.273628906068;3571.4464258040043;3776.169242766587;30189;30621.693783062106;31347.37305253882;31900.361992760016;32045;3236.4012657658172;3323.4848598467033;3352.128446603876;3390.4575267957007;3415.112070861569;445665;448234;448937;449116;450541;55574.49744284551;62836;63234.36765632285;63305;63333.36666633367;65661.67169164124;65728.34271657222;65776.67111664507;65805.34194657992;65938.67030664816;16178.919105404633;16449.342026319053;16469.505914822574;16479;16479.34082636705;11377.601783937687;12562.371881405894;12644.30456324911;12651.620451386472;12655.177413468095;16460.341586336413;17059.65880682404;18986.525336866413;19553.511162221057;19556.511087222647;6887.380135787803;7523.172451030382;8007.279344858991;8048.678052877819;8051.2351326623875;874.9825003500022;876.027609353617;939.4598106089027;950.5912457643279;976.2434113561904;28704.569431458545;30376.240593984887;30457.543136852964;30485.695143048728;30681.926132585253;1045.639254457211;1072.1155047086186;1088.2436706488913;1145.2899202494507;1197.9041676665845;12453.626391208278;15598.454054108051;15645.765313520305;15653.217339132998;16057.839421605868;639914;647203;647285;648710;691039;39639;56883;57348;57473.13790293149;60922;1365.487942021742;1393.888488920884;1407.6551244945053;1409.0911362171341;1409.1263416681722;30326.090217293517;30667.693323067375;31513;31974.52038219475;32226.516602251453;51169;51801.481985179664;51894.74052629713;51895.96208075742;51937;530265.578753691;532016;532237;535362;535745;25842.06184536205;25891.611625826004;25927.092551760597;26103.73896261089;26278.868605656848;46653.30020049634;47269.81825454391;48279.275810862164;48479.5152048475;48686.26970595373;39486;39674.60325396824;39760.80119599384;39912.401313980896;40925;34194.316113678084;39039.024024399616;39529.407058893565;39680.04799280016;40618.79690601528;38249.426258605585;38957;39140.41289380719;39263.41104883372;39362.409563855996;32461;32766;34151.829240853636;34191;34758.82620586881;25142.371440714127;25354.98580056851;25615;25737.485250295264;25986.774899217427 09:13:02 INFO - PROCESS | 1654 | |2;jquery.html;353.9185987222937;371.6506483905129;377.5050798836607;384.7057001393934;402.4044414266885;15220.923895380522;15368.385264589417;17572.91213543932;20584.485387865312;21227;19262.51843703908;19272.807271927275;20424.795752042475;21105.788942110576;21369.893150534226;4880.414350277953;5649.689267090298;5897.587168898179;5967.582269241155;5968.432998865101;5179.09970416566;5698.430156984289;5945.16767652529;5958.493528050121;5965.4929331006915;3740.308043012038;3955.4462375267485;5676.716164191795;5935.9703201483935;5973.342932277446;5828.737706803162;5983.790567330166;6030.969845150768;6046.425589568984;6062.939370606282;5851.882962340729;5854.18041474194;5859.736311865933;5863.296404431453;5864.530837532987;13281;13316.73366532664;13450.798238026437;13561.593152205449;13566.321683915765;2073.3054426767053;2158.3093410108613;2229.944251393712;2349.271725765001;2479.2066538707622;9642.807143857153;9991.800163996752;11052.447377631086;11786.057115430745;14487.275636218252;1865.2445759467437;1878.3613571385658;1959.3925882976323;1982.8413726901958;2017.5460521382718;114625.28062079076;121226.57308397975;122179;122385;128220;10930.836037459445;11173.83239251412;11347.773044539063;11407.581398835488;11625.360605166798;14419.927900360432;14424;14456;14466.132032078109;14471.638209044859;8180.9181908181345;8433.451825631315;8502.787430314167;8596.097409772008;8606;8374.623141958626;8383.329333653293;8420.326373890073;8585.570721463902;8588.141185881486;4372.846950356722;4516.322551617218;4539.364488971547;4543.409356783597;4574.8562859285175;1624.6677724265987;1756.9912150439166;1879.6052828906084;1962.4210857796984;1982.1080513768861;731.5537522111508;736.6169591812335;825.2655136928139;845.3110714767445;1018.2719355660738;19815.900920495595;22315.218967336066;22486.325410237718;22565.66151507729;23313.88343058308;808.7978005498626;880.7269746378515;907.5280853955906;962.6678795815433;989.1987490133015;11095.16786241019;11547.826782598268;11614.6515604532;11625.12811539121;11689.240199387013;333339;409750;431064;551994;592878;78971;115514;146277.78972048993;152302.47697522884;152306.82323769917;944.3436811416;947.6683160893632;1003.8243307421318;1023.4626820918928;1029.0995379043336;18595.72106418432;19867.403977880687;19888.105035273158;19888.70166947526;20562;47416.65041918508;53632.73183634057;56072.439275606725;56699.433005669416;56761;76174.61912690401;81434.77847832406;81856;83112.16887831286;84925.452236433;7930.246626570467;8120.106788253405;8226.629801659059;8285.50286982759;8354;11303.71740706456;12969.805452918024;13020.544280950122;13399.196048237138;13436.059475836988;10727.570897164338;11156.330620162817;11348.262362946381;11582.594609188638;11624.88375116238;10930.453477325942;11211.412348048547;11252.887471125185;11644.184907056764;11735;11144.777104458028;11568.595099171489;11583.536658533902;11915.880841191478;11934.820977685167;8145.714899978472;8156.143604921398;8170.101288858102;8230.259276665129;8274;8379.45533540318;11165;11347.489362978851;11636.06911447099;11772.17594768358 09:13:02 INFO - PROCESS | 1654 | |3;mootools.html;1530.556138719771;1550.3178601415377;1762.8237176282373;1844.1424737497061;1920.3950755512003;8097.149799271073;8475.576221188947;8486.53324067176;8492.575371231436;8513.361497887652;7482.887756683641;7755.650995705193;8023.117457079731;8236.876446853303;8239.958800206006;2284.4060544258527;2312.3756585721844;2313.9652905206435;2322.814174866007;2323.0475505042937;2297.322289924468;2316.8378213524975;2343.238447504568;2343.4492894169944;2346.8239882008834;2279.225063478417;2281.269993602048;2300.804431623306;2303.3550605830396;2303.6890019847356;2268.773122687718;2269.795718385345;2293.1973809166825;2293.9218567273356;2293.9770602294097;2231.3529076567775;2289.3360925331635;2290.209877592228;2293.3693234360517;2294.105298933417;8379.790505237357;8430.494170349799;8451.915480845235;8452.57737113148;8461.53461559614;5058.0895438821;5207.297014902978;5210.811459187113;5210.947890521084;5218.66078704883;3210.662880397548;3318.3363327334628;3559.626239244868;3560.3769340365334;3564.91087722809;944.8331310831118;1029.7065336379171;1030.6032177611598;1053.8788039375418;1071.6731396923935;10754.139668826554;10763.461826908702;10824.783504329947;10839.620613278497;10842.295250808673;4421.602055814928;4514.322851572225;4590.42619672541;4612.0545288215835;4682.063587282557;9431;9433.90566094344;9443.102905223992;9449;9450.771399717993;5228.980348831941;5236;5239.318888544465;5240.816571419982;5251.264822924793;4293.69944103916;4412.42638457005;4639.350490931272;4782.33047373368;4790.952090479051;3328.5340052392685;3686.8525258989876;3701.5373078365205;3728.3848165053005;3815.618438156162;1078.4014871746099;1255.8838357367865;1267.3979859566632;1268.0616343905444;1279.5009946120833;760.3157158557343;851.4933614499487;897.9102089790969;901.6528636475005;933.9626414943326;5400.270963419888;5526.861828454321;5645.604807663506;5846.0061789495885;5852.853678658068;911.7447114807865;981.6417007792247;991.9931269761054;1002.2332915319786;1008.7478130467383;3494.5107684924133;3708.35103856824;3829.659619133281;3853.845846166122;3885.553161386477;9642.566084526214;10100.848487272697;10113.898861011443;10121.848172277421;10147.188224941987;9485.525723713787;9918.702438926844;9931.851022234672;10066.245031622657;10070;7618.961905190438;7846.5292082475235;7853.41099417546;7865.252800983897;7865.842683146305;5544.1960915666195;5584.0507113789945;5617.213590097308;5687.687177205294;5930.584859059824;9227.861582076408;9311.76720581991;9381.812363752822;9404.059594040542;9414.95292523533;9217.078292170729;9510.47692376926;9597.616095356387;9603.951980240054;9609.087136722;6641.867162656817;6848.931510684829;6897.206821215424;7188.820279493055;7371.115466144097;7744.7676569703;7874.3306818918745;8003.6398362075015;8091.433599647969;8094.554799486084;7167;7268.709251629875;7282.1625513064555;7322.853542929005;7428.517146385468;6963.7562685305775;7072.292770722886;7078.964605176941;7163.820904477429;7255.4921155518605;6570.047343135314;6664.8000559983275;6703.966480167568;6711.530192886451;6741.056252124608;4691.765411729468;4778.136526754499;4837.395325584302;4855.732934688626;4918.360613120271;4787.138315103315;4809.134355815987;4860.222364421676;4939.185034469272;4951.628627852998 09:13:02 INFO - PROCESS | 1654 | |4;prototype.html;301.58532018474597;302.47822506176846;311.11953172521766;316.23628936119275;318.04903339016346;4380.649548036154;5017.473165317644;5348.251244825728;5440.836774896749;5467.797084641377;3801.5438147422346;5036.471170527087;5151.45909679483;5241.371035475749;5256.053910296145;3527.7177825773942;4042.7265411395465;4049.453323801293;4083.2650122977852;4109.4041364002205;4035.6973227008093;4049.218343928677;4055.371417430303;4059.918801623966;4065.451164092854;3914.4715463412504;4007.6593489553425;4047.2107938951917;4049.2104039712267;4084.5915408459064;3659.963400365989;3970.0745138607754;3979;4078.632923036926;4096.303628383167;2878.971210287891;3481.251530920839;3491.17957280039;3495.8426870790877;3525.9118522036897;4957.851264462072;5077.365329333833;5107.948920510785;5156.716380599066;5167.4057483389515;3919.7844118573466;4560.338750881137;4602.585767280961;4648.256903661127;4696.483386827446;5588.804391846266;5623.297087864017;5642.181883626892;5648.322201335866;5665.073874882519;3826.349520581508;3842.4236364545263;3854.3640299350573;3868.2650296443585;3877.515310586177;4784.66507344486;5315.2991042865915;5829.941700583025;5841.3282472515775;5891.8527036824;3620.6198349173483;3911.8630847920185;3923.2545816294814;3927.3323534999117;3929.5088113985753;3954.9914771733597;3977.6420122189143;3986.4817573715814;3987.1029018470613;4035.8183881725395;3607.350676878187;4437.689361744711;4560.201964656172;4588.0135770808765;4588.678792484561;4901.950980490149;5187.325647665779;5599.872048621498;5622.690752008679;5626.777422918007;1237.8328925594928;1279.7120647854344;1343.9462421503226;1366.3714691241942;1374.4570894496817;803.4255507312183;838.1869586501084;866.6316815353449;896.2784958108655;899.8470260055806;4318.654507639381;4376.452943382077;5141.434442211354;5151.5878729701535;5178.8926644014045;4781.7130972141085;5158.157172906134;5620.803271885465;5672.461116193955;5674.77300907959;4918.508149185124;5123.666961647481;5158.509941555546;5172.508611681884;5175.301334319894;2550.5791544394965;2858.8284702917476;2963.3184367595572;2967.6438827340858;2989.2078599171236;4782.732575867398;5583.274174357308;5797.536197104221;5854.4580528780325;5893.823185304448;4904.950950490449;5003.274525193827;5743.684097374601;5770.105633626795;5883;5179.585633149263;5241.344831895936;5922.526197904157;5923;5960.225170727777;5323.467653234646;5553.639013464273;5555.194561767361;5657.698729292203;5717.9987004548075;5541.92668388742;5544.445555444423;5556.222128901876;5599.636023658449;5617.157426386075;5644.8024319148635;5790.189373487631;5793.681347525927;5807.970960145341;5891.882162356815;3182.9363412731154;3594.622564630676;3635.527381440396;3863.690904727559;3883.980580097081;5312.362516498045;5690;5748.2061839185935;5783.855403614775;5814.651120932757;5324.733763311897;5564.581031837018;5590.608657393944;5651.547876169979;5653.236813030188;4516.074204787945;4914;4956.306117143675;5507.504324610804;5534.529564987021;4406.911861762683;5240.502152295526;5334.73326333674;5426.294581704353;5532.778688852562;4976.462004377721;5188.785270802819;5462.306684927685;5499.780008799763;5633.887322253614;5059.241113832954;5447.455254474521;5495.422980586981;5512.614117011771;5523.8066667666435 09:13:02 INFO - PROCESS | 1654 | |5;yui.html;610.4475449718005;730.9378702810261;789.4868335581871;789.5302295134396;826.6469751559875;14010.299485025746;14623.634409139777;14637.634059148526;14672.266386680663;14690.412383504661;13353;13462.730745385086;13492.190468571867;13492.527761528348;13507.527236546723;701.2251462134344;723.7177500774702;868.2316150207081;884.5798245833242;899.4333569851018;897.0177655467253;903.4308385716989;907.9001309855911;909.3997961345514;912.434290739739;802.9759107226793;964.5177411294353;966.8791401074866;968.1141755293897;968.6900191938582;734.2363941500886;753.3822265742093;957.9712608621752;960.8606752020918;963.643451922793;561.7696744334803;563.9971800140974;564.3876394112393;591.2520661363379;682.4676752133344;14184.43262269508;14381.928090359586;14386.064905781195;14396.352164152639;14401;12928.741425171538;13043.543475978295;13087.672808179777;13235.801462978063;13247;12071.155019148664;12137.353467315535;12235;12245.877541224563;12285.078619103602;4331.7834108294455;4374.78126093694;4403.163398954189;4464.776761161929;4608.608268297199;77133;81396;89479.55260223722;90650;91181.63227551592;10776.568937242579;10830.328490866425;10882.510287037103;10911.945440272748;10988.780224395467;20962.895185523976;21493.925303735065;21522.892385537973;21534;21537.461563460725;7914.762557123296;7924.920750792534;7972.800679982931;8008.319292860172;8056.274935255738;4202.495700515897;4243.936340954888;4290.099079193405;4384.517703052662;4479.955200447954;3492.441209406483;3569.8572057117944;3606.513120728668;3612.006698157975;3616.8010759407957;676.7462201674372;680.496432639843;684.9691763870637;685.8182581615876;729.5075823818901;516.8681986093598;576.4034224577542;671.7749553899498;672.5695554844904;673.8483841135705;7147.463940204506;8060.8387832243025;8450.61972211252;8664.176903194186;8915.643374264957;568.5962966293895;623.3610549187028;648.6108334998963;652.3574279334852;679.6160169504215;3712.7586706863967;4477.910441791146;4501.7974191161475;4549.772511374485;4558.97720511402;108693;109643.827950112;111129;113898;114576;91081.63377549342;92709.53645231866;93806;94669.0533094674;95471.52264238635;85380;86388.56805716056;87332.12667873366;89412.5529372375;89706;8542.231199192103;8861.822763544822;8869.423487473294;8873.112688731075;9138.543072846463;41908;42210;54390.728046359516;56847.147292791466;57650.4234957645;43928.12143757171;64877.67561162164;73673.6316318415;73836.26163738294;75694;12354.691132721753;12650.114491985472;12678;12688.365581721062;13023.093072078527;14529;14532.200728960008;14533.78199327032;14559.563213103624;14677.70644587081;10704.090152336827;11607.941960290145;13369.598912032654;13377.264250466318;13972.30138493051;10906.454677265947;13025.218486890817;13337.19976801395;13450.46198152063;13487.393067311797;12942.288174150135;12948.741025179632;13039.804402934153;13285.66785830362;13728.176309421468;10804;10884.590869253268;11551.191416600757;11639.88360116388;11683.474243659226;9891.604335826487;10767.192460565333;11308.43457827089;11413.657590272305;11578.36319002463 09:13:02 INFO - PROCESS | 1654 | __end_tp_report 09:13:02 INFO - PROCESS | 1654 | __start_cc_report 09:13:02 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1264 09:13:02 INFO - PROCESS | 1654 | __end_cc_report 09:13:02 INFO - PROCESS | 1654 | __startTimestamp1477757582132__endTimestamp 09:13:02 INFO - PROCESS | 1654 | 09:13:02 INFO - PROCESS | 1654 | ------- Summary: start ------- 09:13:02 INFO - PROCESS | 1654 | Number of tests: 6 09:13:02 INFO - PROCESS | 1654 | 09:13:02 INFO - PROCESS | 1654 | [#0] dojo.html Cycles:165 Average:5629.10 Median:5830.00 stddev:652.92 (11.2%) stddev-sans-first:627.44 09:13:02 INFO - PROCESS | 1654 | Values: 3239.8 3247.3 3267.7 3273.5 3295.1 5470.6 5524.1 5580.7 5596.1 5629.0 5567.4 5567.8 5582.9 5591.4 5599.4 5058.5 5086.8 5102.8 5128.1 5176.4 5122.0 5122.7 5205.7 5212.9 5225.6 5129.3 5135.8 5141.9 5146.1 5170.6 5203.4 5205.7 5219.7 5226.6 5268.7 5014.4 5040.4 5093.6 5145.4 5164.1 4596.5 5496.0 5558.9 5582.6 5591.7 6084.9 6093.8 6097.7 6098.3 6099.7 6026.4 6103.4 6135.7 6159.6 6196.2 5630.0 5665.1 5668.4 5679.5 5733.1 6269.0 6316.9 6320.7 6329.7 6329.8 4644.3 5811.7 5907.1 5957.3 5976.1 6019.2 6095.0 6105.5 6114.9 6123.7 6094.4 6105.8 6112.4 6112.6 6117.5 6116.3 6132.0 6149.8 6156.2 6161.2 4693.0 4794.2 4818.2 4820.3 4855.4 4350.2 4385.5 4387.4 4405.8 4414.9 5599.6 5630.9 5638.4 5642.0 5642.8 6021.2 6122.5 6223.0 6235.3 6252.5 4772.3 5476.7 5568.2 5644.4 5647.4 4555.4 5280.0 5324.1 5336.5 5352.2 6342.3 6350.8 6367.9 6371.2 6374.8 5980.3 6081.2 6089.4 6142.0 6191.7 6292.5 6343.0 6343.5 6358.4 6392.7 6037.3 6048.8 6050.9 6054.2 6054.7 5945.0 5995.1 6111.9 6198.7 6206.1 5857.0 5910.3 5991.6 6012.2 6044.2 5923.8 5979.1 5987.9 5988.1 5997.2 5649.2 5756.9 5812.9 5820.8 5841.4 5888.4 5911.8 5946.3 5975.7 6032.3 5805.7 5830.0 5833.0 5842.2 5892.4 09:13:02 INFO - PROCESS | 1654 | 09:13:02 INFO - PROCESS | 1654 | [#1] ext.html Cycles:180 Average:68541.01 Median:39089.72 stddev:147417.59 (377.1%) stddev-sans-first:147742.56 09:13:02 INFO - PROCESS | 1654 | Values: 478.7 485.4 509.5 531.5 532.5 31871.7 32353.0 33346.7 41017.6 41783.4 42559.0 42959.0 42980.8 43135.8 43378.0 8163.7 9476.7 9661.0 9674.8 9675.9 8632.9 8846.3 9406.7 9466.4 11834.5 11621.2 11676.7 11683.5 11703.8 11810.9 11613.6 11672.6 11675.4 11733.8 11753.5 8545.0 8797.5 11308.3 11656.4 11673.5 41121.0 41499.0 41528.8 41541.0 41687.4 3330.0 3422.9 3543.3 3571.4 3776.2 30189.0 30621.7 31347.4 31900.4 32045.0 3236.4 3323.5 3352.1 3390.5 3415.1 445665.0 448234.0 448937.0 449116.0 450541.0 55574.5 62836.0 63234.4 63305.0 63333.4 65661.7 65728.3 65776.7 65805.3 65938.7 16178.9 16449.3 16469.5 16479.0 16479.3 11377.6 12562.4 12644.3 12651.6 12655.2 16460.3 17059.7 18986.5 19553.5 19556.5 6887.4 7523.2 8007.3 8048.7 8051.2 875.0 876.0 939.5 950.6 976.2 28704.6 30376.2 30457.5 30485.7 30681.9 1045.6 1072.1 1088.2 1145.3 1197.9 12453.6 15598.5 15645.8 15653.2 16057.8 639914.0 647203.0 647285.0 648710.0 691039.0 39639.0 56883.0 57348.0 57473.1 60922.0 1365.5 1393.9 1407.7 1409.1 1409.1 30326.1 30667.7 31513.0 31974.5 32226.5 51169.0 51801.5 51894.7 51896.0 51937.0 530265.6 532016.0 532237.0 535362.0 535745.0 25842.1 25891.6 25927.1 26103.7 26278.9 46653.3 47269.8 48279.3 48479.5 48686.3 39486.0 39674.6 39760.8 39912.4 40925.0 34194.3 39039.0 39529.4 39680.0 40618.8 38249.4 38957.0 39140.4 39263.4 39362.4 32461.0 32766.0 34151.8 34191.0 34758.8 25142.4 25355.0 25615.0 25737.5 25986.8 09:13:02 INFO - PROCESS | 1654 | 09:13:02 INFO - PROCESS | 1654 | [#2] jquery.html Cycles:180 Average:31269.68 Median:22525.99 stddev:80927.68 (359.3%) stddev-sans-first:81121.41 09:13:02 INFO - PROCESS | 1654 | Values: 353.9 371.7 377.5 384.7 402.4 15220.9 15368.4 17572.9 20584.5 21227.0 19262.5 19272.8 20424.8 21105.8 21369.9 4880.4 5649.7 5897.6 5967.6 5968.4 5179.1 5698.4 5945.2 5958.5 5965.5 3740.3 3955.4 5676.7 5936.0 5973.3 5828.7 5983.8 6031.0 6046.4 6062.9 5851.9 5854.2 5859.7 5863.3 5864.5 13281.0 13316.7 13450.8 13561.6 13566.3 2073.3 2158.3 2229.9 2349.3 2479.2 9642.8 9991.8 11052.4 11786.1 14487.3 1865.2 1878.4 1959.4 1982.8 2017.5 114625.3 121226.6 122179.0 122385.0 128220.0 10930.8 11173.8 11347.8 11407.6 11625.4 14419.9 14424.0 14456.0 14466.1 14471.6 8180.9 8433.5 8502.8 8596.1 8606.0 8374.6 8383.3 8420.3 8585.6 8588.1 4372.8 4516.3 4539.4 4543.4 4574.9 1624.7 1757.0 1879.6 1962.4 1982.1 731.6 736.6 825.3 845.3 1018.3 19815.9 22315.2 22486.3 22565.7 23313.9 808.8 880.7 907.5 962.7 989.2 11095.2 11547.8 11614.7 11625.1 11689.2 333339.0 409750.0 431064.0 551994.0 592878.0 78971.0 115514.0 146277.8 152302.5 152306.8 944.3 947.7 1003.8 1023.5 1029.1 18595.7 19867.4 19888.1 19888.7 20562.0 47416.7 53632.7 56072.4 56699.4 56761.0 76174.6 81434.8 81856.0 83112.2 84925.5 7930.2 8120.1 8226.6 8285.5 8354.0 11303.7 12969.8 13020.5 13399.2 13436.1 10727.6 11156.3 11348.3 11582.6 11624.9 10930.5 11211.4 11252.9 11644.2 11735.0 11144.8 11568.6 11583.5 11915.9 11934.8 8145.7 8156.1 8170.1 8230.3 8274.0 8379.5 11165.0 11347.5 11636.1 11772.2 09:13:02 INFO - PROCESS | 1654 | 09:13:02 INFO - PROCESS | 1654 | [#3] mootools.html Cycles:180 Average:5455.91 Median:5214.80 stddev:2979.63 (57.1%) stddev-sans-first:2973.39 09:13:02 INFO - PROCESS | 1654 | Values: 1530.6 1550.3 1762.8 1844.1 1920.4 8097.1 8475.6 8486.5 8492.6 8513.4 7482.9 7755.7 8023.1 8236.9 8240.0 2284.4 2312.4 2314.0 2322.8 2323.0 2297.3 2316.8 2343.2 2343.4 2346.8 2279.2 2281.3 2300.8 2303.4 2303.7 2268.8 2269.8 2293.2 2293.9 2294.0 2231.4 2289.3 2290.2 2293.4 2294.1 8379.8 8430.5 8451.9 8452.6 8461.5 5058.1 5207.3 5210.8 5210.9 5218.7 3210.7 3318.3 3559.6 3560.4 3564.9 944.8 1029.7 1030.6 1053.9 1071.7 10754.1 10763.5 10824.8 10839.6 10842.3 4421.6 4514.3 4590.4 4612.1 4682.1 9431.0 9433.9 9443.1 9449.0 9450.8 5229.0 5236.0 5239.3 5240.8 5251.3 4293.7 4412.4 4639.4 4782.3 4791.0 3328.5 3686.9 3701.5 3728.4 3815.6 1078.4 1255.9 1267.4 1268.1 1279.5 760.3 851.5 897.9 901.7 934.0 5400.3 5526.9 5645.6 5846.0 5852.9 911.7 981.6 992.0 1002.2 1008.7 3494.5 3708.4 3829.7 3853.8 3885.6 9642.6 10100.8 10113.9 10121.8 10147.2 9485.5 9918.7 9931.9 10066.2 10070.0 7619.0 7846.5 7853.4 7865.3 7865.8 5544.2 5584.1 5617.2 5687.7 5930.6 9227.9 9311.8 9381.8 9404.1 9415.0 9217.1 9510.5 9597.6 9604.0 9609.1 6641.9 6848.9 6897.2 7188.8 7371.1 7744.8 7874.3 8003.6 8091.4 8094.6 7167.0 7268.7 7282.2 7322.9 7428.5 6963.8 7072.3 7079.0 7163.8 7255.5 6570.0 6664.8 6704.0 6711.5 6741.1 4691.8 4778.1 4837.4 4855.7 4918.4 4787.1 4809.1 4860.2 4939.2 4951.6 09:13:02 INFO - PROCESS | 1654 | 09:13:02 INFO - PROCESS | 1654 | [#4] prototype.html Cycles:180 Average:4493.68 Median:5092.66 stddev:1374.93 (27.0%) stddev-sans-first:1342.31 09:13:02 INFO - PROCESS | 1654 | Values: 301.6 302.5 311.1 316.2 318.0 4380.6 5017.5 5348.3 5440.8 5467.8 3801.5 5036.5 5151.5 5241.4 5256.1 3527.7 4042.7 4049.5 4083.3 4109.4 4035.7 4049.2 4055.4 4059.9 4065.5 3914.5 4007.7 4047.2 4049.2 4084.6 3660.0 3970.1 3979.0 4078.6 4096.3 2879.0 3481.3 3491.2 3495.8 3525.9 4957.9 5077.4 5107.9 5156.7 5167.4 3919.8 4560.3 4602.6 4648.3 4696.5 5588.8 5623.3 5642.2 5648.3 5665.1 3826.3 3842.4 3854.4 3868.3 3877.5 4784.7 5315.3 5829.9 5841.3 5891.9 3620.6 3911.9 3923.3 3927.3 3929.5 3955.0 3977.6 3986.5 3987.1 4035.8 3607.4 4437.7 4560.2 4588.0 4588.7 4902.0 5187.3 5599.9 5622.7 5626.8 1237.8 1279.7 1343.9 1366.4 1374.5 803.4 838.2 866.6 896.3 899.8 4318.7 4376.5 5141.4 5151.6 5178.9 4781.7 5158.2 5620.8 5672.5 5674.8 4918.5 5123.7 5158.5 5172.5 5175.3 2550.6 2858.8 2963.3 2967.6 2989.2 4782.7 5583.3 5797.5 5854.5 5893.8 4905.0 5003.3 5743.7 5770.1 5883.0 5179.6 5241.3 5922.5 5923.0 5960.2 5323.5 5553.6 5555.2 5657.7 5718.0 5541.9 5544.4 5556.2 5599.6 5617.2 5644.8 5790.2 5793.7 5808.0 5891.9 3182.9 3594.6 3635.5 3863.7 3884.0 5312.4 5690.0 5748.2 5783.9 5814.7 5324.7 5564.6 5590.6 5651.5 5653.2 4516.1 4914.0 4956.3 5507.5 5534.5 4406.9 5240.5 5334.7 5426.3 5532.8 4976.5 5188.8 5462.3 5499.8 5633.9 5059.2 5447.5 5495.4 5512.6 5523.8 09:13:02 INFO - PROCESS | 1654 | 09:13:02 INFO - PROCESS | 1654 | [#5] yui.html Cycles:180 Average:20346.22 Median:4471.34 stddev:29653.01 (663.2%) stddev-sans-first:29699.17 09:13:02 INFO - PROCESS | 1654 | Values: 610.4 730.9 789.5 789.5 826.6 14010.3 14623.6 14637.6 14672.3 14690.4 13353.0 13462.7 13492.2 13492.5 13507.5 701.2 723.7 868.2 884.6 899.4 897.0 903.4 907.9 909.4 912.4 803.0 964.5 966.9 968.1 968.7 734.2 753.4 958.0 960.9 963.6 561.8 564.0 564.4 591.3 682.5 14184.4 14381.9 14386.1 14396.4 14401.0 12928.7 13043.5 13087.7 13235.8 13247.0 12071.2 12137.4 12235.0 12245.9 12285.1 4331.8 4374.8 4403.2 4464.8 4608.6 77133.0 81396.0 89479.6 90650.0 91181.6 10776.6 10830.3 10882.5 10911.9 10988.8 20962.9 21493.9 21522.9 21534.0 21537.5 7914.8 7924.9 7972.8 8008.3 8056.3 4202.5 4243.9 4290.1 4384.5 4480.0 3492.4 3569.9 3606.5 3612.0 3616.8 676.7 680.5 685.0 685.8 729.5 516.9 576.4 671.8 672.6 673.8 7147.5 8060.8 8450.6 8664.2 8915.6 568.6 623.4 648.6 652.4 679.6 3712.8 4477.9 4501.8 4549.8 4559.0 108693.0 109643.8 111129.0 113898.0 114576.0 91081.6 92709.5 93806.0 94669.1 95471.5 85380.0 86388.6 87332.1 89412.6 89706.0 8542.2 8861.8 8869.4 8873.1 9138.5 41908.0 42210.0 54390.7 56847.1 57650.4 43928.1 64877.7 73673.6 73836.3 75694.0 12354.7 12650.1 12678.0 12688.4 13023.1 14529.0 14532.2 14533.8 14559.6 14677.7 10704.1 11607.9 13369.6 13377.3 13972.3 10906.5 13025.2 13337.2 13450.5 13487.4 12942.3 12948.7 13039.8 13285.7 13728.2 10804.0 10884.6 11551.2 11639.9 11683.5 9891.6 10767.2 11308.4 11413.7 11578.4 09:13:02 INFO - PROCESS | 1654 | -------- Summary: end -------- 09:13:02 INFO - PROCESS | 1654 | 09:13:02 INFO - TEST-INFO | 1654: exit 0 09:13:02 INFO - TEST-OK | dromaeo_css | took 1119131ms 09:13:02 INFO - TEST-START | kraken 09:13:02 INFO - operating with platform_type : mac_ 09:13:02 INFO - Initialising browser for kraken test... 09:13:02 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpiCDV9C/profile http://localhost:49274/getInfo.html) 09:13:05 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 09:13:05 INFO - PROCESS | 1660 | colorDepth:24 09:13:05 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 09:13:05 INFO - PROCESS | 1660 | __metrics 09:13:05 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:13:05 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 205: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:05 INFO - TEST-INFO | 1660: exit 0 09:13:05 INFO - Browser initialized. 09:13:05 INFO - Running cycle 1/1 for kraken test... 09:13:05 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/tmpiCDV9C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:17 INFO - PROCESS | 1661 | RSS: Main: 233275392 09:13:17 INFO - PROCESS | 1661 | 09:13:20 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:21 INFO - PROCESS | 1661 | RSS: Main: 291504128 09:13:21 INFO - PROCESS | 1661 | 09:13:24 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 09:13:24 INFO - PROCESS | 1661 | RSS: Main: 293552128 09:13:24 INFO - PROCESS | 1661 | 09:13:28 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 09:13:28 INFO - PROCESS | 1661 | RSS: Main: 386289664 09:13:28 INFO - PROCESS | 1661 | 09:13:30 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 09:13:31 INFO - PROCESS | 1661 | RSS: Main: 288894976 09:13:31 INFO - PROCESS | 1661 | 09:13:33 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:34 INFO - PROCESS | 1661 | RSS: Main: 290508800 09:13:34 INFO - PROCESS | 1661 | 09:13:36 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:37 INFO - PROCESS | 1661 | RSS: Main: 328278016 09:13:37 INFO - PROCESS | 1661 | 09:13:40 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:41 INFO - PROCESS | 1661 | RSS: Main: 329359360 09:13:41 INFO - PROCESS | 1661 | 09:13:43 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 09:13:44 INFO - PROCESS | 1661 | RSS: Main: 329367552 09:13:44 INFO - PROCESS | 1661 | 09:13:46 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:46 INFO - PROCESS | 1661 | RSS: Main: 303161344 09:13:46 INFO - PROCESS | 1661 | 09:13:48 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:49 INFO - PROCESS | 1661 | RSS: Main: 308994048 09:13:49 INFO - PROCESS | 1661 | 09:13:51 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:52 INFO - PROCESS | 1661 | RSS: Main: 310935552 09:13:52 INFO - PROCESS | 1661 | 09:13:55 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:56 INFO - PROCESS | 1661 | RSS: Main: 326713344 09:13:56 INFO - PROCESS | 1661 | 09:13:59 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:59 INFO - PROCESS | 1661 | RSS: Main: 320163840 09:13:59 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 09:14:01 INFO - PROCESS | 1661 | RSS: Main: 364331008 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | __start_tp_report 09:14:01 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 09:14:01 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 09:14:01 INFO - PROCESS | 1661 | |i|pagename|runs| 09:14:01 INFO - PROCESS | 1661 | |0;ai-astar;111;114;113;114;114;114;114;114;114;113 09:14:01 INFO - PROCESS | 1661 | |1;audio-beat-detection;150;112;126;186;140;115;114;113;146;113 09:14:01 INFO - PROCESS | 1661 | |2;audio-dft;181;182;182;183;185;180;182;182;181;183 09:14:01 INFO - PROCESS | 1661 | |3;audio-fft;81;60;57;89;62;60;59;59;85;68 09:14:01 INFO - PROCESS | 1661 | |4;audio-oscillator;89;71;93;69;67;69;92;67;69;90 09:14:01 INFO - PROCESS | 1661 | |5;imaging-gaussian-blur;86;84;87;85;88;84;90;86;95;130 09:14:01 INFO - PROCESS | 1661 | |6;imaging-darkroom;94;94;96;94;88;150;94;94;93;93 09:14:01 INFO - PROCESS | 1661 | |7;imaging-desaturate;82;95;121;131;83;83;82;85;82;82 09:14:01 INFO - PROCESS | 1661 | |8;json-parse-financial;59;57;56;57;53;62;85;85;84;56 09:14:01 INFO - PROCESS | 1661 | |9;json-stringify-tinderbox;63;76;78;74;73;70;69;68;70;70 09:14:01 INFO - PROCESS | 1661 | |10;stanford-crypto-aes;89;86;87;97;72;89;112;110;79;97 09:14:01 INFO - PROCESS | 1661 | |11;stanford-crypto-ccm;154;156;157;135;164;158;157;168;193;151 09:14:01 INFO - PROCESS | 1661 | |12;stanford-crypto-pbkdf2;225;186;186;242;173;174;175;175;172;205 09:14:01 INFO - PROCESS | 1661 | |13;stanford-crypto-sha256-iterative;67;67;67;66;67;68;66;66;66;66 09:14:01 INFO - PROCESS | 1661 | __end_tp_report 09:14:01 INFO - PROCESS | 1661 | __start_cc_report 09:14:01 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,2081 09:14:01 INFO - PROCESS | 1661 | __end_cc_report 09:14:01 INFO - PROCESS | 1661 | __startTimestamp1477757641758__endTimestamp 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | ------- Summary: start ------- 09:14:01 INFO - PROCESS | 1661 | Number of tests: 14 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:0.97 (0.9%) stddev-sans-first:0.44 09:14:01 INFO - PROCESS | 1661 | Values: 111.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#1] audio-beat-detection Cycles:10 Average:131.50 Median:133.00 stddev:24.19 (18.2%) stddev-sans-first:24.72 09:14:01 INFO - PROCESS | 1661 | Values: 150.0 112.0 126.0 186.0 140.0 115.0 114.0 113.0 146.0 113.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#2] audio-dft Cycles:10 Average:182.10 Median:182.00 stddev:1.37 (0.8%) stddev-sans-first:1.39 09:14:01 INFO - PROCESS | 1661 | Values: 181.0 182.0 182.0 183.0 185.0 180.0 182.0 182.0 181.0 183.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#3] audio-fft Cycles:10 Average:68.00 Median:65.00 stddev:12.23 (18.8%) stddev-sans-first:12.03 09:14:01 INFO - PROCESS | 1661 | Values: 81.0 60.0 57.0 89.0 62.0 60.0 59.0 59.0 85.0 68.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:80.00 stddev:11.64 (14.5%) stddev-sans-first:11.59 09:14:01 INFO - PROCESS | 1661 | Values: 89.0 71.0 93.0 69.0 67.0 69.0 92.0 67.0 69.0 90.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:86.50 stddev:13.92 (16.1%) stddev-sans-first:14.62 09:14:01 INFO - PROCESS | 1661 | Values: 86.0 84.0 87.0 85.0 88.0 84.0 90.0 86.0 95.0 130.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#6] imaging-darkroom Cycles:10 Average:99.00 Median:94.00 stddev:18.04 (19.2%) stddev-sans-first:19.04 09:14:01 INFO - PROCESS | 1661 | Values: 94.0 94.0 96.0 94.0 88.0 150.0 94.0 94.0 93.0 93.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#7] imaging-desaturate Cycles:10 Average:92.60 Median:82.50 stddev:18.19 (22.1%) stddev-sans-first:18.89 09:14:01 INFO - PROCESS | 1661 | Values: 82.0 95.0 121.0 131.0 83.0 83.0 82.0 85.0 82.0 82.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:60.50 stddev:13.49 (22.3%) stddev-sans-first:14.11 09:14:01 INFO - PROCESS | 1661 | Values: 59.0 57.0 56.0 57.0 53.0 62.0 85.0 85.0 84.0 56.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.50 stddev:4.31 (6.0%) stddev-sans-first:3.43 09:14:01 INFO - PROCESS | 1661 | Values: 63.0 76.0 78.0 74.0 73.0 70.0 69.0 68.0 70.0 70.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:88.00 stddev:12.57 (14.3%) stddev-sans-first:13.29 09:14:01 INFO - PROCESS | 1661 | Values: 89.0 86.0 87.0 97.0 72.0 89.0 112.0 110.0 79.0 97.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:159.30 Median:157.50 stddev:14.70 (9.3%) stddev-sans-first:15.46 09:14:01 INFO - PROCESS | 1661 | Values: 154.0 156.0 157.0 135.0 164.0 158.0 157.0 168.0 193.0 151.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.30 Median:186.00 stddev:24.69 (13.3%) stddev-sans-first:22.98 09:14:01 INFO - PROCESS | 1661 | Values: 225.0 186.0 186.0 242.0 173.0 174.0 175.0 175.0 172.0 205.0 09:14:01 INFO - PROCESS | 1661 | 09:14:01 INFO - PROCESS | 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 09:14:01 INFO - PROCESS | 1661 | Values: 67.0 67.0 67.0 66.0 67.0 68.0 66.0 66.0 66.0 66.0 09:14:01 INFO - PROCESS | 1661 | -------- Summary: end -------- 09:14:01 INFO - PROCESS | 1661 | 09:14:02 INFO - TEST-INFO | 1661: exit 0 09:14:02 INFO - TEST-OK | kraken | took 59910ms 09:14:02 INFO - SUITE-END | took 1179s 09:14:02 INFO - Completed test suite (00:19:39) 09:14:02 INFO - javascript benchmark 09:14:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3239.7732158748895, 3247.2855971686226, 3267.722243609294, 3273.4598791199455, 3295.1103202135423, 5470.5623550116, 5524.08852539331, 5580.693061881595, 5596.132599447087, 5628.971855140724, 5567.387587365387, 5567.805126820562, 5582.86042848929, 5591.440855914407, 5599.440055994409, 5058.468860769631, 5086.79652813887, 5102.846914592549, 5128.076946149691, 5176.430592634807, 5122.0, 5122.743862806863, 5205.687658740469, 5212.921806172892, 5225.581953443715, 5129.28190053391, 5135.794568217267, 5141.922871156917, 5146.099432599299, 5170.612204084689, 5203.4016088149965, 5205.6616319939085, 5219.739013049332, 5226.5818734501145, 5268.710220937847, 5014.423341315759, 5040.445550989388, 5093.567046801027, 5145.408278048035, 5164.14791559396, 4596.540345965377, 5496.0, 5558.944410555883, 5582.553395728332, 5591.7483713233005, 6084.9351363511205, 6093.817185484442, 6097.69511524422, 6098.32918378978, 6099.725512351954, 6026.3672314406795, 6103.35914728956, 6135.661410523283, 6159.630422174639, 6196.163517925068, 5629.971850140723, 5665.065264231397, 5668.433156684298, 5679.488846003879, 5733.140028995684, 6268.968655156787, 6316.936830631635, 6320.71556779946, 6329.715162817684, 6329.810105696836, 4644.349791029259, 5811.651300921873, 5907.1434641976675, 5957.344692083867, 5976.073708575178, 6019.157317975487, 6095.015197869788, 6105.48103411215, 6114.908276375858, 6123.679189354777, 6094.360092190256, 6105.755769769248, 6112.41229444207, 6112.633242005494, 6117.480014198754, 6116.302340284626, 6131.96934015327, 6149.754009839646, 6156.199694039746, 6161.199044124325, 4693.037927224911, 4794.232922732346, 4818.229083346648, 4820.34925285082, 4855.44162421319, 4350.2387082260475, 4385.473743150842, 4387.407699960529, 4405.757683327448, 4414.867553973386, 5599.552035837123, 5630.85922851932, 5638.35158956717, 5642.0, 5642.830715078472, 6021.217241758543, 6122.479589234876, 6223.0, 6235.314115447297, 6252.531060170414, 4772.284157376422, 5476.658218736435, 5568.164775283659, 5644.435556444405, 5647.435256474402, 4555.362249285103, 5280.0, 5324.121519949243, 5336.519713225828, 5352.170413585901, 6342.270638876496, 6350.809475715736, 6367.936320636734, 6371.23545174582, 6374.808755737243, 5980.34216236205, 6081.179040829431, 6089.421504957022, 6142.017277235621, 6191.721372538156, 6292.528060395397, 6343.048542718445, 6343.492520598249, 6358.364163583605, 6392.712327945161, 6037.275526936795, 6048.758049677964, 6050.878982420415, 6054.243219597551, 6054.727537260922, 5944.970275148597, 5995.130706047686, 6111.938880611137, 6198.659073750987, 6206.131141640084, 5857.033589457862, 5910.290765108214, 5991.580589358703, 6012.158297838394, 6044.153818465506, 5923.822285331447, 5979.073243647242, 5987.940120598738, 5988.101784732151, 5997.16039754426, 5649.180868773922, 5756.934967031113, 5812.854678632899, 5820.76716931318, 5841.386654401226, 5888.440598143169, 5911.7635294587735, 5946.286445626552, 5975.701214939322, 6032.276126864629, 5805.65166090019, 5830.0, 5833.008388574038, 5842.152887831156, 5892.351841297368], "value": 5586.697073434394, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.6745013390894, 485.3859867267907, 509.4777852700983, 531.5242857642412, 532.5233915645497, 31871.72513099476, 32353.029409117706, 33346.66653333466, 41017.58982410175, 41783.37324940128, 42559.0, 42959.0, 42980.785096074556, 43135.784321078354, 43378.0, 8163.714270000552, 9476.715698529055, 9661.0, 9674.806503869919, 9675.854862177073, 8632.870506942401, 8846.292296616255, 9406.717798466023, 9466.432014079177, 11834.467448964817, 11621.186516943817, 11676.708082297968, 11683.474243659013, 11703.765924681502, 11810.881891181065, 11613.593524226611, 11672.591459298968, 11675.416229188506, 11733.765324693544, 11753.4710938008, 8545.0, 8797.516136612483, 11308.264962777475, 11656.358900260482, 11673.533058677644, 41121.0, 41499.0, 41528.75413737593, 41541.0, 41687.374689379685, 3329.9833500832583, 3422.8973130805866, 3543.273628906068, 3571.4464258040043, 3776.169242766587, 30189.0, 30621.693783062106, 31347.37305253882, 31900.361992760016, 32045.0, 3236.4012657658172, 3323.4848598467033, 3352.128446603876, 3390.4575267957007, 3415.112070861569, 445665.0, 448234.0, 448937.0, 449116.0, 450541.0, 55574.49744284551, 62836.0, 63234.36765632285, 63305.0, 63333.36666633367, 65661.67169164124, 65728.34271657222, 65776.67111664507, 65805.34194657992, 65938.67030664816, 16178.919105404633, 16449.342026319053, 16469.505914822574, 16479.0, 16479.34082636705, 11377.601783937687, 12562.371881405894, 12644.30456324911, 12651.620451386472, 12655.177413468095, 16460.341586336413, 17059.65880682404, 18986.525336866413, 19553.511162221057, 19556.511087222647, 6887.380135787803, 7523.172451030382, 8007.279344858991, 8048.678052877819, 8051.2351326623875, 874.9825003500022, 876.027609353617, 939.4598106089027, 950.5912457643279, 976.2434113561904, 28704.569431458545, 30376.240593984887, 30457.543136852964, 30485.695143048728, 30681.926132585253, 1045.639254457211, 1072.1155047086186, 1088.2436706488913, 1145.2899202494507, 1197.9041676665845, 12453.626391208278, 15598.454054108051, 15645.765313520305, 15653.217339132998, 16057.839421605868, 639914.0, 647203.0, 647285.0, 648710.0, 691039.0, 39639.0, 56883.0, 57348.0, 57473.13790293149, 60922.0, 1365.487942021742, 1393.888488920884, 1407.6551244945053, 1409.0911362171341, 1409.1263416681722, 30326.090217293517, 30667.693323067375, 31513.0, 31974.52038219475, 32226.516602251453, 51169.0, 51801.481985179664, 51894.74052629713, 51895.96208075742, 51937.0, 530265.578753691, 532016.0, 532237.0, 535362.0, 535745.0, 25842.06184536205, 25891.611625826004, 25927.092551760597, 26103.73896261089, 26278.868605656848, 46653.30020049634, 47269.81825454391, 48279.275810862164, 48479.5152048475, 48686.26970595373, 39486.0, 39674.60325396824, 39760.80119599384, 39912.401313980896, 40925.0, 34194.316113678084, 39039.024024399616, 39529.407058893565, 39680.04799280016, 40618.79690601528, 38249.426258605585, 38957.0, 39140.41289380719, 39263.41104883372, 39362.409563855996, 32461.0, 32766.0, 34151.829240853636, 34191.0, 34758.82620586881, 25142.371440714127, 25354.98580056851, 25615.0, 25737.485250295264, 25986.774899217427], "value": 20232.909891856656, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.9185987222937, 371.6506483905129, 377.5050798836607, 384.7057001393934, 402.4044414266885, 15220.923895380522, 15368.385264589417, 17572.91213543932, 20584.485387865312, 21227.0, 19262.51843703908, 19272.807271927275, 20424.795752042475, 21105.788942110576, 21369.893150534226, 4880.414350277953, 5649.689267090298, 5897.587168898179, 5967.582269241155, 5968.432998865101, 5179.09970416566, 5698.430156984289, 5945.16767652529, 5958.493528050121, 5965.4929331006915, 3740.308043012038, 3955.4462375267485, 5676.716164191795, 5935.9703201483935, 5973.342932277446, 5828.737706803162, 5983.790567330166, 6030.969845150768, 6046.425589568984, 6062.939370606282, 5851.882962340729, 5854.18041474194, 5859.736311865933, 5863.296404431453, 5864.530837532987, 13281.0, 13316.73366532664, 13450.798238026437, 13561.593152205449, 13566.321683915765, 2073.3054426767053, 2158.3093410108613, 2229.944251393712, 2349.271725765001, 2479.2066538707622, 9642.807143857153, 9991.800163996752, 11052.447377631086, 11786.057115430745, 14487.275636218252, 1865.2445759467437, 1878.3613571385658, 1959.3925882976323, 1982.8413726901958, 2017.5460521382718, 114625.28062079076, 121226.57308397975, 122179.0, 122385.0, 128220.0, 10930.836037459445, 11173.83239251412, 11347.773044539063, 11407.581398835488, 11625.360605166798, 14419.927900360432, 14424.0, 14456.0, 14466.132032078109, 14471.638209044859, 8180.9181908181345, 8433.451825631315, 8502.787430314167, 8596.097409772008, 8606.0, 8374.623141958626, 8383.329333653293, 8420.326373890073, 8585.570721463902, 8588.141185881486, 4372.846950356722, 4516.322551617218, 4539.364488971547, 4543.409356783597, 4574.8562859285175, 1624.6677724265987, 1756.9912150439166, 1879.6052828906084, 1962.4210857796984, 1982.1080513768861, 731.5537522111508, 736.6169591812335, 825.2655136928139, 845.3110714767445, 1018.2719355660738, 19815.900920495595, 22315.218967336066, 22486.325410237718, 22565.66151507729, 23313.88343058308, 808.7978005498626, 880.7269746378515, 907.5280853955906, 962.6678795815433, 989.1987490133015, 11095.16786241019, 11547.826782598268, 11614.6515604532, 11625.12811539121, 11689.240199387013, 333339.0, 409750.0, 431064.0, 551994.0, 592878.0, 78971.0, 115514.0, 146277.78972048993, 152302.47697522884, 152306.82323769917, 944.3436811416, 947.6683160893632, 1003.8243307421318, 1023.4626820918928, 1029.0995379043336, 18595.72106418432, 19867.403977880687, 19888.105035273158, 19888.70166947526, 20562.0, 47416.65041918508, 53632.73183634057, 56072.439275606725, 56699.433005669416, 56761.0, 76174.61912690401, 81434.77847832406, 81856.0, 83112.16887831286, 84925.452236433, 7930.246626570467, 8120.106788253405, 8226.629801659059, 8285.50286982759, 8354.0, 11303.71740706456, 12969.805452918024, 13020.544280950122, 13399.196048237138, 13436.059475836988, 10727.570897164338, 11156.330620162817, 11348.262362946381, 11582.594609188638, 11624.88375116238, 10930.453477325942, 11211.412348048547, 11252.887471125185, 11644.184907056764, 11735.0, 11144.777104458028, 11568.595099171489, 11583.536658533902, 11915.880841191478, 11934.820977685167, 8145.714899978472, 8156.143604921398, 8170.101288858102, 8230.259276665129, 8274.0, 8379.45533540318, 11165.0, 11347.489362978851, 11636.06911447099, 11772.17594768358], "value": 9347.832550051071, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.556138719771, 1550.3178601415377, 1762.8237176282373, 1844.1424737497061, 1920.3950755512003, 8097.149799271073, 8475.576221188947, 8486.53324067176, 8492.575371231436, 8513.361497887652, 7482.887756683641, 7755.650995705193, 8023.117457079731, 8236.876446853303, 8239.958800206006, 2284.4060544258527, 2312.3756585721844, 2313.9652905206435, 2322.814174866007, 2323.0475505042937, 2297.322289924468, 2316.8378213524975, 2343.238447504568, 2343.4492894169944, 2346.8239882008834, 2279.225063478417, 2281.269993602048, 2300.804431623306, 2303.3550605830396, 2303.6890019847356, 2268.773122687718, 2269.795718385345, 2293.1973809166825, 2293.9218567273356, 2293.9770602294097, 2231.3529076567775, 2289.3360925331635, 2290.209877592228, 2293.3693234360517, 2294.105298933417, 8379.790505237357, 8430.494170349799, 8451.915480845235, 8452.57737113148, 8461.53461559614, 5058.0895438821, 5207.297014902978, 5210.811459187113, 5210.947890521084, 5218.66078704883, 3210.662880397548, 3318.3363327334628, 3559.626239244868, 3560.3769340365334, 3564.91087722809, 944.8331310831118, 1029.7065336379171, 1030.6032177611598, 1053.8788039375418, 1071.6731396923935, 10754.139668826554, 10763.461826908702, 10824.783504329947, 10839.620613278497, 10842.295250808673, 4421.602055814928, 4514.322851572225, 4590.42619672541, 4612.0545288215835, 4682.063587282557, 9431.0, 9433.90566094344, 9443.102905223992, 9449.0, 9450.771399717993, 5228.980348831941, 5236.0, 5239.318888544465, 5240.816571419982, 5251.264822924793, 4293.69944103916, 4412.42638457005, 4639.350490931272, 4782.33047373368, 4790.952090479051, 3328.5340052392685, 3686.8525258989876, 3701.5373078365205, 3728.3848165053005, 3815.618438156162, 1078.4014871746099, 1255.8838357367865, 1267.3979859566632, 1268.0616343905444, 1279.5009946120833, 760.3157158557343, 851.4933614499487, 897.9102089790969, 901.6528636475005, 933.9626414943326, 5400.270963419888, 5526.861828454321, 5645.604807663506, 5846.0061789495885, 5852.853678658068, 911.7447114807865, 981.6417007792247, 991.9931269761054, 1002.2332915319786, 1008.7478130467383, 3494.5107684924133, 3708.35103856824, 3829.659619133281, 3853.845846166122, 3885.553161386477, 9642.566084526214, 10100.848487272697, 10113.898861011443, 10121.848172277421, 10147.188224941987, 9485.525723713787, 9918.702438926844, 9931.851022234672, 10066.245031622657, 10070.0, 7618.961905190438, 7846.5292082475235, 7853.41099417546, 7865.252800983897, 7865.842683146305, 5544.1960915666195, 5584.0507113789945, 5617.213590097308, 5687.687177205294, 5930.584859059824, 9227.861582076408, 9311.76720581991, 9381.812363752822, 9404.059594040542, 9414.95292523533, 9217.078292170729, 9510.47692376926, 9597.616095356387, 9603.951980240054, 9609.087136722, 6641.867162656817, 6848.931510684829, 6897.206821215424, 7188.820279493055, 7371.115466144097, 7744.7676569703, 7874.3306818918745, 8003.6398362075015, 8091.433599647969, 8094.554799486084, 7167.0, 7268.709251629875, 7282.1625513064555, 7322.853542929005, 7428.517146385468, 6963.7562685305775, 7072.292770722886, 7078.964605176941, 7163.820904477429, 7255.4921155518605, 6570.047343135314, 6664.8000559983275, 6703.966480167568, 6711.530192886451, 6741.056252124608, 4691.765411729468, 4778.136526754499, 4837.395325584302, 4855.732934688626, 4918.360613120271, 4787.138315103315, 4809.134355815987, 4860.222364421676, 4939.185034469272, 4951.628627852998], "value": 4428.059051716609, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.58532018474597, 302.47822506176846, 311.11953172521766, 316.23628936119275, 318.04903339016346, 4380.649548036154, 5017.473165317644, 5348.251244825728, 5440.836774896749, 5467.797084641377, 3801.5438147422346, 5036.471170527087, 5151.45909679483, 5241.371035475749, 5256.053910296145, 3527.7177825773942, 4042.7265411395465, 4049.453323801293, 4083.2650122977852, 4109.4041364002205, 4035.6973227008093, 4049.218343928677, 4055.371417430303, 4059.918801623966, 4065.451164092854, 3914.4715463412504, 4007.6593489553425, 4047.2107938951917, 4049.2104039712267, 4084.5915408459064, 3659.963400365989, 3970.0745138607754, 3979.0, 4078.632923036926, 4096.303628383167, 2878.971210287891, 3481.251530920839, 3491.17957280039, 3495.8426870790877, 3525.9118522036897, 4957.851264462072, 5077.365329333833, 5107.948920510785, 5156.716380599066, 5167.4057483389515, 3919.7844118573466, 4560.338750881137, 4602.585767280961, 4648.256903661127, 4696.483386827446, 5588.804391846266, 5623.297087864017, 5642.181883626892, 5648.322201335866, 5665.073874882519, 3826.349520581508, 3842.4236364545263, 3854.3640299350573, 3868.2650296443585, 3877.515310586177, 4784.66507344486, 5315.2991042865915, 5829.941700583025, 5841.3282472515775, 5891.8527036824, 3620.6198349173483, 3911.8630847920185, 3923.2545816294814, 3927.3323534999117, 3929.5088113985753, 3954.9914771733597, 3977.6420122189143, 3986.4817573715814, 3987.1029018470613, 4035.8183881725395, 3607.350676878187, 4437.689361744711, 4560.201964656172, 4588.0135770808765, 4588.678792484561, 4901.950980490149, 5187.325647665779, 5599.872048621498, 5622.690752008679, 5626.777422918007, 1237.8328925594928, 1279.7120647854344, 1343.9462421503226, 1366.3714691241942, 1374.4570894496817, 803.4255507312183, 838.1869586501084, 866.6316815353449, 896.2784958108655, 899.8470260055806, 4318.654507639381, 4376.452943382077, 5141.434442211354, 5151.5878729701535, 5178.8926644014045, 4781.7130972141085, 5158.157172906134, 5620.803271885465, 5672.461116193955, 5674.77300907959, 4918.508149185124, 5123.666961647481, 5158.509941555546, 5172.508611681884, 5175.301334319894, 2550.5791544394965, 2858.8284702917476, 2963.3184367595572, 2967.6438827340858, 2989.2078599171236, 4782.732575867398, 5583.274174357308, 5797.536197104221, 5854.4580528780325, 5893.823185304448, 4904.950950490449, 5003.274525193827, 5743.684097374601, 5770.105633626795, 5883.0, 5179.585633149263, 5241.344831895936, 5922.526197904157, 5923.0, 5960.225170727777, 5323.467653234646, 5553.639013464273, 5555.194561767361, 5657.698729292203, 5717.9987004548075, 5541.92668388742, 5544.445555444423, 5556.222128901876, 5599.636023658449, 5617.157426386075, 5644.8024319148635, 5790.189373487631, 5793.681347525927, 5807.970960145341, 5891.882162356815, 3182.9363412731154, 3594.622564630676, 3635.527381440396, 3863.690904727559, 3883.980580097081, 5312.362516498045, 5690.0, 5748.2061839185935, 5783.855403614775, 5814.651120932757, 5324.733763311897, 5564.581031837018, 5590.608657393944, 5651.547876169979, 5653.236813030188, 4516.074204787945, 4914.0, 4956.306117143675, 5507.504324610804, 5534.529564987021, 4406.911861762683, 5240.502152295526, 5334.73326333674, 5426.294581704353, 5532.778688852562, 4976.462004377721, 5188.785270802819, 5462.306684927685, 5499.780008799763, 5633.887322253614, 5059.241113832954, 5447.455254474521, 5495.422980586981, 5512.614117011771, 5523.8066667666435], "value": 4056.222603238936, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.4475449718005, 730.9378702810261, 789.4868335581871, 789.5302295134396, 826.6469751559875, 14010.299485025746, 14623.634409139777, 14637.634059148526, 14672.266386680663, 14690.412383504661, 13353.0, 13462.730745385086, 13492.190468571867, 13492.527761528348, 13507.527236546723, 701.2251462134344, 723.7177500774702, 868.2316150207081, 884.5798245833242, 899.4333569851018, 897.0177655467253, 903.4308385716989, 907.9001309855911, 909.3997961345514, 912.434290739739, 802.9759107226793, 964.5177411294353, 966.8791401074866, 968.1141755293897, 968.6900191938582, 734.2363941500886, 753.3822265742093, 957.9712608621752, 960.8606752020918, 963.643451922793, 561.7696744334803, 563.9971800140974, 564.3876394112393, 591.2520661363379, 682.4676752133344, 14184.43262269508, 14381.928090359586, 14386.064905781195, 14396.352164152639, 14401.0, 12928.741425171538, 13043.543475978295, 13087.672808179777, 13235.801462978063, 13247.0, 12071.155019148664, 12137.353467315535, 12235.0, 12245.877541224563, 12285.078619103602, 4331.7834108294455, 4374.78126093694, 4403.163398954189, 4464.776761161929, 4608.608268297199, 77133.0, 81396.0, 89479.55260223722, 90650.0, 91181.63227551592, 10776.568937242579, 10830.328490866425, 10882.510287037103, 10911.945440272748, 10988.780224395467, 20962.895185523976, 21493.925303735065, 21522.892385537973, 21534.0, 21537.461563460725, 7914.762557123296, 7924.920750792534, 7972.800679982931, 8008.319292860172, 8056.274935255738, 4202.495700515897, 4243.936340954888, 4290.099079193405, 4384.517703052662, 4479.955200447954, 3492.441209406483, 3569.8572057117944, 3606.513120728668, 3612.006698157975, 3616.8010759407957, 676.7462201674372, 680.496432639843, 684.9691763870637, 685.8182581615876, 729.5075823818901, 516.8681986093598, 576.4034224577542, 671.7749553899498, 672.5695554844904, 673.8483841135705, 7147.463940204506, 8060.8387832243025, 8450.61972211252, 8664.176903194186, 8915.643374264957, 568.5962966293895, 623.3610549187028, 648.6108334998963, 652.3574279334852, 679.6160169504215, 3712.7586706863967, 4477.910441791146, 4501.7974191161475, 4549.772511374485, 4558.97720511402, 108693.0, 109643.827950112, 111129.0, 113898.0, 114576.0, 91081.63377549342, 92709.53645231866, 93806.0, 94669.0533094674, 95471.52264238635, 85380.0, 86388.56805716056, 87332.12667873366, 89412.5529372375, 89706.0, 8542.231199192103, 8861.822763544822, 8869.423487473294, 8873.112688731075, 9138.543072846463, 41908.0, 42210.0, 54390.728046359516, 56847.147292791466, 57650.4234957645, 43928.12143757171, 64877.67561162164, 73673.6316318415, 73836.26163738294, 75694.0, 12354.691132721753, 12650.114491985472, 12678.0, 12688.365581721062, 13023.093072078527, 14529.0, 14532.200728960008, 14533.78199327032, 14559.563213103624, 14677.70644587081, 10704.090152336827, 11607.941960290145, 13369.598912032654, 13377.264250466318, 13972.30138493051, 10906.454677265947, 13025.218486890817, 13337.19976801395, 13450.46198152063, 13487.393067311797, 12942.288174150135, 12948.741025179632, 13039.804402934153, 13285.66785830362, 13728.176309421468, 10804.0, 10884.590869253268, 11551.191416600757, 11639.88360116388, 11683.474243659226, 9891.604335826487, 10767.192460565333, 11308.43457827089, 11413.657590272305, 11578.36319002463], "value": 7375.934789259582, "unit": "score"}], "name": "dromaeo_css", "value": 7205.887060814633, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 112.0, 126.0, 186.0, 140.0, 115.0, 114.0, 113.0, 146.0, 113.0], "value": 131.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 182.0, 183.0, 185.0, 180.0, 182.0, 182.0, 181.0, 183.0], "value": 182.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 57.0, 89.0, 62.0, 60.0, 59.0, 59.0, 85.0, 68.0], "value": 68.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 93.0, 69.0, 67.0, 69.0, 92.0, 67.0, 69.0, 90.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 85.0, 88.0, 84.0, 90.0, 86.0, 95.0, 130.0], "value": 91.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 94.0, 88.0, 150.0, 94.0, 94.0, 93.0, 93.0], "value": 99.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 95.0, 121.0, 131.0, 83.0, 83.0, 82.0, 85.0, 82.0, 82.0], "value": 92.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 56.0, 57.0, 53.0, 62.0, 85.0, 85.0, 84.0, 56.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 76.0, 78.0, 74.0, 73.0, 70.0, 69.0, 68.0, 70.0, 70.0], "value": 71.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 87.0, 97.0, 72.0, 89.0, 112.0, 110.0, 79.0, 97.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 156.0, 157.0, 135.0, 164.0, 158.0, 157.0, 168.0, 193.0, 151.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [225.0, 186.0, 186.0, 242.0, 173.0, 174.0, 175.0, 175.0, 172.0, 205.0], "value": 191.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 68.0, 66.0, 66.0, 66.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1501.3, "alertThreshold": 2.0}]} 09:14:03 INFO - Return code: 0 09:14:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:14:03 INFO - # TBPL SUCCESS # 09:14:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:14:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:14:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:14:03 INFO - 2016-10-29 09:14:03.086 screenresolution[1665:9867] starting screenresolution argv=screenresolution get 09:14:03 INFO - 2016-10-29 09:14:03.089 screenresolution[1665:9867] Display 0: 1600x1200x32@60 09:14:03 INFO - 2016-10-29 09:14:03.095 screenresolution[1666:9870] starting screenresolution argv=screenresolution list 09:14:03 INFO - Available Modes on Display 0 09:14:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:14:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:14:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:14:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:14:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:14:03 INFO - Intel Iris: 09:14:03 INFO - Chipset Model: Intel Iris 09:14:03 INFO - Type: GPU 09:14:03 INFO - Bus: Built-In 09:14:03 INFO - VRAM (Dynamic, Max): 1536 MB 09:14:03 INFO - Vendor: Intel (0x8086) 09:14:03 INFO - Device ID: 0x0a2e 09:14:03 INFO - Revision ID: 0x0009 09:14:03 INFO - Displays: 09:14:03 INFO - Display: 09:14:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:14:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:14:03 INFO - Display Serial Number: 1600x1200 60 09:14:03 INFO - Main Display: Yes 09:14:03 INFO - Mirror: Off 09:14:03 INFO - Online: Yes 09:14:03 INFO - Rotation: Supported 09:14:03 INFO - Return code: 0 09:14:03 INFO - Running post-action listener: _resource_record_post_action 09:14:03 INFO - [mozharness: 2016-10-29 16:14:03.329553Z] Finished run-tests step (success) 09:14:03 INFO - Running post-run listener: _resource_record_post_run 09:14:03 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 37106688; Write bytes: 708696576; Read time: 242; Write time: 2004 09:14:03 INFO - TinderboxPrint: CPU usage
53.4% 09:14:03 INFO - TinderboxPrint: I/O read bytes / time
37,106,688 / 242 09:14:03 INFO - TinderboxPrint: I/O write bytes / time
708,696,576 / 2,004 09:14:03 INFO - TinderboxPrint: CPU idle
2,264.3 (46.6%) 09:14:03 INFO - TinderboxPrint: CPU system
969.8 (20.0%) 09:14:03 INFO - TinderboxPrint: CPU user
1,623.7 (33.4%) 09:14:03 INFO - TinderboxPrint: Swap in / out
443,883,520 / 0 09:14:03 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390521344; Write bytes: 382651904; Read time: 28958; Write time: 830 09:14:03 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 30854144; Write bytes: 294992896; Read time: 181; Write time: 1103 09:14:03 INFO - Running post-run listener: _upload_blobber_files 09:14:03 INFO - Blob upload gear active. 09:14:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:14:03 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 09:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:14:04 INFO - (blobuploader) - INFO - Open directory for files ... 09:14:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:14:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:14:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:05 INFO - (blobuploader) - INFO - Done attempting. 09:14:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:14:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:14:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:06 INFO - (blobuploader) - INFO - Done attempting. 09:14:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:14:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:14:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:08 INFO - (blobuploader) - INFO - Done attempting. 09:14:08 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:08 INFO - Return code: 0 09:14:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:14:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1f0d0db784589fb291fe1288c84217f9a4230fcf0fcbaa136281e516b90f84f0bb1bad343c80c8c778b835279ca6988d99dfd796de3ddb45a1b3d5f7ba4feec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99b1728a41d5f1d31e370327de697faf4d108b525c84a32a5c87a89f3902cdefd6f37ca54ba768654448fbd2be6825c9b22dc12670afe73a7986e7a91f33eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e4a4daa9c10c15989f070a7e77489771d77c298cad676d139fe75284f234dd899bc41a71a3ce603090800a0e5915553986744d5d5123ef895893d38fbd16863"} 09:14:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:14:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:14:08 INFO - Contents: 09:14:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1f0d0db784589fb291fe1288c84217f9a4230fcf0fcbaa136281e516b90f84f0bb1bad343c80c8c778b835279ca6988d99dfd796de3ddb45a1b3d5f7ba4feec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99b1728a41d5f1d31e370327de697faf4d108b525c84a32a5c87a89f3902cdefd6f37ca54ba768654448fbd2be6825c9b22dc12670afe73a7986e7a91f33eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e4a4daa9c10c15989f070a7e77489771d77c298cad676d139fe75284f234dd899bc41a71a3ce603090800a0e5915553986744d5d5123ef895893d38fbd16863"} 09:14:08 INFO - Running post-run listener: copy_logs_to_upload_dir 09:14:08 INFO - Copying logs to upload dir... 09:14:08 INFO - mkdir: /builds/slave/test/build/upload/logs 09:14:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.206915 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-10-29 09:14:08.963484) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 09:14:08.966646) ========= 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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1f0d0db784589fb291fe1288c84217f9a4230fcf0fcbaa136281e516b90f84f0bb1bad343c80c8c778b835279ca6988d99dfd796de3ddb45a1b3d5f7ba4feec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99b1728a41d5f1d31e370327de697faf4d108b525c84a32a5c87a89f3902cdefd6f37ca54ba768654448fbd2be6825c9b22dc12670afe73a7986e7a91f33eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e4a4daa9c10c15989f070a7e77489771d77c298cad676d139fe75284f234dd899bc41a71a3ce603090800a0e5915553986744d5d5123ef895893d38fbd16863"} build_url:https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011110 build_url: 'https://queue.taskcluster.net/v1/task/MsuNxgLIRWee8OqDUd7hDg/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1f0d0db784589fb291fe1288c84217f9a4230fcf0fcbaa136281e516b90f84f0bb1bad343c80c8c778b835279ca6988d99dfd796de3ddb45a1b3d5f7ba4feec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d99b1728a41d5f1d31e370327de697faf4d108b525c84a32a5c87a89f3902cdefd6f37ca54ba768654448fbd2be6825c9b22dc12670afe73a7986e7a91f33eb8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e4a4daa9c10c15989f070a7e77489771d77c298cad676d139fe75284f234dd899bc41a71a3ce603090800a0e5915553986744d5d5123ef895893d38fbd16863"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-29 09:14:08.999714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:14:09.000002) ========= 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.F2c0lzCSKs/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.xRM2v7l5fa/Listeners TMPDIR=/var/folders/b8/n19k_6s53931h2l5j8hbqxrr00000w/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.005175 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-29 09:14:09.048660) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 09:14:09.048929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-29 09:14:09.049202) ========= ========= Total master_lag: 0.17 =========