builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0289 starttime: 1474639142.71 results: success (0) buildid: 20160923041700 builduid: e244da3a890a41b2998aa2ba10341702 revision: 2e46d0c12db68401969a817832329187da8add06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 06:59:02.714132) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 06:59:02.714655) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 06:59:02.715019) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 06:59:02.808358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:59:02.808660) ========= 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.hltqo16VIx/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.HZp51g74U6/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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-09-23 06:59:02-- 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% 18.7M=0.001s 2016-09-23 06:59:03 (18.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.455581 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:59:03.311971) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:59:03.312324) ========= 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.hltqo16VIx/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.HZp51g74U6/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.025701 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:59:03.419477) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 06:59:03.419847) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2e46d0c12db68401969a817832329187da8add06 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2e46d0c12db68401969a817832329187da8add06 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hltqo16VIx/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.HZp51g74U6/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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-09-23 06:59:03,559 truncating revision to first 12 chars 2016-09-23 06:59:03,559 Setting DEBUG logging. 2016-09-23 06:59:03,559 attempt 1/10 2016-09-23 06:59:03,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2e46d0c12db6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 06:59:04,315 unpacking tar archive at: fx-team-2e46d0c12db6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.039393 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 06:59:04.559385) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 06:59:04.559759) ========= script_repo_revision: 2e46d0c12db68401969a817832329187da8add06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 06:59:04.560287) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 06:59:04.560643) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 06:59:04.636233) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-23 06:59:04.637074) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hltqo16VIx/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.HZp51g74U6/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 06:59:04 INFO - MultiFileLogger online at 20160923 06:59:04 in /builds/slave/test 06:59:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:59:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:59:04 INFO - {'append_to_log': False, 06:59:04 INFO - 'base_work_dir': '/builds/slave/test', 06:59:04 INFO - 'blob_upload_branch': 'Fx-Team', 06:59:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:59:04 INFO - 'branch': 'Fx-Team', 06:59:04 INFO - 'buildbot_json_path': 'buildprops.json', 06:59:04 INFO - 'config_files': ('talos/mac_config.py',), 06:59:04 INFO - 'default_actions': ('clobber', 06:59:04 INFO - 'read-buildbot-config', 06:59:04 INFO - 'download-and-extract', 06:59:04 INFO - 'populate-webroot', 06:59:04 INFO - 'create-virtualenv', 06:59:04 INFO - 'install', 06:59:04 INFO - 'run-tests'), 06:59:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:59:04 INFO - 'download_minidump_stackwalk': True, 06:59:04 INFO - 'download_symbols': 'ondemand', 06:59:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:59:04 INFO - 'tooltool.py': '/tools/tooltool.py', 06:59:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:59:04 INFO - '/tools/misc-python/virtualenv.py')}, 06:59:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:59:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:59:04 INFO - 'installer_path': 'installer.exe', 06:59:04 INFO - 'log_level': 'info', 06:59:04 INFO - 'log_name': 'talos', 06:59:04 INFO - 'log_to_console': True, 06:59:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:59:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:59:04 INFO - 'opt_config_files': (), 06:59:04 INFO - 'pip_index': False, 06:59:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:59:04 INFO - 'cmd': ('bash', 06:59:04 INFO - '-c', 06:59:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:59:04 INFO - 'enabled': True, 06:59:04 INFO - 'halt_on_failure': False, 06:59:04 INFO - 'name': 'check_screen_resolution'},), 06:59:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:59:04 INFO - 'cmd': ('bash', 06:59:04 INFO - '-c', 06:59:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:59:04 INFO - 'enabled': True, 06:59:04 INFO - 'halt_on_failure': False, 06:59:04 INFO - 'name': 'check_screen_resolution'},), 06:59:04 INFO - 'run_cmd_checks_enabled': True, 06:59:04 INFO - 'sps_profile': False, 06:59:04 INFO - 'sps_profile_interval': 0, 06:59:04 INFO - 'suite': 'dromaeojs-e10s', 06:59:04 INFO - 'system_bits': '32', 06:59:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:59:04 INFO - 'title': 't-yosemite-r7-0289', 06:59:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:59:04 INFO - 'use_talos_json': True, 06:59:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:59:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:59:04 INFO - 'work_dir': 'build'} 06:59:04 INFO - [mozharness: 2016-09-23 13:59:04.849025Z] Running clobber step. 06:59:04 INFO - Running pre-action listener: _resource_record_pre_action 06:59:04 INFO - Running main action method: clobber 06:59:04 INFO - rmtree: /builds/slave/test/build 06:59:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:59:06 INFO - Running post-action listener: _resource_record_post_action 06:59:06 INFO - [mozharness: 2016-09-23 13:59:06.940829Z] Finished clobber step (success) 06:59:06 INFO - [mozharness: 2016-09-23 13:59:06.941029Z] Running read-buildbot-config step. 06:59:06 INFO - Running pre-action listener: _resource_record_pre_action 06:59:06 INFO - Running main action method: read_buildbot_config 06:59:06 INFO - Using buildbot properties: 06:59:06 INFO - { 06:59:06 INFO - "project": "", 06:59:06 INFO - "product": "firefox", 06:59:06 INFO - "script_repo_revision": "production", 06:59:06 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 06:59:06 INFO - "repository": "", 06:59:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 06:59:06 INFO - "buildid": "20160923041700", 06:59:06 INFO - "pgo_build": "False", 06:59:06 INFO - "basedir": "/builds/slave/test", 06:59:06 INFO - "buildnumber": 26, 06:59:06 INFO - "slavename": "t-yosemite-r7-0289", 06:59:06 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 06:59:06 INFO - "platform": "yosemite_r7", 06:59:06 INFO - "scheduler": "tests-fx-team-macosx64-talos-8-3600", 06:59:06 INFO - "branch": "fx-team", 06:59:06 INFO - "repo_path": "integration/fx-team", 06:59:06 INFO - "revision": "2e46d0c12db68401969a817832329187da8add06", 06:59:06 INFO - "stage_platform": "macosx64", 06:59:06 INFO - "builduid": "e244da3a890a41b2998aa2ba10341702", 06:59:06 INFO - "slavebuilddir": "test" 06:59:06 INFO - } 06:59:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:59:06 INFO - Running post-action listener: _resource_record_post_action 06:59:06 INFO - [mozharness: 2016-09-23 13:59:06.944565Z] Finished read-buildbot-config step (success) 06:59:06 INFO - [mozharness: 2016-09-23 13:59:06.944710Z] Running download-and-extract step. 06:59:06 INFO - Running pre-action listener: _resource_record_pre_action 06:59:06 INFO - Running main action method: download_and_extract 06:59:06 INFO - mkdir: /builds/slave/test/build/tests 06:59: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')]} 06:59:06 INFO - trying https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:59:06 INFO - Downloading https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/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 06:59:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/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 06:59:08 INFO - Downloaded 1199 bytes. 06:59:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:59:08 INFO - Using the following test package requirements: 06:59:08 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:59:08 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:59:08 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:59:08 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:59:08 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:59:08 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:59:08 INFO - u'jsshell-mac.zip'], 06:59:08 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:59:08 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:59:08 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:59:08 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:59:08 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:59:08 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:59:08 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:59:08 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:59:08 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:59:08 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:59:08 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:59:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:59:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:59:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:59:08 INFO - Fetch https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:59:08 INFO - Expected file size: 16438829 06:59:16 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 06:59:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:59:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:59:16 INFO - Fetch https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:59:16 INFO - Expected file size: 16438829 06:59:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:59:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:59:23 INFO - Fetch https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:59:23 INFO - Expected file size: 14414059 06:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:24 INFO - trying https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:59:24 INFO - Downloading https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:59:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/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 06:59:27 INFO - Downloaded 111557890 bytes. 06:59:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:59:27 INFO - mkdir: /builds/slave/test/properties 06:59:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:59:27 INFO - Writing to file /builds/slave/test/properties/build_url 06:59:27 INFO - Contents: 06:59:27 INFO - build_url:https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:59:28 INFO - Running post-action listener: _resource_record_post_action 06:59:28 INFO - Running post-action listener: set_extra_try_arguments 06:59:28 INFO - [mozharness: 2016-09-23 13:59:28.318854Z] Finished download-and-extract step (success) 06:59:28 INFO - [mozharness: 2016-09-23 13:59:28.318949Z] Running populate-webroot step. 06:59:28 INFO - Running pre-action listener: _resource_record_pre_action 06:59:28 INFO - Running main action method: populate_webroot 06:59:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:59:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:59:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:59:28 INFO - '--tppagecycles', 06:59:28 INFO - '7'], 06:59:28 INFO - 'tests': ['tsvgm']}}, 06:59:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:59:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:59:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:59:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:59:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:28 INFO - 'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:59:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:28 INFO - 'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['damp', 'tps']}, 06:59:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:28 INFO - 'tests': ['damp', 'tps']}, 06:59:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['dromaeo_dom']}, 06:59:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:59:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['basic_compositor_video']}, 06:59:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:59:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['a11yr', 06:59:28 INFO - 'ts_paint', 06:59:28 INFO - 'tpaint', 06:59:28 INFO - 'sessionrestore', 06:59:28 INFO - 'sessionrestore_no_auto_restore', 06:59:28 INFO - 'tabpaint']}, 06:59:28 INFO - 'other-e10s': {'tests': ['a11yr', 06:59:28 INFO - 'ts_paint', 06:59:28 INFO - 'tpaint', 06:59:28 INFO - 'sessionrestore', 06:59:28 INFO - 'sessionrestore_no_auto_restore', 06:59:28 INFO - 'tabpaint']}, 06:59:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:59:28 INFO - 'ts_paint', 06:59:28 INFO - 'tpaint', 06:59:28 INFO - 'sessionrestore', 06:59:28 INFO - 'sessionrestore_no_auto_restore', 06:59:28 INFO - 'tabpaint']}, 06:59:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:59:28 INFO - 'ts_paint', 06:59:28 INFO - 'tpaint', 06:59:28 INFO - 'sessionrestore', 06:59:28 INFO - 'sessionrestore_no_auto_restore', 06:59:28 INFO - 'tabpaint']}, 06:59:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['a11yr', 06:59:28 INFO - 'ts_paint', 06:59:28 INFO - 'tpaint', 06:59:28 INFO - 'sessionrestore', 06:59:28 INFO - 'sessionrestore_no_auto_restore', 06:59:28 INFO - 'tabpaint']}, 06:59:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['a11yr', 06:59:28 INFO - 'ts_paint', 06:59:28 INFO - 'tpaint', 06:59:28 INFO - 'sessionrestore', 06:59:28 INFO - 'sessionrestore_no_auto_restore', 06:59:28 INFO - 'tabpaint']}, 06:59:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['tsvgx', 06:59:28 INFO - 'tsvgr_opacity', 06:59:28 INFO - 'tart', 06:59:28 INFO - 'tscrollx', 06:59:28 INFO - 'cart']}, 06:59:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:59:28 INFO - 'tsvgr_opacity', 06:59:28 INFO - 'tart', 06:59:28 INFO - 'tscrollx', 06:59:28 INFO - 'cart']}, 06:59:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:28 INFO - 'talos_options': ['--disable-e10s'], 06:59:28 INFO - 'tests': ['tp5o']}, 06:59:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:28 INFO - 'tests': ['tp5o']}, 06:59:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:28 INFO - 'talos_options': ['--disable-e10s', 06:59:28 INFO - '--xperf_path', 06:59:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:28 INFO - 'tests': ['tp5n']}, 06:59:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:59:28 INFO - 'talos_options': ['--xperf_path', 06:59:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:59:28 INFO - 'tests': ['tp5n']}}, 06:59:28 INFO - 'talos.zip': {'path': '', 06:59:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:59:28 INFO - Running post-action listener: _resource_record_post_action 06:59:28 INFO - [mozharness: 2016-09-23 13:59:28.337990Z] Finished populate-webroot step (success) 06:59:28 INFO - [mozharness: 2016-09-23 13:59:28.338133Z] Running create-virtualenv step. 06:59:28 INFO - Running pre-action listener: _resource_record_pre_action 06:59:28 INFO - Running main action method: create_virtualenv 06:59:28 INFO - Creating virtualenv /builds/slave/test/build/venv 06:59:28 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 06:59:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:59:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:59:28 INFO - Using real prefix '/tools/python27' 06:59:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:59:29 INFO - Installing distribute.............................................................................................................................................................................................done. 06:59:32 INFO - Installing pip.................done. 06:59:32 INFO - Return code: 0 06:59:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110474490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2c854c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110288d30>, '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 0x1100aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110280b20>, '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.hltqo16VIx/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.HZp51g74U6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 06:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hltqo16VIx/Render', 06:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:32 INFO - 'HOME': '/Users/cltbld', 06:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:32 INFO - 'LOGNAME': 'cltbld', 06:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:32 INFO - 'MOZ_NO_REMOTE': '1', 06:59:32 INFO - 'NO_EM_RESTART': '1', 06:59:32 INFO - 'PAGER': '/bin/cat', 06:59:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:32 INFO - 'PWD': '/builds/slave/test', 06:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:32 INFO - 'SHELL': '/bin/bash', 06:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HZp51g74U6/Listeners', 06:59:32 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 06:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:32 INFO - 'USER': 'cltbld', 06:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:32 INFO - 'XPC_FLAGS': '0x0', 06:59:32 INFO - 'XPC_SERVICE_NAME': '0', 06:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:32 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 06:59:32 INFO - Cleaning up... 06:59:32 INFO - Return code: 0 06:59:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110474490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2c854c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110288d30>, '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 0x1100aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110280b20>, '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.hltqo16VIx/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.HZp51g74U6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 06:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:59:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hltqo16VIx/Render', 06:59:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:32 INFO - 'HOME': '/Users/cltbld', 06:59:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:32 INFO - 'LOGNAME': 'cltbld', 06:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:32 INFO - 'MOZ_NO_REMOTE': '1', 06:59:32 INFO - 'NO_EM_RESTART': '1', 06:59:32 INFO - 'PAGER': '/bin/cat', 06:59:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:32 INFO - 'PWD': '/builds/slave/test', 06:59:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:32 INFO - 'SHELL': '/bin/bash', 06:59:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HZp51g74U6/Listeners', 06:59:32 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 06:59:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:32 INFO - 'USER': 'cltbld', 06:59:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:32 INFO - 'XPC_FLAGS': '0x0', 06:59:32 INFO - 'XPC_SERVICE_NAME': '0', 06:59:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:32 INFO - Downloading/unpacking psutil>=3.1.1 06:59:32 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 06:59:32 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 06:59:32 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 06:59:32 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 06:59:32 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 06:59:32 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 06:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:59:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:36 INFO - Installing collected packages: psutil 06:59:36 INFO - Running setup.py install for psutil 06:59:36 INFO - building 'psutil._psutil_osx' extension 06:59:36 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 06:59:37 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 06:59:37 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 06:59:37 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 06:59:37 INFO - building 'psutil._psutil_posix' extension 06:59:37 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 06:59:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:59:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:59:37 INFO - ^ 06:59:37 INFO - 1 warning generated. 06:59:37 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 06:59:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:59:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:59:37 INFO - Successfully installed psutil 06:59:37 INFO - Cleaning up... 06:59:37 INFO - Return code: 0 06:59:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:37 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 0x110474490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2c854c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110288d30>, '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 0x1100aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110280b20>, '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.hltqo16VIx/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.HZp51g74U6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 06:59:37 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 06:59:37 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 06:59:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hltqo16VIx/Render', 06:59:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:37 INFO - 'HOME': '/Users/cltbld', 06:59:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:37 INFO - 'LOGNAME': 'cltbld', 06:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:37 INFO - 'MOZ_NO_REMOTE': '1', 06:59:37 INFO - 'NO_EM_RESTART': '1', 06:59:37 INFO - 'PAGER': '/bin/cat', 06:59:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:37 INFO - 'PWD': '/builds/slave/test', 06:59:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:37 INFO - 'SHELL': '/bin/bash', 06:59:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HZp51g74U6/Listeners', 06:59:37 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 06:59:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:37 INFO - 'USER': 'cltbld', 06:59:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:37 INFO - 'XPC_FLAGS': '0x0', 06:59:37 INFO - 'XPC_SERVICE_NAME': '0', 06:59:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:59:37 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 06:59:37 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 06:59:37 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 06:59:37 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 06:59:37 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 06:59:37 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 06:59:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:59:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:59:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:59:40 INFO - Installing collected packages: mozsystemmonitor 06:59:40 INFO - Running setup.py install for mozsystemmonitor 06:59:40 INFO - Successfully installed mozsystemmonitor 06:59:40 INFO - Cleaning up... 06:59:40 INFO - Return code: 0 06:59:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:40 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 0x110474490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2c854c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110288d30>, '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 0x1100aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110280b20>, '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.hltqo16VIx/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.HZp51g74U6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 06:59:40 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 06:59:40 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 06:59:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hltqo16VIx/Render', 06:59:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:40 INFO - 'HOME': '/Users/cltbld', 06:59:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:40 INFO - 'LOGNAME': 'cltbld', 06:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:40 INFO - 'MOZ_NO_REMOTE': '1', 06:59:40 INFO - 'NO_EM_RESTART': '1', 06:59:40 INFO - 'PAGER': '/bin/cat', 06:59:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:40 INFO - 'PWD': '/builds/slave/test', 06:59:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:40 INFO - 'SHELL': '/bin/bash', 06:59:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HZp51g74U6/Listeners', 06:59:40 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 06:59:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:40 INFO - 'USER': 'cltbld', 06:59:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:40 INFO - 'XPC_FLAGS': '0x0', 06:59:40 INFO - 'XPC_SERVICE_NAME': '0', 06:59:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:40 INFO - Downloading/unpacking jsonschema==2.5.1 06:59:40 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 06:59:40 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 06:59:40 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 06:59:40 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 06:59:40 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 06:59:40 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 06:59:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:59:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:43 INFO - Downloading functools32-3.2.3-2.tar.gz 06:59:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:59:43 INFO - warning: no files found matching '*.txt' 06:59:43 INFO - no previously-included directories found matching 'build' 06:59:43 INFO - no previously-included directories found matching 'dist' 06:59:43 INFO - no previously-included directories found matching '.git*' 06:59:43 INFO - Installing collected packages: jsonschema, functools32 06:59:43 INFO - Running setup.py install for functools32 06:59:44 INFO - warning: no files found matching '*.txt' 06:59:44 INFO - no previously-included directories found matching 'build' 06:59:44 INFO - no previously-included directories found matching 'dist' 06:59:44 INFO - no previously-included directories found matching '.git*' 06:59:44 INFO - Successfully installed jsonschema functools32 06:59:44 INFO - Cleaning up... 06:59:44 INFO - Return code: 0 06:59:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:59:44 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')]} 06:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:44 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')]} 06:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:44 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 0x110474490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2c854c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110288d30>, '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 0x1100aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110280b20>, '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.hltqo16VIx/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.HZp51g74U6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 06:59:44 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 06:59:44 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 06:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hltqo16VIx/Render', 06:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:44 INFO - 'HOME': '/Users/cltbld', 06:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:44 INFO - 'LOGNAME': 'cltbld', 06:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:44 INFO - 'MOZ_NO_REMOTE': '1', 06:59:44 INFO - 'NO_EM_RESTART': '1', 06:59:44 INFO - 'PAGER': '/bin/cat', 06:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:44 INFO - 'PWD': '/builds/slave/test', 06:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:44 INFO - 'SHELL': '/bin/bash', 06:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HZp51g74U6/Listeners', 06:59:44 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 06:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:44 INFO - 'USER': 'cltbld', 06:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:44 INFO - 'XPC_FLAGS': '0x0', 06:59:44 INFO - 'XPC_SERVICE_NAME': '0', 06:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:59:44 INFO - Cleaning up... 06:59:44 INFO - Return code: 0 06:59:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:59:44 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')]} 06:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:44 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')]} 06:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:44 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 0x110474490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2c854c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110288d30>, '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 0x1100aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110280b20>, '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.hltqo16VIx/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.HZp51g74U6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 06:59:44 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 06:59:44 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 06:59:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hltqo16VIx/Render', 06:59:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:44 INFO - 'HOME': '/Users/cltbld', 06:59:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:44 INFO - 'LOGNAME': 'cltbld', 06:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:44 INFO - 'MOZ_NO_REMOTE': '1', 06:59:44 INFO - 'NO_EM_RESTART': '1', 06:59:44 INFO - 'PAGER': '/bin/cat', 06:59:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:44 INFO - 'PWD': '/builds/slave/test', 06:59:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:44 INFO - 'SHELL': '/bin/bash', 06:59:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HZp51g74U6/Listeners', 06:59:44 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 06:59:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:44 INFO - 'USER': 'cltbld', 06:59:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:44 INFO - 'XPC_FLAGS': '0x0', 06:59:44 INFO - 'XPC_SERVICE_NAME': '0', 06:59:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:44 INFO - Downloading/unpacking blobuploader==1.2.4 06:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:47 INFO - Downloading blobuploader-1.2.4.tar.gz 06:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:59:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:59:47 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 06:59:47 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 06:59:47 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 06:59:47 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 06:59:47 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 06:59:47 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 06:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:59:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:59:47 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 06:59:47 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 06:59:47 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 06:59:47 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 06:59:47 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 06:59:47 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 06:59:48 INFO - Downloading docopt-0.6.1.tar.gz 06:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:59:48 INFO - Installing collected packages: blobuploader, requests, docopt 06:59:48 INFO - Running setup.py install for blobuploader 06:59:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:59:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:59:48 INFO - Running setup.py install for requests 06:59:49 INFO - Running setup.py install for docopt 06:59:49 INFO - Successfully installed blobuploader requests docopt 06:59:49 INFO - Cleaning up... 06:59:49 INFO - Return code: 0 06:59:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:49 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')]} 06:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:49 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')]} 06:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:49 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 0x110474490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2c854c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110288d30>, '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 0x1100aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110280b20>, '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.hltqo16VIx/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.HZp51g74U6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 06:59:49 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 06:59:49 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 06:59:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hltqo16VIx/Render', 06:59:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:49 INFO - 'HOME': '/Users/cltbld', 06:59:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:49 INFO - 'LOGNAME': 'cltbld', 06:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:49 INFO - 'MOZ_NO_REMOTE': '1', 06:59:49 INFO - 'NO_EM_RESTART': '1', 06:59:49 INFO - 'PAGER': '/bin/cat', 06:59:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:49 INFO - 'PWD': '/builds/slave/test', 06:59:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:49 INFO - 'SHELL': '/bin/bash', 06:59:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HZp51g74U6/Listeners', 06:59:49 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 06:59:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:49 INFO - 'USER': 'cltbld', 06:59:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:49 INFO - 'XPC_FLAGS': '0x0', 06:59:49 INFO - 'XPC_SERVICE_NAME': '0', 06:59:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:59:49 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-u1MhfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:59:49 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-wB6cND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:59:49 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-9VCXkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:59:50 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-9EYDiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:59:50 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-piMtlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:59:50 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-WkVYfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:59:50 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-sl1I5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:59:50 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Z0GN6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:59:50 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-P89XYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:59:50 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-GIinq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:59:50 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-o_seci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:59:50 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-jt77us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:59:50 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-T9ylDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:59:51 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Y4gsM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:51 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Qxvg9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:59:51 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Q5xJXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:59:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:59:51 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-Rbg_1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:59:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:59:51 INFO - Running setup.py install for manifestparser 06:59:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:59:51 INFO - Running setup.py install for mozcrash 06:59:51 INFO - Running setup.py install for mozdebug 06:59:51 INFO - Running setup.py install for mozdevice 06:59:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Running setup.py install for mozfile 06:59:52 INFO - Running setup.py install for mozhttpd 06:59:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Running setup.py install for mozinfo 06:59:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Running setup.py install for mozInstall 06:59:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Running setup.py install for mozleak 06:59:52 INFO - Running setup.py install for mozlog 06:59:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:59:52 INFO - Running setup.py install for moznetwork 06:59:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for mozprocess 06:59:53 INFO - Running setup.py install for mozprofile 06:59:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for mozrunner 06:59:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:59:53 INFO - Running setup.py install for mozscreenshot 06:59:53 INFO - Running setup.py install for moztest 06:59:53 INFO - Running setup.py install for mozversion 06:59:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:59:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:59:54 INFO - Cleaning up... 06:59:54 INFO - Return code: 0 06:59:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:54 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 0x110474490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2c854c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110288d30>, '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 0x1100aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110280b20>, '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.hltqo16VIx/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.HZp51g74U6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 06:59:54 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 06:59:54 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 06:59:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hltqo16VIx/Render', 06:59:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:54 INFO - 'HOME': '/Users/cltbld', 06:59:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:54 INFO - 'LOGNAME': 'cltbld', 06:59:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:54 INFO - 'MOZ_NO_REMOTE': '1', 06:59:54 INFO - 'NO_EM_RESTART': '1', 06:59:54 INFO - 'PAGER': '/bin/cat', 06:59:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:54 INFO - 'PWD': '/builds/slave/test', 06:59:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:54 INFO - 'SHELL': '/bin/bash', 06:59:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HZp51g74U6/Listeners', 06:59:54 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 06:59:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:54 INFO - 'USER': 'cltbld', 06:59:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:54 INFO - 'XPC_FLAGS': '0x0', 06:59:54 INFO - 'XPC_SERVICE_NAME': '0', 06:59:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:59:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-HpWIvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:59:54 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)) 06:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:59:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-79IISS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:59:54 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)) 06:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:59:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-66CmAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:59:54 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)) 06:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:59:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-H_CyxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:59:54 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)) 06:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:59:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-dPH9l9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:59:54 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)) 06:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:59:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-03oVMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:59:54 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)) 06:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:59:54 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-P715aq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:59:55 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-PQGjdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:59:55 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-jnraW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:59:55 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-tQfvtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:59:55 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-WyvMOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:59:55 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-HjHfPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:59:55 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-R1Fjv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:59:55 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-LV5kNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:55 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-ExhKse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:59:55 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)) 06:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:59:55 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-2dYL_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:59:56 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)) 06:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:59:56 INFO - Running setup.py (path:/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/pip-CgYTDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 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)) 06:59:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:59:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:59:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:59:58 INFO - Downloading blessings-1.6.tar.gz 06:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:59:58 INFO - Installing collected packages: blessings 06:59:58 INFO - Running setup.py install for blessings 06:59:58 INFO - Successfully installed blessings 06:59:58 INFO - Cleaning up... 06:59:59 INFO - Return code: 0 06:59:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:59:59 INFO - Reading from file tmpfile_stdout 06:59:59 INFO - Current package versions: 06:59:59 INFO - blessings == 1.6 06:59:59 INFO - blobuploader == 1.2.4 06:59:59 INFO - docopt == 0.6.1 06:59:59 INFO - functools32 == 3.2.3-2 06:59:59 INFO - jsonschema == 2.5.1 06:59:59 INFO - manifestparser == 1.1 06:59:59 INFO - mozInstall == 1.12 06:59:59 INFO - mozcrash == 0.17 06:59:59 INFO - mozdebug == 0.1 06:59:59 INFO - mozdevice == 0.48 06:59:59 INFO - mozfile == 1.2 06:59:59 INFO - mozhttpd == 0.7 06:59:59 INFO - mozinfo == 0.9 06:59:59 INFO - mozleak == 0.1 06:59:59 INFO - mozlog == 3.4 06:59:59 INFO - moznetwork == 0.27 06:59:59 INFO - mozprocess == 0.23 06:59:59 INFO - mozprofile == 0.28 06:59:59 INFO - mozrunner == 6.12 06:59:59 INFO - mozscreenshot == 0.1 06:59:59 INFO - mozsystemmonitor == 0.3 06:59:59 INFO - moztest == 0.7 06:59:59 INFO - mozversion == 1.4 06:59:59 INFO - psutil == 3.1.1 06:59:59 INFO - requests == 1.2.3 06:59:59 INFO - wsgiref == 0.1.2 06:59:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:59 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 0x110474490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2c854c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110288d30>, '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 0x1100aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110280b20>, '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.hltqo16VIx/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.HZp51g74U6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 06:59:59 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 06:59:59 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 06:59:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hltqo16VIx/Render', 06:59:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:59 INFO - 'HOME': '/Users/cltbld', 06:59:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:59 INFO - 'LOGNAME': 'cltbld', 06:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:59 INFO - 'MOZ_NO_REMOTE': '1', 06:59:59 INFO - 'NO_EM_RESTART': '1', 06:59:59 INFO - 'PAGER': '/bin/cat', 06:59:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:59 INFO - 'PWD': '/builds/slave/test', 06:59:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:59 INFO - 'SHELL': '/bin/bash', 06:59:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HZp51g74U6/Listeners', 06:59:59 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 06:59:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:59 INFO - 'USER': 'cltbld', 06:59:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:59 INFO - 'XPC_FLAGS': '0x0', 06:59:59 INFO - 'XPC_SERVICE_NAME': '0', 06:59:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:59 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)) 06:59:59 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)) 06:59:59 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)) 06:59:59 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)) 06:59:59 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)) 06:59:59 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)) 06:59:59 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)) 06:59:59 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)) 06:59:59 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)) 06:59:59 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)) 06:59:59 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)) 06:59:59 INFO - Cleaning up... 06:59:59 INFO - Return code: 0 06:59:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:59:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:59:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:59:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110474490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1103ea570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7f2c854c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110288d30>, '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 0x1100aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110280b20>, '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.hltqo16VIx/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.HZp51g74U6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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 06:59:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:59:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hltqo16VIx/Render', 06:59:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:59 INFO - 'HOME': '/Users/cltbld', 06:59:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:59 INFO - 'LOGNAME': 'cltbld', 06:59:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:59 INFO - 'MOZ_NO_REMOTE': '1', 06:59:59 INFO - 'NO_EM_RESTART': '1', 06:59:59 INFO - 'PAGER': '/bin/cat', 06:59:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:59 INFO - 'PWD': '/builds/slave/test', 06:59:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:59 INFO - 'SHELL': '/bin/bash', 06:59:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HZp51g74U6/Listeners', 06:59:59 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 06:59:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:59 INFO - 'USER': 'cltbld', 06:59:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:59 INFO - 'XPC_FLAGS': '0x0', 06:59:59 INFO - 'XPC_SERVICE_NAME': '0', 06:59:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:59:59 INFO - Cleaning up... 06:59:59 INFO - Return code: 0 06:59:59 INFO - Running post-action listener: _resource_record_post_action 06:59:59 INFO - Running post-action listener: _start_resource_monitoring 06:59:59 INFO - Starting resource monitoring. 06:59:59 INFO - [mozharness: 2016-09-23 13:59:59.864345Z] Finished create-virtualenv step (success) 06:59:59 INFO - [mozharness: 2016-09-23 13:59:59.865370Z] Running install step. 06:59:59 INFO - Running pre-action listener: _resource_record_pre_action 06:59:59 INFO - Running main action method: install 06:59:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:59:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:00:00 INFO - Reading from file tmpfile_stdout 07:00:00 INFO - Detecting whether we're running mozinstall >=1.0... 07:00:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:00:00 INFO - Reading from file tmpfile_stdout 07:00:00 INFO - Output received: 07:00:00 INFO - Usage: mozinstall [options] installer 07:00:00 INFO - Options: 07:00:00 INFO - -h, --help show this help message and exit 07:00:00 INFO - -d DEST, --destination=DEST 07:00:00 INFO - Directory to install application into. [default: 07:00:00 INFO - "/builds/slave/test"] 07:00:00 INFO - --app=APP Application being installed. [default: firefox] 07:00:00 INFO - mkdir: /builds/slave/test/build/application 07:00:00 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'] 07:00:00 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 07:00:34 INFO - Reading from file tmpfile_stdout 07:00:34 INFO - Output received: 07:00:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:00:34 INFO - Running post-action listener: _resource_record_post_action 07:00:34 INFO - [mozharness: 2016-09-23 14:00:34.681439Z] Finished install step (success) 07:00:34 INFO - [mozharness: 2016-09-23 14:00:34.681576Z] Running run-tests step. 07:00:34 INFO - Running pre-action listener: _resource_record_pre_action 07:00:34 INFO - Running main action method: run_tests 07:00:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:00:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:00:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:00:34 INFO - 2016-09-23 07:00:34.696 screenresolution[1640:9409] starting screenresolution argv=screenresolution get 07:00:34 INFO - 2016-09-23 07:00:34.698 screenresolution[1640:9409] Display 0: 1600x1200x32@60 07:00:34 INFO - 2016-09-23 07:00:34.705 screenresolution[1641:9411] starting screenresolution argv=screenresolution list 07:00:34 INFO - Available Modes on Display 0 07:00:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:00:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:00:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:00:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:00:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:00:34 INFO - Intel Iris: 07:00:34 INFO - Chipset Model: Intel Iris 07:00:34 INFO - Type: GPU 07:00:34 INFO - Bus: Built-In 07:00:34 INFO - VRAM (Dynamic, Max): 1536 MB 07:00:34 INFO - Vendor: Intel (0x8086) 07:00:34 INFO - Device ID: 0x0a2e 07:00:34 INFO - Revision ID: 0x0009 07:00:34 INFO - Displays: 07:00:34 INFO - Display: 07:00:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:00:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:00:34 INFO - Display Serial Number: 1600x1200 60 07:00:34 INFO - Main Display: Yes 07:00:34 INFO - Mirror: Off 07:00:34 INFO - Online: Yes 07:00:34 INFO - Rotation: Supported 07:00:34 INFO - Return code: 0 07:00:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:00:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:00:34 INFO - Python 2.7.3 07:00:34 INFO - Return code: 0 07:00:34 INFO - grabbing minidump binary from tooltool 07:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:00:34 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 0x110288d30>, '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 0x1100aedb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110280b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:00:34 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 07:00:34 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 07:00:34 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 07:00:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:00:35 INFO - Return code: 0 07:00:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:00:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:00:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:00:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:00:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:00:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--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 07:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0289 --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 07:00:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hltqo16VIx/Render', 07:00:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:00:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:00:35 INFO - 'HOME': '/Users/cltbld', 07:00:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:00:35 INFO - 'LOGNAME': 'cltbld', 07:00:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:00:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:00:35 INFO - 'MOZ_NO_REMOTE': '1', 07:00:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:00:35 INFO - 'NO_EM_RESTART': '1', 07:00:35 INFO - 'PAGER': '/bin/cat', 07:00:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:00:35 INFO - 'PWD': '/builds/slave/test', 07:00:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:00:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:00:35 INFO - 'SHELL': '/bin/bash', 07:00:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.HZp51g74U6/Listeners', 07:00:35 INFO - 'TMPDIR': '/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/', 07:00:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:00:35 INFO - 'USER': 'cltbld', 07:00:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:00:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:00:35 INFO - 'XPC_FLAGS': '0x0', 07:00:35 INFO - 'XPC_SERVICE_NAME': '0', 07:00:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:00:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0289', '--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 07:00:35 INFO - mozversion application_buildid: 20160923041700 07:00:35 INFO - mozversion application_changeset: 2e46d0c12db68401969a817832329187da8add06 07:00:35 INFO - mozversion application_display_name: Nightly 07:00:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:00:35 INFO - mozversion application_name: Firefox 07:00:35 INFO - mozversion application_remotingname: firefox 07:00:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:00:35 INFO - mozversion application_vendor: Mozilla 07:00:35 INFO - mozversion application_version: 52.0a1 07:00:35 INFO - mozversion platform_buildid: 20160923041700 07:00:35 INFO - mozversion platform_changeset: 2e46d0c12db68401969a817832329187da8add06 07:00:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:00:35 INFO - mozversion platform_version: 52.0a1 07:00:35 INFO - using testdate: 1474639235 07:00:35 INFO - actual date: 1474639235 07:00:35 INFO - starting webserver on 'localhost:49271' 07:00:35 INFO - SUITE-START | Running 2 tests 07:00:35 INFO - TEST-START | dromaeo_css 07:00:35 INFO - operating with platform_type : mac_ 07:00:35 INFO - Initialising browser for dromaeo_css test... 07:00:35 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmp3ER4ij/profile http://localhost:49271/getInfo.html) 07:00:38 INFO - PROCESS | 1651 | 2016-09-23 07:00:38.089 plugin-container[1653:9581] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a43, name = 'com.apple.tsm.portname' 07:00:38 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:00:38 INFO - PROCESS | 1651 | 2016-09-23 07:00:38.093 plugin-container[1653:9581] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x930b, name = 'com.apple.CFPasteboardClient' 07:00:38 INFO - PROCESS | 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:00:38 INFO - PROCESS | 1651 | 2016-09-23 07:00:38.093 plugin-container[1653:9581] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:00:38 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 07:00:38 INFO - PROCESS | 1651 | colorDepth:24 07:00:38 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 07:00:38 INFO - PROCESS | 1651 | __metrics 07:00:38 ERROR - PROCESS | 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 07:00:38 INFO - TEST-INFO | 1651: exit 0 07:00:38 INFO - Browser initialized. 07:00:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:00:38 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmp3ER4ij/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:00:41 INFO - PROCESS | 1655 | 2016-09-23 07:00:41.426 plugin-container[1656:9710] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8813, name = 'com.apple.tsm.portname' 07:00:41 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:00:41 INFO - PROCESS | 1655 | 2016-09-23 07:00:41.429 plugin-container[1656:9710] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 07:00:41 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:00:41 INFO - PROCESS | 1655 | 2016-09-23 07:00:41.430 plugin-container[1656:9710] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:00:51 INFO - PROCESS | 1655 | RSS: Main: 239370240 07:00:51 INFO - PROCESS | 1655 | 07:01:40 INFO - PROCESS | 1655 | 1474639300722 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] 07:03:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 07:03:54 INFO - PROCESS | 1655 | RSS: Main: 252846080 07:03:54 INFO - PROCESS | 1655 | 07:06:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 07:06:57 INFO - PROCESS | 1655 | RSS: Main: 265183232 07:06:57 INFO - PROCESS | 1655 | 07:09:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 07:09:59 INFO - PROCESS | 1655 | RSS: Main: 269787136 07:09:59 INFO - PROCESS | 1655 | 07:13:01 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 07:13:02 INFO - PROCESS | 1655 | RSS: Main: 269545472 07:13:02 INFO - PROCESS | 1655 | 07:16:04 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 07:16:05 INFO - PROCESS | 1655 | RSS: Main: 274923520 07:16:05 INFO - PROCESS | 1655 | 07:19:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 07:19:08 INFO - PROCESS | 1655 | RSS: Main: 277630976 07:19:08 INFO - PROCESS | 1655 | 07:19:08 INFO - PROCESS | 1655 | __start_tp_report 07:19:08 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 07:19:08 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 07:19:08 INFO - PROCESS | 1655 | |i|pagename|runs| 07:19:08 INFO - PROCESS | 1655 | |0;dojo.html;3010.9999999999995;3332.8333583320828;3371.426857434236;3395.4567269236927;3410.283840393517;5474.671519708811;5538.667679939202;5587.525060369869;5589.105743081108;5621.718914054301;5492.066348720717;5574.777008919638;5612.07400778871;5685.118806584976;5705.25831641886;5047.4447810740785;5100.183970564711;5148.124818780816;5176.197689358156;5190.792368305263;5019.222020586815;5193.766280517386;5200.947990520084;5217.58259339252;5271.472852714736;5005.949940500621;5088.542031217171;5114.641975061747;5165.845024649267;5170.767315470813;4180.895477613054;5114.360704911886;5149.794008239666;5156.329677141947;5160.974195129038;5058.140116180258;5082.593392528589;5088.389393272831;5114.2584325273;5127.6154288428515;5439.184122381635;5446.455354464561;5470.753816078286;5546.667199968015;5613.775448982035;6111.541634377395;6164.938350616481;6169.889419904415;6187.659678717669;6192.9380706192815;6227.813165605039;6230.87538249237;6235.220597425322;6235.469985051276;6244.344343843876;5558.722063896789;5613.859653508695;5617.9719101404235;5698.487136157724;5755.136729490568;6149.754009839646;6198.535109866778;6238.064290356483;6241.906371404432;6252.062190671345;4993.975030124826;5923.200367950358;6007.789727359522;6019.518438524995;6029.155918171459;6001.06983417571;6060.272822245639;6076.3012253591405;6176.258848938156;6182.845428864224;4370.956290437119;4979.178435558165;5507.476789704971;5600.775968961278;5996.610220335664;4812.951870481251;4914.336564563738;5695.202671625976;6130.540209484307;6151.66165860873;3981.3629819228786;4827.444843842933;4839.467658557556;4846.200376937766;4850.8787280317565;4238.788060596958;4328.350747387917;4369.563043695669;4404.229259879508;4437.400950871591;5585.413531579207;5597.412271711493;5653.943460565424;5697.23087383198;5709.600327977002;5989.431004054608;6195.132681424604;6225.097360882647;6226.066090086523;6249.25008998923;5583.330000399897;5636.718164091779;5645.435456454322;5651.954388438152;5708.771649133988;5299.3905700844125;5299.682019078868;5319.6808191508635;5332.440093790174;5361.410244873061;6225.595336303126;6247.656378899204;6248.187735594434;6262.906056409066;6266.122742816009;6083.8174854754425;6100.73256437228;6112.1748563945075;6120.8775824484155;6191.5665903388135;6189.319174890848;6213.440790328892;6228.065790131335;6232.002879539252;6244.1570387997035;5967.76128954837;6010.909836352545;6047;6068.939310606837;6101.908471373022;5231.875146843447;6082;6104.883608894006;6107.917136653054;6159.414855588712;5943.257092863392;5993.490553302844;6005.759769609167;6016.819495415145;6036.6679832609625;5803;5852.4147585241135;5978.551608629283;6002.699865006645;6019.428154325332;5638.097904335286;5687.402822703557;5715.399883012224;5721.113227449752;5867.943770121419;4899.681520701143;5894.528437725057;5961.135635332939;5964.343922168645;5969.61197522177;5735;5772.682502462405;5793.15999180125;5799.565032622654;5803.332616749128 07:19:08 INFO - PROCESS | 1655 | |1;ext.html;525.2856115682671;527.2565682387834;535.8687121655195;536.4688957931647;572.8510587247315;33280.83359583202;41209;41310.96722581937;41391.79304103483;41452.37821432681;41679.583204167946;41716;42143.15713685725;42275;42396.36405453913;9628.22974162069;9813.165880900133;9820.803583928317;9828.066333698287;9830.361026533252;9716.222702183808;9788.951055244714;9799.461029643368;9801.656942007032;9819.852702209473;7940.56326902023;8427.747167584952;8816.691415800417;9683.41899486033;9809.411435313905;8511.404201705884;9732.464714440703;9769.609215631403;9814.656487022992;9817.558209880572;9684.322097453181;9714.31999760017;9748.805023899553;9804.068613481708;9805.264605154642;40681.79659101715;40684.98287542805;40717.389239161435;40801.18397632031;40905.772826814944;3430.6054803697643;3438.6905178534053;3476.4263896457055;3633.8364773585254;3817.9045523861846;30420.54369184464;30599.847000764854;30709.77160913561;31134;31707;3190.696883796059;3209.6629853865475;3238.2228265216177;3274.4597141471627;3358.177246574605;469953;475197;477431;477847.61076194746;477932;57235.14147287794;57546.136807947914;57712;57750.7112464435;57867;32780.83609581985;33855.66144338575;33987.83006084954;59598.40401596015;59695.403045969855;16078;16171;16214.675706485805;16243.02541847493;16272.51182464528;12410.503579856704;12496.625101246977;12517.061220408506;12521.749565008831;12532;18952.81047189538;18989.39201551701;19013.957766757252;19041.904790475957;19082.14130364137;6784.491163162783;7678.347340476123;7766.766996990099;8276.29651479619;8358.749237522885;867.6442658510107;930.8696782450462;974.1914211204684;1041.3209220297354;1113.549012649878;29311.560326595118;29712.96004639827;29943.70056299409;30331;30519;1065.9713376591471;1082.3505896462218;1087.717193529688;1093.1528065749108;1156.9595064172713;13443.529476468277;15204.695906081817;15251.703605193683;15308.464203752816;15399.461018864286;620592;676298;676620;680350;680582;41933.79033104876;44755.328670069975;50750.74624626853;56658.43341566614;56897;1339.1830983100301;1372.8421231558498;1395.9232242226774;1397.44800803684;1399.0626280392162;28377.43245135127;29378.853105734335;29430.558541621464;29974;30070.54894176633;47010.82472938204;47767.805804855154;48188.75905620449;48228.5177148224;48248.276275856595;506601.4669926627;541338;572448;572990;574754;25532.744672553035;25735.613965790904;25994.090206843426;26087;26134.215973520826;46476.535234648574;46572.30141547812;47386.763066184445;47387.76306118447;47638.76180619075;32003.35993280168;37647.81176094212;38219.808900955315;38754.80622596869;38825.41761873518;38300.233995320494;38618.80690596529;38859.63991260292;39295.803520983354;39733.80133099316;37421.06447338838;37824.81087594544;38039;38321.04197395087;38390.424143638425;31962.52056219205;34242.31515369729;34612.307753845285;34671.95984120481;34747;25003;25162.62256066197;25467;25621.231363059138;25728.813050890134 07:19:08 INFO - PROCESS | 1655 | |2;jquery.html;320.9261869769953;365.75677174678833;369.5823719197307;377.1495278147776;395.359517581518;17565.033923134222;20163;20775.584488310244;21456.24903128389;21600;20680.37958861233;20842.68735968962;20877.47806304843;21049.368518944455;21652.35042948714;5013.197888337867;5790.131480277971;5862.443067908542;5921.756431149463;6047.425494578008;5627.831165065034;5968.432998865101;5975.163477113208;6062.18160548327;6065.2418447694035;5754.65472071675;6006.9399306007035;6009.75960961561;6044.848878778043;6057.151998720183;5694.288213973254;5838.970805145968;5920.141579470996;5925.703714814264;5999.61002534836;5088.2622019807295;5144.228365745131;5147.6654017488745;5153.716545589991;5156.071907056728;25570.74429255702;25648.61527077095;25686;25782.871085644638;26065;2119.9788002119935;2409.807215422762;2426.9757302426924;2441.6459613355964;2472.134752836511;15473.458428954933;15474.61313467161;15606.921965390215;16067.517974460785;16228.269727862275;1805.9638807223914;1858.8977606231651;1896.1941175000707;1939.7381353517235;1945.3385848811472;115754;116343.4182829089;116655;117117;117276.41361793222;10412.375257484575;10545.789084218273;10623.256372053882;11005.779884402267;11294.717632059264;13182.209067455984;13295.468181272641;13402.53091141825;13414.99387545938;13450.722181392948;8216.877586517085;8401.957990210132;8496.40525163245;8600.182982616641;8604.440711353742;8524.531150786766;8551.657933682583;8551.700690475804;8722.258608018263;8743.256823170103;5546;5922.466977972003;6569.57297775643;6654.434373078343;6696.63168525726;1818.0364406864383;1835.375972169442;1838.1911958738112;1842.5669967557612;1843.9446816595523;833.3374966901328;867.2498288979987;934.56075644447;972.3922548407245;1010.3281317923645;15842.841571584137;17207.79545431808;21408.678869816966;21794.89102554477;22431.32706018822;805.5368163306123;891.2468963725642;968.4673429613684;982.4007355513131;1024.9795004099876;11358.26171298863;11680.766384672259;11820.88179118215;11897.643070707893;11901.523939042341;526094;577854;587314.4439944582;592204;592771;95226;112463;122027;123900.38049809873;124951.75048249583;806.5362416610355;1019.3119644240256;1027.8047171037479;1029.7734498410339;1037.1184493180735;18647.347342843477;19465.902670486557;19682;19784.703229451858;19799.505012374804;53255.46744532505;53370.99717521279;53553;53624;55318;71491;71810.64094679493;72010;72409.6379518099;72477;6435.967820160869;6757.087793147862;7739.458237923292;7893.921060789318;7909.288164065261;11494.94252528732;11875.94062029719;13029.413676384775;13372.799408008694;13375;9286.489243091695;9422.481763503074;11048.729396119548;11382.317060976367;11765;10935.28920620157;11104.278221915549;11205.943970280423;11481.311121332747;11531.423428828357;10371.94814025925;10665;11386.146039047271;11743.647690569296;11767.823482647938;7804.765857024298;7911.327537159175;7970.880436793337;8070.757877263692;8195.262426381654;11134.665960021212;11427.142964277546;11518;11545.884541154817;11733.237339572901 07:19:08 INFO - PROCESS | 1655 | |3;mootools.html;1524.1997951075684;1552.6739384729206;1748.9331507780253;1795.9730604040933;1863.785664648565;7922.485038472495;8181.386396020307;8423.957880210599;8975.012748597657;9000.279977601793;8376.790580235498;8658.26404755595;8686.04453510115;8768.912310876889;8769.517676527788;2025.5442525431806;2324.883755812211;2372.466195106096;2378.4886249456363;2386.1648423051965;2350.9177178798745;2370.4547953970596;2393.4136136646457;2404.651325557802;2408.650745641881;1792.5339411752973;1845.2157832921023;1974.8123928226796;2284.7486776454575;2310.630299152136;2110.725605671268;2203.3830527452337;2337.357226762637;2348.7181538215436;2361.2207971369407;2301.7698230177016;2310.306907927615;2311.0871205873586;2313.745487996319;2314.166899916029;8667.089955554702;8789.912100878973;8860.556972151431;8870.86693699595;8876.600552975131;5162.561182299509;5293.920591191135;5310.57515398771;5321.414644389114;5327.3074500314715;3484.8083355415442;3533.2050288685095;3636.200035992104;3676.7058635309113;3697.0572504011307;962.629387685746;1081.875584307799;1088.9128869690405;1091.345192884271;1097.6652121103061;11517.424128793611;11739.941300293443;11754.29474231549;11775.94112029443;11782.705432364173;4550.954490455119;4629.86110416688;4742.099001189763;4788.11419887322;4817.975910120427;9874.851877221847;9912.603495860085;9915.900840991499;9918.900810991798;9924.652637157666;5226.346706661668;5244.606654500928;5248.816291429782;5274.92087618686;5279.52484276417;4054.9391759123637;4335.566443355639;4502.617277531446;4661.930071048937;4792.592629626451;3900.8244628991765;3903.4535165076913;4024.2957482440456;4047.392891066305;4077.9796101019306;1253.129075292663;1255.0085432508217;1260.0864373329446;1269.041873385588;1273.554256010389;823.263179454385;917.2341095185461;917.2799352508382;924.6486335192584;965.753732798132;5763.510101641407;5809.883802324014;5867.735951882176;5959.404059594006;6135.9079613805825;437.5558807810012;440.1680823244071;440.44503925054664;443.6450839328524;447.7067520773898;3848.7883166426113;3933.3903244997073;4036.5357983832237;4056.6957478189256;4069.694772892045;10382.532786024647;10566.841497377545;10668.14654827612;10668.253222274367;10717.0890474309;10333.449982502685;10503.264771465923;10757.56969721218;10763.677089687322;10780.137588992862;6787.219469760942;8118.959405203054;8137.104918458965;8211.671533138608;8217.876731849026;5455.208994695826;5823.82528524145;5852.590318677822;5888.558358123072;5913.763449461973;9709.563069662023;9943.105120539187;9978.850317245393;10007.349522281029;10009.749756256151;10207.081362677394;10209.336393134423;10220.437875916896;10224.591016359262;10225.693229203136;6856.177258728984;7108.395786358217;7442.665080071518;7528.096628404407;7802.765917022499;7059.647017649199;7150.356467917913;7255.4921155518605;7307.378872795659;7807.804804879924;6262.530310226843;7353.77938661841;7448.404127669882;7484.288992545699;7505.099388073466;7276.7089316428865;7321.853562928818;7330.890036649561;7353.926460735538;7379.151397589131;6763.256041835296;6973.686184121828;7043.190033146254;7117.75087871922;7141.571505709674;4858.732769697559;4918.065567542156;4952.826651067196;4984.526469985346;5035.320231768665;4597.896504838748;4953.925691114564;4989.950100498949;5022.246663000579;5098.388193416814 07:19:08 INFO - PROCESS | 1655 | |4;prototype.html;264.7537789855434;296.8500907041944;305.7263748944695;308.46635320894853;311.30734116590577;4655.7672116394215;4794.544518270767;5336.252924590551;5357.65175263608;5492.176173573966;4103.446034785303;4932.457429682732;5487.368952570456;5517.834464966058;5557.305336832896;3811.4854494643146;3952.051507638175;4236.533981262067;4239.321708526636;4251.638610718092;3471.611355457812;4033.657139143176;4182.581741825824;4232.449781528397;4263.211305908401;3972.483577134983;4176.603222693854;4177.2246795112105;4198.6011328923705;4219.831206751726;3614.9277014459826;4204.180184863937;4216.789160541976;4221.430106935586;4262.2754131797665;3039.3313471036336;3130.9373812523622;3549;3697;3706.629337066299;5029.874253143664;5372.301600791911;5389.730513474311;5418.83743487696;5463.344398672145;4730.432348118248;4740.715557066553;4745.762711864393;4757.785899634525;4765.188538762112;5064.2403639454005;5519.116941289414;5825.533957283407;5884.764609415618;5893;3600;3827.5072721638585;3942.7634341939574;3943.521179557666;3945.743526670757;5596.888062238732;5888.499477544414;6190.071489276599;6210.534209934273;6231.594946328474;3989.8005099744896;3993.4209539616595;3995.081131339808;3999.1201935574127;4005.2590270799997;3549.982250088733;3596.98201508996;3773.981130094387;3887.3002859485564;4041.8383264669674;3968.7378194429475;4423.380726698265;4591.770411479412;4752.976235118802;4753.9049219016115;4718.95281047192;5580.972095139498;5834.124881267844;5883.235179426732;5972.193753843262;1277.5400855691944;1292.2763252578397;1343.8521762606106;1355.6475316417605;1373.3064802274787;897.4704924094685;907.919575704909;920.4661296448178;923.0815338737999;925.2089463508738;5294.338207724035;5326.680399176062;5385.084535628953;5418.620696551282;5428;5578.191162281528;5817.825465236049;5838.416158384212;5987.191729116514;6035.094735789667;4446.066326071561;5246.580273578104;5349.331333583302;5416.485433883775;5421.9366058177;2169.4034140611457;2587.7929765619083;2624.4619852930105;2631.4868600623076;2676.210517897186;5097.923531146962;5204.981110955712;5214.843554693365;5238.616429524557;5249.613998970719;4685.320628508847;5163.173892177234;5864.266966629171;6273.529485288622;6288.610328075302;5760.810891861066;6281.277653069864;6286.591371560834;6290.433860952445;6307.463865571386;5119.48805119485;5413.431589683027;6100.10245133558;6162.722677479614;6209.348018457997;4803.51091161741;5737.311522617312;5991.700414979146;6121.510279177744;6126.877462450815;5805.82582522525;6367.235931688042;6392.456641185551;6409.743610255724;6443.581167224115;3237.7733558650666;3797.525309336333;3992.680585553207;4016.136530645925;4051.3517837145914;5250.606204534599;5416.377116631637;5775.33583637887;5778.768849245983;6090.23872015998;5149.536541711264;5689.715514224355;5848.239728835224;5877.559183061202;5888.263967004124;5399.757010934439;5406.864558442771;5610.298712660918;5826.563007774349;5887.911681324869;5071.667033164638;5471.890562188813;5538;5682.948654498931;5762.740676669476;5900.586958913007;5930.555208359304;5935.376785437467;5942.910856337072;5957.49361304294;5455.809046683347;5513.641613295123;5582.49757521825;5800.361960184292;5908.881822363614 07:19:08 INFO - PROCESS | 1655 | |5;yui.html;748.8577170337635;749.3929916767422;793.1394437035816;794.6463823598501;849.5539841583168;15216.543503694878;15553.377864885419;15808.130552819604;15958;15994.76007859883;14477;14655.63360915975;15313.157776322298;15808.683826323466;15956.202189890517;858.7681326041949;881.858902575588;883.8630012348065;887.3788348156285;889.7686601483596;677.0994577212296;698.8427603789157;852.1563651984521;879.4503435352905;882.1399135842566;886.7871710789397;925.1534845616253;928.2991341537164;929.2890938432105;929.7117893453018;892.6830975003845;918.0635751533432;918.9862152067724;920.6087412849512;920.9861852072257;559.5467671186352;560.5431573267774;643.4080645805869;649.5875119299232;681.2063945503483;12731.427085781163;14932.776008359884;15461.381544738197;15492.690146197127;15531.922340388339;11918.821217681741;13617.114887532278;14012.509562165376;14013.579592612237;14260.85739142616;11760.941195294054;11770.588029419016;11822.467988940432;11964.102692298113;12196.14626976112;3745.906352341186;3768.4724138620613;3791.5829258781514;3903.0437542802197;3944.2505923874373;101133;103767;106148.46925765321;109445.45277273563;123759.3812030934;10917.81464154266;11027.779444411068;11053.944730276458;11101.666949991513;11214;21892;21949.67075493869;21966.89016554939;22134.446638834157;22251.109955601918;7979.441439099323;8064.072631647318;8067.39494537912;8076.717314894068;8284.212999765012;4468.195724769507;4471.32930060487;4480.61914737251;4558.544145585482;4614.538546145426;2959.792814502964;3613.9638603614153;3678.1172518595345;3734.8132593370224;3805.7906815125434;696.8536607312521;711.4273010226714;712.6258714174996;718.4611541343992;722.1045903080247;563.8167595531469;617.1791517282004;629.2260519560874;643.8165122939939;662.5031226580065;7747.573883436352;9315.161635452841;9405.482698451515;9505.382150160218;9632.75918102053;518.6861948521166;583.9036558967807;603.405645439242;663.9045574801615;671.6868522039401;4211.305134652809;4405.29515277554;4615.123126606001;4823;4834.081524510332;78634.64096077127;88121.55939220263;134306;137435;145786.2710686461;121593;124036.1394579082;126079.3696031514;126926.73073269334;127445;105714;108128;111378.44310778394;114450.42774786073;115492;9069.365144439826;9111.635534578543;9163;9234.875978524842;9292.535373231176;61195.38804611897;61232.387676124454;61347;63237.36762632499;63812.68093659502;88983.11016889749;91994.54002729943;93917.59123613288;95406;95982;11581.768364632491;11771.646850594496;11825.940870295593;11881.168318217642;12332.075094368138;12270.386480676108;12396.442160102637;12564.685882853002;12975.610731678065;13814.723705526034;12329.260244385365;12393.62819115428;12639;12800.423980920694;12803.35983200855;12145.757084858431;12274.693132671755;12372.752544948871;12738.426770795522;12745.553905613258;11807.114466415225;12032.75934481323;12131.21147125434;12147.574834880737;12477.438515266653;9643.360628693279;9668.129868311886;10015.14871235953;10445;10641.148708103488;8904.287656987295;9337.953310233406;9600.855987160337;10691.251612387057;10744.731381715206 07:19:08 INFO - PROCESS | 1655 | __end_tp_report 07:19:08 INFO - PROCESS | 1655 | __start_cc_report 07:19:08 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,367 07:19:08 INFO - PROCESS | 1655 | __end_cc_report 07:19:08 INFO - PROCESS | 1655 | __startTimestamp1474640348614__endTimestamp 07:19:08 INFO - PROCESS | 1655 | 07:19:08 INFO - PROCESS | 1655 | ------- Summary: start ------- 07:19:08 INFO - PROCESS | 1655 | Number of tests: 6 07:19:08 INFO - PROCESS | 1655 | 07:19:08 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5575.97 Median:5698.49 stddev:655.59 (11.5%) stddev-sans-first:625.96 07:19:08 INFO - PROCESS | 1655 | Values: 3011.0 3332.8 3371.4 3395.5 3410.3 5474.7 5538.7 5587.5 5589.1 5621.7 5492.1 5574.8 5612.1 5685.1 5705.3 5047.4 5100.2 5148.1 5176.2 5190.8 5019.2 5193.8 5200.9 5217.6 5271.5 5005.9 5088.5 5114.6 5165.8 5170.8 4180.9 5114.4 5149.8 5156.3 5161.0 5058.1 5082.6 5088.4 5114.3 5127.6 5439.2 5446.5 5470.8 5546.7 5613.8 6111.5 6164.9 6169.9 6187.7 6192.9 6227.8 6230.9 6235.2 6235.5 6244.3 5558.7 5613.9 5618.0 5698.5 5755.1 6149.8 6198.5 6238.1 6241.9 6252.1 4994.0 5923.2 6007.8 6019.5 6029.2 6001.1 6060.3 6076.3 6176.3 6182.8 4371.0 4979.2 5507.5 5600.8 5996.6 4813.0 4914.3 5695.2 6130.5 6151.7 3981.4 4827.4 4839.5 4846.2 4850.9 4238.8 4328.4 4369.6 4404.2 4437.4 5585.4 5597.4 5653.9 5697.2 5709.6 5989.4 6195.1 6225.1 6226.1 6249.3 5583.3 5636.7 5645.4 5652.0 5708.8 5299.4 5299.7 5319.7 5332.4 5361.4 6225.6 6247.7 6248.2 6262.9 6266.1 6083.8 6100.7 6112.2 6120.9 6191.6 6189.3 6213.4 6228.1 6232.0 6244.2 5967.8 6010.9 6047.0 6068.9 6101.9 5231.9 6082.0 6104.9 6107.9 6159.4 5943.3 5993.5 6005.8 6016.8 6036.7 5803.0 5852.4 5978.6 6002.7 6019.4 5638.1 5687.4 5715.4 5721.1 5867.9 4899.7 5894.5 5961.1 5964.3 5969.6 5735.0 5772.7 5793.2 5799.6 5803.3 07:19:08 INFO - PROCESS | 1655 | 07:19:08 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:69006.18 Median:40207.80 stddev:152807.23 (380.0%) stddev-sans-first:153149.40 07:19:08 INFO - PROCESS | 1655 | Values: 525.3 527.3 535.9 536.5 572.9 33280.8 41209.0 41311.0 41391.8 41452.4 41679.6 41716.0 42143.2 42275.0 42396.4 9628.2 9813.2 9820.8 9828.1 9830.4 9716.2 9789.0 9799.5 9801.7 9819.9 7940.6 8427.7 8816.7 9683.4 9809.4 8511.4 9732.5 9769.6 9814.7 9817.6 9684.3 9714.3 9748.8 9804.1 9805.3 40681.8 40685.0 40717.4 40801.2 40905.8 3430.6 3438.7 3476.4 3633.8 3817.9 30420.5 30599.8 30709.8 31134.0 31707.0 3190.7 3209.7 3238.2 3274.5 3358.2 469953.0 475197.0 477431.0 477847.6 477932.0 57235.1 57546.1 57712.0 57750.7 57867.0 32780.8 33855.7 33987.8 59598.4 59695.4 16078.0 16171.0 16214.7 16243.0 16272.5 12410.5 12496.6 12517.1 12521.7 12532.0 18952.8 18989.4 19014.0 19041.9 19082.1 6784.5 7678.3 7766.8 8276.3 8358.7 867.6 930.9 974.2 1041.3 1113.5 29311.6 29713.0 29943.7 30331.0 30519.0 1066.0 1082.4 1087.7 1093.2 1157.0 13443.5 15204.7 15251.7 15308.5 15399.5 620592.0 676298.0 676620.0 680350.0 680582.0 41933.8 44755.3 50750.7 56658.4 56897.0 1339.2 1372.8 1395.9 1397.4 1399.1 28377.4 29378.9 29430.6 29974.0 30070.5 47010.8 47767.8 48188.8 48228.5 48248.3 506601.5 541338.0 572448.0 572990.0 574754.0 25532.7 25735.6 25994.1 26087.0 26134.2 46476.5 46572.3 47386.8 47387.8 47638.8 32003.4 37647.8 38219.8 38754.8 38825.4 38300.2 38618.8 38859.6 39295.8 39733.8 37421.1 37824.8 38039.0 38321.0 38390.4 31962.5 34242.3 34612.3 34672.0 34747.0 25003.0 25162.6 25467.0 25621.2 25728.8 07:19:08 INFO - PROCESS | 1655 | 07:19:08 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:34032.20 Median:2434.31 stddev:95888.92 (3939.1%) stddev-sans-first:96124.51 07:19:08 INFO - PROCESS | 1655 | Values: 320.9 365.8 369.6 377.1 395.4 17565.0 20163.0 20775.6 21456.2 21600.0 20680.4 20842.7 20877.5 21049.4 21652.4 5013.2 5790.1 5862.4 5921.8 6047.4 5627.8 5968.4 5975.2 6062.2 6065.2 5754.7 6006.9 6009.8 6044.8 6057.2 5694.3 5839.0 5920.1 5925.7 5999.6 5088.3 5144.2 5147.7 5153.7 5156.1 25570.7 25648.6 25686.0 25782.9 26065.0 2120.0 2409.8 2427.0 2441.6 2472.1 15473.5 15474.6 15606.9 16067.5 16228.3 1806.0 1858.9 1896.2 1939.7 1945.3 115754.0 116343.4 116655.0 117117.0 117276.4 10412.4 10545.8 10623.3 11005.8 11294.7 13182.2 13295.5 13402.5 13415.0 13450.7 8216.9 8402.0 8496.4 8600.2 8604.4 8524.5 8551.7 8551.7 8722.3 8743.3 5546.0 5922.5 6569.6 6654.4 6696.6 1818.0 1835.4 1838.2 1842.6 1843.9 833.3 867.2 934.6 972.4 1010.3 15842.8 17207.8 21408.7 21794.9 22431.3 805.5 891.2 968.5 982.4 1025.0 11358.3 11680.8 11820.9 11897.6 11901.5 526094.0 577854.0 587314.4 592204.0 592771.0 95226.0 112463.0 122027.0 123900.4 124951.8 806.5 1019.3 1027.8 1029.8 1037.1 18647.3 19465.9 19682.0 19784.7 19799.5 53255.5 53371.0 53553.0 53624.0 55318.0 71491.0 71810.6 72010.0 72409.6 72477.0 6436.0 6757.1 7739.5 7893.9 7909.3 11494.9 11875.9 13029.4 13372.8 13375.0 9286.5 9422.5 11048.7 11382.3 11765.0 10935.3 11104.3 11205.9 11481.3 11531.4 10371.9 10665.0 11386.1 11743.6 11767.8 7804.8 7911.3 7970.9 8070.8 8195.3 11134.7 11427.1 11518.0 11545.9 11733.2 07:19:08 INFO - PROCESS | 1655 | 07:19:08 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5628.65 Median:4805.28 stddev:3197.15 (66.5%) stddev-sans-first:3191.24 07:19:08 INFO - PROCESS | 1655 | Values: 1524.2 1552.7 1748.9 1796.0 1863.8 7922.5 8181.4 8424.0 8975.0 9000.3 8376.8 8658.3 8686.0 8768.9 8769.5 2025.5 2324.9 2372.5 2378.5 2386.2 2350.9 2370.5 2393.4 2404.7 2408.7 1792.5 1845.2 1974.8 2284.7 2310.6 2110.7 2203.4 2337.4 2348.7 2361.2 2301.8 2310.3 2311.1 2313.7 2314.2 8667.1 8789.9 8860.6 8870.9 8876.6 5162.6 5293.9 5310.6 5321.4 5327.3 3484.8 3533.2 3636.2 3676.7 3697.1 962.6 1081.9 1088.9 1091.3 1097.7 11517.4 11739.9 11754.3 11775.9 11782.7 4551.0 4629.9 4742.1 4788.1 4818.0 9874.9 9912.6 9915.9 9918.9 9924.7 5226.3 5244.6 5248.8 5274.9 5279.5 4054.9 4335.6 4502.6 4661.9 4792.6 3900.8 3903.5 4024.3 4047.4 4078.0 1253.1 1255.0 1260.1 1269.0 1273.6 823.3 917.2 917.3 924.6 965.8 5763.5 5809.9 5867.7 5959.4 6135.9 437.6 440.2 440.4 443.6 447.7 3848.8 3933.4 4036.5 4056.7 4069.7 10382.5 10566.8 10668.1 10668.3 10717.1 10333.4 10503.3 10757.6 10763.7 10780.1 6787.2 8119.0 8137.1 8211.7 8217.9 5455.2 5823.8 5852.6 5888.6 5913.8 9709.6 9943.1 9978.9 10007.3 10009.7 10207.1 10209.3 10220.4 10224.6 10225.7 6856.2 7108.4 7442.7 7528.1 7802.8 7059.6 7150.4 7255.5 7307.4 7807.8 6262.5 7353.8 7448.4 7484.3 7505.1 7276.7 7321.9 7330.9 7353.9 7379.2 6763.3 6973.7 7043.2 7117.8 7141.6 4858.7 4918.1 4952.8 4984.5 5035.3 4597.9 4953.9 4990.0 5022.2 5098.4 07:19:08 INFO - PROCESS | 1655 | 07:19:08 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4660.16 Median:5272.47 stddev:1482.65 (28.1%) stddev-sans-first:1449.64 07:19:08 INFO - PROCESS | 1655 | Values: 264.8 296.9 305.7 308.5 311.3 4655.8 4794.5 5336.3 5357.7 5492.2 4103.4 4932.5 5487.4 5517.8 5557.3 3811.5 3952.1 4236.5 4239.3 4251.6 3471.6 4033.7 4182.6 4232.4 4263.2 3972.5 4176.6 4177.2 4198.6 4219.8 3614.9 4204.2 4216.8 4221.4 4262.3 3039.3 3130.9 3549.0 3697.0 3706.6 5029.9 5372.3 5389.7 5418.8 5463.3 4730.4 4740.7 4745.8 4757.8 4765.2 5064.2 5519.1 5825.5 5884.8 5893.0 3600.0 3827.5 3942.8 3943.5 3945.7 5596.9 5888.5 6190.1 6210.5 6231.6 3989.8 3993.4 3995.1 3999.1 4005.3 3550.0 3597.0 3774.0 3887.3 4041.8 3968.7 4423.4 4591.8 4753.0 4753.9 4719.0 5581.0 5834.1 5883.2 5972.2 1277.5 1292.3 1343.9 1355.6 1373.3 897.5 907.9 920.5 923.1 925.2 5294.3 5326.7 5385.1 5418.6 5428.0 5578.2 5817.8 5838.4 5987.2 6035.1 4446.1 5246.6 5349.3 5416.5 5421.9 2169.4 2587.8 2624.5 2631.5 2676.2 5097.9 5205.0 5214.8 5238.6 5249.6 4685.3 5163.2 5864.3 6273.5 6288.6 5760.8 6281.3 6286.6 6290.4 6307.5 5119.5 5413.4 6100.1 6162.7 6209.3 4803.5 5737.3 5991.7 6121.5 6126.9 5805.8 6367.2 6392.5 6409.7 6443.6 3237.8 3797.5 3992.7 4016.1 4051.4 5250.6 5416.4 5775.3 5778.8 6090.2 5149.5 5689.7 5848.2 5877.6 5888.3 5399.8 5406.9 5610.3 5826.6 5887.9 5071.7 5471.9 5538.0 5682.9 5762.7 5900.6 5930.6 5935.4 5942.9 5957.5 5455.8 5513.6 5582.5 5800.4 5908.9 07:19:08 INFO - PROCESS | 1655 | 07:19:08 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:23701.45 Median:3854.42 stddev:37228.35 (965.9%) stddev-sans-first:37292.90 07:19:08 INFO - PROCESS | 1655 | Values: 748.9 749.4 793.1 794.6 849.6 15216.5 15553.4 15808.1 15958.0 15994.8 14477.0 14655.6 15313.2 15808.7 15956.2 858.8 881.9 883.9 887.4 889.8 677.1 698.8 852.2 879.5 882.1 886.8 925.2 928.3 929.3 929.7 892.7 918.1 919.0 920.6 921.0 559.5 560.5 643.4 649.6 681.2 12731.4 14932.8 15461.4 15492.7 15531.9 11918.8 13617.1 14012.5 14013.6 14260.9 11760.9 11770.6 11822.5 11964.1 12196.1 3745.9 3768.5 3791.6 3903.0 3944.3 101133.0 103767.0 106148.5 109445.5 123759.4 10917.8 11027.8 11053.9 11101.7 11214.0 21892.0 21949.7 21966.9 22134.4 22251.1 7979.4 8064.1 8067.4 8076.7 8284.2 4468.2 4471.3 4480.6 4558.5 4614.5 2959.8 3614.0 3678.1 3734.8 3805.8 696.9 711.4 712.6 718.5 722.1 563.8 617.2 629.2 643.8 662.5 7747.6 9315.2 9405.5 9505.4 9632.8 518.7 583.9 603.4 663.9 671.7 4211.3 4405.3 4615.1 4823.0 4834.1 78634.6 88121.6 134306.0 137435.0 145786.3 121593.0 124036.1 126079.4 126926.7 127445.0 105714.0 108128.0 111378.4 114450.4 115492.0 9069.4 9111.6 9163.0 9234.9 9292.5 61195.4 61232.4 61347.0 63237.4 63812.7 88983.1 91994.5 93917.6 95406.0 95982.0 11581.8 11771.6 11825.9 11881.2 12332.1 12270.4 12396.4 12564.7 12975.6 13814.7 12329.3 12393.6 12639.0 12800.4 12803.4 12145.8 12274.7 12372.8 12738.4 12745.6 11807.1 12032.8 12131.2 12147.6 12477.4 9643.4 9668.1 10015.1 10445.0 10641.1 8904.3 9338.0 9600.9 10691.3 10744.7 07:19:08 INFO - PROCESS | 1655 | -------- Summary: end -------- 07:19:08 INFO - PROCESS | 1655 | 07:19:09 INFO - TEST-INFO | 1655: exit 0 07:19:09 INFO - TEST-OK | dromaeo_css | took 1114074ms 07:19:09 INFO - TEST-START | kraken 07:19:09 INFO - operating with platform_type : mac_ 07:19:09 INFO - Initialising browser for kraken test... 07:19:09 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpvKA4p8/profile http://localhost:49271/getInfo.html) 07:19:12 INFO - PROCESS | 1665 | 2016-09-23 07:19:12.189 plugin-container[1666:11958] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x450f, name = 'com.apple.tsm.portname' 07:19:12 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:19:12 INFO - PROCESS | 1665 | 2016-09-23 07:19:12.192 plugin-container[1666:11958] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f03, name = 'com.apple.CFPasteboardClient' 07:19:12 INFO - PROCESS | 1665 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:19:12 INFO - PROCESS | 1665 | 2016-09-23 07:19:12.192 plugin-container[1666:11958] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:19:12 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 07:19:12 INFO - PROCESS | 1665 | colorDepth:24 07:19:12 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 07:19:12 INFO - PROCESS | 1665 | __metrics 07:19:12 ERROR - PROCESS | 1665 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 07:19:12 INFO - TEST-INFO | 1665: exit 0 07:19:12 INFO - Browser initialized. 07:19:12 INFO - Running cycle 1/1 for kraken test... 07:19:12 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/T/tmpvKA4p8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:19:15 INFO - PROCESS | 1667 | 2016-09-23 07:19:15.269 plugin-container[1668:12071] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8813, name = 'com.apple.tsm.portname' 07:19:15 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:19:15 INFO - PROCESS | 1667 | 2016-09-23 07:19:15.271 plugin-container[1668:12071] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e03, name = 'com.apple.CFPasteboardClient' 07:19:15 INFO - PROCESS | 1667 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:19:15 INFO - PROCESS | 1667 | 2016-09-23 07:19:15.271 plugin-container[1668:12071] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:19:24 INFO - PROCESS | 1667 | RSS: Main: 239427584 07:19:24 INFO - PROCESS | 1667 | 07:19:28 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 07:19:29 INFO - PROCESS | 1667 | RSS: Main: 253386752 07:19:29 INFO - PROCESS | 1667 | 07:19:31 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 07:19:32 INFO - PROCESS | 1667 | RSS: Main: 260911104 07:19:32 INFO - PROCESS | 1667 | 07:19:35 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 07:19:36 INFO - PROCESS | 1667 | RSS: Main: 261718016 07:19:36 INFO - PROCESS | 1667 | 07:19:38 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 07:19:38 INFO - PROCESS | 1667 | RSS: Main: 262832128 07:19:38 INFO - PROCESS | 1667 | 07:19:40 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:19:41 INFO - PROCESS | 1667 | RSS: Main: 264458240 07:19:41 INFO - PROCESS | 1667 | 07:19:44 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 07:19:44 INFO - PROCESS | 1667 | RSS: Main: 265166848 07:19:44 INFO - PROCESS | 1667 | 07:19:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 07:19:48 INFO - PROCESS | 1667 | RSS: Main: 265207808 07:19:48 INFO - PROCESS | 1667 | 07:19:51 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 07:19:52 INFO - PROCESS | 1667 | RSS: Main: 265506816 07:19:52 INFO - PROCESS | 1667 | 07:19:53 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:19:54 INFO - PROCESS | 1667 | RSS: Main: 264712192 07:19:54 INFO - PROCESS | 1667 | 07:19:56 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:19:56 INFO - PROCESS | 1667 | RSS: Main: 264736768 07:19:56 INFO - PROCESS | 1667 | 07:19:58 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:19:59 INFO - PROCESS | 1667 | RSS: Main: 264736768 07:19:59 INFO - PROCESS | 1667 | 07:20:02 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:20:03 INFO - PROCESS | 1667 | RSS: Main: 264847360 07:20:03 INFO - PROCESS | 1667 | 07:20:06 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:20:07 INFO - PROCESS | 1667 | RSS: Main: 265121792 07:20:07 INFO - PROCESS | 1667 | 07:20:08 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 07:20:09 INFO - PROCESS | 1667 | RSS: Main: 266801152 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | __start_tp_report 07:20:09 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 07:20:09 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 07:20:09 INFO - PROCESS | 1667 | |i|pagename|runs| 07:20:09 INFO - PROCESS | 1667 | |0;ai-astar;106;117;117;115;116;123;116;154;170;127 07:20:09 INFO - PROCESS | 1667 | |1;audio-beat-detection;150;113;111;151;111;109;95;102;170;140 07:20:09 INFO - PROCESS | 1667 | |2;audio-dft;200;211;220;201;197;197;195;195;199;193 07:20:09 INFO - PROCESS | 1667 | |3;audio-fft;83;58;60;86;51;72;83;82;101;60 07:20:09 INFO - PROCESS | 1667 | |4;audio-oscillator;94;71;87;93;69;69;77;73;103;115 07:20:09 INFO - PROCESS | 1667 | |5;imaging-gaussian-blur;90;88;88;87;89;86;90;87;89;85 07:20:09 INFO - PROCESS | 1667 | |6;imaging-darkroom;150;150;95;97;95;112;95;98;96;106 07:20:09 INFO - PROCESS | 1667 | |7;imaging-desaturate;146;151;97;91;106;146;94;90;90;119 07:20:09 INFO - PROCESS | 1667 | |8;json-parse-financial;56;55;57;57;58;57;58;59;56;57 07:20:09 INFO - PROCESS | 1667 | |9;json-stringify-tinderbox;70;74;74;82;76;75;71;73;73;74 07:20:09 INFO - PROCESS | 1667 | |10;stanford-crypto-aes;89;86;91;90;91;86;92;81;102;97 07:20:09 INFO - PROCESS | 1667 | |11;stanford-crypto-ccm;138;141;130;150;153;154;153;163;151;138 07:20:09 INFO - PROCESS | 1667 | |12;stanford-crypto-pbkdf2;172;190;233;243;189;182;238;210;173;220 07:20:09 INFO - PROCESS | 1667 | |13;stanford-crypto-sha256-iterative;67;70;69;65;73;63;69;70;66;68 07:20:09 INFO - PROCESS | 1667 | __end_tp_report 07:20:09 INFO - PROCESS | 1667 | __start_cc_report 07:20:09 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,928 07:20:09 INFO - PROCESS | 1667 | __end_cc_report 07:20:09 INFO - PROCESS | 1667 | __startTimestamp1474640409014__endTimestamp 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | ------- Summary: start ------- 07:20:09 INFO - PROCESS | 1667 | Number of tests: 14 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#0] ai-astar Cycles:10 Average:126.10 Median:120.00 stddev:20.04 (16.7%) stddev-sans-first:19.89 07:20:09 INFO - PROCESS | 1667 | Values: 106.0 117.0 117.0 115.0 116.0 123.0 116.0 154.0 170.0 127.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#1] audio-beat-detection Cycles:10 Average:125.20 Median:145.00 stddev:25.32 (17.5%) stddev-sans-first:25.22 07:20:09 INFO - PROCESS | 1667 | Values: 150.0 113.0 111.0 151.0 111.0 109.0 95.0 102.0 170.0 140.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#2] audio-dft Cycles:10 Average:200.80 Median:199.50 stddev:8.39 (4.2%) stddev-sans-first:8.89 07:20:09 INFO - PROCESS | 1667 | Values: 200.0 211.0 220.0 201.0 197.0 197.0 195.0 195.0 199.0 193.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#3] audio-fft Cycles:10 Average:73.60 Median:77.00 stddev:15.91 (20.7%) stddev-sans-first:16.51 07:20:09 INFO - PROCESS | 1667 | Values: 83.0 58.0 60.0 86.0 51.0 72.0 83.0 82.0 101.0 60.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#4] audio-oscillator Cycles:10 Average:85.10 Median:75.00 stddev:15.95 (21.3%) stddev-sans-first:16.59 07:20:09 INFO - PROCESS | 1667 | Values: 94.0 71.0 87.0 93.0 69.0 69.0 77.0 73.0 103.0 115.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:88.50 stddev:1.66 (1.9%) stddev-sans-first:1.58 07:20:09 INFO - PROCESS | 1667 | Values: 90.0 88.0 88.0 87.0 89.0 86.0 90.0 87.0 89.0 85.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#6] imaging-darkroom Cycles:10 Average:109.40 Median:95.00 stddev:22.11 (23.3%) stddev-sans-first:17.92 07:20:09 INFO - PROCESS | 1667 | Values: 150.0 150.0 95.0 97.0 95.0 112.0 95.0 98.0 96.0 106.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#7] imaging-desaturate Cycles:10 Average:113.00 Median:90.00 stddev:25.53 (28.4%) stddev-sans-first:24.12 07:20:09 INFO - PROCESS | 1667 | Values: 146.0 151.0 97.0 91.0 106.0 146.0 94.0 90.0 90.0 119.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:1.15 (2.0%) stddev-sans-first:1.17 07:20:09 INFO - PROCESS | 1667 | Values: 56.0 55.0 57.0 57.0 58.0 57.0 58.0 59.0 56.0 57.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:74.20 Median:74.00 stddev:3.26 (4.4%) stddev-sans-first:3.08 07:20:09 INFO - PROCESS | 1667 | Values: 70.0 74.0 74.0 82.0 76.0 75.0 71.0 73.0 73.0 74.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:90.50 stddev:5.87 (6.5%) stddev-sans-first:6.20 07:20:09 INFO - PROCESS | 1667 | Values: 89.0 86.0 91.0 90.0 91.0 86.0 92.0 81.0 102.0 97.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:152.00 stddev:9.94 (6.5%) stddev-sans-first:9.98 07:20:09 INFO - PROCESS | 1667 | Values: 138.0 141.0 130.0 150.0 153.0 154.0 153.0 163.0 151.0 138.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:205.00 Median:215.00 stddev:27.26 (12.7%) stddev-sans-first:26.17 07:20:09 INFO - PROCESS | 1667 | Values: 172.0 190.0 233.0 243.0 189.0 182.0 238.0 210.0 173.0 220.0 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - PROCESS | 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:69.00 stddev:2.87 (4.2%) stddev-sans-first:3.02 07:20:09 INFO - PROCESS | 1667 | Values: 67.0 70.0 69.0 65.0 73.0 63.0 69.0 70.0 66.0 68.0 07:20:09 INFO - PROCESS | 1667 | -------- Summary: end -------- 07:20:09 INFO - PROCESS | 1667 | 07:20:09 INFO - TEST-INFO | 1667: exit 0 07:20:09 INFO - TEST-OK | kraken | took 60460ms 07:20:09 INFO - SUITE-END | took 1174s 07:20:10 INFO - Completed test suite (00:19:34) 07:20:10 INFO - javascript benchmark 07:20:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7282.258930798364, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3010.9999999999995, 3332.8333583320828, 3371.426857434236, 3395.4567269236927, 3410.283840393517, 5474.671519708811, 5538.667679939202, 5587.525060369869, 5589.105743081108, 5621.718914054301, 5492.066348720717, 5574.777008919638, 5612.07400778871, 5685.118806584976, 5705.25831641886, 5047.4447810740785, 5100.183970564711, 5148.124818780816, 5176.197689358156, 5190.792368305263, 5019.222020586815, 5193.766280517386, 5200.947990520084, 5217.58259339252, 5271.472852714736, 5005.949940500621, 5088.542031217171, 5114.641975061747, 5165.845024649267, 5170.767315470813, 4180.895477613054, 5114.360704911886, 5149.794008239666, 5156.329677141947, 5160.974195129038, 5058.140116180258, 5082.593392528589, 5088.389393272831, 5114.2584325273, 5127.6154288428515, 5439.184122381635, 5446.455354464561, 5470.753816078286, 5546.667199968015, 5613.775448982035, 6111.541634377395, 6164.938350616481, 6169.889419904415, 6187.659678717669, 6192.9380706192815, 6227.813165605039, 6230.87538249237, 6235.220597425322, 6235.469985051276, 6244.344343843876, 5558.722063896789, 5613.859653508695, 5617.9719101404235, 5698.487136157724, 5755.136729490568, 6149.754009839646, 6198.535109866778, 6238.064290356483, 6241.906371404432, 6252.062190671345, 4993.975030124826, 5923.200367950358, 6007.789727359522, 6019.518438524995, 6029.155918171459, 6001.06983417571, 6060.272822245639, 6076.3012253591405, 6176.258848938156, 6182.845428864224, 4370.956290437119, 4979.178435558165, 5507.476789704971, 5600.775968961278, 5996.610220335664, 4812.951870481251, 4914.336564563738, 5695.202671625976, 6130.540209484307, 6151.66165860873, 3981.3629819228786, 4827.444843842933, 4839.467658557556, 4846.200376937766, 4850.8787280317565, 4238.788060596958, 4328.350747387917, 4369.563043695669, 4404.229259879508, 4437.400950871591, 5585.413531579207, 5597.412271711493, 5653.943460565424, 5697.23087383198, 5709.600327977002, 5989.431004054608, 6195.132681424604, 6225.097360882647, 6226.066090086523, 6249.25008998923, 5583.330000399897, 5636.718164091779, 5645.435456454322, 5651.954388438152, 5708.771649133988, 5299.3905700844125, 5299.682019078868, 5319.6808191508635, 5332.440093790174, 5361.410244873061, 6225.595336303126, 6247.656378899204, 6248.187735594434, 6262.906056409066, 6266.122742816009, 6083.8174854754425, 6100.73256437228, 6112.1748563945075, 6120.8775824484155, 6191.5665903388135, 6189.319174890848, 6213.440790328892, 6228.065790131335, 6232.002879539252, 6244.1570387997035, 5967.76128954837, 6010.909836352545, 6047.0, 6068.939310606837, 6101.908471373022, 5231.875146843447, 6082.0, 6104.883608894006, 6107.917136653054, 6159.414855588712, 5943.257092863392, 5993.490553302844, 6005.759769609167, 6016.819495415145, 6036.6679832609625, 5803.0, 5852.4147585241135, 5978.551608629283, 6002.699865006645, 6019.428154325332, 5638.097904335286, 5687.402822703557, 5715.399883012224, 5721.113227449752, 5867.943770121419, 4899.681520701143, 5894.528437725057, 5961.135635332939, 5964.343922168645, 5969.61197522177, 5735.0, 5772.682502462405, 5793.15999180125, 5799.565032622654, 5803.332616749128], "value": 5535.720661747315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [525.2856115682671, 527.2565682387834, 535.8687121655195, 536.4688957931647, 572.8510587247315, 33280.83359583202, 41209.0, 41310.96722581937, 41391.79304103483, 41452.37821432681, 41679.583204167946, 41716.0, 42143.15713685725, 42275.0, 42396.36405453913, 9628.22974162069, 9813.165880900133, 9820.803583928317, 9828.066333698287, 9830.361026533252, 9716.222702183808, 9788.951055244714, 9799.461029643368, 9801.656942007032, 9819.852702209473, 7940.56326902023, 8427.747167584952, 8816.691415800417, 9683.41899486033, 9809.411435313905, 8511.404201705884, 9732.464714440703, 9769.609215631403, 9814.656487022992, 9817.558209880572, 9684.322097453181, 9714.31999760017, 9748.805023899553, 9804.068613481708, 9805.264605154642, 40681.79659101715, 40684.98287542805, 40717.389239161435, 40801.18397632031, 40905.772826814944, 3430.6054803697643, 3438.6905178534053, 3476.4263896457055, 3633.8364773585254, 3817.9045523861846, 30420.54369184464, 30599.847000764854, 30709.77160913561, 31134.0, 31707.0, 3190.696883796059, 3209.6629853865475, 3238.2228265216177, 3274.4597141471627, 3358.177246574605, 469953.0, 475197.0, 477431.0, 477847.61076194746, 477932.0, 57235.14147287794, 57546.136807947914, 57712.0, 57750.7112464435, 57867.0, 32780.83609581985, 33855.66144338575, 33987.83006084954, 59598.40401596015, 59695.403045969855, 16078.0, 16171.0, 16214.675706485805, 16243.02541847493, 16272.51182464528, 12410.503579856704, 12496.625101246977, 12517.061220408506, 12521.749565008831, 12532.0, 18952.81047189538, 18989.39201551701, 19013.957766757252, 19041.904790475957, 19082.14130364137, 6784.491163162783, 7678.347340476123, 7766.766996990099, 8276.29651479619, 8358.749237522885, 867.6442658510107, 930.8696782450462, 974.1914211204684, 1041.3209220297354, 1113.549012649878, 29311.560326595118, 29712.96004639827, 29943.70056299409, 30331.0, 30519.0, 1065.9713376591471, 1082.3505896462218, 1087.717193529688, 1093.1528065749108, 1156.9595064172713, 13443.529476468277, 15204.695906081817, 15251.703605193683, 15308.464203752816, 15399.461018864286, 620592.0, 676298.0, 676620.0, 680350.0, 680582.0, 41933.79033104876, 44755.328670069975, 50750.74624626853, 56658.43341566614, 56897.0, 1339.1830983100301, 1372.8421231558498, 1395.9232242226774, 1397.44800803684, 1399.0626280392162, 28377.43245135127, 29378.853105734335, 29430.558541621464, 29974.0, 30070.54894176633, 47010.82472938204, 47767.805804855154, 48188.75905620449, 48228.5177148224, 48248.276275856595, 506601.4669926627, 541338.0, 572448.0, 572990.0, 574754.0, 25532.744672553035, 25735.613965790904, 25994.090206843426, 26087.0, 26134.215973520826, 46476.535234648574, 46572.30141547812, 47386.763066184445, 47387.76306118447, 47638.76180619075, 32003.35993280168, 37647.81176094212, 38219.808900955315, 38754.80622596869, 38825.41761873518, 38300.233995320494, 38618.80690596529, 38859.63991260292, 39295.803520983354, 39733.80133099316, 37421.06447338838, 37824.81087594544, 38039.0, 38321.04197395087, 38390.424143638425, 31962.52056219205, 34242.31515369729, 34612.307753845285, 34671.95984120481, 34747.0, 25003.0, 25162.62256066197, 25467.0, 25621.231363059138, 25728.813050890134], "value": 19677.50213009355, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.9261869769953, 365.75677174678833, 369.5823719197307, 377.1495278147776, 395.359517581518, 17565.033923134222, 20163.0, 20775.584488310244, 21456.24903128389, 21600.0, 20680.37958861233, 20842.68735968962, 20877.47806304843, 21049.368518944455, 21652.35042948714, 5013.197888337867, 5790.131480277971, 5862.443067908542, 5921.756431149463, 6047.425494578008, 5627.831165065034, 5968.432998865101, 5975.163477113208, 6062.18160548327, 6065.2418447694035, 5754.65472071675, 6006.9399306007035, 6009.75960961561, 6044.848878778043, 6057.151998720183, 5694.288213973254, 5838.970805145968, 5920.141579470996, 5925.703714814264, 5999.61002534836, 5088.2622019807295, 5144.228365745131, 5147.6654017488745, 5153.716545589991, 5156.071907056728, 25570.74429255702, 25648.61527077095, 25686.0, 25782.871085644638, 26065.0, 2119.9788002119935, 2409.807215422762, 2426.9757302426924, 2441.6459613355964, 2472.134752836511, 15473.458428954933, 15474.61313467161, 15606.921965390215, 16067.517974460785, 16228.269727862275, 1805.9638807223914, 1858.8977606231651, 1896.1941175000707, 1939.7381353517235, 1945.3385848811472, 115754.0, 116343.4182829089, 116655.0, 117117.0, 117276.41361793222, 10412.375257484575, 10545.789084218273, 10623.256372053882, 11005.779884402267, 11294.717632059264, 13182.209067455984, 13295.468181272641, 13402.53091141825, 13414.99387545938, 13450.722181392948, 8216.877586517085, 8401.957990210132, 8496.40525163245, 8600.182982616641, 8604.440711353742, 8524.531150786766, 8551.657933682583, 8551.700690475804, 8722.258608018263, 8743.256823170103, 5546.0, 5922.466977972003, 6569.57297775643, 6654.434373078343, 6696.63168525726, 1818.0364406864383, 1835.375972169442, 1838.1911958738112, 1842.5669967557612, 1843.9446816595523, 833.3374966901328, 867.2498288979987, 934.56075644447, 972.3922548407245, 1010.3281317923645, 15842.841571584137, 17207.79545431808, 21408.678869816966, 21794.89102554477, 22431.32706018822, 805.5368163306123, 891.2468963725642, 968.4673429613684, 982.4007355513131, 1024.9795004099876, 11358.26171298863, 11680.766384672259, 11820.88179118215, 11897.643070707893, 11901.523939042341, 526094.0, 577854.0, 587314.4439944582, 592204.0, 592771.0, 95226.0, 112463.0, 122027.0, 123900.38049809873, 124951.75048249583, 806.5362416610355, 1019.3119644240256, 1027.8047171037479, 1029.7734498410339, 1037.1184493180735, 18647.347342843477, 19465.902670486557, 19682.0, 19784.703229451858, 19799.505012374804, 53255.46744532505, 53370.99717521279, 53553.0, 53624.0, 55318.0, 71491.0, 71810.64094679493, 72010.0, 72409.6379518099, 72477.0, 6435.967820160869, 6757.087793147862, 7739.458237923292, 7893.921060789318, 7909.288164065261, 11494.94252528732, 11875.94062029719, 13029.413676384775, 13372.799408008694, 13375.0, 9286.489243091695, 9422.481763503074, 11048.729396119548, 11382.317060976367, 11765.0, 10935.28920620157, 11104.278221915549, 11205.943970280423, 11481.311121332747, 11531.423428828357, 10371.94814025925, 10665.0, 11386.146039047271, 11743.647690569296, 11767.823482647938, 7804.765857024298, 7911.327537159175, 7970.880436793337, 8070.757877263692, 8195.262426381654, 11134.665960021212, 11427.142964277546, 11518.0, 11545.884541154817, 11733.237339572901], "value": 9650.08690603544, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1524.1997951075684, 1552.6739384729206, 1748.9331507780253, 1795.9730604040933, 1863.785664648565, 7922.485038472495, 8181.386396020307, 8423.957880210599, 8975.012748597657, 9000.279977601793, 8376.790580235498, 8658.26404755595, 8686.04453510115, 8768.912310876889, 8769.517676527788, 2025.5442525431806, 2324.883755812211, 2372.466195106096, 2378.4886249456363, 2386.1648423051965, 2350.9177178798745, 2370.4547953970596, 2393.4136136646457, 2404.651325557802, 2408.650745641881, 1792.5339411752973, 1845.2157832921023, 1974.8123928226796, 2284.7486776454575, 2310.630299152136, 2110.725605671268, 2203.3830527452337, 2337.357226762637, 2348.7181538215436, 2361.2207971369407, 2301.7698230177016, 2310.306907927615, 2311.0871205873586, 2313.745487996319, 2314.166899916029, 8667.089955554702, 8789.912100878973, 8860.556972151431, 8870.86693699595, 8876.600552975131, 5162.561182299509, 5293.920591191135, 5310.57515398771, 5321.414644389114, 5327.3074500314715, 3484.8083355415442, 3533.2050288685095, 3636.200035992104, 3676.7058635309113, 3697.0572504011307, 962.629387685746, 1081.875584307799, 1088.9128869690405, 1091.345192884271, 1097.6652121103061, 11517.424128793611, 11739.941300293443, 11754.29474231549, 11775.94112029443, 11782.705432364173, 4550.954490455119, 4629.86110416688, 4742.099001189763, 4788.11419887322, 4817.975910120427, 9874.851877221847, 9912.603495860085, 9915.900840991499, 9918.900810991798, 9924.652637157666, 5226.346706661668, 5244.606654500928, 5248.816291429782, 5274.92087618686, 5279.52484276417, 4054.9391759123637, 4335.566443355639, 4502.617277531446, 4661.930071048937, 4792.592629626451, 3900.8244628991765, 3903.4535165076913, 4024.2957482440456, 4047.392891066305, 4077.9796101019306, 1253.129075292663, 1255.0085432508217, 1260.0864373329446, 1269.041873385588, 1273.554256010389, 823.263179454385, 917.2341095185461, 917.2799352508382, 924.6486335192584, 965.753732798132, 5763.510101641407, 5809.883802324014, 5867.735951882176, 5959.404059594006, 6135.9079613805825, 437.5558807810012, 440.1680823244071, 440.44503925054664, 443.6450839328524, 447.7067520773898, 3848.7883166426113, 3933.3903244997073, 4036.5357983832237, 4056.6957478189256, 4069.694772892045, 10382.532786024647, 10566.841497377545, 10668.14654827612, 10668.253222274367, 10717.0890474309, 10333.449982502685, 10503.264771465923, 10757.56969721218, 10763.677089687322, 10780.137588992862, 6787.219469760942, 8118.959405203054, 8137.104918458965, 8211.671533138608, 8217.876731849026, 5455.208994695826, 5823.82528524145, 5852.590318677822, 5888.558358123072, 5913.763449461973, 9709.563069662023, 9943.105120539187, 9978.850317245393, 10007.349522281029, 10009.749756256151, 10207.081362677394, 10209.336393134423, 10220.437875916896, 10224.591016359262, 10225.693229203136, 6856.177258728984, 7108.395786358217, 7442.665080071518, 7528.096628404407, 7802.765917022499, 7059.647017649199, 7150.356467917913, 7255.4921155518605, 7307.378872795659, 7807.804804879924, 6262.530310226843, 7353.77938661841, 7448.404127669882, 7484.288992545699, 7505.099388073466, 7276.7089316428865, 7321.853562928818, 7330.890036649561, 7353.926460735538, 7379.151397589131, 6763.256041835296, 6973.686184121828, 7043.190033146254, 7117.75087871922, 7141.571505709674, 4858.732769697559, 4918.065567542156, 4952.826651067196, 4984.526469985346, 5035.320231768665, 4597.896504838748, 4953.925691114564, 4989.950100498949, 5022.246663000579, 5098.388193416814], "value": 4441.3633800404705, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.7537789855434, 296.8500907041944, 305.7263748944695, 308.46635320894853, 311.30734116590577, 4655.7672116394215, 4794.544518270767, 5336.252924590551, 5357.65175263608, 5492.176173573966, 4103.446034785303, 4932.457429682732, 5487.368952570456, 5517.834464966058, 5557.305336832896, 3811.4854494643146, 3952.051507638175, 4236.533981262067, 4239.321708526636, 4251.638610718092, 3471.611355457812, 4033.657139143176, 4182.581741825824, 4232.449781528397, 4263.211305908401, 3972.483577134983, 4176.603222693854, 4177.2246795112105, 4198.6011328923705, 4219.831206751726, 3614.9277014459826, 4204.180184863937, 4216.789160541976, 4221.430106935586, 4262.2754131797665, 3039.3313471036336, 3130.9373812523622, 3549.0, 3697.0, 3706.629337066299, 5029.874253143664, 5372.301600791911, 5389.730513474311, 5418.83743487696, 5463.344398672145, 4730.432348118248, 4740.715557066553, 4745.762711864393, 4757.785899634525, 4765.188538762112, 5064.2403639454005, 5519.116941289414, 5825.533957283407, 5884.764609415618, 5893.0, 3600.0, 3827.5072721638585, 3942.7634341939574, 3943.521179557666, 3945.743526670757, 5596.888062238732, 5888.499477544414, 6190.071489276599, 6210.534209934273, 6231.594946328474, 3989.8005099744896, 3993.4209539616595, 3995.081131339808, 3999.1201935574127, 4005.2590270799997, 3549.982250088733, 3596.98201508996, 3773.981130094387, 3887.3002859485564, 4041.8383264669674, 3968.7378194429475, 4423.380726698265, 4591.770411479412, 4752.976235118802, 4753.9049219016115, 4718.95281047192, 5580.972095139498, 5834.124881267844, 5883.235179426732, 5972.193753843262, 1277.5400855691944, 1292.2763252578397, 1343.8521762606106, 1355.6475316417605, 1373.3064802274787, 897.4704924094685, 907.919575704909, 920.4661296448178, 923.0815338737999, 925.2089463508738, 5294.338207724035, 5326.680399176062, 5385.084535628953, 5418.620696551282, 5428.0, 5578.191162281528, 5817.825465236049, 5838.416158384212, 5987.191729116514, 6035.094735789667, 4446.066326071561, 5246.580273578104, 5349.331333583302, 5416.485433883775, 5421.9366058177, 2169.4034140611457, 2587.7929765619083, 2624.4619852930105, 2631.4868600623076, 2676.210517897186, 5097.923531146962, 5204.981110955712, 5214.843554693365, 5238.616429524557, 5249.613998970719, 4685.320628508847, 5163.173892177234, 5864.266966629171, 6273.529485288622, 6288.610328075302, 5760.810891861066, 6281.277653069864, 6286.591371560834, 6290.433860952445, 6307.463865571386, 5119.48805119485, 5413.431589683027, 6100.10245133558, 6162.722677479614, 6209.348018457997, 4803.51091161741, 5737.311522617312, 5991.700414979146, 6121.510279177744, 6126.877462450815, 5805.82582522525, 6367.235931688042, 6392.456641185551, 6409.743610255724, 6443.581167224115, 3237.7733558650666, 3797.525309336333, 3992.680585553207, 4016.136530645925, 4051.3517837145914, 5250.606204534599, 5416.377116631637, 5775.33583637887, 5778.768849245983, 6090.23872015998, 5149.536541711264, 5689.715514224355, 5848.239728835224, 5877.559183061202, 5888.263967004124, 5399.757010934439, 5406.864558442771, 5610.298712660918, 5826.563007774349, 5887.911681324869, 5071.667033164638, 5471.890562188813, 5538.0, 5682.948654498931, 5762.740676669476, 5900.586958913007, 5930.555208359304, 5935.376785437467, 5942.910856337072, 5957.49361304294, 5455.809046683347, 5513.641613295123, 5582.49757521825, 5800.361960184292, 5908.881822363614], "value": 4181.1228699318235, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.8577170337635, 749.3929916767422, 793.1394437035816, 794.6463823598501, 849.5539841583168, 15216.543503694878, 15553.377864885419, 15808.130552819604, 15958.0, 15994.76007859883, 14477.0, 14655.63360915975, 15313.157776322298, 15808.683826323466, 15956.202189890517, 858.7681326041949, 881.858902575588, 883.8630012348065, 887.3788348156285, 889.7686601483596, 677.0994577212296, 698.8427603789157, 852.1563651984521, 879.4503435352905, 882.1399135842566, 886.7871710789397, 925.1534845616253, 928.2991341537164, 929.2890938432105, 929.7117893453018, 892.6830975003845, 918.0635751533432, 918.9862152067724, 920.6087412849512, 920.9861852072257, 559.5467671186352, 560.5431573267774, 643.4080645805869, 649.5875119299232, 681.2063945503483, 12731.427085781163, 14932.776008359884, 15461.381544738197, 15492.690146197127, 15531.922340388339, 11918.821217681741, 13617.114887532278, 14012.509562165376, 14013.579592612237, 14260.85739142616, 11760.941195294054, 11770.588029419016, 11822.467988940432, 11964.102692298113, 12196.14626976112, 3745.906352341186, 3768.4724138620613, 3791.5829258781514, 3903.0437542802197, 3944.2505923874373, 101133.0, 103767.0, 106148.46925765321, 109445.45277273563, 123759.3812030934, 10917.81464154266, 11027.779444411068, 11053.944730276458, 11101.666949991513, 11214.0, 21892.0, 21949.67075493869, 21966.89016554939, 22134.446638834157, 22251.109955601918, 7979.441439099323, 8064.072631647318, 8067.39494537912, 8076.717314894068, 8284.212999765012, 4468.195724769507, 4471.32930060487, 4480.61914737251, 4558.544145585482, 4614.538546145426, 2959.792814502964, 3613.9638603614153, 3678.1172518595345, 3734.8132593370224, 3805.7906815125434, 696.8536607312521, 711.4273010226714, 712.6258714174996, 718.4611541343992, 722.1045903080247, 563.8167595531469, 617.1791517282004, 629.2260519560874, 643.8165122939939, 662.5031226580065, 7747.573883436352, 9315.161635452841, 9405.482698451515, 9505.382150160218, 9632.75918102053, 518.6861948521166, 583.9036558967807, 603.405645439242, 663.9045574801615, 671.6868522039401, 4211.305134652809, 4405.29515277554, 4615.123126606001, 4823.0, 4834.081524510332, 78634.64096077127, 88121.55939220263, 134306.0, 137435.0, 145786.2710686461, 121593.0, 124036.1394579082, 126079.3696031514, 126926.73073269334, 127445.0, 105714.0, 108128.0, 111378.44310778394, 114450.42774786073, 115492.0, 9069.365144439826, 9111.635534578543, 9163.0, 9234.875978524842, 9292.535373231176, 61195.38804611897, 61232.387676124454, 61347.0, 63237.36762632499, 63812.68093659502, 88983.11016889749, 91994.54002729943, 93917.59123613288, 95406.0, 95982.0, 11581.768364632491, 11771.646850594496, 11825.940870295593, 11881.168318217642, 12332.075094368138, 12270.386480676108, 12396.442160102637, 12564.685882853002, 12975.610731678065, 13814.723705526034, 12329.260244385365, 12393.62819115428, 12639.0, 12800.423980920694, 12803.35983200855, 12145.757084858431, 12274.693132671755, 12372.752544948871, 12738.426770795522, 12745.553905613258, 11807.114466415225, 12032.75934481323, 12131.21147125434, 12147.574834880737, 12477.438515266653, 9643.360628693279, 9668.129868311886, 10015.14871235953, 10445.0, 10641.148708103488, 8904.287656987295, 9337.953310233406, 9600.855987160337, 10691.251612387057, 10744.731381715206], "value": 7639.517136902774, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 117.0, 117.0, 115.0, 116.0, 123.0, 116.0, 154.0, 170.0, 127.0], "value": 126.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 113.0, 111.0, 151.0, 111.0, 109.0, 95.0, 102.0, 170.0, 140.0], "value": 125.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 211.0, 220.0, 201.0, 197.0, 197.0, 195.0, 195.0, 199.0, 193.0], "value": 200.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 60.0, 86.0, 51.0, 72.0, 83.0, 82.0, 101.0, 60.0], "value": 73.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 71.0, 87.0, 93.0, 69.0, 69.0, 77.0, 73.0, 103.0, 115.0], "value": 85.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 88.0, 87.0, 89.0, 86.0, 90.0, 87.0, 89.0, 85.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 95.0, 97.0, 95.0, 112.0, 95.0, 98.0, 96.0, 106.0], "value": 109.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 151.0, 97.0, 91.0, 106.0, 146.0, 94.0, 90.0, 90.0, 119.0], "value": 113.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 57.0, 58.0, 57.0, 58.0, 59.0, 56.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 74.0, 82.0, 76.0, 75.0, 71.0, 73.0, 73.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 91.0, 90.0, 91.0, 86.0, 92.0, 81.0, 102.0, 97.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 141.0, 130.0, 150.0, 153.0, 154.0, 153.0, 163.0, 151.0, 138.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 190.0, 233.0, 243.0, 189.0, 182.0, 238.0, 210.0, 173.0, 220.0], "value": 205.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 69.0, 65.0, 73.0, 63.0, 69.0, 70.0, 66.0, 68.0], "value": 68.0, "unit": "score"}]}]} 07:20:10 INFO - Return code: 0 07:20:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:20:10 ERROR - # TBPL SUCCESS # 07:20:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:20:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:20:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:20:10 INFO - 2016-09-23 07:20:10.353 screenresolution[1672:12452] starting screenresolution argv=screenresolution get 07:20:10 INFO - 2016-09-23 07:20:10.356 screenresolution[1672:12452] Display 0: 1600x1200x32@60 07:20:10 INFO - 2016-09-23 07:20:10.362 screenresolution[1673:12455] starting screenresolution argv=screenresolution list 07:20:10 INFO - Available Modes on Display 0 07:20:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:20:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:20:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:20:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:20:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:20:10 INFO - Intel Iris: 07:20:10 INFO - Chipset Model: Intel Iris 07:20:10 INFO - Type: GPU 07:20:10 INFO - Bus: Built-In 07:20:10 INFO - VRAM (Dynamic, Max): 1536 MB 07:20:10 INFO - Vendor: Intel (0x8086) 07:20:10 INFO - Device ID: 0x0a2e 07:20:10 INFO - Revision ID: 0x0009 07:20:10 INFO - Displays: 07:20:10 INFO - Display: 07:20:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:20:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:20:10 INFO - Display Serial Number: 1600x1200 60 07:20:10 INFO - Main Display: Yes 07:20:10 INFO - Mirror: Off 07:20:10 INFO - Online: Yes 07:20:10 INFO - Rotation: Supported 07:20:10 INFO - Return code: 0 07:20:10 INFO - Running post-action listener: _resource_record_post_action 07:20:10 INFO - [mozharness: 2016-09-23 14:20:10.598251Z] Finished run-tests step (success) 07:20:10 INFO - Running post-run listener: _resource_record_post_run 07:20:10 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 32666112; Write bytes: 712814592; Read time: 198; Write time: 2037 07:20:10 INFO - TinderboxPrint: CPU usage
54.4% 07:20:10 INFO - TinderboxPrint: I/O read bytes / time
32,666,112 / 198 07:20:10 INFO - TinderboxPrint: I/O write bytes / time
712,814,592 / 2,037 07:20:10 INFO - TinderboxPrint: CPU idle
2,206.2 (45.6%) 07:20:10 INFO - TinderboxPrint: CPU system
975.2 (20.1%) 07:20:10 INFO - TinderboxPrint: CPU user
1,660.3 (34.3%) 07:20:10 INFO - TinderboxPrint: Swap in / out
435,331,072 / 0 07:20:10 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 390834688; Write bytes: 383026176; Read time: 29352; Write time: 768 07:20:10 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 31744512; Write bytes: 303451136; Read time: 185; Write time: 1207 07:20:11 INFO - Running post-run listener: _upload_blobber_files 07:20:11 INFO - Blob upload gear active. 07:20:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:20:11 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 07:20:11 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:20:11 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:20:11 INFO - (blobuploader) - INFO - Open directory for files ... 07:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:12 INFO - (blobuploader) - INFO - Done attempting. 07:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:20:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:13 INFO - (blobuploader) - INFO - Done attempting. 07:20:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:20:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:20:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:20:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:20:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:20:15 INFO - (blobuploader) - INFO - Done attempting. 07:20:15 INFO - (blobuploader) - INFO - Iteration through files over. 07:20:15 INFO - Return code: 0 07:20:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:20:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:20:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a48dfc77689d002bf5f5bea9066f7b2e52e594c8555782ce6f5c7eed1d7cdca37ee79b43377c4fb18f1afbf072e23ac519d3b296d577c9d82a526062873de0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/476d4f1defafbeccb4c6a06207d0050bf28afa15549d5b573b4668d2ad40b693c187bdbbacbdd6119a1ca30b2782d2f143db906307709ad6180e3f7ef486e273", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06ba149923af5707a211881c87648c263fe8b0ae17acbaf4c88d1282490ef68b63b198c7382a8fc2b0d85ee7521ca702636ff0691b344a7784c81224f32c1439"} 07:20:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:20:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:20:15 INFO - Contents: 07:20:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a48dfc77689d002bf5f5bea9066f7b2e52e594c8555782ce6f5c7eed1d7cdca37ee79b43377c4fb18f1afbf072e23ac519d3b296d577c9d82a526062873de0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/476d4f1defafbeccb4c6a06207d0050bf28afa15549d5b573b4668d2ad40b693c187bdbbacbdd6119a1ca30b2782d2f143db906307709ad6180e3f7ef486e273", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06ba149923af5707a211881c87648c263fe8b0ae17acbaf4c88d1282490ef68b63b198c7382a8fc2b0d85ee7521ca702636ff0691b344a7784c81224f32c1439"} 07:20:15 INFO - Running post-run listener: copy_logs_to_upload_dir 07:20:15 INFO - Copying logs to upload dir... 07:20:15 INFO - mkdir: /builds/slave/test/build/upload/logs 07:20:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.106612 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-09-23 07:20:15.882728) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 07:20:15.886412) ========= 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.hltqo16VIx/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.HZp51g74U6/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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/Fx-Team/sha512/0a48dfc77689d002bf5f5bea9066f7b2e52e594c8555782ce6f5c7eed1d7cdca37ee79b43377c4fb18f1afbf072e23ac519d3b296d577c9d82a526062873de0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/476d4f1defafbeccb4c6a06207d0050bf28afa15549d5b573b4668d2ad40b693c187bdbbacbdd6119a1ca30b2782d2f143db906307709ad6180e3f7ef486e273", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06ba149923af5707a211881c87648c263fe8b0ae17acbaf4c88d1282490ef68b63b198c7382a8fc2b0d85ee7521ca702636ff0691b344a7784c81224f32c1439"} build_url:https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0a48dfc77689d002bf5f5bea9066f7b2e52e594c8555782ce6f5c7eed1d7cdca37ee79b43377c4fb18f1afbf072e23ac519d3b296d577c9d82a526062873de0c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/476d4f1defafbeccb4c6a06207d0050bf28afa15549d5b573b4668d2ad40b693c187bdbbacbdd6119a1ca30b2782d2f143db906307709ad6180e3f7ef486e273", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/06ba149923af5707a211881c87648c263fe8b0ae17acbaf4c88d1282490ef68b63b198c7382a8fc2b0d85ee7521ca702636ff0691b344a7784c81224f32c1439"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 07:20:15.925501) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 07:20:15.925822) ========= 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.hltqo16VIx/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.HZp51g74U6/Listeners TMPDIR=/var/folders/h_/my_ljhhj0k7_kt_82jk2vx6000000w/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.005182 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 07:20:15.973872) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 07:20:15.974198) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 07:20:15.974531) ========= ========= Total master_lag: 0.44 =========