builder: mozilla-beta_yosemite_r7_devedition_test-dromaeojs-e10s slave: t-yosemite-r7-0163 starttime: 1495806872.05 results: success (0) buildid: 20170526051315 builduid: ede73c92b670400980e8921df9921580 revision: a6718df8269d161f0e2685b1266f7dcc981a751d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:32.047726) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:32.048179) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:32.048455) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:32.074229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:32.074569) ========= 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.UhYQsh3vSj/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.lE6QEkUspG/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 --2017-05-26 06:54:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-05-26 06:54:32 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102290 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:32.199916) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:32.200227) ========= 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.UhYQsh3vSj/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.lE6QEkUspG/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.028679 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:32.249433) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 06:54:32.250218) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a6718df8269d161f0e2685b1266f7dcc981a751d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a6718df8269d161f0e2685b1266f7dcc981a751d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UhYQsh3vSj/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.lE6QEkUspG/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 2017-05-26 06:54:32,343 truncating revision to first 12 chars 2017-05-26 06:54:32,344 Setting DEBUG logging. 2017-05-26 06:54:32,344 attempt 1/10 2017-05-26 06:54:32,344 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a6718df8269d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-26 06:54:33,371 unpacking tar archive at: mozilla-beta-a6718df8269d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.313262 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-26 06:54:33.590853) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:33.591679) ========= script_repo_revision: a6718df8269d161f0e2685b1266f7dcc981a751d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:33.592681) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:33.593499) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 06:54:33.613843) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-05-26 06:54:33.614174) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UhYQsh3vSj/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.lE6QEkUspG/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:54:33 INFO - MultiFileLogger online at 20170526 06:54:33 in /builds/slave/test 06:54:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:54:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:54:33 INFO - {'append_to_log': False, 06:54:33 INFO - 'base_work_dir': '/builds/slave/test', 06:54:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:54:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:54:33 INFO - 'branch': 'Mozilla-Beta', 06:54:33 INFO - 'buildbot_json_path': 'buildprops.json', 06:54:33 INFO - 'config_files': ('talos/mac_config.py',), 06:54:33 INFO - 'default_actions': ('clobber', 06:54:33 INFO - 'read-buildbot-config', 06:54:33 INFO - 'download-and-extract', 06:54:33 INFO - 'populate-webroot', 06:54:33 INFO - 'create-virtualenv', 06:54:33 INFO - 'install', 06:54:33 INFO - 'run-tests'), 06:54:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:54:33 INFO - 'download_minidump_stackwalk': True, 06:54:33 INFO - 'download_symbols': 'ondemand', 06:54:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:54:33 INFO - 'tooltool.py': '/tools/tooltool.py', 06:54:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:54:33 INFO - '/tools/misc-python/virtualenv.py')}, 06:54:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:54:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:54:33 INFO - 'gecko_profile': False, 06:54:33 INFO - 'gecko_profile_interval': 0, 06:54:33 INFO - 'installer_path': 'installer.exe', 06:54:33 INFO - 'log_level': 'info', 06:54:33 INFO - 'log_name': 'talos', 06:54:33 INFO - 'log_to_console': True, 06:54:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:54:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:54:33 INFO - 'opt_config_files': (), 06:54:33 INFO - 'pip_index': False, 06:54:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:33 INFO - 'cmd': ('bash', 06:54:33 INFO - '-c', 06:54:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:33 INFO - 'enabled': True, 06:54:33 INFO - 'halt_on_failure': False, 06:54:33 INFO - 'name': 'check_screen_resolution'},), 06:54:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:54:33 INFO - 'cmd': ('bash', 06:54:33 INFO - '-c', 06:54:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:54:33 INFO - 'enabled': True, 06:54:33 INFO - 'halt_on_failure': False, 06:54:33 INFO - 'name': 'check_screen_resolution'},), 06:54:33 INFO - 'run_cmd_checks_enabled': True, 06:54:33 INFO - 'suite': 'dromaeojs-e10s', 06:54:33 INFO - 'system_bits': '32', 06:54:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:54:33 INFO - 'title': 't-yosemite-r7-0163', 06:54:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:54:33 INFO - 'use_talos_json': True, 06:54:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:54:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:54:33 INFO - 'work_dir': 'build'} 06:54:33 INFO - [mozharness: 2017-05-26 13:54:33.823803Z] Running clobber step. 06:54:33 INFO - Running pre-action listener: _resource_record_pre_action 06:54:33 INFO - Running main action method: clobber 06:54:33 INFO - rmtree: /builds/slave/test/build 06:54:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:54:36 INFO - Running post-action listener: _resource_record_post_action 06:54:36 INFO - [mozharness: 2017-05-26 13:54:36.308596Z] Finished clobber step (success) 06:54:36 INFO - [mozharness: 2017-05-26 13:54:36.308721Z] Running read-buildbot-config step. 06:54:36 INFO - Running pre-action listener: _resource_record_pre_action 06:54:36 INFO - Running main action method: read_buildbot_config 06:54:36 INFO - Using buildbot properties: 06:54:36 INFO - { 06:54:36 INFO - "project": "", 06:54:36 INFO - "product": "firefox", 06:54:36 INFO - "script_repo_revision": "production", 06:54:36 INFO - "builddir": "mozilla-beta_yosemite_r7_devedition_test-dromaeojs-e10s", 06:54:36 INFO - "repository": "", 06:54:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 DevEdition mozilla-beta talos dromaeojs-e10s", 06:54:36 INFO - "buildid": "20170526051315", 06:54:36 INFO - "pgo_build": "False", 06:54:36 INFO - "basedir": "/builds/slave/test", 06:54:36 INFO - "buildnumber": 3, 06:54:36 INFO - "slavename": "t-yosemite-r7-0163", 06:54:36 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 06:54:36 INFO - "platform": "yosemite_r7_devedition", 06:54:36 INFO - "scheduler": "tests-mozilla-beta-macosx64-devedition-talos", 06:54:36 INFO - "branch": "mozilla-beta", 06:54:36 INFO - "repo_path": "releases/mozilla-beta", 06:54:36 INFO - "revision": "a6718df8269d161f0e2685b1266f7dcc981a751d", 06:54:36 INFO - "stage_platform": "macosx64-devedition", 06:54:36 INFO - "builduid": "ede73c92b670400980e8921df9921580", 06:54:36 INFO - "slavebuilddir": "test" 06:54:36 INFO - } 06:54:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 06:54:36 INFO - Running post-action listener: _resource_record_post_action 06:54:36 INFO - [mozharness: 2017-05-26 13:54:36.312149Z] Finished read-buildbot-config step (success) 06:54:36 INFO - [mozharness: 2017-05-26 13:54:36.312287Z] Running download-and-extract step. 06:54:36 INFO - Running pre-action listener: _resource_record_pre_action 06:54:36 INFO - Running main action method: download_and_extract 06:54:36 INFO - mkdir: /builds/slave/test/build/tests 06:54:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:54:36 INFO - trying https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 06:54:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 06:54:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 06:54:37 INFO - Downloaded 1287 bytes. 06:54:37 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 06:54:37 INFO - Using the following test package requirements: 06:54:37 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:37 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 06:54:37 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 06:54:37 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:37 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 06:54:37 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:37 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 06:54:37 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:54:37 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:37 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 06:54:37 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 06:54:37 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:37 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 06:54:37 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:37 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 06:54:37 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:37 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 06:54:37 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 06:54:37 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 06:54:37 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 06:54:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 06:54:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 06:54:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 06:54:39 INFO - Expected file size: 51963612 06:54:39 INFO - Obtained file size: 51963612 06:54:55 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:54:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 06:54:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 06:54:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 06:54:57 INFO - Expected file size: 51963612 06:54:57 INFO - Obtained file size: 51963612 06:55:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 06:55:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 06:55:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 06:55:13 INFO - Expected file size: 14404449 06:55:13 INFO - Obtained file size: 14404449 06:55:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:13 INFO - trying https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 06:55:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 06:55:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 06:55:16 INFO - Downloaded 74892601 bytes. 06:55:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 06:55:16 INFO - mkdir: /builds/slave/test/properties 06:55:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:55:16 INFO - Writing to file /builds/slave/test/properties/build_url 06:55:16 INFO - Contents: 06:55:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 06:55:17 INFO - Running post-action listener: _resource_record_post_action 06:55:17 INFO - Running post-action listener: set_extra_try_arguments 06:55:17 INFO - [mozharness: 2017-05-26 13:55:17.035261Z] Finished download-and-extract step (success) 06:55:17 INFO - [mozharness: 2017-05-26 13:55:17.035397Z] Running populate-webroot step. 06:55:17 INFO - Running pre-action listener: _resource_record_pre_action 06:55:17 INFO - Running main action method: populate_webroot 06:55:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:55:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:55:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:55:17 INFO - '--tppagecycles', 06:55:17 INFO - '7'], 06:55:17 INFO - 'tests': ['tsvgm']}}, 06:55:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:55:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:55:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:55:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:55:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:55:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:55:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:55:17 INFO - 'talos_options': ['--disable-e10s'], 06:55:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:55:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:55:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:55:17 INFO - 'talos_options': ['--disable-e10s'], 06:55:17 INFO - 'tests': ['damp', 'tps']}, 06:55:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:55:17 INFO - 'tests': ['damp', 'tps']}, 06:55:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:55:17 INFO - 'tests': ['dromaeo_dom']}, 06:55:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:55:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:55:17 INFO - 'tests': ['basic_compositor_video']}, 06:55:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:55:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:55:17 INFO - 'tests': ['a11yr', 06:55:17 INFO - 'ts_paint', 06:55:17 INFO - 'tpaint', 06:55:17 INFO - 'sessionrestore', 06:55:17 INFO - 'sessionrestore_no_auto_restore', 06:55:17 INFO - 'tabpaint']}, 06:55:17 INFO - 'other-e10s': {'tests': ['a11yr', 06:55:17 INFO - 'ts_paint', 06:55:17 INFO - 'tpaint', 06:55:17 INFO - 'sessionrestore', 06:55:17 INFO - 'sessionrestore_no_auto_restore', 06:55:17 INFO - 'tabpaint']}, 06:55:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:55:17 INFO - 'ts_paint', 06:55:17 INFO - 'tpaint', 06:55:17 INFO - 'sessionrestore', 06:55:17 INFO - 'sessionrestore_no_auto_restore', 06:55:17 INFO - 'tabpaint']}, 06:55:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:55:17 INFO - 'ts_paint', 06:55:17 INFO - 'tpaint', 06:55:17 INFO - 'sessionrestore', 06:55:17 INFO - 'sessionrestore_no_auto_restore', 06:55:17 INFO - 'tabpaint']}, 06:55:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:55:17 INFO - 'tests': ['a11yr', 06:55:17 INFO - 'ts_paint', 06:55:17 INFO - 'tpaint', 06:55:17 INFO - 'sessionrestore', 06:55:17 INFO - 'sessionrestore_no_auto_restore', 06:55:17 INFO - 'tabpaint']}, 06:55:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:55:17 INFO - 'tests': ['a11yr', 06:55:17 INFO - 'ts_paint', 06:55:17 INFO - 'tpaint', 06:55:17 INFO - 'sessionrestore', 06:55:17 INFO - 'sessionrestore_no_auto_restore', 06:55:17 INFO - 'tabpaint']}, 06:55:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:55:17 INFO - 'tests': ['tsvgx', 06:55:17 INFO - 'tsvgr_opacity', 06:55:17 INFO - 'tart', 06:55:17 INFO - 'tscrollx', 06:55:17 INFO - 'cart', 06:55:17 INFO - 'tsvg_static']}, 06:55:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:55:17 INFO - 'tsvgr_opacity', 06:55:17 INFO - 'tart', 06:55:17 INFO - 'tscrollx', 06:55:17 INFO - 'cart', 06:55:17 INFO - 'tsvg_static']}, 06:55:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:55:17 INFO - 'talos_options': ['--disable-e10s'], 06:55:17 INFO - 'tests': ['tp5o']}, 06:55:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:55:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:55:17 INFO - 'talos_options': ['--disable-e10s', 06:55:17 INFO - '--xperf_path', 06:55:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:17 INFO - 'tests': ['tp5n']}, 06:55:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:55:17 INFO - 'talos_options': ['--xperf_path', 06:55:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:55:17 INFO - 'tests': ['tp5n']}}, 06:55:17 INFO - 'talos.zip': {'path': '', 06:55:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:55:17 INFO - Running post-action listener: _resource_record_post_action 06:55:17 INFO - [mozharness: 2017-05-26 13:55:17.053974Z] Finished populate-webroot step (success) 06:55:17 INFO - [mozharness: 2017-05-26 13:55:17.054066Z] Running create-virtualenv step. 06:55:17 INFO - Running pre-action listener: _resource_record_pre_action 06:55:17 INFO - Running main action method: create_virtualenv 06:55:17 INFO - Creating virtualenv /builds/slave/test/build/venv 06:55:17 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:55:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:55:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:55:17 INFO - Using real prefix '/tools/python27' 06:55:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:55:17 INFO - Installing distribute.............................................................................................................................................................................................done. 06:55:20 INFO - Installing pip.................done. 06:55:20 INFO - Return code: 0 06:55:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:55:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:55:21 INFO - Reading from file tmpfile_stdout 06:55:21 INFO - Output received: 06:55:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:55:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:21 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/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 0x1104ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6934805c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ddd30>, '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 0x110204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102d2be8>, '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.UhYQsh3vSj/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.lE6QEkUspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:55:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UhYQsh3vSj/Render', 06:55:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:21 INFO - 'HOME': '/Users/cltbld', 06:55:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:21 INFO - 'LOGNAME': 'cltbld', 06:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:21 INFO - 'MOZ_NO_REMOTE': '1', 06:55:21 INFO - 'NO_EM_RESTART': '1', 06:55:21 INFO - 'PAGER': '/bin/cat', 06:55:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:21 INFO - 'PWD': '/builds/slave/test', 06:55:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:21 INFO - 'SHELL': '/bin/bash', 06:55:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lE6QEkUspG/Listeners', 06:55:21 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:55:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:21 INFO - 'USER': 'cltbld', 06:55:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:21 INFO - 'XPC_FLAGS': '0x0', 06:55:21 INFO - 'XPC_SERVICE_NAME': '0', 06:55:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:21 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:55:21 INFO - Cleaning up... 06:55:21 INFO - Return code: 0 06:55:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:21 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/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 0x1104ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6934805c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ddd30>, '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 0x110204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102d2be8>, '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.UhYQsh3vSj/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.lE6QEkUspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:55:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UhYQsh3vSj/Render', 06:55:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:21 INFO - 'HOME': '/Users/cltbld', 06:55:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:21 INFO - 'LOGNAME': 'cltbld', 06:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:21 INFO - 'MOZ_NO_REMOTE': '1', 06:55:21 INFO - 'NO_EM_RESTART': '1', 06:55:21 INFO - 'PAGER': '/bin/cat', 06:55:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:21 INFO - 'PWD': '/builds/slave/test', 06:55:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:21 INFO - 'SHELL': '/bin/bash', 06:55:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lE6QEkUspG/Listeners', 06:55:21 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:55:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:21 INFO - 'USER': 'cltbld', 06:55:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:21 INFO - 'XPC_FLAGS': '0x0', 06:55:21 INFO - 'XPC_SERVICE_NAME': '0', 06:55:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:21 INFO - Downloading/unpacking psutil>=3.1.1 06:55:21 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:55:21 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:55:21 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:55:21 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:55:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:55:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:23 INFO - Installing collected packages: psutil 06:55:23 INFO - Running setup.py install for psutil 06:55:23 INFO - building 'psutil._psutil_osx' extension 06:55:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:55:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:55:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:55:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:55:24 INFO - building 'psutil._psutil_posix' extension 06:55:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:55:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:55:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:55:24 INFO - ^ 06:55:24 INFO - 1 warning generated. 06:55:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:55:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:55:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:55:24 INFO - Successfully installed psutil 06:55:24 INFO - Cleaning up... 06:55:24 INFO - Return code: 0 06:55:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1104ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6934805c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ddd30>, '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 0x110204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102d2be8>, '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.UhYQsh3vSj/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.lE6QEkUspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:55:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:55:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:55:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UhYQsh3vSj/Render', 06:55:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:24 INFO - 'HOME': '/Users/cltbld', 06:55:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:24 INFO - 'LOGNAME': 'cltbld', 06:55:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:24 INFO - 'MOZ_NO_REMOTE': '1', 06:55:24 INFO - 'NO_EM_RESTART': '1', 06:55:24 INFO - 'PAGER': '/bin/cat', 06:55:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:24 INFO - 'PWD': '/builds/slave/test', 06:55:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:24 INFO - 'SHELL': '/bin/bash', 06:55:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lE6QEkUspG/Listeners', 06:55:24 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:55:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:24 INFO - 'USER': 'cltbld', 06:55:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:24 INFO - 'XPC_FLAGS': '0x0', 06:55:24 INFO - 'XPC_SERVICE_NAME': '0', 06:55:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:55:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:55:26 INFO - Installing collected packages: mozsystemmonitor 06:55:26 INFO - Running setup.py install for mozsystemmonitor 06:55:26 INFO - Successfully installed mozsystemmonitor 06:55:26 INFO - Cleaning up... 06:55:26 INFO - Return code: 0 06:55:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:26 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/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 0x1104ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6934805c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ddd30>, '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 0x110204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102d2be8>, '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.UhYQsh3vSj/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.lE6QEkUspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:55:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:55:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:55:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UhYQsh3vSj/Render', 06:55:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:26 INFO - 'HOME': '/Users/cltbld', 06:55:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:26 INFO - 'LOGNAME': 'cltbld', 06:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:26 INFO - 'MOZ_NO_REMOTE': '1', 06:55:26 INFO - 'NO_EM_RESTART': '1', 06:55:26 INFO - 'PAGER': '/bin/cat', 06:55:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:26 INFO - 'PWD': '/builds/slave/test', 06:55:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:26 INFO - 'SHELL': '/bin/bash', 06:55:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lE6QEkUspG/Listeners', 06:55:26 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:55:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:26 INFO - 'USER': 'cltbld', 06:55:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:26 INFO - 'XPC_FLAGS': '0x0', 06:55:26 INFO - 'XPC_SERVICE_NAME': '0', 06:55:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:26 INFO - Downloading/unpacking jsonschema==2.5.1 06:55:26 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:55:26 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:55:26 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:55:26 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:55:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:55:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:55:28 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:55:28 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:55:28 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:55:28 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:55:28 INFO - Downloading functools32-3.2.3-2.tar.gz 06:55:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:55:28 INFO - warning: no files found matching '*.txt' 06:55:28 INFO - no previously-included directories found matching 'build' 06:55:28 INFO - no previously-included directories found matching 'dist' 06:55:28 INFO - no previously-included directories found matching '.git*' 06:55:28 INFO - Installing collected packages: jsonschema, functools32 06:55:28 INFO - Running setup.py install for functools32 06:55:28 INFO - warning: no files found matching '*.txt' 06:55:28 INFO - no previously-included directories found matching 'build' 06:55:28 INFO - no previously-included directories found matching 'dist' 06:55:28 INFO - no previously-included directories found matching '.git*' 06:55:28 INFO - Successfully installed jsonschema functools32 06:55:28 INFO - Cleaning up... 06:55:28 INFO - Return code: 0 06:55:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:55:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:29 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/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 0x1104ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6934805c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ddd30>, '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 0x110204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102d2be8>, '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.UhYQsh3vSj/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.lE6QEkUspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:55:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:55:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:55:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UhYQsh3vSj/Render', 06:55:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:29 INFO - 'HOME': '/Users/cltbld', 06:55:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:29 INFO - 'LOGNAME': 'cltbld', 06:55:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:29 INFO - 'MOZ_NO_REMOTE': '1', 06:55:29 INFO - 'NO_EM_RESTART': '1', 06:55:29 INFO - 'PAGER': '/bin/cat', 06:55:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:29 INFO - 'PWD': '/builds/slave/test', 06:55:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:29 INFO - 'SHELL': '/bin/bash', 06:55:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lE6QEkUspG/Listeners', 06:55:29 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:55:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:29 INFO - 'USER': 'cltbld', 06:55:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:29 INFO - 'XPC_FLAGS': '0x0', 06:55:29 INFO - 'XPC_SERVICE_NAME': '0', 06:55:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:55:29 INFO - Cleaning up... 06:55:29 INFO - Return code: 0 06:55:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:30 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/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 0x1104ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6934805c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ddd30>, '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 0x110204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102d2be8>, '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.UhYQsh3vSj/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.lE6QEkUspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:55:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:55:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:55:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UhYQsh3vSj/Render', 06:55:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:30 INFO - 'HOME': '/Users/cltbld', 06:55:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:30 INFO - 'LOGNAME': 'cltbld', 06:55:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:30 INFO - 'MOZ_NO_REMOTE': '1', 06:55:30 INFO - 'NO_EM_RESTART': '1', 06:55:30 INFO - 'PAGER': '/bin/cat', 06:55:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:30 INFO - 'PWD': '/builds/slave/test', 06:55:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:30 INFO - 'SHELL': '/bin/bash', 06:55:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lE6QEkUspG/Listeners', 06:55:30 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:55:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:30 INFO - 'USER': 'cltbld', 06:55:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:30 INFO - 'XPC_FLAGS': '0x0', 06:55:30 INFO - 'XPC_SERVICE_NAME': '0', 06:55:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:30 INFO - Downloading/unpacking blobuploader==1.2.4 06:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:55:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:55:32 INFO - Downloading blobuploader-1.2.4.tar.gz 06:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:55:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:55: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:55: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:55: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:55: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:55:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:55:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:55: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:55: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:55: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:55: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:55:33 INFO - Downloading docopt-0.6.1.tar.gz 06:55:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:55:33 INFO - Installing collected packages: blobuploader, requests, docopt 06:55:33 INFO - Running setup.py install for blobuploader 06:55:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:55:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:55:33 INFO - Running setup.py install for requests 06:55:33 INFO - Running setup.py install for docopt 06:55:33 INFO - Successfully installed blobuploader requests docopt 06:55:33 INFO - Cleaning up... 06:55:34 INFO - Return code: 0 06:55:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:34 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/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 0x1104ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6934805c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ddd30>, '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 0x110204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102d2be8>, '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.UhYQsh3vSj/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.lE6QEkUspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:55:34 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:55:34 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:55:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UhYQsh3vSj/Render', 06:55:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:34 INFO - 'HOME': '/Users/cltbld', 06:55:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:34 INFO - 'LOGNAME': 'cltbld', 06:55:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:34 INFO - 'MOZ_NO_REMOTE': '1', 06:55:34 INFO - 'NO_EM_RESTART': '1', 06:55:34 INFO - 'PAGER': '/bin/cat', 06:55:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:34 INFO - 'PWD': '/builds/slave/test', 06:55:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:34 INFO - 'SHELL': '/bin/bash', 06:55:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lE6QEkUspG/Listeners', 06:55:34 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:55:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:34 INFO - 'USER': 'cltbld', 06:55:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:34 INFO - 'XPC_FLAGS': '0x0', 06:55:34 INFO - 'XPC_SERVICE_NAME': '0', 06:55:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-qdM_Hh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-69zyx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-w1sV5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-SgTvnP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Fc0BSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-_rZ5Ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:34 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-bnIDsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-518l1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-R7gfWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-VRwtE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Qp8sIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-d00LOa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-a9RaA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-EPM8Qd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-pc8rXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-YzzHSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:35 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-UJPZIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:55:36 INFO - Running setup.py install for manifestparser 06:55:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:55:36 INFO - Running setup.py install for mozcrash 06:55:36 INFO - Running setup.py install for mozdebug 06:55:36 INFO - Running setup.py install for mozdevice 06:55:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:55:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:55:36 INFO - Running setup.py install for mozfile 06:55:36 INFO - Running setup.py install for mozhttpd 06:55:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:55:36 INFO - Running setup.py install for mozinfo 06:55:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:55:37 INFO - Running setup.py install for mozInstall 06:55:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:55:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:55:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:55:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:55:37 INFO - Running setup.py install for mozleak 06:55:37 INFO - Running setup.py install for mozlog 06:55:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:55:37 INFO - Running setup.py install for moznetwork 06:55:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:55:37 INFO - Running setup.py install for mozprocess 06:55:37 INFO - Running setup.py install for mozprofile 06:55:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:55:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:55:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:55:38 INFO - Running setup.py install for mozrunner 06:55:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:55:38 INFO - Running setup.py install for mozscreenshot 06:55:38 INFO - Running setup.py install for moztest 06:55:38 INFO - Running setup.py install for mozversion 06:55:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:55:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:55:38 INFO - Cleaning up... 06:55:38 INFO - Return code: 0 06:55:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:38 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/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 0x1104ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6934805c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ddd30>, '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 0x110204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102d2be8>, '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.UhYQsh3vSj/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.lE6QEkUspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:55:38 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:55:38 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:55:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UhYQsh3vSj/Render', 06:55:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:38 INFO - 'HOME': '/Users/cltbld', 06:55:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:38 INFO - 'LOGNAME': 'cltbld', 06:55:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:38 INFO - 'MOZ_NO_REMOTE': '1', 06:55:38 INFO - 'NO_EM_RESTART': '1', 06:55:38 INFO - 'PAGER': '/bin/cat', 06:55:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:38 INFO - 'PWD': '/builds/slave/test', 06:55:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:38 INFO - 'SHELL': '/bin/bash', 06:55:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lE6QEkUspG/Listeners', 06:55:38 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:55:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:38 INFO - 'USER': 'cltbld', 06:55:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:38 INFO - 'XPC_FLAGS': '0x0', 06:55:38 INFO - 'XPC_SERVICE_NAME': '0', 06:55:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:38 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-cR1m_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-iELipi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Gv_GB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-_zratm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-DvCtb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-cRU01r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-gdhBGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-obxSON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-G50X01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-StMth6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:39 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:55:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-tU1qya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:40 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:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-pcg_xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-btd2P5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:40 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:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-jWxpf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ygnEI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:40 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:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-1VRFTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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:55:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-xXc3qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:40 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:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:55:40 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:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:55:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:55:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:55: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:55: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:55: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:55: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:55:42 INFO - Downloading blessings-1.6.tar.gz 06:55:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:55:42 INFO - Installing collected packages: blessings 06:55:42 INFO - Running setup.py install for blessings 06:55:42 INFO - Successfully installed blessings 06:55:42 INFO - Cleaning up... 06:55:42 INFO - Return code: 0 06:55:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:55:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:42 INFO - Reading from file tmpfile_stdout 06:55:42 INFO - Current package versions: 06:55:42 INFO - blessings == 1.6 06:55:42 INFO - blobuploader == 1.2.4 06:55:42 INFO - docopt == 0.6.1 06:55:42 INFO - functools32 == 3.2.3-2 06:55:42 INFO - jsonschema == 2.5.1 06:55:42 INFO - manifestparser == 1.1 06:55:42 INFO - mozInstall == 1.12 06:55:42 INFO - mozcrash == 1.0 06:55:42 INFO - mozdebug == 0.1 06:55:42 INFO - mozdevice == 0.49 06:55:42 INFO - mozfile == 1.2 06:55:42 INFO - mozhttpd == 0.7 06:55:42 INFO - mozinfo == 0.9 06:55:42 INFO - mozleak == 0.1 06:55:42 INFO - mozlog == 3.4 06:55:42 INFO - moznetwork == 0.27 06:55:42 INFO - mozprocess == 0.25 06:55:42 INFO - mozprofile == 0.28 06:55:42 INFO - mozrunner == 6.13 06:55:42 INFO - mozscreenshot == 0.1 06:55:42 INFO - mozsystemmonitor == 0.3 06:55:42 INFO - moztest == 0.8 06:55:42 INFO - mozversion == 1.4 06:55:42 INFO - psutil == 3.1.1 06:55:42 INFO - requests == 1.2.3 06:55:42 INFO - wsgiref == 0.1.2 06:55:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:42 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/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 0x1104ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6934805c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ddd30>, '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 0x110204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102d2be8>, '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.UhYQsh3vSj/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.lE6QEkUspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:55:42 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:55:42 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:55:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UhYQsh3vSj/Render', 06:55:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:42 INFO - 'HOME': '/Users/cltbld', 06:55:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:42 INFO - 'LOGNAME': 'cltbld', 06:55:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:42 INFO - 'MOZ_NO_REMOTE': '1', 06:55:42 INFO - 'NO_EM_RESTART': '1', 06:55:42 INFO - 'PAGER': '/bin/cat', 06:55:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:42 INFO - 'PWD': '/builds/slave/test', 06:55:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:42 INFO - 'SHELL': '/bin/bash', 06:55:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lE6QEkUspG/Listeners', 06:55:42 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:55:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:42 INFO - 'USER': 'cltbld', 06:55:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:42 INFO - 'XPC_FLAGS': '0x0', 06:55:42 INFO - 'XPC_SERVICE_NAME': '0', 06:55:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:43 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:55:43 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:55:43 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:55:43 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:55:43 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:55:43 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:55:43 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:55:43 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:55:43 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:55:43 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:55:43 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:55:43 INFO - Cleaning up... 06:55:43 INFO - Return code: 0 06:55:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:43 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/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 0x1104ffb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110502768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe6934805c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102ddd30>, '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 0x110204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102d2be8>, '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.UhYQsh3vSj/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.lE6QEkUspG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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:55:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:55:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UhYQsh3vSj/Render', 06:55:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:43 INFO - 'HOME': '/Users/cltbld', 06:55:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:43 INFO - 'LOGNAME': 'cltbld', 06:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:43 INFO - 'MOZ_NO_REMOTE': '1', 06:55:43 INFO - 'NO_EM_RESTART': '1', 06:55:43 INFO - 'PAGER': '/bin/cat', 06:55:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:43 INFO - 'PWD': '/builds/slave/test', 06:55:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:43 INFO - 'SHELL': '/bin/bash', 06:55:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lE6QEkUspG/Listeners', 06:55:43 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:55:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:43 INFO - 'USER': 'cltbld', 06:55:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:43 INFO - 'XPC_FLAGS': '0x0', 06:55:43 INFO - 'XPC_SERVICE_NAME': '0', 06:55:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:55:43 INFO - Cleaning up... 06:55:43 INFO - Return code: 0 06:55:43 INFO - Running post-action listener: _resource_record_post_action 06:55:43 INFO - Running post-action listener: _start_resource_monitoring 06:55:43 INFO - Starting resource monitoring. 06:55:43 INFO - [mozharness: 2017-05-26 13:55:43.321188Z] Finished create-virtualenv step (success) 06:55:43 INFO - [mozharness: 2017-05-26 13:55:43.322116Z] Running install step. 06:55:43 INFO - Running pre-action listener: _resource_record_pre_action 06:55:43 INFO - Running main action method: install 06:55:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:43 INFO - Reading from file tmpfile_stdout 06:55:43 INFO - Detecting whether we're running mozinstall >=1.0... 06:55:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:55:43 INFO - Reading from file tmpfile_stdout 06:55:43 INFO - Output received: 06:55:43 INFO - Usage: mozinstall [options] installer 06:55:43 INFO - Options: 06:55:43 INFO - -h, --help show this help message and exit 06:55:43 INFO - -d DEST, --destination=DEST 06:55:43 INFO - Directory to install application into. [default: 06:55:43 INFO - "/builds/slave/test"] 06:55:43 INFO - --app=APP Application being installed. [default: firefox] 06:55:43 INFO - mkdir: /builds/slave/test/build/application 06:55:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:55:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:56:03 INFO - Reading from file tmpfile_stdout 06:56:03 INFO - Output received: 06:56:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 06:56:03 INFO - Running post-action listener: _resource_record_post_action 06:56:03 INFO - [mozharness: 2017-05-26 13:56:03.684488Z] Finished install step (success) 06:56:03 INFO - [mozharness: 2017-05-26 13:56:03.684644Z] Running run-tests step. 06:56:03 INFO - Running pre-action listener: _resource_record_pre_action 06:56:03 INFO - Running main action method: run_tests 06:56:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:56:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:56:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:56:03 INFO - 2017-05-26 06:56:03.699 screenresolution[1623:7360] starting screenresolution argv=screenresolution get 06:56:03 INFO - 2017-05-26 06:56:03.702 screenresolution[1623:7360] Display 0: 1600x1200x32@60 06:56:03 INFO - 2017-05-26 06:56:03.707 screenresolution[1624:7363] starting screenresolution argv=screenresolution list 06:56:03 INFO - Available Modes on Display 0 06:56:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:56:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:56:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:56:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:56:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:56:03 INFO - Intel Iris: 06:56:03 INFO - Chipset Model: Intel Iris 06:56:03 INFO - Type: GPU 06:56:03 INFO - Bus: Built-In 06:56:03 INFO - VRAM (Dynamic, Max): 1536 MB 06:56:03 INFO - Vendor: Intel (0x8086) 06:56:03 INFO - Device ID: 0x0a2e 06:56:03 INFO - Revision ID: 0x0009 06:56:03 INFO - Displays: 06:56:03 INFO - Display: 06:56:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:56:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:56:03 INFO - Display Serial Number: 1600x1200 60 06:56:03 INFO - Main Display: Yes 06:56:03 INFO - Mirror: Off 06:56:03 INFO - Online: Yes 06:56:03 INFO - Rotation: Supported 06:56:03 INFO - Return code: 0 06:56:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:56:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:56:03 INFO - Python 2.7.3 06:56:03 INFO - Return code: 0 06:56:03 INFO - grabbing minidump binary from tooltool 06:56:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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:56:03 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 0x1102ddd30>, '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 0x110204db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102d2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:56:03 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 06:56:03 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 06:56:03 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 06:56:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:56:04 INFO - Return code: 0 06:56:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:56:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:56:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:56:04 INFO - ENV: RUST_BACKTRACE is now 1 06:56:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:56:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 06:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --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 06:56:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UhYQsh3vSj/Render', 06:56:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:56:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:56:04 INFO - 'HOME': '/Users/cltbld', 06:56:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:56:04 INFO - 'LOGNAME': 'cltbld', 06:56:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:56:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:56:04 INFO - 'MOZ_NO_REMOTE': '1', 06:56:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:56:04 INFO - 'NO_EM_RESTART': '1', 06:56:04 INFO - 'PAGER': '/bin/cat', 06:56:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:56:04 INFO - 'PWD': '/builds/slave/test', 06:56:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:56:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:56:04 INFO - 'RUST_BACKTRACE': '1', 06:56:04 INFO - 'SHELL': '/bin/bash', 06:56:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lE6QEkUspG/Listeners', 06:56:04 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 06:56:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:56:04 INFO - 'USER': 'cltbld', 06:56:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:56:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:56:04 INFO - 'XPC_FLAGS': '0x0', 06:56:04 INFO - 'XPC_SERVICE_NAME': '0', 06:56:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:56:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 06:56:04 INFO - mozversion application_buildid: 20170526051315 06:56:04 INFO - mozversion application_changeset: a6718df8269d161f0e2685b1266f7dcc981a751d 06:56:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 06:56:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:56:04 INFO - mozversion application_name: Firefox 06:56:04 INFO - mozversion application_remotingname: firefox-dev 06:56:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:56:04 INFO - mozversion application_vendor: Mozilla 06:56:04 INFO - mozversion application_version: 54.0 06:56:04 INFO - mozversion platform_buildid: 20170526051315 06:56:04 INFO - mozversion platform_changeset: a6718df8269d161f0e2685b1266f7dcc981a751d 06:56:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:56:04 INFO - mozversion platform_version: 54.0 06:56:04 INFO - using testdate: 1495806964 06:56:04 INFO - actual date: 1495806964 06:56:04 INFO - starting webserver on 'localhost:49225' 06:56:04 INFO - SUITE-START | Running 2 tests 06:56:04 INFO - TEST-START | dromaeo_css 06:56:04 INFO - operating with platform_type : mac_ 06:56:04 INFO - Initialising browser for dromaeo_css test... 06:56:04 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpEKCWH_/profile http://localhost:49225/getInfo.html) 06:56:07 INFO - PROCESS | 1634 | 2017-05-26 06:56:07.137 plugin-container[1637:7541] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c3f, name = 'com.apple.tsm.portname' 06:56:07 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:56:07 INFO - PROCESS | 1634 | 2017-05-26 06:56:07.138 plugin-container[1637:7541] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x920f, name = 'com.apple.CFPasteboardClient' 06:56:07 INFO - PROCESS | 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:56:07 INFO - PROCESS | 1634 | 2017-05-26 06:56:07.138 plugin-container[1637:7541] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:56:07 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 06:56:07 INFO - PROCESS | 1634 | colorDepth:24 06:56:07 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 06:56:07 INFO - PROCESS | 1634 | __metrics 06:56:07 ERROR - PROCESS | 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 06:56:07 INFO - TEST-INFO | 1634: exit 0 06:56:07 INFO - Browser initialized. 06:56:07 INFO - Running cycle 1/1 for dromaeo_css test... 06:56:07 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpEKCWH_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:10 INFO - PROCESS | 1638 | 2017-05-26 06:56:10.453 plugin-container[1639:7673] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 06:56:10 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:56:10 INFO - PROCESS | 1638 | 2017-05-26 06:56:10.454 plugin-container[1639:7673] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 06:56:10 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 06:56:10 INFO - PROCESS | 1638 | 2017-05-26 06:56:10.454 plugin-container[1639:7673] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 06:56:20 INFO - PROCESS | 1638 | RSS: Main: 202993664 06:56:20 INFO - PROCESS | 1638 | 06:59:22 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49225/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49225/tests/dromaeo/cssquery-ext.html) 06:59:24 INFO - PROCESS | 1638 | RSS: Main: 216571904 06:59:24 INFO - PROCESS | 1638 | 07:02:26 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49225/tests/dromaeo/cssquery-ext.html (next: http://localhost:49225/tests/dromaeo/cssquery-jquery.html) 07:02:27 INFO - PROCESS | 1638 | RSS: Main: 229707776 07:02:27 INFO - PROCESS | 1638 | 07:05:29 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49225/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49225/tests/dromaeo/cssquery-mootools.html) 07:05:29 INFO - PROCESS | 1638 | RSS: Main: 231497728 07:05:29 INFO - PROCESS | 1638 | 07:08:31 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49225/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49225/tests/dromaeo/cssquery-prototype.html) 07:08:32 INFO - PROCESS | 1638 | RSS: Main: 234172416 07:08:32 INFO - PROCESS | 1638 | 07:11:35 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49225/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49225/tests/dromaeo/cssquery-yui.html) 07:11:35 INFO - PROCESS | 1638 | RSS: Main: 236208128 07:11:35 INFO - PROCESS | 1638 | 07:14:38 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49225/tests/dromaeo/cssquery-yui.html (next: http://localhost:49225/tests/dromaeo/cssquery-dojo.html) 07:14:38 INFO - PROCESS | 1638 | RSS: Main: 234328064 07:14:38 INFO - PROCESS | 1638 | 07:14:38 INFO - PROCESS | 1638 | __start_tp_report 07:14:38 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 07:14:38 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 07:14:38 INFO - PROCESS | 1638 | |i|pagename|runs| 07:14:38 INFO - PROCESS | 1638 | |0;dojo.html;2979.9702002979975;3392.304577561599;3411.8805841795534;3412.965870341296;3425.5204271401994;5825.766969321227;5829.795957141501;5852.590318677694;5932.673702946347;5944.286685597724;5903.911441328383;5956.79151229706;5962.821115366535;6010.669413182284;6025.819225423234;5270.789168433268;5351.598630102739;5354.629398552533;5393.83818485446;5432.402435732066;4473.66447516436;5423.159410291391;5437.939601777655;5443.047466693332;5464.508194262516;5194.740262986855;5218.269442278084;5313.468653134694;5423.430539793324;5428.158635411518;5327.653702509325;5372.489613486693;5451.209574611698;5480;5484.341878974508;5243.397009343936;5330.466953304677;5347.919781203285;5373.220882971987;5399.676019438846;5876.676782776945;5883.352831188566;5953.047512397996;5980.491658209057;6030.035194368924;5045.823396181153;5207.270982062514;6119.076065312615;6286.87426251477;6288.748450061992;6263.404976527223;6291.245050593912;6337.746490140389;6338.176037115146;6338.366163383671;6011;6042.9395706042815;6049.758009679607;6052.12244224585;6068.33248342682;5526.336839579276;6225.501959843202;6347.650879201596;6378.521610879203;6421.165248517663;6146.862830376305;6166.907496387557;6193.597416167935;6234.1583886175695;6253.6873156342;6321.683915804191;6328.303886572473;6335.746570137235;6339.049142628551;6343.1436756038265;6263.342349053375;6285.654289014056;6313.210848643919;6331.113644089831;6349.7142628580905;6141.025769127022;6208.099825525273;6224.813255602339;6249.156363890907;6322.36776322364;4699.553542413465;4852.223644216909;4856.2958371036;4876.317315575822;4901.656884018156;4372.300431930876;4379.4525684289465;4387.166438376698;4387.254166791653;4413.40419043425;5481.561475082063;5628.774849006076;5640.407757185437;5783.624064435799;5789.88420231593;6207.81376558704;6228.813135605939;6228.906566401508;6293.748250070037;6294.2446906370615;5562.749676264578;5602.38373778884;5745.368009518949;5787.942120578825;5791.189233507313;5415.756290966916;5474.562035037267;5499.890002199933;5555.555555555546;5561.582881283839;6240.188775459162;6282.528810339243;6380.266269378988;6410.679466026773;6428.839279018062;5885.9405307045145;6223.253209614875;6262.3111457738705;6315.715792789244;6331.588446750947;5638.464345887134;6392.137061496825;6430.549861509649;6433.678316084083;6434.034894765822;6325;6329.7468101275435;6365.904511432424;6378.45783108441;6380.553361264667;6129.267100814712;6170.7223174958135;6226.12834203221;6240.28236752761;6326;6278.46633036197;6297.685115744286;6306.211723534559;6311.053341998737;6336.493080553452;6204;6233.158523599437;6262.968685156545;6282.780102696383;6325.399087086719;5772.624779389326;5959.195508606283;5968.552358573038;6060.757569697339;6207.81376558704;6201.2868520118955;6260.499160067093;6294.590851594632;6304.936950630435;6307.526935479766;6127.908081378694;6149.692515374303;6156.846078848064;6157;6167.814965551041 07:14:38 INFO - PROCESS | 1638 | |1;ext.html;812.6708682983392;891.402760150699;911.2163539356148;915.5102020419073;918.9035151309113;38736.80631596842;39458.60541394585;42079.789601051954;42137.7893110534;42147.57852421479;40051.19897602046;40383.19233615326;40410.19179616406;40453.393199102036;40462;9074.319426043057;9374.484403357812;9518.619255229818;9520.095590918852;9528.571214295373;9216.354855160142;9257.16685498305;9324.766880827965;9328.207102396305;9328.860067098998;9350.766230844216;9352.298577606673;9362.110599493037;9370.578323975438;9372.484513351763;9263.536823158849;9312.534373281344;9314.301427392906;9315.860262096074;9344.579493922722;9099;9154.725358239197;9161.9921808601;9169.816603667956;9178.586963586655;35874;35937.82031089828;36018.27963440717;36036.81981590075;36169.63830361689;3858.7298889077774;3877.6428250112517;3906.4726261954556;3961.425593288986;3986.362182050858;25905.352366190808;27171.320716982034;27199.728002720116;27199.864000680067;27248.59127113095;3016.366563021746;3079.6612372638992;3101.1316831287277;3283.7208837248863;3300.5214243934734;383736;384910;385954;386147.06926465186;386784;45250;45269;45506.08987820225;45747.54252457433;45765.77117114393;37418.87743367704;45877.770611147396;46461.76769116133;46467.070658586636;46522.76738616353;11749.588764393206;11753.059755219561;14029.298535073205;14138.575842724735;14198.14811111316;12019.879801201876;12091.274523528617;12178.147529672839;12184.025277977918;12190.878091219152;10824.404657743742;12107.03143748498;12249.203801753036;12298.815517767242;12440.875591244152;4718.905621887543;5018.0214858103045;5200.959808038332;5569;5608.214849921014;1036.4972988100765;1118.032901540162;1174.8883856033663;1176.9882301176879;1213.8422005139275;23021.539569208522;27493;28011.159665210078;28035.598220088916;28264.010759623314;1079.2067830144838;1104.0450010740813;1261.8359613250218;1267.8985681145487;1326.907116501855;13539.864601354057;14153;14294.785578216335;14360.922930780232;14516.709665806624;442039;493744;493906;495742;496049;59961;60331.79336413247;60476;60512.78974420487;60539;1413.2721648351107;1451.3831621560794;1463.7877507761527;1498.8725958293667;1500.0549653718087;21604.783952160276;27622.309442264104;27905.58141627918;28029.299267518476;28457.28856778597;40990.38514422346;41053.973650657776;41225.175496490505;41259.38110928278;41378.793106034274;425782;427033;427755;428180;428749;29895;30139;30244;30292.939747108747;30327;45145.54854451545;46990.76504617455;47625.333113340865;47870;50760.49239507558;33939.66060339365;33957.66042339644;34201.82899085488;34217.65782342145;35047.47428788519;33976.66023339834;34455;34670;35180.648193517736;35290.82354588313;41312.586874132074;41436.1712765749;42979.570204298805;43175;43182.784086079366;33123;33944.98165055052;34561.30877382489;36513.63486365102;36636.63363366439;23671.526569468857;25827;26042.86978565095;27341.86329068342;27367.863160684068 07:14:38 INFO - PROCESS | 1638 | |2;jquery.html;399.15976868691405;402.1133400851124;411.3747104401309;424.8470550601783;441.9138268037732;20180.091895864683;20884;22207.22274720381;22368;22401.887990560044;22157;22236.8888155559;22547.54904901905;22565.887170564165;22611.208607698733;6736.29268926763;7084.681189346492;7094;7126;7126.679299431538;6512.316206798289;7195.89206161908;7506.399488040944;7563.659635316424;7665;7326.9267307327045;7564.773056808304;7590.127135379446;7606.809829754273;7634.198409167041;7467.775966721007;7568.583727894964;7599.886001709979;7682.7311044113185;7718.073831140243;6645.102911107036;7248.818779530501;7471;7473.476856620039;7476.065491813523;24985.87507062453;25792.355191120183;25994.87002564994;26309.21072367832;26400.86799566009;2826.2086615747626;2860.427914417104;2973.658029326612;2976.821390716564;2988.5666578346236;15146.772798408032;16067.116308603023;16130.95148815335;16298.42955496552;16592.751108733377;2102.4218339956483;2125.362391282609;2131.573685262938;2142.1645558232303;2169.0781417897488;146829.26585367005;151851.20371990677;171750.14124929297;172082;173335;20402.89798550998;20466.38600841977;20728.792712072987;20751.273705420237;20924.790752092587;30834.92077777267;31320.060398188092;31332.686673133434;31343.68656313453;31445.742170312933;10059.346142500714;10090.243231757648;10229.897701023043;10285.43430111336;10432;8500.787480313042;8510.063892971768;8523.57382130891;8567.914320856837;8661.523616201044;7573;9383.343165978453;9501.667441639509;9528.285378596494;9534.332596718303;3390.881319153867;4002.4396584478195;4050.691106069571;4086.4891888513935;4120.198265179647;855.234565064264;885.6059053721161;924.2744445610164;946.0114180681205;957.3298690916387;20872.895635521727;21398.251061212784;21414.357569272946;21457.570848582942;21556.784432155793;938.3290946972947;956.9377990430634;964.6189755046857;972.9589339406767;980.9558569864373;10583.417912014758;10982.011618954173;10990.120790336914;11107.722306942229;11108.444577771079;646362;716405;741654;748890;768300;128633;131953.34023329822;157873;165313.17343413207;172692;1097.9780404391868;1208.6313674329238;1225.4695736098324;1230.8584512780965;1250.956216532417;19644.214231430582;19914.800851991873;20069.498262543555;20317.288894888607;20396.79603203949;49727.75136124296;61359;62113.37886621076;62239;62414;58525.70737146287;76060.23939760531;81101;88578.22843543222;91047;11018.724531886766;11443.599474018702;11532.827007594726;11601.18791684574;11617.128715346551;10577.153827693612;11389.54441822351;12232.143749937419;12475.688107797378;12681.93659031699;10965.890341096487;10979.39613321275;11352.318860868374;11385.259958102697;11424.600138995096;10240.539175737258;10279.743006424898;10312.845307320245;10391.37651740898;10465.319754215952;11148.996590306911;11198.21612487118;11577.768444631229;11679.474423651127;11782.823257651313;9437;11402.372869492257;11462.598809041643;11464.770704586028;11563.132765042823;8759.693410730593;10213.182945364204;10219.948900255451;10417.687469375931;10629.20280978945 07:14:38 INFO - PROCESS | 1638 | |3;mootools.html;1364.624728199745;1546.791183190269;1598.9440369587066;1607.4373969110814;1607.9598010049751;10785.245032847704;11224.551017959293;11252.831207531894;11266.380349080797;11649.184557081007;10954.780904381907;11135.276207046536;11136.944315278412;11140.777184456307;11141.997220250176;2424.3454267347806;2469.703635563726;2470.1601455505124;2473.8392004519737;2483.205374280231;1891.7919028906879;2413.5052314275617;2424.9515009699794;2433.8174636902213;2438.4147804526874;2332.5218330242346;2396.3529846941315;2404.8557086574774;2432.9391765205924;2441.6703744994375;2354.4702441950426;2395.964060539093;2411.6503107049466;2419.6249581314923;2423.2730180945823;2378.9405264868515;2381.5236952609375;2397.904083836662;2401.78383945444;2402.783749462539;10780.892191078146;10939.56241750337;10975;11010.559577616887;11011.724706882313;5785.392533783935;5926.970365148147;5963.344032156459;5969.343372229051;5979.342272350038;3250.041237834844;3251.138448311199;3296.3407318536388;3530.73519486037;3555.3244883472057;1188.197966372695;1191.7724743514107;1230.2864338683632;1243.5771837575269;1273.210609422155;13452.596422107352;13764;14626.780598290929;14894.70210595793;15006.924965375103;4680.742559159211;4780.713157210578;4805.207140821725;4823.348847905488;4832.106060378841;10932.070773984142;11439.485223164978;11510.079193664487;11515.021223195954;11535.19253652253;4901.460839307673;5178.663386879916;5762;5767.8558036049435;5779.393163717833;5123.820666276662;5282.2340760589495;5284.233786100994;5316.521513063843;5318.016167009038;3801.7148713846573;3953.1303113315025;3965.20695860829;3986.0234242610745;4016.3172260715164;916.5142474488398;1061.6443491430457;1065.7974984752873;1069.4759567811873;1079.3577821196375;945.9101385368378;965.9725497009174;971;977.1205914676848;979.2655508368723;5881.441263080001;6489.578177418547;6547.9017814732815;6645.700943457556;6705.295943925915;995.8729589090118;1049.1134990932649;1082.924195306321;1091.3015669971226;1107.5126944144552;3135.545345924874;3683.355412802802;3918.45141680165;4267.871963841089;4322.681582117421;13244.404001819941;13742.793858092136;13755;13759.38082786257;13811.240381779098;13334.333283335794;13359.53241636538;13593.252371119486;13656;13762.587122386345;9797.314188006914;9808.509574521246;9916.405015698936;10009.69970900874;10033.799324013478;5679.835633695;6388.2972872984865;6418.390252925965;6501.284858665637;6563.507736919654;10112.443815589919;11924.940375298069;12256.75486490283;12286.569970051005;12296.692582685504;9912.950435247778;11285.266457680225;11606.94196529012;12364.319962402154;12383.504659813507;8350.791230219293;8358.83282334362;8494.193051660082;8553.95723021381;8593.92575928009;10162.187025038127;10170.288079834341;10287.742806429898;10309.536070876678;10423.270371073952;7386.707326217783;8782.51696156692;8796.428232164888;8830.735077947671;8836.823263534821;7981.281684648409;8592.957035214784;8651.783705407164;8677.305815534868;8682.305415566612;7548.962255188909;7682.615869206629;7769.650365733669;7807.375409967075;7811.336036436739;5591.356993945586;5624.6625202487985;5713.7428815704225;5778.075507918713;5822.70886455684;5630.18362337467;5978.192943952511;6034.456898879122;6174.629522228681;6274.968625156845 07:14:38 INFO - PROCESS | 1638 | |4;prototype.html;313.30133801622384;317.02198716958185;382.0963421508134;385.63557438220874;394.36704089935654;4585.954140458599;4605.9769701151445;5153.896922061561;5258.079836028699;5368.651037682548;5047.873803154923;5210.505002024811;5286.4449232830575;5300.787968481266;5312.548433383167;4013.71903966721;4091.833827359203;4110.547839737634;4255.957290463841;4430.623397011242;4081.1429599784083;4126.8032270641625;4271.209826182151;4430.534793846648;4434.290513517838;3960.5445373782095;4012.458318127059;4251.97874010631;4444.422225110731;4524.6380289576755;3589.569251689788;3838.865639702625;3963.292858284062;4287.978560107211;4344.6089851913475;3985.548887434236;4047.8785636430953;4052.756834589934;4053.8243909266275;4088.4480595119576;4963.535756951708;5318.282031925718;5348.833722342458;5355.839324820262;5375.301210842605;4563.54364563541;4817.783199755984;4820.879478013043;5136.253673750943;5212.582993360522;4886.438059623153;5714.79998200061;5744.615984366525;5794.304683437972;5802.709864506758;4302.333138363559;4302.9887976325535;4418.2606783793935;4590.793414296331;4653.602869904988;5250.6324557281005;5961.463468287875;6061.545384096166;6085.421884920926;6100.511959043266;3930.349253313615;4063.512378514538;4238.4490016298305;4732.739699316502;4771.850578618096;4290.241001189497;4302.161078589707;4679.555442232982;4765.354503804592;4795.808167673324;4748.762561871962;4773.9045219096115;5143.099957507421;5146.430338746718;5177.508136727005;4955.324124972474;5077.8730531737;5658.603897727119;5687.037971899688;5718.599698021098;1388.9582812890333;1443.7617793064237;1510.9121432568534;1520.3310543360885;1587.9920600396924;1074.0601973273385;1173.8297946797666;1175.8824117588172;1216.0757824053605;1244.8381710377594;4944.826931057396;4972.602191824645;5122.487751224922;5128.7179205144075;5277.340332458442;5572.972135139298;5637.605367624227;5820.30156381237;5902.704864756745;5907.911381329283;4680.391549098664;4893.926591101136;5026.637480384214;5091.891408736813;5222.92165617516;2660.986695066551;2712.457508498308;2787.916362509128;2819.8287318764437;3065.218369315855;4855.732934688555;5158.793648254103;5402.838389746224;6032.245969253843;6106;5346.235742205141;5373.677579345252;5703.7488631479655;5711.685857277889;5887.793927212527;4996.629297645459;5377.892442151213;5397.379301380392;5403.514732997273;5538.944610553924;5274;5458.645188062763;5942.435468630473;5948.256467941507;5955.464008239279;5307.283516725192;5438.75525601341;5828.222392170429;5847.210626565359;5870.561712380494;5324.201369794562;5500.5874559409;6093.023488106182;6125.663088529996;6207.534434917489;4327.112941846976;4747.952520474889;5038.546530812245;5116.083832215601;5295.867603309948;5513.531349835309;5552.833414997556;5772.797952071657;5916.467517923235;5918.218437334446;4378.562143785596;4508.887277818081;5113.977204559029;5597.972010140086;5708.001099807434;5374.892502150014;5615.157726341082;5691.516221121251;5729.341125770423;5740.339860916049;5251.684898906078;5574.414686457863;5613.578981576316;5625.481120097633;5633.521150702072;5085.033843569858;5315.6279060465395;5474.91787623178;5735.139729040678;5757.819646972277;4700.412448443944;4777.495089046939;4855.36880205571;5355.571554275726;5411 07:14:38 INFO - PROCESS | 1638 | |5;yui.html;728.9380402665773;735.6763024269321;792.1998781230959;827.1769589258688;849.9915000849992;14486.782698259522;15370.615734606627;16609.750853737172;16621.335146594123;16652.167391630417;15229.314680839361;15288.31202595883;15402.152881591508;15431.537053888402;15439;959.8992105828875;967.6758285974207;976.7509285132317;977.5014742481314;979.3683074416997;985.8471936849764;986.866772985645;997.5261750668411;999.20063948841;999.7350702063959;1019.8317277649179;1031.494567661848;1040.0639424517956;1043.4782608695652;1044.4568824211444;1032.3496197395668;1033.1837848099992;1034.4569101221844;1034.886162522122;1037.087363120453;756.527170518426;760.224570937646;768.876979683248;770.4029377232633;770.9691612335556;17104.57238569046;17317.307307707677;17394.47816565505;17434.215460304316;17549.56126096845;14382.856171438256;14460.783088253685;14574.781378279335;14589;14625.70748585033;11638.6508404748;11663.883361166365;11936.880631193751;12012.819807702892;12103.334316612583;3671.9816400918094;3704.0369503928905;3743.3074881147077;3744.6817020553285;3756.5116534850295;96761.93311501468;107216.46391767991;114236;115475.42262288718;115679;10929.552327599155;11020.889791101987;11154.609588664358;11159.72100697489;11656.708582285512;23108;23308.300750977498;23322.65016024761;23506.412339691302;23545.175918842757;6802.8299292517095;7899.170587088273;7922.207779222032;8027.317677997436;8442.873356899652;4383.211022016004;4430.734155950653;4462.219111655448;4495.123450927038;4534.229181039232;3448;3512.016635342108;3535.840887160084;3545.3263879862743;3576.7853928764357;617.4288782875822;622.6326467384265;629.6788637794666;632.0740115730385;637.0317117980736;662.4733336997099;674.3020973292619;684.8561802021632;710.7086094701148;730.477708438469;10427.739306517245;10439.895601044043;10546.57813687444;10786.946065269623;10828.296160749525;471.56144785349267;538.6606437944148;622.4242575617536;712.9348159737084;732.6007326007339;3901.8439262429183;4487.708298960622;5074.720890350993;5080.59355251579;5082.822101226439;102465.48767256115;103230.48384758028;104892;104920.95079049112;105047;70766.64616676884;76460.70617881473;85005.57497212474;85111;85618.57190714007;67609.66195168992;68737;73264.63367683128;74665.6266718663;76309.61845190849;10207.642732504326;10771.946140269249;10853.78292434131;11155.498002590066;11389.031932285849;49280.26079608737;51071.74464127656;52414.21378679247;53978;54200.72899635477;73535;73651.63174184095;74359.6282018608;75137;75293.623531882;13841.723165536834;13915.443382264595;14067.859321406655;14086.929565352108;14158.575242742734;15207.695846083237;15289.235538222822;15291.23543822782;15479.922600386926;16014.839851601335;14126.731094948525;14184.219867906952;14186;14303.356348964113;14683.853161468676;13565.932170339085;13854.238016908763;13959.930200348934;13980.37088331048;13981.790273145707;12954.963602911934;13405.66485837862;13488.730225395633;13574.728505430034;13853.515126970507;8808.986966498678;8924.821503570021;9762.121409073217;10056.34633748804;10276.948615256875;7577.452603630684;9727.756806079904;9734.61061557558;11246.381449020382;11634.243774154653 07:14:38 INFO - PROCESS | 1638 | __end_tp_report 07:14:38 INFO - PROCESS | 1638 | __start_cc_report 07:14:38 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,376 07:14:38 INFO - PROCESS | 1638 | __end_cc_report 07:14:38 INFO - PROCESS | 1638 | __startTimestamp1495808078783__endTimestamp 07:14:38 INFO - PROCESS | 1638 | 07:14:38 INFO - PROCESS | 1638 | ------- Summary: start ------- 07:14:38 INFO - PROCESS | 1638 | Number of tests: 6 07:14:38 INFO - PROCESS | 1638 | 07:14:38 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5815.85 Median:6060.76 stddev:669.37 (11.0%) stddev-sans-first:633.38 07:14:38 INFO - PROCESS | 1638 | Values: 2980.0 3392.3 3411.9 3413.0 3425.5 5825.8 5829.8 5852.6 5932.7 5944.3 5903.9 5956.8 5962.8 6010.7 6025.8 5270.8 5351.6 5354.6 5393.8 5432.4 4473.7 5423.2 5437.9 5443.0 5464.5 5194.7 5218.3 5313.5 5423.4 5428.2 5327.7 5372.5 5451.2 5480.0 5484.3 5243.4 5330.5 5347.9 5373.2 5399.7 5876.7 5883.4 5953.0 5980.5 6030.0 5045.8 5207.3 6119.1 6286.9 6288.7 6263.4 6291.2 6337.7 6338.2 6338.4 6011.0 6042.9 6049.8 6052.1 6068.3 5526.3 6225.5 6347.7 6378.5 6421.2 6146.9 6166.9 6193.6 6234.2 6253.7 6321.7 6328.3 6335.7 6339.0 6343.1 6263.3 6285.7 6313.2 6331.1 6349.7 6141.0 6208.1 6224.8 6249.2 6322.4 4699.6 4852.2 4856.3 4876.3 4901.7 4372.3 4379.5 4387.2 4387.3 4413.4 5481.6 5628.8 5640.4 5783.6 5789.9 6207.8 6228.8 6228.9 6293.7 6294.2 5562.7 5602.4 5745.4 5787.9 5791.2 5415.8 5474.6 5499.9 5555.6 5561.6 6240.2 6282.5 6380.3 6410.7 6428.8 5885.9 6223.3 6262.3 6315.7 6331.6 5638.5 6392.1 6430.5 6433.7 6434.0 6325.0 6329.7 6365.9 6378.5 6380.6 6129.3 6170.7 6226.1 6240.3 6326.0 6278.5 6297.7 6306.2 6311.1 6336.5 6204.0 6233.2 6263.0 6282.8 6325.4 5772.6 5959.2 5968.6 6060.8 6207.8 6201.3 6260.5 6294.6 6304.9 6307.5 6127.9 6149.7 6156.8 6157.0 6167.8 07:14:38 INFO - PROCESS | 1638 | 07:14:38 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:57001.85 Median:386465.53 stddev:115309.76 (29.8%) stddev-sans-first:115556.06 07:14:38 INFO - PROCESS | 1638 | Values: 812.7 891.4 911.2 915.5 918.9 38736.8 39458.6 42079.8 42137.8 42147.6 40051.2 40383.2 40410.2 40453.4 40462.0 9074.3 9374.5 9518.6 9520.1 9528.6 9216.4 9257.2 9324.8 9328.2 9328.9 9350.8 9352.3 9362.1 9370.6 9372.5 9263.5 9312.5 9314.3 9315.9 9344.6 9099.0 9154.7 9162.0 9169.8 9178.6 35874.0 35937.8 36018.3 36036.8 36169.6 3858.7 3877.6 3906.5 3961.4 3986.4 25905.4 27171.3 27199.7 27199.9 27248.6 3016.4 3079.7 3101.1 3283.7 3300.5 383736.0 384910.0 385954.0 386147.1 386784.0 45250.0 45269.0 45506.1 45747.5 45765.8 37418.9 45877.8 46461.8 46467.1 46522.8 11749.6 11753.1 14029.3 14138.6 14198.1 12019.9 12091.3 12178.1 12184.0 12190.9 10824.4 12107.0 12249.2 12298.8 12440.9 4718.9 5018.0 5201.0 5569.0 5608.2 1036.5 1118.0 1174.9 1177.0 1213.8 23021.5 27493.0 28011.2 28035.6 28264.0 1079.2 1104.0 1261.8 1267.9 1326.9 13539.9 14153.0 14294.8 14360.9 14516.7 442039.0 493744.0 493906.0 495742.0 496049.0 59961.0 60331.8 60476.0 60512.8 60539.0 1413.3 1451.4 1463.8 1498.9 1500.1 21604.8 27622.3 27905.6 28029.3 28457.3 40990.4 41054.0 41225.2 41259.4 41378.8 425782.0 427033.0 427755.0 428180.0 428749.0 29895.0 30139.0 30244.0 30292.9 30327.0 45145.5 46990.8 47625.3 47870.0 50760.5 33939.7 33957.7 34201.8 34217.7 35047.5 33976.7 34455.0 34670.0 35180.6 35290.8 41312.6 41436.2 42979.6 43175.0 43182.8 33123.0 33945.0 34561.3 36513.6 36636.6 23671.5 25827.0 26042.9 27341.9 27367.9 07:14:38 INFO - PROCESS | 1638 | 07:14:38 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:42284.14 Median:22556.72 stddev:121409.03 (538.2%) stddev-sans-first:121708.88 07:14:38 INFO - PROCESS | 1638 | Values: 399.2 402.1 411.4 424.8 441.9 20180.1 20884.0 22207.2 22368.0 22401.9 22157.0 22236.9 22547.5 22565.9 22611.2 6736.3 7084.7 7094.0 7126.0 7126.7 6512.3 7195.9 7506.4 7563.7 7665.0 7326.9 7564.8 7590.1 7606.8 7634.2 7467.8 7568.6 7599.9 7682.7 7718.1 6645.1 7248.8 7471.0 7473.5 7476.1 24985.9 25792.4 25994.9 26309.2 26400.9 2826.2 2860.4 2973.7 2976.8 2988.6 15146.8 16067.1 16131.0 16298.4 16592.8 2102.4 2125.4 2131.6 2142.2 2169.1 146829.3 151851.2 171750.1 172082.0 173335.0 20402.9 20466.4 20728.8 20751.3 20924.8 30834.9 31320.1 31332.7 31343.7 31445.7 10059.3 10090.2 10229.9 10285.4 10432.0 8500.8 8510.1 8523.6 8567.9 8661.5 7573.0 9383.3 9501.7 9528.3 9534.3 3390.9 4002.4 4050.7 4086.5 4120.2 855.2 885.6 924.3 946.0 957.3 20872.9 21398.3 21414.4 21457.6 21556.8 938.3 956.9 964.6 973.0 981.0 10583.4 10982.0 10990.1 11107.7 11108.4 646362.0 716405.0 741654.0 748890.0 768300.0 128633.0 131953.3 157873.0 165313.2 172692.0 1098.0 1208.6 1225.5 1230.9 1251.0 19644.2 19914.8 20069.5 20317.3 20396.8 49727.8 61359.0 62113.4 62239.0 62414.0 58525.7 76060.2 81101.0 88578.2 91047.0 11018.7 11443.6 11532.8 11601.2 11617.1 10577.2 11389.5 12232.1 12475.7 12681.9 10965.9 10979.4 11352.3 11385.3 11424.6 10240.5 10279.7 10312.8 10391.4 10465.3 11149.0 11198.2 11577.8 11679.5 11782.8 9437.0 11402.4 11462.6 11464.8 11563.1 8759.7 10213.2 10219.9 10417.7 10629.2 07:14:38 INFO - PROCESS | 1638 | 07:14:38 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:6607.73 Median:2469.93 stddev:4098.76 (165.9%) stddev-sans-first:4091.32 07:14:38 INFO - PROCESS | 1638 | Values: 1364.6 1546.8 1598.9 1607.4 1608.0 10785.2 11224.6 11252.8 11266.4 11649.2 10954.8 11135.3 11136.9 11140.8 11142.0 2424.3 2469.7 2470.2 2473.8 2483.2 1891.8 2413.5 2425.0 2433.8 2438.4 2332.5 2396.4 2404.9 2432.9 2441.7 2354.5 2396.0 2411.7 2419.6 2423.3 2378.9 2381.5 2397.9 2401.8 2402.8 10780.9 10939.6 10975.0 11010.6 11011.7 5785.4 5927.0 5963.3 5969.3 5979.3 3250.0 3251.1 3296.3 3530.7 3555.3 1188.2 1191.8 1230.3 1243.6 1273.2 13452.6 13764.0 14626.8 14894.7 15006.9 4680.7 4780.7 4805.2 4823.3 4832.1 10932.1 11439.5 11510.1 11515.0 11535.2 4901.5 5178.7 5762.0 5767.9 5779.4 5123.8 5282.2 5284.2 5316.5 5318.0 3801.7 3953.1 3965.2 3986.0 4016.3 916.5 1061.6 1065.8 1069.5 1079.4 945.9 966.0 971.0 977.1 979.3 5881.4 6489.6 6547.9 6645.7 6705.3 995.9 1049.1 1082.9 1091.3 1107.5 3135.5 3683.4 3918.5 4267.9 4322.7 13244.4 13742.8 13755.0 13759.4 13811.2 13334.3 13359.5 13593.3 13656.0 13762.6 9797.3 9808.5 9916.4 10009.7 10033.8 5679.8 6388.3 6418.4 6501.3 6563.5 10112.4 11924.9 12256.8 12286.6 12296.7 9913.0 11285.3 11606.9 12364.3 12383.5 8350.8 8358.8 8494.2 8554.0 8593.9 10162.2 10170.3 10287.7 10309.5 10423.3 7386.7 8782.5 8796.4 8830.7 8836.8 7981.3 8593.0 8651.8 8677.3 8682.3 7549.0 7682.6 7769.7 7807.4 7811.3 5591.4 5624.7 5713.7 5778.1 5822.7 5630.2 5978.2 6034.5 6174.6 6275.0 07:14:38 INFO - PROCESS | 1638 | 07:14:38 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4698.24 Median:5119.29 stddev:1324.38 (25.9%) stddev-sans-first:1286.55 07:14:38 INFO - PROCESS | 1638 | Values: 313.3 317.0 382.1 385.6 394.4 4586.0 4606.0 5153.9 5258.1 5368.7 5047.9 5210.5 5286.4 5300.8 5312.5 4013.7 4091.8 4110.5 4256.0 4430.6 4081.1 4126.8 4271.2 4430.5 4434.3 3960.5 4012.5 4252.0 4444.4 4524.6 3589.6 3838.9 3963.3 4288.0 4344.6 3985.5 4047.9 4052.8 4053.8 4088.4 4963.5 5318.3 5348.8 5355.8 5375.3 4563.5 4817.8 4820.9 5136.3 5212.6 4886.4 5714.8 5744.6 5794.3 5802.7 4302.3 4303.0 4418.3 4590.8 4653.6 5250.6 5961.5 6061.5 6085.4 6100.5 3930.3 4063.5 4238.4 4732.7 4771.9 4290.2 4302.2 4679.6 4765.4 4795.8 4748.8 4773.9 5143.1 5146.4 5177.5 4955.3 5077.9 5658.6 5687.0 5718.6 1389.0 1443.8 1510.9 1520.3 1588.0 1074.1 1173.8 1175.9 1216.1 1244.8 4944.8 4972.6 5122.5 5128.7 5277.3 5573.0 5637.6 5820.3 5902.7 5907.9 4680.4 4893.9 5026.6 5091.9 5222.9 2661.0 2712.5 2787.9 2819.8 3065.2 4855.7 5158.8 5402.8 6032.2 6106.0 5346.2 5373.7 5703.7 5711.7 5887.8 4996.6 5377.9 5397.4 5403.5 5538.9 5274.0 5458.6 5942.4 5948.3 5955.5 5307.3 5438.8 5828.2 5847.2 5870.6 5324.2 5500.6 6093.0 6125.7 6207.5 4327.1 4748.0 5038.5 5116.1 5295.9 5513.5 5552.8 5772.8 5916.5 5918.2 4378.6 4508.9 5114.0 5598.0 5708.0 5374.9 5615.2 5691.5 5729.3 5740.3 5251.7 5574.4 5613.6 5625.5 5633.5 5085.0 5315.6 5474.9 5735.1 5757.8 4700.4 4777.5 4855.4 5355.6 5411.0 07:14:38 INFO - PROCESS | 1638 | 07:14:38 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20744.06 Median:23414.53 stddev:29364.32 (125.4%) stddev-sans-first:29408.24 07:14:38 INFO - PROCESS | 1638 | Values: 728.9 735.7 792.2 827.2 850.0 14486.8 15370.6 16609.8 16621.3 16652.2 15229.3 15288.3 15402.2 15431.5 15439.0 959.9 967.7 976.8 977.5 979.4 985.8 986.9 997.5 999.2 999.7 1019.8 1031.5 1040.1 1043.5 1044.5 1032.3 1033.2 1034.5 1034.9 1037.1 756.5 760.2 768.9 770.4 771.0 17104.6 17317.3 17394.5 17434.2 17549.6 14382.9 14460.8 14574.8 14589.0 14625.7 11638.7 11663.9 11936.9 12012.8 12103.3 3672.0 3704.0 3743.3 3744.7 3756.5 96761.9 107216.5 114236.0 115475.4 115679.0 10929.6 11020.9 11154.6 11159.7 11656.7 23108.0 23308.3 23322.7 23506.4 23545.2 6802.8 7899.2 7922.2 8027.3 8442.9 4383.2 4430.7 4462.2 4495.1 4534.2 3448.0 3512.0 3535.8 3545.3 3576.8 617.4 622.6 629.7 632.1 637.0 662.5 674.3 684.9 710.7 730.5 10427.7 10439.9 10546.6 10786.9 10828.3 471.6 538.7 622.4 712.9 732.6 3901.8 4487.7 5074.7 5080.6 5082.8 102465.5 103230.5 104892.0 104921.0 105047.0 70766.6 76460.7 85005.6 85111.0 85618.6 67609.7 68737.0 73264.6 74665.6 76309.6 10207.6 10771.9 10853.8 11155.5 11389.0 49280.3 51071.7 52414.2 53978.0 54200.7 73535.0 73651.6 74359.6 75137.0 75293.6 13841.7 13915.4 14067.9 14086.9 14158.6 15207.7 15289.2 15291.2 15479.9 16014.8 14126.7 14184.2 14186.0 14303.4 14683.9 13565.9 13854.2 13959.9 13980.4 13981.8 12955.0 13405.7 13488.7 13574.7 13853.5 8809.0 8924.8 9762.1 10056.3 10276.9 7577.5 9727.8 9734.6 11246.4 11634.2 07:14:38 INFO - PROCESS | 1638 | -------- Summary: end -------- 07:14:38 INFO - PROCESS | 1638 | 07:14:39 INFO - TEST-INFO | 1638: exit 0 07:14:39 INFO - TEST-OK | dromaeo_css | took 1114939ms 07:14:39 INFO - TEST-START | kraken 07:14:39 INFO - operating with platform_type : mac_ 07:14:39 INFO - Initialising browser for kraken test... 07:14:39 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpc9Qol8/profile http://localhost:49225/getInfo.html) 07:14:41 INFO - PROCESS | 1650 | 2017-05-26 07:14:41.952 plugin-container[1652:10128] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 07:14:41 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:14:41 INFO - PROCESS | 1650 | 2017-05-26 07:14:41.953 plugin-container[1652:10128] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 07:14:41 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:14:41 INFO - PROCESS | 1650 | 2017-05-26 07:14:41.953 plugin-container[1652:10128] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:14:42 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 07:14:42 INFO - PROCESS | 1650 | colorDepth:24 07:14:42 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 07:14:42 INFO - PROCESS | 1650 | __metrics 07:14:42 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 07:14:42 INFO - TEST-INFO | 1650: exit 0 07:14:42 INFO - Browser initialized. 07:14:42 INFO - Running cycle 1/1 for kraken test... 07:14:42 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpc9Qol8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:45 INFO - PROCESS | 1653 | 2017-05-26 07:14:45.271 plugin-container[1654:10257] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4443, name = 'com.apple.tsm.portname' 07:14:45 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:14:45 INFO - PROCESS | 1653 | 2017-05-26 07:14:45.272 plugin-container[1654:10257] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.CFPasteboardClient' 07:14:45 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 07:14:45 INFO - PROCESS | 1653 | 2017-05-26 07:14:45.272 plugin-container[1654:10257] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 07:14:55 INFO - PROCESS | 1653 | RSS: Main: 202907648 07:14:55 INFO - PROCESS | 1653 | 07:14:58 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49225/tests/kraken/driver.html?testName=audio-beat-detection) 07:14:59 INFO - PROCESS | 1653 | RSS: Main: 216584192 07:14:59 INFO - PROCESS | 1653 | 07:15:01 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49225/tests/kraken/driver.html?testName=audio-dft) 07:15:02 INFO - PROCESS | 1653 | RSS: Main: 224428032 07:15:02 INFO - PROCESS | 1653 | 07:15:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49225/tests/kraken/driver.html?testName=audio-fft) 07:15:06 INFO - PROCESS | 1653 | RSS: Main: 228581376 07:15:06 INFO - PROCESS | 1653 | 07:15:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49225/tests/kraken/driver.html?testName=audio-oscillator) 07:15:08 INFO - PROCESS | 1653 | RSS: Main: 228421632 07:15:08 INFO - PROCESS | 1653 | 07:15:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49225/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:15:11 INFO - PROCESS | 1653 | RSS: Main: 228540416 07:15:11 INFO - PROCESS | 1653 | 07:15:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49225/tests/kraken/driver.html?testName=imaging-darkroom) 07:15:15 INFO - PROCESS | 1653 | RSS: Main: 232292352 07:15:15 INFO - PROCESS | 1653 | 07:15:18 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49225/tests/kraken/driver.html?testName=imaging-desaturate) 07:15:18 INFO - PROCESS | 1653 | RSS: Main: 231919616 07:15:18 INFO - PROCESS | 1653 | 07:15:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49225/tests/kraken/driver.html?testName=json-parse-financial) 07:15:22 INFO - PROCESS | 1653 | RSS: Main: 233451520 07:15:22 INFO - PROCESS | 1653 | 07:15:24 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49225/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:15:25 INFO - PROCESS | 1653 | RSS: Main: 233181184 07:15:25 INFO - PROCESS | 1653 | 07:15:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:15:27 INFO - PROCESS | 1653 | RSS: Main: 233070592 07:15:27 INFO - PROCESS | 1653 | 07:15:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:15:30 INFO - PROCESS | 1653 | RSS: Main: 233140224 07:15:30 INFO - PROCESS | 1653 | 07:15:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:15:34 INFO - PROCESS | 1653 | RSS: Main: 233676800 07:15:34 INFO - PROCESS | 1653 | 07:15:37 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:15:37 INFO - PROCESS | 1653 | RSS: Main: 241283072 07:15:37 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49225/tests/kraken/driver.html?testName=ai-astar) 07:15:39 INFO - PROCESS | 1653 | RSS: Main: 242941952 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | __start_tp_report 07:15:39 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 07:15:39 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 07:15:39 INFO - PROCESS | 1653 | |i|pagename|runs| 07:15:39 INFO - PROCESS | 1653 | |0;ai-astar;109;101;168;176;120;119;121;137;177;120 07:15:39 INFO - PROCESS | 1653 | |1;audio-beat-detection;146;138;141;149;112;115;112;115;133;112 07:15:39 INFO - PROCESS | 1653 | |2;audio-dft;264;263;197;202;199;202;196;194;201;199 07:15:39 INFO - PROCESS | 1653 | |3;audio-fft;82;58;61;88;71;83;53;67;96;82 07:15:39 INFO - PROCESS | 1653 | |4;audio-oscillator;94;63;115;98;99;79;81;72;70;82 07:15:39 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;88;89;88;106;88;88;89;88;102;109 07:15:39 INFO - PROCESS | 1653 | |6;imaging-darkroom;105;116;97;97;97;98;97;96;95;97 07:15:39 INFO - PROCESS | 1653 | |7;imaging-desaturate;105;141;143;140;142;118;99;130;90;90 07:15:39 INFO - PROCESS | 1653 | |8;json-parse-financial;66;67;67;67;70;67;69;69;70;69 07:15:39 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;57;65;66;74;86;52;55;63;80;83 07:15:39 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;87;85;88;87;87;86;98;101;102;108 07:15:39 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;153;144;143;145;138;145;141;142;203;156 07:15:39 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;168;170;169;165;175;168;165;168;168;174 07:15:39 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;67;67;74;66;66;64;66;82;79;80 07:15:39 INFO - PROCESS | 1653 | __end_tp_report 07:15:39 INFO - PROCESS | 1653 | __start_cc_report 07:15:39 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1010 07:15:39 INFO - PROCESS | 1653 | __end_cc_report 07:15:39 INFO - PROCESS | 1653 | __startTimestamp1495808139856__endTimestamp 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | ------- Summary: start ------- 07:15:39 INFO - PROCESS | 1653 | Number of tests: 14 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:134.80 Median:129.00 stddev:28.42 (22.0%) stddev-sans-first:28.57 07:15:39 INFO - PROCESS | 1653 | Values: 109.0 101.0 168.0 176.0 120.0 119.0 121.0 137.0 177.0 120.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:127.30 Median:135.50 stddev:15.49 (11.4%) stddev-sans-first:14.88 07:15:39 INFO - PROCESS | 1653 | Values: 146.0 138.0 141.0 149.0 112.0 115.0 112.0 115.0 133.0 112.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:211.70 Median:201.50 stddev:27.42 (13.6%) stddev-sans-first:21.59 07:15:39 INFO - PROCESS | 1653 | Values: 264.0 263.0 197.0 202.0 199.0 202.0 196.0 194.0 201.0 199.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:74.10 Median:82.00 stddev:14.19 (17.3%) stddev-sans-first:14.76 07:15:39 INFO - PROCESS | 1653 | Values: 82.0 58.0 61.0 88.0 71.0 83.0 53.0 67.0 96.0 82.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:85.30 Median:81.50 stddev:15.93 (19.5%) stddev-sans-first:16.58 07:15:39 INFO - PROCESS | 1653 | Values: 94.0 63.0 115.0 98.0 99.0 79.0 81.0 72.0 70.0 82.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:88.00 stddev:8.57 (9.7%) stddev-sans-first:8.85 07:15:39 INFO - PROCESS | 1653 | Values: 88.0 89.0 88.0 106.0 88.0 88.0 89.0 88.0 102.0 109.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:97.00 stddev:6.40 (6.6%) stddev-sans-first:6.47 07:15:39 INFO - PROCESS | 1653 | Values: 105.0 116.0 97.0 97.0 97.0 98.0 97.0 96.0 95.0 97.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:119.80 Median:142.50 stddev:22.17 (15.6%) stddev-sans-first:22.86 07:15:39 INFO - PROCESS | 1653 | Values: 105.0 141.0 143.0 140.0 142.0 118.0 99.0 130.0 90.0 90.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:68.10 Median:69.00 stddev:1.45 (2.1%) stddev-sans-first:1.32 07:15:39 INFO - PROCESS | 1653 | Values: 66.0 67.0 67.0 67.0 70.0 67.0 69.0 69.0 70.0 69.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:70.00 stddev:12.08 (17.3%) stddev-sans-first:12.12 07:15:39 INFO - PROCESS | 1653 | Values: 57.0 65.0 66.0 74.0 86.0 52.0 55.0 63.0 80.0 83.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:92.90 Median:87.00 stddev:8.44 (9.7%) stddev-sans-first:8.68 07:15:39 INFO - PROCESS | 1653 | Values: 87.0 85.0 88.0 87.0 87.0 86.0 98.0 101.0 102.0 108.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:151.00 Median:145.00 stddev:19.06 (13.1%) stddev-sans-first:20.20 07:15:39 INFO - PROCESS | 1653 | Values: 153.0 144.0 143.0 145.0 138.0 145.0 141.0 142.0 203.0 156.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:168.50 stddev:3.30 (2.0%) stddev-sans-first:3.48 07:15:39 INFO - PROCESS | 1653 | Values: 168.0 170.0 169.0 165.0 175.0 168.0 165.0 168.0 168.0 174.0 07:15:39 INFO - PROCESS | 1653 | 07:15:39 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:70.50 stddev:6.92 (9.8%) stddev-sans-first:7.18 07:15:39 INFO - PROCESS | 1653 | Values: 67.0 67.0 74.0 66.0 66.0 64.0 66.0 82.0 79.0 80.0 07:15:39 INFO - PROCESS | 1653 | -------- Summary: end -------- 07:15:39 INFO - PROCESS | 1653 | 07:15:40 INFO - TEST-INFO | 1653: exit 0 07:15:40 INFO - TEST-OK | kraken | took 61327ms 07:15:40 INFO - SUITE-END | took 1176s 07:15:40 INFO - Completed test suite (00:19:36) 07:15:40 INFO - javascript benchmark 07:15:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7725.931868012159, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2979.9702002979975, 3392.304577561599, 3411.8805841795534, 3412.965870341296, 3425.5204271401994, 5825.766969321227, 5829.795957141501, 5852.590318677694, 5932.673702946347, 5944.286685597724, 5903.911441328383, 5956.79151229706, 5962.821115366535, 6010.669413182284, 6025.819225423234, 5270.789168433268, 5351.598630102739, 5354.629398552533, 5393.83818485446, 5432.402435732066, 4473.66447516436, 5423.159410291391, 5437.939601777655, 5443.047466693332, 5464.508194262516, 5194.740262986855, 5218.269442278084, 5313.468653134694, 5423.430539793324, 5428.158635411518, 5327.653702509325, 5372.489613486693, 5451.209574611698, 5480.0, 5484.341878974508, 5243.397009343936, 5330.466953304677, 5347.919781203285, 5373.220882971987, 5399.676019438846, 5876.676782776945, 5883.352831188566, 5953.047512397996, 5980.491658209057, 6030.035194368924, 5045.823396181153, 5207.270982062514, 6119.076065312615, 6286.87426251477, 6288.748450061992, 6263.404976527223, 6291.245050593912, 6337.746490140389, 6338.176037115146, 6338.366163383671, 6011.0, 6042.9395706042815, 6049.758009679607, 6052.12244224585, 6068.33248342682, 5526.336839579276, 6225.501959843202, 6347.650879201596, 6378.521610879203, 6421.165248517663, 6146.862830376305, 6166.907496387557, 6193.597416167935, 6234.1583886175695, 6253.6873156342, 6321.683915804191, 6328.303886572473, 6335.746570137235, 6339.049142628551, 6343.1436756038265, 6263.342349053375, 6285.654289014056, 6313.210848643919, 6331.113644089831, 6349.7142628580905, 6141.025769127022, 6208.099825525273, 6224.813255602339, 6249.156363890907, 6322.36776322364, 4699.553542413465, 4852.223644216909, 4856.2958371036, 4876.317315575822, 4901.656884018156, 4372.300431930876, 4379.4525684289465, 4387.166438376698, 4387.254166791653, 4413.40419043425, 5481.561475082063, 5628.774849006076, 5640.407757185437, 5783.624064435799, 5789.88420231593, 6207.81376558704, 6228.813135605939, 6228.906566401508, 6293.748250070037, 6294.2446906370615, 5562.749676264578, 5602.38373778884, 5745.368009518949, 5787.942120578825, 5791.189233507313, 5415.756290966916, 5474.562035037267, 5499.890002199933, 5555.555555555546, 5561.582881283839, 6240.188775459162, 6282.528810339243, 6380.266269378988, 6410.679466026773, 6428.839279018062, 5885.9405307045145, 6223.253209614875, 6262.3111457738705, 6315.715792789244, 6331.588446750947, 5638.464345887134, 6392.137061496825, 6430.549861509649, 6433.678316084083, 6434.034894765822, 6325.0, 6329.7468101275435, 6365.904511432424, 6378.45783108441, 6380.553361264667, 6129.267100814712, 6170.7223174958135, 6226.12834203221, 6240.28236752761, 6326.0, 6278.46633036197, 6297.685115744286, 6306.211723534559, 6311.053341998737, 6336.493080553452, 6204.0, 6233.158523599437, 6262.968685156545, 6282.780102696383, 6325.399087086719, 5772.624779389326, 5959.195508606283, 5968.552358573038, 6060.757569697339, 6207.81376558704, 6201.2868520118955, 6260.499160067093, 6294.590851594632, 6304.936950630435, 6307.526935479766, 6127.908081378694, 6149.692515374303, 6156.846078848064, 6157.0, 6167.814965551041], "value": 5771.814848544785, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.6708682983392, 891.402760150699, 911.2163539356148, 915.5102020419073, 918.9035151309113, 38736.80631596842, 39458.60541394585, 42079.789601051954, 42137.7893110534, 42147.57852421479, 40051.19897602046, 40383.19233615326, 40410.19179616406, 40453.393199102036, 40462.0, 9074.319426043057, 9374.484403357812, 9518.619255229818, 9520.095590918852, 9528.571214295373, 9216.354855160142, 9257.16685498305, 9324.766880827965, 9328.207102396305, 9328.860067098998, 9350.766230844216, 9352.298577606673, 9362.110599493037, 9370.578323975438, 9372.484513351763, 9263.536823158849, 9312.534373281344, 9314.301427392906, 9315.860262096074, 9344.579493922722, 9099.0, 9154.725358239197, 9161.9921808601, 9169.816603667956, 9178.586963586655, 35874.0, 35937.82031089828, 36018.27963440717, 36036.81981590075, 36169.63830361689, 3858.7298889077774, 3877.6428250112517, 3906.4726261954556, 3961.425593288986, 3986.362182050858, 25905.352366190808, 27171.320716982034, 27199.728002720116, 27199.864000680067, 27248.59127113095, 3016.366563021746, 3079.6612372638992, 3101.1316831287277, 3283.7208837248863, 3300.5214243934734, 383736.0, 384910.0, 385954.0, 386147.06926465186, 386784.0, 45250.0, 45269.0, 45506.08987820225, 45747.54252457433, 45765.77117114393, 37418.87743367704, 45877.770611147396, 46461.76769116133, 46467.070658586636, 46522.76738616353, 11749.588764393206, 11753.059755219561, 14029.298535073205, 14138.575842724735, 14198.14811111316, 12019.879801201876, 12091.274523528617, 12178.147529672839, 12184.025277977918, 12190.878091219152, 10824.404657743742, 12107.03143748498, 12249.203801753036, 12298.815517767242, 12440.875591244152, 4718.905621887543, 5018.0214858103045, 5200.959808038332, 5569.0, 5608.214849921014, 1036.4972988100765, 1118.032901540162, 1174.8883856033663, 1176.9882301176879, 1213.8422005139275, 23021.539569208522, 27493.0, 28011.159665210078, 28035.598220088916, 28264.010759623314, 1079.2067830144838, 1104.0450010740813, 1261.8359613250218, 1267.8985681145487, 1326.907116501855, 13539.864601354057, 14153.0, 14294.785578216335, 14360.922930780232, 14516.709665806624, 442039.0, 493744.0, 493906.0, 495742.0, 496049.0, 59961.0, 60331.79336413247, 60476.0, 60512.78974420487, 60539.0, 1413.2721648351107, 1451.3831621560794, 1463.7877507761527, 1498.8725958293667, 1500.0549653718087, 21604.783952160276, 27622.309442264104, 27905.58141627918, 28029.299267518476, 28457.28856778597, 40990.38514422346, 41053.973650657776, 41225.175496490505, 41259.38110928278, 41378.793106034274, 425782.0, 427033.0, 427755.0, 428180.0, 428749.0, 29895.0, 30139.0, 30244.0, 30292.939747108747, 30327.0, 45145.54854451545, 46990.76504617455, 47625.333113340865, 47870.0, 50760.49239507558, 33939.66060339365, 33957.66042339644, 34201.82899085488, 34217.65782342145, 35047.47428788519, 33976.66023339834, 34455.0, 34670.0, 35180.648193517736, 35290.82354588313, 41312.586874132074, 41436.1712765749, 42979.570204298805, 43175.0, 43182.784086079366, 33123.0, 33944.98165055052, 34561.30877382489, 36513.63486365102, 36636.63363366439, 23671.526569468857, 25827.0, 26042.86978565095, 27341.86329068342, 27367.863160684068], "value": 18754.39712406784, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.15976868691405, 402.1133400851124, 411.3747104401309, 424.8470550601783, 441.9138268037732, 20180.091895864683, 20884.0, 22207.22274720381, 22368.0, 22401.887990560044, 22157.0, 22236.8888155559, 22547.54904901905, 22565.887170564165, 22611.208607698733, 6736.29268926763, 7084.681189346492, 7094.0, 7126.0, 7126.679299431538, 6512.316206798289, 7195.89206161908, 7506.399488040944, 7563.659635316424, 7665.0, 7326.9267307327045, 7564.773056808304, 7590.127135379446, 7606.809829754273, 7634.198409167041, 7467.775966721007, 7568.583727894964, 7599.886001709979, 7682.7311044113185, 7718.073831140243, 6645.102911107036, 7248.818779530501, 7471.0, 7473.476856620039, 7476.065491813523, 24985.87507062453, 25792.355191120183, 25994.87002564994, 26309.21072367832, 26400.86799566009, 2826.2086615747626, 2860.427914417104, 2973.658029326612, 2976.821390716564, 2988.5666578346236, 15146.772798408032, 16067.116308603023, 16130.95148815335, 16298.42955496552, 16592.751108733377, 2102.4218339956483, 2125.362391282609, 2131.573685262938, 2142.1645558232303, 2169.0781417897488, 146829.26585367005, 151851.20371990677, 171750.14124929297, 172082.0, 173335.0, 20402.89798550998, 20466.38600841977, 20728.792712072987, 20751.273705420237, 20924.790752092587, 30834.92077777267, 31320.060398188092, 31332.686673133434, 31343.68656313453, 31445.742170312933, 10059.346142500714, 10090.243231757648, 10229.897701023043, 10285.43430111336, 10432.0, 8500.787480313042, 8510.063892971768, 8523.57382130891, 8567.914320856837, 8661.523616201044, 7573.0, 9383.343165978453, 9501.667441639509, 9528.285378596494, 9534.332596718303, 3390.881319153867, 4002.4396584478195, 4050.691106069571, 4086.4891888513935, 4120.198265179647, 855.234565064264, 885.6059053721161, 924.2744445610164, 946.0114180681205, 957.3298690916387, 20872.895635521727, 21398.251061212784, 21414.357569272946, 21457.570848582942, 21556.784432155793, 938.3290946972947, 956.9377990430634, 964.6189755046857, 972.9589339406767, 980.9558569864373, 10583.417912014758, 10982.011618954173, 10990.120790336914, 11107.722306942229, 11108.444577771079, 646362.0, 716405.0, 741654.0, 748890.0, 768300.0, 128633.0, 131953.34023329822, 157873.0, 165313.17343413207, 172692.0, 1097.9780404391868, 1208.6313674329238, 1225.4695736098324, 1230.8584512780965, 1250.956216532417, 19644.214231430582, 19914.800851991873, 20069.498262543555, 20317.288894888607, 20396.79603203949, 49727.75136124296, 61359.0, 62113.37886621076, 62239.0, 62414.0, 58525.70737146287, 76060.23939760531, 81101.0, 88578.22843543222, 91047.0, 11018.724531886766, 11443.599474018702, 11532.827007594726, 11601.18791684574, 11617.128715346551, 10577.153827693612, 11389.54441822351, 12232.143749937419, 12475.688107797378, 12681.93659031699, 10965.890341096487, 10979.39613321275, 11352.318860868374, 11385.259958102697, 11424.600138995096, 10240.539175737258, 10279.743006424898, 10312.845307320245, 10391.37651740898, 10465.319754215952, 11148.996590306911, 11198.21612487118, 11577.768444631229, 11679.474423651127, 11782.823257651313, 9437.0, 11402.372869492257, 11462.598809041643, 11464.770704586028, 11563.132765042823, 8759.693410730593, 10213.182945364204, 10219.948900255451, 10417.687469375931, 10629.20280978945], "value": 11570.16050938726, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.624728199745, 1546.791183190269, 1598.9440369587066, 1607.4373969110814, 1607.9598010049751, 10785.245032847704, 11224.551017959293, 11252.831207531894, 11266.380349080797, 11649.184557081007, 10954.780904381907, 11135.276207046536, 11136.944315278412, 11140.777184456307, 11141.997220250176, 2424.3454267347806, 2469.703635563726, 2470.1601455505124, 2473.8392004519737, 2483.205374280231, 1891.7919028906879, 2413.5052314275617, 2424.9515009699794, 2433.8174636902213, 2438.4147804526874, 2332.5218330242346, 2396.3529846941315, 2404.8557086574774, 2432.9391765205924, 2441.6703744994375, 2354.4702441950426, 2395.964060539093, 2411.6503107049466, 2419.6249581314923, 2423.2730180945823, 2378.9405264868515, 2381.5236952609375, 2397.904083836662, 2401.78383945444, 2402.783749462539, 10780.892191078146, 10939.56241750337, 10975.0, 11010.559577616887, 11011.724706882313, 5785.392533783935, 5926.970365148147, 5963.344032156459, 5969.343372229051, 5979.342272350038, 3250.041237834844, 3251.138448311199, 3296.3407318536388, 3530.73519486037, 3555.3244883472057, 1188.197966372695, 1191.7724743514107, 1230.2864338683632, 1243.5771837575269, 1273.210609422155, 13452.596422107352, 13764.0, 14626.780598290929, 14894.70210595793, 15006.924965375103, 4680.742559159211, 4780.713157210578, 4805.207140821725, 4823.348847905488, 4832.106060378841, 10932.070773984142, 11439.485223164978, 11510.079193664487, 11515.021223195954, 11535.19253652253, 4901.460839307673, 5178.663386879916, 5762.0, 5767.8558036049435, 5779.393163717833, 5123.820666276662, 5282.2340760589495, 5284.233786100994, 5316.521513063843, 5318.016167009038, 3801.7148713846573, 3953.1303113315025, 3965.20695860829, 3986.0234242610745, 4016.3172260715164, 916.5142474488398, 1061.6443491430457, 1065.7974984752873, 1069.4759567811873, 1079.3577821196375, 945.9101385368378, 965.9725497009174, 971.0, 977.1205914676848, 979.2655508368723, 5881.441263080001, 6489.578177418547, 6547.9017814732815, 6645.700943457556, 6705.295943925915, 995.8729589090118, 1049.1134990932649, 1082.924195306321, 1091.3015669971226, 1107.5126944144552, 3135.545345924874, 3683.355412802802, 3918.45141680165, 4267.871963841089, 4322.681582117421, 13244.404001819941, 13742.793858092136, 13755.0, 13759.38082786257, 13811.240381779098, 13334.333283335794, 13359.53241636538, 13593.252371119486, 13656.0, 13762.587122386345, 9797.314188006914, 9808.509574521246, 9916.405015698936, 10009.69970900874, 10033.799324013478, 5679.835633695, 6388.2972872984865, 6418.390252925965, 6501.284858665637, 6563.507736919654, 10112.443815589919, 11924.940375298069, 12256.75486490283, 12286.569970051005, 12296.692582685504, 9912.950435247778, 11285.266457680225, 11606.94196529012, 12364.319962402154, 12383.504659813507, 8350.791230219293, 8358.83282334362, 8494.193051660082, 8553.95723021381, 8593.92575928009, 10162.187025038127, 10170.288079834341, 10287.742806429898, 10309.536070876678, 10423.270371073952, 7386.707326217783, 8782.51696156692, 8796.428232164888, 8830.735077947671, 8836.823263534821, 7981.281684648409, 8592.957035214784, 8651.783705407164, 8677.305815534868, 8682.305415566612, 7548.962255188909, 7682.615869206629, 7769.650365733669, 7807.375409967075, 7811.336036436739, 5591.356993945586, 5624.6625202487985, 5713.7428815704225, 5778.075507918713, 5822.70886455684, 5630.18362337467, 5978.192943952511, 6034.456898879122, 6174.629522228681, 6274.968625156845], "value": 5078.834119374058, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.30133801622384, 317.02198716958185, 382.0963421508134, 385.63557438220874, 394.36704089935654, 4585.954140458599, 4605.9769701151445, 5153.896922061561, 5258.079836028699, 5368.651037682548, 5047.873803154923, 5210.505002024811, 5286.4449232830575, 5300.787968481266, 5312.548433383167, 4013.71903966721, 4091.833827359203, 4110.547839737634, 4255.957290463841, 4430.623397011242, 4081.1429599784083, 4126.8032270641625, 4271.209826182151, 4430.534793846648, 4434.290513517838, 3960.5445373782095, 4012.458318127059, 4251.97874010631, 4444.422225110731, 4524.6380289576755, 3589.569251689788, 3838.865639702625, 3963.292858284062, 4287.978560107211, 4344.6089851913475, 3985.548887434236, 4047.8785636430953, 4052.756834589934, 4053.8243909266275, 4088.4480595119576, 4963.535756951708, 5318.282031925718, 5348.833722342458, 5355.839324820262, 5375.301210842605, 4563.54364563541, 4817.783199755984, 4820.879478013043, 5136.253673750943, 5212.582993360522, 4886.438059623153, 5714.79998200061, 5744.615984366525, 5794.304683437972, 5802.709864506758, 4302.333138363559, 4302.9887976325535, 4418.2606783793935, 4590.793414296331, 4653.602869904988, 5250.6324557281005, 5961.463468287875, 6061.545384096166, 6085.421884920926, 6100.511959043266, 3930.349253313615, 4063.512378514538, 4238.4490016298305, 4732.739699316502, 4771.850578618096, 4290.241001189497, 4302.161078589707, 4679.555442232982, 4765.354503804592, 4795.808167673324, 4748.762561871962, 4773.9045219096115, 5143.099957507421, 5146.430338746718, 5177.508136727005, 4955.324124972474, 5077.8730531737, 5658.603897727119, 5687.037971899688, 5718.599698021098, 1388.9582812890333, 1443.7617793064237, 1510.9121432568534, 1520.3310543360885, 1587.9920600396924, 1074.0601973273385, 1173.8297946797666, 1175.8824117588172, 1216.0757824053605, 1244.8381710377594, 4944.826931057396, 4972.602191824645, 5122.487751224922, 5128.7179205144075, 5277.340332458442, 5572.972135139298, 5637.605367624227, 5820.30156381237, 5902.704864756745, 5907.911381329283, 4680.391549098664, 4893.926591101136, 5026.637480384214, 5091.891408736813, 5222.92165617516, 2660.986695066551, 2712.457508498308, 2787.916362509128, 2819.8287318764437, 3065.218369315855, 4855.732934688555, 5158.793648254103, 5402.838389746224, 6032.245969253843, 6106.0, 5346.235742205141, 5373.677579345252, 5703.7488631479655, 5711.685857277889, 5887.793927212527, 4996.629297645459, 5377.892442151213, 5397.379301380392, 5403.514732997273, 5538.944610553924, 5274.0, 5458.645188062763, 5942.435468630473, 5948.256467941507, 5955.464008239279, 5307.283516725192, 5438.75525601341, 5828.222392170429, 5847.210626565359, 5870.561712380494, 5324.201369794562, 5500.5874559409, 6093.023488106182, 6125.663088529996, 6207.534434917489, 4327.112941846976, 4747.952520474889, 5038.546530812245, 5116.083832215601, 5295.867603309948, 5513.531349835309, 5552.833414997556, 5772.797952071657, 5916.467517923235, 5918.218437334446, 4378.562143785596, 4508.887277818081, 5113.977204559029, 5597.972010140086, 5708.001099807434, 5374.892502150014, 5615.157726341082, 5691.516221121251, 5729.341125770423, 5740.339860916049, 5251.684898906078, 5574.414686457863, 5613.578981576316, 5625.481120097633, 5633.521150702072, 5085.033843569858, 5315.6279060465395, 5474.91787623178, 5735.139729040678, 5757.819646972277, 4700.412448443944, 4777.495089046939, 4855.36880205571, 5355.571554275726, 5411.0], "value": 4301.371235803184, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.9380402665773, 735.6763024269321, 792.1998781230959, 827.1769589258688, 849.9915000849992, 14486.782698259522, 15370.615734606627, 16609.750853737172, 16621.335146594123, 16652.167391630417, 15229.314680839361, 15288.31202595883, 15402.152881591508, 15431.537053888402, 15439.0, 959.8992105828875, 967.6758285974207, 976.7509285132317, 977.5014742481314, 979.3683074416997, 985.8471936849764, 986.866772985645, 997.5261750668411, 999.20063948841, 999.7350702063959, 1019.8317277649179, 1031.494567661848, 1040.0639424517956, 1043.4782608695652, 1044.4568824211444, 1032.3496197395668, 1033.1837848099992, 1034.4569101221844, 1034.886162522122, 1037.087363120453, 756.527170518426, 760.224570937646, 768.876979683248, 770.4029377232633, 770.9691612335556, 17104.57238569046, 17317.307307707677, 17394.47816565505, 17434.215460304316, 17549.56126096845, 14382.856171438256, 14460.783088253685, 14574.781378279335, 14589.0, 14625.70748585033, 11638.6508404748, 11663.883361166365, 11936.880631193751, 12012.819807702892, 12103.334316612583, 3671.9816400918094, 3704.0369503928905, 3743.3074881147077, 3744.6817020553285, 3756.5116534850295, 96761.93311501468, 107216.46391767991, 114236.0, 115475.42262288718, 115679.0, 10929.552327599155, 11020.889791101987, 11154.609588664358, 11159.72100697489, 11656.708582285512, 23108.0, 23308.300750977498, 23322.65016024761, 23506.412339691302, 23545.175918842757, 6802.8299292517095, 7899.170587088273, 7922.207779222032, 8027.317677997436, 8442.873356899652, 4383.211022016004, 4430.734155950653, 4462.219111655448, 4495.123450927038, 4534.229181039232, 3448.0, 3512.016635342108, 3535.840887160084, 3545.3263879862743, 3576.7853928764357, 617.4288782875822, 622.6326467384265, 629.6788637794666, 632.0740115730385, 637.0317117980736, 662.4733336997099, 674.3020973292619, 684.8561802021632, 710.7086094701148, 730.477708438469, 10427.739306517245, 10439.895601044043, 10546.57813687444, 10786.946065269623, 10828.296160749525, 471.56144785349267, 538.6606437944148, 622.4242575617536, 712.9348159737084, 732.6007326007339, 3901.8439262429183, 4487.708298960622, 5074.720890350993, 5080.59355251579, 5082.822101226439, 102465.48767256115, 103230.48384758028, 104892.0, 104920.95079049112, 105047.0, 70766.64616676884, 76460.70617881473, 85005.57497212474, 85111.0, 85618.57190714007, 67609.66195168992, 68737.0, 73264.63367683128, 74665.6266718663, 76309.61845190849, 10207.642732504326, 10771.946140269249, 10853.78292434131, 11155.498002590066, 11389.031932285849, 49280.26079608737, 51071.74464127656, 52414.21378679247, 53978.0, 54200.72899635477, 73535.0, 73651.63174184095, 74359.6282018608, 75137.0, 75293.623531882, 13841.723165536834, 13915.443382264595, 14067.859321406655, 14086.929565352108, 14158.575242742734, 15207.695846083237, 15289.235538222822, 15291.23543822782, 15479.922600386926, 16014.839851601335, 14126.731094948525, 14184.219867906952, 14186.0, 14303.356348964113, 14683.853161468676, 13565.932170339085, 13854.238016908763, 13959.930200348934, 13980.37088331048, 13981.790273145707, 12954.963602911934, 13405.66485837862, 13488.730225395633, 13574.728505430034, 13853.515126970507, 8808.986966498678, 8924.821503570021, 9762.121409073217, 10056.34633748804, 10276.948615256875, 7577.452603630684, 9727.756806079904, 9734.61061557558, 11246.381449020382, 11634.243774154653], "value": 7772.100349184683, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 101.0, 168.0, 176.0, 120.0, 119.0, 121.0, 137.0, 177.0, 120.0], "value": 134.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 138.0, 141.0, 149.0, 112.0, 115.0, 112.0, 115.0, 133.0, 112.0], "value": 127.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [264.0, 263.0, 197.0, 202.0, 199.0, 202.0, 196.0, 194.0, 201.0, 199.0], "value": 211.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 61.0, 88.0, 71.0, 83.0, 53.0, 67.0, 96.0, 82.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 63.0, 115.0, 98.0, 99.0, 79.0, 81.0, 72.0, 70.0, 82.0], "value": 85.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 106.0, 88.0, 88.0, 89.0, 88.0, 102.0, 109.0], "value": 93.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 97.0, 97.0, 97.0, 98.0, 97.0, 96.0, 95.0, 97.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 141.0, 143.0, 140.0, 142.0, 118.0, 99.0, 130.0, 90.0, 90.0], "value": 119.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 67.0, 70.0, 67.0, 69.0, 69.0, 70.0, 69.0], "value": 68.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 65.0, 66.0, 74.0, 86.0, 52.0, 55.0, 63.0, 80.0, 83.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 88.0, 87.0, 87.0, 86.0, 98.0, 101.0, 102.0, 108.0], "value": 92.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 144.0, 143.0, 145.0, 138.0, 145.0, 141.0, 142.0, 203.0, 156.0], "value": 151.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 169.0, 165.0, 175.0, 168.0, 165.0, 168.0, 168.0, 174.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 74.0, 66.0, 66.0, 64.0, 66.0, 82.0, 79.0, 80.0], "value": 71.1, "unit": "score"}]}]} 07:15:41 INFO - Return code: 0 07:15:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:15:41 ERROR - # TBPL SUCCESS # 07:15:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:41 INFO - 2017-05-26 07:15:41.184 screenresolution[1658:10658] starting screenresolution argv=screenresolution get 07:15:41 INFO - 2017-05-26 07:15:41.187 screenresolution[1658:10658] Display 0: 1600x1200x32@60 07:15:41 INFO - 2017-05-26 07:15:41.193 screenresolution[1659:10661] starting screenresolution argv=screenresolution list 07:15:41 INFO - Available Modes on Display 0 07:15:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:41 INFO - Intel Iris: 07:15:41 INFO - Chipset Model: Intel Iris 07:15:41 INFO - Type: GPU 07:15:41 INFO - Bus: Built-In 07:15:41 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:41 INFO - Vendor: Intel (0x8086) 07:15:41 INFO - Device ID: 0x0a2e 07:15:41 INFO - Revision ID: 0x0009 07:15:41 INFO - Displays: 07:15:41 INFO - Display: 07:15:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:41 INFO - Display Serial Number: 1600x1200 60 07:15:41 INFO - Main Display: Yes 07:15:41 INFO - Mirror: Off 07:15:41 INFO - Online: Yes 07:15:41 INFO - Rotation: Supported 07:15:41 INFO - Return code: 0 07:15:41 INFO - Running post-action listener: _resource_record_post_action 07:15:41 INFO - [mozharness: 2017-05-26 14:15:41.429386Z] Finished run-tests step (success) 07:15:41 INFO - Running post-run listener: _resource_record_post_run 07:15:41 INFO - Total resource usage - Wall time: 1197s; CPU: 55.0%; Read bytes: 40523776; Write bytes: 513066496; Read time: 391; Write time: 2470 07:15:41 INFO - TinderboxPrint: CPU usage
54.6% 07:15:41 INFO - TinderboxPrint: I/O read bytes / time
40,523,776 / 391 07:15:41 INFO - TinderboxPrint: I/O write bytes / time
513,066,496 / 2,470 07:15:41 INFO - TinderboxPrint: CPU idle
2,176.6 (45.4%) 07:15:41 INFO - TinderboxPrint: CPU system
961.8 (20.1%) 07:15:41 INFO - TinderboxPrint: CPU user
1,651.3 (34.5%) 07:15:41 INFO - TinderboxPrint: Swap in / out
249,475,072 / 0 07:15:41 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206336512; Write bytes: 202868736; Read time: 15709; Write time: 466 07:15:41 INFO - run-tests - Wall time: 1178s; CPU: 55.0%; Read bytes: 38410240; Write bytes: 299126272; Read time: 364; Write time: 1971 07:15:41 INFO - Running post-run listener: _upload_blobber_files 07:15:41 INFO - Blob upload gear active. 07:15:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:15:41 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:15:41 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:15:41 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:15:42 INFO - (blobuploader) - INFO - Open directory for files ... 07:15:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:15:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:15:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:43 INFO - (blobuploader) - INFO - Done attempting. 07:15:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:15:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:15:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:44 INFO - (blobuploader) - INFO - Done attempting. 07:15:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:15:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:15:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:45 INFO - (blobuploader) - INFO - Done attempting. 07:15:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:15:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:15:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:47 INFO - (blobuploader) - INFO - Done attempting. 07:15:47 INFO - (blobuploader) - INFO - Iteration through files over. 07:15:47 INFO - Return code: 0 07:15:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:15:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:15:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ebfaad560ea12c87746667f9464714153b7c0b9db13f7d10505c470759bce1145fae083b57ea29d3e1e46098d8899d550bb96d1865e10ef9e0591e9d592bfa05", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/707583fdad7c6e485c72938cf3e3e683c45632a787ef8d81504e6f3ffbcbef45fbefd26e1ab4d669d03dfcf77351f6a64c6f1c43504f4825655a359427fb7332", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08ce173ff1925fdb5a4624558c5783eca4dd98dec65ec279371da76cc314a6016e4172293ceaae1d966dcab532aa6b800505347486c98f1a7e386b14af466d9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1bca4729237dd5fc7050ee58edfa8f03095dbef5b207b3babce53944a2cda6bb1c1512b93e35e9398055e419576b8c87b6b0acbce50e8210d3fea49874021088"} 07:15:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:15:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:15:47 INFO - Contents: 07:15:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ebfaad560ea12c87746667f9464714153b7c0b9db13f7d10505c470759bce1145fae083b57ea29d3e1e46098d8899d550bb96d1865e10ef9e0591e9d592bfa05", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/707583fdad7c6e485c72938cf3e3e683c45632a787ef8d81504e6f3ffbcbef45fbefd26e1ab4d669d03dfcf77351f6a64c6f1c43504f4825655a359427fb7332", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08ce173ff1925fdb5a4624558c5783eca4dd98dec65ec279371da76cc314a6016e4172293ceaae1d966dcab532aa6b800505347486c98f1a7e386b14af466d9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1bca4729237dd5fc7050ee58edfa8f03095dbef5b207b3babce53944a2cda6bb1c1512b93e35e9398055e419576b8c87b6b0acbce50e8210d3fea49874021088"} 07:15:47 INFO - Running post-run listener: copy_logs_to_upload_dir 07:15:47 INFO - Copying logs to upload dir... 07:15:47 INFO - mkdir: /builds/slave/test/build/upload/logs 07:15:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.843567 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-05-26 07:15:47.494210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 07:15:47.497271) ========= 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.UhYQsh3vSj/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.lE6QEkUspG/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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/Mozilla-Beta/sha512/ebfaad560ea12c87746667f9464714153b7c0b9db13f7d10505c470759bce1145fae083b57ea29d3e1e46098d8899d550bb96d1865e10ef9e0591e9d592bfa05", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/707583fdad7c6e485c72938cf3e3e683c45632a787ef8d81504e6f3ffbcbef45fbefd26e1ab4d669d03dfcf77351f6a64c6f1c43504f4825655a359427fb7332", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08ce173ff1925fdb5a4624558c5783eca4dd98dec65ec279371da76cc314a6016e4172293ceaae1d966dcab532aa6b800505347486c98f1a7e386b14af466d9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1bca4729237dd5fc7050ee58edfa8f03095dbef5b207b3babce53944a2cda6bb1c1512b93e35e9398055e419576b8c87b6b0acbce50e8210d3fea49874021088"} build_url:https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/Qsj9cez2TO22LqODXr_bpw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ebfaad560ea12c87746667f9464714153b7c0b9db13f7d10505c470759bce1145fae083b57ea29d3e1e46098d8899d550bb96d1865e10ef9e0591e9d592bfa05", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/707583fdad7c6e485c72938cf3e3e683c45632a787ef8d81504e6f3ffbcbef45fbefd26e1ab4d669d03dfcf77351f6a64c6f1c43504f4825655a359427fb7332", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/08ce173ff1925fdb5a4624558c5783eca4dd98dec65ec279371da76cc314a6016e4172293ceaae1d966dcab532aa6b800505347486c98f1a7e386b14af466d9f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1bca4729237dd5fc7050ee58edfa8f03095dbef5b207b3babce53944a2cda6bb1c1512b93e35e9398055e419576b8c87b6b0acbce50e8210d3fea49874021088"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 07:15:47.531054) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 07:15:47.531379) ========= 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.UhYQsh3vSj/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.lE6QEkUspG/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.005137 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 07:15:47.579810) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 07:15:47.580191) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 07:15:47.580642) ========= ========= Total master_lag: 0.17 =========