builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0239 starttime: 1497523410.88 results: success (0) revision: dced94de288a8be800e8229dcc1a8b736ba7d1a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-15 03:43:30.880776) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-15 03:43:30.881191) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-15 03:43:30.881461) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-15 03:43:30.920135) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-15 03:43:30.920482) ========= 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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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-06-15 03:43:31-- 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% 12.1M=0.001s 2017-06-15 03:43:31 (12.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.510822 ========= master_lag: 0.34 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-15 03:43:31.766403) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-15 03:43:31.766736) ========= 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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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.043746 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-15 03:43:31.841875) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-15 03:43:31.842202) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dced94de288a8be800e8229dcc1a8b736ba7d1a2 --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 dced94de288a8be800e8229dcc1a8b736ba7d1a2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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-06-15 03:43:32,004 truncating revision to first 12 chars 2017-06-15 03:43:32,005 Setting DEBUG logging. 2017-06-15 03:43:32,005 attempt 1/10 2017-06-15 03:43:32,005 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dced94de288a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-15 03:43:33,065 unpacking tar archive at: mozilla-central-dced94de288a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.503871 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-15 03:43:33.385781) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-15 03:43:33.386083) ========= script_repo_revision: dced94de288a8be800e8229dcc1a8b736ba7d1a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-15 03:43:33.386454) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-15 03:43:33.386721) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-15 03:43:33.416390) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 23 mins, 43 secs) (at 2017-06-15 03:43:33.416807) ========= /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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:43:33 INFO - MultiFileLogger online at 20170615 03:43:33 in /builds/slave/test 03:43:33 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 03:43:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:43:33 INFO - {'append_to_log': False, 03:43:33 INFO - 'base_work_dir': '/builds/slave/test', 03:43:33 INFO - 'blob_upload_branch': 'Firefox', 03:43:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:43:33 INFO - 'branch': 'Firefox', 03:43:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:43:33 INFO - 'config_files': ('talos/mac_config.py',), 03:43:33 INFO - 'default_actions': ('clobber', 03:43:33 INFO - 'read-buildbot-config', 03:43:33 INFO - 'download-and-extract', 03:43:33 INFO - 'populate-webroot', 03:43:33 INFO - 'create-virtualenv', 03:43:33 INFO - 'install', 03:43:33 INFO - 'setup-mitmproxy', 03:43:33 INFO - 'run-tests'), 03:43:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:43:33 INFO - 'download_minidump_stackwalk': True, 03:43:33 INFO - 'download_symbols': 'ondemand', 03:43:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:43:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:43:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:43:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:43:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:43:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:43:33 INFO - 'gecko_profile': False, 03:43:33 INFO - 'gecko_profile_interval': 0, 03:43:33 INFO - 'installer_path': 'installer.exe', 03:43:33 INFO - 'log_level': 'info', 03:43:33 INFO - 'log_name': 'talos', 03:43:33 INFO - 'log_to_console': True, 03:43:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:43:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:43:33 INFO - 'opt_config_files': (), 03:43:33 INFO - 'pip_index': False, 03:43:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:43:33 INFO - 'cmd': ('bash', 03:43:33 INFO - '-c', 03:43:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:43:33 INFO - 'enabled': True, 03:43:33 INFO - 'halt_on_failure': False, 03:43:33 INFO - 'name': 'check_screen_resolution'},), 03:43:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:43:33 INFO - 'cmd': ('bash', 03:43:33 INFO - '-c', 03:43:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:43:33 INFO - 'enabled': True, 03:43:33 INFO - 'halt_on_failure': False, 03:43:33 INFO - 'name': 'check_screen_resolution'},), 03:43:33 INFO - 'run_cmd_checks_enabled': True, 03:43:33 INFO - 'suite': 'dromaeojs-e10s', 03:43:33 INFO - 'system_bits': '32', 03:43:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:43:33 INFO - 'title': 't-yosemite-r7-0239', 03:43:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:43:33 INFO - 'use_talos_json': True, 03:43:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:43:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:43:33 INFO - 'work_dir': 'build'} 03:43:33 INFO - [mozharness: 2017-06-15 10:43:33.792374Z] Running clobber step. 03:43:33 INFO - Running pre-action listener: _resource_record_pre_action 03:43:33 INFO - Running main action method: clobber 03:43:33 INFO - rmtree: /builds/slave/test/build 03:43:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:43:37 INFO - Running post-action listener: _resource_record_post_action 03:43:37 INFO - [mozharness: 2017-06-15 10:43:37.832653Z] Finished clobber step (success) 03:43:37 INFO - [mozharness: 2017-06-15 10:43:37.832869Z] Running read-buildbot-config step. 03:43:37 INFO - Running pre-action listener: _resource_record_pre_action 03:43:37 INFO - Running main action method: read_buildbot_config 03:43:37 INFO - Using buildbot properties: 03:43:37 INFO - { 03:43:37 INFO - "project": "", 03:43:37 INFO - "product": "firefox", 03:43:37 INFO - "who": "archaeopteryx@coole-files.de", 03:43:37 INFO - "installer_path": "public/build/firefox-56.0a1.en-US.mac.dmg", 03:43:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 03:43:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:43:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 03:43:37 INFO - "stage_platform": "macosx64", 03:43:37 INFO - "basedir": "/builds/slave/test", 03:43:37 INFO - "buildnumber": 94, 03:43:37 INFO - "platform": "yosemite_r7", 03:43:37 INFO - "parent_task_id": "bCtrgS--SzmC9Rvedkg_-A", 03:43:37 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 03:43:37 INFO - "slavebuilddir": "test", 03:43:37 INFO - "taskId": "cz3CvGAGTzOLxwqVv5MHqA", 03:43:37 INFO - "branch": "mozilla-central", 03:43:37 INFO - "script_repo_revision": "production", 03:43:37 INFO - "revision": "dced94de288a8be800e8229dcc1a8b736ba7d1a2", 03:43:37 INFO - "slavename": "t-yosemite-r7-0239", 03:43:37 INFO - "repo_path": "mozilla-central" 03:43:37 INFO - } 03:43:37 INFO - Finding installer, test and symbols from parent task. 03:43:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cz3CvGAGTzOLxwqVv5MHqA'}, attempt #1 03:43:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cz3CvGAGTzOLxwqVv5MHqA'}, attempt #1 03:43:39 INFO - Task dependencies: UlpsJ7xLSbChI_ghjEAO_Q bCtrgS--SzmC9Rvedkg_-A 03:43:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A'}, attempt #1 03:43:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.dmg 03:43:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/test_packages.json 03:43:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/target.crashreporter-symbols.zip 03:43:39 INFO - Running post-action listener: _resource_record_post_action 03:43:39 INFO - [mozharness: 2017-06-15 10:43:39.569002Z] Finished read-buildbot-config step (success) 03:43:39 INFO - [mozharness: 2017-06-15 10:43:39.569169Z] Running download-and-extract step. 03:43:39 INFO - Running pre-action listener: _resource_record_pre_action 03:43:39 INFO - Running main action method: download_and_extract 03:43:39 INFO - mkdir: /builds/slave/test/build/tests 03:43:39 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')]} 03:43:39 INFO - trying https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.test_packages.json 03:43:39 INFO - Downloading https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-56.0a1.en-US.mac.test_packages.json 03:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-56.0a1.en-US.mac.test_packages.json'}, attempt #1 03:43:40 INFO - Downloaded 1328 bytes. 03:43:40 INFO - Reading from file /builds/slave/test/build/firefox-56.0a1.en-US.mac.test_packages.json 03:43:40 INFO - Using the following test package requirements: 03:43:40 INFO - {u'awsy': [u'firefox-56.0a1.en-US.mac.common.tests.zip', 03:43:40 INFO - u'firefox-56.0a1.en-US.mac.awsy.tests.zip'], 03:43:40 INFO - u'common': [u'firefox-56.0a1.en-US.mac.common.tests.zip'], 03:43:40 INFO - u'cppunittest': [u'firefox-56.0a1.en-US.mac.common.tests.zip', 03:43:40 INFO - u'firefox-56.0a1.en-US.mac.cppunittest.tests.zip'], 03:43:40 INFO - u'gtest': [u'firefox-56.0a1.en-US.mac.common.tests.zip', 03:43:40 INFO - u'firefox-56.0a1.en-US.mac.gtest.tests.zip'], 03:43:40 INFO - u'jittest': [u'firefox-56.0a1.en-US.mac.common.tests.zip', 03:43:40 INFO - u'jsshell-mac.zip'], 03:43:40 INFO - u'mochitest': [u'firefox-56.0a1.en-US.mac.common.tests.zip', 03:43:40 INFO - u'firefox-56.0a1.en-US.mac.mochitest.tests.zip'], 03:43:40 INFO - u'mozbase': [u'firefox-56.0a1.en-US.mac.common.tests.zip'], 03:43:40 INFO - u'reftest': [u'firefox-56.0a1.en-US.mac.common.tests.zip', 03:43:40 INFO - u'firefox-56.0a1.en-US.mac.reftest.tests.zip'], 03:43:40 INFO - u'talos': [u'firefox-56.0a1.en-US.mac.common.tests.zip', 03:43:40 INFO - u'firefox-56.0a1.en-US.mac.talos.tests.zip'], 03:43:40 INFO - u'web-platform': [u'firefox-56.0a1.en-US.mac.common.tests.zip', 03:43:40 INFO - u'firefox-56.0a1.en-US.mac.web-platform.tests.tar.gz'], 03:43:40 INFO - u'xpcshell': [u'firefox-56.0a1.en-US.mac.common.tests.zip', 03:43:40 INFO - u'firefox-56.0a1.en-US.mac.xpcshell.tests.zip']} 03:43:40 INFO - Downloading packages: [u'firefox-56.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:43:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.common.tests.zip 03:43:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:43:40 INFO - Fetch https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.common.tests.zip into memory 03:43:43 INFO - Content-Length response header: 59589462 03:43:43 INFO - Bytes received: 59589462 03:44:11 INFO - Downloading packages: [u'firefox-56.0a1.en-US.mac.common.tests.zip', u'firefox-56.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:44:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.common.tests.zip 03:44:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:44:11 INFO - Fetch https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.common.tests.zip into memory 03:44:14 INFO - Content-Length response header: 59589462 03:44:14 INFO - Bytes received: 59589462 03:44:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.talos.tests.zip 03:44:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:44:42 INFO - Fetch https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.talos.tests.zip into memory 03:44:44 INFO - Content-Length response header: 14454477 03:44:44 INFO - Bytes received: 14454477 03:44:45 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')]} 03:44:45 INFO - trying https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.dmg 03:44:45 INFO - Downloading https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-56.0a1.en-US.mac.dmg 03:44:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-56.0a1.en-US.mac.dmg'}, attempt #1 03:44:48 INFO - Downloaded 69610530 bytes. 03:44:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.dmg 03:44:48 INFO - mkdir: /builds/slave/test/properties 03:44:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:44:48 INFO - Writing to file /builds/slave/test/properties/build_url 03:44:48 INFO - Contents: 03:44:48 INFO - build_url:https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.dmg 03:44:48 INFO - Running post-action listener: _resource_record_post_action 03:44:48 INFO - Running post-action listener: set_extra_try_arguments 03:44:48 INFO - [mozharness: 2017-06-15 10:44:48.266681Z] Finished download-and-extract step (success) 03:44:48 INFO - [mozharness: 2017-06-15 10:44:48.266863Z] Running populate-webroot step. 03:44:48 INFO - Running pre-action listener: _resource_record_pre_action 03:44:48 INFO - Running main action method: populate_webroot 03:44:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:44:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:44:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:44:48 INFO - '--tppagecycles', 03:44:48 INFO - '7'], 03:44:48 INFO - 'tests': ['tsvgm']}}, 03:44:48 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:44:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:44:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:44:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:44:48 INFO - 'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:44:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:44:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:44:48 INFO - 'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['damp', 'tps']}, 03:44:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:44:48 INFO - 'tests': ['damp', 'tps']}, 03:44:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['dromaeo_dom']}, 03:44:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:44:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:44:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:44:48 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:44:48 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:44:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['a11yr', 03:44:48 INFO - 'ts_paint', 03:44:48 INFO - 'tpaint', 03:44:48 INFO - 'sessionrestore', 03:44:48 INFO - 'sessionrestore_no_auto_restore', 03:44:48 INFO - 'tabpaint']}, 03:44:48 INFO - 'other-e10s': {'tests': ['a11yr', 03:44:48 INFO - 'ts_paint', 03:44:48 INFO - 'tpaint', 03:44:48 INFO - 'sessionrestore', 03:44:48 INFO - 'sessionrestore_no_auto_restore', 03:44:48 INFO - 'tabpaint']}, 03:44:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:44:48 INFO - 'ts_paint', 03:44:48 INFO - 'tpaint', 03:44:48 INFO - 'sessionrestore', 03:44:48 INFO - 'sessionrestore_no_auto_restore', 03:44:48 INFO - 'tabpaint']}, 03:44:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:44:48 INFO - 'ts_paint', 03:44:48 INFO - 'tpaint', 03:44:48 INFO - 'sessionrestore', 03:44:48 INFO - 'sessionrestore_no_auto_restore', 03:44:48 INFO - 'tabpaint']}, 03:44:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['a11yr', 03:44:48 INFO - 'ts_paint', 03:44:48 INFO - 'tpaint', 03:44:48 INFO - 'sessionrestore', 03:44:48 INFO - 'sessionrestore_no_auto_restore', 03:44:48 INFO - 'tabpaint']}, 03:44:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['a11yr', 03:44:48 INFO - 'ts_paint', 03:44:48 INFO - 'tpaint', 03:44:48 INFO - 'sessionrestore', 03:44:48 INFO - 'sessionrestore_no_auto_restore', 03:44:48 INFO - 'tabpaint']}, 03:44:48 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:44:48 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:44:48 INFO - 'bloom_basic_ref']}, 03:44:48 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:44:48 INFO - 'talos_options': ['--mitmproxy', 03:44:48 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:44:48 INFO - '--firstNonBlankPaint'], 03:44:48 INFO - 'tests': ['quantum_pageload_google', 03:44:48 INFO - 'quantum_pageload_youtube', 03:44:48 INFO - 'quantum_pageload_amazon', 03:44:48 INFO - 'quantum_pageload_facebook']}, 03:44:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['tsvgx', 03:44:48 INFO - 'tsvgr_opacity', 03:44:48 INFO - 'tart', 03:44:48 INFO - 'tscrollx', 03:44:48 INFO - 'cart', 03:44:48 INFO - 'tsvg_static']}, 03:44:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:44:48 INFO - 'tsvgr_opacity', 03:44:48 INFO - 'tart', 03:44:48 INFO - 'tscrollx', 03:44:48 INFO - 'cart', 03:44:48 INFO - 'tsvg_static']}, 03:44:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:44:48 INFO - 'talos_options': ['--disable-e10s'], 03:44:48 INFO - 'tests': ['tp5o']}, 03:44:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:44:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:44:48 INFO - 'talos_options': ['--disable-e10s', 03:44:48 INFO - '--xperf_path', 03:44:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:48 INFO - 'tests': ['tp5n']}, 03:44:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:44:48 INFO - 'talos_options': ['--xperf_path', 03:44:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:44:48 INFO - 'tests': ['tp5n']}}, 03:44:48 INFO - 'talos.zip': {'path': '', 03:44:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:44:48 INFO - Running post-action listener: _resource_record_post_action 03:44:48 INFO - [mozharness: 2017-06-15 10:44:48.302237Z] Finished populate-webroot step (success) 03:44:48 INFO - [mozharness: 2017-06-15 10:44:48.302529Z] Running create-virtualenv step. 03:44:48 INFO - Running pre-action listener: _resource_record_pre_action 03:44:48 INFO - Running main action method: create_virtualenv 03:44:48 INFO - Creating virtualenv /builds/slave/test/build/venv 03:44:48 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 03:44:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:44:48 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:44:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:44:48 INFO - Using real prefix '/tools/python27' 03:44:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:44:49 INFO - Installing distribute.............................................................................................................................................................................................done. 03:44:54 INFO - Installing pip.................done. 03:44:54 INFO - Return code: 0 03:44:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:44:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:44:54 INFO - Reading from file tmpfile_stdout 03:44:54 INFO - Output received: 03:44:54 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) 03:44:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:44:54 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')]} 03:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:54 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')]} 03:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:54 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 0x10d660c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe06a4e1cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b6d30>, '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 0x10d380cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:44:54 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 03:44:54 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 03:44:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ax1Q4QUAMp/Render', 03:44:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:54 INFO - 'HOME': '/Users/cltbld', 03:44:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:54 INFO - 'LOGNAME': 'cltbld', 03:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:54 INFO - 'MOZ_NO_REMOTE': '1', 03:44:54 INFO - 'NO_EM_RESTART': '1', 03:44:54 INFO - 'PAGER': '/bin/cat', 03:44:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:54 INFO - 'PWD': '/builds/slave/test', 03:44:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:54 INFO - 'SHELL': '/bin/bash', 03:44:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEryjlRLYW/Listeners', 03:44:54 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:44:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:54 INFO - 'USER': 'cltbld', 03:44:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:54 INFO - 'XPC_FLAGS': '0x0', 03:44:54 INFO - 'XPC_SERVICE_NAME': '0', 03:44:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:55 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 03:44:55 INFO - Cleaning up... 03:44:55 INFO - Return code: 0 03:44:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:44:55 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')]} 03:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:44:55 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')]} 03:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:44:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10d660c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe06a4e1cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b6d30>, '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 0x10d380cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:44:55 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 03:44:55 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 03:44:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ax1Q4QUAMp/Render', 03:44:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:44:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:44:55 INFO - 'HOME': '/Users/cltbld', 03:44:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:44:55 INFO - 'LOGNAME': 'cltbld', 03:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:55 INFO - 'MOZ_NO_REMOTE': '1', 03:44:55 INFO - 'NO_EM_RESTART': '1', 03:44:55 INFO - 'PAGER': '/bin/cat', 03:44:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:55 INFO - 'PWD': '/builds/slave/test', 03:44:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:44:55 INFO - 'SHELL': '/bin/bash', 03:44:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEryjlRLYW/Listeners', 03:44:55 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:44:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:44:55 INFO - 'USER': 'cltbld', 03:44:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:44:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:55 INFO - 'XPC_FLAGS': '0x0', 03:44:55 INFO - 'XPC_SERVICE_NAME': '0', 03:44:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:44:55 INFO - Downloading/unpacking psutil>=3.1.1 03:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:44:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:44:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:44:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:44:58 INFO - Installing collected packages: psutil 03:44:58 INFO - Running setup.py install for psutil 03:44:58 INFO - building 'psutil._psutil_osx' extension 03:44:58 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 03:44:59 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 03:44:59 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 03:44:59 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 03:44:59 INFO - building 'psutil._psutil_posix' extension 03:44:59 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 03:44:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:44:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:44:59 INFO - ^ 03:45:00 INFO - 1 warning generated. 03:45:00 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 03:45:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:00 INFO - Successfully installed psutil 03:45:00 INFO - Cleaning up... 03:45:00 INFO - Return code: 0 03:45:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:45:00 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')]} 03:45:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:00 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')]} 03:45:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:00 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 0x10d660c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe06a4e1cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b6d30>, '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 0x10d380cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:45:00 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 03:45:00 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 03:45:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ax1Q4QUAMp/Render', 03:45:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:00 INFO - 'HOME': '/Users/cltbld', 03:45:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:00 INFO - 'LOGNAME': 'cltbld', 03:45:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:00 INFO - 'MOZ_NO_REMOTE': '1', 03:45:00 INFO - 'NO_EM_RESTART': '1', 03:45:00 INFO - 'PAGER': '/bin/cat', 03:45:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:00 INFO - 'PWD': '/builds/slave/test', 03:45:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:00 INFO - 'SHELL': '/bin/bash', 03:45:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEryjlRLYW/Listeners', 03:45:00 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:45:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:00 INFO - 'USER': 'cltbld', 03:45:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:00 INFO - 'XPC_FLAGS': '0x0', 03:45:00 INFO - 'XPC_SERVICE_NAME': '0', 03:45:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:45:00 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 03:45:00 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 03:45:00 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 03:45:00 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 03:45:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:45:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:45:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:45:03 INFO - Installing collected packages: mozsystemmonitor 03:45:03 INFO - Running setup.py install for mozsystemmonitor 03:45:03 INFO - Successfully installed mozsystemmonitor 03:45:03 INFO - Cleaning up... 03:45:03 INFO - Return code: 0 03:45:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:45: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')]} 03:45:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45: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')]} 03:45:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45: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', '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 0x10d660c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe06a4e1cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b6d30>, '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 0x10d380cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:45: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:45: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 jsonschema==2.5.1 03:45:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ax1Q4QUAMp/Render', 03:45:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:03 INFO - 'HOME': '/Users/cltbld', 03:45:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:03 INFO - 'LOGNAME': 'cltbld', 03:45:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:03 INFO - 'MOZ_NO_REMOTE': '1', 03:45:03 INFO - 'NO_EM_RESTART': '1', 03:45:03 INFO - 'PAGER': '/bin/cat', 03:45:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:03 INFO - 'PWD': '/builds/slave/test', 03:45:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:03 INFO - 'SHELL': '/bin/bash', 03:45:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEryjlRLYW/Listeners', 03:45:03 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:45:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:03 INFO - 'USER': 'cltbld', 03:45:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:03 INFO - 'XPC_FLAGS': '0x0', 03:45:03 INFO - 'XPC_SERVICE_NAME': '0', 03:45:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:03 INFO - Downloading/unpacking jsonschema==2.5.1 03:45:03 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 03:45:03 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 03:45:03 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 03:45:03 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 03:45:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:45:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:06 INFO - Downloading functools32-3.2.3-2.tar.gz 03:45:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:45:06 INFO - warning: no files found matching '*.txt' 03:45:06 INFO - no previously-included directories found matching 'build' 03:45:06 INFO - no previously-included directories found matching 'dist' 03:45:06 INFO - no previously-included directories found matching '.git*' 03:45:06 INFO - Installing collected packages: jsonschema, functools32 03:45:06 INFO - Running setup.py install for functools32 03:45:06 INFO - warning: no files found matching '*.txt' 03:45:06 INFO - no previously-included directories found matching 'build' 03:45:06 INFO - no previously-included directories found matching 'dist' 03:45:06 INFO - no previously-included directories found matching '.git*' 03:45:06 INFO - Successfully installed jsonschema functools32 03:45:06 INFO - Cleaning up... 03:45:06 INFO - Return code: 0 03:45:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:45:06 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')]} 03:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:06 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')]} 03:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:06 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 0x10d660c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe06a4e1cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b6d30>, '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 0x10d380cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:45:06 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 03:45:06 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 03:45:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ax1Q4QUAMp/Render', 03:45:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:06 INFO - 'HOME': '/Users/cltbld', 03:45:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:06 INFO - 'LOGNAME': 'cltbld', 03:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:06 INFO - 'MOZ_NO_REMOTE': '1', 03:45:06 INFO - 'NO_EM_RESTART': '1', 03:45:06 INFO - 'PAGER': '/bin/cat', 03:45:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:06 INFO - 'PWD': '/builds/slave/test', 03:45:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:06 INFO - 'SHELL': '/bin/bash', 03:45:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEryjlRLYW/Listeners', 03:45:06 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:45:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:06 INFO - 'USER': 'cltbld', 03:45:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:06 INFO - 'XPC_FLAGS': '0x0', 03:45:06 INFO - 'XPC_SERVICE_NAME': '0', 03:45:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:07 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:45:07 INFO - Cleaning up... 03:45:07 INFO - Return code: 0 03:45:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:45: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')]} 03:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45: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')]} 03:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45: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', '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 0x10d660c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe06a4e1cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b6d30>, '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 0x10d380cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:45: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:45: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 blobuploader==1.2.4 03:45:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ax1Q4QUAMp/Render', 03:45:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:07 INFO - 'HOME': '/Users/cltbld', 03:45:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:07 INFO - 'LOGNAME': 'cltbld', 03:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:07 INFO - 'MOZ_NO_REMOTE': '1', 03:45:07 INFO - 'NO_EM_RESTART': '1', 03:45:07 INFO - 'PAGER': '/bin/cat', 03:45:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:07 INFO - 'PWD': '/builds/slave/test', 03:45:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:07 INFO - 'SHELL': '/bin/bash', 03:45:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEryjlRLYW/Listeners', 03:45:07 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:45:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:07 INFO - 'USER': 'cltbld', 03:45:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:07 INFO - 'XPC_FLAGS': '0x0', 03:45:07 INFO - 'XPC_SERVICE_NAME': '0', 03:45:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:07 INFO - Downloading/unpacking blobuploader==1.2.4 03:45:07 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 03:45:07 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 03:45:07 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 03:45:07 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 03:45:09 INFO - Downloading blobuploader-1.2.4.tar.gz 03:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:45:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:45:10 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 03:45:10 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 03:45:10 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 03:45:10 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 03:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:45:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:45:10 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 03:45:10 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 03:45:10 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 03:45:10 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 03:45:11 INFO - Downloading docopt-0.6.1.tar.gz 03:45:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:45:11 INFO - Installing collected packages: blobuploader, requests, docopt 03:45:11 INFO - Running setup.py install for blobuploader 03:45:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:45:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:45:11 INFO - Running setup.py install for requests 03:45:12 INFO - Running setup.py install for docopt 03:45:12 INFO - Successfully installed blobuploader requests docopt 03:45:12 INFO - Cleaning up... 03:45:12 INFO - Return code: 0 03:45:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45: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')]} 03:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45: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')]} 03:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:12 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 0x10d660c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe06a4e1cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b6d30>, '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 0x10d380cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:45:12 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 03:45:12 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 03:45:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ax1Q4QUAMp/Render', 03:45:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:12 INFO - 'HOME': '/Users/cltbld', 03:45:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:12 INFO - 'LOGNAME': 'cltbld', 03:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:12 INFO - 'MOZ_NO_REMOTE': '1', 03:45:12 INFO - 'NO_EM_RESTART': '1', 03:45:12 INFO - 'PAGER': '/bin/cat', 03:45:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:12 INFO - 'PWD': '/builds/slave/test', 03:45:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:12 INFO - 'SHELL': '/bin/bash', 03:45:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEryjlRLYW/Listeners', 03:45:12 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:45:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:12 INFO - 'USER': 'cltbld', 03:45:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:12 INFO - 'XPC_FLAGS': '0x0', 03:45:12 INFO - 'XPC_SERVICE_NAME': '0', 03:45:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-sdl6AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-5WlVK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-eXQydH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-SL7wYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-63LkQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:13 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-S1UWOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:14 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-PGgU9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:14 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-8TlNKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:14 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-2ff51o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:14 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-qCGKPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:14 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-uPp_Zb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:14 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-QWznLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:15 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-oaYwv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:15 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-oXycHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:15 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-JU7bRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:15 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-eFjjca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:15 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-IFZ0p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:45:15 INFO - Running setup.py install for manifestparser 03:45:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Running setup.py install for mozcrash 03:45:16 INFO - Running setup.py install for mozdebug 03:45:16 INFO - Running setup.py install for mozdevice 03:45:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Running setup.py install for mozfile 03:45:16 INFO - Running setup.py install for mozhttpd 03:45:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:45:17 INFO - Running setup.py install for mozinfo 03:45:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:45:17 INFO - Running setup.py install for mozInstall 03:45:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:45:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:45:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:45:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:45:17 INFO - Running setup.py install for mozleak 03:45:17 INFO - Running setup.py install for mozlog 03:45:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:45:18 INFO - Running setup.py install for moznetwork 03:45:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:45:18 INFO - Running setup.py install for mozprocess 03:45:18 INFO - Running setup.py install for mozprofile 03:45:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:45:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:45:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:45:18 INFO - Running setup.py install for mozrunner 03:45:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:45:19 INFO - Running setup.py install for mozscreenshot 03:45:19 INFO - Running setup.py install for moztest 03:45:19 INFO - Running setup.py install for mozversion 03:45:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:45:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:45:19 INFO - Cleaning up... 03:45:19 INFO - Return code: 0 03:45:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:19 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')]} 03:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:19 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')]} 03:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:19 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 0x10d660c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe06a4e1cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b6d30>, '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 0x10d380cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:45:19 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 03:45:19 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 03:45:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ax1Q4QUAMp/Render', 03:45:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:19 INFO - 'HOME': '/Users/cltbld', 03:45:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:19 INFO - 'LOGNAME': 'cltbld', 03:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:19 INFO - 'MOZ_NO_REMOTE': '1', 03:45:19 INFO - 'NO_EM_RESTART': '1', 03:45:19 INFO - 'PAGER': '/bin/cat', 03:45:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:19 INFO - 'PWD': '/builds/slave/test', 03:45:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:19 INFO - 'SHELL': '/bin/bash', 03:45:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEryjlRLYW/Listeners', 03:45:19 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:45:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:19 INFO - 'USER': 'cltbld', 03:45:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:19 INFO - 'XPC_FLAGS': '0x0', 03:45:19 INFO - 'XPC_SERVICE_NAME': '0', 03:45:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:20 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-CYcqSl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45: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)) 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:20 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-LcTTZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45: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)) 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:20 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-gNjH3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45: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)) 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:20 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-gSQOPn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 03:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:20 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-xjMADg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45: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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:21 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-_ydtcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45: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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:21 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-ljtyw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:21 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-tO6wUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:21 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-2iMLP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45: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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:21 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-DEr5jF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45: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)) 03:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:21 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-mWzYk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:22 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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:22 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-krJ_S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:22 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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:22 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-_zEnvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45: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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:22 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-gsTPJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45: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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:22 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-0sA7p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45: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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:22 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-3KcUOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45: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)) 03:45:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:22 INFO - Running setup.py (path:/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/pip-RQRx8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:23 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)) 03:45:23 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)) 03:45:23 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)) 03:45:23 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)) 03:45:23 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:23 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:23 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:45:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:23 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 03:45:23 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 03:45:23 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 03:45:23 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 03:45:25 INFO - Downloading blessings-1.6.tar.gz 03:45:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:45:25 INFO - Installing collected packages: blessings 03:45:25 INFO - Running setup.py install for blessings 03:45:25 INFO - Successfully installed blessings 03:45:25 INFO - Cleaning up... 03:45:25 INFO - Return code: 0 03:45:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:45:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:26 INFO - Reading from file tmpfile_stdout 03:45:26 INFO - Current package versions: 03:45:26 INFO - blessings == 1.6 03:45:26 INFO - blobuploader == 1.2.4 03:45:26 INFO - docopt == 0.6.1 03:45:26 INFO - functools32 == 3.2.3-2 03:45:26 INFO - jsonschema == 2.5.1 03:45:26 INFO - manifestparser == 1.1 03:45:26 INFO - mozInstall == 1.13 03:45:26 INFO - mozcrash == 1.0 03:45:26 INFO - mozdebug == 0.1 03:45:26 INFO - mozdevice == 0.51 03:45:26 INFO - mozfile == 1.2 03:45:26 INFO - mozhttpd == 0.7 03:45:26 INFO - mozinfo == 0.10 03:45:26 INFO - mozleak == 0.1 03:45:26 INFO - mozlog == 3.4 03:45:26 INFO - moznetwork == 0.27 03:45:26 INFO - mozprocess == 0.25 03:45:26 INFO - mozprofile == 0.28 03:45:26 INFO - mozrunner == 6.13 03:45:26 INFO - mozscreenshot == 0.1 03:45:26 INFO - mozsystemmonitor == 0.3 03:45:26 INFO - moztest == 0.8 03:45:26 INFO - mozversion == 1.4 03:45:26 INFO - psutil == 3.1.1 03:45:26 INFO - requests == 1.2.3 03:45:26 INFO - wsgiref == 0.1.2 03:45:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:26 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 0x10d660c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe06a4e1cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b6d30>, '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 0x10d380cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:45:26 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 03:45:26 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 03:45:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ax1Q4QUAMp/Render', 03:45:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:26 INFO - 'HOME': '/Users/cltbld', 03:45:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:26 INFO - 'LOGNAME': 'cltbld', 03:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:26 INFO - 'MOZ_NO_REMOTE': '1', 03:45:26 INFO - 'NO_EM_RESTART': '1', 03:45:26 INFO - 'PAGER': '/bin/cat', 03:45:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:26 INFO - 'PWD': '/builds/slave/test', 03:45:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:26 INFO - 'SHELL': '/bin/bash', 03:45:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEryjlRLYW/Listeners', 03:45:26 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:45:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:26 INFO - 'USER': 'cltbld', 03:45:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:26 INFO - 'XPC_FLAGS': '0x0', 03:45:26 INFO - 'XPC_SERVICE_NAME': '0', 03:45:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:26 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)) 03:45:26 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)) 03:45:26 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)) 03:45:26 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)) 03:45:26 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)) 03:45:26 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)) 03:45:26 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)) 03:45:26 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)) 03:45:26 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)) 03:45:26 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:28 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:45:29 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)) 03:45:29 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)) 03:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:45:29 INFO - Installing collected packages: marionette-driver 03:45:29 INFO - Running setup.py install for marionette-driver 03:45:29 INFO - Successfully installed marionette-driver 03:45:29 INFO - Cleaning up... 03:45:29 INFO - Return code: 0 03:45:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d660c10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d664768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe06a4e1cf0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d3b6d30>, '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 0x10d380cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, '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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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 03:45:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:45:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ax1Q4QUAMp/Render', 03:45:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:45:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:45:29 INFO - 'HOME': '/Users/cltbld', 03:45:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:45:29 INFO - 'LOGNAME': 'cltbld', 03:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:29 INFO - 'MOZ_NO_REMOTE': '1', 03:45:29 INFO - 'NO_EM_RESTART': '1', 03:45:29 INFO - 'PAGER': '/bin/cat', 03:45:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:29 INFO - 'PWD': '/builds/slave/test', 03:45:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:45:29 INFO - 'SHELL': '/bin/bash', 03:45:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEryjlRLYW/Listeners', 03:45:29 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:45:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:45:29 INFO - 'USER': 'cltbld', 03:45:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:45:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:29 INFO - 'XPC_FLAGS': '0x0', 03:45:29 INFO - 'XPC_SERVICE_NAME': '0', 03:45:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:45:29 INFO - Cleaning up... 03:45:29 INFO - Return code: 0 03:45:29 INFO - Running post-action listener: _resource_record_post_action 03:45:29 INFO - Running post-action listener: _start_resource_monitoring 03:45:29 INFO - Starting resource monitoring. 03:45:29 INFO - [mozharness: 2017-06-15 10:45:29.915900Z] Finished create-virtualenv step (success) 03:45:29 INFO - [mozharness: 2017-06-15 10:45:29.917460Z] Running install step. 03:45:29 INFO - Running pre-action listener: _resource_record_pre_action 03:45:29 INFO - Running main action method: install 03:45:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:30 INFO - Reading from file tmpfile_stdout 03:45:30 INFO - Detecting whether we're running mozinstall >=1.0... 03:45:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:45:30 INFO - Reading from file tmpfile_stdout 03:45:30 INFO - Output received: 03:45:30 INFO - Usage: mozinstall [options] installer 03:45:30 INFO - Options: 03:45:30 INFO - -h, --help show this help message and exit 03:45:30 INFO - -d DEST, --destination=DEST 03:45:30 INFO - Directory to install application into. [default: 03:45:30 INFO - "/builds/slave/test"] 03:45:30 INFO - --app=APP Application being installed. [default: firefox] 03:45:30 INFO - mkdir: /builds/slave/test/build/application 03:45:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-56.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:45:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-56.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:46:06 INFO - Reading from file tmpfile_stdout 03:46:06 INFO - Output received: 03:46:06 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:46:06 INFO - Running post-action listener: _resource_record_post_action 03:46:06 INFO - [mozharness: 2017-06-15 10:46:06.508039Z] Finished install step (success) 03:46:06 INFO - [mozharness: 2017-06-15 10:46:06.508243Z] Running setup-mitmproxy step. 03:46:06 INFO - Running pre-action listener: _resource_record_pre_action 03:46:06 INFO - Running main action method: setup_mitmproxy 03:46:06 INFO - Skipping: mitmproxy is not required 03:46:06 INFO - Running post-action listener: _resource_record_post_action 03:46:06 INFO - [mozharness: 2017-06-15 10:46:06.509448Z] Finished setup-mitmproxy step (success) 03:46:06 INFO - [mozharness: 2017-06-15 10:46:06.509692Z] Running run-tests step. 03:46:06 INFO - Running pre-action listener: _resource_record_pre_action 03:46:06 INFO - Running main action method: run_tests 03:46:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:46:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:46:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:46:06 INFO - 2017-06-15 03:46:06.530 screenresolution[1679:7875] starting screenresolution argv=screenresolution get 03:46:06 INFO - 2017-06-15 03:46:06.535 screenresolution[1679:7875] Display 0: 1600x1200x32@60 03:46:06 INFO - 2017-06-15 03:46:06.544 screenresolution[1680:7881] starting screenresolution argv=screenresolution list 03:46:06 INFO - Available Modes on Display 0 03:46:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:46:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:46:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:46:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:46:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:46:06 INFO - Intel Iris: 03:46:06 INFO - Chipset Model: Intel Iris 03:46:06 INFO - Type: GPU 03:46:06 INFO - Bus: Built-In 03:46:06 INFO - VRAM (Dynamic, Max): 1536 MB 03:46:06 INFO - Vendor: Intel (0x8086) 03:46:06 INFO - Device ID: 0x0a2e 03:46:06 INFO - Revision ID: 0x0009 03:46:06 INFO - Displays: 03:46:06 INFO - Display: 03:46:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:46:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:46:06 INFO - Display Serial Number: 1600x1200 60 03:46:06 INFO - Main Display: Yes 03:46:06 INFO - Mirror: Off 03:46:06 INFO - Online: Yes 03:46:06 INFO - Rotation: Supported 03:46:06 INFO - Return code: 0 03:46:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:46:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:46:06 INFO - Python 2.7.3 03:46:06 INFO - Return code: 0 03:46:06 INFO - grabbing minidump binary from tooltool 03:46:06 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')]} 03:46:06 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 0x10d3b6d30>, '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 0x10d380cd8>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d3a7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:46:06 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 03:46:06 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 03:46:06 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 03:46:06 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:46:07 INFO - Return code: 0 03:46:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:46:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:46:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:46:07 INFO - ENV: RUST_BACKTRACE is now 1 03:46:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:46:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:46:07 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/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0239', '--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 03:46:07 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/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/target.crashreporter-symbols.zip --title t-yosemite-r7-0239 --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 03:46:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ax1Q4QUAMp/Render', 03:46:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:46:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:46:07 INFO - 'HOME': '/Users/cltbld', 03:46:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:46:07 INFO - 'LOGNAME': 'cltbld', 03:46:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:46:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:07 INFO - 'MOZ_NO_REMOTE': '1', 03:46:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:46:07 INFO - 'NO_EM_RESTART': '1', 03:46:07 INFO - 'PAGER': '/bin/cat', 03:46:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:07 INFO - 'PWD': '/builds/slave/test', 03:46:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:46:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:46:07 INFO - 'RUST_BACKTRACE': '1', 03:46:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:46:07 INFO - 'SHELL': '/bin/bash', 03:46:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TEryjlRLYW/Listeners', 03:46:07 INFO - 'TMPDIR': '/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/', 03:46:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:46:07 INFO - 'USER': 'cltbld', 03:46:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:46:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:07 INFO - 'XPC_FLAGS': '0x0', 03:46:07 INFO - 'XPC_SERVICE_NAME': '0', 03:46:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:46:07 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/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0239', '--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 03:46:07 INFO - mozversion application_buildid: 20170615015658 03:46:07 INFO - mozversion application_changeset: dced94de288a8be800e8229dcc1a8b736ba7d1a2 03:46:07 INFO - mozversion application_display_name: Nightly 03:46:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:46:07 INFO - mozversion application_name: Firefox 03:46:07 INFO - mozversion application_remotingname: firefox 03:46:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:46:07 INFO - mozversion application_vendor: Mozilla 03:46:07 INFO - mozversion application_version: 56.0a1 03:46:07 INFO - mozversion platform_buildid: 20170615015658 03:46:07 INFO - mozversion platform_changeset: dced94de288a8be800e8229dcc1a8b736ba7d1a2 03:46:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:46:07 INFO - mozversion platform_version: 56.0a1 03:46:07 INFO - using testdate: 1497523567 03:46:07 INFO - actual date: 1497523567 03:46:07 INFO - starting webserver on 'localhost:49228' 03:46:07 INFO - SUITE-START | Running 2 tests 03:46:07 INFO - TEST-START | dromaeo_css 03:46:07 INFO - operating with platform_type : mac_ 03:46:07 INFO - Initialising browser for dromaeo_css test... 03:46:07 INFO - Application command: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox http://localhost:49228/getInfo.html -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmp9ZsLQh/profile 03:46:07 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox http://localhost:49228/getInfo.html -foreground) 03:46:43 INFO - TEST-INFO | 1690: killed by SIGTERM 03:46:43 INFO - Browser initialized. 03:46:43 INFO - Running cycle 1/1 for dromaeo_css test... 03:46:43 INFO - TEST-INFO | started process 1701 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmp9ZsLQh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:46 INFO - PID 1701 | 2017-06-15 03:46:46.589 plugin-container[1702:8378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4553, name = 'com.apple.tsm.portname' 03:46:46 INFO - PID 1701 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:46:46 INFO - PID 1701 | 2017-06-15 03:46:46.591 plugin-container[1702:8378] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4917, name = 'com.apple.CFPasteboardClient' 03:46:46 INFO - PID 1701 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:46:46 INFO - PID 1701 | 2017-06-15 03:46:46.591 plugin-container[1702:8378] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:46:47 INFO - PID 1701 | 2017-06-15 03:46:47.040 plugin-container[1704:8419] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 03:46:47 INFO - PID 1701 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:46:47 INFO - PID 1701 | 2017-06-15 03:46:47.041 plugin-container[1704:8419] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a1f, name = 'com.apple.CFPasteboardClient' 03:46:47 INFO - PID 1701 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:46:47 INFO - PID 1701 | 2017-06-15 03:46:47.041 plugin-container[1704:8419] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:46:56 INFO - PID 1701 | RSS: Main: 254242816 03:46:56 INFO - PID 1701 | 03:49:58 INFO - PID 1701 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49228/tests/dromaeo/cssquery-ext.html) 03:50:00 INFO - PID 1701 | RSS: Main: 266645504 03:50:00 INFO - PID 1701 | 03:53:03 INFO - PID 1701 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-ext.html (next: http://localhost:49228/tests/dromaeo/cssquery-jquery.html) 03:53:03 INFO - PID 1701 | RSS: Main: 276844544 03:53:03 INFO - PID 1701 | 03:56:05 INFO - PID 1701 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49228/tests/dromaeo/cssquery-mootools.html) 03:56:06 INFO - PID 1701 | RSS: Main: 275722240 03:56:06 INFO - PID 1701 | 03:59:08 INFO - PID 1701 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49228/tests/dromaeo/cssquery-prototype.html) 03:59:09 INFO - PID 1701 | RSS: Main: 278863872 03:59:09 INFO - PID 1701 | 04:02:13 INFO - PID 1701 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49228/tests/dromaeo/cssquery-yui.html) 04:02:13 INFO - PID 1701 | RSS: Main: 278106112 04:02:13 INFO - PID 1701 | 04:05:15 INFO - PID 1701 | Cycle 1(1): loaded http://localhost:49228/tests/dromaeo/cssquery-yui.html (next: http://localhost:49228/tests/dromaeo/cssquery-dojo.html) 04:05:16 INFO - PID 1701 | RSS: Main: 277053440 04:05:16 INFO - PID 1701 | 04:05:16 INFO - PID 1701 | __start_tp_report 04:05:16 INFO - PID 1701 | _x_x_mozilla_page_load 04:05:16 INFO - PID 1701 | _x_x_mozilla_page_load_details 04:05:16 INFO - PID 1701 | |i|pagename|runs| 04:05:16 INFO - PID 1701 | |0;dojo.html;1690.028233765585;1972.6942323939777;2179.891005449727;2226.8997895094717;2232.3079845247976;3614.4216925291958;3752.5496940367125;3754.7371683982133;3775.697944164467;3908.433277174808;3720.069982504374;3744.2698673758628;3745.4756334113245;3845.057960799608;3866.2847373235973;2434.354895952565;3160.336329370829;3260.6413294537583;3313.9005829825146;3326.9833650831833;3190.4416727072785;3279.26216601264;3333.666633336671;3370.9662903371022;3401.979406178149;3310.0897253255307;3325;3356.681115294043;3356.9328613427715;3417.0773891049525;3162.414953233659;3254.6908043735807;3284.343131373711;3315.668433156689;3319.6016478022552;2809.0028040045695;3043.8630261638277;3233.725133363667;3259.168911927467;3275.9189467475676;3112.7665425092982;3487.2676737885076;3743.681787048104;3788.981055094707;3808.8286027128847;3944.9013774655577;3955.367141257385;3985.720999530034;3997.6601988830985;4029.9395509067385;3881.146147847469;3893.6301051400073;4016.979915100435;4077.4699289092227;4220.451341325639;3794.354959656865;3803.8858834234466;3816.561095474056;3962.385830196324;4059.208454351432;3804.6956243500454;4110.17796440713;4115.938260926088;4125.608067233608;4132.958670413317;3799.069228039148;3846.3461211593535;3993.6405723485027;3996.7801770902297;4006.45912801768;3826.3877779555696;3923.6272554107886;3972.8808135755394;3975.582563830814;4218.599233072853;3725.3108174987715;3835.4438606401914;3837.808109594565;3923.6468717815533;3955.960440395617;4003.719739618257;4032.5765794591734;4047.1298670785923;4048.4939382577177;4049.959500405017;3060.2196439908125;3125;3128.7966282191583;3162.177833763238;3163.9525407118913;2825.6467941507312;2906.6076079729387;2907.6074729911616;2923.7076292371016;2958.8224706517676;3498.2478767065204;3571.9641304021543;3716.3682174030478;3808.914459379064;3827.3876179811095;3804.600516945736;3832.7317087803585;4009.1580768038457;4022.8735953932946;4037.4953130858644;3267.428200064979;3422.606400263952;3781.810909454571;3784.299904517673;3822.369309063973;3206.5350524173864;3678.70570354371;3701.11173318407;3702.1114932416026;3707.8146092695797;4240.491141063092;4280.422143010654;4343.391925130484;4344.000879797664;4462.576055274743;3886.6696330812197;4122.979385103055;4123.814428350672;4207.305794543866;4416.381706561148;4011.51861776577;4135.77253251062;4180.623743863067;4257.808398622007;4259.574042595716;3954.466147070224;3997.1006523531973;4005.7396269242404;4036.8788936331957;4077.082656402286;4013.9397909031973;4064.1871625674394;4095.242380159561;4193.643540299109;4196.28663127263;3885.3977633466857;3911.06134527717;3917.588653191488;3955.3473676843;4071.592840716023;3719.6094410086553;3732.720045996507;3747.8313475894197;3807.3908174691915;3991.421243919557;3291.9835400822844;3682.429223470366;3717.2937141942944;3735.439684047306;3752.9866935927694;3753.906152346104;3887.1642596841816;3930.4890364252465;3945.230680017369;4030.3954406838034;3752.718546109107;3791.5071040764524;3848.249591329664;3856.942145867758;3872.9806350968065 04:05:16 INFO - PID 1701 | |1;ext.html;478.18708196066694;479.32654620258535;488.8020351757538;512.9051125541778;513.9229115632654;23164.420889477773;23246;23909.641355379663;24795.75204247957;25004.749952500468;23077.96149173287;23185.76814231857;23334.88332558335;23559.175428859995;24157.033718651233;4339.826406943735;4424.646028317743;4436.55634436557;4438.844640437585;4471.351654010183;4957.355543779304;5053.963937392844;5139.588832893378;5152.8711782205555;5277.683338999653;5064.468230835764;5149.536541711245;5250.422453530108;5255.395629502599;5302.575793936476;4926.817563784702;4956.306117143621;5061.240813877911;5065.569426598707;5186.766595503212;5002.124628190052;5007.54932056113;5040.773165207538;5070.923936140961;5126.026055049529;19619.117139728747;21934.341969740934;22291.44271393228;22403.887980560157;22970.196043138578;2072.95854082919;2083.156321689718;2098.4544018555134;2109.4093653776968;2122.90446929887;18753.53116172093;18868.1509332079;18958.81041189598;19414.70877936832;19500.80499195004;1792.265171279769;1799.1454059321848;1801.6216594515167;1819.672458957387;1854.1285595769966;138031;165151;166278;169381;171328;22655.546889062127;22758.886205569197;22942.394032417906;23216.4195895104;24004.87997560001;27003.729962700123;30690.53964190539;31119.377612447624;31279.843600782304;32448.728588998543;7369.263073692588;7385.187629360766;7415.555066696015;7555.773326800205;7659.846803064019;5756.7121643917635;5764.308283005982;5786.652800831879;5814.622049566765;5850.736716847752;7562.962185189039;8168.550729709804;8176;8211.21993410625;8412.579371031425;3436.226848959014;3467.514547963287;3591.7910485052025;3639.2357604902736;3679.4848721179055;568.8151350811003;588.3498733899065;606.5420607441441;625.64338327154;634.5875181132209;16834.831651683573;17325.393611223546;17693.115344232738;17715.114244287994;18680.906595466935;625.1102271168534;651.0689713709346;656.1076935367992;696.9337912898267;712.4905692429937;5771.682557459296;6809.659517024129;7371.447141464411;7667.386609071373;7703.460757746904;156613;159195.6120658191;168720;171663;178670;32382.190445238586;33080.17299567482;33156;33931.491027634605;34443;798.5967086621336;875.3916028360228;896.9596368163449;902.201551626815;904.7602385367883;13232.867671323549;15982.840171598134;16477.176141193133;16659.083750393846;17430.825691743426;22704.205352813235;22913.083476661413;23346;23592;24121.879390602935;132429;163565;165227;169900.15049925167;174556;16411;16565;18810.717839232148;19597.804021959597;19990.700604460664;24525.50948981046;25136.24591262265;25607;25791.710414478825;26687;14051.789223161457;17228.224729887435;17790.555236119202;17879.642407152045;18077.638447231246;16774.832251677326;16933.068681222157;17163.7425438616;18236.36172733948;18527.351542695942;21666.89166554157;21873.781262187174;21930.780692192875;21951.231706890183;22466.438339041655;15115;16356;17015.574610634834;17047.232874520923;17907.820921790615;9695.9030409695;13064;13297.468101275841;13347.599572012856;14390.06464579799 04:05:16 INFO - PID 1701 | |2;jquery.html;249.90253801017607;262.28788838304024;285.3138202622693;296.4308527626957;297.88978078111097;11537.192396532235;13018.804717929226;13642;13707.177569345846;13954.58136255914;9705.466199359033;9956.701298961025;10164.288499804998;10246.948765256182;12245.265284082961;3622.34797736408;3668.9543480108173;3783.924321513568;3882.611738826109;3924.313245182096;3632.4914511968345;3664.992127165024;3667.486551882725;3685.3366394049062;3745;3752;3796.0130366104872;3815.465834783133;3892.746971446861;3930.8034598270115;3249.155219642898;3684.9815750921075;3752.9812350938346;3792.58281589025;3838.692904567642;3329.4839299908554;3443;3462.4633181856852;3463.445848664227;3507.526483924663;13389.861861741763;14178.503752368617;16791.992480451212;16846.494605161864;17514;1171.3030746705697;1243.2540475714588;1250.2560976219136;1280.6286177008656;1306.751717173734;10308;11438.714032149179;11742;11910.58312959051;12082;1322.1406086044053;1326.3633455941201;1331.9544157836149;1345.986540134596;1368.1517459175275;101099;104292.47853760759;106324.46837765761;106362;108835;8612;8692.826143477096;8719;8738.432001919855;8935.195832375117;11204.49579768896;11252.324860508395;11282.323060616389;11351.829722554168;11406.144539159597;4706.223473126965;5080.7205603692155;5083.110455670243;5232;5471.179323101487;3668.5414323209598;4661.90445245367;4672.112298663243;4719.834805781781;4751.192297309466;4890.462049174588;5007.873228523553;5116.053530096944;5140.40885298188;5231.973840130851;1403.9929800351138;1418.170370333346;1481.1779462398472;1529.5640742388366;1531.7778922056239;504.3418339067552;504.4904646307256;604.5043064686914;620.5097972601684;650.8307839961644;9564.330496865152;10799.946000270105;11242;12402.627921162379;13329.73340533184;610.8075956073823;617.6510271696477;635.1679300116862;658.3317932298721;663.7909058646511;5603.551715862721;6340.175777149033;6736.124303840469;6845.828854278683;6983.615901125385;275566.6221668919;318030.4098479539;321093;323344;348439;85484;87925.24149516974;88058.55970720106;88109.55945220233;93462.53268733749;598.8443004818779;699.5033526196356;712.2805965974403;727.5634619228526;732.772840419461;9665.130138287306;10602.469876506299;10886.61896833607;10947.616833410792;11631.76736465283;38160.04599885025;39852;40187.39718904277;40468.797656011535;41193.58806411897;53068.4693153079;54487.36537903869;55224.72387638197;55478.72260638671;56605;6368.745250189941;6767.323267673193;6848.863022739418;7010.439164866696;7121.359077682826;8382.748517544484;8845.69040083594;10745.462726863781;10784.245102842726;11131.276467029616;8619.008813986471;8666.176713212235;8752.562371881508;8810.207081362709;8816.162464565856;6932.410745086724;7206.819829504304;7730.497517661334;8176.918230817853;8311.96100487439;5241.50205730455;7236.348728614239;9311.836020497438;9318.813623727352;9725.756856078655;5778.739956701875;5818.185454036354;5891.675957822361;6473.223213214256;7064.187618423947;9017.2786177107;9148.405353652257;9163.991960884165;9336.95331523338;9430.669926552539 04:05:16 INFO - PID 1701 | |3;mootools.html;797.7566842113155;851.4763420496397;867.5271976772658;874.33113668044;891.8305521950829;7372.262773722625;8041;8187.877181842277;8223.958880205599;8412.873806892901;6478.870422591545;6494.545381823263;6680.231773346067;7383.593902335369;7898.170692077335;1576.7713681516202;1599.9760003599956;1640.5242479680878;1644.6464010237796;1673.6652669466155;1468.4786900650276;1633.8774591905594;1688.5694147992244;1691.6532110917233;1734.1156010434643;1552.968940621187;1659.9751003734953;1662.3018332300462;1664.9667006659859;1691.2220378625848;1337.565291280333;1409.3305679802165;1431.6277767780452;1516.249456519019;1611.6212690017837;1586.1831156954063;1601.7036848183122;1632.2002218912646;1653.884228104021;1682.3775203174903;7447.553146811155;7588.468807183499;7668.769936901902;8037.879431808527;8056.234657707509;4315.719478233905;4503.707259028185;4574.611158051536;4618.145643056012;4697.177993851063;2624.8687565621835;2726.5910113482937;2847.345110624568;2862.756665683419;2991.7756168287465;807.4146243973131;809.1544336168658;826.7147833997261;847.9321654267706;876.4478378621428;11821.34982575958;12020.737822528596;12150.21023633461;12224.266544007389;12331.321777302244;4113.958860411358;4154.584541545822;4223.387608796707;4277.230098582285;4339.848105316362;9416.387934784218;9452.19656329206;9674.56464459101;9694.418334899787;10001.24990625706;4345.30475123985;4448.488423831236;4618.607418369476;4673.509281525459;4674.018456124184;3904.355781296111;3955.1891862168186;4015.3374693175883;4076.9388459173138;4197.853075142355;2531.4304281536874;2699.190242927153;2978.6447166539174;3196.9040928772174;3272.345530893831;886.423824514071;984.247051005981;1007.1841808135433;1027.2655051638114;1047.4972013433594;443.49220142936156;505.15891041416364;511.71088335090553;512.8998298649376;543.665645627936;3464.7574669772875;4334.089841133335;4486.725365178942;4732.716037037789;4785.832495862628;403.39289369498715;409.58631781900493;429.60261757873843;431.76253060816424;432.3212556286663;2465.272744540365;2541.3265484646586;2713.17248239285;2773.8751756171023;3070.1250143708935;10695.930406959398;10705.678829635124;10759.677209683721;10807.513661885234;10915.454227288605;9389.248860091177;10257.846132308021;10265.024822641837;10362.792744145076;10743.247972641997;5142.537171654494;5271.815486458032;5340.412554618989;5452.182172674051;5641.971790141105;4365.156571930277;4742.193827049479;4956.306117143531;4963.6525443218625;5091.66904151229;9203.539823008688;9401.10689484498;9424.198943089914;9691.418514889128;9716.076972687584;7434.3309102181065;9556.76108097303;9635.421874687541;9806.215502759906;9925.751856203653;5970.940290597212;6076.756929722762;6155.230596175478;6304.968475157778;6356.55504114726;7026.718931242693;7174.139103307636;7232.710691572278;7433.033705618452;7581;5632.436756324335;5673.149027645886;5743.540516758733;5979.611325263844;6078.939210607838;5655.717214139194;5687.033204355353;5905.025670764276;6028.09578563219;6064.545159112996;5109.310243117132;5136.30659860914;5295.682259064469;5521.834344969658;5525.668459892419;3840.327942610088;3880.7865567394065;4010.979945100256;4159.854405095807;4449.154660614473;3648.890533284006;4000.439938408567;4031.455753473361;4239.957600423956;4391.3193455014525 04:05:16 INFO - PID 1701 | |4;prototype.html;231.54385859856086;234.86143175526436;238.30890417788422;289.92606885244254;290.7208283552369;3420;3909.394043923193;4004.6195611416906;4041.595840415957;4063.7155399122075;2953.9852300738467;3312.850921708523;3929.5481019682743;3934.803259837011;4032.314506533889;2864.64191976003;2894.0062713455404;2912.082693951409;2954.6454425468974;2964.3774807290497;2793.2458236276193;2862.0520863510515;2919.5182794838825;2931.780116491261;3014.3368458939;2465.359006658273;2723.509768241716;2798.670631450055;2849.3446507303333;2874.5688146778048;2471.394508345467;2873.1380585824168;2885.6970018148004;2893.537034074538;2908.6218791557176;2037.5822956293923;2254.3349711834885;2264.7169103862016;2518.5214809186195;2572.897084116633;3845.8653947111716;3850.6726928210855;3855.2867719471988;3859.614038596146;3869.6517313441645;3348.866045358183;3435.587729472479;3435.6736110069505;3449.7757645752945;3565.732570057256;3212.6909283438094;3554.7689400188906;3598.784072955631;4146.019820971871;4187.874363769091;2326.8254880884;2832.475991941477;2851.303474432709;2852.3724780548246;2915.2420370703558;3912.2371137628174;3978.303796835542;4262.616364527207;4389.934150987706;4549.203889319356;2775.4726601945567;2822.9011984580443;2897.5219088850527;2902.460347196203;2914.2714321419644;3004.7014034263807;3016.713412225835;3041.558973948765;3046.497327940909;3052.236940764809;3382.797032178028;3417.333619944087;3431.5244444888936;3447.793132412063;3581.158427769472;3249.8212598306845;3982.5818289079807;4082.2856000199845;4185.979070104691;4197.601227883346;864.0538610221797;932.4638332958576;985.1429256546706;992.9673139934388;1009.9495025248708;575.0628379922271;661.5798967655574;669.926308106108;679.5956405938458;691.2776148924386;3782.243551289698;3833.846646134179;3840.9615903840604;3877.612238776156;3882.5923278055398;4173.52004519478;4317.7193482423545;4362.236608593484;4370.541093185233;4404.295312749945;3152.2907345847;3232.854521546536;3403.6045221459085;3480.8781692640637;3940.9211815763524;1750.5886116762551;1965.5380985468403;2155.374941267015;2308.2457332427475;2312.838101332924;3327.966720332814;3467.5665541807275;4311.986683129462;4335.826566937287;4432.82268709248;4084.571120032413;4153.127843152912;4369.868903932887;4482.21561226784;4531.4109165808895;3683.6132206117973;4290.270653988767;4356.6732495063;4373.250699720137;4402.647788176874;3409.590849098124;4241.745495270294;4283.807228674655;4287.3783301421745;4402.713823601455;3229.8223597702354;3753.4932784074895;4117.341225403921;4245.384419259129;4286;4236.703430759941;4342.717723347972;4475.70907890986;4543.545645435563;4587.793549290223;2500.9249722508353;2577.7937764978383;2885.5094633912704;2890.4652639261803;2899.913002609925;3383.3571621391857;3750.4248215749994;3982.90042748922;4245.195791788539;4298.20483210607;3760.3231418344963;3860.8841734748003;3946.250212459738;3975.7597557990143;4148.755373388032;3468.7745296555645;3912.374020156761;3965.759345969518;4064.7357921734992;4231.703780735319;3685.8157092144747;3852.1910398816563;4003.4195041718203;4046.8988275293354;4117.711760176759;3412.1233321672485;4069.5726948669962;4227.281362168377;4240.78796060202;4295.634871035997;3368.983155084209;3723.7153182152115;3913.032625246522;3998.400239963912;4006.9799651002722 04:05:16 INFO - PID 1701 | |5;yui.html;415.4951733643623;488.64573184441286;491.42257847029754;510.49971028392196;516.7185380256963;7787.831825226219;9463.952680236598;9733.853992190114;9761.267904907125;9809.50952452378;9609.951950240256;10465.05814476697;10755.569777208902;11157.772645009043;11247.775044499105;561.3993027460629;572.9484346408823;586.988260234795;598.5181928547518;599.3856297295285;594.459042271533;604.0456079394568;608.3217212807709;609.451493655709;615.4860691322751;589.8761260135356;609.1106983803652;634.4924060751381;635.8427661655788;658.6673729766461;613.9662318572476;619.4394073363613;621.751299480207;635.8537536366615;645.3933302695451;454.0895504513462;462.7940566447932;468.79607370793474;469.86996273961176;470.7716757372672;10400.583976640924;10411.739706507322;10483.68548943533;10777.976092271221;10783.892161078367;8892;9902.356346837432;10663;10814.621488247953;10931.453427328603;8569.185927336894;8631.438956467873;8937.419067760575;8945.016048234755;8999.920009598825;2080.20952038226;2120.9045592948355;2122.670985997173;2126.9787302126933;2204.2836078274627;61798;72700.27299726987;83126;92021;98165.5275170873;7771.222877712296;7998.200179982072;8311.376646751396;8580.099089595627;8591.5704214789;11874.287542747463;16147.919260403858;16205.298443663482;16495.422660206834;16682.41517055878;3479.756417050782;3578.910527236788;4024.6377825995214;4305.440292761921;4651.465081515601;2203.8016578508013;2266.3880752196815;2354.9646755298686;2379.5003049359484;2380.2264264114233;2681.1554360376417;2728.0588197072375;2729;2732.27594687408;2846.9857650711615;546.8851541176318;606.6299557270062;609.3814778000333;628.424991133108;628.6071205496564;334.9849256783402;367.2691344224973;404.52872403649417;414.8713898691415;432.38169417732314;5908.379620139824;5962.34414214436;6337.271213810379;6514.153160089253;7379.778606641809;360.9530761001053;374.4738642207703;391.6318660459159;392.91163477168084;393.6358868047045;2391.0196819304;3141.6701246368802;3187.442197615408;3263.951040734391;3616.1140520572626;87067;88344;94883;96435;97052;69125.65437172783;72793;73746;77504.61247693838;77598;61449.38550614437;65551.34448655548;65653.671731642;69789;71257.57484850274;5768.654123492961;6154.692265386623;6688.3646053624825;6799.490038247052;6861.656917154222;20704.79295207089;23339;24142.637860431758;27735;29251.85374073116;44065.77967110144;50355;50694;53768.11811586576;57130.42869571251;8152.551609661526;8288.668453261802;9613.471259080818;9899;9954.502274886372;10479.895201048197;10499.94750026245;10936.453177340942;10993.285436446606;11492.36791976416;9460.526973651427;9466.195373393064;9816.067473589997;9958.904520502883;10168.135708464863;9383.296252780932;9416.246700264099;9491.9558848528;9514.001029892039;9698.95150524271;9388.718338449857;9503;9662.516874156405;9838.704838854846;10206.081452669296;5749.8562535936935;7103.1476222851525;7311.086114235721;7427.405807535276;7574.583397913168;7272.345488906024;7435.219301973431;7755.2632499912415;7777.494462859896;8373.916260837557 04:05:16 INFO - PID 1701 | __end_tp_report 04:05:16 INFO - PID 1701 | __start_cc_report 04:05:16 INFO - PID 1701 | _x_x_mozilla_cycle_collect,650 04:05:16 INFO - PID 1701 | __end_cc_report 04:05:16 INFO - PID 1701 | __startTimestamp1497524716224__endTimestamp 04:05:16 INFO - PID 1701 | 04:05:16 INFO - PID 1701 | ------- Summary: start ------- 04:05:16 INFO - PID 1701 | Number of tests: 6 04:05:16 INFO - PID 1701 | 04:05:16 INFO - PID 1701 | [#0] dojo.html Cycles:165 Average:3693.21 Median:3808.91 stddev:472.40 (12.4%) stddev-sans-first:446.95 04:05:16 INFO - PID 1701 | Values: 1690.0 1972.7 2179.9 2226.9 2232.3 3614.4 3752.5 3754.7 3775.7 3908.4 3720.1 3744.3 3745.5 3845.1 3866.3 2434.4 3160.3 3260.6 3313.9 3327.0 3190.4 3279.3 3333.7 3371.0 3402.0 3310.1 3325.0 3356.7 3356.9 3417.1 3162.4 3254.7 3284.3 3315.7 3319.6 2809.0 3043.9 3233.7 3259.2 3275.9 3112.8 3487.3 3743.7 3789.0 3808.8 3944.9 3955.4 3985.7 3997.7 4029.9 3881.1 3893.6 4017.0 4077.5 4220.5 3794.4 3803.9 3816.6 3962.4 4059.2 3804.7 4110.2 4115.9 4125.6 4133.0 3799.1 3846.3 3993.6 3996.8 4006.5 3826.4 3923.6 3972.9 3975.6 4218.6 3725.3 3835.4 3837.8 3923.6 3956.0 4003.7 4032.6 4047.1 4048.5 4050.0 3060.2 3125.0 3128.8 3162.2 3164.0 2825.6 2906.6 2907.6 2923.7 2958.8 3498.2 3572.0 3716.4 3808.9 3827.4 3804.6 3832.7 4009.2 4022.9 4037.5 3267.4 3422.6 3781.8 3784.3 3822.4 3206.5 3678.7 3701.1 3702.1 3707.8 4240.5 4280.4 4343.4 4344.0 4462.6 3886.7 4123.0 4123.8 4207.3 4416.4 4011.5 4135.8 4180.6 4257.8 4259.6 3954.5 3997.1 4005.7 4036.9 4077.1 4013.9 4064.2 4095.2 4193.6 4196.3 3885.4 3911.1 3917.6 3955.3 4071.6 3719.6 3732.7 3747.8 3807.4 3991.4 3292.0 3682.4 3717.3 3735.4 3753.0 3753.9 3887.2 3930.5 3945.2 4030.4 3752.7 3791.5 3848.2 3856.9 3873.0 04:05:16 INFO - PID 1701 | 04:05:16 INFO - PID 1701 | [#1] ext.html Cycles:180 Average:25436.39 Median:24139.46 stddev:42865.43 (177.6%) stddev-sans-first:42944.72 04:05:16 INFO - PID 1701 | Values: 478.2 479.3 488.8 512.9 513.9 23164.4 23246.0 23909.6 24795.8 25004.7 23078.0 23185.8 23334.9 23559.2 24157.0 4339.8 4424.6 4436.6 4438.8 4471.4 4957.4 5054.0 5139.6 5152.9 5277.7 5064.5 5149.5 5250.4 5255.4 5302.6 4926.8 4956.3 5061.2 5065.6 5186.8 5002.1 5007.5 5040.8 5070.9 5126.0 19619.1 21934.3 22291.4 22403.9 22970.2 2073.0 2083.2 2098.5 2109.4 2122.9 18753.5 18868.2 18958.8 19414.7 19500.8 1792.3 1799.1 1801.6 1819.7 1854.1 138031.0 165151.0 166278.0 169381.0 171328.0 22655.5 22758.9 22942.4 23216.4 24004.9 27003.7 30690.5 31119.4 31279.8 32448.7 7369.3 7385.2 7415.6 7555.8 7659.8 5756.7 5764.3 5786.7 5814.6 5850.7 7563.0 8168.6 8176.0 8211.2 8412.6 3436.2 3467.5 3591.8 3639.2 3679.5 568.8 588.3 606.5 625.6 634.6 16834.8 17325.4 17693.1 17715.1 18680.9 625.1 651.1 656.1 696.9 712.5 5771.7 6809.7 7371.4 7667.4 7703.5 156613.0 159195.6 168720.0 171663.0 178670.0 32382.2 33080.2 33156.0 33931.5 34443.0 798.6 875.4 897.0 902.2 904.8 13232.9 15982.8 16477.2 16659.1 17430.8 22704.2 22913.1 23346.0 23592.0 24121.9 132429.0 163565.0 165227.0 169900.2 174556.0 16411.0 16565.0 18810.7 19597.8 19990.7 24525.5 25136.2 25607.0 25791.7 26687.0 14051.8 17228.2 17790.6 17879.6 18077.6 16774.8 16933.1 17163.7 18236.4 18527.4 21666.9 21873.8 21930.8 21951.2 22466.4 15115.0 16356.0 17015.6 17047.2 17907.8 9695.9 13064.0 13297.5 13347.6 14390.1 04:05:16 INFO - PID 1701 | 04:05:16 INFO - PID 1701 | [#2] jquery.html Cycles:180 Average:22277.57 Median:21891.40 stddev:55113.21 (251.8%) stddev-sans-first:55243.00 04:05:16 INFO - PID 1701 | Values: 249.9 262.3 285.3 296.4 297.9 11537.2 13018.8 13642.0 13707.2 13954.6 9705.5 9956.7 10164.3 10246.9 12245.3 3622.3 3669.0 3783.9 3882.6 3924.3 3632.5 3665.0 3667.5 3685.3 3745.0 3752.0 3796.0 3815.5 3892.7 3930.8 3249.2 3685.0 3753.0 3792.6 3838.7 3329.5 3443.0 3462.5 3463.4 3507.5 13389.9 14178.5 16792.0 16846.5 17514.0 1171.3 1243.3 1250.3 1280.6 1306.8 10308.0 11438.7 11742.0 11910.6 12082.0 1322.1 1326.4 1332.0 1346.0 1368.2 101099.0 104292.5 106324.5 106362.0 108835.0 8612.0 8692.8 8719.0 8738.4 8935.2 11204.5 11252.3 11282.3 11351.8 11406.1 4706.2 5080.7 5083.1 5232.0 5471.2 3668.5 4661.9 4672.1 4719.8 4751.2 4890.5 5007.9 5116.1 5140.4 5232.0 1404.0 1418.2 1481.2 1529.6 1531.8 504.3 504.5 604.5 620.5 650.8 9564.3 10799.9 11242.0 12402.6 13329.7 610.8 617.7 635.2 658.3 663.8 5603.6 6340.2 6736.1 6845.8 6983.6 275566.6 318030.4 321093.0 323344.0 348439.0 85484.0 87925.2 88058.6 88109.6 93462.5 598.8 699.5 712.3 727.6 732.8 9665.1 10602.5 10886.6 10947.6 11631.8 38160.0 39852.0 40187.4 40468.8 41193.6 53068.5 54487.4 55224.7 55478.7 56605.0 6368.7 6767.3 6848.9 7010.4 7121.4 8382.7 8845.7 10745.5 10784.2 11131.3 8619.0 8666.2 8752.6 8810.2 8816.2 6932.4 7206.8 7730.5 8176.9 8312.0 5241.5 7236.3 9311.8 9318.8 9725.8 5778.7 5818.2 5891.7 6473.2 7064.2 9017.3 9148.4 9164.0 9337.0 9430.7 04:05:16 INFO - PID 1701 | 04:05:16 INFO - PID 1701 | [#3] mootools.html Cycles:180 Average:4857.37 Median:4495.22 stddev:3214.18 (71.5%) stddev-sans-first:3208.72 04:05:16 INFO - PID 1701 | Values: 797.8 851.5 867.5 874.3 891.8 7372.3 8041.0 8187.9 8224.0 8412.9 6478.9 6494.5 6680.2 7383.6 7898.2 1576.8 1600.0 1640.5 1644.6 1673.7 1468.5 1633.9 1688.6 1691.7 1734.1 1553.0 1660.0 1662.3 1665.0 1691.2 1337.6 1409.3 1431.6 1516.2 1611.6 1586.2 1601.7 1632.2 1653.9 1682.4 7447.6 7588.5 7668.8 8037.9 8056.2 4315.7 4503.7 4574.6 4618.1 4697.2 2624.9 2726.6 2847.3 2862.8 2991.8 807.4 809.2 826.7 847.9 876.4 11821.3 12020.7 12150.2 12224.3 12331.3 4114.0 4154.6 4223.4 4277.2 4339.8 9416.4 9452.2 9674.6 9694.4 10001.2 4345.3 4448.5 4618.6 4673.5 4674.0 3904.4 3955.2 4015.3 4076.9 4197.9 2531.4 2699.2 2978.6 3196.9 3272.3 886.4 984.2 1007.2 1027.3 1047.5 443.5 505.2 511.7 512.9 543.7 3464.8 4334.1 4486.7 4732.7 4785.8 403.4 409.6 429.6 431.8 432.3 2465.3 2541.3 2713.2 2773.9 3070.1 10695.9 10705.7 10759.7 10807.5 10915.5 9389.2 10257.8 10265.0 10362.8 10743.2 5142.5 5271.8 5340.4 5452.2 5642.0 4365.2 4742.2 4956.3 4963.7 5091.7 9203.5 9401.1 9424.2 9691.4 9716.1 7434.3 9556.8 9635.4 9806.2 9925.8 5970.9 6076.8 6155.2 6305.0 6356.6 7026.7 7174.1 7232.7 7433.0 7581.0 5632.4 5673.1 5743.5 5979.6 6078.9 5655.7 5687.0 5905.0 6028.1 6064.5 5109.3 5136.3 5295.7 5521.8 5525.7 3840.3 3880.8 4011.0 4159.9 4449.2 3648.9 4000.4 4031.5 4240.0 4391.3 04:05:16 INFO - PID 1701 | 04:05:16 INFO - PID 1701 | [#4] prototype.html Cycles:180 Average:3318.23 Median:3771.28 stddev:1037.10 (27.5%) stddev-sans-first:1013.80 04:05:16 INFO - PID 1701 | Values: 231.5 234.9 238.3 289.9 290.7 3420.0 3909.4 4004.6 4041.6 4063.7 2954.0 3312.9 3929.5 3934.8 4032.3 2864.6 2894.0 2912.1 2954.6 2964.4 2793.2 2862.1 2919.5 2931.8 3014.3 2465.4 2723.5 2798.7 2849.3 2874.6 2471.4 2873.1 2885.7 2893.5 2908.6 2037.6 2254.3 2264.7 2518.5 2572.9 3845.9 3850.7 3855.3 3859.6 3869.7 3348.9 3435.6 3435.7 3449.8 3565.7 3212.7 3554.8 3598.8 4146.0 4187.9 2326.8 2832.5 2851.3 2852.4 2915.2 3912.2 3978.3 4262.6 4389.9 4549.2 2775.5 2822.9 2897.5 2902.5 2914.3 3004.7 3016.7 3041.6 3046.5 3052.2 3382.8 3417.3 3431.5 3447.8 3581.2 3249.8 3982.6 4082.3 4186.0 4197.6 864.1 932.5 985.1 993.0 1009.9 575.1 661.6 669.9 679.6 691.3 3782.2 3833.8 3841.0 3877.6 3882.6 4173.5 4317.7 4362.2 4370.5 4404.3 3152.3 3232.9 3403.6 3480.9 3940.9 1750.6 1965.5 2155.4 2308.2 2312.8 3328.0 3467.6 4312.0 4335.8 4432.8 4084.6 4153.1 4369.9 4482.2 4531.4 3683.6 4290.3 4356.7 4373.3 4402.6 3409.6 4241.7 4283.8 4287.4 4402.7 3229.8 3753.5 4117.3 4245.4 4286.0 4236.7 4342.7 4475.7 4543.5 4587.8 2500.9 2577.8 2885.5 2890.5 2899.9 3383.4 3750.4 3982.9 4245.2 4298.2 3760.3 3860.9 3946.3 3975.8 4148.8 3468.8 3912.4 3965.8 4064.7 4231.7 3685.8 3852.2 4003.4 4046.9 4117.7 3412.1 4069.6 4227.3 4240.8 4295.6 3369.0 3723.7 3913.0 3998.4 4007.0 04:05:16 INFO - PID 1701 | 04:05:16 INFO - PID 1701 | [#5] yui.html Cycles:180 Average:15570.72 Median:601.72 stddev:24505.77 (4072.7%) stddev-sans-first:24548.10 04:05:16 INFO - PID 1701 | Values: 415.5 488.6 491.4 510.5 516.7 7787.8 9464.0 9733.9 9761.3 9809.5 9610.0 10465.1 10755.6 11157.8 11247.8 561.4 572.9 587.0 598.5 599.4 594.5 604.0 608.3 609.5 615.5 589.9 609.1 634.5 635.8 658.7 614.0 619.4 621.8 635.9 645.4 454.1 462.8 468.8 469.9 470.8 10400.6 10411.7 10483.7 10778.0 10783.9 8892.0 9902.4 10663.0 10814.6 10931.5 8569.2 8631.4 8937.4 8945.0 8999.9 2080.2 2120.9 2122.7 2127.0 2204.3 61798.0 72700.3 83126.0 92021.0 98165.5 7771.2 7998.2 8311.4 8580.1 8591.6 11874.3 16147.9 16205.3 16495.4 16682.4 3479.8 3578.9 4024.6 4305.4 4651.5 2203.8 2266.4 2355.0 2379.5 2380.2 2681.2 2728.1 2729.0 2732.3 2847.0 546.9 606.6 609.4 628.4 628.6 335.0 367.3 404.5 414.9 432.4 5908.4 5962.3 6337.3 6514.2 7379.8 361.0 374.5 391.6 392.9 393.6 2391.0 3141.7 3187.4 3264.0 3616.1 87067.0 88344.0 94883.0 96435.0 97052.0 69125.7 72793.0 73746.0 77504.6 77598.0 61449.4 65551.3 65653.7 69789.0 71257.6 5768.7 6154.7 6688.4 6799.5 6861.7 20704.8 23339.0 24142.6 27735.0 29251.9 44065.8 50355.0 50694.0 53768.1 57130.4 8152.6 8288.7 9613.5 9899.0 9954.5 10479.9 10499.9 10936.5 10993.3 11492.4 9460.5 9466.2 9816.1 9958.9 10168.1 9383.3 9416.2 9492.0 9514.0 9699.0 9388.7 9503.0 9662.5 9838.7 10206.1 5749.9 7103.1 7311.1 7427.4 7574.6 7272.3 7435.2 7755.3 7777.5 8373.9 04:05:16 INFO - PID 1701 | -------- Summary: end -------- 04:05:16 INFO - PID 1701 | 04:05:17 INFO - TEST-INFO | 1701: exit 0 04:05:17 INFO - TEST-OK | dromaeo_css | took 1149839ms 04:05:17 INFO - TEST-START | kraken 04:05:17 INFO - operating with platform_type : mac_ 04:05:17 INFO - Initialising browser for kraken test... 04:05:17 INFO - Application command: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox http://localhost:49228/getInfo.html -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpMt0mx4/profile 04:05:17 INFO - TEST-INFO | started process 1825 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox http://localhost:49228/getInfo.html -foreground) 04:05:52 INFO - TEST-INFO | 1825: killed by SIGTERM 04:05:52 INFO - Browser initialized. 04:05:52 INFO - Running cycle 1/1 for kraken test... 04:05:52 INFO - TEST-INFO | started process 1833 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/T/tmpMt0mx4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:55 INFO - PID 1833 | 2017-06-15 04:05:55.570 plugin-container[1834:11260] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x973f, name = 'com.apple.tsm.portname' 04:05:55 INFO - PID 1833 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:05:55 INFO - PID 1833 | 2017-06-15 04:05:55.571 plugin-container[1834:11260] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x491f, name = 'com.apple.CFPasteboardClient' 04:05:55 INFO - PID 1833 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:05:55 INFO - PID 1833 | 2017-06-15 04:05:55.571 plugin-container[1834:11260] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:05:56 INFO - PID 1833 | 2017-06-15 04:05:56.391 plugin-container[1835:11304] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4947, name = 'com.apple.tsm.portname' 04:05:56 INFO - PID 1833 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:05:56 INFO - PID 1833 | 2017-06-15 04:05:56.392 plugin-container[1835:11304] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a1b, name = 'com.apple.CFPasteboardClient' 04:05:56 INFO - PID 1833 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:05:56 INFO - PID 1833 | 2017-06-15 04:05:56.392 plugin-container[1835:11304] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:06:05 INFO - PID 1833 | RSS: Main: 253718528 04:06:05 INFO - PID 1833 | 04:06:09 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-beat-detection) 04:06:11 INFO - PID 1833 | RSS: Main: 265961472 04:06:11 INFO - PID 1833 | 04:06:15 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-dft) 04:06:15 INFO - PID 1833 | RSS: Main: 276312064 04:06:15 INFO - PID 1833 | 04:06:20 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-fft) 04:06:21 INFO - PID 1833 | RSS: Main: 275914752 04:06:21 INFO - PID 1833 | 04:06:23 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49228/tests/kraken/driver.html?testName=audio-oscillator) 04:06:24 INFO - PID 1833 | RSS: Main: 281522176 04:06:24 INFO - PID 1833 | 04:06:27 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49228/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:06:28 INFO - PID 1833 | RSS: Main: 281862144 04:06:28 INFO - PID 1833 | 04:06:33 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49228/tests/kraken/driver.html?testName=imaging-darkroom) 04:06:33 INFO - PID 1833 | RSS: Main: 280784896 04:06:33 INFO - PID 1833 | 04:06:38 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49228/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:39 INFO - PID 1833 | RSS: Main: 281464832 04:06:39 INFO - PID 1833 | 04:06:43 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49228/tests/kraken/driver.html?testName=json-parse-financial) 04:06:44 INFO - PID 1833 | RSS: Main: 280211456 04:06:44 INFO - PID 1833 | 04:06:46 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49228/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:47 INFO - PID 1833 | RSS: Main: 285462528 04:06:47 INFO - PID 1833 | 04:06:49 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:50 INFO - PID 1833 | RSS: Main: 285327360 04:06:50 INFO - PID 1833 | 04:06:53 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:54 INFO - PID 1833 | RSS: Main: 291704832 04:06:54 INFO - PID 1833 | 04:06:58 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:59 INFO - PID 1833 | RSS: Main: 283889664 04:06:59 INFO - PID 1833 | 04:07:04 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:07:05 INFO - PID 1833 | RSS: Main: 283398144 04:07:05 INFO - PID 1833 | 04:07:07 INFO - PID 1833 | Cycle 1(1): loaded http://localhost:49228/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49228/tests/kraken/driver.html?testName=ai-astar) 04:07:08 INFO - PID 1833 | RSS: Main: 289546240 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | __start_tp_report 04:07:08 INFO - PID 1833 | _x_x_mozilla_page_load 04:07:08 INFO - PID 1833 | _x_x_mozilla_page_load_details 04:07:08 INFO - PID 1833 | |i|pagename|runs| 04:07:08 INFO - PID 1833 | |0;ai-astar;213;197;263;187;215;199;196;190;206;204 04:07:08 INFO - PID 1833 | |1;audio-beat-detection;268;267;271;262;224;233;282;261;287;196 04:07:08 INFO - PID 1833 | |2;audio-dft;266;346;286;278;277;288;265;327;285;272 04:07:08 INFO - PID 1833 | |3;audio-fft;116;139;123;235;117;108;94;113;234;101 04:07:08 INFO - PID 1833 | |4;audio-oscillator;109;121;180;111;124;129;181;121;129;216 04:07:08 INFO - PID 1833 | |5;imaging-gaussian-blur;177;196;211;180;162;238;181;238;172;179 04:07:08 INFO - PID 1833 | |6;imaging-darkroom;184;165;225;170;178;176;177;187;187;183 04:07:08 INFO - PID 1833 | |7;imaging-desaturate;148;147;139;149;146;149;198;138;186;225 04:07:08 INFO - PID 1833 | |8;json-parse-financial;95;91;102;100;75;92;98;92;81;94 04:07:08 INFO - PID 1833 | |9;json-stringify-tinderbox;84;92;104;102;98;109;104;103;94;101 04:07:08 INFO - PID 1833 | |10;stanford-crypto-aes;137;156;136;147;132;142;137;168;168;136 04:07:08 INFO - PID 1833 | |11;stanford-crypto-ccm;245;245;268;248;281;276;218;234;279;347 04:07:08 INFO - PID 1833 | |12;stanford-crypto-pbkdf2;321;375;379;378;328;358;331;337;330;429 04:07:08 INFO - PID 1833 | |13;stanford-crypto-sha256-iterative;113;115;132;107;118;107;122;111;103;121 04:07:08 INFO - PID 1833 | __end_tp_report 04:07:08 INFO - PID 1833 | __start_cc_report 04:07:08 INFO - PID 1833 | _x_x_mozilla_cycle_collect,1600 04:07:08 INFO - PID 1833 | __end_cc_report 04:07:08 INFO - PID 1833 | __startTimestamp1497524828059__endTimestamp 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | ------- Summary: start ------- 04:07:08 INFO - PID 1833 | Number of tests: 14 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#0] ai-astar Cycles:10 Average:207.00 Median:205.00 stddev:21.65 (10.6%) stddev-sans-first:22.86 04:07:08 INFO - PID 1833 | Values: 213.0 197.0 263.0 187.0 215.0 199.0 196.0 190.0 206.0 204.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#1] audio-beat-detection Cycles:10 Average:255.10 Median:267.50 stddev:28.54 (10.7%) stddev-sans-first:29.89 04:07:08 INFO - PID 1833 | Values: 268.0 267.0 271.0 262.0 224.0 233.0 282.0 261.0 287.0 196.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#2] audio-dft Cycles:10 Average:289.00 Median:285.50 stddev:26.62 (9.3%) stddev-sans-first:26.90 04:07:08 INFO - PID 1833 | Values: 266.0 346.0 286.0 278.0 277.0 288.0 265.0 327.0 285.0 272.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#3] audio-fft Cycles:10 Average:138.00 Median:131.00 stddev:52.29 (39.9%) stddev-sans-first:54.85 04:07:08 INFO - PID 1833 | Values: 116.0 139.0 123.0 235.0 117.0 108.0 94.0 113.0 234.0 101.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#4] audio-oscillator Cycles:10 Average:142.10 Median:129.00 stddev:36.57 (28.3%) stddev-sans-first:36.77 04:07:08 INFO - PID 1833 | Values: 109.0 121.0 180.0 111.0 124.0 129.0 181.0 121.0 129.0 216.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#5] imaging-gaussian-blur Cycles:10 Average:193.40 Median:188.50 stddev:26.97 (14.3%) stddev-sans-first:27.95 04:07:08 INFO - PID 1833 | Values: 177.0 196.0 211.0 180.0 162.0 238.0 181.0 238.0 172.0 179.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#6] imaging-darkroom Cycles:10 Average:183.20 Median:183.50 stddev:16.33 (8.9%) stddev-sans-first:17.32 04:07:08 INFO - PID 1833 | Values: 184.0 165.0 225.0 170.0 178.0 176.0 177.0 187.0 187.0 183.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#7] imaging-desaturate Cycles:10 Average:162.50 Median:149.00 stddev:29.74 (20.0%) stddev-sans-first:31.07 04:07:08 INFO - PID 1833 | Values: 148.0 147.0 139.0 149.0 146.0 149.0 198.0 138.0 186.0 225.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#8] json-parse-financial Cycles:10 Average:92.00 Median:92.00 stddev:8.33 (9.1%) stddev-sans-first:8.76 04:07:08 INFO - PID 1833 | Values: 95.0 91.0 102.0 100.0 75.0 92.0 98.0 92.0 81.0 94.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#9] json-stringify-tinderbox Cycles:10 Average:99.10 Median:96.50 stddev:7.29 (7.6%) stddev-sans-first:5.31 04:07:08 INFO - PID 1833 | Values: 84.0 92.0 104.0 102.0 98.0 109.0 104.0 103.0 94.0 101.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#10] stanford-crypto-aes Cycles:10 Average:145.90 Median:144.50 stddev:13.51 (9.4%) stddev-sans-first:13.94 04:07:08 INFO - PID 1833 | Values: 137.0 156.0 136.0 147.0 132.0 142.0 137.0 168.0 168.0 136.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#11] stanford-crypto-ccm Cycles:10 Average:264.10 Median:272.00 stddev:35.83 (13.2%) stddev-sans-first:37.34 04:07:08 INFO - PID 1833 | Values: 245.0 245.0 268.0 248.0 281.0 276.0 218.0 234.0 279.0 347.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:356.60 Median:366.50 stddev:33.95 (9.3%) stddev-sans-first:33.48 04:07:08 INFO - PID 1833 | Values: 321.0 375.0 379.0 378.0 328.0 358.0 331.0 337.0 330.0 429.0 04:07:08 INFO - PID 1833 | 04:07:08 INFO - PID 1833 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:114.90 Median:116.50 stddev:8.66 (7.4%) stddev-sans-first:9.16 04:07:08 INFO - PID 1833 | Values: 113.0 115.0 132.0 107.0 118.0 107.0 122.0 111.0 103.0 121.0 04:07:08 INFO - PID 1833 | -------- Summary: end -------- 04:07:08 INFO - PID 1833 | 04:07:09 INFO - TEST-INFO | 1833: exit 0 04:07:09 INFO - TEST-OK | kraken | took 112148ms 04:07:09 INFO - SUITE-END | took 1261s 04:07:09 INFO - Completed test suite (00:21:02) 04:07:09 INFO - javascript benchmark 04:07:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 4897.763545415877, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1690.028233765585, 1972.6942323939777, 2179.891005449727, 2226.8997895094717, 2232.3079845247976, 3614.4216925291958, 3752.5496940367125, 3754.7371683982133, 3775.697944164467, 3908.433277174808, 3720.069982504374, 3744.2698673758628, 3745.4756334113245, 3845.057960799608, 3866.2847373235973, 2434.354895952565, 3160.336329370829, 3260.6413294537583, 3313.9005829825146, 3326.9833650831833, 3190.4416727072785, 3279.26216601264, 3333.666633336671, 3370.9662903371022, 3401.979406178149, 3310.0897253255307, 3325.0, 3356.681115294043, 3356.9328613427715, 3417.0773891049525, 3162.414953233659, 3254.6908043735807, 3284.343131373711, 3315.668433156689, 3319.6016478022552, 2809.0028040045695, 3043.8630261638277, 3233.725133363667, 3259.168911927467, 3275.9189467475676, 3112.7665425092982, 3487.2676737885076, 3743.681787048104, 3788.981055094707, 3808.8286027128847, 3944.9013774655577, 3955.367141257385, 3985.720999530034, 3997.6601988830985, 4029.9395509067385, 3881.146147847469, 3893.6301051400073, 4016.979915100435, 4077.4699289092227, 4220.451341325639, 3794.354959656865, 3803.8858834234466, 3816.561095474056, 3962.385830196324, 4059.208454351432, 3804.6956243500454, 4110.17796440713, 4115.938260926088, 4125.608067233608, 4132.958670413317, 3799.069228039148, 3846.3461211593535, 3993.6405723485027, 3996.7801770902297, 4006.45912801768, 3826.3877779555696, 3923.6272554107886, 3972.8808135755394, 3975.582563830814, 4218.599233072853, 3725.3108174987715, 3835.4438606401914, 3837.808109594565, 3923.6468717815533, 3955.960440395617, 4003.719739618257, 4032.5765794591734, 4047.1298670785923, 4048.4939382577177, 4049.959500405017, 3060.2196439908125, 3125.0, 3128.7966282191583, 3162.177833763238, 3163.9525407118913, 2825.6467941507312, 2906.6076079729387, 2907.6074729911616, 2923.7076292371016, 2958.8224706517676, 3498.2478767065204, 3571.9641304021543, 3716.3682174030478, 3808.914459379064, 3827.3876179811095, 3804.600516945736, 3832.7317087803585, 4009.1580768038457, 4022.8735953932946, 4037.4953130858644, 3267.428200064979, 3422.606400263952, 3781.810909454571, 3784.299904517673, 3822.369309063973, 3206.5350524173864, 3678.70570354371, 3701.11173318407, 3702.1114932416026, 3707.8146092695797, 4240.491141063092, 4280.422143010654, 4343.391925130484, 4344.000879797664, 4462.576055274743, 3886.6696330812197, 4122.979385103055, 4123.814428350672, 4207.305794543866, 4416.381706561148, 4011.51861776577, 4135.77253251062, 4180.623743863067, 4257.808398622007, 4259.574042595716, 3954.466147070224, 3997.1006523531973, 4005.7396269242404, 4036.8788936331957, 4077.082656402286, 4013.9397909031973, 4064.1871625674394, 4095.242380159561, 4193.643540299109, 4196.28663127263, 3885.3977633466857, 3911.06134527717, 3917.588653191488, 3955.3473676843, 4071.592840716023, 3719.6094410086553, 3732.720045996507, 3747.8313475894197, 3807.3908174691915, 3991.421243919557, 3291.9835400822844, 3682.429223470366, 3717.2937141942944, 3735.439684047306, 3752.9866935927694, 3753.906152346104, 3887.1642596841816, 3930.4890364252465, 3945.230680017369, 4030.3954406838034, 3752.718546109107, 3791.5071040764524, 3848.249591329664, 3856.942145867758, 3872.9806350968065], "value": 3660.330855195663, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [478.18708196066694, 479.32654620258535, 488.8020351757538, 512.9051125541778, 513.9229115632654, 23164.420889477773, 23246.0, 23909.641355379663, 24795.75204247957, 25004.749952500468, 23077.96149173287, 23185.76814231857, 23334.88332558335, 23559.175428859995, 24157.033718651233, 4339.826406943735, 4424.646028317743, 4436.55634436557, 4438.844640437585, 4471.351654010183, 4957.355543779304, 5053.963937392844, 5139.588832893378, 5152.8711782205555, 5277.683338999653, 5064.468230835764, 5149.536541711245, 5250.422453530108, 5255.395629502599, 5302.575793936476, 4926.817563784702, 4956.306117143621, 5061.240813877911, 5065.569426598707, 5186.766595503212, 5002.124628190052, 5007.54932056113, 5040.773165207538, 5070.923936140961, 5126.026055049529, 19619.117139728747, 21934.341969740934, 22291.44271393228, 22403.887980560157, 22970.196043138578, 2072.95854082919, 2083.156321689718, 2098.4544018555134, 2109.4093653776968, 2122.90446929887, 18753.53116172093, 18868.1509332079, 18958.81041189598, 19414.70877936832, 19500.80499195004, 1792.265171279769, 1799.1454059321848, 1801.6216594515167, 1819.672458957387, 1854.1285595769966, 138031.0, 165151.0, 166278.0, 169381.0, 171328.0, 22655.546889062127, 22758.886205569197, 22942.394032417906, 23216.4195895104, 24004.87997560001, 27003.729962700123, 30690.53964190539, 31119.377612447624, 31279.843600782304, 32448.728588998543, 7369.263073692588, 7385.187629360766, 7415.555066696015, 7555.773326800205, 7659.846803064019, 5756.7121643917635, 5764.308283005982, 5786.652800831879, 5814.622049566765, 5850.736716847752, 7562.962185189039, 8168.550729709804, 8176.0, 8211.21993410625, 8412.579371031425, 3436.226848959014, 3467.514547963287, 3591.7910485052025, 3639.2357604902736, 3679.4848721179055, 568.8151350811003, 588.3498733899065, 606.5420607441441, 625.64338327154, 634.5875181132209, 16834.831651683573, 17325.393611223546, 17693.115344232738, 17715.114244287994, 18680.906595466935, 625.1102271168534, 651.0689713709346, 656.1076935367992, 696.9337912898267, 712.4905692429937, 5771.682557459296, 6809.659517024129, 7371.447141464411, 7667.386609071373, 7703.460757746904, 156613.0, 159195.6120658191, 168720.0, 171663.0, 178670.0, 32382.190445238586, 33080.17299567482, 33156.0, 33931.491027634605, 34443.0, 798.5967086621336, 875.3916028360228, 896.9596368163449, 902.201551626815, 904.7602385367883, 13232.867671323549, 15982.840171598134, 16477.176141193133, 16659.083750393846, 17430.825691743426, 22704.205352813235, 22913.083476661413, 23346.0, 23592.0, 24121.879390602935, 132429.0, 163565.0, 165227.0, 169900.15049925167, 174556.0, 16411.0, 16565.0, 18810.717839232148, 19597.804021959597, 19990.700604460664, 24525.50948981046, 25136.24591262265, 25607.0, 25791.710414478825, 26687.0, 14051.789223161457, 17228.224729887435, 17790.555236119202, 17879.642407152045, 18077.638447231246, 16774.832251677326, 16933.068681222157, 17163.7425438616, 18236.36172733948, 18527.351542695942, 21666.89166554157, 21873.781262187174, 21930.780692192875, 21951.231706890183, 22466.438339041655, 15115.0, 16356.0, 17015.574610634834, 17047.232874520923, 17907.820921790615, 9695.9030409695, 13064.0, 13297.468101275841, 13347.599572012856, 14390.06464579799], "value": 10170.00415010449, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [249.90253801017607, 262.28788838304024, 285.3138202622693, 296.4308527626957, 297.88978078111097, 11537.192396532235, 13018.804717929226, 13642.0, 13707.177569345846, 13954.58136255914, 9705.466199359033, 9956.701298961025, 10164.288499804998, 10246.948765256182, 12245.265284082961, 3622.34797736408, 3668.9543480108173, 3783.924321513568, 3882.611738826109, 3924.313245182096, 3632.4914511968345, 3664.992127165024, 3667.486551882725, 3685.3366394049062, 3745.0, 3752.0, 3796.0130366104872, 3815.465834783133, 3892.746971446861, 3930.8034598270115, 3249.155219642898, 3684.9815750921075, 3752.9812350938346, 3792.58281589025, 3838.692904567642, 3329.4839299908554, 3443.0, 3462.4633181856852, 3463.445848664227, 3507.526483924663, 13389.861861741763, 14178.503752368617, 16791.992480451212, 16846.494605161864, 17514.0, 1171.3030746705697, 1243.2540475714588, 1250.2560976219136, 1280.6286177008656, 1306.751717173734, 10308.0, 11438.714032149179, 11742.0, 11910.58312959051, 12082.0, 1322.1406086044053, 1326.3633455941201, 1331.9544157836149, 1345.986540134596, 1368.1517459175275, 101099.0, 104292.47853760759, 106324.46837765761, 106362.0, 108835.0, 8612.0, 8692.826143477096, 8719.0, 8738.432001919855, 8935.195832375117, 11204.49579768896, 11252.324860508395, 11282.323060616389, 11351.829722554168, 11406.144539159597, 4706.223473126965, 5080.7205603692155, 5083.110455670243, 5232.0, 5471.179323101487, 3668.5414323209598, 4661.90445245367, 4672.112298663243, 4719.834805781781, 4751.192297309466, 4890.462049174588, 5007.873228523553, 5116.053530096944, 5140.40885298188, 5231.973840130851, 1403.9929800351138, 1418.170370333346, 1481.1779462398472, 1529.5640742388366, 1531.7778922056239, 504.3418339067552, 504.4904646307256, 604.5043064686914, 620.5097972601684, 650.8307839961644, 9564.330496865152, 10799.946000270105, 11242.0, 12402.627921162379, 13329.73340533184, 610.8075956073823, 617.6510271696477, 635.1679300116862, 658.3317932298721, 663.7909058646511, 5603.551715862721, 6340.175777149033, 6736.124303840469, 6845.828854278683, 6983.615901125385, 275566.6221668919, 318030.4098479539, 321093.0, 323344.0, 348439.0, 85484.0, 87925.24149516974, 88058.55970720106, 88109.55945220233, 93462.53268733749, 598.8443004818779, 699.5033526196356, 712.2805965974403, 727.5634619228526, 732.772840419461, 9665.130138287306, 10602.469876506299, 10886.61896833607, 10947.616833410792, 11631.76736465283, 38160.04599885025, 39852.0, 40187.39718904277, 40468.797656011535, 41193.58806411897, 53068.4693153079, 54487.36537903869, 55224.72387638197, 55478.72260638671, 56605.0, 6368.745250189941, 6767.323267673193, 6848.863022739418, 7010.439164866696, 7121.359077682826, 8382.748517544484, 8845.69040083594, 10745.462726863781, 10784.245102842726, 11131.276467029616, 8619.008813986471, 8666.176713212235, 8752.562371881508, 8810.207081362709, 8816.162464565856, 6932.410745086724, 7206.819829504304, 7730.497517661334, 8176.918230817853, 8311.96100487439, 5241.50205730455, 7236.348728614239, 9311.836020497438, 9318.813623727352, 9725.756856078655, 5778.739956701875, 5818.185454036354, 5891.675957822361, 6473.223213214256, 7064.187618423947, 9017.2786177107, 9148.405353652257, 9163.991960884165, 9336.95331523338, 9430.669926552539], "value": 6632.138207710711, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.7566842113155, 851.4763420496397, 867.5271976772658, 874.33113668044, 891.8305521950829, 7372.262773722625, 8041.0, 8187.877181842277, 8223.958880205599, 8412.873806892901, 6478.870422591545, 6494.545381823263, 6680.231773346067, 7383.593902335369, 7898.170692077335, 1576.7713681516202, 1599.9760003599956, 1640.5242479680878, 1644.6464010237796, 1673.6652669466155, 1468.4786900650276, 1633.8774591905594, 1688.5694147992244, 1691.6532110917233, 1734.1156010434643, 1552.968940621187, 1659.9751003734953, 1662.3018332300462, 1664.9667006659859, 1691.2220378625848, 1337.565291280333, 1409.3305679802165, 1431.6277767780452, 1516.249456519019, 1611.6212690017837, 1586.1831156954063, 1601.7036848183122, 1632.2002218912646, 1653.884228104021, 1682.3775203174903, 7447.553146811155, 7588.468807183499, 7668.769936901902, 8037.879431808527, 8056.234657707509, 4315.719478233905, 4503.707259028185, 4574.611158051536, 4618.145643056012, 4697.177993851063, 2624.8687565621835, 2726.5910113482937, 2847.345110624568, 2862.756665683419, 2991.7756168287465, 807.4146243973131, 809.1544336168658, 826.7147833997261, 847.9321654267706, 876.4478378621428, 11821.34982575958, 12020.737822528596, 12150.21023633461, 12224.266544007389, 12331.321777302244, 4113.958860411358, 4154.584541545822, 4223.387608796707, 4277.230098582285, 4339.848105316362, 9416.387934784218, 9452.19656329206, 9674.56464459101, 9694.418334899787, 10001.24990625706, 4345.30475123985, 4448.488423831236, 4618.607418369476, 4673.509281525459, 4674.018456124184, 3904.355781296111, 3955.1891862168186, 4015.3374693175883, 4076.9388459173138, 4197.853075142355, 2531.4304281536874, 2699.190242927153, 2978.6447166539174, 3196.9040928772174, 3272.345530893831, 886.423824514071, 984.247051005981, 1007.1841808135433, 1027.2655051638114, 1047.4972013433594, 443.49220142936156, 505.15891041416364, 511.71088335090553, 512.8998298649376, 543.665645627936, 3464.7574669772875, 4334.089841133335, 4486.725365178942, 4732.716037037789, 4785.832495862628, 403.39289369498715, 409.58631781900493, 429.60261757873843, 431.76253060816424, 432.3212556286663, 2465.272744540365, 2541.3265484646586, 2713.17248239285, 2773.8751756171023, 3070.1250143708935, 10695.930406959398, 10705.678829635124, 10759.677209683721, 10807.513661885234, 10915.454227288605, 9389.248860091177, 10257.846132308021, 10265.024822641837, 10362.792744145076, 10743.247972641997, 5142.537171654494, 5271.815486458032, 5340.412554618989, 5452.182172674051, 5641.971790141105, 4365.156571930277, 4742.193827049479, 4956.306117143531, 4963.6525443218625, 5091.66904151229, 9203.539823008688, 9401.10689484498, 9424.198943089914, 9691.418514889128, 9716.076972687584, 7434.3309102181065, 9556.76108097303, 9635.421874687541, 9806.215502759906, 9925.751856203653, 5970.940290597212, 6076.756929722762, 6155.230596175478, 6304.968475157778, 6356.55504114726, 7026.718931242693, 7174.139103307636, 7232.710691572278, 7433.033705618452, 7581.0, 5632.436756324335, 5673.149027645886, 5743.540516758733, 5979.611325263844, 6078.939210607838, 5655.717214139194, 5687.033204355353, 5905.025670764276, 6028.09578563219, 6064.545159112996, 5109.310243117132, 5136.30659860914, 5295.682259064469, 5521.834344969658, 5525.668459892419, 3840.327942610088, 3880.7865567394065, 4010.979945100256, 4159.854405095807, 4449.154660614473, 3648.890533284006, 4000.439938408567, 4031.455753473361, 4239.957600423956, 4391.3193455014525], "value": 3587.410620953958, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [231.54385859856086, 234.86143175526436, 238.30890417788422, 289.92606885244254, 290.7208283552369, 3420.0, 3909.394043923193, 4004.6195611416906, 4041.595840415957, 4063.7155399122075, 2953.9852300738467, 3312.850921708523, 3929.5481019682743, 3934.803259837011, 4032.314506533889, 2864.64191976003, 2894.0062713455404, 2912.082693951409, 2954.6454425468974, 2964.3774807290497, 2793.2458236276193, 2862.0520863510515, 2919.5182794838825, 2931.780116491261, 3014.3368458939, 2465.359006658273, 2723.509768241716, 2798.670631450055, 2849.3446507303333, 2874.5688146778048, 2471.394508345467, 2873.1380585824168, 2885.6970018148004, 2893.537034074538, 2908.6218791557176, 2037.5822956293923, 2254.3349711834885, 2264.7169103862016, 2518.5214809186195, 2572.897084116633, 3845.8653947111716, 3850.6726928210855, 3855.2867719471988, 3859.614038596146, 3869.6517313441645, 3348.866045358183, 3435.587729472479, 3435.6736110069505, 3449.7757645752945, 3565.732570057256, 3212.6909283438094, 3554.7689400188906, 3598.784072955631, 4146.019820971871, 4187.874363769091, 2326.8254880884, 2832.475991941477, 2851.303474432709, 2852.3724780548246, 2915.2420370703558, 3912.2371137628174, 3978.303796835542, 4262.616364527207, 4389.934150987706, 4549.203889319356, 2775.4726601945567, 2822.9011984580443, 2897.5219088850527, 2902.460347196203, 2914.2714321419644, 3004.7014034263807, 3016.713412225835, 3041.558973948765, 3046.497327940909, 3052.236940764809, 3382.797032178028, 3417.333619944087, 3431.5244444888936, 3447.793132412063, 3581.158427769472, 3249.8212598306845, 3982.5818289079807, 4082.2856000199845, 4185.979070104691, 4197.601227883346, 864.0538610221797, 932.4638332958576, 985.1429256546706, 992.9673139934388, 1009.9495025248708, 575.0628379922271, 661.5798967655574, 669.926308106108, 679.5956405938458, 691.2776148924386, 3782.243551289698, 3833.846646134179, 3840.9615903840604, 3877.612238776156, 3882.5923278055398, 4173.52004519478, 4317.7193482423545, 4362.236608593484, 4370.541093185233, 4404.295312749945, 3152.2907345847, 3232.854521546536, 3403.6045221459085, 3480.8781692640637, 3940.9211815763524, 1750.5886116762551, 1965.5380985468403, 2155.374941267015, 2308.2457332427475, 2312.838101332924, 3327.966720332814, 3467.5665541807275, 4311.986683129462, 4335.826566937287, 4432.82268709248, 4084.571120032413, 4153.127843152912, 4369.868903932887, 4482.21561226784, 4531.4109165808895, 3683.6132206117973, 4290.270653988767, 4356.6732495063, 4373.250699720137, 4402.647788176874, 3409.590849098124, 4241.745495270294, 4283.807228674655, 4287.3783301421745, 4402.713823601455, 3229.8223597702354, 3753.4932784074895, 4117.341225403921, 4245.384419259129, 4286.0, 4236.703430759941, 4342.717723347972, 4475.70907890986, 4543.545645435563, 4587.793549290223, 2500.9249722508353, 2577.7937764978383, 2885.5094633912704, 2890.4652639261803, 2899.913002609925, 3383.3571621391857, 3750.4248215749994, 3982.90042748922, 4245.195791788539, 4298.20483210607, 3760.3231418344963, 3860.8841734748003, 3946.250212459738, 3975.7597557990143, 4148.755373388032, 3468.7745296555645, 3912.374020156761, 3965.759345969518, 4064.7357921734992, 4231.703780735319, 3685.8157092144747, 3852.1910398816563, 4003.4195041718203, 4046.8988275293354, 4117.711760176759, 3412.1233321672485, 4069.5726948669962, 4227.281362168377, 4240.78796060202, 4295.634871035997, 3368.983155084209, 3723.7153182152115, 3913.032625246522, 3998.400239963912, 4006.9799651002722], "value": 3000.3618180149656, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.4951733643623, 488.64573184441286, 491.42257847029754, 510.49971028392196, 516.7185380256963, 7787.831825226219, 9463.952680236598, 9733.853992190114, 9761.267904907125, 9809.50952452378, 9609.951950240256, 10465.05814476697, 10755.569777208902, 11157.772645009043, 11247.775044499105, 561.3993027460629, 572.9484346408823, 586.988260234795, 598.5181928547518, 599.3856297295285, 594.459042271533, 604.0456079394568, 608.3217212807709, 609.451493655709, 615.4860691322751, 589.8761260135356, 609.1106983803652, 634.4924060751381, 635.8427661655788, 658.6673729766461, 613.9662318572476, 619.4394073363613, 621.751299480207, 635.8537536366615, 645.3933302695451, 454.0895504513462, 462.7940566447932, 468.79607370793474, 469.86996273961176, 470.7716757372672, 10400.583976640924, 10411.739706507322, 10483.68548943533, 10777.976092271221, 10783.892161078367, 8892.0, 9902.356346837432, 10663.0, 10814.621488247953, 10931.453427328603, 8569.185927336894, 8631.438956467873, 8937.419067760575, 8945.016048234755, 8999.920009598825, 2080.20952038226, 2120.9045592948355, 2122.670985997173, 2126.9787302126933, 2204.2836078274627, 61798.0, 72700.27299726987, 83126.0, 92021.0, 98165.5275170873, 7771.222877712296, 7998.200179982072, 8311.376646751396, 8580.099089595627, 8591.5704214789, 11874.287542747463, 16147.919260403858, 16205.298443663482, 16495.422660206834, 16682.41517055878, 3479.756417050782, 3578.910527236788, 4024.6377825995214, 4305.440292761921, 4651.465081515601, 2203.8016578508013, 2266.3880752196815, 2354.9646755298686, 2379.5003049359484, 2380.2264264114233, 2681.1554360376417, 2728.0588197072375, 2729.0, 2732.27594687408, 2846.9857650711615, 546.8851541176318, 606.6299557270062, 609.3814778000333, 628.424991133108, 628.6071205496564, 334.9849256783402, 367.2691344224973, 404.52872403649417, 414.8713898691415, 432.38169417732314, 5908.379620139824, 5962.34414214436, 6337.271213810379, 6514.153160089253, 7379.778606641809, 360.9530761001053, 374.4738642207703, 391.6318660459159, 392.91163477168084, 393.6358868047045, 2391.0196819304, 3141.6701246368802, 3187.442197615408, 3263.951040734391, 3616.1140520572626, 87067.0, 88344.0, 94883.0, 96435.0, 97052.0, 69125.65437172783, 72793.0, 73746.0, 77504.61247693838, 77598.0, 61449.38550614437, 65551.34448655548, 65653.671731642, 69789.0, 71257.57484850274, 5768.654123492961, 6154.692265386623, 6688.3646053624825, 6799.490038247052, 6861.656917154222, 20704.79295207089, 23339.0, 24142.637860431758, 27735.0, 29251.85374073116, 44065.77967110144, 50355.0, 50694.0, 53768.11811586576, 57130.42869571251, 8152.551609661526, 8288.668453261802, 9613.471259080818, 9899.0, 9954.502274886372, 10479.895201048197, 10499.94750026245, 10936.453177340942, 10993.285436446606, 11492.36791976416, 9460.526973651427, 9466.195373393064, 9816.067473589997, 9958.904520502883, 10168.135708464863, 9383.296252780932, 9416.246700264099, 9491.9558848528, 9514.001029892039, 9698.95150524271, 9388.718338449857, 9503.0, 9662.516874156405, 9838.704838854846, 10206.081452669296, 5749.8562535936935, 7103.1476222851525, 7311.086114235721, 7427.405807535276, 7574.583397913168, 7272.345488906024, 7435.219301973431, 7755.2632499912415, 7777.494462859896, 8373.916260837557], "value": 5193.892008624925, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 2642.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [213.0, 197.0, 263.0, 187.0, 215.0, 199.0, 196.0, 190.0, 206.0, 204.0], "value": 207.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [268.0, 267.0, 271.0, 262.0, 224.0, 233.0, 282.0, 261.0, 287.0, 196.0], "value": 255.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [266.0, 346.0, 286.0, 278.0, 277.0, 288.0, 265.0, 327.0, 285.0, 272.0], "value": 289.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 139.0, 123.0, 235.0, 117.0, 108.0, 94.0, 113.0, 234.0, 101.0], "value": 138.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 121.0, 180.0, 111.0, 124.0, 129.0, 181.0, 121.0, 129.0, 216.0], "value": 142.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 196.0, 211.0, 180.0, 162.0, 238.0, 181.0, 238.0, 172.0, 179.0], "value": 193.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 165.0, 225.0, 170.0, 178.0, 176.0, 177.0, 187.0, 187.0, 183.0], "value": 183.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 139.0, 149.0, 146.0, 149.0, 198.0, 138.0, 186.0, 225.0], "value": 162.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 91.0, 102.0, 100.0, 75.0, 92.0, 98.0, 92.0, 81.0, 94.0], "value": 92.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 92.0, 104.0, 102.0, 98.0, 109.0, 104.0, 103.0, 94.0, 101.0], "value": 99.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 156.0, 136.0, 147.0, 132.0, 142.0, 137.0, 168.0, 168.0, 136.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [245.0, 245.0, 268.0, 248.0, 281.0, 276.0, 218.0, 234.0, 279.0, 347.0], "value": 264.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [321.0, 375.0, 379.0, 378.0, 328.0, 358.0, 331.0, 337.0, 330.0, 429.0], "value": 356.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 132.0, 107.0, 118.0, 107.0, 122.0, 111.0, 103.0, 121.0], "value": 114.9, "unit": "score"}]}]} 04:07:09 INFO - Return code: 0 04:07:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:07:09 INFO - # TBPL SUCCESS # 04:07:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:07:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:07:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:07:10 INFO - 2017-06-15 04:07:10.010 screenresolution[1849:11696] starting screenresolution argv=screenresolution get 04:07:10 INFO - 2017-06-15 04:07:10.014 screenresolution[1849:11696] Display 0: 1600x1200x32@60 04:07:10 INFO - 2017-06-15 04:07:10.023 screenresolution[1850:11699] starting screenresolution argv=screenresolution list 04:07:10 INFO - Available Modes on Display 0 04:07:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:07:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:07:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:07:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:07:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:07:10 INFO - Intel Iris: 04:07:10 INFO - Chipset Model: Intel Iris 04:07:10 INFO - Type: GPU 04:07:10 INFO - Bus: Built-In 04:07:10 INFO - VRAM (Dynamic, Max): 1536 MB 04:07:10 INFO - Vendor: Intel (0x8086) 04:07:10 INFO - Device ID: 0x0a2e 04:07:10 INFO - Revision ID: 0x0009 04:07:10 INFO - Displays: 04:07:10 INFO - Display: 04:07:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:07:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:07:10 INFO - Display Serial Number: 1600x1200 60 04:07:10 INFO - Main Display: Yes 04:07:10 INFO - Mirror: Off 04:07:10 INFO - Online: Yes 04:07:10 INFO - Rotation: Supported 04:07:10 INFO - Return code: 0 04:07:10 INFO - Running post-action listener: _resource_record_post_action 04:07:10 INFO - [mozharness: 2017-06-15 11:07:10.358458Z] Finished run-tests step (success) 04:07:10 INFO - Running post-run listener: _resource_record_post_run 04:07:10 INFO - Total resource usage - Wall time: 1300s; CPU: 55.0%; Read bytes: 35077632; Write bytes: 582837760; Read time: 254; Write time: 1913 04:07:10 INFO - TinderboxPrint: CPU usage
54.5% 04:07:10 INFO - TinderboxPrint: I/O read bytes / time
35,077,632 / 254 04:07:10 INFO - TinderboxPrint: I/O write bytes / time
582,837,760 / 1,913 04:07:10 INFO - TinderboxPrint: CPU idle
2,363.4 (45.5%) 04:07:10 INFO - TinderboxPrint: CPU system
1,080.3 (20.8%) 04:07:10 INFO - TinderboxPrint: CPU user
1,754.9 (33.8%) 04:07:10 INFO - TinderboxPrint: Swap in / out
284,151,808 / 0 04:07:10 INFO - install - Wall time: 37s; CPU: 55.0%; Read bytes: 246948352; Write bytes: 242139136; Read time: 29582; Write time: 492 04:07:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:07:10 INFO - run-tests - Wall time: 1264s; CPU: 55.0%; Read bytes: 34053632; Write bytes: 325395968; Read time: 238; Write time: 1382 04:07:11 INFO - Running post-run listener: _upload_blobber_files 04:07:11 INFO - Blob upload gear active. 04:07:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:07:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:07:11 INFO - (blobuploader) - INFO - Open directory for files ... 04:07:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:07:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:07:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:12 INFO - (blobuploader) - INFO - Done attempting. 04:07:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:07:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:07:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:13 INFO - (blobuploader) - INFO - Done attempting. 04:07:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:07:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:07:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:14 INFO - (blobuploader) - INFO - Done attempting. 04:07:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:07:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:07:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:16 INFO - (blobuploader) - INFO - Done attempting. 04:07:16 INFO - (blobuploader) - INFO - Iteration through files over. 04:07:16 INFO - Return code: 0 04:07:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:07:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:07:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad1c73a2ecfb6b313a05a18a90bad93ad1d38043641bcd0313d70ecc5b60e9d3ede11f6f1fca67366e2ce89a0b94a0760824aab0d42f161bb0ea47402016570a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba6a043ca492d54a69ccd1d2d96e8d5da2f44c25d5ee5b98a8049b3e16bda3b720829405695956146e90d800d0818d3b0e131b094e602113e6076eb171b36c87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fe94c8147e651739e49e783cec121c90084fb61b8bd12c3a6f16886136e8d13fa22fb280792e553724bddfc8480fafad42548eed7b416bdc8805a599b7259e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd92aa10b5effbbfb86c479582c7b37b4547c9e2fcacb7da05cc29d1bf363abfa19b86c73773eed17b2e0b3727005ed64925195419bcf9ebe9bfb1ec8ed4545e"} 04:07:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:07:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:07:16 INFO - Contents: 04:07:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad1c73a2ecfb6b313a05a18a90bad93ad1d38043641bcd0313d70ecc5b60e9d3ede11f6f1fca67366e2ce89a0b94a0760824aab0d42f161bb0ea47402016570a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba6a043ca492d54a69ccd1d2d96e8d5da2f44c25d5ee5b98a8049b3e16bda3b720829405695956146e90d800d0818d3b0e131b094e602113e6076eb171b36c87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fe94c8147e651739e49e783cec121c90084fb61b8bd12c3a6f16886136e8d13fa22fb280792e553724bddfc8480fafad42548eed7b416bdc8805a599b7259e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd92aa10b5effbbfb86c479582c7b37b4547c9e2fcacb7da05cc29d1bf363abfa19b86c73773eed17b2e0b3727005ed64925195419bcf9ebe9bfb1ec8ed4545e"} 04:07:16 INFO - Running post-run listener: copy_logs_to_upload_dir 04:07:16 INFO - Copying logs to upload dir... 04:07:16 INFO - mkdir: /builds/slave/test/build/upload/logs 04:07:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1423.528812 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 23 mins, 43 secs) (at 2017-06-15 04:07:16.993851) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-15 04:07:16.997338) ========= 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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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/ad1c73a2ecfb6b313a05a18a90bad93ad1d38043641bcd0313d70ecc5b60e9d3ede11f6f1fca67366e2ce89a0b94a0760824aab0d42f161bb0ea47402016570a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba6a043ca492d54a69ccd1d2d96e8d5da2f44c25d5ee5b98a8049b3e16bda3b720829405695956146e90d800d0818d3b0e131b094e602113e6076eb171b36c87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fe94c8147e651739e49e783cec121c90084fb61b8bd12c3a6f16886136e8d13fa22fb280792e553724bddfc8480fafad42548eed7b416bdc8805a599b7259e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd92aa10b5effbbfb86c479582c7b37b4547c9e2fcacb7da05cc29d1bf363abfa19b86c73773eed17b2e0b3727005ed64925195419bcf9ebe9bfb1ec8ed4545e"} build_url:https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.015742 build_url: 'https://queue.taskcluster.net/v1/task/bCtrgS--SzmC9Rvedkg_-A/artifacts/public/build/firefox-56.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad1c73a2ecfb6b313a05a18a90bad93ad1d38043641bcd0313d70ecc5b60e9d3ede11f6f1fca67366e2ce89a0b94a0760824aab0d42f161bb0ea47402016570a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba6a043ca492d54a69ccd1d2d96e8d5da2f44c25d5ee5b98a8049b3e16bda3b720829405695956146e90d800d0818d3b0e131b094e602113e6076eb171b36c87", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fe94c8147e651739e49e783cec121c90084fb61b8bd12c3a6f16886136e8d13fa22fb280792e553724bddfc8480fafad42548eed7b416bdc8805a599b7259e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd92aa10b5effbbfb86c479582c7b37b4547c9e2fcacb7da05cc29d1bf363abfa19b86c73773eed17b2e0b3727005ed64925195419bcf9ebe9bfb1ec8ed4545e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-15 04:07:17.047707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-15 04:07:17.048059) ========= 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.Ax1Q4QUAMp/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.TEryjlRLYW/Listeners TMPDIR=/var/folders/2t/z2gyjfx51g106820y9w1z5ph00000w/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.008389 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-15 04:07:17.100767) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-15 04:07:17.101079) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-15 04:07:17.101407) ========= ========= Total master_lag: 0.53 =========