builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0119 starttime: 1495213329.08 results: success (0) revision: 52b207e50972b74546b89775b6dd7c182ff6ff6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 10:02:09.076897) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 10:02:09.077448) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 10:02:09.077731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 10:02:09.103481) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 10:02:09.103861) ========= 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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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-19 10:02:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 56.7M=0s 2017-05-19 10:02:09 (56.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.226392 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 10:02:09.353521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 10:02:09.353829) ========= 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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.029015 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 10:02:09.403321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-19 10:02:09.403742) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 52b207e50972b74546b89775b6dd7c182ff6ff6a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 52b207e50972b74546b89775b6dd7c182ff6ff6a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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-19 10:02:09,496 truncating revision to first 12 chars 2017-05-19 10:02:09,496 Setting DEBUG logging. 2017-05-19 10:02:09,496 attempt 1/10 2017-05-19 10:02:09,496 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/52b207e50972?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-19 10:02:10,652 unpacking tar archive at: mozilla-central-52b207e50972/testing/mozharness/ program finished with exit code 0 elapsedTime=1.430340 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-19 10:02:10.862034) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 10:02:10.862392) ========= script_repo_revision: 52b207e50972b74546b89775b6dd7c182ff6ff6a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 10:02:10.872344) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 10:02:10.872712) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 10:02:10.892005) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-05-19 10:02:10.892362) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 10:02:11 INFO - MultiFileLogger online at 20170519 10:02:11 in /builds/slave/test 10:02:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:02:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:02:11 INFO - {'append_to_log': False, 10:02:11 INFO - 'base_work_dir': '/builds/slave/test', 10:02:11 INFO - 'blob_upload_branch': 'Firefox', 10:02:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:02:11 INFO - 'branch': 'Firefox', 10:02:11 INFO - 'buildbot_json_path': 'buildprops.json', 10:02:11 INFO - 'config_files': ('talos/mac_config.py',), 10:02:11 INFO - 'default_actions': ('clobber', 10:02:11 INFO - 'read-buildbot-config', 10:02:11 INFO - 'download-and-extract', 10:02:11 INFO - 'populate-webroot', 10:02:11 INFO - 'create-virtualenv', 10:02:11 INFO - 'install', 10:02:11 INFO - 'run-tests'), 10:02:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:02:11 INFO - 'download_minidump_stackwalk': True, 10:02:11 INFO - 'download_symbols': 'ondemand', 10:02:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:02:11 INFO - 'tooltool.py': '/tools/tooltool.py', 10:02:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:02:11 INFO - '/tools/misc-python/virtualenv.py')}, 10:02:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:02:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:02:11 INFO - 'gecko_profile': False, 10:02:11 INFO - 'gecko_profile_interval': 0, 10:02:11 INFO - 'installer_path': 'installer.exe', 10:02:11 INFO - 'log_level': 'info', 10:02:11 INFO - 'log_name': 'talos', 10:02:11 INFO - 'log_to_console': True, 10:02:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:02:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:02:11 INFO - 'opt_config_files': (), 10:02:11 INFO - 'pip_index': False, 10:02:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:02:11 INFO - 'cmd': ('bash', 10:02:11 INFO - '-c', 10:02:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:02:11 INFO - 'enabled': True, 10:02:11 INFO - 'halt_on_failure': False, 10:02:11 INFO - 'name': 'check_screen_resolution'},), 10:02:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:02:11 INFO - 'cmd': ('bash', 10:02:11 INFO - '-c', 10:02:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:02:11 INFO - 'enabled': True, 10:02:11 INFO - 'halt_on_failure': False, 10:02:11 INFO - 'name': 'check_screen_resolution'},), 10:02:11 INFO - 'run_cmd_checks_enabled': True, 10:02:11 INFO - 'suite': 'dromaeojs-e10s', 10:02:11 INFO - 'system_bits': '32', 10:02:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:02:11 INFO - 'title': 't-yosemite-r7-0119', 10:02:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:02:11 INFO - 'use_talos_json': True, 10:02:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:02:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:02:11 INFO - 'work_dir': 'build'} 10:02:11 INFO - [mozharness: 2017-05-19 17:02:11.100912Z] Running clobber step. 10:02:11 INFO - Running pre-action listener: _resource_record_pre_action 10:02:11 INFO - Running main action method: clobber 10:02:11 INFO - rmtree: /builds/slave/test/build 10:02:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:02:13 INFO - Running post-action listener: _resource_record_post_action 10:02:13 INFO - [mozharness: 2017-05-19 17:02:13.620639Z] Finished clobber step (success) 10:02:13 INFO - [mozharness: 2017-05-19 17:02:13.620768Z] Running read-buildbot-config step. 10:02:13 INFO - Running pre-action listener: _resource_record_pre_action 10:02:13 INFO - Running main action method: read_buildbot_config 10:02:13 INFO - Using buildbot properties: 10:02:13 INFO - { 10:02:13 INFO - "project": "", 10:02:13 INFO - "product": "firefox", 10:02:13 INFO - "who": "ryanvm@gmail.com", 10:02:13 INFO - "installer_path": "public/build/firefox-55.0a1.en-US.mac.dmg", 10:02:13 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:02:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:02:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:02:13 INFO - "stage_platform": "macosx64", 10:02:13 INFO - "basedir": "/builds/slave/test", 10:02:13 INFO - "buildnumber": 219, 10:02:13 INFO - "platform": "yosemite_r7", 10:02:13 INFO - "parent_task_id": "YxkcyhW1Q7qSonc-Ehz0Mw", 10:02:13 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 10:02:13 INFO - "slavebuilddir": "test", 10:02:13 INFO - "taskId": "BArxsk2-RT2XSDlrnlmOkg", 10:02:13 INFO - "branch": "mozilla-central", 10:02:13 INFO - "script_repo_revision": "production", 10:02:13 INFO - "revision": "52b207e50972b74546b89775b6dd7c182ff6ff6a", 10:02:13 INFO - "slavename": "t-yosemite-r7-0119", 10:02:13 INFO - "repo_path": "mozilla-central" 10:02:13 INFO - } 10:02:13 INFO - Finding installer, test and symbols from parent task. 10:02:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BArxsk2-RT2XSDlrnlmOkg'}, attempt #1 10:02:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BArxsk2-RT2XSDlrnlmOkg'}, attempt #1 10:02:14 INFO - Task dependencies: BnUXPDZvT529EZ-7mebBsg YxkcyhW1Q7qSonc-Ehz0Mw 10:02:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw'}, attempt #1 10:02:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:02:15 INFO - Set test_url: https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/test_packages.json 10:02:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/target.crashreporter-symbols.zip 10:02:15 INFO - Running post-action listener: _resource_record_post_action 10:02:15 INFO - [mozharness: 2017-05-19 17:02:15.368532Z] Finished read-buildbot-config step (success) 10:02:15 INFO - [mozharness: 2017-05-19 17:02:15.368679Z] Running download-and-extract step. 10:02:15 INFO - Running pre-action listener: _resource_record_pre_action 10:02:15 INFO - Running main action method: download_and_extract 10:02:15 INFO - mkdir: /builds/slave/test/build/tests 10:02:15 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')]} 10:02:15 INFO - trying https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 10:02:15 INFO - Downloading https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:02:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 10:02:16 INFO - Downloaded 1325 bytes. 10:02:16 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 10:02:16 INFO - Using the following test package requirements: 10:02:16 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:16 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 10:02:16 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:02:16 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:16 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 10:02:16 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:16 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 10:02:16 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:16 INFO - u'jsshell-mac.zip'], 10:02:16 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:16 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 10:02:16 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 10:02:16 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:16 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 10:02:16 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:16 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 10:02:16 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:16 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 10:02:16 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 10:02:16 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 10:02:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:02:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:02:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:02:16 INFO - Fetch https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:02:17 INFO - Content-Length response header: 56570683 10:02:17 INFO - Bytes received: 56570683 10:02:35 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 10:02:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 10:02:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 10:02:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 10:02:38 INFO - Content-Length response header: 56570683 10:02:38 INFO - Bytes received: 56570683 10:02:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 10:02:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 10:02:55 INFO - Fetch https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 10:02:55 INFO - Content-Length response header: 14410008 10:02:55 INFO - Bytes received: 14410008 10:02:56 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')]} 10:02:56 INFO - trying https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:02:56 INFO - Downloading https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 10:02:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 10:02:58 INFO - Downloaded 71651695 bytes. 10:02:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:02:58 INFO - mkdir: /builds/slave/test/properties 10:02:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:02:58 INFO - Writing to file /builds/slave/test/properties/build_url 10:02:58 INFO - Contents: 10:02:58 INFO - build_url:https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 10:02:58 INFO - Running post-action listener: _resource_record_post_action 10:02:58 INFO - Running post-action listener: set_extra_try_arguments 10:02:58 INFO - [mozharness: 2017-05-19 17:02:58.372159Z] Finished download-and-extract step (success) 10:02:58 INFO - [mozharness: 2017-05-19 17:02:58.372303Z] Running populate-webroot step. 10:02:58 INFO - Running pre-action listener: _resource_record_pre_action 10:02:58 INFO - Running main action method: populate_webroot 10:02:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:02:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:02:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:02:58 INFO - '--tppagecycles', 10:02:58 INFO - '7'], 10:02:58 INFO - 'tests': ['tsvgm']}}, 10:02:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:02:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:02:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:02:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:02:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:02:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:02:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:02:58 INFO - 'talos_options': ['--disable-e10s'], 10:02:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:02:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:02:58 INFO - 'talos_options': ['--disable-e10s'], 10:02:58 INFO - 'tests': ['damp', 'tps']}, 10:02:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:02:58 INFO - 'tests': ['damp', 'tps']}, 10:02:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:02:58 INFO - 'tests': ['dromaeo_dom']}, 10:02:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:02:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:02:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:02:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:02:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:02:58 INFO - 'tests': ['ts_paint', 'tp5o']}, 10:02:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:02:58 INFO - 'tests': ['a11yr', 10:02:58 INFO - 'ts_paint', 10:02:58 INFO - 'tpaint', 10:02:58 INFO - 'sessionrestore', 10:02:58 INFO - 'sessionrestore_no_auto_restore', 10:02:58 INFO - 'tabpaint']}, 10:02:58 INFO - 'other-e10s': {'tests': ['a11yr', 10:02:58 INFO - 'ts_paint', 10:02:58 INFO - 'tpaint', 10:02:58 INFO - 'sessionrestore', 10:02:58 INFO - 'sessionrestore_no_auto_restore', 10:02:58 INFO - 'tabpaint']}, 10:02:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:02:58 INFO - 'ts_paint', 10:02:58 INFO - 'tpaint', 10:02:58 INFO - 'sessionrestore', 10:02:58 INFO - 'sessionrestore_no_auto_restore', 10:02:58 INFO - 'tabpaint']}, 10:02:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:02:58 INFO - 'ts_paint', 10:02:58 INFO - 'tpaint', 10:02:58 INFO - 'sessionrestore', 10:02:58 INFO - 'sessionrestore_no_auto_restore', 10:02:58 INFO - 'tabpaint']}, 10:02:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:02:58 INFO - 'tests': ['a11yr', 10:02:58 INFO - 'ts_paint', 10:02:58 INFO - 'tpaint', 10:02:58 INFO - 'sessionrestore', 10:02:58 INFO - 'sessionrestore_no_auto_restore', 10:02:58 INFO - 'tabpaint']}, 10:02:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:02:58 INFO - 'tests': ['a11yr', 10:02:58 INFO - 'ts_paint', 10:02:58 INFO - 'tpaint', 10:02:58 INFO - 'sessionrestore', 10:02:58 INFO - 'sessionrestore_no_auto_restore', 10:02:58 INFO - 'tabpaint']}, 10:02:58 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:02:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:02:58 INFO - 'bloom_basic_ref']}, 10:02:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:02:58 INFO - 'tests': ['tsvgx', 10:02:58 INFO - 'tsvgr_opacity', 10:02:58 INFO - 'tart', 10:02:58 INFO - 'tscrollx', 10:02:58 INFO - 'cart', 10:02:58 INFO - 'tsvg_static']}, 10:02:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:02:58 INFO - 'tsvgr_opacity', 10:02:58 INFO - 'tart', 10:02:58 INFO - 'tscrollx', 10:02:58 INFO - 'cart', 10:02:58 INFO - 'tsvg_static']}, 10:02:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:02:58 INFO - 'talos_options': ['--disable-e10s'], 10:02:58 INFO - 'tests': ['tp5o']}, 10:02:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:02:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:02:58 INFO - 'talos_options': ['--disable-e10s', 10:02:58 INFO - '--xperf_path', 10:02:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:58 INFO - 'tests': ['tp5n']}, 10:02:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:02:58 INFO - 'talos_options': ['--xperf_path', 10:02:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:58 INFO - 'tests': ['tp5n']}}, 10:02:58 INFO - 'talos.zip': {'path': '', 10:02:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:02:58 INFO - Running post-action listener: _resource_record_post_action 10:02:58 INFO - [mozharness: 2017-05-19 17:02:58.393543Z] Finished populate-webroot step (success) 10:02:58 INFO - [mozharness: 2017-05-19 17:02:58.393703Z] Running create-virtualenv step. 10:02:58 INFO - Running pre-action listener: _resource_record_pre_action 10:02:58 INFO - Running main action method: create_virtualenv 10:02:58 INFO - Creating virtualenv /builds/slave/test/build/venv 10:02:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:02:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:02:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:02:58 INFO - Using real prefix '/tools/python27' 10:02:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:02:59 INFO - Installing distribute.............................................................................................................................................................................................done. 10:03:02 INFO - Installing pip.................done. 10:03:02 INFO - Return code: 0 10:03:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:03:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:03:02 INFO - Reading from file tmpfile_stdout 10:03:02 INFO - Output received: 10:03:02 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:03:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:03:02 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')]} 10:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:02 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')]} 10:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:03 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 0x1022d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe24a585210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe7d30>, '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 0x101f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fdcbe8>, '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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 10:03:03 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 10:03:03 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 10:03:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ3sSVc4HE/Render', 10:03:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:03 INFO - 'HOME': '/Users/cltbld', 10:03:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:03 INFO - 'LOGNAME': 'cltbld', 10:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:03 INFO - 'MOZ_NO_REMOTE': '1', 10:03:03 INFO - 'NO_EM_RESTART': '1', 10:03:03 INFO - 'PAGER': '/bin/cat', 10:03:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:03 INFO - 'PWD': '/builds/slave/test', 10:03:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:03 INFO - 'SHELL': '/bin/bash', 10:03:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSf9Wu86Vb/Listeners', 10:03:03 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 10:03:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:03 INFO - 'USER': 'cltbld', 10:03:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:03 INFO - 'XPC_FLAGS': '0x0', 10:03:03 INFO - 'XPC_SERVICE_NAME': '0', 10:03:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:03 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 10:03:03 INFO - Cleaning up... 10:03:03 INFO - Return code: 0 10:03:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:03: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')]} 10:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03: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')]} 10:03:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:03 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 0x1022d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe24a585210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe7d30>, '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 0x101f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fdcbe8>, '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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 10:03:03 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 10:03:03 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 10:03:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ3sSVc4HE/Render', 10:03:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:03 INFO - 'HOME': '/Users/cltbld', 10:03:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:03 INFO - 'LOGNAME': 'cltbld', 10:03:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:03 INFO - 'MOZ_NO_REMOTE': '1', 10:03:03 INFO - 'NO_EM_RESTART': '1', 10:03:03 INFO - 'PAGER': '/bin/cat', 10:03:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:03 INFO - 'PWD': '/builds/slave/test', 10:03:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:03 INFO - 'SHELL': '/bin/bash', 10:03:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSf9Wu86Vb/Listeners', 10:03:03 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 10:03:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:03 INFO - 'USER': 'cltbld', 10:03:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:03 INFO - 'XPC_FLAGS': '0x0', 10:03:03 INFO - 'XPC_SERVICE_NAME': '0', 10:03:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:04 INFO - Downloading/unpacking psutil>=3.1.1 10:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:03:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:06 INFO - Installing collected packages: psutil 10:03:06 INFO - Running setup.py install for psutil 10:03:06 INFO - building 'psutil._psutil_osx' extension 10:03:06 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 10:03:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 10:03:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 10:03:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 10:03:07 INFO - building 'psutil._psutil_posix' extension 10:03:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 10:03:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:03:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:03:07 INFO - ^ 10:03:07 INFO - 1 warning generated. 10:03:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 10:03:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:03:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:03:07 INFO - Successfully installed psutil 10:03:07 INFO - Cleaning up... 10:03:07 INFO - Return code: 0 10:03:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:03:07 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')]} 10:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:07 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')]} 10:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1022d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe24a585210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe7d30>, '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 0x101f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fdcbe8>, '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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 10:03:07 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 10:03:07 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 10:03:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ3sSVc4HE/Render', 10:03:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:07 INFO - 'HOME': '/Users/cltbld', 10:03:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:07 INFO - 'LOGNAME': 'cltbld', 10:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:07 INFO - 'MOZ_NO_REMOTE': '1', 10:03:07 INFO - 'NO_EM_RESTART': '1', 10:03:07 INFO - 'PAGER': '/bin/cat', 10:03:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:07 INFO - 'PWD': '/builds/slave/test', 10:03:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:07 INFO - 'SHELL': '/bin/bash', 10:03:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSf9Wu86Vb/Listeners', 10:03:07 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 10:03:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:07 INFO - 'USER': 'cltbld', 10:03:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:07 INFO - 'XPC_FLAGS': '0x0', 10:03:07 INFO - 'XPC_SERVICE_NAME': '0', 10:03:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:03:08 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 10:03:08 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 10:03:08 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 10:03:08 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 10:03:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:03:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:03:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:03:09 INFO - Installing collected packages: mozsystemmonitor 10:03:09 INFO - Running setup.py install for mozsystemmonitor 10:03:09 INFO - Successfully installed mozsystemmonitor 10:03:09 INFO - Cleaning up... 10:03:09 INFO - Return code: 0 10:03:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:03:09 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')]} 10:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:09 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')]} 10:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:09 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 0x1022d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe24a585210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe7d30>, '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 0x101f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fdcbe8>, '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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 10:03:09 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 10:03:09 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 10:03:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ3sSVc4HE/Render', 10:03:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:09 INFO - 'HOME': '/Users/cltbld', 10:03:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:09 INFO - 'LOGNAME': 'cltbld', 10:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:09 INFO - 'MOZ_NO_REMOTE': '1', 10:03:09 INFO - 'NO_EM_RESTART': '1', 10:03:09 INFO - 'PAGER': '/bin/cat', 10:03:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:09 INFO - 'PWD': '/builds/slave/test', 10:03:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:09 INFO - 'SHELL': '/bin/bash', 10:03:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSf9Wu86Vb/Listeners', 10:03:09 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 10:03:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:09 INFO - 'USER': 'cltbld', 10:03:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:09 INFO - 'XPC_FLAGS': '0x0', 10:03:09 INFO - 'XPC_SERVICE_NAME': '0', 10:03:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:09 INFO - Downloading/unpacking jsonschema==2.5.1 10:03:09 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 10:03:09 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 10:03:09 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 10:03:09 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 10:03:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:03:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:03:11 INFO - Downloading functools32-3.2.3-2.tar.gz 10:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:03:11 INFO - warning: no files found matching '*.txt' 10:03:11 INFO - no previously-included directories found matching 'build' 10:03:11 INFO - no previously-included directories found matching 'dist' 10:03:11 INFO - no previously-included directories found matching '.git*' 10:03:11 INFO - Installing collected packages: jsonschema, functools32 10:03:11 INFO - Running setup.py install for functools32 10:03:11 INFO - warning: no files found matching '*.txt' 10:03:11 INFO - no previously-included directories found matching 'build' 10:03:11 INFO - no previously-included directories found matching 'dist' 10:03:11 INFO - no previously-included directories found matching '.git*' 10:03:11 INFO - Successfully installed jsonschema functools32 10:03:11 INFO - Cleaning up... 10:03:11 INFO - Return code: 0 10:03:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:03:11 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')]} 10:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:11 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')]} 10:03:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:12 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 0x1022d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe24a585210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe7d30>, '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 0x101f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fdcbe8>, '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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 10:03:12 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 10:03:12 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 10:03:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ3sSVc4HE/Render', 10:03:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:12 INFO - 'HOME': '/Users/cltbld', 10:03:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:12 INFO - 'LOGNAME': 'cltbld', 10:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:12 INFO - 'MOZ_NO_REMOTE': '1', 10:03:12 INFO - 'NO_EM_RESTART': '1', 10:03:12 INFO - 'PAGER': '/bin/cat', 10:03:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:12 INFO - 'PWD': '/builds/slave/test', 10:03:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:12 INFO - 'SHELL': '/bin/bash', 10:03:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSf9Wu86Vb/Listeners', 10:03:12 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 10:03:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:12 INFO - 'USER': 'cltbld', 10:03:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:12 INFO - 'XPC_FLAGS': '0x0', 10:03:12 INFO - 'XPC_SERVICE_NAME': '0', 10:03:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:03:12 INFO - Cleaning up... 10:03:12 INFO - Return code: 0 10:03:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:03:12 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')]} 10:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:12 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')]} 10:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:12 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 0x1022d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe24a585210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe7d30>, '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 0x101f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fdcbe8>, '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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 10:03:12 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 10:03:12 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 10:03:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ3sSVc4HE/Render', 10:03:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:12 INFO - 'HOME': '/Users/cltbld', 10:03:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:12 INFO - 'LOGNAME': 'cltbld', 10:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:12 INFO - 'MOZ_NO_REMOTE': '1', 10:03:12 INFO - 'NO_EM_RESTART': '1', 10:03:12 INFO - 'PAGER': '/bin/cat', 10:03:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:12 INFO - 'PWD': '/builds/slave/test', 10:03:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:12 INFO - 'SHELL': '/bin/bash', 10:03:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSf9Wu86Vb/Listeners', 10:03:12 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 10:03:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:12 INFO - 'USER': 'cltbld', 10:03:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:12 INFO - 'XPC_FLAGS': '0x0', 10:03:12 INFO - 'XPC_SERVICE_NAME': '0', 10:03:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:12 INFO - Downloading/unpacking blobuploader==1.2.4 10:03:12 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 10:03:12 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 10:03:12 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 10:03:12 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 10:03:13 INFO - Downloading blobuploader-1.2.4.tar.gz 10:03:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:03:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:03:14 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 10:03:14 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 10:03:14 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 10:03:14 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 10:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:03:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:03:14 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 10:03:14 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 10:03:14 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 10:03:14 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 10:03:14 INFO - Downloading docopt-0.6.1.tar.gz 10:03:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:03:14 INFO - Installing collected packages: blobuploader, requests, docopt 10:03:14 INFO - Running setup.py install for blobuploader 10:03:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:03:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:03:15 INFO - Running setup.py install for requests 10:03:15 INFO - Running setup.py install for docopt 10:03:15 INFO - Successfully installed blobuploader requests docopt 10:03:15 INFO - Cleaning up... 10:03:15 INFO - Return code: 0 10:03:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03:15 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')]} 10:03:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:15 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')]} 10:03:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:15 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 0x1022d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe24a585210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe7d30>, '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 0x101f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fdcbe8>, '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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 10:03:15 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 10:03:15 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 10:03:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ3sSVc4HE/Render', 10:03:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:15 INFO - 'HOME': '/Users/cltbld', 10:03:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:15 INFO - 'LOGNAME': 'cltbld', 10:03:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:15 INFO - 'MOZ_NO_REMOTE': '1', 10:03:15 INFO - 'NO_EM_RESTART': '1', 10:03:15 INFO - 'PAGER': '/bin/cat', 10:03:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:15 INFO - 'PWD': '/builds/slave/test', 10:03:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:15 INFO - 'SHELL': '/bin/bash', 10:03:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSf9Wu86Vb/Listeners', 10:03:15 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 10:03:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:15 INFO - 'USER': 'cltbld', 10:03:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:15 INFO - 'XPC_FLAGS': '0x0', 10:03:15 INFO - 'XPC_SERVICE_NAME': '0', 10:03:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:03:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-emZ7Oz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:03:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-y5Ftt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:03:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-vgkWEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:03:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-QjWGDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:03:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-5YhkCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:03:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-aQj_bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:03:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-cz9wyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:03:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-52SL0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:03:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-4mdhj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:03:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:03:16 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-tnrar0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:03:17 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-M1flXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:03:17 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-9j9oB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:03:17 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-n3YQlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:03:17 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-FYgMG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:17 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-2jEXir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:03:17 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-QN5yTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:03:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:03:17 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-lC5dbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:03:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:03:17 INFO - Running setup.py install for manifestparser 10:03:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:03:17 INFO - Running setup.py install for mozcrash 10:03:18 INFO - Running setup.py install for mozdebug 10:03:18 INFO - Running setup.py install for mozdevice 10:03:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:03:18 INFO - Running setup.py install for mozfile 10:03:18 INFO - Running setup.py install for mozhttpd 10:03:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:03:18 INFO - Running setup.py install for mozinfo 10:03:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:03:18 INFO - Running setup.py install for mozInstall 10:03:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:03:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:03:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:03:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:03:18 INFO - Running setup.py install for mozleak 10:03:19 INFO - Running setup.py install for mozlog 10:03:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:03:19 INFO - Running setup.py install for moznetwork 10:03:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:03:19 INFO - Running setup.py install for mozprocess 10:03:19 INFO - Running setup.py install for mozprofile 10:03:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:03:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:03:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:03:19 INFO - Running setup.py install for mozrunner 10:03:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:03:19 INFO - Running setup.py install for mozscreenshot 10:03:20 INFO - Running setup.py install for moztest 10:03:20 INFO - Running setup.py install for mozversion 10:03:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:03:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:03:20 INFO - Cleaning up... 10:03:20 INFO - Return code: 0 10:03:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03:20 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')]} 10:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03:20 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')]} 10:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:20 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 0x1022d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe24a585210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe7d30>, '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 0x101f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fdcbe8>, '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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 10:03:20 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 10:03:20 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 10:03:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ3sSVc4HE/Render', 10:03:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:20 INFO - 'HOME': '/Users/cltbld', 10:03:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:20 INFO - 'LOGNAME': 'cltbld', 10:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:20 INFO - 'MOZ_NO_REMOTE': '1', 10:03:20 INFO - 'NO_EM_RESTART': '1', 10:03:20 INFO - 'PAGER': '/bin/cat', 10:03:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:20 INFO - 'PWD': '/builds/slave/test', 10:03:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:20 INFO - 'SHELL': '/bin/bash', 10:03:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSf9Wu86Vb/Listeners', 10:03:20 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 10:03:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:20 INFO - 'USER': 'cltbld', 10:03:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:20 INFO - 'XPC_FLAGS': '0x0', 10:03:20 INFO - 'XPC_SERVICE_NAME': '0', 10:03:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:03:20 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-5ligVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:03:20 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)) 10:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:03:20 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-jVOylZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:03:20 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)) 10:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:03:20 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-1MMQ8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:03:20 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)) 10:03:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:03:20 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-idrmPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:03:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 10:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:03:21 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-m9YAJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:03:21 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)) 10:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:03:21 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-zzb6Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:03:21 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)) 10:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:03:21 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-JYFQY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:03:21 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)) 10:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:03:21 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-Hep8_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:03:21 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)) 10:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:03:21 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-C3GRik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:03:21 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)) 10:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:03:21 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-L0hMOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:03:21 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)) 10:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:03:21 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-6V0jbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:03:21 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)) 10:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:03:21 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-t0kogH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:03:21 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)) 10:03:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:03:21 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-AtNvyK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:03:22 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)) 10:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:03:22 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-csIx7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:03:22 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)) 10:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:22 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-51WPen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:03:22 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)) 10:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:03:22 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-ePjOiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:03:22 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)) 10:03:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:03:22 INFO - Running setup.py (path:/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/pip-rhCldS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:03:22 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)) 10:03:22 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)) 10:03:22 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)) 10:03:22 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)) 10:03:22 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:03:22 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:03:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:03:22 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 10:03:22 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 10:03:22 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 10:03:22 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 10:03:23 INFO - Downloading blessings-1.6.tar.gz 10:03:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:03:23 INFO - Installing collected packages: blessings 10:03:23 INFO - Running setup.py install for blessings 10:03:24 INFO - Successfully installed blessings 10:03:24 INFO - Cleaning up... 10:03:24 INFO - Return code: 0 10:03:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:03:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:24 INFO - Reading from file tmpfile_stdout 10:03:24 INFO - Current package versions: 10:03:24 INFO - blessings == 1.6 10:03:24 INFO - blobuploader == 1.2.4 10:03:24 INFO - docopt == 0.6.1 10:03:24 INFO - functools32 == 3.2.3-2 10:03:24 INFO - jsonschema == 2.5.1 10:03:24 INFO - manifestparser == 1.1 10:03:24 INFO - mozInstall == 1.12 10:03:24 INFO - mozcrash == 1.0 10:03:24 INFO - mozdebug == 0.1 10:03:24 INFO - mozdevice == 0.50 10:03:24 INFO - mozfile == 1.2 10:03:24 INFO - mozhttpd == 0.7 10:03:24 INFO - mozinfo == 0.9 10:03:24 INFO - mozleak == 0.1 10:03:24 INFO - mozlog == 3.4 10:03:24 INFO - moznetwork == 0.27 10:03:24 INFO - mozprocess == 0.25 10:03:24 INFO - mozprofile == 0.28 10:03:24 INFO - mozrunner == 6.13 10:03:24 INFO - mozscreenshot == 0.1 10:03:24 INFO - mozsystemmonitor == 0.3 10:03:24 INFO - moztest == 0.8 10:03:24 INFO - mozversion == 1.4 10:03:24 INFO - psutil == 3.1.1 10:03:24 INFO - requests == 1.2.3 10:03:24 INFO - wsgiref == 0.1.2 10:03:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:03: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')]} 10:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03: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')]} 10:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03:24 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 0x1022d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe24a585210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe7d30>, '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 0x101f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fdcbe8>, '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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 10:03:24 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 10:03:24 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 10:03:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ3sSVc4HE/Render', 10:03:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:24 INFO - 'HOME': '/Users/cltbld', 10:03:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:24 INFO - 'LOGNAME': 'cltbld', 10:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:24 INFO - 'MOZ_NO_REMOTE': '1', 10:03:24 INFO - 'NO_EM_RESTART': '1', 10:03:24 INFO - 'PAGER': '/bin/cat', 10:03:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:24 INFO - 'PWD': '/builds/slave/test', 10:03:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:24 INFO - 'SHELL': '/bin/bash', 10:03:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSf9Wu86Vb/Listeners', 10:03:24 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 10:03:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:24 INFO - 'USER': 'cltbld', 10:03:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:24 INFO - 'XPC_FLAGS': '0x0', 10:03:24 INFO - 'XPC_SERVICE_NAME': '0', 10:03:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:24 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)) 10:03:24 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)) 10:03:24 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)) 10:03:24 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)) 10:03:24 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)) 10:03:24 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)) 10:03:24 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)) 10:03:24 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)) 10:03:24 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)) 10:03:24 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)) 10:03:24 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)) 10:03:24 INFO - Cleaning up... 10:03:24 INFO - Return code: 0 10:03:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:03: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')]} 10:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:03: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')]} 10:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:03: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1022d7b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1022db768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe24a585210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101fe7d30>, '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 0x101f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fdcbe8>, '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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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 10:03: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', 'jsonschema'] in /builds/slave/test/build 10:03: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 jsonschema 10:03:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ3sSVc4HE/Render', 10:03:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:24 INFO - 'HOME': '/Users/cltbld', 10:03:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:24 INFO - 'LOGNAME': 'cltbld', 10:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:24 INFO - 'MOZ_NO_REMOTE': '1', 10:03:24 INFO - 'NO_EM_RESTART': '1', 10:03:24 INFO - 'PAGER': '/bin/cat', 10:03:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:24 INFO - 'PWD': '/builds/slave/test', 10:03:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:24 INFO - 'SHELL': '/bin/bash', 10:03:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSf9Wu86Vb/Listeners', 10:03:24 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 10:03:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:24 INFO - 'USER': 'cltbld', 10:03:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:24 INFO - 'XPC_FLAGS': '0x0', 10:03:24 INFO - 'XPC_SERVICE_NAME': '0', 10:03:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:03:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:03:24 INFO - Cleaning up... 10:03:24 INFO - Return code: 0 10:03:24 INFO - Running post-action listener: _resource_record_post_action 10:03:24 INFO - Running post-action listener: _start_resource_monitoring 10:03:24 INFO - Starting resource monitoring. 10:03:24 INFO - [mozharness: 2017-05-19 17:03:24.980867Z] Finished create-virtualenv step (success) 10:03:24 INFO - [mozharness: 2017-05-19 17:03:24.981825Z] Running install step. 10:03:24 INFO - Running pre-action listener: _resource_record_pre_action 10:03:24 INFO - Running main action method: install 10:03:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:03:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:03:25 INFO - Reading from file tmpfile_stdout 10:03:25 INFO - Detecting whether we're running mozinstall >=1.0... 10:03:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:03:25 INFO - Reading from file tmpfile_stdout 10:03:25 INFO - Output received: 10:03:25 INFO - Usage: mozinstall [options] installer 10:03:25 INFO - Options: 10:03:25 INFO - -h, --help show this help message and exit 10:03:25 INFO - -d DEST, --destination=DEST 10:03:25 INFO - Directory to install application into. [default: 10:03:25 INFO - "/builds/slave/test"] 10:03:25 INFO - --app=APP Application being installed. [default: firefox] 10:03:25 INFO - mkdir: /builds/slave/test/build/application 10:03:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:03:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 10:03:47 INFO - Reading from file tmpfile_stdout 10:03:47 INFO - Output received: 10:03:47 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 10:03:47 INFO - Running post-action listener: _resource_record_post_action 10:03:47 INFO - [mozharness: 2017-05-19 17:03:47.700507Z] Finished install step (success) 10:03:47 INFO - [mozharness: 2017-05-19 17:03:47.700660Z] Running run-tests step. 10:03:47 INFO - Running pre-action listener: _resource_record_pre_action 10:03:47 INFO - Running main action method: run_tests 10:03:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:03:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:03:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:03:47 INFO - 2017-05-19 10:03:47.715 screenresolution[1627:7459] starting screenresolution argv=screenresolution get 10:03:47 INFO - 2017-05-19 10:03:47.718 screenresolution[1627:7459] Display 0: 1600x1200x32@60 10:03:47 INFO - 2017-05-19 10:03:47.724 screenresolution[1628:7461] starting screenresolution argv=screenresolution list 10:03:47 INFO - Available Modes on Display 0 10:03:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:03:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:03:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:03:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:03:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:03:47 INFO - Intel Iris: 10:03:47 INFO - Chipset Model: Intel Iris 10:03:47 INFO - Type: GPU 10:03:47 INFO - Bus: Built-In 10:03:47 INFO - VRAM (Dynamic, Max): 1536 MB 10:03:47 INFO - Vendor: Intel (0x8086) 10:03:47 INFO - Device ID: 0x0a2e 10:03:47 INFO - Revision ID: 0x0009 10:03:47 INFO - Displays: 10:03:47 INFO - Display: 10:03:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:03:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:03:47 INFO - Display Serial Number: 1600x1200 60 10:03:47 INFO - Main Display: Yes 10:03:47 INFO - Mirror: Off 10:03:47 INFO - Online: Yes 10:03:47 INFO - Rotation: Supported 10:03:47 INFO - Return code: 0 10:03:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:03:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:03:47 INFO - Python 2.7.3 10:03:47 INFO - Return code: 0 10:03:47 INFO - grabbing minidump binary from tooltool 10:03:47 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')]} 10:03:47 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 0x101fe7d30>, '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 0x101f9bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101fdcbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:03:47 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 10:03:47 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 10:03:47 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 10:03:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:03:48 INFO - Return code: 0 10:03:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:03:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:03:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:03:48 INFO - ENV: RUST_BACKTRACE is now 1 10:03:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:03:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:03:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--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 10:03:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/target.crashreporter-symbols.zip --title t-yosemite-r7-0119 --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 10:03:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RZ3sSVc4HE/Render', 10:03:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:03:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:03:48 INFO - 'HOME': '/Users/cltbld', 10:03:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:03:48 INFO - 'LOGNAME': 'cltbld', 10:03:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:03:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:48 INFO - 'MOZ_NO_REMOTE': '1', 10:03:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:03:48 INFO - 'NO_EM_RESTART': '1', 10:03:48 INFO - 'PAGER': '/bin/cat', 10:03:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:48 INFO - 'PWD': '/builds/slave/test', 10:03:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:03:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:03:48 INFO - 'RUST_BACKTRACE': '1', 10:03:48 INFO - 'SHELL': '/bin/bash', 10:03:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.kSf9Wu86Vb/Listeners', 10:03:48 INFO - 'TMPDIR': '/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/', 10:03:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:03:48 INFO - 'USER': 'cltbld', 10:03:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:03:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:48 INFO - 'XPC_FLAGS': '0x0', 10:03:48 INFO - 'XPC_SERVICE_NAME': '0', 10:03:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:03:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0119', '--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 10:03:48 INFO - mozversion application_buildid: 20170519084251 10:03:48 INFO - mozversion application_changeset: 52b207e50972b74546b89775b6dd7c182ff6ff6a 10:03:48 INFO - mozversion application_display_name: Nightly 10:03:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:03:48 INFO - mozversion application_name: Firefox 10:03:48 INFO - mozversion application_remotingname: firefox 10:03:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:03:48 INFO - mozversion application_vendor: Mozilla 10:03:48 INFO - mozversion application_version: 55.0a1 10:03:48 INFO - mozversion platform_buildid: 20170519084251 10:03:48 INFO - mozversion platform_changeset: 52b207e50972b74546b89775b6dd7c182ff6ff6a 10:03:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:03:48 INFO - mozversion platform_version: 55.0a1 10:03:48 INFO - using testdate: 1495213428 10:03:48 INFO - actual date: 1495213428 10:03:48 INFO - starting webserver on 'localhost:49230' 10:03:48 INFO - SUITE-START | Running 2 tests 10:03:48 INFO - TEST-START | dromaeo_css 10:03:48 INFO - operating with platform_type : mac_ 10:03:48 INFO - Initialising browser for dromaeo_css test... 10:03:48 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpUafoPa/profile http://localhost:49230/getInfo.html) 10:03:48 INFO - PID 1638 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 10:03:50 INFO - PID 1638 | 2017-05-19 10:03:50.876 plugin-container[1643:7706] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4e47, name = 'com.apple.tsm.portname' 10:03:50 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:03:50 INFO - PID 1638 | 2017-05-19 10:03:50.879 plugin-container[1643:7706] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0xa30b, name = 'com.apple.CFPasteboardClient' 10:03:50 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:03:50 INFO - PID 1638 | 2017-05-19 10:03:50.879 plugin-container[1643:7706] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:03:50 INFO - PID 1638 | __metrics Screen width/height:1600/1200 10:03:50 INFO - PID 1638 | colorDepth:24 10:03:50 INFO - PID 1638 | Browser inner width/height: 1024/691 10:03:50 INFO - PID 1638 | __metrics 10:03:51 INFO - PID 1638 | 2017-05-19 10:03:51.554 plugin-container[1644:7761] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9543, name = 'com.apple.tsm.portname' 10:03:51 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:03:51 INFO - PID 1638 | 2017-05-19 10:03:51.555 plugin-container[1644:7761] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 10:03:51 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:03:51 INFO - PID 1638 | 2017-05-19 10:03:51.555 plugin-container[1644:7761] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:03:52 INFO - TEST-INFO | 1638: exit 0 10:03:52 INFO - Browser initialized. 10:03:52 INFO - Running cycle 1/1 for dromaeo_css test... 10:03:52 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmpUafoPa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:53 INFO - PID 1645 | 2017-05-19 10:03:53.960 plugin-container[1646:7855] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4947, name = 'com.apple.tsm.portname' 10:03:53 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:03:53 INFO - PID 1645 | 2017-05-19 10:03:53.961 plugin-container[1646:7855] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9e0b, name = 'com.apple.CFPasteboardClient' 10:03:53 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:03:53 INFO - PID 1645 | 2017-05-19 10:03:53.961 plugin-container[1646:7855] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:03:54 INFO - PID 1645 | 2017-05-19 10:03:54.648 plugin-container[1647:7903] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4847, name = 'com.apple.tsm.portname' 10:03:54 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:03:54 INFO - PID 1645 | 2017-05-19 10:03:54.648 plugin-container[1647:7903] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9713, name = 'com.apple.CFPasteboardClient' 10:03:54 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:03:54 INFO - PID 1645 | 2017-05-19 10:03:54.648 plugin-container[1647:7903] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:04:04 INFO - PID 1645 | RSS: Main: 239665152 10:04:04 INFO - PID 1645 | 10:07:07 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49230/tests/dromaeo/cssquery-ext.html) 10:07:08 INFO - PID 1645 | RSS: Main: 262475776 10:07:08 INFO - PID 1645 | 10:10:10 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-ext.html (next: http://localhost:49230/tests/dromaeo/cssquery-jquery.html) 10:10:11 INFO - PID 1645 | RSS: Main: 270704640 10:10:11 INFO - PID 1645 | 10:13:12 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49230/tests/dromaeo/cssquery-mootools.html) 10:13:13 INFO - PID 1645 | RSS: Main: 275288064 10:13:13 INFO - PID 1645 | 10:16:15 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49230/tests/dromaeo/cssquery-prototype.html) 10:16:15 INFO - PID 1645 | RSS: Main: 273391616 10:16:15 INFO - PID 1645 | 10:19:18 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49230/tests/dromaeo/cssquery-yui.html) 10:19:19 INFO - PID 1645 | RSS: Main: 274972672 10:19:19 INFO - PID 1645 | 10:22:21 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49230/tests/dromaeo/cssquery-yui.html (next: http://localhost:49230/tests/dromaeo/cssquery-dojo.html) 10:22:21 INFO - PID 1645 | RSS: Main: 276447232 10:22:21 INFO - PID 1645 | 10:22:21 INFO - PID 1645 | __start_tp_report 10:22:21 INFO - PID 1645 | _x_x_mozilla_page_load 10:22:21 INFO - PID 1645 | _x_x_mozilla_page_load_details 10:22:21 INFO - PID 1645 | |i|pagename|runs| 10:22:21 INFO - PID 1645 | |0;dojo.html;3545.3441113394015;3588.7129029677644;3611.3499570077374;3622.4385220290847;3624.9637503624963;6117.401149625505;6194.7831825886105;6228.781992630247;6232.501399888004;6243.906341404882;6114.601521188694;6154.753809847612;6204.751809927598;6214.906776398347;6279.340669229734;5355.277037599933;5357.4374690657505;5417.7291135443265;5450.264214331074;5454.045542030149;5498.642588231772;5559.444055594448;5576.275084239043;5609.775608975636;5612.859678508029;5378.193271009341;5477.397486276506;5526.751296191641;5552.666839989593;5568.136938774476;5402.486763757437;5452.2094296327205;5458.372287186945;5474;5498.972505137449;5430.809921652763;5452.482014208684;5477.863053423656;5480.534154596864;5488.53347465466;4915.9754201229125;5303.443138470444;6027.849303767397;6280.089387038899;6313.431791138773;6425.1647285853005;6582.3417658234275;6637.601743895333;6714.395704386579;6758.256591774901;6816.07982922309;6839.897401538981;6861.1080559526945;6863.656817159172;6871.072405225281;5724.427557244284;6299.748010079637;6325.683715814191;6326.304106548276;6334.1765570475545;6761.8647627047185;6846.281140480278;6849;7011.263817299212;7044.049053377831;5044.646874718735;5587.944120558743;6673.699683514254;6685.09751183584;6686.1642294713165;6588.505862060365;6742.696578653972;6835.726570937107;6848.589084654936;6862.3137686230975;5554.444555544414;6428.903566446507;6547.672616369163;6600.273969863311;6719.496037797185;6769.323067693192;6771.52599318043;6775.4918381121615;6776.559523630948;6823.1812182538415;5397.784088636489;5404.621676482609;5418.1330987042675;5431.891362172734;5464.590155738336;3999.580044095328;4748.738819364969;4764.309175169581;4802.567768900815;4883.731394773251;6399.04014397844;6400.103985442041;6426;6441.742330306735;6461.676916154173;6769.763058292936;6854.657267136623;6856.760013399507;6870.175578930461;6891.069705589782;5175.585953123741;6382.074599183093;6388.968055159695;6416.973284274493;6425.293217746044;5880.558958078076;5992.790252341147;6064.514838812885;6089.391060893964;6131.96934015336;7072.646367681596;7077.610731409719;7085.6457177141965;7096.148462184571;7101.680424380812;6786.830329241809;6856.177258728984;6900.447964162955;6908.516403851883;6921.826954326182;5588.608797384144;6758.7296508139125;6780.93219067803;6963.9651801740665;7036.612986285599;6346.619202847844;6356.968215158895;6766.15423072116;6769.830754231184;6782.084418603623;5929.932612129858;6643.60138391698;6743.426808721314;6764.763233286812;6882.931170688229;6307.842303942254;6418.133551970611;6472.223333200046;6627.37039981201;6650.83372915681;6506.967465162644;6582.3746744059235;6600.174978127734;6615.4376877965915;6634.535582509371;5972.731227094878;6278.46633036197;6501.2523559791225;6518.217813862367;6533.118029066015;6364.681765911779;6558.704858281293;6655.201375834931;6664.733410663713;6667.699953502201;6263.123162757127;6504.772332968512;6529.118568993125;6531.706073226811;6547.312532184052 10:22:21 INFO - PID 1645 | |1;ext.html;796.1043825696092;810.2909953790434;835.4861760017587;1220.8657047724748;1253.7179134694688;32642.836785816096;36153;37640.43539346905;38832.805835970816;39287.41068883969;38645.61354386455;38891.611083889155;38970.83087507379;39045.70497245301;39231.803840980756;7596.848063038749;7729.922700772977;8133.210693647388;8321.334293256525;8331.66673333066;7244.927550724505;8105.554194519299;8179.345652347798;8221.218984196492;8306.584670766468;8259.710910118147;8318.45930014547;8334.87497687532;8347.248747612713;8353.164683531659;8217.917820821805;8299.626516806758;8327;8331.16688331162;8344.499330040217;8134.877976830352;8140.877886831702;8154.3884208684585;8159;8162.8368482352225;30410.391792164253;31292.53061204084;37149;37233;37261.62738372609;3548.6983606393487;3555.9111022224392;3596.3706351388664;3597.6402359764074;3599.5680518337704;29713.851430742925;29933.70066299331;30019.69980300191;30067.398652027056;30387.392252155056;3079.430305393487;3109.440300745865;3120.3603261331373;3133;3136.4197623439736;303078;304730;315131.1217219565;318831.9999999977;319396;47291.05417891623;47980.760096199294;48014.759926200146;48025.75987120042;48191;48947.755261223465;48976;48997;49032;49126.50873491291;13302.068855180045;13508.12197207198;13509.729805403837;13536.323183840768;13662.795058074136;9386.67146649864;11014.063804576701;11047.226694131494;11144.2199046066;11210.551577936954;12759.362031898369;12855.742885142245;12956.28740419286;12970.675733106747;13116.934415327862;5093.261477085802;5093.465186155475;5988.970055149696;5990.550708696778;6083.422074902877;1012.792377562598;1033.478093562761;1049.317943336837;1064.2709743825503;1066.589363095214;19531.51171220731;23511.529769404515;24490.755092448846;24609.876950615133;24634;1127.2729089737074;1130.1298000539539;1132.5130194016651;1138.5047504335641;1168.2990205876406;12368.44342004612;12452.439640216213;12470.43883025266;12498.750024999448;12543.184692994926;323473;323845.3807730946;324769.1284630732;325556;326996;50833.23750143751;50986;51396.22905656418;51422.74288628533;51478.48521514812;1488.159190057614;1516.6587517808625;1552.2006166824094;1562.6952744214768;1568.443202663061;17434.9128254363;20380.08289627;21452.927353632567;21619.675704864756;22373.888130559244;33757.66242337545;37372.06569835776;37465;37493.625063749016;37536.812315938245;274077;275510;275600;275838;276538;33423.16442088967;34338.82830585831;35547.11132221715;35674.18398516167;35882.64117358793;39154.23805928797;39589.60410395974;43849;45019.87450313768;45039.54960450353;25357.74642253554;30181.396372072875;30247;30771.384572308878;31033.379332412773;28551;29446.705532945252;30749.538756918217;31004.069877903697;31226.375472490876;36543.81728091343;37317.25365492621;37715.81142094272;37800.62199377971;37815.43276850905;30031.798728050635;30606.693933061277;30973.535396969513;31268.68731312658;31682.366352673278;23205.88397058004;24034.158804441762;24474.388140296636;24612.384690382885;24837.895263092112 10:22:21 INFO - PID 1645 | |2;jquery.html;434.83258945306045;441.4327589048074;443.2442685221697;459.125366177432;461.6399208617278;21358.35924922251;21835.454113647145;22246.332610021705;23213.651795223086;23579.764202357972;23071.653925191134;23530.411739706517;23925.76074239257;24259.878700606474;24617.261482155518;6459.257185423666;6532.706028228741;6638.668066596675;6663.9333606663795;6665.666716664172;6435.806925792233;6520.31536688648;6626.337366263383;6626.939689649657;6634.038064480647;6694.765683201089;6704.994250862385;6787.219469760967;6791.694373753168;6824;6547.639879806608;6709.194896612414;6750.291219421939;6755.594664320157;6757.729690812411;6373.235211774617;6564.081028655992;6602.504812139109;6604.900926486107;6620.470362371047;29059;29276.51149652282;29538.26154346137;29782.55326170109;30185.396292074256;2215.6233440315186;2268.387535365442;2284.942876428086;2285.9428514287274;2289.782470665284;18588.62822743551;18706.345277915345;18741.96919169445;19188.328408505637;19410.4176874694;2274.1358283852196;2300.3903965449167;2352.2590384028977;2359.1035406545575;2360.6104992676187;131075.34462327627;171789;173917;174392;174859.25140748557;19947.800521994886;23949.640755388682;24330.756692433202;24646;25333.493330133293;41894.16211675749;42032.57967420348;42109.78945105316;42121;42427;10462.63380781669;10705.785884282272;10866.989606922745;10943.507542160622;11007.394593297446;7657.272559106876;8023.438359314909;8463.66145354179;8560.443571167854;8686.609102590399;10236.078752912124;10637.308574942605;11346.205765596495;11366.033887119522;11572.710682233012;4455.371330914776;4569.109023740339;4573.199690054227;4580.648708630962;4603.148417542765;947.9715608531756;957.8323793336277;971.8590804333332;980.7106903463496;996.7707427291764;16426.260818263207;18169.45491635253;19981.300654477312;20620.27829025977;21058.578828423346;862.7454900804278;972.8103019911049;988.1008282463068;995.4127065031666;1014.0923873133504;10660.413677247825;10894.128469722404;10928.781424371467;10933.726656833484;10977.890221097847;430089.8495507502;535416;538934;552732.4726752761;554602;104889.27866695919;109344;111340;113772;123653;1110.3726394587034;1130.8360287758394;1149.2816989381636;1150.9021733152608;1151.8502594662807;17595;18147.81852181514;18181.909090454465;18322;18447.631047379247;42417.30330786858;53125;53637;54502.45497545132;54683.437987441765;72115.63942180255;73975.8903616457;74019.25980740123;74091.25908740844;74660;11561.826572601249;12672.366381681064;12688.429020693906;12794.680132996376;13088.803667944798;11010.39442830652;13435.12671676338;13697.109687870257;13932.442702292201;14156.50452234167;11522.308661480338;11712.590059347882;11962.940185299018;11998.700032499257;12044.457999389873;9168.404053736485;10915.781684366428;10953.507092181031;11308.717282068013;11496;9579.377340472847;11387.0321022714;12291.631251062483;12298.692532686397;12372.938135309267;8707.782305442415;8792.47245165292;8880.911190888266;9194.12655797698;9220.677276295297;11653.359065251492;11692.298462092302;11860.051195904134;11940.880591194324;12063.276203427822 10:22:21 INFO - PID 1645 | |3;mootools.html;1156.2599936040933;1433.6057584164353;1436.432609119398;1437.187988786335;1449.3767679897644;9306.627734890604;11408.429578521082;11664.00855927246;11975.64073077808;12072.973797227247;11766.235194712337;11790.764184716301;11928.761424771521;11965.940170299136;12042.096842736808;2535.2521006303186;2573.665423494943;2580.2775222937607;2584.147231413629;2586.0690151545427;2477.7770000699934;2520.332111990324;2534.3664083979006;2538.581134112869;2546.4270539128734;2505.023041014006;2522.9495410091786;2527.747225277467;2533.3413312538783;2536.1377131775193;2455.914043008495;2473.4063824682034;2499.350168956066;2504.3864253257884;2510.1716433576967;2434.539276434143;2457.8402403843693;2516.7609077137645;2524.3058159006237;2527.772500474966;9237.445753254826;10088.848667269996;11522.539098436053;11545.307281563133;11562.826557601642;5603.187537807036;6464.321246269168;6698.363655452724;6702.932970670328;6703;3271.5419841222247;3621.818909054563;4233.449651545279;4287.121140166259;4372.672049596293;1218.3238302741975;1224.124750803171;1257.0509265504577;1258.5028913579085;1260.810878368243;12717.872821271761;15494.767578486331;15888.04671719689;15914.283857226452;16034.919825400915;5818.359980402152;5937.584369094208;6071.119687645355;6095.207623008981;6130.264368275835;11962.880371196177;12658.683532911751;13461.528846490326;13495.865041349658;13510.459581616822;6665.733370665119;6710.496712746563;6715.093462382613;6725.596464212163;6726.562773419712;5854.326752423441;6109.450149486479;6119.2350956130485;6164.106204600308;6193.256809182837;4548.658850586153;4650.093231819763;4654.301854721819;4676.812927482931;4708;1315.9210447373189;1446.985530144685;1457.234951650392;1476.0922032949659;1484.2485866677425;769.4421544380391;783.2441693765544;788.9566073865877;796.474326944214;797.2744802229943;6558.311377305409;6872.484563657646;6965.965170174117;7194.028806111212;7228.855422891513;809.283783851284;884.2881480408205;924.8335299645994;943.1794338925179;950.3632566180676;3704.3147017801793;3997.780122093313;4217.283061879488;4223.260929337353;4372.278574035248;14301.141931484144;14570.05294655844;14721.190334531704;14729.779053314209;14739;14067.155970641794;14352;14577;14603.634909127144;14614.415423383158;7363.226861179606;7632.274933881384;8229.95885020571;8375.162483751697;8447.32421406286;6584.572002819801;6817.454603631599;6859.314068593101;6894.8621027580175;6996.160460744743;12571.497140114294;12766.425510851848;12906.290154041619;12965.740685186433;13273.933630331787;13122.934385328012;13215.801762973371;13300.667483312995;13538.661533461742;13624.86375136236;8929.151730585583;9174.724758257264;9311.627534898798;9422.246220302222;9433.151016408556;10809.729756756144;10941.28881622692;10952.616658416917;10962.287451315638;10967.561297548009;7492.587907665131;8792.956035219782;9074.818503629758;9111;9195.540222988957;7356;8765.34259930495;8850.070742571937;8891.155340242667;8953.194212520904;7975.960120199594;7984.20157984197;8073.596320184085;8075.798105047421;8136.471129376809;5066.59467242627;5931.3178984417345;6024.608400453956;6049.909251361145;6241.687915604292;6039.094135879477;6090.299615544269;6210.875782484415;6247.68761561911;6340.587861788969 10:22:21 INFO - PID 1645 | |4;prototype.html;349.734202006475;394.176171800936;394.47534778744273;400.3714168755056;408.41392601616684;4294.957050429495;6103.748731510041;6145.508359331248;6303.716332765025;6437.2918978912285;5394.433584473622;5595.524380427659;6193.163922870411;6264.185655864742;6276.843078923029;3800.429935509668;4527.547245275479;4603;4621.976890115545;4623;3666.3767159582803;4633.7063153738945;4641.443026836768;4654.348391225214;4659.207934651117;4261.637760790337;4596.747178905159;4618.838340658078;4629.699069560468;4642.373279607244;3550;4237.894052648678;4365.668471116308;4639.675222734427;4641.976790116045;3908.511436070491;3908.902277443058;3917.98041009796;3925.3130702127014;3944.36890097583;6204.224471941007;6215.72577621591;6223.159873417076;6228.477466626024;6234.812955611339;4805.951940480585;5315.767377701375;5425.907232877262;5459.389480103379;5518.91721624176;6159.784407545759;6769.120014398146;6772.559783614099;6803.516716398529;6821.249662537117;3907.355286377744;4435.578620031092;4437.2013037653205;4440.2895536714295;4444.177827101997;5513.3108361454815;5607.233721377753;6868.501131758706;6951.582905025664;7194.064771579713;4367.912641747211;4500.964778101055;4501.7524036177665;4502.16709908668;4522.909541809211;4575.725456472623;4578.291583817052;4581.496035436099;4588.151192029485;4589.931151032737;4693.95306046942;5235.869103272373;5343.171808369709;5392.272043274186;5489.890202195934;5876.353601103875;6786.219584747719;6796.184457864989;6807.570410213911;6831.633673265367;1532;1552.7205103081553;1553.4640549010574;1554.3083327919194;1563.1715190948814;975.8243516167016;983.9016098390103;1013.0983424751977;1019.6686077024997;1023.1661196125134;6203.503719702413;6211.689415529206;6419.903701444482;6477.77327793525;6484.967575162094;6322.336154703782;6415.358464153547;6542.691461707677;6783.559068660521;6962.651867406609;5169.974150129226;6410.519211059189;6446.387593178641;6503.739850406026;6525.934740652628;3538.221591249921;3598.2908118643436;3653.611627581502;3673.2102597941034;3689.8524059037873;7141.178764442156;7211.3870321023305;7246.130464344313;7249.673764680602;7249.96375018132;6964.825879353057;7208.819779505449;7231.168415632164;7239.89140162898;7274.418046556263;7111.395531379787;7142.535735177197;7181.210066892638;7186.1376634804155;7223.602701851449;5438.809641662523;5723.914141287967;5827.679477628772;7050.461833739747;7050.964745176241;6599.868002640016;6857.211420686485;6908.1364829396325;6931.861362772817;6943.79168624942;7081.858362832818;7292.307230813064;7293;7307.817304567428;7308.817279567841;4196.622303992655;4353.978230108829;4503.5138404327145;4525.420510309093;4549;5644;6783.896991932516;7026.156861176692;7104.467164962752;7166.856662866818;5951.940480595139;6856.6228857413325;6876.484263680344;6877.071595334566;6879.3120687930805;6558;6591.472682185509;6859.485538584726;6871.759488417882;6899.448044156556;5027.3464449621315;5634.4365563443325;6114.379689382228;6657.467402607683;6745.258021617717;5990.940090599038;6113.51091912637;6473.902891456538;6688.097106890702;6823.829404264933;5544.445555444423;6031.36670649593;6188.257409110755;6587.934120658732;6717.193936727428 10:22:21 INFO - PID 1645 | |5;yui.html;777.2577188784704;848.5799529233028;852.4075767341697;855.392671203446;874.9300055995519;12607.873921260785;14347.928260358683;14982.550523484286;16744.246508907097;17148.657026859455;16695.582610434743;17261.30954761811;17443.3022679093;17508.21213045413;17845.196966136522;996.3025881882675;1004.372267332917;1011.9677928512913;1013.4729940430972;1015.8730158730159;1013.9746506337364;1018.1549314069305;1019.765453945593;1022.4734261855151;1025.2208321675505;1061.946902654864;1068.2468859454066;1078.0890147825114;1079.7408621930758;1080.9081228095622;1060.4432672846779;1062.2511129653576;1063.648995831374;1065.6802959112313;1066.9573217071309;766.8159641686011;784.1178673991759;786.9921300786976;787.8345547435046;787.9645415956296;16793.32826686931;17191.91404042984;17400.39098631542;17410.825891741046;17450.825491745047;16397.262123204484;16677.166141692865;17015.319387224496;17213.913930430266;17255.568610784707;14081.225532595703;14305.570832874926;14336.64158396038;14477.71044579113;14482.275886205647;3417.0603084151808;3446.9310613787584;3455.153487395579;3493.0917961329983;3495.828897319401;109852;122107.77892221053;128382;129794.99999999905;131613.68386316206;12192.695182620506;12262.693432664255;12276.508939642314;12288.877111228774;12304.261744295192;20807;20972.11250987388;21150.153993840075;21192;21213;6176.320604733476;6689.364510371507;7962.681492740341;8133.918660813434;8140.633671484798;3934.5868683788362;3961.6632586230494;4013.2174226026227;4015.1768887378016;4015.5181378234215;3448.637788073747;4166.208420400114;4275.209086318979;4281.614654681093;4284.271673815459;870.2863651805459;892.7009451833578;895.4806212396794;901.2699713232172;902.3052249767774;653.5359894474881;660.2044536333707;661.2461793555351;665.1220389086457;701.8210356359198;10307.896921030693;11365.204435689422;11574.826377604342;11609.245399049034;12083.879161208275;656.4026735670517;669.4075742967411;669.4844969373555;677.8542613338058;688.9379955804002;4486.910261794746;5308.522232999048;5668.461496157858;5720;5772.480476757112;89752.20495590051;103165;105271;110159;111973;92754;95388.09223815484;96108.55837162449;96717;97094.51452742833;86436;86777.1322286769;87628;88000.55999720088;89003;9075.954620226856;10815.083646125866;11206.551737930391;11416.257943233662;11542.422878856192;35019.82490087635;36538.26923461569;39520.407193892686;40143.799281004576;41086.589134108275;64220;66930.66534667296;68583.28541786496;69232.34595675541;71209;15570.377184912477;16495.9175204128;16833.989960602405;17113.14434278256;17315.82684173142;14982.700345992802;17870.91064544669;18394.94950503957;18749.812501875353;18790.248390064244;16569.337226510805;16817.831821681626;17138.742918855976;17438.9128054364;17546.122693865513;13691;17092.97442153475;17355.56611084733;17420.390286339916;17643.647127057644;16433.67132657364;17023.808333417037;17108.91445542814;17121.315147393965;17224.82775172232;11798.11514136426;11854.644360669194;12080.577179799016;12196.81704774447;12519.812202817147;13152.671183220496;13622.182669039888;13703.862961370658;13717.314134293445;13736.244506552235 10:22:21 INFO - PID 1645 | __end_tp_report 10:22:21 INFO - PID 1645 | __start_cc_report 10:22:21 INFO - PID 1645 | _x_x_mozilla_cycle_collect,340 10:22:21 INFO - PID 1645 | __end_cc_report 10:22:21 INFO - PID 1645 | __startTimestamp1495214541391__endTimestamp 10:22:21 INFO - PID 1645 | 10:22:21 INFO - PID 1645 | ------- Summary: start ------- 10:22:21 INFO - PID 1645 | Number of tests: 6 10:22:21 INFO - PID 1645 | 10:22:21 INFO - PID 1645 | [#0] dojo.html Cycles:165 Average:6170.36 Median:6416.97 stddev:762.23 (11.9%) stddev-sans-first:736.23 10:22:21 INFO - PID 1645 | Values: 3545.3 3588.7 3611.3 3622.4 3625.0 6117.4 6194.8 6228.8 6232.5 6243.9 6114.6 6154.8 6204.8 6214.9 6279.3 5355.3 5357.4 5417.7 5450.3 5454.0 5498.6 5559.4 5576.3 5609.8 5612.9 5378.2 5477.4 5526.8 5552.7 5568.1 5402.5 5452.2 5458.4 5474.0 5499.0 5430.8 5452.5 5477.9 5480.5 5488.5 4916.0 5303.4 6027.8 6280.1 6313.4 6425.2 6582.3 6637.6 6714.4 6758.3 6816.1 6839.9 6861.1 6863.7 6871.1 5724.4 6299.7 6325.7 6326.3 6334.2 6761.9 6846.3 6849.0 7011.3 7044.0 5044.6 5587.9 6673.7 6685.1 6686.2 6588.5 6742.7 6835.7 6848.6 6862.3 5554.4 6428.9 6547.7 6600.3 6719.5 6769.3 6771.5 6775.5 6776.6 6823.2 5397.8 5404.6 5418.1 5431.9 5464.6 3999.6 4748.7 4764.3 4802.6 4883.7 6399.0 6400.1 6426.0 6441.7 6461.7 6769.8 6854.7 6856.8 6870.2 6891.1 5175.6 6382.1 6389.0 6417.0 6425.3 5880.6 5992.8 6064.5 6089.4 6132.0 7072.6 7077.6 7085.6 7096.1 7101.7 6786.8 6856.2 6900.4 6908.5 6921.8 5588.6 6758.7 6780.9 6964.0 7036.6 6346.6 6357.0 6766.2 6769.8 6782.1 5929.9 6643.6 6743.4 6764.8 6882.9 6307.8 6418.1 6472.2 6627.4 6650.8 6507.0 6582.4 6600.2 6615.4 6634.5 5972.7 6278.5 6501.3 6518.2 6533.1 6364.7 6558.7 6655.2 6664.7 6667.7 6263.1 6504.8 6529.1 6531.7 6547.3 10:22:21 INFO - PID 1645 | 10:22:21 INFO - PID 1645 | [#1] ext.html Cycles:180 Average:44984.31 Median:325162.56 stddev:80086.46 (24.6%) stddev-sans-first:80242.40 10:22:21 INFO - PID 1645 | Values: 796.1 810.3 835.5 1220.9 1253.7 32642.8 36153.0 37640.4 38832.8 39287.4 38645.6 38891.6 38970.8 39045.7 39231.8 7596.8 7729.9 8133.2 8321.3 8331.7 7244.9 8105.6 8179.3 8221.2 8306.6 8259.7 8318.5 8334.9 8347.2 8353.2 8217.9 8299.6 8327.0 8331.2 8344.5 8134.9 8140.9 8154.4 8159.0 8162.8 30410.4 31292.5 37149.0 37233.0 37261.6 3548.7 3555.9 3596.4 3597.6 3599.6 29713.9 29933.7 30019.7 30067.4 30387.4 3079.4 3109.4 3120.4 3133.0 3136.4 303078.0 304730.0 315131.1 318832.0 319396.0 47291.1 47980.8 48014.8 48025.8 48191.0 48947.8 48976.0 48997.0 49032.0 49126.5 13302.1 13508.1 13509.7 13536.3 13662.8 9386.7 11014.1 11047.2 11144.2 11210.6 12759.4 12855.7 12956.3 12970.7 13116.9 5093.3 5093.5 5989.0 5990.6 6083.4 1012.8 1033.5 1049.3 1064.3 1066.6 19531.5 23511.5 24490.8 24609.9 24634.0 1127.3 1130.1 1132.5 1138.5 1168.3 12368.4 12452.4 12470.4 12498.8 12543.2 323473.0 323845.4 324769.1 325556.0 326996.0 50833.2 50986.0 51396.2 51422.7 51478.5 1488.2 1516.7 1552.2 1562.7 1568.4 17434.9 20380.1 21452.9 21619.7 22373.9 33757.7 37372.1 37465.0 37493.6 37536.8 274077.0 275510.0 275600.0 275838.0 276538.0 33423.2 34338.8 35547.1 35674.2 35882.6 39154.2 39589.6 43849.0 45019.9 45039.5 25357.7 30181.4 30247.0 30771.4 31033.4 28551.0 29446.7 30749.5 31004.1 31226.4 36543.8 37317.3 37715.8 37800.6 37815.4 30031.8 30606.7 30973.5 31268.7 31682.4 23205.9 24034.2 24474.4 24612.4 24837.9 10:22:21 INFO - PID 1645 | 10:22:21 INFO - PID 1645 | [#2] jquery.html Cycles:180 Average:35867.58 Median:2359.86 stddev:89088.96 (3775.2%) stddev-sans-first:89299.16 10:22:21 INFO - PID 1645 | Values: 434.8 441.4 443.2 459.1 461.6 21358.4 21835.5 22246.3 23213.7 23579.8 23071.7 23530.4 23925.8 24259.9 24617.3 6459.3 6532.7 6638.7 6663.9 6665.7 6435.8 6520.3 6626.3 6626.9 6634.0 6694.8 6705.0 6787.2 6791.7 6824.0 6547.6 6709.2 6750.3 6755.6 6757.7 6373.2 6564.1 6602.5 6604.9 6620.5 29059.0 29276.5 29538.3 29782.6 30185.4 2215.6 2268.4 2284.9 2285.9 2289.8 18588.6 18706.3 18742.0 19188.3 19410.4 2274.1 2300.4 2352.3 2359.1 2360.6 131075.3 171789.0 173917.0 174392.0 174859.3 19947.8 23949.6 24330.8 24646.0 25333.5 41894.2 42032.6 42109.8 42121.0 42427.0 10462.6 10705.8 10867.0 10943.5 11007.4 7657.3 8023.4 8463.7 8560.4 8686.6 10236.1 10637.3 11346.2 11366.0 11572.7 4455.4 4569.1 4573.2 4580.6 4603.1 948.0 957.8 971.9 980.7 996.8 16426.3 18169.5 19981.3 20620.3 21058.6 862.7 972.8 988.1 995.4 1014.1 10660.4 10894.1 10928.8 10933.7 10977.9 430089.8 535416.0 538934.0 552732.5 554602.0 104889.3 109344.0 111340.0 113772.0 123653.0 1110.4 1130.8 1149.3 1150.9 1151.9 17595.0 18147.8 18181.9 18322.0 18447.6 42417.3 53125.0 53637.0 54502.5 54683.4 72115.6 73975.9 74019.3 74091.3 74660.0 11561.8 12672.4 12688.4 12794.7 13088.8 11010.4 13435.1 13697.1 13932.4 14156.5 11522.3 11712.6 11962.9 11998.7 12044.5 9168.4 10915.8 10953.5 11308.7 11496.0 9579.4 11387.0 12291.6 12298.7 12372.9 8707.8 8792.5 8880.9 9194.1 9220.7 11653.4 11692.3 11860.1 11940.9 12063.3 10:22:21 INFO - PID 1645 | 10:22:21 INFO - PID 1645 | [#3] mootools.html Cycles:180 Average:7033.27 Median:3851.05 stddev:4364.50 (113.3%) stddev-sans-first:4354.39 10:22:21 INFO - PID 1645 | Values: 1156.3 1433.6 1436.4 1437.2 1449.4 9306.6 11408.4 11664.0 11975.6 12073.0 11766.2 11790.8 11928.8 11965.9 12042.1 2535.3 2573.7 2580.3 2584.1 2586.1 2477.8 2520.3 2534.4 2538.6 2546.4 2505.0 2522.9 2527.7 2533.3 2536.1 2455.9 2473.4 2499.4 2504.4 2510.2 2434.5 2457.8 2516.8 2524.3 2527.8 9237.4 10088.8 11522.5 11545.3 11562.8 5603.2 6464.3 6698.4 6702.9 6703.0 3271.5 3621.8 4233.4 4287.1 4372.7 1218.3 1224.1 1257.1 1258.5 1260.8 12717.9 15494.8 15888.0 15914.3 16034.9 5818.4 5937.6 6071.1 6095.2 6130.3 11962.9 12658.7 13461.5 13495.9 13510.5 6665.7 6710.5 6715.1 6725.6 6726.6 5854.3 6109.5 6119.2 6164.1 6193.3 4548.7 4650.1 4654.3 4676.8 4708.0 1315.9 1447.0 1457.2 1476.1 1484.2 769.4 783.2 789.0 796.5 797.3 6558.3 6872.5 6966.0 7194.0 7228.9 809.3 884.3 924.8 943.2 950.4 3704.3 3997.8 4217.3 4223.3 4372.3 14301.1 14570.1 14721.2 14729.8 14739.0 14067.2 14352.0 14577.0 14603.6 14614.4 7363.2 7632.3 8230.0 8375.2 8447.3 6584.6 6817.5 6859.3 6894.9 6996.2 12571.5 12766.4 12906.3 12965.7 13273.9 13122.9 13215.8 13300.7 13538.7 13624.9 8929.2 9174.7 9311.6 9422.2 9433.2 10809.7 10941.3 10952.6 10962.3 10967.6 7492.6 8793.0 9074.8 9111.0 9195.5 7356.0 8765.3 8850.1 8891.2 8953.2 7976.0 7984.2 8073.6 8075.8 8136.5 5066.6 5931.3 6024.6 6049.9 6241.7 6039.1 6090.3 6210.9 6247.7 6340.6 10:22:21 INFO - PID 1645 | 10:22:21 INFO - PID 1645 | [#4] prototype.html Cycles:180 Average:5395.53 Median:6108.63 stddev:1735.05 (28.4%) stddev-sans-first:1698.08 10:22:21 INFO - PID 1645 | Values: 349.7 394.2 394.5 400.4 408.4 4295.0 6103.7 6145.5 6303.7 6437.3 5394.4 5595.5 6193.2 6264.2 6276.8 3800.4 4527.5 4603.0 4622.0 4623.0 3666.4 4633.7 4641.4 4654.3 4659.2 4261.6 4596.7 4618.8 4629.7 4642.4 3550.0 4237.9 4365.7 4639.7 4642.0 3908.5 3908.9 3918.0 3925.3 3944.4 6204.2 6215.7 6223.2 6228.5 6234.8 4806.0 5315.8 5425.9 5459.4 5518.9 6159.8 6769.1 6772.6 6803.5 6821.2 3907.4 4435.6 4437.2 4440.3 4444.2 5513.3 5607.2 6868.5 6951.6 7194.1 4367.9 4501.0 4501.8 4502.2 4522.9 4575.7 4578.3 4581.5 4588.2 4589.9 4694.0 5235.9 5343.2 5392.3 5489.9 5876.4 6786.2 6796.2 6807.6 6831.6 1532.0 1552.7 1553.5 1554.3 1563.2 975.8 983.9 1013.1 1019.7 1023.2 6203.5 6211.7 6419.9 6477.8 6485.0 6322.3 6415.4 6542.7 6783.6 6962.7 5170.0 6410.5 6446.4 6503.7 6525.9 3538.2 3598.3 3653.6 3673.2 3689.9 7141.2 7211.4 7246.1 7249.7 7250.0 6964.8 7208.8 7231.2 7239.9 7274.4 7111.4 7142.5 7181.2 7186.1 7223.6 5438.8 5723.9 5827.7 7050.5 7051.0 6599.9 6857.2 6908.1 6931.9 6943.8 7081.9 7292.3 7293.0 7307.8 7308.8 4196.6 4354.0 4503.5 4525.4 4549.0 5644.0 6783.9 7026.2 7104.5 7166.9 5951.9 6856.6 6876.5 6877.1 6879.3 6558.0 6591.5 6859.5 6871.8 6899.4 5027.3 5634.4 6114.4 6657.5 6745.3 5990.9 6113.5 6473.9 6688.1 6823.8 5544.4 6031.4 6188.3 6587.9 6717.2 10:22:21 INFO - PID 1645 | 10:22:21 INFO - PID 1645 | [#5] yui.html Cycles:180 Average:22162.23 Median:17429.65 stddev:31603.15 (181.3%) stddev-sans-first:31651.01 10:22:21 INFO - PID 1645 | Values: 777.3 848.6 852.4 855.4 874.9 12607.9 14347.9 14982.6 16744.2 17148.7 16695.6 17261.3 17443.3 17508.2 17845.2 996.3 1004.4 1012.0 1013.5 1015.9 1014.0 1018.2 1019.8 1022.5 1025.2 1061.9 1068.2 1078.1 1079.7 1080.9 1060.4 1062.3 1063.6 1065.7 1067.0 766.8 784.1 787.0 787.8 788.0 16793.3 17191.9 17400.4 17410.8 17450.8 16397.3 16677.2 17015.3 17213.9 17255.6 14081.2 14305.6 14336.6 14477.7 14482.3 3417.1 3446.9 3455.2 3493.1 3495.8 109852.0 122107.8 128382.0 129795.0 131613.7 12192.7 12262.7 12276.5 12288.9 12304.3 20807.0 20972.1 21150.2 21192.0 21213.0 6176.3 6689.4 7962.7 8133.9 8140.6 3934.6 3961.7 4013.2 4015.2 4015.5 3448.6 4166.2 4275.2 4281.6 4284.3 870.3 892.7 895.5 901.3 902.3 653.5 660.2 661.2 665.1 701.8 10307.9 11365.2 11574.8 11609.2 12083.9 656.4 669.4 669.5 677.9 688.9 4486.9 5308.5 5668.5 5720.0 5772.5 89752.2 103165.0 105271.0 110159.0 111973.0 92754.0 95388.1 96108.6 96717.0 97094.5 86436.0 86777.1 87628.0 88000.6 89003.0 9076.0 10815.1 11206.6 11416.3 11542.4 35019.8 36538.3 39520.4 40143.8 41086.6 64220.0 66930.7 68583.3 69232.3 71209.0 15570.4 16495.9 16834.0 17113.1 17315.8 14982.7 17870.9 18394.9 18749.8 18790.2 16569.3 16817.8 17138.7 17438.9 17546.1 13691.0 17093.0 17355.6 17420.4 17643.6 16433.7 17023.8 17108.9 17121.3 17224.8 11798.1 11854.6 12080.6 12196.8 12519.8 13152.7 13622.2 13703.9 13717.3 13736.2 10:22:21 INFO - PID 1645 | -------- Summary: end -------- 10:22:21 INFO - PID 1645 | 10:22:22 INFO - TEST-INFO | 1645: exit 0 10:22:22 INFO - TEST-OK | dromaeo_css | took 1113827ms 10:22:22 INFO - TEST-START | kraken 10:22:22 INFO - operating with platform_type : mac_ 10:22:22 INFO - Initialising browser for kraken test... 10:22:22 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmp3Uwf7k/profile http://localhost:49230/getInfo.html) 10:22:22 INFO - PID 1659 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 10:22:24 INFO - PID 1659 | 2017-05-19 10:22:24.617 plugin-container[1660:10410] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x993f, name = 'com.apple.tsm.portname' 10:22:24 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:24 INFO - PID 1659 | 2017-05-19 10:22:24.620 plugin-container[1660:10410] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9e0f, name = 'com.apple.CFPasteboardClient' 10:22:24 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:24 INFO - PID 1659 | 2017-05-19 10:22:24.620 plugin-container[1660:10410] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:22:24 INFO - PID 1659 | __metrics Screen width/height:1600/1200 10:22:24 INFO - PID 1659 | colorDepth:24 10:22:24 INFO - PID 1659 | Browser inner width/height: 1024/691 10:22:24 INFO - PID 1659 | __metrics 10:22:25 INFO - TEST-INFO | 1659: exit 0 10:22:25 INFO - Browser initialized. 10:22:25 INFO - Running cycle 1/1 for kraken test... 10:22:25 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/T/tmp3Uwf7k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:22:27 INFO - PID 1662 | 2017-05-19 10:22:27.557 plugin-container[1663:10552] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x963f, name = 'com.apple.tsm.portname' 10:22:27 INFO - PID 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:27 INFO - PID 1662 | 2017-05-19 10:22:27.558 plugin-container[1663:10552] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9b0b, name = 'com.apple.CFPasteboardClient' 10:22:27 INFO - PID 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:27 INFO - PID 1662 | 2017-05-19 10:22:27.558 plugin-container[1663:10552] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:22:28 INFO - PID 1662 | 2017-05-19 10:22:28.309 plugin-container[1664:10600] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x454b, name = 'com.apple.tsm.portname' 10:22:28 INFO - PID 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:28 INFO - PID 1662 | 2017-05-19 10:22:28.310 plugin-container[1664:10600] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9c0b, name = 'com.apple.CFPasteboardClient' 10:22:28 INFO - PID 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:22:28 INFO - PID 1662 | 2017-05-19 10:22:28.310 plugin-container[1664:10600] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:22:37 INFO - PID 1662 | RSS: Main: 240332800 10:22:37 INFO - PID 1662 | 10:22:40 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-beat-detection) 10:22:41 INFO - PID 1662 | RSS: Main: 251514880 10:22:41 INFO - PID 1662 | 10:22:43 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-dft) 10:22:44 INFO - PID 1662 | RSS: Main: 260489216 10:22:44 INFO - PID 1662 | 10:22:47 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-fft) 10:22:48 INFO - PID 1662 | RSS: Main: 263561216 10:22:48 INFO - PID 1662 | 10:22:50 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49230/tests/kraken/driver.html?testName=audio-oscillator) 10:22:50 INFO - PID 1662 | RSS: Main: 265846784 10:22:50 INFO - PID 1662 | 10:22:52 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49230/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:22:53 INFO - PID 1662 | RSS: Main: 266207232 10:22:53 INFO - PID 1662 | 10:22:56 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49230/tests/kraken/driver.html?testName=imaging-darkroom) 10:22:56 INFO - PID 1662 | RSS: Main: 276684800 10:22:56 INFO - PID 1662 | 10:22:59 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49230/tests/kraken/driver.html?testName=imaging-desaturate) 10:23:00 INFO - PID 1662 | RSS: Main: 276262912 10:23:00 INFO - PID 1662 | 10:23:03 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49230/tests/kraken/driver.html?testName=json-parse-financial) 10:23:04 INFO - PID 1662 | RSS: Main: 275509248 10:23:04 INFO - PID 1662 | 10:23:05 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49230/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:23:06 INFO - PID 1662 | RSS: Main: 275279872 10:23:06 INFO - PID 1662 | 10:23:07 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:23:08 INFO - PID 1662 | RSS: Main: 275140608 10:23:08 INFO - PID 1662 | 10:23:10 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:23:11 INFO - PID 1662 | RSS: Main: 275283968 10:23:11 INFO - PID 1662 | 10:23:14 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:23:14 INFO - PID 1662 | RSS: Main: 275046400 10:23:14 INFO - PID 1662 | 10:23:17 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:23:18 INFO - PID 1662 | RSS: Main: 275353600 10:23:18 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | Cycle 1(1): loaded http://localhost:49230/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49230/tests/kraken/driver.html?testName=ai-astar) 10:23:20 INFO - PID 1662 | RSS: Main: 277016576 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | __start_tp_report 10:23:20 INFO - PID 1662 | _x_x_mozilla_page_load 10:23:20 INFO - PID 1662 | _x_x_mozilla_page_load_details 10:23:20 INFO - PID 1662 | |i|pagename|runs| 10:23:20 INFO - PID 1662 | |0;ai-astar;103;114;117;115;114;113;114;115;114;115 10:23:20 INFO - PID 1662 | |1;audio-beat-detection;139;113;113;153;114;128;114;111;141;115 10:23:20 INFO - PID 1662 | |2;audio-dft;196;195;195;196;200;206;224;202;202;196 10:23:20 INFO - PID 1662 | |3;audio-fft;80;57;61;85;63;65;63;60;81;59 10:23:20 INFO - PID 1662 | |4;audio-oscillator;85;71;82;71;69;70;91;54;65;94 10:23:20 INFO - PID 1662 | |5;imaging-gaussian-blur;89;90;89;89;99;90;90;91;90;89 10:23:20 INFO - PID 1662 | |6;imaging-darkroom;98;99;97;98;97;97;130;97;111;149 10:23:20 INFO - PID 1662 | |7;imaging-desaturate;93;96;93;92;94;91;90;92;90;91 10:23:20 INFO - PID 1662 | |8;json-parse-financial;50;48;54;52;64;45;46;66;74;77 10:23:20 INFO - PID 1662 | |9;json-stringify-tinderbox;55;63;58;58;59;58;55;57;56;58 10:23:20 INFO - PID 1662 | |10;stanford-crypto-aes;84;82;80;81;82;84;83;86;84;81 10:23:20 INFO - PID 1662 | |11;stanford-crypto-ccm;128;137;141;155;153;148;154;132;187;155 10:23:20 INFO - PID 1662 | |12;stanford-crypto-pbkdf2;188;183;183;180;180;202;181;191;182;187 10:23:20 INFO - PID 1662 | |13;stanford-crypto-sha256-iterative;70;67;71;69;67;90;103;67;70;70 10:23:20 INFO - PID 1662 | __end_tp_report 10:23:20 INFO - PID 1662 | __start_cc_report 10:23:20 INFO - PID 1662 | _x_x_mozilla_cycle_collect,920 10:23:20 INFO - PID 1662 | __end_cc_report 10:23:20 INFO - PID 1662 | __startTimestamp1495214600564__endTimestamp 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | ------- Summary: start ------- 10:23:20 INFO - PID 1662 | Number of tests: 14 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:3.81 (3.3%) stddev-sans-first:1.13 10:23:20 INFO - PID 1662 | Values: 103.0 114.0 117.0 115.0 114.0 113.0 114.0 115.0 114.0 115.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:121.50 stddev:15.14 (12.5%) stddev-sans-first:15.07 10:23:20 INFO - PID 1662 | Values: 139.0 113.0 113.0 153.0 114.0 128.0 114.0 111.0 141.0 115.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#2] audio-dft Cycles:10 Average:201.20 Median:201.00 stddev:8.84 (4.4%) stddev-sans-first:9.18 10:23:20 INFO - PID 1662 | Values: 196.0 195.0 195.0 196.0 200.0 206.0 224.0 202.0 202.0 196.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#3] audio-fft Cycles:10 Average:67.40 Median:64.00 stddev:10.39 (16.2%) stddev-sans-first:9.97 10:23:20 INFO - PID 1662 | Values: 80.0 57.0 61.0 85.0 63.0 65.0 63.0 60.0 81.0 59.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#4] audio-oscillator Cycles:10 Average:75.20 Median:76.50 stddev:12.47 (16.3%) stddev-sans-first:12.71 10:23:20 INFO - PID 1662 | Values: 85.0 71.0 82.0 71.0 69.0 70.0 91.0 54.0 65.0 94.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:90.00 stddev:3.03 (3.4%) stddev-sans-first:3.15 10:23:20 INFO - PID 1662 | Values: 89.0 90.0 89.0 89.0 99.0 90.0 90.0 91.0 90.0 89.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#6] imaging-darkroom Cycles:10 Average:107.30 Median:97.00 stddev:18.06 (18.6%) stddev-sans-first:18.83 10:23:20 INFO - PID 1662 | Values: 98.0 99.0 97.0 98.0 97.0 97.0 130.0 97.0 111.0 149.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#7] imaging-desaturate Cycles:10 Average:92.20 Median:92.50 stddev:1.87 (2.0%) stddev-sans-first:1.96 10:23:20 INFO - PID 1662 | Values: 93.0 96.0 93.0 92.0 94.0 91.0 90.0 92.0 90.0 91.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:59.00 stddev:11.76 (19.9%) stddev-sans-first:12.15 10:23:20 INFO - PID 1662 | Values: 50.0 48.0 54.0 52.0 64.0 45.0 46.0 66.0 74.0 77.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:57.70 Median:58.00 stddev:2.31 (4.0%) stddev-sans-first:2.24 10:23:20 INFO - PID 1662 | Values: 55.0 63.0 58.0 58.0 59.0 58.0 55.0 57.0 56.0 58.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.50 stddev:1.83 (2.2%) stddev-sans-first:1.88 10:23:20 INFO - PID 1662 | Values: 84.0 82.0 80.0 81.0 82.0 84.0 83.0 86.0 84.0 81.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:153.50 stddev:16.65 (10.8%) stddev-sans-first:15.84 10:23:20 INFO - PID 1662 | Values: 128.0 137.0 141.0 155.0 153.0 148.0 154.0 132.0 187.0 155.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.70 Median:185.00 stddev:6.80 (3.7%) stddev-sans-first:7.16 10:23:20 INFO - PID 1662 | Values: 188.0 183.0 183.0 180.0 180.0 202.0 181.0 191.0 182.0 187.0 10:23:20 INFO - PID 1662 | 10:23:20 INFO - PID 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.40 Median:70.00 stddev:12.13 (17.3%) stddev-sans-first:12.76 10:23:20 INFO - PID 1662 | Values: 70.0 67.0 71.0 69.0 67.0 90.0 103.0 67.0 70.0 70.0 10:23:20 INFO - PID 1662 | -------- Summary: end -------- 10:23:20 INFO - PID 1662 | 10:23:21 INFO - TEST-INFO | 1662: exit 0 10:23:21 INFO - TEST-OK | kraken | took 59267ms 10:23:21 INFO - SUITE-END | took 1173s 10:23:21 INFO - Completed test suite (00:19:33) 10:23:21 INFO - javascript benchmark 10:23:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8013.043701675255, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3545.3441113394015, 3588.7129029677644, 3611.3499570077374, 3622.4385220290847, 3624.9637503624963, 6117.401149625505, 6194.7831825886105, 6228.781992630247, 6232.501399888004, 6243.906341404882, 6114.601521188694, 6154.753809847612, 6204.751809927598, 6214.906776398347, 6279.340669229734, 5355.277037599933, 5357.4374690657505, 5417.7291135443265, 5450.264214331074, 5454.045542030149, 5498.642588231772, 5559.444055594448, 5576.275084239043, 5609.775608975636, 5612.859678508029, 5378.193271009341, 5477.397486276506, 5526.751296191641, 5552.666839989593, 5568.136938774476, 5402.486763757437, 5452.2094296327205, 5458.372287186945, 5474.0, 5498.972505137449, 5430.809921652763, 5452.482014208684, 5477.863053423656, 5480.534154596864, 5488.53347465466, 4915.9754201229125, 5303.443138470444, 6027.849303767397, 6280.089387038899, 6313.431791138773, 6425.1647285853005, 6582.3417658234275, 6637.601743895333, 6714.395704386579, 6758.256591774901, 6816.07982922309, 6839.897401538981, 6861.1080559526945, 6863.656817159172, 6871.072405225281, 5724.427557244284, 6299.748010079637, 6325.683715814191, 6326.304106548276, 6334.1765570475545, 6761.8647627047185, 6846.281140480278, 6849.0, 7011.263817299212, 7044.049053377831, 5044.646874718735, 5587.944120558743, 6673.699683514254, 6685.09751183584, 6686.1642294713165, 6588.505862060365, 6742.696578653972, 6835.726570937107, 6848.589084654936, 6862.3137686230975, 5554.444555544414, 6428.903566446507, 6547.672616369163, 6600.273969863311, 6719.496037797185, 6769.323067693192, 6771.52599318043, 6775.4918381121615, 6776.559523630948, 6823.1812182538415, 5397.784088636489, 5404.621676482609, 5418.1330987042675, 5431.891362172734, 5464.590155738336, 3999.580044095328, 4748.738819364969, 4764.309175169581, 4802.567768900815, 4883.731394773251, 6399.04014397844, 6400.103985442041, 6426.0, 6441.742330306735, 6461.676916154173, 6769.763058292936, 6854.657267136623, 6856.760013399507, 6870.175578930461, 6891.069705589782, 5175.585953123741, 6382.074599183093, 6388.968055159695, 6416.973284274493, 6425.293217746044, 5880.558958078076, 5992.790252341147, 6064.514838812885, 6089.391060893964, 6131.96934015336, 7072.646367681596, 7077.610731409719, 7085.6457177141965, 7096.148462184571, 7101.680424380812, 6786.830329241809, 6856.177258728984, 6900.447964162955, 6908.516403851883, 6921.826954326182, 5588.608797384144, 6758.7296508139125, 6780.93219067803, 6963.9651801740665, 7036.612986285599, 6346.619202847844, 6356.968215158895, 6766.15423072116, 6769.830754231184, 6782.084418603623, 5929.932612129858, 6643.60138391698, 6743.426808721314, 6764.763233286812, 6882.931170688229, 6307.842303942254, 6418.133551970611, 6472.223333200046, 6627.37039981201, 6650.83372915681, 6506.967465162644, 6582.3746744059235, 6600.174978127734, 6615.4376877965915, 6634.535582509371, 5972.731227094878, 6278.46633036197, 6501.2523559791225, 6518.217813862367, 6533.118029066015, 6364.681765911779, 6558.704858281293, 6655.201375834931, 6664.733410663713, 6667.699953502201, 6263.123162757127, 6504.772332968512, 6529.118568993125, 6531.706073226811, 6547.312532184052], "value": 6120.924056447082, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.1043825696092, 810.2909953790434, 835.4861760017587, 1220.8657047724748, 1253.7179134694688, 32642.836785816096, 36153.0, 37640.43539346905, 38832.805835970816, 39287.41068883969, 38645.61354386455, 38891.611083889155, 38970.83087507379, 39045.70497245301, 39231.803840980756, 7596.848063038749, 7729.922700772977, 8133.210693647388, 8321.334293256525, 8331.66673333066, 7244.927550724505, 8105.554194519299, 8179.345652347798, 8221.218984196492, 8306.584670766468, 8259.710910118147, 8318.45930014547, 8334.87497687532, 8347.248747612713, 8353.164683531659, 8217.917820821805, 8299.626516806758, 8327.0, 8331.16688331162, 8344.499330040217, 8134.877976830352, 8140.877886831702, 8154.3884208684585, 8159.0, 8162.8368482352225, 30410.391792164253, 31292.53061204084, 37149.0, 37233.0, 37261.62738372609, 3548.6983606393487, 3555.9111022224392, 3596.3706351388664, 3597.6402359764074, 3599.5680518337704, 29713.851430742925, 29933.70066299331, 30019.69980300191, 30067.398652027056, 30387.392252155056, 3079.430305393487, 3109.440300745865, 3120.3603261331373, 3133.0, 3136.4197623439736, 303078.0, 304730.0, 315131.1217219565, 318831.9999999977, 319396.0, 47291.05417891623, 47980.760096199294, 48014.759926200146, 48025.75987120042, 48191.0, 48947.755261223465, 48976.0, 48997.0, 49032.0, 49126.50873491291, 13302.068855180045, 13508.12197207198, 13509.729805403837, 13536.323183840768, 13662.795058074136, 9386.67146649864, 11014.063804576701, 11047.226694131494, 11144.2199046066, 11210.551577936954, 12759.362031898369, 12855.742885142245, 12956.28740419286, 12970.675733106747, 13116.934415327862, 5093.261477085802, 5093.465186155475, 5988.970055149696, 5990.550708696778, 6083.422074902877, 1012.792377562598, 1033.478093562761, 1049.317943336837, 1064.2709743825503, 1066.589363095214, 19531.51171220731, 23511.529769404515, 24490.755092448846, 24609.876950615133, 24634.0, 1127.2729089737074, 1130.1298000539539, 1132.5130194016651, 1138.5047504335641, 1168.2990205876406, 12368.44342004612, 12452.439640216213, 12470.43883025266, 12498.750024999448, 12543.184692994926, 323473.0, 323845.3807730946, 324769.1284630732, 325556.0, 326996.0, 50833.23750143751, 50986.0, 51396.22905656418, 51422.74288628533, 51478.48521514812, 1488.159190057614, 1516.6587517808625, 1552.2006166824094, 1562.6952744214768, 1568.443202663061, 17434.9128254363, 20380.08289627, 21452.927353632567, 21619.675704864756, 22373.888130559244, 33757.66242337545, 37372.06569835776, 37465.0, 37493.625063749016, 37536.812315938245, 274077.0, 275510.0, 275600.0, 275838.0, 276538.0, 33423.16442088967, 34338.82830585831, 35547.11132221715, 35674.18398516167, 35882.64117358793, 39154.23805928797, 39589.60410395974, 43849.0, 45019.87450313768, 45039.54960450353, 25357.74642253554, 30181.396372072875, 30247.0, 30771.384572308878, 31033.379332412773, 28551.0, 29446.705532945252, 30749.538756918217, 31004.069877903697, 31226.375472490876, 36543.81728091343, 37317.25365492621, 37715.81142094272, 37800.62199377971, 37815.43276850905, 30031.798728050635, 30606.693933061277, 30973.535396969513, 31268.68731312658, 31682.366352673278, 23205.88397058004, 24034.158804441762, 24474.388140296636, 24612.384690382885, 24837.895263092112], "value": 17228.91362069545, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.83258945306045, 441.4327589048074, 443.2442685221697, 459.125366177432, 461.6399208617278, 21358.35924922251, 21835.454113647145, 22246.332610021705, 23213.651795223086, 23579.764202357972, 23071.653925191134, 23530.411739706517, 23925.76074239257, 24259.878700606474, 24617.261482155518, 6459.257185423666, 6532.706028228741, 6638.668066596675, 6663.9333606663795, 6665.666716664172, 6435.806925792233, 6520.31536688648, 6626.337366263383, 6626.939689649657, 6634.038064480647, 6694.765683201089, 6704.994250862385, 6787.219469760967, 6791.694373753168, 6824.0, 6547.639879806608, 6709.194896612414, 6750.291219421939, 6755.594664320157, 6757.729690812411, 6373.235211774617, 6564.081028655992, 6602.504812139109, 6604.900926486107, 6620.470362371047, 29059.0, 29276.51149652282, 29538.26154346137, 29782.55326170109, 30185.396292074256, 2215.6233440315186, 2268.387535365442, 2284.942876428086, 2285.9428514287274, 2289.782470665284, 18588.62822743551, 18706.345277915345, 18741.96919169445, 19188.328408505637, 19410.4176874694, 2274.1358283852196, 2300.3903965449167, 2352.2590384028977, 2359.1035406545575, 2360.6104992676187, 131075.34462327627, 171789.0, 173917.0, 174392.0, 174859.25140748557, 19947.800521994886, 23949.640755388682, 24330.756692433202, 24646.0, 25333.493330133293, 41894.16211675749, 42032.57967420348, 42109.78945105316, 42121.0, 42427.0, 10462.63380781669, 10705.785884282272, 10866.989606922745, 10943.507542160622, 11007.394593297446, 7657.272559106876, 8023.438359314909, 8463.66145354179, 8560.443571167854, 8686.609102590399, 10236.078752912124, 10637.308574942605, 11346.205765596495, 11366.033887119522, 11572.710682233012, 4455.371330914776, 4569.109023740339, 4573.199690054227, 4580.648708630962, 4603.148417542765, 947.9715608531756, 957.8323793336277, 971.8590804333332, 980.7106903463496, 996.7707427291764, 16426.260818263207, 18169.45491635253, 19981.300654477312, 20620.27829025977, 21058.578828423346, 862.7454900804278, 972.8103019911049, 988.1008282463068, 995.4127065031666, 1014.0923873133504, 10660.413677247825, 10894.128469722404, 10928.781424371467, 10933.726656833484, 10977.890221097847, 430089.8495507502, 535416.0, 538934.0, 552732.4726752761, 554602.0, 104889.27866695919, 109344.0, 111340.0, 113772.0, 123653.0, 1110.3726394587034, 1130.8360287758394, 1149.2816989381636, 1150.9021733152608, 1151.8502594662807, 17595.0, 18147.81852181514, 18181.909090454465, 18322.0, 18447.631047379247, 42417.30330786858, 53125.0, 53637.0, 54502.45497545132, 54683.437987441765, 72115.63942180255, 73975.8903616457, 74019.25980740123, 74091.25908740844, 74660.0, 11561.826572601249, 12672.366381681064, 12688.429020693906, 12794.680132996376, 13088.803667944798, 11010.39442830652, 13435.12671676338, 13697.109687870257, 13932.442702292201, 14156.50452234167, 11522.308661480338, 11712.590059347882, 11962.940185299018, 11998.700032499257, 12044.457999389873, 9168.404053736485, 10915.781684366428, 10953.507092181031, 11308.717282068013, 11496.0, 9579.377340472847, 11387.0321022714, 12291.631251062483, 12298.692532686397, 12372.938135309267, 8707.782305442415, 8792.47245165292, 8880.911190888266, 9194.12655797698, 9220.677276295297, 11653.359065251492, 11692.298462092302, 11860.051195904134, 11940.880591194324, 12063.276203427822], "value": 11516.458337703809, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1156.2599936040933, 1433.6057584164353, 1436.432609119398, 1437.187988786335, 1449.3767679897644, 9306.627734890604, 11408.429578521082, 11664.00855927246, 11975.64073077808, 12072.973797227247, 11766.235194712337, 11790.764184716301, 11928.761424771521, 11965.940170299136, 12042.096842736808, 2535.2521006303186, 2573.665423494943, 2580.2775222937607, 2584.147231413629, 2586.0690151545427, 2477.7770000699934, 2520.332111990324, 2534.3664083979006, 2538.581134112869, 2546.4270539128734, 2505.023041014006, 2522.9495410091786, 2527.747225277467, 2533.3413312538783, 2536.1377131775193, 2455.914043008495, 2473.4063824682034, 2499.350168956066, 2504.3864253257884, 2510.1716433576967, 2434.539276434143, 2457.8402403843693, 2516.7609077137645, 2524.3058159006237, 2527.772500474966, 9237.445753254826, 10088.848667269996, 11522.539098436053, 11545.307281563133, 11562.826557601642, 5603.187537807036, 6464.321246269168, 6698.363655452724, 6702.932970670328, 6703.0, 3271.5419841222247, 3621.818909054563, 4233.449651545279, 4287.121140166259, 4372.672049596293, 1218.3238302741975, 1224.124750803171, 1257.0509265504577, 1258.5028913579085, 1260.810878368243, 12717.872821271761, 15494.767578486331, 15888.04671719689, 15914.283857226452, 16034.919825400915, 5818.359980402152, 5937.584369094208, 6071.119687645355, 6095.207623008981, 6130.264368275835, 11962.880371196177, 12658.683532911751, 13461.528846490326, 13495.865041349658, 13510.459581616822, 6665.733370665119, 6710.496712746563, 6715.093462382613, 6725.596464212163, 6726.562773419712, 5854.326752423441, 6109.450149486479, 6119.2350956130485, 6164.106204600308, 6193.256809182837, 4548.658850586153, 4650.093231819763, 4654.301854721819, 4676.812927482931, 4708.0, 1315.9210447373189, 1446.985530144685, 1457.234951650392, 1476.0922032949659, 1484.2485866677425, 769.4421544380391, 783.2441693765544, 788.9566073865877, 796.474326944214, 797.2744802229943, 6558.311377305409, 6872.484563657646, 6965.965170174117, 7194.028806111212, 7228.855422891513, 809.283783851284, 884.2881480408205, 924.8335299645994, 943.1794338925179, 950.3632566180676, 3704.3147017801793, 3997.780122093313, 4217.283061879488, 4223.260929337353, 4372.278574035248, 14301.141931484144, 14570.05294655844, 14721.190334531704, 14729.779053314209, 14739.0, 14067.155970641794, 14352.0, 14577.0, 14603.634909127144, 14614.415423383158, 7363.226861179606, 7632.274933881384, 8229.95885020571, 8375.162483751697, 8447.32421406286, 6584.572002819801, 6817.454603631599, 6859.314068593101, 6894.8621027580175, 6996.160460744743, 12571.497140114294, 12766.425510851848, 12906.290154041619, 12965.740685186433, 13273.933630331787, 13122.934385328012, 13215.801762973371, 13300.667483312995, 13538.661533461742, 13624.86375136236, 8929.151730585583, 9174.724758257264, 9311.627534898798, 9422.246220302222, 9433.151016408556, 10809.729756756144, 10941.28881622692, 10952.616658416917, 10962.287451315638, 10967.561297548009, 7492.587907665131, 8792.956035219782, 9074.818503629758, 9111.0, 9195.540222988957, 7356.0, 8765.34259930495, 8850.070742571937, 8891.155340242667, 8953.194212520904, 7975.960120199594, 7984.20157984197, 8073.596320184085, 8075.798105047421, 8136.471129376809, 5066.59467242627, 5931.3178984417345, 6024.608400453956, 6049.909251361145, 6241.687915604292, 6039.094135879477, 6090.299615544269, 6210.875782484415, 6247.68761561911, 6340.587861788969], "value": 5367.575173086213, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.734202006475, 394.176171800936, 394.47534778744273, 400.3714168755056, 408.41392601616684, 4294.957050429495, 6103.748731510041, 6145.508359331248, 6303.716332765025, 6437.2918978912285, 5394.433584473622, 5595.524380427659, 6193.163922870411, 6264.185655864742, 6276.843078923029, 3800.429935509668, 4527.547245275479, 4603.0, 4621.976890115545, 4623.0, 3666.3767159582803, 4633.7063153738945, 4641.443026836768, 4654.348391225214, 4659.207934651117, 4261.637760790337, 4596.747178905159, 4618.838340658078, 4629.699069560468, 4642.373279607244, 3550.0, 4237.894052648678, 4365.668471116308, 4639.675222734427, 4641.976790116045, 3908.511436070491, 3908.902277443058, 3917.98041009796, 3925.3130702127014, 3944.36890097583, 6204.224471941007, 6215.72577621591, 6223.159873417076, 6228.477466626024, 6234.812955611339, 4805.951940480585, 5315.767377701375, 5425.907232877262, 5459.389480103379, 5518.91721624176, 6159.784407545759, 6769.120014398146, 6772.559783614099, 6803.516716398529, 6821.249662537117, 3907.355286377744, 4435.578620031092, 4437.2013037653205, 4440.2895536714295, 4444.177827101997, 5513.3108361454815, 5607.233721377753, 6868.501131758706, 6951.582905025664, 7194.064771579713, 4367.912641747211, 4500.964778101055, 4501.7524036177665, 4502.16709908668, 4522.909541809211, 4575.725456472623, 4578.291583817052, 4581.496035436099, 4588.151192029485, 4589.931151032737, 4693.95306046942, 5235.869103272373, 5343.171808369709, 5392.272043274186, 5489.890202195934, 5876.353601103875, 6786.219584747719, 6796.184457864989, 6807.570410213911, 6831.633673265367, 1532.0, 1552.7205103081553, 1553.4640549010574, 1554.3083327919194, 1563.1715190948814, 975.8243516167016, 983.9016098390103, 1013.0983424751977, 1019.6686077024997, 1023.1661196125134, 6203.503719702413, 6211.689415529206, 6419.903701444482, 6477.77327793525, 6484.967575162094, 6322.336154703782, 6415.358464153547, 6542.691461707677, 6783.559068660521, 6962.651867406609, 5169.974150129226, 6410.519211059189, 6446.387593178641, 6503.739850406026, 6525.934740652628, 3538.221591249921, 3598.2908118643436, 3653.611627581502, 3673.2102597941034, 3689.8524059037873, 7141.178764442156, 7211.3870321023305, 7246.130464344313, 7249.673764680602, 7249.96375018132, 6964.825879353057, 7208.819779505449, 7231.168415632164, 7239.89140162898, 7274.418046556263, 7111.395531379787, 7142.535735177197, 7181.210066892638, 7186.1376634804155, 7223.602701851449, 5438.809641662523, 5723.914141287967, 5827.679477628772, 7050.461833739747, 7050.964745176241, 6599.868002640016, 6857.211420686485, 6908.1364829396325, 6931.861362772817, 6943.79168624942, 7081.858362832818, 7292.307230813064, 7293.0, 7307.817304567428, 7308.817279567841, 4196.622303992655, 4353.978230108829, 4503.5138404327145, 4525.420510309093, 4549.0, 5644.0, 6783.896991932516, 7026.156861176692, 7104.467164962752, 7166.856662866818, 5951.940480595139, 6856.6228857413325, 6876.484263680344, 6877.071595334566, 6879.3120687930805, 6558.0, 6591.472682185509, 6859.485538584726, 6871.759488417882, 6899.448044156556, 5027.3464449621315, 5634.4365563443325, 6114.379689382228, 6657.467402607683, 6745.258021617717, 5990.940090599038, 6113.51091912637, 6473.902891456538, 6688.097106890702, 6823.829404264933, 5544.445555444423, 6031.36670649593, 6188.257409110755, 6587.934120658732, 6717.193936727428], "value": 4851.508719208564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.2577188784704, 848.5799529233028, 852.4075767341697, 855.392671203446, 874.9300055995519, 12607.873921260785, 14347.928260358683, 14982.550523484286, 16744.246508907097, 17148.657026859455, 16695.582610434743, 17261.30954761811, 17443.3022679093, 17508.21213045413, 17845.196966136522, 996.3025881882675, 1004.372267332917, 1011.9677928512913, 1013.4729940430972, 1015.8730158730159, 1013.9746506337364, 1018.1549314069305, 1019.765453945593, 1022.4734261855151, 1025.2208321675505, 1061.946902654864, 1068.2468859454066, 1078.0890147825114, 1079.7408621930758, 1080.9081228095622, 1060.4432672846779, 1062.2511129653576, 1063.648995831374, 1065.6802959112313, 1066.9573217071309, 766.8159641686011, 784.1178673991759, 786.9921300786976, 787.8345547435046, 787.9645415956296, 16793.32826686931, 17191.91404042984, 17400.39098631542, 17410.825891741046, 17450.825491745047, 16397.262123204484, 16677.166141692865, 17015.319387224496, 17213.913930430266, 17255.568610784707, 14081.225532595703, 14305.570832874926, 14336.64158396038, 14477.71044579113, 14482.275886205647, 3417.0603084151808, 3446.9310613787584, 3455.153487395579, 3493.0917961329983, 3495.828897319401, 109852.0, 122107.77892221053, 128382.0, 129794.99999999905, 131613.68386316206, 12192.695182620506, 12262.693432664255, 12276.508939642314, 12288.877111228774, 12304.261744295192, 20807.0, 20972.11250987388, 21150.153993840075, 21192.0, 21213.0, 6176.320604733476, 6689.364510371507, 7962.681492740341, 8133.918660813434, 8140.633671484798, 3934.5868683788362, 3961.6632586230494, 4013.2174226026227, 4015.1768887378016, 4015.5181378234215, 3448.637788073747, 4166.208420400114, 4275.209086318979, 4281.614654681093, 4284.271673815459, 870.2863651805459, 892.7009451833578, 895.4806212396794, 901.2699713232172, 902.3052249767774, 653.5359894474881, 660.2044536333707, 661.2461793555351, 665.1220389086457, 701.8210356359198, 10307.896921030693, 11365.204435689422, 11574.826377604342, 11609.245399049034, 12083.879161208275, 656.4026735670517, 669.4075742967411, 669.4844969373555, 677.8542613338058, 688.9379955804002, 4486.910261794746, 5308.522232999048, 5668.461496157858, 5720.0, 5772.480476757112, 89752.20495590051, 103165.0, 105271.0, 110159.0, 111973.0, 92754.0, 95388.09223815484, 96108.55837162449, 96717.0, 97094.51452742833, 86436.0, 86777.1322286769, 87628.0, 88000.55999720088, 89003.0, 9075.954620226856, 10815.083646125866, 11206.551737930391, 11416.257943233662, 11542.422878856192, 35019.82490087635, 36538.26923461569, 39520.407193892686, 40143.799281004576, 41086.589134108275, 64220.0, 66930.66534667296, 68583.28541786496, 69232.34595675541, 71209.0, 15570.377184912477, 16495.9175204128, 16833.989960602405, 17113.14434278256, 17315.82684173142, 14982.700345992802, 17870.91064544669, 18394.94950503957, 18749.812501875353, 18790.248390064244, 16569.337226510805, 16817.831821681626, 17138.742918855976, 17438.9128054364, 17546.122693865513, 13691.0, 17092.97442153475, 17355.56611084733, 17420.390286339916, 17643.647127057644, 16433.67132657364, 17023.808333417037, 17108.91445542814, 17121.315147393965, 17224.82775172232, 11798.11514136426, 11854.644360669194, 12080.577179799016, 12196.81704774447, 12519.812202817147, 13152.671183220496, 13622.182669039888, 13703.862961370658, 13717.314134293445, 13736.244506552235], "value": 8369.61152789195, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1478.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 117.0, 115.0, 114.0, 113.0, 114.0, 115.0, 114.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 113.0, 113.0, 153.0, 114.0, 128.0, 114.0, 111.0, 141.0, 115.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 195.0, 195.0, 196.0, 200.0, 206.0, 224.0, 202.0, 202.0, 196.0], "value": 201.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 61.0, 85.0, 63.0, 65.0, 63.0, 60.0, 81.0, 59.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 82.0, 71.0, 69.0, 70.0, 91.0, 54.0, 65.0, 94.0], "value": 75.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 89.0, 89.0, 99.0, 90.0, 90.0, 91.0, 90.0, 89.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 97.0, 98.0, 97.0, 97.0, 130.0, 97.0, 111.0, 149.0], "value": 107.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 96.0, 93.0, 92.0, 94.0, 91.0, 90.0, 92.0, 90.0, 91.0], "value": 92.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 54.0, 52.0, 64.0, 45.0, 46.0, 66.0, 74.0, 77.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 63.0, 58.0, 58.0, 59.0, 58.0, 55.0, 57.0, 56.0, 58.0], "value": 57.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 80.0, 81.0, 82.0, 84.0, 83.0, 86.0, 84.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 137.0, 141.0, 155.0, 153.0, 148.0, 154.0, 132.0, 187.0, 155.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 183.0, 183.0, 180.0, 180.0, 202.0, 181.0, 191.0, 182.0, 187.0], "value": 185.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 67.0, 71.0, 69.0, 67.0, 90.0, 103.0, 67.0, 70.0, 70.0], "value": 74.4, "unit": "score"}]}]} 10:23:21 INFO - Return code: 0 10:23:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:23:21 INFO - # TBPL SUCCESS # 10:23:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:23:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:23:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:23:21 INFO - 2017-05-19 10:23:21.887 screenresolution[1669:10981] starting screenresolution argv=screenresolution get 10:23:21 INFO - 2017-05-19 10:23:21.890 screenresolution[1669:10981] Display 0: 1600x1200x32@60 10:23:21 INFO - 2017-05-19 10:23:21.896 screenresolution[1670:10984] starting screenresolution argv=screenresolution list 10:23:21 INFO - Available Modes on Display 0 10:23:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:23:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:23:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:23:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:23:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:23:22 INFO - Intel Iris: 10:23:22 INFO - Chipset Model: Intel Iris 10:23:22 INFO - Type: GPU 10:23:22 INFO - Bus: Built-In 10:23:22 INFO - VRAM (Dynamic, Max): 1536 MB 10:23:22 INFO - Vendor: Intel (0x8086) 10:23:22 INFO - Device ID: 0x0a2e 10:23:22 INFO - Revision ID: 0x0009 10:23:22 INFO - Displays: 10:23:22 INFO - Display: 10:23:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:23:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:23:22 INFO - Display Serial Number: 1600x1200 60 10:23:22 INFO - Main Display: Yes 10:23:22 INFO - Mirror: Off 10:23:22 INFO - Online: Yes 10:23:22 INFO - Rotation: Supported 10:23:22 INFO - Return code: 0 10:23:22 INFO - Running post-action listener: _resource_record_post_action 10:23:22 INFO - [mozharness: 2017-05-19 17:23:22.131349Z] Finished run-tests step (success) 10:23:22 INFO - Running post-run listener: _resource_record_post_run 10:23:22 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 54820864; Write bytes: 587016192; Read time: 610; Write time: 1824 10:23:22 INFO - TinderboxPrint: CPU usage
54.2% 10:23:22 INFO - TinderboxPrint: I/O read bytes / time
54,820,864 / 610 10:23:22 INFO - TinderboxPrint: I/O write bytes / time
587,016,192 / 1,824 10:23:22 INFO - TinderboxPrint: CPU idle
2,193.6 (45.8%) 10:23:22 INFO - TinderboxPrint: CPU system
960.6 (20.1%) 10:23:22 INFO - TinderboxPrint: CPU user
1,631.4 (34.1%) 10:23:22 INFO - TinderboxPrint: Swap in / out
304,701,440 / 0 10:23:22 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 245398016; Write bytes: 237596672; Read time: 17660; Write time: 418 10:23:22 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 53796864; Write bytes: 326440960; Read time: 595; Write time: 1361 10:23:22 INFO - Running post-run listener: _upload_blobber_files 10:23:22 INFO - Blob upload gear active. 10:23:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:23:22 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 10:23:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:23:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:23:23 INFO - (blobuploader) - INFO - Open directory for files ... 10:23:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:23:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:23:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:24 INFO - (blobuploader) - INFO - Done attempting. 10:23:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:23:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:23:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:25 INFO - (blobuploader) - INFO - Done attempting. 10:23:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:23:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:23:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:26 INFO - (blobuploader) - INFO - Done attempting. 10:23:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:23:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:23:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:28 INFO - (blobuploader) - INFO - Done attempting. 10:23:28 INFO - (blobuploader) - INFO - Iteration through files over. 10:23:28 INFO - Return code: 0 10:23:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:23:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:23:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72943336f71d8475d536c660c00f1e1b776e029a2d53c932c72d8227c9f13e65937a109e516a2fc432ebf1809cb72c098cb4cc96900aa9fea189fa2a1ec3bc86", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be6b619500e732cc4b63ed877df23a348afebdf0ec252cde6c22a10d352bb0018226bdf60fdd23b0f45dba4a30e94b9f633c32bf3640d2cefaf9455ebbe37340", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb1a26ae7ec8707a1264be9f40f81044592f8cf318f4531133f0e1aad9488d62cf8bf65e9cc49d76ea2e0979a2adc03926722ec25ec3eb34823ca0645e5c2e51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06d96e71bbde92ed24b378831bdcd0cd2e52bd2281e70140313a5b0167eda2745d343757adea3f849efb3ca89766e4d2066416e7906d08713dfbf474e1e42ab8"} 10:23:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:23:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:23:28 INFO - Contents: 10:23:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72943336f71d8475d536c660c00f1e1b776e029a2d53c932c72d8227c9f13e65937a109e516a2fc432ebf1809cb72c098cb4cc96900aa9fea189fa2a1ec3bc86", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be6b619500e732cc4b63ed877df23a348afebdf0ec252cde6c22a10d352bb0018226bdf60fdd23b0f45dba4a30e94b9f633c32bf3640d2cefaf9455ebbe37340", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb1a26ae7ec8707a1264be9f40f81044592f8cf318f4531133f0e1aad9488d62cf8bf65e9cc49d76ea2e0979a2adc03926722ec25ec3eb34823ca0645e5c2e51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06d96e71bbde92ed24b378831bdcd0cd2e52bd2281e70140313a5b0167eda2745d343757adea3f849efb3ca89766e4d2066416e7906d08713dfbf474e1e42ab8"} 10:23:28 INFO - Running post-run listener: copy_logs_to_upload_dir 10:23:28 INFO - Copying logs to upload dir... 10:23:28 INFO - mkdir: /builds/slave/test/build/upload/logs 10:23:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.703711 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-05-19 10:23:28.633569) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 10:23:28.637443) ========= 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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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/Firefox/sha512/72943336f71d8475d536c660c00f1e1b776e029a2d53c932c72d8227c9f13e65937a109e516a2fc432ebf1809cb72c098cb4cc96900aa9fea189fa2a1ec3bc86", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be6b619500e732cc4b63ed877df23a348afebdf0ec252cde6c22a10d352bb0018226bdf60fdd23b0f45dba4a30e94b9f633c32bf3640d2cefaf9455ebbe37340", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb1a26ae7ec8707a1264be9f40f81044592f8cf318f4531133f0e1aad9488d62cf8bf65e9cc49d76ea2e0979a2adc03926722ec25ec3eb34823ca0645e5c2e51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06d96e71bbde92ed24b378831bdcd0cd2e52bd2281e70140313a5b0167eda2745d343757adea3f849efb3ca89766e4d2066416e7906d08713dfbf474e1e42ab8"} build_url:https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011113 build_url: 'https://queue.taskcluster.net/v1/task/YxkcyhW1Q7qSonc-Ehz0Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72943336f71d8475d536c660c00f1e1b776e029a2d53c932c72d8227c9f13e65937a109e516a2fc432ebf1809cb72c098cb4cc96900aa9fea189fa2a1ec3bc86", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be6b619500e732cc4b63ed877df23a348afebdf0ec252cde6c22a10d352bb0018226bdf60fdd23b0f45dba4a30e94b9f633c32bf3640d2cefaf9455ebbe37340", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb1a26ae7ec8707a1264be9f40f81044592f8cf318f4531133f0e1aad9488d62cf8bf65e9cc49d76ea2e0979a2adc03926722ec25ec3eb34823ca0645e5c2e51", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06d96e71bbde92ed24b378831bdcd0cd2e52bd2281e70140313a5b0167eda2745d343757adea3f849efb3ca89766e4d2066416e7906d08713dfbf474e1e42ab8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 10:23:28.669903) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 10:23:28.670295) ========= 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.RZ3sSVc4HE/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.kSf9Wu86Vb/Listeners TMPDIR=/var/folders/xg/t9n0l1xx5tbbv7rdc0m9kfch00000w/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.005131 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 10:23:28.719193) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 10:23:28.719528) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 10:23:28.719899) ========= ========= Total master_lag: 0.17 =========