builder: larch_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0212 starttime: 1475873303.7 results: success (0) buildid: 20161007113100 builduid: d87b637329c447ddab13a697c31a1695 revision: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 13:48:23.703519) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 13:48:23.703979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 13:48:23.704272) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 13:48:23.727065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:48:23.727425) ========= 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.T0cyJXzknk/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.O5bXj7qNdP/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-07 13:48:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.21M=0.001s 2016-10-07 13:48:23 (8.21 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:48:23.848194) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:48:23.848530) ========= 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.T0cyJXzknk/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.O5bXj7qNdP/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.021339 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:48:23.896817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 13:48:23.897181) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 259c110bf47100196fd28e35c47c4e23bf9ad0a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 259c110bf47100196fd28e35c47c4e23bf9ad0a9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.T0cyJXzknk/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.O5bXj7qNdP/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-07 13:48:23,976 truncating revision to first 12 chars 2016-10-07 13:48:23,976 Setting DEBUG logging. 2016-10-07 13:48:23,976 attempt 1/10 2016-10-07 13:48:23,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/259c110bf471?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 13:48:25,465 unpacking tar archive at: larch-259c110bf471/testing/mozharness/ program finished with exit code 0 elapsedTime=1.776498 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 13:48:25.698094) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 13:48:25.698459) ========= script_repo_revision: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 13:48:25.698898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 13:48:25.699170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 13:48:25.717742) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-07 13:48:25.718144) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Larch', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.T0cyJXzknk/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.O5bXj7qNdP/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:48:25 INFO - MultiFileLogger online at 20161007 13:48:25 in /builds/slave/test 13:48:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch 13:48:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:48:25 INFO - {'append_to_log': False, 13:48:25 INFO - 'base_work_dir': '/builds/slave/test', 13:48:25 INFO - 'blob_upload_branch': 'Larch', 13:48:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:48:25 INFO - 'branch': 'Larch', 13:48:25 INFO - 'buildbot_json_path': 'buildprops.json', 13:48:25 INFO - 'config_files': ('talos/mac_config.py',), 13:48:25 INFO - 'default_actions': ('clobber', 13:48:25 INFO - 'read-buildbot-config', 13:48:25 INFO - 'download-and-extract', 13:48:25 INFO - 'populate-webroot', 13:48:25 INFO - 'create-virtualenv', 13:48:25 INFO - 'install', 13:48:25 INFO - 'run-tests'), 13:48:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:48:25 INFO - 'download_minidump_stackwalk': True, 13:48:25 INFO - 'download_symbols': 'ondemand', 13:48:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:48:25 INFO - 'tooltool.py': '/tools/tooltool.py', 13:48:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:48:25 INFO - '/tools/misc-python/virtualenv.py')}, 13:48:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:48:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:48:25 INFO - 'installer_path': 'installer.exe', 13:48:25 INFO - 'log_level': 'info', 13:48:25 INFO - 'log_name': 'talos', 13:48:25 INFO - 'log_to_console': True, 13:48:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:48:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:48:25 INFO - 'opt_config_files': (), 13:48:25 INFO - 'pip_index': False, 13:48:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:25 INFO - 'cmd': ('bash', 13:48:25 INFO - '-c', 13:48:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:25 INFO - 'enabled': True, 13:48:25 INFO - 'halt_on_failure': False, 13:48:25 INFO - 'name': 'check_screen_resolution'},), 13:48:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:48:25 INFO - 'cmd': ('bash', 13:48:25 INFO - '-c', 13:48:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:48:25 INFO - 'enabled': True, 13:48:25 INFO - 'halt_on_failure': False, 13:48:25 INFO - 'name': 'check_screen_resolution'},), 13:48:25 INFO - 'run_cmd_checks_enabled': True, 13:48:25 INFO - 'sps_profile': False, 13:48:25 INFO - 'sps_profile_interval': 0, 13:48:25 INFO - 'suite': 'dromaeojs-e10s', 13:48:25 INFO - 'system_bits': '32', 13:48:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:48:25 INFO - 'title': 't-yosemite-r7-0212', 13:48:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:48:25 INFO - 'use_talos_json': True, 13:48:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:48:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:48:25 INFO - 'work_dir': 'build'} 13:48:25 INFO - [mozharness: 2016-10-07 20:48:25.930440Z] Running clobber step. 13:48:25 INFO - Running pre-action listener: _resource_record_pre_action 13:48:25 INFO - Running main action method: clobber 13:48:25 INFO - rmtree: /builds/slave/test/build 13:48:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:48:26 INFO - Running post-action listener: _resource_record_post_action 13:48:26 INFO - [mozharness: 2016-10-07 20:48:26.194818Z] Finished clobber step (success) 13:48:26 INFO - [mozharness: 2016-10-07 20:48:26.194986Z] Running read-buildbot-config step. 13:48:26 INFO - Running pre-action listener: _resource_record_pre_action 13:48:26 INFO - Running main action method: read_buildbot_config 13:48:26 INFO - Using buildbot properties: 13:48:26 INFO - { 13:48:26 INFO - "project": "", 13:48:26 INFO - "product": "firefox", 13:48:26 INFO - "script_repo_revision": "production", 13:48:26 INFO - "builddir": "larch_yosemite_r7_test-dromaeojs-e10s", 13:48:26 INFO - "repository": "", 13:48:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 larch talos dromaeojs-e10s", 13:48:26 INFO - "buildid": "20161007113100", 13:48:26 INFO - "pgo_build": "False", 13:48:26 INFO - "basedir": "/builds/slave/test", 13:48:26 INFO - "buildnumber": 0, 13:48:26 INFO - "slavename": "t-yosemite-r7-0212", 13:48:26 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 13:48:26 INFO - "platform": "yosemite_r7", 13:48:26 INFO - "scheduler": "tests-larch-macosx64-talos", 13:48:26 INFO - "branch": "larch", 13:48:26 INFO - "repo_path": "projects/larch", 13:48:26 INFO - "revision": "259c110bf47100196fd28e35c47c4e23bf9ad0a9", 13:48:26 INFO - "stage_platform": "macosx64", 13:48:26 INFO - "builduid": "d87b637329c447ddab13a697c31a1695", 13:48:26 INFO - "slavebuilddir": "test" 13:48:26 INFO - } 13:48:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 13:48:26 INFO - Running post-action listener: _resource_record_post_action 13:48:26 INFO - [mozharness: 2016-10-07 20:48:26.198513Z] Finished read-buildbot-config step (success) 13:48:26 INFO - [mozharness: 2016-10-07 20:48:26.198654Z] Running download-and-extract step. 13:48:26 INFO - Running pre-action listener: _resource_record_pre_action 13:48:26 INFO - Running main action method: download_and_extract 13:48:26 INFO - mkdir: /builds/slave/test/build/tests 13:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:26 INFO - trying https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 13:48:26 INFO - Downloading https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:48:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 13:48:27 INFO - Downloaded 1199 bytes. 13:48:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 13:48:27 INFO - Using the following test package requirements: 13:48:27 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:48:27 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:48:27 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 13:48:27 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:48:27 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 13:48:27 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:48:27 INFO - u'jsshell-mac.zip'], 13:48:27 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:48:27 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 13:48:27 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 13:48:27 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:48:27 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 13:48:27 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:48:27 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 13:48:27 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:48:27 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 13:48:27 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 13:48:27 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 13:48:27 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:48:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:48:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:48:27 INFO - Fetch https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:48:28 INFO - Http code: 200 13:48:28 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 13:48:28 INFO - x-amz-cf-id: g9a42KzqNoJV68khI6REm9og7rG_jAU_AzcfUaLKGE37nvUMMjV2UA== 13:48:28 INFO - x-amz-version-id: uoRuJuWFVsBoBltmFRzNYqwhQAYRFNNk 13:48:28 INFO - Expected file size: 16476601 13:48:28 INFO - Obtained file size: 16476601 13:48:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 13:48:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 13:48:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:48:34 INFO - Fetch https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 13:48:35 INFO - Http code: 200 13:48:35 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 13:48:35 INFO - x-amz-cf-id: 3MVP1bCukOuDfEwcq8Fa2uv0Sr0ySCcLljdf82NUcw1Dhx68ycYk7w== 13:48:35 INFO - x-amz-version-id: uoRuJuWFVsBoBltmFRzNYqwhQAYRFNNk 13:48:35 INFO - Expected file size: 16476601 13:48:35 INFO - Obtained file size: 16476601 13:48:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 13:48:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:48:42 INFO - Fetch https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 13:48:42 INFO - Http code: 200 13:48:42 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 13:48:42 INFO - x-amz-cf-id: OamBMZYGYFkPiLbGvzOG8Gyqihz73trIPk0IqE6aNLXViEBO83hHIw== 13:48:42 INFO - x-amz-version-id: ngPJjYaV5z1WIH9Cbzvo30ButOOxvblz 13:48:42 INFO - Expected file size: 14408522 13:48:42 INFO - Obtained file size: 14408522 13:48:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:43 INFO - trying https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:48:43 INFO - Downloading https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 13:48:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 13:48:45 INFO - Downloaded 111657336 bytes. 13:48:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:48:45 INFO - mkdir: /builds/slave/test/properties 13:48:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:48:45 INFO - Writing to file /builds/slave/test/properties/build_url 13:48:45 INFO - Contents: 13:48:45 INFO - build_url:https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 13:48:46 INFO - Running post-action listener: _resource_record_post_action 13:48:46 INFO - Running post-action listener: set_extra_try_arguments 13:48:46 INFO - [mozharness: 2016-10-07 20:48:46.596427Z] Finished download-and-extract step (success) 13:48:46 INFO - [mozharness: 2016-10-07 20:48:46.596553Z] Running populate-webroot step. 13:48:46 INFO - Running pre-action listener: _resource_record_pre_action 13:48:46 INFO - Running main action method: populate_webroot 13:48:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:48:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:48:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:48:46 INFO - '--tppagecycles', 13:48:46 INFO - '7'], 13:48:46 INFO - 'tests': ['tsvgm']}}, 13:48:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:48:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:48:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:48:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:48:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:48:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:48:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:46 INFO - 'talos_options': ['--disable-e10s'], 13:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:48:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:46 INFO - 'talos_options': ['--disable-e10s'], 13:48:46 INFO - 'tests': ['damp', 'tps']}, 13:48:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:46 INFO - 'tests': ['damp', 'tps']}, 13:48:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:48:46 INFO - 'tests': ['dromaeo_dom']}, 13:48:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:48:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:48:46 INFO - 'tests': ['basic_compositor_video']}, 13:48:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:48:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:48:46 INFO - 'tests': ['a11yr', 13:48:46 INFO - 'ts_paint', 13:48:46 INFO - 'tpaint', 13:48:46 INFO - 'sessionrestore', 13:48:46 INFO - 'sessionrestore_no_auto_restore', 13:48:46 INFO - 'tabpaint']}, 13:48:46 INFO - 'other-e10s': {'tests': ['a11yr', 13:48:46 INFO - 'ts_paint', 13:48:46 INFO - 'tpaint', 13:48:46 INFO - 'sessionrestore', 13:48:46 INFO - 'sessionrestore_no_auto_restore', 13:48:46 INFO - 'tabpaint']}, 13:48:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:48:46 INFO - 'ts_paint', 13:48:46 INFO - 'tpaint', 13:48:46 INFO - 'sessionrestore', 13:48:46 INFO - 'sessionrestore_no_auto_restore', 13:48:46 INFO - 'tabpaint']}, 13:48:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:48:46 INFO - 'ts_paint', 13:48:46 INFO - 'tpaint', 13:48:46 INFO - 'sessionrestore', 13:48:46 INFO - 'sessionrestore_no_auto_restore', 13:48:46 INFO - 'tabpaint']}, 13:48:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:48:46 INFO - 'tests': ['a11yr', 13:48:46 INFO - 'ts_paint', 13:48:46 INFO - 'tpaint', 13:48:46 INFO - 'sessionrestore', 13:48:46 INFO - 'sessionrestore_no_auto_restore', 13:48:46 INFO - 'tabpaint']}, 13:48:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:48:46 INFO - 'tests': ['a11yr', 13:48:46 INFO - 'ts_paint', 13:48:46 INFO - 'tpaint', 13:48:46 INFO - 'sessionrestore', 13:48:46 INFO - 'sessionrestore_no_auto_restore', 13:48:46 INFO - 'tabpaint']}, 13:48:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:48:46 INFO - 'tests': ['tsvgx', 13:48:46 INFO - 'tsvgr_opacity', 13:48:46 INFO - 'tart', 13:48:46 INFO - 'tscrollx', 13:48:46 INFO - 'cart']}, 13:48:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:48:46 INFO - 'tsvgr_opacity', 13:48:46 INFO - 'tart', 13:48:46 INFO - 'tscrollx', 13:48:46 INFO - 'cart']}, 13:48:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:46 INFO - 'talos_options': ['--disable-e10s'], 13:48:46 INFO - 'tests': ['tp5o']}, 13:48:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:46 INFO - 'tests': ['tp5o']}, 13:48:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:46 INFO - 'talos_options': ['--disable-e10s', 13:48:46 INFO - '--xperf_path', 13:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:46 INFO - 'tests': ['tp5n']}, 13:48:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:48:46 INFO - 'talos_options': ['--xperf_path', 13:48:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:48:46 INFO - 'tests': ['tp5n']}}, 13:48:46 INFO - 'talos.zip': {'path': '', 13:48:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:48:46 INFO - Running post-action listener: _resource_record_post_action 13:48:46 INFO - [mozharness: 2016-10-07 20:48:46.615068Z] Finished populate-webroot step (success) 13:48:46 INFO - [mozharness: 2016-10-07 20:48:46.615181Z] Running create-virtualenv step. 13:48:46 INFO - Running pre-action listener: _resource_record_pre_action 13:48:46 INFO - Running main action method: create_virtualenv 13:48:46 INFO - Creating virtualenv /builds/slave/test/build/venv 13:48:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:48:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:48:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:48:46 INFO - Using real prefix '/tools/python27' 13:48:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:48:47 INFO - Installing distribute.............................................................................................................................................................................................done. 13:48:50 INFO - Installing pip.................done. 13:48:50 INFO - Return code: 0 13:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:48:50 INFO - Reading from file tmpfile_stdout 13:48:50 INFO - Output received: 13:48:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:48:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:50 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 0x104ebf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e35570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febca499360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cd3d30>, '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 0x104af9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ccbb20>, '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.T0cyJXzknk/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.O5bXj7qNdP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:48:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0cyJXzknk/Render', 13:48:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:50 INFO - 'HOME': '/Users/cltbld', 13:48:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:50 INFO - 'LOGNAME': 'cltbld', 13:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:50 INFO - 'MOZ_NO_REMOTE': '1', 13:48:50 INFO - 'NO_EM_RESTART': '1', 13:48:50 INFO - 'PAGER': '/bin/cat', 13:48:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:50 INFO - 'PWD': '/builds/slave/test', 13:48:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:50 INFO - 'SHELL': '/bin/bash', 13:48:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O5bXj7qNdP/Listeners', 13:48:50 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:48:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:50 INFO - 'USER': 'cltbld', 13:48:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:50 INFO - 'XPC_FLAGS': '0x0', 13:48:50 INFO - 'XPC_SERVICE_NAME': '0', 13:48:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:48:50 INFO - Cleaning up... 13:48:50 INFO - Return code: 0 13:48:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:50 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 0x104ebf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e35570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febca499360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cd3d30>, '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 0x104af9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ccbb20>, '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.T0cyJXzknk/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.O5bXj7qNdP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:48:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:48:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0cyJXzknk/Render', 13:48:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:50 INFO - 'HOME': '/Users/cltbld', 13:48:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:50 INFO - 'LOGNAME': 'cltbld', 13:48:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:50 INFO - 'MOZ_NO_REMOTE': '1', 13:48:50 INFO - 'NO_EM_RESTART': '1', 13:48:50 INFO - 'PAGER': '/bin/cat', 13:48:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:50 INFO - 'PWD': '/builds/slave/test', 13:48:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:50 INFO - 'SHELL': '/bin/bash', 13:48:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O5bXj7qNdP/Listeners', 13:48:50 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:48:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:50 INFO - 'USER': 'cltbld', 13:48:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:50 INFO - 'XPC_FLAGS': '0x0', 13:48:50 INFO - 'XPC_SERVICE_NAME': '0', 13:48:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:51 INFO - Downloading/unpacking psutil>=3.1.1 13:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:48:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:48:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:48:54 INFO - Installing collected packages: psutil 13:48:54 INFO - Running setup.py install for psutil 13:48:54 INFO - building 'psutil._psutil_osx' extension 13:48:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:48:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:48:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:48:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:48:54 INFO - building 'psutil._psutil_posix' extension 13:48:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:48:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:48:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:48:54 INFO - ^ 13:48:55 INFO - 1 warning generated. 13:48:55 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:48:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:48:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:48:55 INFO - Successfully installed psutil 13:48:55 INFO - Cleaning up... 13:48:55 INFO - Return code: 0 13:48:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:55 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 0x104ebf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e35570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febca499360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cd3d30>, '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 0x104af9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ccbb20>, '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.T0cyJXzknk/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.O5bXj7qNdP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:48:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0cyJXzknk/Render', 13:48:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:55 INFO - 'HOME': '/Users/cltbld', 13:48:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:55 INFO - 'LOGNAME': 'cltbld', 13:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:55 INFO - 'MOZ_NO_REMOTE': '1', 13:48:55 INFO - 'NO_EM_RESTART': '1', 13:48:55 INFO - 'PAGER': '/bin/cat', 13:48:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:55 INFO - 'PWD': '/builds/slave/test', 13:48:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:55 INFO - 'SHELL': '/bin/bash', 13:48:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O5bXj7qNdP/Listeners', 13:48:55 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:48:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:55 INFO - 'USER': 'cltbld', 13:48:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:55 INFO - 'XPC_FLAGS': '0x0', 13:48:55 INFO - 'XPC_SERVICE_NAME': '0', 13:48:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:48:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:48:58 INFO - Installing collected packages: mozsystemmonitor 13:48:58 INFO - Running setup.py install for mozsystemmonitor 13:48:58 INFO - Successfully installed mozsystemmonitor 13:48:58 INFO - Cleaning up... 13:48:58 INFO - Return code: 0 13:48:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:48:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:48:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:48:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:48:58 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 0x104ebf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e35570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febca499360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cd3d30>, '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 0x104af9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ccbb20>, '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.T0cyJXzknk/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.O5bXj7qNdP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:48:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:48:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0cyJXzknk/Render', 13:48:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:48:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:48:58 INFO - 'HOME': '/Users/cltbld', 13:48:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:48:58 INFO - 'LOGNAME': 'cltbld', 13:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:48:58 INFO - 'MOZ_NO_REMOTE': '1', 13:48:58 INFO - 'NO_EM_RESTART': '1', 13:48:58 INFO - 'PAGER': '/bin/cat', 13:48:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:48:58 INFO - 'PWD': '/builds/slave/test', 13:48:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:48:58 INFO - 'SHELL': '/bin/bash', 13:48:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O5bXj7qNdP/Listeners', 13:48:58 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:48:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:48:58 INFO - 'USER': 'cltbld', 13:48:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:48:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:48:58 INFO - 'XPC_FLAGS': '0x0', 13:48:58 INFO - 'XPC_SERVICE_NAME': '0', 13:48:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:48:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:48:58 INFO - Downloading/unpacking jsonschema==2.5.1 13:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:48:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:48:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:48:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:49:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:01 INFO - Downloading functools32-3.2.3-2.tar.gz 13:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:49:01 INFO - warning: no files found matching '*.txt' 13:49:01 INFO - no previously-included directories found matching 'build' 13:49:01 INFO - no previously-included directories found matching 'dist' 13:49:01 INFO - no previously-included directories found matching '.git*' 13:49:01 INFO - Installing collected packages: jsonschema, functools32 13:49:01 INFO - Running setup.py install for functools32 13:49:01 INFO - warning: no files found matching '*.txt' 13:49:01 INFO - no previously-included directories found matching 'build' 13:49:01 INFO - no previously-included directories found matching 'dist' 13:49:01 INFO - no previously-included directories found matching '.git*' 13:49:01 INFO - Successfully installed jsonschema functools32 13:49:01 INFO - Cleaning up... 13:49:01 INFO - Return code: 0 13:49:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:01 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 0x104ebf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e35570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febca499360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cd3d30>, '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 0x104af9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ccbb20>, '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.T0cyJXzknk/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.O5bXj7qNdP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:49:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:49:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0cyJXzknk/Render', 13:49:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:01 INFO - 'HOME': '/Users/cltbld', 13:49:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:01 INFO - 'LOGNAME': 'cltbld', 13:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:01 INFO - 'MOZ_NO_REMOTE': '1', 13:49:01 INFO - 'NO_EM_RESTART': '1', 13:49:01 INFO - 'PAGER': '/bin/cat', 13:49:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:01 INFO - 'PWD': '/builds/slave/test', 13:49:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:01 INFO - 'SHELL': '/bin/bash', 13:49:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O5bXj7qNdP/Listeners', 13:49:01 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:49:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:01 INFO - 'USER': 'cltbld', 13:49:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:01 INFO - 'XPC_FLAGS': '0x0', 13:49:01 INFO - 'XPC_SERVICE_NAME': '0', 13:49:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:49:02 INFO - Cleaning up... 13:49:02 INFO - Return code: 0 13:49:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104ebf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e35570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febca499360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cd3d30>, '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 0x104af9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ccbb20>, '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.T0cyJXzknk/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.O5bXj7qNdP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:49:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:49:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0cyJXzknk/Render', 13:49:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:02 INFO - 'HOME': '/Users/cltbld', 13:49:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:02 INFO - 'LOGNAME': 'cltbld', 13:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:02 INFO - 'MOZ_NO_REMOTE': '1', 13:49:02 INFO - 'NO_EM_RESTART': '1', 13:49:02 INFO - 'PAGER': '/bin/cat', 13:49:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:02 INFO - 'PWD': '/builds/slave/test', 13:49:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:02 INFO - 'SHELL': '/bin/bash', 13:49:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O5bXj7qNdP/Listeners', 13:49:02 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:49:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:02 INFO - 'USER': 'cltbld', 13:49:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:02 INFO - 'XPC_FLAGS': '0x0', 13:49:02 INFO - 'XPC_SERVICE_NAME': '0', 13:49:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:02 INFO - Downloading/unpacking blobuploader==1.2.4 13:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:04 INFO - Downloading blobuploader-1.2.4.tar.gz 13:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:49:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:49:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:05 INFO - Downloading docopt-0.6.1.tar.gz 13:49:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:49:06 INFO - Installing collected packages: blobuploader, requests, docopt 13:49:06 INFO - Running setup.py install for blobuploader 13:49:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:49:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:49:06 INFO - Running setup.py install for requests 13:49:06 INFO - Running setup.py install for docopt 13:49:06 INFO - Successfully installed blobuploader requests docopt 13:49:06 INFO - Cleaning up... 13:49:06 INFO - Return code: 0 13:49:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:06 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 0x104ebf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e35570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febca499360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cd3d30>, '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 0x104af9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ccbb20>, '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.T0cyJXzknk/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.O5bXj7qNdP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:49:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0cyJXzknk/Render', 13:49:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:06 INFO - 'HOME': '/Users/cltbld', 13:49:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:06 INFO - 'LOGNAME': 'cltbld', 13:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:06 INFO - 'MOZ_NO_REMOTE': '1', 13:49:06 INFO - 'NO_EM_RESTART': '1', 13:49:06 INFO - 'PAGER': '/bin/cat', 13:49:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:06 INFO - 'PWD': '/builds/slave/test', 13:49:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:06 INFO - 'SHELL': '/bin/bash', 13:49:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O5bXj7qNdP/Listeners', 13:49:06 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:49:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:06 INFO - 'USER': 'cltbld', 13:49:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:06 INFO - 'XPC_FLAGS': '0x0', 13:49:06 INFO - 'XPC_SERVICE_NAME': '0', 13:49:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:07 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-RuNgqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:07 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-MOcl7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:07 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-dkEfRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:07 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-VQ7RwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:07 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Euh9lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:07 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-7kSSBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:07 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-SH9gPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:07 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-2BiciB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:07 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-31lvyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:08 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Cm_O7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:08 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-9vmA5E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:08 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-fUA6dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:08 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-TOeiFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:08 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-cxKNqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:08 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-IYVo07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:08 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-on623n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:08 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-pR8fCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:49:08 INFO - Running setup.py install for manifestparser 13:49:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:49:09 INFO - Running setup.py install for mozcrash 13:49:09 INFO - Running setup.py install for mozdebug 13:49:09 INFO - Running setup.py install for mozdevice 13:49:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:49:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:49:09 INFO - Running setup.py install for mozfile 13:49:09 INFO - Running setup.py install for mozhttpd 13:49:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:49:09 INFO - Running setup.py install for mozinfo 13:49:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:49:09 INFO - Running setup.py install for mozInstall 13:49:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:49:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:49:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:49:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:49:10 INFO - Running setup.py install for mozleak 13:49:10 INFO - Running setup.py install for mozlog 13:49:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:49:10 INFO - Running setup.py install for moznetwork 13:49:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:49:10 INFO - Running setup.py install for mozprocess 13:49:10 INFO - Running setup.py install for mozprofile 13:49:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:49:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:49:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:49:10 INFO - Running setup.py install for mozrunner 13:49:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:49:11 INFO - Running setup.py install for mozscreenshot 13:49:11 INFO - Running setup.py install for moztest 13:49:11 INFO - Running setup.py install for mozversion 13:49:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:49:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:49:11 INFO - Cleaning up... 13:49:11 INFO - Return code: 0 13:49:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49: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')]} 13:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49: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')]} 13:49:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:11 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 0x104ebf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e35570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febca499360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cd3d30>, '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 0x104af9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ccbb20>, '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.T0cyJXzknk/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.O5bXj7qNdP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:49:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:49:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:49:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0cyJXzknk/Render', 13:49:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:11 INFO - 'HOME': '/Users/cltbld', 13:49:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:11 INFO - 'LOGNAME': 'cltbld', 13:49:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:11 INFO - 'MOZ_NO_REMOTE': '1', 13:49:11 INFO - 'NO_EM_RESTART': '1', 13:49:11 INFO - 'PAGER': '/bin/cat', 13:49:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:11 INFO - 'PWD': '/builds/slave/test', 13:49:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:11 INFO - 'SHELL': '/bin/bash', 13:49:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O5bXj7qNdP/Listeners', 13:49:11 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:49:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:11 INFO - 'USER': 'cltbld', 13:49:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:11 INFO - 'XPC_FLAGS': '0x0', 13:49:11 INFO - 'XPC_SERVICE_NAME': '0', 13:49:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:49:11 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-TAuM86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:49:11 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-dsTzeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:49:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:49:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:49:11 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-V5fcO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:49:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-tyWIaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:49:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-zZlD8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:49:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-t744Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:49:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-W8ZhhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:49:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-2sStHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:49:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-yLgvxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:49:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-BH71Vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:49:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-ut_p4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:49:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:49:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:49:12 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-iLjwQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:49:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-hNlBfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:49:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-etbAo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Vv4wOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:49:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-Vrc51Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:49:13 INFO - Running setup.py (path:/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/pip-eChaz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:49:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:49:16 INFO - Downloading blessings-1.6.tar.gz 13:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:49:16 INFO - Installing collected packages: blessings 13:49:16 INFO - Running setup.py install for blessings 13:49:16 INFO - Successfully installed blessings 13:49:16 INFO - Cleaning up... 13:49:16 INFO - Return code: 0 13:49:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:49:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:16 INFO - Reading from file tmpfile_stdout 13:49:16 INFO - Current package versions: 13:49:16 INFO - blessings == 1.6 13:49:16 INFO - blobuploader == 1.2.4 13:49:16 INFO - docopt == 0.6.1 13:49:16 INFO - functools32 == 3.2.3-2 13:49:16 INFO - jsonschema == 2.5.1 13:49:16 INFO - manifestparser == 1.1 13:49:16 INFO - mozInstall == 1.12 13:49:16 INFO - mozcrash == 0.17 13:49:16 INFO - mozdebug == 0.1 13:49:16 INFO - mozdevice == 0.48 13:49:16 INFO - mozfile == 1.2 13:49:16 INFO - mozhttpd == 0.7 13:49:16 INFO - mozinfo == 0.9 13:49:16 INFO - mozleak == 0.1 13:49:16 INFO - mozlog == 3.4 13:49:16 INFO - moznetwork == 0.27 13:49:16 INFO - mozprocess == 0.23 13:49:16 INFO - mozprofile == 0.28 13:49:16 INFO - mozrunner == 6.12 13:49:16 INFO - mozscreenshot == 0.1 13:49:16 INFO - mozsystemmonitor == 0.3 13:49:16 INFO - moztest == 0.7 13:49:16 INFO - mozversion == 1.4 13:49:16 INFO - psutil == 3.1.1 13:49:16 INFO - requests == 1.2.3 13:49:16 INFO - wsgiref == 0.1.2 13:49:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:16 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 0x104ebf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e35570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febca499360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cd3d30>, '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 0x104af9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ccbb20>, '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.T0cyJXzknk/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.O5bXj7qNdP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:49:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0cyJXzknk/Render', 13:49:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:16 INFO - 'HOME': '/Users/cltbld', 13:49:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:16 INFO - 'LOGNAME': 'cltbld', 13:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:16 INFO - 'MOZ_NO_REMOTE': '1', 13:49:16 INFO - 'NO_EM_RESTART': '1', 13:49:16 INFO - 'PAGER': '/bin/cat', 13:49:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:16 INFO - 'PWD': '/builds/slave/test', 13:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:16 INFO - 'SHELL': '/bin/bash', 13:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O5bXj7qNdP/Listeners', 13:49:16 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:16 INFO - 'USER': 'cltbld', 13:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:16 INFO - 'XPC_FLAGS': '0x0', 13:49:16 INFO - 'XPC_SERVICE_NAME': '0', 13:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:49:16 INFO - Cleaning up... 13:49:16 INFO - Return code: 0 13:49:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:49:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104ebf490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e35570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febca499360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cd3d30>, '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 0x104af9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ccbb20>, '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.T0cyJXzknk/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.O5bXj7qNdP/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:49:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0cyJXzknk/Render', 13:49:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:16 INFO - 'HOME': '/Users/cltbld', 13:49:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:16 INFO - 'LOGNAME': 'cltbld', 13:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:16 INFO - 'MOZ_NO_REMOTE': '1', 13:49:16 INFO - 'NO_EM_RESTART': '1', 13:49:16 INFO - 'PAGER': '/bin/cat', 13:49:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:16 INFO - 'PWD': '/builds/slave/test', 13:49:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:16 INFO - 'SHELL': '/bin/bash', 13:49:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O5bXj7qNdP/Listeners', 13:49:16 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:49:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:16 INFO - 'USER': 'cltbld', 13:49:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:16 INFO - 'XPC_FLAGS': '0x0', 13:49:16 INFO - 'XPC_SERVICE_NAME': '0', 13:49:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:49:17 INFO - Cleaning up... 13:49:17 INFO - Return code: 0 13:49:17 INFO - Running post-action listener: _resource_record_post_action 13:49:17 INFO - Running post-action listener: _start_resource_monitoring 13:49:17 INFO - Starting resource monitoring. 13:49:17 INFO - [mozharness: 2016-10-07 20:49:17.281387Z] Finished create-virtualenv step (success) 13:49:17 INFO - [mozharness: 2016-10-07 20:49:17.282373Z] Running install step. 13:49:17 INFO - Running pre-action listener: _resource_record_pre_action 13:49:17 INFO - Running main action method: install 13:49:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:49:17 INFO - Reading from file tmpfile_stdout 13:49:17 INFO - Detecting whether we're running mozinstall >=1.0... 13:49:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:49:17 INFO - Reading from file tmpfile_stdout 13:49:17 INFO - Output received: 13:49:17 INFO - Usage: mozinstall [options] installer 13:49:17 INFO - Options: 13:49:17 INFO - -h, --help show this help message and exit 13:49:17 INFO - -d DEST, --destination=DEST 13:49:17 INFO - Directory to install application into. [default: 13:49:17 INFO - "/builds/slave/test"] 13:49:17 INFO - --app=APP Application being installed. [default: firefox] 13:49:17 INFO - mkdir: /builds/slave/test/build/application 13:49:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:49:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 13:49:52 INFO - Reading from file tmpfile_stdout 13:49:52 INFO - Output received: 13:49:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:49:52 INFO - Running post-action listener: _resource_record_post_action 13:49:52 INFO - [mozharness: 2016-10-07 20:49:52.287961Z] Finished install step (success) 13:49:52 INFO - [mozharness: 2016-10-07 20:49:52.288089Z] Running run-tests step. 13:49:52 INFO - Running pre-action listener: _resource_record_pre_action 13:49:52 INFO - Running main action method: run_tests 13:49:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:49:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:49:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:49:52 INFO - 2016-10-07 13:49:52.300 screenresolution[2002:278517] starting screenresolution argv=screenresolution get 13:49:52 INFO - 2016-10-07 13:49:52.302 screenresolution[2002:278517] Display 0: 1600x1200x32@60 13:49:52 INFO - 2016-10-07 13:49:52.307 screenresolution[2003:278519] starting screenresolution argv=screenresolution list 13:49:52 INFO - Available Modes on Display 0 13:49:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:49:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:49:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:49:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:49:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:49:52 INFO - Intel Iris: 13:49:52 INFO - Chipset Model: Intel Iris 13:49:52 INFO - Type: GPU 13:49:52 INFO - Bus: Built-In 13:49:52 INFO - VRAM (Dynamic, Max): 1536 MB 13:49:52 INFO - Vendor: Intel (0x8086) 13:49:52 INFO - Device ID: 0x0a2e 13:49:52 INFO - Revision ID: 0x0009 13:49:52 INFO - Displays: 13:49:52 INFO - Display: 13:49:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:49:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:49:52 INFO - Display Serial Number: 1600x1200 60 13:49:52 INFO - Main Display: Yes 13:49:52 INFO - Mirror: Off 13:49:52 INFO - Online: Yes 13:49:52 INFO - Rotation: Supported 13:49:52 INFO - Return code: 0 13:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:49:52 INFO - Python 2.7.3 13:49:52 INFO - Return code: 0 13:49:52 INFO - grabbing minidump binary from tooltool 13:49:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:49:52 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 0x104cd3d30>, '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 0x104af9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ccbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:49:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:49:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:49:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:49:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:49:52 INFO - Return code: 0 13:49:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:49:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:49:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:49:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:49:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0212 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:49:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T0cyJXzknk/Render', 13:49:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:49:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:49:52 INFO - 'HOME': '/Users/cltbld', 13:49:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:49:52 INFO - 'LOGNAME': 'cltbld', 13:49:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:49:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:49:52 INFO - 'MOZ_NO_REMOTE': '1', 13:49:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:49:52 INFO - 'NO_EM_RESTART': '1', 13:49:52 INFO - 'PAGER': '/bin/cat', 13:49:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:49:52 INFO - 'PWD': '/builds/slave/test', 13:49:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:49:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:49:52 INFO - 'SHELL': '/bin/bash', 13:49:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.O5bXj7qNdP/Listeners', 13:49:52 INFO - 'TMPDIR': '/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/', 13:49:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:49:52 INFO - 'USER': 'cltbld', 13:49:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:49:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:49:52 INFO - 'XPC_FLAGS': '0x0', 13:49:52 INFO - 'XPC_SERVICE_NAME': '0', 13:49:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:49:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0212', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:49:52 INFO - mozversion application_buildid: 20161007113100 13:49:52 INFO - mozversion application_changeset: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 13:49:52 INFO - mozversion application_display_name: Nightly 13:49:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:49:52 INFO - mozversion application_name: Firefox 13:49:52 INFO - mozversion application_remotingname: firefox 13:49:52 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 13:49:52 INFO - mozversion application_vendor: Mozilla 13:49:52 INFO - mozversion application_version: 52.0a1 13:49:52 INFO - mozversion platform_buildid: 20161007113100 13:49:52 INFO - mozversion platform_changeset: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 13:49:52 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 13:49:52 INFO - mozversion platform_version: 52.0a1 13:49:52 INFO - using testdate: 1475873392 13:49:52 INFO - actual date: 1475873392 13:49:52 INFO - starting webserver on 'localhost:49372' 13:49:52 INFO - SUITE-START | Running 2 tests 13:49:52 INFO - TEST-START | dromaeo_css 13:49:52 INFO - operating with platform_type : mac_ 13:49:52 INFO - Initialising browser for dromaeo_css test... 13:49:52 INFO - TEST-INFO | started process 2013 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmpc8U6ZF/profile http://localhost:49372/getInfo.html) 13:49:55 INFO - PROCESS | 2013 | 2016-10-07 13:49:55.833 plugin-container[2016:278683] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d37, name = 'com.apple.tsm.portname' 13:49:55 INFO - PROCESS | 2013 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:49:55 INFO - PROCESS | 2013 | 2016-10-07 13:49:55.835 plugin-container[2016:278683] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 13:49:55 INFO - PROCESS | 2013 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:49:55 INFO - PROCESS | 2013 | 2016-10-07 13:49:55.835 plugin-container[2016:278683] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:49:55 INFO - PROCESS | 2013 | __metrics Screen width/height:1600/1200 13:49:55 INFO - PROCESS | 2013 | colorDepth:24 13:49:55 INFO - PROCESS | 2013 | Browser inner width/height: 1024/689 13:49:55 INFO - PROCESS | 2013 | __metrics 13:49:55 ERROR - PROCESS | 2013 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 13:49:56 INFO - TEST-INFO | 2013: exit 0 13:49:56 INFO - Browser initialized. 13:49:56 INFO - Running cycle 1/1 for dromaeo_css test... 13:49:56 INFO - TEST-INFO | started process 2018 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmpc8U6ZF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:49:59 INFO - PROCESS | 2018 | 2016-10-07 13:49:59.182 plugin-container[2019:278808] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.tsm.portname' 13:49:59 INFO - PROCESS | 2018 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:49:59 INFO - PROCESS | 2018 | 2016-10-07 13:49:59.184 plugin-container[2019:278808] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 13:49:59 INFO - PROCESS | 2018 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:49:59 INFO - PROCESS | 2018 | 2016-10-07 13:49:59.184 plugin-container[2019:278808] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:50:08 INFO - PROCESS | 2018 | RSS: Main: 246157312 13:50:08 INFO - PROCESS | 2018 | 13:50:58 INFO - PROCESS | 2018 | 1475873458429 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:53:11 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49372/tests/dromaeo/cssquery-ext.html) 13:53:13 INFO - PROCESS | 2018 | RSS: Main: 258916352 13:53:13 INFO - PROCESS | 2018 | 13:56:15 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-ext.html (next: http://localhost:49372/tests/dromaeo/cssquery-jquery.html) 13:56:16 INFO - PROCESS | 2018 | RSS: Main: 269791232 13:56:16 INFO - PROCESS | 2018 | 13:59:18 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49372/tests/dromaeo/cssquery-mootools.html) 13:59:18 INFO - PROCESS | 2018 | RSS: Main: 273264640 13:59:18 INFO - PROCESS | 2018 | 14:02:20 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49372/tests/dromaeo/cssquery-prototype.html) 14:02:21 INFO - PROCESS | 2018 | RSS: Main: 273039360 14:02:21 INFO - PROCESS | 2018 | 14:05:24 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49372/tests/dromaeo/cssquery-yui.html) 14:05:24 INFO - PROCESS | 2018 | RSS: Main: 278355968 14:05:24 INFO - PROCESS | 2018 | 14:08:27 INFO - PROCESS | 2018 | Cycle 1(1): loaded http://localhost:49372/tests/dromaeo/cssquery-yui.html (next: http://localhost:49372/tests/dromaeo/cssquery-dojo.html) 14:08:27 INFO - PROCESS | 2018 | RSS: Main: 280899584 14:08:27 INFO - PROCESS | 2018 | 14:08:27 INFO - PROCESS | 2018 | __start_tp_report 14:08:27 INFO - PROCESS | 2018 | _x_x_mozilla_page_load 14:08:27 INFO - PROCESS | 2018 | _x_x_mozilla_page_load_details 14:08:27 INFO - PROCESS | 2018 | |i|pagename|runs| 14:08:27 INFO - PROCESS | 2018 | |0;dojo.html;2826.2227887330996;3326.1518312830226;3343.548620936174;3356.5972083349984;3382.171368014835;5627.380988091307;5701.315842098954;5702.201691763156;5750.3962083981205;5856.355800861902;5652.971735141318;5687.8578035549135;5754.625949313292;5796.391378905207;5827.03853864113;4730.952690473103;4837.443693975203;5197.584193264549;5224.399194092671;5285.339332583427;5231.424543300234;5324.41431442541;5343.839684809462;5394.352677678665;5406.864828379283;4299.828006879721;5137.357830271216;5238.109521381374;5267.28891599633;5275.815346462875;5222.973885130588;5227.843164705065;5228.058949389108;5231.267622532849;5244.711540865251;5129.563987061104;5166.612504062173;5238.633295669305;5246.108161612535;5314.9468505314835;4328.0045589514275;4623.30650402439;5740.253767010262;5748.367679555246;5750.137479378127;6198.287196972361;6250.718717657671;6278.529110316745;6279.529035322324;6287.056941458772;6001.849953751192;6011.699415029231;6059.606125601822;6133.212252453595;6151.569390142692;5595.048841696921;5597.132444471114;5597.216389705444;5615.2700148980775;5624.240727501776;6120.510359171256;6171.537134714914;6181.320054793969;6191.783287584913;6207.720652570645;5871.6183448075735;5929.4070592941225;5994.700264986734;6065.939340606626;6077.604955677955;6141.385861413823;6244.937550624436;6275.497960163268;6287.811365659038;6292.779752708633;6143;6147.815565532952;6189.721462534197;6201.81394558164;6237.781677641261;6199.380061993765;6230.563860529719;6243.094751261133;6264.21697287839;6295.96852015737;4806.134895718735;4874.0495603357;4906.288588154697;4908;4937.925931111036;3993.821822562351;4232.597903199191;4407.537208593116;4411.779411029435;4434.645228381722;5413.242146099549;5749.13762935563;5793.304803423616;5840.269966254218;5851.912221316684;5475.972620136874;6009.549283803733;6130.826205142237;6195.907061394083;6236;5032.823851165265;5834.824955251349;5837.883242335214;5889.146073819272;5889.528837692974;5449.264349312872;5457.263269458573;5462.989346970744;5464.153056276284;5472.425395333512;6047.092936059538;6129.35641757609;6242.531810114168;6354.459870910932;6369.235691717024;6127.525510585677;6176.166217560752;6191.84520386994;6235.376462353728;6243.063540468966;6380.170577824853;6380.840478988062;6382.585131966407;6397.456216221487;6412.807615771534;6197;6229.563930525001;6244.687765611792;6254.3745625437095;6259.217597800275;6043.425874541911;6105.45050945417;6114.449440885012;6121.2700689216845;6164.075388691732;5874.676892770768;5992.700364981821;6027.698615069141;6030.48740857032;6065.909011364744;5801.477866991991;5900.616459930091;5951.672658003851;6029.336772955059;6056.152138700673;5785.190073389813;5793.739281732248;5807.680577568274;5824.737886795019;5852.092925596539;6010.368911264254;6055.061465472859;6061.15143879866;6106.278657334014;6188.040853667689;6009.248843894513;6025.1564780931585;6034.366391528826;6035.517158627212;6073.453389194994 14:08:27 INFO - PROCESS | 2018 | |1;ext.html;517.0899217377416;531.572084472;534.4121466386972;534.6284332388989;535.3950036458801;39652;41582.960425989324;41631.79184104075;43271;43647.56352436475;42100;42191.36712949308;42322.36516452248;42481;42548;9694.321397502177;9887.258455615822;9890.15933645641;9896.901030989706;9940.90059099407;9804.019598040175;9862;9886.802263954716;9911.702648920507;9944.502774861228;8591.957040214791;9855.753606159868;9947.552360143774;9964.850527242097;10236.385816851012;9840.114389704926;9881.654142105028;9911.653092141813;9922.355046921963;9936.552855121538;9671.661491847752;9740.951295243549;9765.365251258645;9768.413895166314;9772.706818795448;40330;40465.5837045702;40642.79678601617;40724.59275407238;40892.97767555805;3274.0832566881313;3380.492926061086;3524.4713293006;4030.294698427793;4086.4074709167303;30882.227944301347;31240.906568270002;31601.683983160103;31636.367272654647;31877.609179311414;3226.774125811194;3345.1469875181915;3360.3615313090436;3390.9491357629654;3392;413368.9331553353;415529;420336.89831550955;420845.7915420837;421609;59325.406745931985;59819;59852.40147598468;60009.399906000384;60085.39914600886;62084.379156208764;62335;62365;62662.686686566274;63066.73866522644;14915.328810203568;14989.250537473083;14991.925040374947;15005.324760385809;15007.624809379635;12253.69365765863;12266.693332666755;12274.754504909852;12294.200876943149;12299.323537205539;17934.840284410253;18740.437786866416;18765.7185142223;18877.961712105967;18890;8031.799205019921;8060.435769496196;8091.595420228965;8131.90219320396;8161.102278749333;886.3219636977717;951.0869565217469;1011.1910471622673;1047.1413440978324;1083.263380900995;29664.258393540335;29909.953151639587;30172.17245240751;30636.54045189324;30742.923997659975;927.6057675488025;954.4511905654276;1051.369178492898;1071.517816982361;1086.8043752124693;12959.416826242841;15039.097654140787;15165.545033648788;15297;15301.6174595636;653346;653521.732391335;658511;658748;661502.1549353527;48082.55752327436;54936.450635493136;55310.723446383316;55564.72217638886;55761.44238557644;1184.3663639952756;1319.901007424447;1387.958361249144;1388.7708528092953;1391.0262816028821;25865;27660.58509122405;28572.714272857007;29287.41425171442;29356.559651604817;48690.5130948686;49463.752681237806;49494;49563.504364957334;49633.75183124061;628534;632619;633591;633815;635365;25583.232503024195;25612.87193564095;25719.742802572484;25752.61371079398;25793.323433976733;44309;45367.54632453765;45489;45642.77178614086;45921.77039114783;37349;37557;37639.43540846944;38755;38917.80541097277;31678.04965851028;37331;38182;38382.424263636625;39935.400968984904;37910.0522486929;38449;38465.4230186553;38758.6124138755;38963;32359.51460728138;33482;34550.82724586361;34924.825375872955;35487.82256088703;25707;25815.870920646026;25956;26090.60864087078;26309.473810524065 14:08:27 INFO - PROCESS | 2018 | |2;jquery.html;341.6685814759684;345.80868906616706;346.42320536307045;357.2052183890845;377.3377722097718;16649.750253746202;19826.314763245122;20448.488787780312;20946.581068378644;21167.894160529177;20248.898755506238;20660.690089648666;20684.586308273825;20780.272690455837;20851.582968340623;5709.457601527848;5809.506191973687;5823.155642431845;6109.022556390978;6117.908231376533;5866.120081987715;6047.818565443044;6048.6068405553715;6054.636721796706;6055.6063855849225;5724.8282551523525;5922.14128951304;5952.434518720715;5990.970045149768;6002.159697642333;5807.361190269067;5855.326637436707;5922.170896074553;5925.911111333334;5929.644221346712;5018.84943451697;5030;5046.9747651261505;5094.923576146361;5099.286099945974;25406;25416.237512874643;25500.36249093769;25893;25911.35221619456;2216.26863135165;2250.9774902250933;2375.393663629952;2429.6477010833505;3049.9630125757126;12519.874801251963;14662.973591848575;15562.922185389114;15753.448629298035;16298.940568863105;1843.3548258109688;1869.2055876252539;1901.8858868467798;1902.9904850475798;1962.80371962804;62712;127553.89784408612;131859.34070329586;133243.0040648173;136146;10857.402842843561;11454.312741235386;11473.254238474472;11550;11696.766064678659;14164;14222.573322800332;14412.76602126672;14440;14447.060941038799;8222;8460.323174146053;8484.490930544063;8499.61751721174;8653.307735381155;8263.793405164919;8313.916860831314;8376.581170941428;8397.160283971554;8461.95769021151;4412.382266482695;4510.571495707903;4515.616172625298;4576.931346029813;4629.213033784265;1891.101726679816;1941.0973897137899;1981.6135853508715;1987.960240795176;2004.2383894120142;763.412172627074;837.4138103327573;885.1369914333474;891.3270480786964;980.9993806317516;18066.36767713124;19377.128029238716;21765;21766.12935482563;21977.890110549346;891.2513488669549;896.112848280211;909.5315912305168;927.6335847340263;929.5723966975132;9529.90470095304;9635.134257200069;10838.403887786248;11551.249168804;11612.76774464506;587401;597831;606790;619498;620131;117899;118499.8150018506;120163;121123;122895;920.9677661281823;962.7159987803615;985.2758222706306;989.7525618595207;990.5641517732175;19320.13059412358;19477.902610487425;19626.313079042164;19741.309054183035;19801.108950096994;37086.62913370939;38193;38640.6135938637;53757.46242537525;54865.78775016367;75371.62314188613;76442;76643.61678191573;78290.6085469569;78912;7739.148693643582;7765.495242809199;8054.187807743211;8264.752057438287;8328.6668533258;7039.6832142552685;10666.626668066581;10900.781984360427;13167.078304518593;13548.796768048684;11186.049185819296;11321.03771179426;11450.083993280685;11464;11704.414779261173;11076.612318568812;11163.832542512031;11166.776664466828;11350.035247004098;11522.942385288019;11365.943170284096;11421.828672570084;11775.528978841094;11781.52873885035;11939.641810745692;7760.30157285847;7933.523988560705;8136.308413784895;8298.377621678277;8301.128381519853;9941.353812002197;10809.405482698527;11040.503177356877;11162.274452160584;11256.21206515536 14:08:27 INFO - PROCESS | 2018 | |3;mootools.html;1337.3447010964628;1481.6369989352606;1644.2354305248057;1827.4974382044945;1835.1466568045864;8103.473274237171;8403.5378054207;8602;9221.63113475461;9222.985471598118;8678.958524977012;8978.595963181657;8996.730098097067;9110.180083792457;9134.817303653923;2341.262502311775;2360.8347415680864;2386.5226954609147;2390.1634427950253;2394.521095780842;2327.3367090379247;2352.623580227164;2370.3363058343607;2376.263358358914;2379.5478859016816;2363.4800343924308;2366.1363602285214;2372.181597348912;2374.988125059372;2384.1178763857397;2326.4649130700036;2337.4506990857135;2345.718513778349;2353.1646265575732;2362.9409264768346;2277.1574517428494;2277.703898493202;2290.7022087128566;2291.873946932918;2296.666983287431;8157.510549367057;8783.78040548985;9037.277017838624;9085.364024518287;9181.311401644836;5088.974555127238;5248.842534723926;5339.733013349317;5375.381831089436;5377.381601115882;3498.510208570802;3644.398674218751;3690.206605579813;3717.070732316921;3717.3308804415196;1042.3329069395593;1077.9191560632985;1082.3235477826358;1109.9889001109966;1114.9442527873573;11736.237144585575;11793.056555475541;11844.28934263947;11868.643940681879;11897.821532677017;4526.140033393644;4582.518835522289;4762.047590481918;4800.783964721596;4821.5178482152205;10075.596976120873;10100.242481813746;10160.187185025181;10169.084782369622;10178.491075446198;5237.764300606482;5332.92000619991;5355.223492593552;5370.03339398912;5370.060239458079;4399.36209249657;4558.247889098262;4723.7401942893475;4851;4878.341423907798;3825.3688141456346;3870.729048966545;3934.881953541398;3956.802159891994;3995.4006898965386;1080.5245691895698;1168.1472525056756;1270.5299039355498;1284.28722059258;1284.5760898903338;813.2802469814256;872.4111224923279;910.5037754423855;929.8837645294338;941.1670671455811;4755.976220118947;5808.825735227865;5909.084091965752;6037.486813620803;6068.514518838482;430.6597787747707;437.78110944527737;440.62106588334007;447.75373544550365;452.19734970427754;3531.858725650945;3562.625924277965;3569.910752231215;3580.695640870555;3637.5089362935664;10783.568657253621;10816.188785841094;11018.39398833072;11125.998660120627;11153;10754.354738715701;11021.889781102087;11033.282836615594;11118.888811111947;11123.332600044023;8065.919340806634;8199.508029518249;8410.789730256793;8440.53577053268;8468.745937621881;5731.484166425042;5746;5808.477237048686;5812.912806307993;5914.083317085859;10253.794924101625;10278.33190842593;10298.897011029794;10302.433366164632;10314.896851031393;9756.951215243878;10071.093601575893;10222;10248.026437488426;10429;6560.573562718408;6926.9307306926285;7131.964340178266;7393.963030184815;7679.500832445873;8320.334373250005;8356.206160414751;8395.24442800151;8426.831463370576;8562.57187140628;7458.701651933862;7537.359324457482;7581.848363032598;7616.657250423855;7679.347255483346;7344.339009489172;7404.259574042552;7436;7525.736599219001;7541.170471248268;6971.51199416036;7131.108611423572;7134.429245660439;7135.286471352823;7143.714251429885;4902.362692849907;4915.041566894564;4997.85006449807;5046.369203849519;5123.052235336475;5040.873978150576;5091.923621145612;5161.612879034163;5187.818426355059;5263.157894736823 14:08:27 INFO - PROCESS | 2018 | |4;prototype.html;297.06276697020905;304.1483845233347;311.1924555777756;313.1810316023599;314.78122704720226;5354.6613346663335;5529.3364796224405;5547.44525547445;5567.471090246425;5629.791019119099;4984.850454486362;5082.4917508249155;5270.894582108355;5410.971915336084;5472.34331880174;4112.527059388179;4128.56650051744;4141.012314089239;4149.9792501037455;4190.706650534464;3831.8467261309515;3836.827342769568;3846.5576458707187;3874.1476875087437;4150.916981660365;3688.8524459021605;3792.184680293736;3813.036286312551;4068.7965601719943;4135.338345864662;3679.9816000919823;3942.48747662802;3990.361542153256;4106.488951946073;4119.567445418218;3375.71306438953;3504.789712617251;3532.2405682778067;3551.698105661022;3585.4621806728937;4651.720896746206;5323.334583177103;5358.410574836765;5363.490468405495;5364.222187782789;4664.5335466453425;4695.835645752382;4713.552212539803;4724.858254252378;4729.361536192604;5252.684838909678;5531.3915469298345;5749.770009199627;5802.361740208574;5814.592978491507;3450.0339904826437;3779.6409341112826;3875.399313106473;3899.3566061599804;3902.5902280260448;6050.96974515129;6059.7273122709585;6132.877342453126;6153.476954458876;6163.627003603645;3085.382923415281;3782.3569993101237;3866.033491627093;3874.8375487353683;3981.462502562117;3398.895359008283;3777.6411240932066;3979.6816254700134;3988.481497405319;4009.599040095967;4667.276572131325;4680.602148817388;4689.413823272091;4701.553352431513;4714.878304762802;5362.570994320445;5670.780782131861;5797.2173756542325;5815.331236907809;5838.591298609056;1210.9455074521668;1274.6749578857518;1288.2463758701078;1353.0325817040864;1356.3015047250674;811.7443005453264;882.5057967538199;898.1691934960136;906.9274458043341;934.6541779541477;4752.5485078917445;5377.596680248918;5405.7837686492885;5408.594355423359;5428.782848686087;5920.171176035358;5926.318473375531;5933.893467818948;5962.850928726816;5972.611780234271;4743.193657078305;4954.176119611859;5390.730463476811;5403.405625381205;5414.431484694129;3113.9844300778805;3123.2191952012;3157.7947433416753;3166.366726654678;3177.809331440121;5073.543381095646;5092.949070509321;6233.470155036873;6263.655498947602;6301.243850737941;5305.787768489295;5439.3200849893765;5816.912746308809;6107.877842443127;6176.104464852661;5721.685307308138;6219.689015549205;6291.622502649856;6292.206721084469;6307.495400367868;5333.959877823787;5846.626042880005;5861.912071318849;5960.4635582797755;6077.784443111307;5021.49785021495;5939.584229103922;5942.881142377215;5945.821625351246;5956.463918247378;5476.972615137058;5747.4252574742195;6241.595640980743;6248.312685604671;6254.405831446005;3319.5850518685165;3774.773198710485;4035.233305671913;4060.852839049642;4064.9268872874454;4968.764056174664;5254.474552544868;5641.746121424464;5875.6474611523445;5971.402859713994;5519.668819870821;5641.746121424464;5666.886662266649;5756.395578464369;5822.155787410887;5078.822241221687;5208.270842082035;5711.314642242957;5754.31723696826;5885.323187833283;5100.5409513143995;5273.393559740525;5721.799737009184;5740.966626007359;5766.336871259691;5850.414958504116;5855.560832937462;5896.528277737856;5935.703214839327;5958.76164953397;4930.852074437773;5464.672119672832;5552.861178470571;5766.884662306814;5787.045137552257 14:08:27 INFO - PROCESS | 2018 | |5;yui.html;666.3170250493243;711.1714852197188;723.9855202895939;757.9805162057035;823.1562648285507;14817.481388151404;15465.458708945189;15594.37622495099;15780.526584202464;15797;14419.423223071064;14436.206008669518;14519.637009074779;14552.345144468498;14598.124112553254;697.2295613347254;852.910444403338;876.023234093987;876.1326286975911;879.551428771328;707.253847191213;841.167244428018;865.9567021648924;874.7375787263827;877.3682948277262;913.6071489259616;915.771057235691;916.294453270981;916.4547094478808;919.4621146629197;883.4257732473911;893.1782759860911;910.877031600732;911.129870973219;911.6717981526712;619.5848781316483;620.6896551724138;646.014827388232;674.305465370669;675.5507587454337;14493.202873841934;14535.636609084751;14544.34550445222;14548.854511454962;14581.562553123424;14253.50112746049;14424.35090420923;14461.566153015427;14535.709285814224;14588.416463341453;11790.705232369259;11861.94069029658;11871.287722736663;11875.34685592292;11877.762444751057;3828.502294701671;3834.309824231665;3878.3406820840523;3881.825317860703;4002.419649150886;99534.5023274879;100088;100871.49564252132;109307.15046318319;109700;10990.17573681977;11102.833457498144;11104.869379334248;11129.998300153025;11253.71865703364;17736.29054837818;21813.345599632037;22072.33782986513;22478.438039049153;22495.550088998127;7821.022372203474;7952.84094318122;8008.199180081945;8079.798005049921;8097.433179677484;3913.0804260998643;4383.408239887574;4411.2941929291155;4472.731636101845;4474.306482495218;3559.537260156163;3676.3933950897804;3679.2273622539565;3688.944665830015;3857.7299589029058;707;713.5789883968483;724.8941824001284;729.0595132279407;736.9373603243677;576.1760682224459;593.8930992421406;620.996895015522;630.3035146163515;654.2214764430407;9420.90579094214;9582.069295864585;9656.71029869105;9679.370840895319;9731.854022189673;536.7530935769589;610.2615834839894;643.5173619785161;670.5607826873405;675.6486626953956;4031.879043628696;4739.984140204565;4770.160909718686;4778.1638213312535;4847.997058808897;144891.5510844899;164246.7876606189;164917;167116;169712.66580337952;130831;133182;133424;133753;134431.32784336017;78814;118969;120945.39527302483;122693.38653306676;123638.14542781866;9073.727788166365;9280.72157835266;9501.002394748451;9802.36284641496;10018.3488073275;48036.27945580749;50937.23594146165;54005.729971349894;62133;64330.678346607965;92231;97524;98382.52426213755;98761.6052635534;99373.50939736054;11323.358113073722;12614.306213158365;12956.28740419286;13012.21926684402;13099.541516046893;14550.4907328243;14846.77729834075;14965.77551336709;14989.700205995601;15022.248887555797;13699.109557878706;13764.17414955106;13868.4452621894;14100;14372.28138593087;13738.519151829638;13765.311734413439;13776.380062896993;13839.446422143;14053.22707251111;11242.550297988317;13350.866491335351;13930.094543854617;14025.789613156016;14257.358418871383;10863.185261105291;11043.779124417628;11713.297202167898;11823.645290641294;11830.763384732429;9709.465979371202;10478.79042419132;11404.156030632059;11554.653360399201;11622.6513204604 14:08:27 INFO - PROCESS | 2018 | __end_tp_report 14:08:27 INFO - PROCESS | 2018 | __start_cc_report 14:08:27 INFO - PROCESS | 2018 | _x_x_mozilla_cycle_collect,366 14:08:27 INFO - PROCESS | 2018 | __end_cc_report 14:08:27 INFO - PROCESS | 2018 | __startTimestamp1475874507836__endTimestamp 14:08:27 INFO - PROCESS | 2018 | 14:08:27 INFO - PROCESS | 2018 | ------- Summary: start ------- 14:08:27 INFO - PROCESS | 2018 | Number of tests: 6 14:08:27 INFO - PROCESS | 2018 | 14:08:27 INFO - PROCESS | 2018 | [#0] dojo.html Cycles:165 Average:5689.16 Median:5889.15 stddev:673.43 (11.4%) stddev-sans-first:636.95 14:08:27 INFO - PROCESS | 2018 | Values: 2826.2 3326.2 3343.5 3356.6 3382.2 5627.4 5701.3 5702.2 5750.4 5856.4 5653.0 5687.9 5754.6 5796.4 5827.0 4731.0 4837.4 5197.6 5224.4 5285.3 5231.4 5324.4 5343.8 5394.4 5406.9 4299.8 5137.4 5238.1 5267.3 5275.8 5223.0 5227.8 5228.1 5231.3 5244.7 5129.6 5166.6 5238.6 5246.1 5314.9 4328.0 4623.3 5740.3 5748.4 5750.1 6198.3 6250.7 6278.5 6279.5 6287.1 6001.8 6011.7 6059.6 6133.2 6151.6 5595.0 5597.1 5597.2 5615.3 5624.2 6120.5 6171.5 6181.3 6191.8 6207.7 5871.6 5929.4 5994.7 6065.9 6077.6 6141.4 6244.9 6275.5 6287.8 6292.8 6143.0 6147.8 6189.7 6201.8 6237.8 6199.4 6230.6 6243.1 6264.2 6296.0 4806.1 4874.0 4906.3 4908.0 4937.9 3993.8 4232.6 4407.5 4411.8 4434.6 5413.2 5749.1 5793.3 5840.3 5851.9 5476.0 6009.5 6130.8 6195.9 6236.0 5032.8 5834.8 5837.9 5889.1 5889.5 5449.3 5457.3 5463.0 5464.2 5472.4 6047.1 6129.4 6242.5 6354.5 6369.2 6127.5 6176.2 6191.8 6235.4 6243.1 6380.2 6380.8 6382.6 6397.5 6412.8 6197.0 6229.6 6244.7 6254.4 6259.2 6043.4 6105.5 6114.4 6121.3 6164.1 5874.7 5992.7 6027.7 6030.5 6065.9 5801.5 5900.6 5951.7 6029.3 6056.2 5785.2 5793.7 5807.7 5824.7 5852.1 6010.4 6055.1 6061.2 6106.3 6188.0 6009.2 6025.2 6034.4 6035.5 6073.5 14:08:27 INFO - PROCESS | 2018 | 14:08:27 INFO - PROCESS | 2018 | [#1] ext.html Cycles:180 Average:70059.83 Median:22405.50 stddev:155144.13 (692.4%) stddev-sans-first:155491.49 14:08:27 INFO - PROCESS | 2018 | Values: 517.1 531.6 534.4 534.6 535.4 39652.0 41583.0 41631.8 43271.0 43647.6 42100.0 42191.4 42322.4 42481.0 42548.0 9694.3 9887.3 9890.2 9896.9 9940.9 9804.0 9862.0 9886.8 9911.7 9944.5 8592.0 9855.8 9947.6 9964.9 10236.4 9840.1 9881.7 9911.7 9922.4 9936.6 9671.7 9741.0 9765.4 9768.4 9772.7 40330.0 40465.6 40642.8 40724.6 40893.0 3274.1 3380.5 3524.5 4030.3 4086.4 30882.2 31240.9 31601.7 31636.4 31877.6 3226.8 3345.1 3360.4 3390.9 3392.0 413368.9 415529.0 420336.9 420845.8 421609.0 59325.4 59819.0 59852.4 60009.4 60085.4 62084.4 62335.0 62365.0 62662.7 63066.7 14915.3 14989.3 14991.9 15005.3 15007.6 12253.7 12266.7 12274.8 12294.2 12299.3 17934.8 18740.4 18765.7 18878.0 18890.0 8031.8 8060.4 8091.6 8131.9 8161.1 886.3 951.1 1011.2 1047.1 1083.3 29664.3 29910.0 30172.2 30636.5 30742.9 927.6 954.5 1051.4 1071.5 1086.8 12959.4 15039.1 15165.5 15297.0 15301.6 653346.0 653521.7 658511.0 658748.0 661502.2 48082.6 54936.5 55310.7 55564.7 55761.4 1184.4 1319.9 1388.0 1388.8 1391.0 25865.0 27660.6 28572.7 29287.4 29356.6 48690.5 49463.8 49494.0 49563.5 49633.8 628534.0 632619.0 633591.0 633815.0 635365.0 25583.2 25612.9 25719.7 25752.6 25793.3 44309.0 45367.5 45489.0 45642.8 45921.8 37349.0 37557.0 37639.4 38755.0 38917.8 31678.0 37331.0 38182.0 38382.4 39935.4 37910.1 38449.0 38465.4 38758.6 38963.0 32359.5 33482.0 34550.8 34924.8 35487.8 25707.0 25815.9 25956.0 26090.6 26309.5 14:08:27 INFO - PROCESS | 2018 | 14:08:27 INFO - PROCESS | 2018 | [#2] jquery.html Cycles:180 Average:34886.83 Median:343.74 stddev:101008.97 (29385.4%) stddev-sans-first:101259.02 14:08:27 INFO - PROCESS | 2018 | Values: 341.7 345.8 346.4 357.2 377.3 16649.8 19826.3 20448.5 20946.6 21167.9 20248.9 20660.7 20684.6 20780.3 20851.6 5709.5 5809.5 5823.2 6109.0 6117.9 5866.1 6047.8 6048.6 6054.6 6055.6 5724.8 5922.1 5952.4 5991.0 6002.2 5807.4 5855.3 5922.2 5925.9 5929.6 5018.8 5030.0 5047.0 5094.9 5099.3 25406.0 25416.2 25500.4 25893.0 25911.4 2216.3 2251.0 2375.4 2429.6 3050.0 12519.9 14663.0 15562.9 15753.4 16298.9 1843.4 1869.2 1901.9 1903.0 1962.8 62712.0 127553.9 131859.3 133243.0 136146.0 10857.4 11454.3 11473.3 11550.0 11696.8 14164.0 14222.6 14412.8 14440.0 14447.1 8222.0 8460.3 8484.5 8499.6 8653.3 8263.8 8313.9 8376.6 8397.2 8462.0 4412.4 4510.6 4515.6 4576.9 4629.2 1891.1 1941.1 1981.6 1988.0 2004.2 763.4 837.4 885.1 891.3 981.0 18066.4 19377.1 21765.0 21766.1 21977.9 891.3 896.1 909.5 927.6 929.6 9529.9 9635.1 10838.4 11551.2 11612.8 587401.0 597831.0 606790.0 619498.0 620131.0 117899.0 118499.8 120163.0 121123.0 122895.0 921.0 962.7 985.3 989.8 990.6 19320.1 19477.9 19626.3 19741.3 19801.1 37086.6 38193.0 38640.6 53757.5 54865.8 75371.6 76442.0 76643.6 78290.6 78912.0 7739.1 7765.5 8054.2 8264.8 8328.7 7039.7 10666.6 10900.8 13167.1 13548.8 11186.0 11321.0 11450.1 11464.0 11704.4 11076.6 11163.8 11166.8 11350.0 11522.9 11365.9 11421.8 11775.5 11781.5 11939.6 7760.3 7933.5 8136.3 8298.4 8301.1 9941.4 10809.4 11040.5 11162.3 11256.2 14:08:27 INFO - PROCESS | 2018 | 14:08:27 INFO - PROCESS | 2018 | [#3] mootools.html Cycles:180 Average:5742.78 Median:4542.19 stddev:3298.98 (72.6%) stddev-sans-first:3291.62 14:08:27 INFO - PROCESS | 2018 | Values: 1337.3 1481.6 1644.2 1827.5 1835.1 8103.5 8403.5 8602.0 9221.6 9223.0 8679.0 8978.6 8996.7 9110.2 9134.8 2341.3 2360.8 2386.5 2390.2 2394.5 2327.3 2352.6 2370.3 2376.3 2379.5 2363.5 2366.1 2372.2 2375.0 2384.1 2326.5 2337.5 2345.7 2353.2 2362.9 2277.2 2277.7 2290.7 2291.9 2296.7 8157.5 8783.8 9037.3 9085.4 9181.3 5089.0 5248.8 5339.7 5375.4 5377.4 3498.5 3644.4 3690.2 3717.1 3717.3 1042.3 1077.9 1082.3 1110.0 1114.9 11736.2 11793.1 11844.3 11868.6 11897.8 4526.1 4582.5 4762.0 4800.8 4821.5 10075.6 10100.2 10160.2 10169.1 10178.5 5237.8 5332.9 5355.2 5370.0 5370.1 4399.4 4558.2 4723.7 4851.0 4878.3 3825.4 3870.7 3934.9 3956.8 3995.4 1080.5 1168.1 1270.5 1284.3 1284.6 813.3 872.4 910.5 929.9 941.2 4756.0 5808.8 5909.1 6037.5 6068.5 430.7 437.8 440.6 447.8 452.2 3531.9 3562.6 3569.9 3580.7 3637.5 10783.6 10816.2 11018.4 11126.0 11153.0 10754.4 11021.9 11033.3 11118.9 11123.3 8065.9 8199.5 8410.8 8440.5 8468.7 5731.5 5746.0 5808.5 5812.9 5914.1 10253.8 10278.3 10298.9 10302.4 10314.9 9757.0 10071.1 10222.0 10248.0 10429.0 6560.6 6926.9 7132.0 7394.0 7679.5 8320.3 8356.2 8395.2 8426.8 8562.6 7458.7 7537.4 7581.8 7616.7 7679.3 7344.3 7404.3 7436.0 7525.7 7541.2 6971.5 7131.1 7134.4 7135.3 7143.7 4902.4 4915.0 4997.9 5046.4 5123.1 5040.9 5091.9 5161.6 5187.8 5263.2 14:08:27 INFO - PROCESS | 2018 | 14:08:27 INFO - PROCESS | 2018 | [#4] prototype.html Cycles:180 Average:4678.87 Median:5344.31 stddev:1470.48 (27.5%) stddev-sans-first:1437.36 14:08:27 INFO - PROCESS | 2018 | Values: 297.1 304.1 311.2 313.2 314.8 5354.7 5529.3 5547.4 5567.5 5629.8 4984.9 5082.5 5270.9 5411.0 5472.3 4112.5 4128.6 4141.0 4150.0 4190.7 3831.8 3836.8 3846.6 3874.1 4150.9 3688.9 3792.2 3813.0 4068.8 4135.3 3680.0 3942.5 3990.4 4106.5 4119.6 3375.7 3504.8 3532.2 3551.7 3585.5 4651.7 5323.3 5358.4 5363.5 5364.2 4664.5 4695.8 4713.6 4724.9 4729.4 5252.7 5531.4 5749.8 5802.4 5814.6 3450.0 3779.6 3875.4 3899.4 3902.6 6051.0 6059.7 6132.9 6153.5 6163.6 3085.4 3782.4 3866.0 3874.8 3981.5 3398.9 3777.6 3979.7 3988.5 4009.6 4667.3 4680.6 4689.4 4701.6 4714.9 5362.6 5670.8 5797.2 5815.3 5838.6 1210.9 1274.7 1288.2 1353.0 1356.3 811.7 882.5 898.2 906.9 934.7 4752.5 5377.6 5405.8 5408.6 5428.8 5920.2 5926.3 5933.9 5962.9 5972.6 4743.2 4954.2 5390.7 5403.4 5414.4 3114.0 3123.2 3157.8 3166.4 3177.8 5073.5 5092.9 6233.5 6263.7 6301.2 5305.8 5439.3 5816.9 6107.9 6176.1 5721.7 6219.7 6291.6 6292.2 6307.5 5334.0 5846.6 5861.9 5960.5 6077.8 5021.5 5939.6 5942.9 5945.8 5956.5 5477.0 5747.4 6241.6 6248.3 6254.4 3319.6 3774.8 4035.2 4060.9 4064.9 4968.8 5254.5 5641.7 5875.6 5971.4 5519.7 5641.7 5666.9 5756.4 5822.2 5078.8 5208.3 5711.3 5754.3 5885.3 5100.5 5273.4 5721.8 5741.0 5766.3 5850.4 5855.6 5896.5 5935.7 5958.8 4930.9 5464.7 5552.9 5766.9 5787.0 14:08:27 INFO - PROCESS | 2018 | 14:08:27 INFO - PROCESS | 2018 | [#5] yui.html Cycles:180 Average:25283.29 Median:3684.09 stddev:41181.96 (1117.8%) stddev-sans-first:41256.01 14:08:27 INFO - PROCESS | 2018 | Values: 666.3 711.2 724.0 758.0 823.2 14817.5 15465.5 15594.4 15780.5 15797.0 14419.4 14436.2 14519.6 14552.3 14598.1 697.2 852.9 876.0 876.1 879.6 707.3 841.2 866.0 874.7 877.4 913.6 915.8 916.3 916.5 919.5 883.4 893.2 910.9 911.1 911.7 619.6 620.7 646.0 674.3 675.6 14493.2 14535.6 14544.3 14548.9 14581.6 14253.5 14424.4 14461.6 14535.7 14588.4 11790.7 11861.9 11871.3 11875.3 11877.8 3828.5 3834.3 3878.3 3881.8 4002.4 99534.5 100088.0 100871.5 109307.2 109700.0 10990.2 11102.8 11104.9 11130.0 11253.7 17736.3 21813.3 22072.3 22478.4 22495.6 7821.0 7952.8 8008.2 8079.8 8097.4 3913.1 4383.4 4411.3 4472.7 4474.3 3559.5 3676.4 3679.2 3688.9 3857.7 707.0 713.6 724.9 729.1 736.9 576.2 593.9 621.0 630.3 654.2 9420.9 9582.1 9656.7 9679.4 9731.9 536.8 610.3 643.5 670.6 675.6 4031.9 4740.0 4770.2 4778.2 4848.0 144891.6 164246.8 164917.0 167116.0 169712.7 130831.0 133182.0 133424.0 133753.0 134431.3 78814.0 118969.0 120945.4 122693.4 123638.1 9073.7 9280.7 9501.0 9802.4 10018.3 48036.3 50937.2 54005.7 62133.0 64330.7 92231.0 97524.0 98382.5 98761.6 99373.5 11323.4 12614.3 12956.3 13012.2 13099.5 14550.5 14846.8 14965.8 14989.7 15022.2 13699.1 13764.2 13868.4 14100.0 14372.3 13738.5 13765.3 13776.4 13839.4 14053.2 11242.6 13350.9 13930.1 14025.8 14257.4 10863.2 11043.8 11713.3 11823.6 11830.8 9709.5 10478.8 11404.2 11554.7 11622.7 14:08:27 INFO - PROCESS | 2018 | -------- Summary: end -------- 14:08:27 INFO - PROCESS | 2018 | 14:08:28 INFO - TEST-INFO | 2018: exit 0 14:08:28 INFO - TEST-OK | dromaeo_css | took 1115564ms 14:08:28 INFO - TEST-START | kraken 14:08:28 INFO - operating with platform_type : mac_ 14:08:28 INFO - Initialising browser for kraken test... 14:08:28 INFO - TEST-INFO | started process 2024 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmphysYRS/profile http://localhost:49372/getInfo.html) 14:08:31 INFO - PROCESS | 2024 | 2016-10-07 14:08:31.060 plugin-container[2025:280778] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c23, name = 'com.apple.tsm.portname' 14:08:31 INFO - PROCESS | 2024 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:08:31 INFO - PROCESS | 2024 | 2016-10-07 14:08:31.063 plugin-container[2025:280778] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f07, name = 'com.apple.CFPasteboardClient' 14:08:31 INFO - PROCESS | 2024 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:08:31 INFO - PROCESS | 2024 | 2016-10-07 14:08:31.063 plugin-container[2025:280778] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:08:31 INFO - PROCESS | 2024 | __metrics Screen width/height:1600/1200 14:08:31 INFO - PROCESS | 2024 | colorDepth:24 14:08:31 INFO - PROCESS | 2024 | Browser inner width/height: 1024/689 14:08:31 INFO - PROCESS | 2024 | __metrics 14:08:31 ERROR - PROCESS | 2024 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 14:08:31 INFO - TEST-INFO | 2024: exit 0 14:08:31 INFO - Browser initialized. 14:08:31 INFO - Running cycle 1/1 for kraken test... 14:08:31 INFO - TEST-INFO | started process 2026 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/T/tmphysYRS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:08:34 INFO - PROCESS | 2026 | 2016-10-07 14:08:34.370 plugin-container[2027:280891] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a1f, name = 'com.apple.tsm.portname' 14:08:34 INFO - PROCESS | 2026 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:08:34 INFO - PROCESS | 2026 | 2016-10-07 14:08:34.373 plugin-container[2027:280891] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9103, name = 'com.apple.CFPasteboardClient' 14:08:34 INFO - PROCESS | 2026 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:08:34 INFO - PROCESS | 2026 | 2016-10-07 14:08:34.373 plugin-container[2027:280891] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:08:44 INFO - PROCESS | 2026 | RSS: Main: 245760000 14:08:44 INFO - PROCESS | 2026 | 14:08:47 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-beat-detection) 14:08:48 INFO - PROCESS | 2026 | RSS: Main: 257744896 14:08:48 INFO - PROCESS | 2026 | 14:08:50 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-dft) 14:08:51 INFO - PROCESS | 2026 | RSS: Main: 265211904 14:08:51 INFO - PROCESS | 2026 | 14:08:54 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-fft) 14:08:55 INFO - PROCESS | 2026 | RSS: Main: 264015872 14:08:55 INFO - PROCESS | 2026 | 14:08:57 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49372/tests/kraken/driver.html?testName=audio-oscillator) 14:08:58 INFO - PROCESS | 2026 | RSS: Main: 266117120 14:08:58 INFO - PROCESS | 2026 | 14:08:59 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49372/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:09:00 INFO - PROCESS | 2026 | RSS: Main: 266436608 14:09:00 INFO - PROCESS | 2026 | 14:09:03 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49372/tests/kraken/driver.html?testName=imaging-darkroom) 14:09:04 INFO - PROCESS | 2026 | RSS: Main: 267120640 14:09:04 INFO - PROCESS | 2026 | 14:09:07 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49372/tests/kraken/driver.html?testName=imaging-desaturate) 14:09:08 INFO - PROCESS | 2026 | RSS: Main: 267255808 14:09:08 INFO - PROCESS | 2026 | 14:09:10 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49372/tests/kraken/driver.html?testName=json-parse-financial) 14:09:11 INFO - PROCESS | 2026 | RSS: Main: 267313152 14:09:11 INFO - PROCESS | 2026 | 14:09:13 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49372/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:09:13 INFO - PROCESS | 2026 | RSS: Main: 267481088 14:09:13 INFO - PROCESS | 2026 | 14:09:15 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:09:16 INFO - PROCESS | 2026 | RSS: Main: 267427840 14:09:16 INFO - PROCESS | 2026 | 14:09:18 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:09:19 INFO - PROCESS | 2026 | RSS: Main: 267370496 14:09:19 INFO - PROCESS | 2026 | 14:09:22 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:09:23 INFO - PROCESS | 2026 | RSS: Main: 267624448 14:09:23 INFO - PROCESS | 2026 | 14:09:26 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:09:26 INFO - PROCESS | 2026 | RSS: Main: 267440128 14:09:26 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | Cycle 1(1): loaded http://localhost:49372/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49372/tests/kraken/driver.html?testName=ai-astar) 14:09:28 INFO - PROCESS | 2026 | RSS: Main: 269045760 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | __start_tp_report 14:09:28 INFO - PROCESS | 2026 | _x_x_mozilla_page_load 14:09:28 INFO - PROCESS | 2026 | _x_x_mozilla_page_load_details 14:09:28 INFO - PROCESS | 2026 | |i|pagename|runs| 14:09:28 INFO - PROCESS | 2026 | |0;ai-astar;114;118;117;117;117;117;118;118;118;117 14:09:28 INFO - PROCESS | 2026 | |1;audio-beat-detection;145;115;103;178;138;124;119;116;163;132 14:09:28 INFO - PROCESS | 2026 | |2;audio-dft;202;206;233;201;200;198;198;197;194;195 14:09:28 INFO - PROCESS | 2026 | |3;audio-fft;82;59;60;87;84;54;104;81;103;82 14:09:28 INFO - PROCESS | 2026 | |4;audio-oscillator;78;70;86;73;69;70;88;70;71;86 14:09:28 INFO - PROCESS | 2026 | |5;imaging-gaussian-blur;94;76;84;99;91;84;133;86;129;90 14:09:28 INFO - PROCESS | 2026 | |6;imaging-darkroom;111;150;97;137;147;102;151;148;97;97 14:09:28 INFO - PROCESS | 2026 | |7;imaging-desaturate;90;93;92;91;97;92;91;92;93;92 14:09:28 INFO - PROCESS | 2026 | |8;json-parse-financial;56;57;57;57;66;84;79;84;82;82 14:09:28 INFO - PROCESS | 2026 | |9;json-stringify-tinderbox;67;75;70;91;94;75;60;82;96;99 14:09:28 INFO - PROCESS | 2026 | |10;stanford-crypto-aes;89;90;112;106;75;98;107;110;106;107 14:09:28 INFO - PROCESS | 2026 | |11;stanford-crypto-ccm;146;145;147;146;147;148;150;152;198;155 14:09:28 INFO - PROCESS | 2026 | |12;stanford-crypto-pbkdf2;179;173;174;204;237;172;176;174;176;189 14:09:28 INFO - PROCESS | 2026 | |13;stanford-crypto-sha256-iterative;70;70;73;71;69;70;69;70;82;87 14:09:28 INFO - PROCESS | 2026 | __end_tp_report 14:09:28 INFO - PROCESS | 2026 | __start_cc_report 14:09:28 INFO - PROCESS | 2026 | _x_x_mozilla_cycle_collect,956 14:09:28 INFO - PROCESS | 2026 | __end_cc_report 14:09:28 INFO - PROCESS | 2026 | __startTimestamp1475874568758__endTimestamp 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | ------- Summary: start ------- 14:09:28 INFO - PROCESS | 2026 | Number of tests: 14 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#0] ai-astar Cycles:10 Average:117.10 Median:117.50 stddev:1.20 (1.0%) stddev-sans-first:0.53 14:09:28 INFO - PROCESS | 2026 | Values: 114.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:135.00 stddev:23.30 (17.3%) stddev-sans-first:24.32 14:09:28 INFO - PROCESS | 2026 | Values: 145.0 115.0 103.0 178.0 138.0 124.0 119.0 116.0 163.0 132.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#2] audio-dft Cycles:10 Average:202.40 Median:200.50 stddev:11.31 (5.6%) stddev-sans-first:11.99 14:09:28 INFO - PROCESS | 2026 | Values: 202.0 206.0 233.0 201.0 200.0 198.0 198.0 197.0 194.0 195.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#3] audio-fft Cycles:10 Average:79.60 Median:81.50 stddev:17.30 (21.2%) stddev-sans-first:18.33 14:09:28 INFO - PROCESS | 2026 | Values: 82.0 59.0 60.0 87.0 84.0 54.0 104.0 81.0 103.0 82.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#4] audio-oscillator Cycles:10 Average:76.10 Median:75.50 stddev:7.74 (10.2%) stddev-sans-first:8.18 14:09:28 INFO - PROCESS | 2026 | Values: 78.0 70.0 86.0 73.0 69.0 70.0 88.0 70.0 71.0 86.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#5] imaging-gaussian-blur Cycles:10 Average:96.60 Median:88.00 stddev:19.20 (21.8%) stddev-sans-first:20.34 14:09:28 INFO - PROCESS | 2026 | Values: 94.0 76.0 84.0 99.0 91.0 84.0 133.0 86.0 129.0 90.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#6] imaging-darkroom Cycles:10 Average:123.70 Median:150.50 stddev:24.76 (16.5%) stddev-sans-first:25.83 14:09:28 INFO - PROCESS | 2026 | Values: 111.0 150.0 97.0 137.0 147.0 102.0 151.0 148.0 97.0 97.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#7] imaging-desaturate Cycles:10 Average:92.30 Median:92.00 stddev:1.89 (2.1%) stddev-sans-first:1.81 14:09:28 INFO - PROCESS | 2026 | Values: 90.0 93.0 92.0 91.0 97.0 92.0 91.0 92.0 93.0 92.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#8] json-parse-financial Cycles:10 Average:70.40 Median:80.50 stddev:12.82 (15.9%) stddev-sans-first:12.49 14:09:28 INFO - PROCESS | 2026 | Values: 56.0 57.0 57.0 57.0 66.0 84.0 79.0 84.0 82.0 82.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#9] json-stringify-tinderbox Cycles:10 Average:80.90 Median:86.50 stddev:13.54 (15.6%) stddev-sans-first:13.39 14:09:28 INFO - PROCESS | 2026 | Values: 67.0 75.0 70.0 91.0 94.0 75.0 60.0 82.0 96.0 99.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#10] stanford-crypto-aes Cycles:10 Average:100.00 Median:93.50 stddev:11.85 (12.7%) stddev-sans-first:11.88 14:09:28 INFO - PROCESS | 2026 | Values: 89.0 90.0 112.0 106.0 75.0 98.0 107.0 110.0 106.0 107.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#11] stanford-crypto-ccm Cycles:10 Average:153.40 Median:149.00 stddev:15.97 (10.7%) stddev-sans-first:16.72 14:09:28 INFO - PROCESS | 2026 | Values: 146.0 145.0 147.0 146.0 147.0 148.0 150.0 152.0 198.0 155.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.40 Median:177.50 stddev:20.64 (11.6%) stddev-sans-first:21.76 14:09:28 INFO - PROCESS | 2026 | Values: 179.0 173.0 174.0 204.0 237.0 172.0 176.0 174.0 176.0 189.0 14:09:28 INFO - PROCESS | 2026 | 14:09:28 INFO - PROCESS | 2026 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.10 Median:70.50 stddev:6.23 (8.8%) stddev-sans-first:6.50 14:09:28 INFO - PROCESS | 2026 | Values: 70.0 70.0 73.0 71.0 69.0 70.0 69.0 70.0 82.0 87.0 14:09:28 INFO - PROCESS | 2026 | -------- Summary: end -------- 14:09:28 INFO - PROCESS | 2026 | 14:09:29 INFO - TEST-INFO | 2026: exit 0 14:09:29 INFO - TEST-OK | kraken | took 61154ms 14:09:29 INFO - SUITE-END | took 1176s 14:09:29 INFO - Completed test suite (00:19:37) 14:09:29 INFO - javascript benchmark 14:09:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7370.327671497552, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2826.2227887330996, 3326.1518312830226, 3343.548620936174, 3356.5972083349984, 3382.171368014835, 5627.380988091307, 5701.315842098954, 5702.201691763156, 5750.3962083981205, 5856.355800861902, 5652.971735141318, 5687.8578035549135, 5754.625949313292, 5796.391378905207, 5827.03853864113, 4730.952690473103, 4837.443693975203, 5197.584193264549, 5224.399194092671, 5285.339332583427, 5231.424543300234, 5324.41431442541, 5343.839684809462, 5394.352677678665, 5406.864828379283, 4299.828006879721, 5137.357830271216, 5238.109521381374, 5267.28891599633, 5275.815346462875, 5222.973885130588, 5227.843164705065, 5228.058949389108, 5231.267622532849, 5244.711540865251, 5129.563987061104, 5166.612504062173, 5238.633295669305, 5246.108161612535, 5314.9468505314835, 4328.0045589514275, 4623.30650402439, 5740.253767010262, 5748.367679555246, 5750.137479378127, 6198.287196972361, 6250.718717657671, 6278.529110316745, 6279.529035322324, 6287.056941458772, 6001.849953751192, 6011.699415029231, 6059.606125601822, 6133.212252453595, 6151.569390142692, 5595.048841696921, 5597.132444471114, 5597.216389705444, 5615.2700148980775, 5624.240727501776, 6120.510359171256, 6171.537134714914, 6181.320054793969, 6191.783287584913, 6207.720652570645, 5871.6183448075735, 5929.4070592941225, 5994.700264986734, 6065.939340606626, 6077.604955677955, 6141.385861413823, 6244.937550624436, 6275.497960163268, 6287.811365659038, 6292.779752708633, 6143.0, 6147.815565532952, 6189.721462534197, 6201.81394558164, 6237.781677641261, 6199.380061993765, 6230.563860529719, 6243.094751261133, 6264.21697287839, 6295.96852015737, 4806.134895718735, 4874.0495603357, 4906.288588154697, 4908.0, 4937.925931111036, 3993.821822562351, 4232.597903199191, 4407.537208593116, 4411.779411029435, 4434.645228381722, 5413.242146099549, 5749.13762935563, 5793.304803423616, 5840.269966254218, 5851.912221316684, 5475.972620136874, 6009.549283803733, 6130.826205142237, 6195.907061394083, 6236.0, 5032.823851165265, 5834.824955251349, 5837.883242335214, 5889.146073819272, 5889.528837692974, 5449.264349312872, 5457.263269458573, 5462.989346970744, 5464.153056276284, 5472.425395333512, 6047.092936059538, 6129.35641757609, 6242.531810114168, 6354.459870910932, 6369.235691717024, 6127.525510585677, 6176.166217560752, 6191.84520386994, 6235.376462353728, 6243.063540468966, 6380.170577824853, 6380.840478988062, 6382.585131966407, 6397.456216221487, 6412.807615771534, 6197.0, 6229.563930525001, 6244.687765611792, 6254.3745625437095, 6259.217597800275, 6043.425874541911, 6105.45050945417, 6114.449440885012, 6121.2700689216845, 6164.075388691732, 5874.676892770768, 5992.700364981821, 6027.698615069141, 6030.48740857032, 6065.909011364744, 5801.477866991991, 5900.616459930091, 5951.672658003851, 6029.336772955059, 6056.152138700673, 5785.190073389813, 5793.739281732248, 5807.680577568274, 5824.737886795019, 5852.092925596539, 6010.368911264254, 6055.061465472859, 6061.15143879866, 6106.278657334014, 6188.040853667689, 6009.248843894513, 6025.1564780931585, 6034.366391528826, 6035.517158627212, 6073.453389194994], "value": 5644.508657596682, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.0899217377416, 531.572084472, 534.4121466386972, 534.6284332388989, 535.3950036458801, 39652.0, 41582.960425989324, 41631.79184104075, 43271.0, 43647.56352436475, 42100.0, 42191.36712949308, 42322.36516452248, 42481.0, 42548.0, 9694.321397502177, 9887.258455615822, 9890.15933645641, 9896.901030989706, 9940.90059099407, 9804.019598040175, 9862.0, 9886.802263954716, 9911.702648920507, 9944.502774861228, 8591.957040214791, 9855.753606159868, 9947.552360143774, 9964.850527242097, 10236.385816851012, 9840.114389704926, 9881.654142105028, 9911.653092141813, 9922.355046921963, 9936.552855121538, 9671.661491847752, 9740.951295243549, 9765.365251258645, 9768.413895166314, 9772.706818795448, 40330.0, 40465.5837045702, 40642.79678601617, 40724.59275407238, 40892.97767555805, 3274.0832566881313, 3380.492926061086, 3524.4713293006, 4030.294698427793, 4086.4074709167303, 30882.227944301347, 31240.906568270002, 31601.683983160103, 31636.367272654647, 31877.609179311414, 3226.774125811194, 3345.1469875181915, 3360.3615313090436, 3390.9491357629654, 3392.0, 413368.9331553353, 415529.0, 420336.89831550955, 420845.7915420837, 421609.0, 59325.406745931985, 59819.0, 59852.40147598468, 60009.399906000384, 60085.39914600886, 62084.379156208764, 62335.0, 62365.0, 62662.686686566274, 63066.73866522644, 14915.328810203568, 14989.250537473083, 14991.925040374947, 15005.324760385809, 15007.624809379635, 12253.69365765863, 12266.693332666755, 12274.754504909852, 12294.200876943149, 12299.323537205539, 17934.840284410253, 18740.437786866416, 18765.7185142223, 18877.961712105967, 18890.0, 8031.799205019921, 8060.435769496196, 8091.595420228965, 8131.90219320396, 8161.102278749333, 886.3219636977717, 951.0869565217469, 1011.1910471622673, 1047.1413440978324, 1083.263380900995, 29664.258393540335, 29909.953151639587, 30172.17245240751, 30636.54045189324, 30742.923997659975, 927.6057675488025, 954.4511905654276, 1051.369178492898, 1071.517816982361, 1086.8043752124693, 12959.416826242841, 15039.097654140787, 15165.545033648788, 15297.0, 15301.6174595636, 653346.0, 653521.732391335, 658511.0, 658748.0, 661502.1549353527, 48082.55752327436, 54936.450635493136, 55310.723446383316, 55564.72217638886, 55761.44238557644, 1184.3663639952756, 1319.901007424447, 1387.958361249144, 1388.7708528092953, 1391.0262816028821, 25865.0, 27660.58509122405, 28572.714272857007, 29287.41425171442, 29356.559651604817, 48690.5130948686, 49463.752681237806, 49494.0, 49563.504364957334, 49633.75183124061, 628534.0, 632619.0, 633591.0, 633815.0, 635365.0, 25583.232503024195, 25612.87193564095, 25719.742802572484, 25752.61371079398, 25793.323433976733, 44309.0, 45367.54632453765, 45489.0, 45642.77178614086, 45921.77039114783, 37349.0, 37557.0, 37639.43540846944, 38755.0, 38917.80541097277, 31678.04965851028, 37331.0, 38182.0, 38382.424263636625, 39935.400968984904, 37910.0522486929, 38449.0, 38465.4230186553, 38758.6124138755, 38963.0, 32359.51460728138, 33482.0, 34550.82724586361, 34924.825375872955, 35487.82256088703, 25707.0, 25815.870920646026, 25956.0, 26090.60864087078, 26309.473810524065], "value": 19942.88780719976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.6685814759684, 345.80868906616706, 346.42320536307045, 357.2052183890845, 377.3377722097718, 16649.750253746202, 19826.314763245122, 20448.488787780312, 20946.581068378644, 21167.894160529177, 20248.898755506238, 20660.690089648666, 20684.586308273825, 20780.272690455837, 20851.582968340623, 5709.457601527848, 5809.506191973687, 5823.155642431845, 6109.022556390978, 6117.908231376533, 5866.120081987715, 6047.818565443044, 6048.6068405553715, 6054.636721796706, 6055.6063855849225, 5724.8282551523525, 5922.14128951304, 5952.434518720715, 5990.970045149768, 6002.159697642333, 5807.361190269067, 5855.326637436707, 5922.170896074553, 5925.911111333334, 5929.644221346712, 5018.84943451697, 5030.0, 5046.9747651261505, 5094.923576146361, 5099.286099945974, 25406.0, 25416.237512874643, 25500.36249093769, 25893.0, 25911.35221619456, 2216.26863135165, 2250.9774902250933, 2375.393663629952, 2429.6477010833505, 3049.9630125757126, 12519.874801251963, 14662.973591848575, 15562.922185389114, 15753.448629298035, 16298.940568863105, 1843.3548258109688, 1869.2055876252539, 1901.8858868467798, 1902.9904850475798, 1962.80371962804, 62712.0, 127553.89784408612, 131859.34070329586, 133243.0040648173, 136146.0, 10857.402842843561, 11454.312741235386, 11473.254238474472, 11550.0, 11696.766064678659, 14164.0, 14222.573322800332, 14412.76602126672, 14440.0, 14447.060941038799, 8222.0, 8460.323174146053, 8484.490930544063, 8499.61751721174, 8653.307735381155, 8263.793405164919, 8313.916860831314, 8376.581170941428, 8397.160283971554, 8461.95769021151, 4412.382266482695, 4510.571495707903, 4515.616172625298, 4576.931346029813, 4629.213033784265, 1891.101726679816, 1941.0973897137899, 1981.6135853508715, 1987.960240795176, 2004.2383894120142, 763.412172627074, 837.4138103327573, 885.1369914333474, 891.3270480786964, 980.9993806317516, 18066.36767713124, 19377.128029238716, 21765.0, 21766.12935482563, 21977.890110549346, 891.2513488669549, 896.112848280211, 909.5315912305168, 927.6335847340263, 929.5723966975132, 9529.90470095304, 9635.134257200069, 10838.403887786248, 11551.249168804, 11612.76774464506, 587401.0, 597831.0, 606790.0, 619498.0, 620131.0, 117899.0, 118499.8150018506, 120163.0, 121123.0, 122895.0, 920.9677661281823, 962.7159987803615, 985.2758222706306, 989.7525618595207, 990.5641517732175, 19320.13059412358, 19477.902610487425, 19626.313079042164, 19741.309054183035, 19801.108950096994, 37086.62913370939, 38193.0, 38640.6135938637, 53757.46242537525, 54865.78775016367, 75371.62314188613, 76442.0, 76643.61678191573, 78290.6085469569, 78912.0, 7739.148693643582, 7765.495242809199, 8054.187807743211, 8264.752057438287, 8328.6668533258, 7039.6832142552685, 10666.626668066581, 10900.781984360427, 13167.078304518593, 13548.796768048684, 11186.049185819296, 11321.03771179426, 11450.083993280685, 11464.0, 11704.414779261173, 11076.612318568812, 11163.832542512031, 11166.776664466828, 11350.035247004098, 11522.942385288019, 11365.943170284096, 11421.828672570084, 11775.528978841094, 11781.52873885035, 11939.641810745692, 7760.30157285847, 7933.523988560705, 8136.308413784895, 8298.377621678277, 8301.128381519853, 9941.353812002197, 10809.405482698527, 11040.503177356877, 11162.274452160584, 11256.21206515536], "value": 9551.61813319104, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.3447010964628, 1481.6369989352606, 1644.2354305248057, 1827.4974382044945, 1835.1466568045864, 8103.473274237171, 8403.5378054207, 8602.0, 9221.63113475461, 9222.985471598118, 8678.958524977012, 8978.595963181657, 8996.730098097067, 9110.180083792457, 9134.817303653923, 2341.262502311775, 2360.8347415680864, 2386.5226954609147, 2390.1634427950253, 2394.521095780842, 2327.3367090379247, 2352.623580227164, 2370.3363058343607, 2376.263358358914, 2379.5478859016816, 2363.4800343924308, 2366.1363602285214, 2372.181597348912, 2374.988125059372, 2384.1178763857397, 2326.4649130700036, 2337.4506990857135, 2345.718513778349, 2353.1646265575732, 2362.9409264768346, 2277.1574517428494, 2277.703898493202, 2290.7022087128566, 2291.873946932918, 2296.666983287431, 8157.510549367057, 8783.78040548985, 9037.277017838624, 9085.364024518287, 9181.311401644836, 5088.974555127238, 5248.842534723926, 5339.733013349317, 5375.381831089436, 5377.381601115882, 3498.510208570802, 3644.398674218751, 3690.206605579813, 3717.070732316921, 3717.3308804415196, 1042.3329069395593, 1077.9191560632985, 1082.3235477826358, 1109.9889001109966, 1114.9442527873573, 11736.237144585575, 11793.056555475541, 11844.28934263947, 11868.643940681879, 11897.821532677017, 4526.140033393644, 4582.518835522289, 4762.047590481918, 4800.783964721596, 4821.5178482152205, 10075.596976120873, 10100.242481813746, 10160.187185025181, 10169.084782369622, 10178.491075446198, 5237.764300606482, 5332.92000619991, 5355.223492593552, 5370.03339398912, 5370.060239458079, 4399.36209249657, 4558.247889098262, 4723.7401942893475, 4851.0, 4878.341423907798, 3825.3688141456346, 3870.729048966545, 3934.881953541398, 3956.802159891994, 3995.4006898965386, 1080.5245691895698, 1168.1472525056756, 1270.5299039355498, 1284.28722059258, 1284.5760898903338, 813.2802469814256, 872.4111224923279, 910.5037754423855, 929.8837645294338, 941.1670671455811, 4755.976220118947, 5808.825735227865, 5909.084091965752, 6037.486813620803, 6068.514518838482, 430.6597787747707, 437.78110944527737, 440.62106588334007, 447.75373544550365, 452.19734970427754, 3531.858725650945, 3562.625924277965, 3569.910752231215, 3580.695640870555, 3637.5089362935664, 10783.568657253621, 10816.188785841094, 11018.39398833072, 11125.998660120627, 11153.0, 10754.354738715701, 11021.889781102087, 11033.282836615594, 11118.888811111947, 11123.332600044023, 8065.919340806634, 8199.508029518249, 8410.789730256793, 8440.53577053268, 8468.745937621881, 5731.484166425042, 5746.0, 5808.477237048686, 5812.912806307993, 5914.083317085859, 10253.794924101625, 10278.33190842593, 10298.897011029794, 10302.433366164632, 10314.896851031393, 9756.951215243878, 10071.093601575893, 10222.0, 10248.026437488426, 10429.0, 6560.573562718408, 6926.9307306926285, 7131.964340178266, 7393.963030184815, 7679.500832445873, 8320.334373250005, 8356.206160414751, 8395.24442800151, 8426.831463370576, 8562.57187140628, 7458.701651933862, 7537.359324457482, 7581.848363032598, 7616.657250423855, 7679.347255483346, 7344.339009489172, 7404.259574042552, 7436.0, 7525.736599219001, 7541.170471248268, 6971.51199416036, 7131.108611423572, 7134.429245660439, 7135.286471352823, 7143.714251429885, 4902.362692849907, 4915.041566894564, 4997.85006449807, 5046.369203849519, 5123.052235336475, 5040.873978150576, 5091.923621145612, 5161.612879034163, 5187.818426355059, 5263.157894736823], "value": 4506.340804520555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.06276697020905, 304.1483845233347, 311.1924555777756, 313.1810316023599, 314.78122704720226, 5354.6613346663335, 5529.3364796224405, 5547.44525547445, 5567.471090246425, 5629.791019119099, 4984.850454486362, 5082.4917508249155, 5270.894582108355, 5410.971915336084, 5472.34331880174, 4112.527059388179, 4128.56650051744, 4141.012314089239, 4149.9792501037455, 4190.706650534464, 3831.8467261309515, 3836.827342769568, 3846.5576458707187, 3874.1476875087437, 4150.916981660365, 3688.8524459021605, 3792.184680293736, 3813.036286312551, 4068.7965601719943, 4135.338345864662, 3679.9816000919823, 3942.48747662802, 3990.361542153256, 4106.488951946073, 4119.567445418218, 3375.71306438953, 3504.789712617251, 3532.2405682778067, 3551.698105661022, 3585.4621806728937, 4651.720896746206, 5323.334583177103, 5358.410574836765, 5363.490468405495, 5364.222187782789, 4664.5335466453425, 4695.835645752382, 4713.552212539803, 4724.858254252378, 4729.361536192604, 5252.684838909678, 5531.3915469298345, 5749.770009199627, 5802.361740208574, 5814.592978491507, 3450.0339904826437, 3779.6409341112826, 3875.399313106473, 3899.3566061599804, 3902.5902280260448, 6050.96974515129, 6059.7273122709585, 6132.877342453126, 6153.476954458876, 6163.627003603645, 3085.382923415281, 3782.3569993101237, 3866.033491627093, 3874.8375487353683, 3981.462502562117, 3398.895359008283, 3777.6411240932066, 3979.6816254700134, 3988.481497405319, 4009.599040095967, 4667.276572131325, 4680.602148817388, 4689.413823272091, 4701.553352431513, 4714.878304762802, 5362.570994320445, 5670.780782131861, 5797.2173756542325, 5815.331236907809, 5838.591298609056, 1210.9455074521668, 1274.6749578857518, 1288.2463758701078, 1353.0325817040864, 1356.3015047250674, 811.7443005453264, 882.5057967538199, 898.1691934960136, 906.9274458043341, 934.6541779541477, 4752.5485078917445, 5377.596680248918, 5405.7837686492885, 5408.594355423359, 5428.782848686087, 5920.171176035358, 5926.318473375531, 5933.893467818948, 5962.850928726816, 5972.611780234271, 4743.193657078305, 4954.176119611859, 5390.730463476811, 5403.405625381205, 5414.431484694129, 3113.9844300778805, 3123.2191952012, 3157.7947433416753, 3166.366726654678, 3177.809331440121, 5073.543381095646, 5092.949070509321, 6233.470155036873, 6263.655498947602, 6301.243850737941, 5305.787768489295, 5439.3200849893765, 5816.912746308809, 6107.877842443127, 6176.104464852661, 5721.685307308138, 6219.689015549205, 6291.622502649856, 6292.206721084469, 6307.495400367868, 5333.959877823787, 5846.626042880005, 5861.912071318849, 5960.4635582797755, 6077.784443111307, 5021.49785021495, 5939.584229103922, 5942.881142377215, 5945.821625351246, 5956.463918247378, 5476.972615137058, 5747.4252574742195, 6241.595640980743, 6248.312685604671, 6254.405831446005, 3319.5850518685165, 3774.773198710485, 4035.233305671913, 4060.852839049642, 4064.9268872874454, 4968.764056174664, 5254.474552544868, 5641.746121424464, 5875.6474611523445, 5971.402859713994, 5519.668819870821, 5641.746121424464, 5666.886662266649, 5756.395578464369, 5822.155787410887, 5078.822241221687, 5208.270842082035, 5711.314642242957, 5754.31723696826, 5885.323187833283, 5100.5409513143995, 5273.393559740525, 5721.799737009184, 5740.966626007359, 5766.336871259691, 5850.414958504116, 5855.560832937462, 5896.528277737856, 5935.703214839327, 5958.76164953397, 4930.852074437773, 5464.672119672832, 5552.861178470571, 5766.884662306814, 5787.045137552257], "value": 4202.609775752342, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.3170250493243, 711.1714852197188, 723.9855202895939, 757.9805162057035, 823.1562648285507, 14817.481388151404, 15465.458708945189, 15594.37622495099, 15780.526584202464, 15797.0, 14419.423223071064, 14436.206008669518, 14519.637009074779, 14552.345144468498, 14598.124112553254, 697.2295613347254, 852.910444403338, 876.023234093987, 876.1326286975911, 879.551428771328, 707.253847191213, 841.167244428018, 865.9567021648924, 874.7375787263827, 877.3682948277262, 913.6071489259616, 915.771057235691, 916.294453270981, 916.4547094478808, 919.4621146629197, 883.4257732473911, 893.1782759860911, 910.877031600732, 911.129870973219, 911.6717981526712, 619.5848781316483, 620.6896551724138, 646.014827388232, 674.305465370669, 675.5507587454337, 14493.202873841934, 14535.636609084751, 14544.34550445222, 14548.854511454962, 14581.562553123424, 14253.50112746049, 14424.35090420923, 14461.566153015427, 14535.709285814224, 14588.416463341453, 11790.705232369259, 11861.94069029658, 11871.287722736663, 11875.34685592292, 11877.762444751057, 3828.502294701671, 3834.309824231665, 3878.3406820840523, 3881.825317860703, 4002.419649150886, 99534.5023274879, 100088.0, 100871.49564252132, 109307.15046318319, 109700.0, 10990.17573681977, 11102.833457498144, 11104.869379334248, 11129.998300153025, 11253.71865703364, 17736.29054837818, 21813.345599632037, 22072.33782986513, 22478.438039049153, 22495.550088998127, 7821.022372203474, 7952.84094318122, 8008.199180081945, 8079.798005049921, 8097.433179677484, 3913.0804260998643, 4383.408239887574, 4411.2941929291155, 4472.731636101845, 4474.306482495218, 3559.537260156163, 3676.3933950897804, 3679.2273622539565, 3688.944665830015, 3857.7299589029058, 707.0, 713.5789883968483, 724.8941824001284, 729.0595132279407, 736.9373603243677, 576.1760682224459, 593.8930992421406, 620.996895015522, 630.3035146163515, 654.2214764430407, 9420.90579094214, 9582.069295864585, 9656.71029869105, 9679.370840895319, 9731.854022189673, 536.7530935769589, 610.2615834839894, 643.5173619785161, 670.5607826873405, 675.6486626953956, 4031.879043628696, 4739.984140204565, 4770.160909718686, 4778.1638213312535, 4847.997058808897, 144891.5510844899, 164246.7876606189, 164917.0, 167116.0, 169712.66580337952, 130831.0, 133182.0, 133424.0, 133753.0, 134431.32784336017, 78814.0, 118969.0, 120945.39527302483, 122693.38653306676, 123638.14542781866, 9073.727788166365, 9280.72157835266, 9501.002394748451, 9802.36284641496, 10018.3488073275, 48036.27945580749, 50937.23594146165, 54005.729971349894, 62133.0, 64330.678346607965, 92231.0, 97524.0, 98382.52426213755, 98761.6052635534, 99373.50939736054, 11323.358113073722, 12614.306213158365, 12956.28740419286, 13012.21926684402, 13099.541516046893, 14550.4907328243, 14846.77729834075, 14965.77551336709, 14989.700205995601, 15022.248887555797, 13699.109557878706, 13764.17414955106, 13868.4452621894, 14100.0, 14372.28138593087, 13738.519151829638, 13765.311734413439, 13776.380062896993, 13839.446422143, 14053.22707251111, 11242.550297988317, 13350.866491335351, 13930.094543854617, 14025.789613156016, 14257.358418871383, 10863.185261105291, 11043.779124417628, 11713.297202167898, 11823.645290641294, 11830.763384732429, 9709.465979371202, 10478.79042419132, 11404.156030632059, 11554.653360399201, 11622.6513204604], "value": 7871.201362916893, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 115.0, 103.0, 178.0, 138.0, 124.0, 119.0, 116.0, 163.0, 132.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 206.0, 233.0, 201.0, 200.0, 198.0, 198.0, 197.0, 194.0, 195.0], "value": 202.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 60.0, 87.0, 84.0, 54.0, 104.0, 81.0, 103.0, 82.0], "value": 79.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 70.0, 86.0, 73.0, 69.0, 70.0, 88.0, 70.0, 71.0, 86.0], "value": 76.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 76.0, 84.0, 99.0, 91.0, 84.0, 133.0, 86.0, 129.0, 90.0], "value": 96.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 150.0, 97.0, 137.0, 147.0, 102.0, 151.0, 148.0, 97.0, 97.0], "value": 123.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 92.0, 91.0, 97.0, 92.0, 91.0, 92.0, 93.0, 92.0], "value": 92.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 66.0, 84.0, 79.0, 84.0, 82.0, 82.0], "value": 70.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 75.0, 70.0, 91.0, 94.0, 75.0, 60.0, 82.0, 96.0, 99.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 112.0, 106.0, 75.0, 98.0, 107.0, 110.0, 106.0, 107.0], "value": 100.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 146.0, 147.0, 148.0, 150.0, 152.0, 198.0, 155.0], "value": 153.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 173.0, 174.0, 204.0, 237.0, 172.0, 176.0, 174.0, 176.0, 189.0], "value": 185.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 73.0, 71.0, 69.0, 70.0, 69.0, 70.0, 82.0, 87.0], "value": 73.1, "unit": "score"}]}]} 14:09:29 INFO - Return code: 0 14:09:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:09:30 ERROR - # TBPL SUCCESS # 14:09:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:09:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:09:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:09:30 INFO - 2016-10-07 14:09:30.039 screenresolution[2031:281276] starting screenresolution argv=screenresolution get 14:09:30 INFO - 2016-10-07 14:09:30.041 screenresolution[2031:281276] Display 0: 1600x1200x32@60 14:09:30 INFO - 2016-10-07 14:09:30.047 screenresolution[2032:281279] starting screenresolution argv=screenresolution list 14:09:30 INFO - Available Modes on Display 0 14:09:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:09:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:09:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:09:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:09:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:09:30 INFO - Intel Iris: 14:09:30 INFO - Chipset Model: Intel Iris 14:09:30 INFO - Type: GPU 14:09:30 INFO - Bus: Built-In 14:09:30 INFO - VRAM (Dynamic, Max): 1536 MB 14:09:30 INFO - Vendor: Intel (0x8086) 14:09:30 INFO - Device ID: 0x0a2e 14:09:30 INFO - Revision ID: 0x0009 14:09:30 INFO - Displays: 14:09:30 INFO - Display: 14:09:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:09:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:09:30 INFO - Display Serial Number: 1600x1200 60 14:09:30 INFO - Main Display: Yes 14:09:30 INFO - Mirror: Off 14:09:30 INFO - Online: Yes 14:09:30 INFO - Rotation: Supported 14:09:30 INFO - Return code: 0 14:09:30 INFO - Running post-action listener: _resource_record_post_action 14:09:30 INFO - [mozharness: 2016-10-07 21:09:30.284173Z] Finished run-tests step (success) 14:09:30 INFO - Running post-run listener: _resource_record_post_run 14:09:30 INFO - Total resource usage - Wall time: 1212s; CPU: 55.0%; Read bytes: 1610240; Write bytes: 710145024; Read time: 24; Write time: 1992 14:09:30 INFO - TinderboxPrint: CPU usage
54.7% 14:09:30 INFO - TinderboxPrint: I/O read bytes / time
1,610,240 / 24 14:09:30 INFO - TinderboxPrint: I/O write bytes / time
710,145,024 / 1,992 14:09:30 INFO - TinderboxPrint: CPU idle
2,195.1 (45.3%) 14:09:30 INFO - TinderboxPrint: CPU system
984.6 (20.3%) 14:09:30 INFO - TinderboxPrint: CPU user
1,670.0 (34.4%) 14:09:30 INFO - TinderboxPrint: Swap in / out
425,132,032 / 0 14:09:30 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 384856576; Write bytes: 378455552; Read time: 29030; Write time: 755 14:09:30 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 1610240; Write bytes: 300797440; Read time: 24; Write time: 1163 14:09:30 INFO - Running post-run listener: _upload_blobber_files 14:09:30 INFO - Blob upload gear active. 14:09:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:09:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:09:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Larch', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:09:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Larch -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:09:31 INFO - (blobuploader) - INFO - Open directory for files ... 14:09:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:09:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:09:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:32 INFO - (blobuploader) - INFO - Done attempting. 14:09:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:09:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:09:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:33 INFO - (blobuploader) - INFO - Done attempting. 14:09:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:09:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:09:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:09:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:09:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:09:35 INFO - (blobuploader) - INFO - Done attempting. 14:09:35 INFO - (blobuploader) - INFO - Iteration through files over. 14:09:35 INFO - Return code: 0 14:09:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:09:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:09:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/190bacec953d124e9649964e479aaab88be3bbdee453221f8be5cb2212d91f3835728d1f3d10a40c40d2085ec731e1d56e2a8e09d2d9e71f963da996006142c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b283bf2377f302152e141431f81e4ebc3ad91e547848037484781394911c70612e13168ce347375349948ffa566ed0b7a5887e01f114152fcdd4c425c7007ad2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c193991320b2ff468b8850ad0d60a8b8d9facab8d9b8a6388046e0a067493021cde97d5576706b0677c08df09206f170eef8cd945b36a91333529f0eea51b47e"} 14:09:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:09:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:09:35 INFO - Contents: 14:09:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/190bacec953d124e9649964e479aaab88be3bbdee453221f8be5cb2212d91f3835728d1f3d10a40c40d2085ec731e1d56e2a8e09d2d9e71f963da996006142c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b283bf2377f302152e141431f81e4ebc3ad91e547848037484781394911c70612e13168ce347375349948ffa566ed0b7a5887e01f114152fcdd4c425c7007ad2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c193991320b2ff468b8850ad0d60a8b8d9facab8d9b8a6388046e0a067493021cde97d5576706b0677c08df09206f170eef8cd945b36a91333529f0eea51b47e"} 14:09:35 INFO - Running post-run listener: copy_logs_to_upload_dir 14:09:35 INFO - Copying logs to upload dir... 14:09:35 INFO - mkdir: /builds/slave/test/build/upload/logs 14:09:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.724019 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-10-07 14:09:35.479341) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 14:09:35.483383) ========= 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.T0cyJXzknk/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.O5bXj7qNdP/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/190bacec953d124e9649964e479aaab88be3bbdee453221f8be5cb2212d91f3835728d1f3d10a40c40d2085ec731e1d56e2a8e09d2d9e71f963da996006142c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b283bf2377f302152e141431f81e4ebc3ad91e547848037484781394911c70612e13168ce347375349948ffa566ed0b7a5887e01f114152fcdd4c425c7007ad2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c193991320b2ff468b8850ad0d60a8b8d9facab8d9b8a6388046e0a067493021cde97d5576706b0677c08df09206f170eef8cd945b36a91333529f0eea51b47e"} build_url:https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/GF-4gBq0RTiuo7UlD7UqTw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/190bacec953d124e9649964e479aaab88be3bbdee453221f8be5cb2212d91f3835728d1f3d10a40c40d2085ec731e1d56e2a8e09d2d9e71f963da996006142c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/b283bf2377f302152e141431f81e4ebc3ad91e547848037484781394911c70612e13168ce347375349948ffa566ed0b7a5887e01f114152fcdd4c425c7007ad2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch/sha512/c193991320b2ff468b8850ad0d60a8b8d9facab8d9b8a6388046e0a067493021cde97d5576706b0677c08df09206f170eef8cd945b36a91333529f0eea51b47e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 14:09:35.515568) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 14:09:35.515977) ========= 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.T0cyJXzknk/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.O5bXj7qNdP/Listeners TMPDIR=/var/folders/tt/pgc51pmj37x56t_l_9rys0d000000w/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.005304 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 14:09:35.564525) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 14:09:35.564952) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 14:09:35.565273) ========= ========= Total master_lag: 0.17 =========