builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0219 starttime: 1494597470.34 results: success (0) revision: bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:50.335966) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:50.336416) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:50.336738) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:50.361934) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:50.362269) ========= 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.OITsMlCfG0/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.gL5kZ68SUd/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-12 06:57:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2017-05-12 06:57:50 (19.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.085839 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:50.471706) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:50.472026) ========= 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.OITsMlCfG0/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.gL5kZ68SUd/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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.026292 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:50.521299) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:50.521947) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 --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 bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OITsMlCfG0/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.gL5kZ68SUd/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-12 06:57:50,627 truncating revision to first 12 chars 2017-05-12 06:57:50,627 Setting DEBUG logging. 2017-05-12 06:57:50,627 attempt 1/10 2017-05-12 06:57:50,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bcb5e1ff13f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 06:57:51,317 unpacking tar archive at: mozilla-central-bcb5e1ff13f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.958789 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:51.502832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:51.503150) ========= script_repo_revision: bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:51.503522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:51.503784) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:57:51.524146) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-05-12 06:57:51.524448) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.OITsMlCfG0/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.gL5kZ68SUd/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:57:51 INFO - MultiFileLogger online at 20170512 06:57:51 in /builds/slave/test 06:57:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:57:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:51 INFO - {'append_to_log': False, 06:57:51 INFO - 'base_work_dir': '/builds/slave/test', 06:57:51 INFO - 'blob_upload_branch': 'Firefox', 06:57:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:51 INFO - 'branch': 'Firefox', 06:57:51 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:51 INFO - 'config_files': ('talos/mac_config.py',), 06:57:51 INFO - 'default_actions': ('clobber', 06:57:51 INFO - 'read-buildbot-config', 06:57:51 INFO - 'download-and-extract', 06:57:51 INFO - 'populate-webroot', 06:57:51 INFO - 'create-virtualenv', 06:57:51 INFO - 'install', 06:57:51 INFO - 'run-tests'), 06:57:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:51 INFO - 'download_minidump_stackwalk': True, 06:57:51 INFO - 'download_symbols': 'ondemand', 06:57:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:51 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:51 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:51 INFO - 'gecko_profile': False, 06:57:51 INFO - 'gecko_profile_interval': 0, 06:57:51 INFO - 'installer_path': 'installer.exe', 06:57:51 INFO - 'log_level': 'info', 06:57:51 INFO - 'log_name': 'talos', 06:57:51 INFO - 'log_to_console': True, 06:57:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:57:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:57:51 INFO - 'opt_config_files': (), 06:57:51 INFO - 'pip_index': False, 06:57:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:57:51 INFO - 'cmd': ('bash', 06:57:51 INFO - '-c', 06:57:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:57:51 INFO - 'enabled': True, 06:57:51 INFO - 'halt_on_failure': False, 06:57:51 INFO - 'name': 'check_screen_resolution'},), 06:57:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:57:51 INFO - 'cmd': ('bash', 06:57:51 INFO - '-c', 06:57:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:57:51 INFO - 'enabled': True, 06:57:51 INFO - 'halt_on_failure': False, 06:57:51 INFO - 'name': 'check_screen_resolution'},), 06:57:51 INFO - 'run_cmd_checks_enabled': True, 06:57:51 INFO - 'suite': 'dromaeojs', 06:57:51 INFO - 'system_bits': '32', 06:57:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:51 INFO - 'title': 't-yosemite-r7-0219', 06:57:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:51 INFO - 'use_talos_json': True, 06:57:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:51 INFO - 'work_dir': 'build'} 06:57:51 INFO - [mozharness: 2017-05-12 13:57:51.737779Z] Running clobber step. 06:57:51 INFO - Running pre-action listener: _resource_record_pre_action 06:57:51 INFO - Running main action method: clobber 06:57:51 INFO - rmtree: /builds/slave/test/build 06:57:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:51 INFO - Running post-action listener: _resource_record_post_action 06:57:51 INFO - [mozharness: 2017-05-12 13:57:51.743176Z] Finished clobber step (success) 06:57:51 INFO - [mozharness: 2017-05-12 13:57:51.743320Z] Running read-buildbot-config step. 06:57:51 INFO - Running pre-action listener: _resource_record_pre_action 06:57:51 INFO - Running main action method: read_buildbot_config 06:57:51 INFO - Using buildbot properties: 06:57:51 INFO - { 06:57:51 INFO - "project": "", 06:57:51 INFO - "product": "firefox", 06:57:51 INFO - "who": "cbook@mozilla.com", 06:57:51 INFO - "installer_path": "public/build/firefox-55.0a1.en-US.mac.dmg", 06:57:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:57:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:57:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:57:51 INFO - "stage_platform": "macosx64", 06:57:51 INFO - "basedir": "/builds/slave/test", 06:57:51 INFO - "buildnumber": 51, 06:57:51 INFO - "platform": "yosemite_r7", 06:57:51 INFO - "parent_task_id": "BWX4BTA0R-66tGAAkAc8SQ", 06:57:51 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 06:57:51 INFO - "slavebuilddir": "test", 06:57:51 INFO - "taskId": "Q79TbfpwQK-ikCGzqg1nsg", 06:57:51 INFO - "branch": "mozilla-central", 06:57:51 INFO - "script_repo_revision": "production", 06:57:51 INFO - "revision": "bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501", 06:57:51 INFO - "slavename": "t-yosemite-r7-0219", 06:57:51 INFO - "repo_path": "mozilla-central" 06:57:51 INFO - } 06:57:51 INFO - Finding installer, test and symbols from parent task. 06:57:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q79TbfpwQK-ikCGzqg1nsg'}, attempt #1 06:57:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q79TbfpwQK-ikCGzqg1nsg'}, attempt #1 06:57:52 INFO - Task dependencies: A-_-N-nrTguNC9_GOEJCKg 06:57:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ'}, attempt #1 06:57:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:57:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/test_packages.json 06:57:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/target.crashreporter-symbols.zip 06:57:53 INFO - Running post-action listener: _resource_record_post_action 06:57:53 INFO - [mozharness: 2017-05-12 13:57:53.125064Z] Finished read-buildbot-config step (success) 06:57:53 INFO - [mozharness: 2017-05-12 13:57:53.125212Z] Running download-and-extract step. 06:57:53 INFO - Running pre-action listener: _resource_record_pre_action 06:57:53 INFO - Running main action method: download_and_extract 06:57:53 INFO - mkdir: /builds/slave/test/build/tests 06:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:57:53 INFO - trying https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 06:57:53 INFO - Downloading https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 06:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 06:57:54 INFO - Downloaded 1325 bytes. 06:57:54 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 06:57:54 INFO - Using the following test package requirements: 06:57:54 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:57:54 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 06:57:54 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:57:54 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:57:54 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 06:57:54 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:57:54 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 06:57:54 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:57:54 INFO - u'jsshell-mac.zip'], 06:57:54 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:57:54 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 06:57:54 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 06:57:54 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:57:54 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 06:57:54 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:57:54 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 06:57:54 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:57:54 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 06:57:54 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 06:57:54 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 06:57:54 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:57:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:57:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:57:54 INFO - Fetch https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:57:55 INFO - Content-Length response header: 52712974 06:57:55 INFO - Bytes received: 52712974 06:58:11 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:58:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 06:58:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:58:11 INFO - Fetch https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 06:58:13 INFO - Content-Length response header: 52712974 06:58:13 INFO - Bytes received: 52712974 06:58:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 06:58:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:58:29 INFO - Fetch https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 06:58:29 INFO - Content-Length response header: 14409411 06:58:29 INFO - Bytes received: 14409411 06:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:30 INFO - trying https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:58:30 INFO - Downloading https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 06:58:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 06:58:32 INFO - Downloaded 75874503 bytes. 06:58:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:58:32 INFO - mkdir: /builds/slave/test/properties 06:58:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:58:32 INFO - Writing to file /builds/slave/test/properties/build_url 06:58:32 INFO - Contents: 06:58:32 INFO - build_url:https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 06:58:32 INFO - Running post-action listener: _resource_record_post_action 06:58:32 INFO - Running post-action listener: set_extra_try_arguments 06:58:32 INFO - [mozharness: 2017-05-12 13:58:32.431632Z] Finished download-and-extract step (success) 06:58:32 INFO - [mozharness: 2017-05-12 13:58:32.431783Z] Running populate-webroot step. 06:58:32 INFO - Running pre-action listener: _resource_record_pre_action 06:58:32 INFO - Running main action method: populate_webroot 06:58:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:58:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:58:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:58:32 INFO - '--tppagecycles', 06:58:32 INFO - '7'], 06:58:32 INFO - 'tests': ['tsvgm']}}, 06:58:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:58:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:58:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:58:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:58:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:58:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:58:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:58:32 INFO - 'talos_options': ['--disable-e10s'], 06:58:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:58:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:58:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:58:32 INFO - 'talos_options': ['--disable-e10s'], 06:58:32 INFO - 'tests': ['damp', 'tps']}, 06:58:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:58:32 INFO - 'tests': ['damp', 'tps']}, 06:58:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:58:32 INFO - 'tests': ['dromaeo_dom']}, 06:58:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:58:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:58:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:58:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:58:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:58:32 INFO - 'tests': ['a11yr', 06:58:32 INFO - 'ts_paint', 06:58:32 INFO - 'tpaint', 06:58:32 INFO - 'sessionrestore', 06:58:32 INFO - 'sessionrestore_no_auto_restore', 06:58:32 INFO - 'tabpaint']}, 06:58:32 INFO - 'other-e10s': {'tests': ['a11yr', 06:58:32 INFO - 'ts_paint', 06:58:32 INFO - 'tpaint', 06:58:32 INFO - 'sessionrestore', 06:58:32 INFO - 'sessionrestore_no_auto_restore', 06:58:32 INFO - 'tabpaint']}, 06:58:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:58:32 INFO - 'ts_paint', 06:58:32 INFO - 'tpaint', 06:58:32 INFO - 'sessionrestore', 06:58:32 INFO - 'sessionrestore_no_auto_restore', 06:58:32 INFO - 'tabpaint']}, 06:58:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:58:32 INFO - 'ts_paint', 06:58:32 INFO - 'tpaint', 06:58:32 INFO - 'sessionrestore', 06:58:32 INFO - 'sessionrestore_no_auto_restore', 06:58:32 INFO - 'tabpaint']}, 06:58:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:58:32 INFO - 'tests': ['a11yr', 06:58:32 INFO - 'ts_paint', 06:58:32 INFO - 'tpaint', 06:58:32 INFO - 'sessionrestore', 06:58:32 INFO - 'sessionrestore_no_auto_restore', 06:58:32 INFO - 'tabpaint']}, 06:58:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:58:32 INFO - 'tests': ['a11yr', 06:58:32 INFO - 'ts_paint', 06:58:32 INFO - 'tpaint', 06:58:32 INFO - 'sessionrestore', 06:58:32 INFO - 'sessionrestore_no_auto_restore', 06:58:32 INFO - 'tabpaint']}, 06:58:32 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:58:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:58:32 INFO - 'bloom_basic_ref']}, 06:58:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:58:32 INFO - 'tests': ['tsvgx', 06:58:32 INFO - 'tsvgr_opacity', 06:58:32 INFO - 'tart', 06:58:32 INFO - 'tscrollx', 06:58:32 INFO - 'cart', 06:58:32 INFO - 'tsvg_static']}, 06:58:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:58:32 INFO - 'tsvgr_opacity', 06:58:32 INFO - 'tart', 06:58:32 INFO - 'tscrollx', 06:58:32 INFO - 'cart', 06:58:32 INFO - 'tsvg_static']}, 06:58:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:58:32 INFO - 'talos_options': ['--disable-e10s'], 06:58:32 INFO - 'tests': ['tp5o']}, 06:58:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:58:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:58:32 INFO - 'talos_options': ['--disable-e10s', 06:58:32 INFO - '--xperf_path', 06:58:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:32 INFO - 'tests': ['tp5n']}, 06:58:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:58:32 INFO - 'talos_options': ['--xperf_path', 06:58:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:58:32 INFO - 'tests': ['tp5n']}}, 06:58:32 INFO - 'talos.zip': {'path': '', 06:58:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:58:32 INFO - Running post-action listener: _resource_record_post_action 06:58:32 INFO - [mozharness: 2017-05-12 13:58:32.453267Z] Finished populate-webroot step (success) 06:58:32 INFO - [mozharness: 2017-05-12 13:58:32.453418Z] Running create-virtualenv step. 06:58:32 INFO - Running pre-action listener: _resource_record_pre_action 06:58:32 INFO - Running main action method: create_virtualenv 06:58:32 INFO - Creating virtualenv /builds/slave/test/build/venv 06:58:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:58:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:58:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:58:32 INFO - Using real prefix '/tools/python27' 06:58:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:58:33 INFO - Installing distribute.............................................................................................................................................................................................done. 06:58:36 INFO - Installing pip.................done. 06:58:36 INFO - Return code: 0 06:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:58:36 INFO - Reading from file tmpfile_stdout 06:58:36 INFO - Output received: 06:58:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:58:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:36 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 0x10c574b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c577768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d34752e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c285d30>, '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 0x10c238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c279be8>, '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.OITsMlCfG0/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.gL5kZ68SUd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:58:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OITsMlCfG0/Render', 06:58:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:36 INFO - 'HOME': '/Users/cltbld', 06:58:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:36 INFO - 'LOGNAME': 'cltbld', 06:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:36 INFO - 'MOZ_NO_REMOTE': '1', 06:58:36 INFO - 'NO_EM_RESTART': '1', 06:58:36 INFO - 'PAGER': '/bin/cat', 06:58:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:36 INFO - 'PWD': '/builds/slave/test', 06:58:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:36 INFO - 'SHELL': '/bin/bash', 06:58:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gL5kZ68SUd/Listeners', 06:58:36 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:58:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:36 INFO - 'USER': 'cltbld', 06:58:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:36 INFO - 'XPC_FLAGS': '0x0', 06:58:36 INFO - 'XPC_SERVICE_NAME': '0', 06:58:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:58:36 INFO - Cleaning up... 06:58:36 INFO - Return code: 0 06:58:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:36 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 0x10c574b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c577768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d34752e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c285d30>, '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 0x10c238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c279be8>, '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.OITsMlCfG0/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.gL5kZ68SUd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:58:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OITsMlCfG0/Render', 06:58:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:36 INFO - 'HOME': '/Users/cltbld', 06:58:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:36 INFO - 'LOGNAME': 'cltbld', 06:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:36 INFO - 'MOZ_NO_REMOTE': '1', 06:58:36 INFO - 'NO_EM_RESTART': '1', 06:58:36 INFO - 'PAGER': '/bin/cat', 06:58:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:36 INFO - 'PWD': '/builds/slave/test', 06:58:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:36 INFO - 'SHELL': '/bin/bash', 06:58:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gL5kZ68SUd/Listeners', 06:58:36 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:58:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:36 INFO - 'USER': 'cltbld', 06:58:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:36 INFO - 'XPC_FLAGS': '0x0', 06:58:36 INFO - 'XPC_SERVICE_NAME': '0', 06:58:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:36 INFO - Downloading/unpacking psutil>=3.1.1 06:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:58:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:39 INFO - Installing collected packages: psutil 06:58:39 INFO - Running setup.py install for psutil 06:58:39 INFO - building 'psutil._psutil_osx' extension 06:58:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:58:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:58:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:58:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:58:40 INFO - building 'psutil._psutil_posix' extension 06:58:40 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:58:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:58:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:58:40 INFO - ^ 06:58:40 INFO - 1 warning generated. 06:58:40 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:58:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:58:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:58:41 INFO - Successfully installed psutil 06:58:41 INFO - Cleaning up... 06:58:41 INFO - Return code: 0 06:58:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:41 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 0x10c574b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c577768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d34752e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c285d30>, '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 0x10c238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c279be8>, '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.OITsMlCfG0/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.gL5kZ68SUd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:58:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OITsMlCfG0/Render', 06:58:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:41 INFO - 'HOME': '/Users/cltbld', 06:58:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:41 INFO - 'LOGNAME': 'cltbld', 06:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:41 INFO - 'MOZ_NO_REMOTE': '1', 06:58:41 INFO - 'NO_EM_RESTART': '1', 06:58:41 INFO - 'PAGER': '/bin/cat', 06:58:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:41 INFO - 'PWD': '/builds/slave/test', 06:58:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:41 INFO - 'SHELL': '/bin/bash', 06:58:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gL5kZ68SUd/Listeners', 06:58:41 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:58:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:41 INFO - 'USER': 'cltbld', 06:58:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:41 INFO - 'XPC_FLAGS': '0x0', 06:58:41 INFO - 'XPC_SERVICE_NAME': '0', 06:58:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:58:42 INFO - Installing collected packages: mozsystemmonitor 06:58:42 INFO - Running setup.py install for mozsystemmonitor 06:58:42 INFO - Successfully installed mozsystemmonitor 06:58:42 INFO - Cleaning up... 06:58:42 INFO - Return code: 0 06:58:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:42 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 0x10c574b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c577768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d34752e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c285d30>, '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 0x10c238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c279be8>, '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.OITsMlCfG0/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.gL5kZ68SUd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:58:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:58:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OITsMlCfG0/Render', 06:58:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:42 INFO - 'HOME': '/Users/cltbld', 06:58:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:42 INFO - 'LOGNAME': 'cltbld', 06:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:42 INFO - 'MOZ_NO_REMOTE': '1', 06:58:42 INFO - 'NO_EM_RESTART': '1', 06:58:42 INFO - 'PAGER': '/bin/cat', 06:58:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:42 INFO - 'PWD': '/builds/slave/test', 06:58:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:42 INFO - 'SHELL': '/bin/bash', 06:58:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gL5kZ68SUd/Listeners', 06:58:42 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:58:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:42 INFO - 'USER': 'cltbld', 06:58:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:42 INFO - 'XPC_FLAGS': '0x0', 06:58:42 INFO - 'XPC_SERVICE_NAME': '0', 06:58:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:43 INFO - Downloading/unpacking jsonschema==2.5.1 06:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:58:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:44 INFO - Downloading functools32-3.2.3-2.tar.gz 06:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:58:44 INFO - warning: no files found matching '*.txt' 06:58:44 INFO - no previously-included directories found matching 'build' 06:58:44 INFO - no previously-included directories found matching 'dist' 06:58:44 INFO - no previously-included directories found matching '.git*' 06:58:44 INFO - Installing collected packages: jsonschema, functools32 06:58:44 INFO - Running setup.py install for functools32 06:58:45 INFO - warning: no files found matching '*.txt' 06:58:45 INFO - no previously-included directories found matching 'build' 06:58:45 INFO - no previously-included directories found matching 'dist' 06:58:45 INFO - no previously-included directories found matching '.git*' 06:58:45 INFO - Successfully installed jsonschema functools32 06:58:45 INFO - Cleaning up... 06:58:45 INFO - Return code: 0 06:58:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58: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')]} 06:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:45 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 0x10c574b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c577768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d34752e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c285d30>, '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 0x10c238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c279be8>, '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.OITsMlCfG0/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.gL5kZ68SUd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:58:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:58:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OITsMlCfG0/Render', 06:58:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:45 INFO - 'HOME': '/Users/cltbld', 06:58:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:45 INFO - 'LOGNAME': 'cltbld', 06:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:45 INFO - 'MOZ_NO_REMOTE': '1', 06:58:45 INFO - 'NO_EM_RESTART': '1', 06:58:45 INFO - 'PAGER': '/bin/cat', 06:58:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:45 INFO - 'PWD': '/builds/slave/test', 06:58:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:45 INFO - 'SHELL': '/bin/bash', 06:58:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gL5kZ68SUd/Listeners', 06:58:45 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:58:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:45 INFO - 'USER': 'cltbld', 06:58:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:45 INFO - 'XPC_FLAGS': '0x0', 06:58:45 INFO - 'XPC_SERVICE_NAME': '0', 06:58:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:58:45 INFO - Cleaning up... 06:58:45 INFO - Return code: 0 06:58:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58: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')]} 06:58:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:45 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 0x10c574b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c577768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d34752e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c285d30>, '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 0x10c238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c279be8>, '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.OITsMlCfG0/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.gL5kZ68SUd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:58:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:58:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:58:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OITsMlCfG0/Render', 06:58:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:45 INFO - 'HOME': '/Users/cltbld', 06:58:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:45 INFO - 'LOGNAME': 'cltbld', 06:58:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:45 INFO - 'MOZ_NO_REMOTE': '1', 06:58:45 INFO - 'NO_EM_RESTART': '1', 06:58:45 INFO - 'PAGER': '/bin/cat', 06:58:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:45 INFO - 'PWD': '/builds/slave/test', 06:58:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:45 INFO - 'SHELL': '/bin/bash', 06:58:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gL5kZ68SUd/Listeners', 06:58:45 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:58:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:45 INFO - 'USER': 'cltbld', 06:58:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:45 INFO - 'XPC_FLAGS': '0x0', 06:58:45 INFO - 'XPC_SERVICE_NAME': '0', 06:58:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:45 INFO - Downloading/unpacking blobuploader==1.2.4 06:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:47 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:58:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:47 INFO - Downloading docopt-0.6.1.tar.gz 06:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:48 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:48 INFO - Running setup.py install for blobuploader 06:58:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:58:48 INFO - Running setup.py install for requests 06:58:48 INFO - Running setup.py install for docopt 06:58:48 INFO - Successfully installed blobuploader requests docopt 06:58:48 INFO - Cleaning up... 06:58:48 INFO - Return code: 0 06:58:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10c574b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c577768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d34752e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c285d30>, '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 0x10c238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c279be8>, '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.OITsMlCfG0/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.gL5kZ68SUd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:58:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OITsMlCfG0/Render', 06:58:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:49 INFO - 'HOME': '/Users/cltbld', 06:58:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:49 INFO - 'LOGNAME': 'cltbld', 06:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:49 INFO - 'MOZ_NO_REMOTE': '1', 06:58:49 INFO - 'NO_EM_RESTART': '1', 06:58:49 INFO - 'PAGER': '/bin/cat', 06:58:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:49 INFO - 'PWD': '/builds/slave/test', 06:58:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:49 INFO - 'SHELL': '/bin/bash', 06:58:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gL5kZ68SUd/Listeners', 06:58:49 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:58:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:49 INFO - 'USER': 'cltbld', 06:58:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:49 INFO - 'XPC_FLAGS': '0x0', 06:58:49 INFO - 'XPC_SERVICE_NAME': '0', 06:58:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:49 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-ybKFae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-W1uTnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-DTR9wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-RT087Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-ihT1kN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-GTY59r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-Ais54l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-U8wVdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-gxI8wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-ZrVI_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:50 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-fdOIEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:51 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-J6NAhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:51 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-1ba7lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:51 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-xb4yo2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:51 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-DI40P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:51 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-48_OgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:51 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-Wx83K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:51 INFO - Running setup.py install for manifestparser 06:58:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:58:51 INFO - Running setup.py install for mozcrash 06:58:51 INFO - Running setup.py install for mozdebug 06:58:52 INFO - Running setup.py install for mozdevice 06:58:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:58:52 INFO - Running setup.py install for mozfile 06:58:52 INFO - Running setup.py install for mozhttpd 06:58:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:58:52 INFO - Running setup.py install for mozinfo 06:58:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:58:52 INFO - Running setup.py install for mozInstall 06:58:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:58:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:58:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:58:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:58:52 INFO - Running setup.py install for mozleak 06:58:52 INFO - Running setup.py install for mozlog 06:58:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:58:53 INFO - Running setup.py install for moznetwork 06:58:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:58:53 INFO - Running setup.py install for mozprocess 06:58:53 INFO - Running setup.py install for mozprofile 06:58:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:58:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:58:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:58:53 INFO - Running setup.py install for mozrunner 06:58:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:58:53 INFO - Running setup.py install for mozscreenshot 06:58:53 INFO - Running setup.py install for moztest 06:58:54 INFO - Running setup.py install for mozversion 06:58:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:58:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:54 INFO - Cleaning up... 06:58:54 INFO - Return code: 0 06:58:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58: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')]} 06:58:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58: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')]} 06:58:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10c574b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c577768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d34752e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c285d30>, '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 0x10c238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c279be8>, '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.OITsMlCfG0/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.gL5kZ68SUd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:58:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:58:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:58:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OITsMlCfG0/Render', 06:58:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:54 INFO - 'HOME': '/Users/cltbld', 06:58:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:54 INFO - 'LOGNAME': 'cltbld', 06:58:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:54 INFO - 'MOZ_NO_REMOTE': '1', 06:58:54 INFO - 'NO_EM_RESTART': '1', 06:58:54 INFO - 'PAGER': '/bin/cat', 06:58:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:54 INFO - 'PWD': '/builds/slave/test', 06:58:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:54 INFO - 'SHELL': '/bin/bash', 06:58:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gL5kZ68SUd/Listeners', 06:58:54 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:58:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:54 INFO - 'USER': 'cltbld', 06:58:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:54 INFO - 'XPC_FLAGS': '0x0', 06:58:54 INFO - 'XPC_SERVICE_NAME': '0', 06:58:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:54 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-3fHyO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-NVIylk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-7US4kW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-0zVG1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-VDKbMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-A0zzpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-uQypSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-5wwcxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-iCVcvH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:58:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:55 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-5wi3N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:56 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-8yfw_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:56 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-X7XSOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:56 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-uAZa19-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:56 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-HylzNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:56 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-gvg8Ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:56 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-ZILH4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:58:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:56 INFO - Running setup.py (path:/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/pip-4JGaVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:58:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:58 INFO - Downloading blessings-1.6.tar.gz 06:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:58:58 INFO - Installing collected packages: blessings 06:58:58 INFO - Running setup.py install for blessings 06:58:58 INFO - Successfully installed blessings 06:58:58 INFO - Cleaning up... 06:58:58 INFO - Return code: 0 06:58:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:58:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:59 INFO - Reading from file tmpfile_stdout 06:58:59 INFO - Current package versions: 06:58:59 INFO - blessings == 1.6 06:58:59 INFO - blobuploader == 1.2.4 06:58:59 INFO - docopt == 0.6.1 06:58:59 INFO - functools32 == 3.2.3-2 06:58:59 INFO - jsonschema == 2.5.1 06:58:59 INFO - manifestparser == 1.1 06:58:59 INFO - mozInstall == 1.12 06:58:59 INFO - mozcrash == 1.0 06:58:59 INFO - mozdebug == 0.1 06:58:59 INFO - mozdevice == 0.50 06:58:59 INFO - mozfile == 1.2 06:58:59 INFO - mozhttpd == 0.7 06:58:59 INFO - mozinfo == 0.9 06:58:59 INFO - mozleak == 0.1 06:58:59 INFO - mozlog == 3.4 06:58:59 INFO - moznetwork == 0.27 06:58:59 INFO - mozprocess == 0.25 06:58:59 INFO - mozprofile == 0.28 06:58:59 INFO - mozrunner == 6.13 06:58:59 INFO - mozscreenshot == 0.1 06:58:59 INFO - mozsystemmonitor == 0.3 06:58:59 INFO - moztest == 0.8 06:58:59 INFO - mozversion == 1.4 06:58:59 INFO - psutil == 3.1.1 06:58:59 INFO - requests == 1.2.3 06:58:59 INFO - wsgiref == 0.1.2 06:58:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10c574b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c577768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d34752e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c285d30>, '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 0x10c238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c279be8>, '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.OITsMlCfG0/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.gL5kZ68SUd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:58:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:58:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OITsMlCfG0/Render', 06:58:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:59 INFO - 'HOME': '/Users/cltbld', 06:58:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:59 INFO - 'LOGNAME': 'cltbld', 06:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:59 INFO - 'MOZ_NO_REMOTE': '1', 06:58:59 INFO - 'NO_EM_RESTART': '1', 06:58:59 INFO - 'PAGER': '/bin/cat', 06:58:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:59 INFO - 'PWD': '/builds/slave/test', 06:58:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:59 INFO - 'SHELL': '/bin/bash', 06:58:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gL5kZ68SUd/Listeners', 06:58:59 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:58:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:59 INFO - 'USER': 'cltbld', 06:58:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:59 INFO - 'XPC_FLAGS': '0x0', 06:58:59 INFO - 'XPC_SERVICE_NAME': '0', 06:58:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:58:59 INFO - Cleaning up... 06:58:59 INFO - Return code: 0 06:58:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x10c574b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c577768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd0d34752e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c285d30>, '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 0x10c238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c279be8>, '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.OITsMlCfG0/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.gL5kZ68SUd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:58:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:58:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OITsMlCfG0/Render', 06:58:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:58:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:58:59 INFO - 'HOME': '/Users/cltbld', 06:58:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:58:59 INFO - 'LOGNAME': 'cltbld', 06:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:59 INFO - 'MOZ_NO_REMOTE': '1', 06:58:59 INFO - 'NO_EM_RESTART': '1', 06:58:59 INFO - 'PAGER': '/bin/cat', 06:58:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:59 INFO - 'PWD': '/builds/slave/test', 06:58:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:58:59 INFO - 'SHELL': '/bin/bash', 06:58:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gL5kZ68SUd/Listeners', 06:58:59 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:58:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:58:59 INFO - 'USER': 'cltbld', 06:58:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:58:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:59 INFO - 'XPC_FLAGS': '0x0', 06:58:59 INFO - 'XPC_SERVICE_NAME': '0', 06:58:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:58:59 INFO - Cleaning up... 06:58:59 INFO - Return code: 0 06:58:59 INFO - Running post-action listener: _resource_record_post_action 06:58:59 INFO - Running post-action listener: _start_resource_monitoring 06:58:59 INFO - Starting resource monitoring. 06:58:59 INFO - [mozharness: 2017-05-12 13:58:59.723845Z] Finished create-virtualenv step (success) 06:58:59 INFO - [mozharness: 2017-05-12 13:58:59.724784Z] Running install step. 06:58:59 INFO - Running pre-action listener: _resource_record_pre_action 06:58:59 INFO - Running main action method: install 06:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:59 INFO - Reading from file tmpfile_stdout 06:58:59 INFO - Detecting whether we're running mozinstall >=1.0... 06:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:59:00 INFO - Reading from file tmpfile_stdout 06:59:00 INFO - Output received: 06:59:00 INFO - Usage: mozinstall [options] installer 06:59:00 INFO - Options: 06:59:00 INFO - -h, --help show this help message and exit 06:59:00 INFO - -d DEST, --destination=DEST 06:59:00 INFO - Directory to install application into. [default: 06:59:00 INFO - "/builds/slave/test"] 06:59:00 INFO - --app=APP Application being installed. [default: firefox] 06:59:00 INFO - mkdir: /builds/slave/test/build/application 06:59:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:59:20 INFO - Reading from file tmpfile_stdout 06:59:20 INFO - Output received: 06:59:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:59:20 INFO - Running post-action listener: _resource_record_post_action 06:59:20 INFO - [mozharness: 2017-05-12 13:59:20.407563Z] Finished install step (success) 06:59:20 INFO - [mozharness: 2017-05-12 13:59:20.407707Z] Running run-tests step. 06:59:20 INFO - Running pre-action listener: _resource_record_pre_action 06:59:20 INFO - Running main action method: run_tests 06:59:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:59:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:59:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:59:20 INFO - 2017-05-12 06:59:20.422 screenresolution[1628:7508] starting screenresolution argv=screenresolution get 06:59:20 INFO - 2017-05-12 06:59:20.425 screenresolution[1628:7508] Display 0: 1600x1200x32@60 06:59:20 INFO - 2017-05-12 06:59:20.431 screenresolution[1629:7511] starting screenresolution argv=screenresolution list 06:59:20 INFO - Available Modes on Display 0 06:59:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:59:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:59:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:59:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:59:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:59:20 INFO - Intel Iris: 06:59:20 INFO - Chipset Model: Intel Iris 06:59:20 INFO - Type: GPU 06:59:20 INFO - Bus: Built-In 06:59:20 INFO - VRAM (Dynamic, Max): 1536 MB 06:59:20 INFO - Vendor: Intel (0x8086) 06:59:20 INFO - Device ID: 0x0a2e 06:59:20 INFO - Revision ID: 0x0009 06:59:20 INFO - Displays: 06:59:20 INFO - Display: 06:59:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:59:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:59:20 INFO - Display Serial Number: 1600x1200 60 06:59:20 INFO - Main Display: Yes 06:59:20 INFO - Mirror: Off 06:59:20 INFO - Online: Yes 06:59:20 INFO - Rotation: Supported 06:59:20 INFO - Return code: 0 06:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:59:20 INFO - Python 2.7.3 06:59:20 INFO - Return code: 0 06:59:20 INFO - grabbing minidump binary from tooltool 06:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:59:20 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 0x10c285d30>, '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 0x10c238db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c279be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:59:20 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:59:20 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:59:20 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:59:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:59:20 INFO - Return code: 0 06:59:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:59:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:59:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:59:20 INFO - ENV: RUST_BACKTRACE is now 1 06:59:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:59:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:59:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0219', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:59:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/target.crashreporter-symbols.zip --title t-yosemite-r7-0219 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:59:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OITsMlCfG0/Render', 06:59:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:59:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:59:20 INFO - 'HOME': '/Users/cltbld', 06:59:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:59:20 INFO - 'LOGNAME': 'cltbld', 06:59:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:59:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:59:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:59:20 INFO - 'MOZ_NO_REMOTE': '1', 06:59:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:59:20 INFO - 'NO_EM_RESTART': '1', 06:59:20 INFO - 'PAGER': '/bin/cat', 06:59:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:59:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:59:20 INFO - 'PWD': '/builds/slave/test', 06:59:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:59:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:59:20 INFO - 'RUST_BACKTRACE': '1', 06:59:20 INFO - 'SHELL': '/bin/bash', 06:59:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gL5kZ68SUd/Listeners', 06:59:20 INFO - 'TMPDIR': '/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/', 06:59:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:59:20 INFO - 'USER': 'cltbld', 06:59:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:59:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:59:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:59:20 INFO - 'XPC_FLAGS': '0x0', 06:59:20 INFO - 'XPC_SERVICE_NAME': '0', 06:59:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:59:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0219', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:59:21 INFO - mozversion application_buildid: 20170512053747 06:59:21 INFO - mozversion application_changeset: bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 06:59:21 INFO - mozversion application_display_name: Nightly 06:59:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:59:21 INFO - mozversion application_name: Firefox 06:59:21 INFO - mozversion application_remotingname: firefox 06:59:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:59:21 INFO - mozversion application_vendor: Mozilla 06:59:21 INFO - mozversion application_version: 55.0a1 06:59:21 INFO - mozversion platform_buildid: 20170512053747 06:59:21 INFO - mozversion platform_changeset: bcb5e1ff13f807387595d5b6b5dbdb4c3b8ad501 06:59:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:59:21 INFO - mozversion platform_version: 55.0a1 06:59:21 INFO - using testdate: 1494597561 06:59:21 INFO - actual date: 1494597561 06:59:21 INFO - starting webserver on 'localhost:49225' 06:59:21 INFO - SUITE-START | Running 2 tests 06:59:21 INFO - TEST-START | dromaeo_css 06:59:21 INFO - operating with platform_type : mac_ 06:59:21 INFO - Initialising browser for dromaeo_css test... 06:59:21 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmpku1mxg/profile http://localhost:49225/getInfo.html) 06:59:23 INFO - PID 1639 | __metrics Screen width/height:1600/1200 06:59:23 INFO - PID 1639 | colorDepth:24 06:59:23 INFO - PID 1639 | Browser inner width/height: 1024/691 06:59:23 INFO - PID 1639 | __metrics 06:59:23 INFO - PID 1639 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:59:23 INFO - PID 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:59:24 INFO - TEST-INFO | 1639: exit 0 06:59:24 INFO - Browser initialized. 06:59:24 INFO - Running cycle 1/1 for dromaeo_css test... 06:59:24 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmpku1mxg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:59:36 INFO - PID 1641 | RSS: Main: 232607744 06:59:36 INFO - PID 1641 | 07:02:40 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49225/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49225/tests/dromaeo/cssquery-ext.html) 07:02:42 INFO - PID 1641 | RSS: Main: 429084672 07:02:42 INFO - PID 1641 | 07:05:45 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49225/tests/dromaeo/cssquery-ext.html (next: http://localhost:49225/tests/dromaeo/cssquery-jquery.html) 07:05:45 INFO - PID 1641 | RSS: Main: 371400704 07:05:45 INFO - PID 1641 | 07:08:47 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49225/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49225/tests/dromaeo/cssquery-mootools.html) 07:08:48 INFO - PID 1641 | RSS: Main: 332836864 07:08:48 INFO - PID 1641 | 07:11:50 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49225/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49225/tests/dromaeo/cssquery-prototype.html) 07:11:51 INFO - PID 1641 | RSS: Main: 335085568 07:11:51 INFO - PID 1641 | 07:14:54 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49225/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49225/tests/dromaeo/cssquery-yui.html) 07:14:55 INFO - PID 1641 | RSS: Main: 324923392 07:14:55 INFO - PID 1641 | 07:17:57 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49225/tests/dromaeo/cssquery-yui.html (next: http://localhost:49225/tests/dromaeo/cssquery-dojo.html) 07:17:57 INFO - PID 1641 | RSS: Main: 373223424 07:17:57 INFO - PID 1641 | 07:17:57 INFO - PID 1641 | __start_tp_report 07:17:57 INFO - PID 1641 | _x_x_mozilla_page_load 07:17:57 INFO - PID 1641 | _x_x_mozilla_page_load_details 07:17:57 INFO - PID 1641 | |i|pagename|runs| 07:17:57 INFO - PID 1641 | |0;dojo.html;2962.688917663645;3538.186217170049;3561.3233485637725;3581.1763294442276;3605.3870841956864;5355.571554275658;5514.869451762389;6270.780522681707;6273.686315684215;6284.780032698851;6151.753929842801;6184.845378865531;6202;6221.875562488759;6279.215098112736;5206.245094461301;5243.082460569404;5365.651232669884;5402.567794576435;5443.401225865152;5459.781608735646;5496.7526461309135;5504.2294078829;5512.724363781815;5521.751521181536;5283.682979021271;5339.172428273624;5341.599380046512;5364.946350536484;5453.31833520808;5353.437889021636;5365.651232669903;5367.785288588452;5381.165919282517;5388.407275199725;5298.681574516795;5309.814156504543;5355.062863998824;5363.302770639831;5365.919511207335;5900.616459930134;6188.350223226541;6248.87502249957;6249.843753906189;6291.685415729241;6540.771073012422;6580.276169621337;6596.109525214083;6596.736130554772;6601.834954126137;6421.967890160566;6583.275839657634;6672.833179170511;6725.630090345029;6743.055972163901;6170.7531698732;6188.752449901998;6270.905936410957;6335.524835637346;6344.587601805868;6815.182178138556;6819.488538359643;6827.897581536281;6851.143607049119;6853.451723862079;6293.590916590407;6358.554901156875;6372.1716176897635;6393.360663933569;6455.289918109004;6700.195976482853;6701.128853249046;6708.798736037927;6717.731290748413;6719.899201511981;6331.651759153291;6402.327755585689;6478.449331806849;6501.869962600722;6573.704183311763;6557.704903279268;6575.079488871466;6594.3735345143095;6596.835079122964;6607;5239.083160446907;5248.448912864171;5263.078961181778;5276.36683597963;5303.071962406563;4459.509453960061;4683.7892294846815;4697.342372067913;4721.079389519079;4738;6144.832481828438;6262.279837818618;6331.96834015827;6335.493160547145;6339.492840572743;6638.4689224861895;6712.697928593225;6716.3955244028275;6730;6730.192376914802;6322.683865806784;6327.588706734047;6333.96833015832;6336.714847831859;6337.04944258365;5655.7172141393585;5736.110902810071;5748.885022299614;5762.135679648002;5829;6690.732370705312;6698;6711.798646040626;6719.160104986877;6719.731210751515;6513;6522.902156467562;6641.634710090992;6650.3682150195655;6741.629210393476;6854.725810967506;6878.312168783082;6885.655717214219;6895.482838787011;6901;6576.408123268929;6588.703508342041;6595.241547222131;6595.703193356215;6603.636799976048;6410.0705397718;6465.482761379172;6487.0593763903025;6658.0345849852465;6706.195256569243;5417.43116972728;6364.363563643784;6440.516961228021;6441.677916104082;6444.774432895014;6419.133416988833;6441.1626488556185;6443.484521238383;6451.1936007999;6457.967710161419;5273.367195936512;6290.654014029273;6324.715387807468;6329.303776584664;6336.176297081534;5257.658252213594;6196.628202307876;6309.432151106423;6432.324605916311;6454.515911306765;6249.78125765596;6281.528885333527;6305.054241863757;6314.684265786784;6325.525585581007 07:17:57 INFO - PID 1641 | |1;ext.html;750.1935419424117;797.0236460336088;811.667216441259;1118.189312748258;1133.087864269264;27483.450330993368;27747.445051098966;27828.304292392673;27844.025459108936;27863.582046269297;27766;38835;38913.805430972876;38946.41580376297;38956.22087558247;8371.330293576515;8529.360297977646;8535.786605334853;8542.060373358925;8548.31613470924;6049.546284028694;8422.199891010345;8545.31637469001;8568.871466928002;8604;6162.5069994400565;8395.916040839606;8507;8545.102764209762;8590.711393290994;8487.66049358028;8531.360147988926;8541.145885411472;8541.914580854174;8550.2732267757;5973.820785376446;8323.791905202357;8396.454230475061;8416.789580260542;8426.78933026673;25815.09647162359;35722.28555428903;35885.46171807399;35944.64055359439;35988.460173097425;3193.8243396613175;3609.8809369095666;3637.1634524059614;3638.909027274313;3644.1436262478296;30057.098287051424;30106.94625688112;30112.397752044835;30169.698303016907;30253.63858626367;3139.9058028259187;3168.8098714077228;3184.8885289015006;3187.553742476055;3194.1216165554424;276808;277204.61397693085;277348;277693;277798.2220177813;47959.801004975154;48054.75972620115;48093.5190648096;48128.5187148131;48146;50072.74963625159;50216.74891625519;50241.74879125654;50256.497435025914;50262;13440.731185376238;13617;13622.455101796015;13633.182009079486;13634.386452609657;10988.835167472495;10992.230543861853;11001.00990910822;11011.944940275407;11016.834747478793;10361.274710770174;10405.635802746867;12114.636560903187;12362.134650574373;12413;5045.697258164522;5167.974160129251;5195.116830138885;5201.687898726089;5218.712970786567;995.7610173558294;1008.6368907193405;1010.4644538394663;1045.2369770067894;1049.9790004199874;19632.21471141167;22352.329430117123;24302.027918883046;24329.63505547418;24411;1088.3306766338803;1097.8847221041676;1124.7525544380223;1133.54091592905;1141.315210873486;11907.106966977512;12363.072769542321;12384.071194660257;12398.752024959631;12404.689882753004;303911.48044259637;303920;303989;304432;304640;51642.741786290826;51878.406079695866;51948.48051519512;51959.74020129875;52124.739376302874;1487.6727120033574;1526.7480865657042;1530.2195880101006;1545.768134779792;1549.3105568022347;23681;23796.405089872893;23847.92684329244;23862.88068559646;23884.52230955406;37074.258514829016;37195.07012324713;37223;37227.813860930524;37340.626593733716;225431;265276.67361663067;266211;266307;267477;31678.366432670755;31804;32467;32592.511112333807;32730.83634581812;35488.46767298441;35499.58001679904;35500.467492988144;35504.82247588746;42726.78636606922;25409.491810163323;26864.462710746066;29372.55941160927;29549.852250738608;29753.85123074371;26700.732992669826;29163;29222.561661575517;29410;29629.851850740608;33146;33913.49129763105;34841.651583484854;35233.471497927036;35421;28400;28637.570436443053;29426.705732942395;29481;29838.701612983594;18899.527511812314;22560.774392255866;22938.738369389845;23269;23415.648765268194 07:17:57 INFO - PID 1641 | |2;jquery.html;438.86614582552306;440.61886468205;442.32324543448516;446.8726412972303;461.06173936040165;21297.828619425927;21380.25169119081;21588.892055539738;21984.560308793814;22080.558388832233;21891.90540472974;22671.546569068607;23541.529169416644;23656.935437905293;23943.28170154898;4588.977055114719;5981.4018598140165;6214.0989556514505;6224.657643829588;6227.750889964419;3625.8912232633065;3693.5013773140686;3693.741438099334;5375.0593646111965;5977.133315669225;6069.848253793669;6072.696365181745;6080.939190608082;6085.361037091086;6113.510919126482;5875.735591898375;6050.667213303266;6072.240969878765;6109.266887973427;6130.141780150782;5304.522592966651;5440.102383106782;5445.292112025451;5447.4824891635235;5449.536789372908;27999.020034298905;28037;28544.28639284014;28601.85699071512;28905.988290409736;2134.8292136629034;2149.580831737812;2158.6761985702115;2175.2495389090736;2180.967285490719;17766.378176763752;17860.928344299384;17894.731579026324;18293.359732409433;18426.078696065142;2098.8425868059803;2154.515234072337;2172.945676358088;2176.858504197222;2186.7813218678166;154140;157750;159967;160398;162246.18876905658;11955.815464587498;12610.847288177956;12624.843789052737;12628.621141365773;12686.873131268754;16513.422030228885;16514.93563304587;16517.174141292886;16518.091504967342;16564.420245291356;8557.614907329185;8753;8769.956150219336;8855.025947145938;8896.955515222382;8148.329592433537;8162.7143049992965;8176.059753128347;8347.248747612623;8353.457025293337;7706.229377062361;7851.921480785233;7865.960670196612;7868.213178682086;7900.604969751489;2072.9424099453486;2156.5255643758346;2157.20183532091;2184.7050648162294;2304.550612630521;936.4287784451479;936.9203617692436;970.9320347575602;982.3320142303303;982.7420901246415;20115;21368;21385.89307053455;21595.460113497287;21615.527742720922;869.9086595907465;975.0882924465648;1001.0940099210227;1003.242551873331;1003.859459675646;11033.889661103447;11255.380954047443;11274.774504509864;11305.943470282597;11321.547138114383;547817;556600;560346;563241;567533;119216.40391797986;124880;125816.37091814482;131638;132667;1175.0834349207462;1196.5393323570313;1236.505397840871;1240.665020444493;1245.5578269714301;15980.760288595913;21388;22413.43966400853;22518.774812251668;22960.08159673661;56944;57212.42787572071;57674.42325576858;58308.70845645745;58654;58965.58583648162;80345.59827200827;80859;83492;83840;8722.607482663168;8773.56132193375;8804.779880503038;9300.72097837066;9343.906560934576;13786.172829630254;14290;14433.20617366055;14694.853051469776;14908.62728431798;11884.584039558575;12030.398480076135;12193.57322493744;12287.93856030714;12303.446344914679;10519.26365154432;11191.104711623213;11436.771264574829;11664.475098620753;11844.644660660195;11838.763224735629;12046.337451440255;12354.505819767108;12387.566435174725;12443.191192572454;8728.825423491622;8775.166359195866;8784.560771961504;8954.865677014981;9110.908890911007;11726.41367931617;11905.40472976365;12081.879181208076;12156.939215303866;12169.20900141488 07:17:57 INFO - PID 1641 | |3;mootools.html;1423.3381477612909;1442.9494967676128;1469.8897582681302;1473.9336729847148;1478.1426772471968;11552.342961118937;12034.398280086005;12049.518019279218;12050.276983380993;12084.939575302133;11537.134714896374;12140.575079872184;12187.939060304709;12199.878001219986;12229.082818788582;2506.511230310086;2580.948381032378;2583.547879121156;2585.8836352364096;2588.961165582518;2149.9570008599817;2255.616545187322;2502.749725027501;2580.58710606303;2589.676290463692;2207.073029327686;2519.3197836584113;2606.7784238339764;2611.8302310349864;2613.607958806185;2526.734692857242;2541.3646588352913;2551.2983929419465;2553.3871870750977;2557.1561384743177;2137.4015275722822;2519.987400062988;2536.720960694322;2546.1597672767944;2546.5161619292276;11249.493772780163;11532.192746507748;11550.653480395602;11553.595624153115;11612.883871161264;6433.485321174295;6677.666116694146;6679.766208182739;6687.465002799764;6691.397774200345;4073.735207211522;4224.809883555247;4299.527052024275;4361.214981303364;4369.956300436987;1116.3357802107814;1229.1825935752713;1246.5637027040555;1267.689416093054;1277.086882878746;15734.9213253933;15946.521604351889;16349;16352.591185220346;16387.83612163875;5740.225069615549;5772;5958.433948774859;6019.157317975487;6065.059915713072;13852.376643050886;13888.513902013381;13889.02776805614;13911.956603254795;13926.164430134224;6795.18457785059;6795.1845778506895;6797.796066118024;6799.218089919624;6802.387785099266;5657.830265092054;6118.357572454917;6136.447719705248;6193.287771906198;6239.875202496016;4512.5261847505535;4629.236176030917;4639.837605683785;4672.345871577982;4713.552212539872;1307.2875282970804;1421.7440860644977;1465.7801329800616;1469.8677119059337;1487.4199062365685;660.867826434715;675.2470994840717;753.179034852014;772.3743767548303;798.469018102955;5967.701614919237;5997.640141591519;6026.789062382795;6186.690665466709;6190.133381326618;893.8614514750224;909.9909000910038;918.4443411735937;927.7077720518015;940.2431043010306;3469.2887957968555;3734.3464893643504;3846.288436639231;3881.902952426212;3886.1839013807416;14419.062760920506;14616.926915365355;14718.55844324672;14751.40994360235;14760;14336.068155569854;14608.05047671898;14886.553403397915;15032.549023529311;15033.323500442506;8425.95787021061;8522.78693032679;8526.147385261424;8536.975562932488;8543.615537300837;6284.811455656338;6512.34876512345;6757.256701762703;6763.357481039294;6782.28785977485;11773.411329433666;13165.473381065034;13450.058495905192;13486.595402137558;13738.587842364745;13149.342532873126;13711.108777929403;13938.790918136034;13972.904064390423;14020.579382618538;8959.372843900865;9202.447853128833;9401.764955876159;9423.340366174301;9426;10659.573617055232;10882.45587720595;10883.23817332779;10904.61833835812;10926;8845.071267517076;9042.412243204171;9096.90903090987;9213.769655758391;9227.21568666644;8861.51261680588;8868.645254190018;8930.910690893008;8973.192412682889;9161.633534658806;6937.7571784987285;7901.328387086932;8064.475809072392;8104.716334928249;8208.507489550646;5969.194158788681;6012.849678758066;6021.668808215415;6070.18052562916;6136;5052.9388828346455;5941.494972927349;6115.052166914135;6134;6182.783602573888 07:17:57 INFO - PID 1641 | |4;prototype.html;345.5968766806763;361.3892521638429;391.06925517268894;393.323483608194;404.22994196056516;5201.973990130049;5961.344252132273;6037.909431358527;6054.490413723513;6078.392160783919;4706.388169537955;5256.8160114396005;5655.26481557398;5921.85195370116;6014.398560143984;4333.176696427684;4426.690131690783;4430.424044874162;4434.800433980478;4494.4831344395325;4433.866983990485;4443.15580039793;4449.221386257408;4450.643948484129;4476.597106260436;4168.812403441837;4373.628241599452;4421.7840093974255;4423.823047078113;4423.942866567046;4338.175746608134;4350.825966961318;4379.583939525756;4382.868513944587;4426.845060422886;3159.8104113753247;3377.459606462954;3736.3461394255896;3781.9054523636855;3782.8108594570435;4843.346148269974;5658;5906.852328691774;5912.17229587858;5914.61554998928;5198.584113270929;5203.178887389421;5224.268602395668;5255.290535777659;5284.656497327662;6413.454856337217;6438.967805160991;6439.645819479973;6447.903281450782;6477.287498375175;4160.45914031174;4220.198162349144;4288.004474786901;4300.290452075404;4315.4821421429315;5966.671833049137;5974.61165024272;6233.407826256498;6578.243501997236;6709.664516774142;3526.682598566141;4211.936820947688;4220.85227017053;4222.683298752544;4238.279492486285;3760.981195094007;4244.830206791694;4264.9079417422745;4405.273129933525;4416.1609294233995;5018.734076035341;5117.309163262987;5193.922091168635;5202.76587553561;5210.244514545369;6386.233651961795;6470.320616335312;6476.283784797032;6476.740930362733;6479.838004049842;1161.3496441992343;1434.6413396650837;1493.9775903361458;1506.314626844783;1517.9165145916859;824.3034635732796;843.6119385082808;876.5456721180668;932.9737288982066;999.2805180270194;4916.3451736062125;6029.186059881948;6056.454919057306;6089.299730530957;6096.719688865299;5946.167536544887;6056.788012419544;6668.666566671647;6672.065910772496;6688.929771236676;4683.672142949961;5249;5848.941510584925;6072.574919755663;6093.055576385579;3275.7051865332232;3447.5690538682666;3457.9827100864836;3471.6701913318193;3489.685928266468;5690.715464226855;6295.18162638854;6768.661566921634;6852.349026842442;6887.449004079662;5845.795397161079;6829.590224586541;6857.314268573103;6859.348361905611;6871.896921546181;6095.542834287357;6465.013631052934;6810;6821;6836.726530938806;6375.585586936834;6495.220573531206;6508.219013718384;6512.446442052478;6549.7380104795275;5479.890082438172;5826.94173058264;6016.699165041818;6313.842153946188;6513.250976137615;6014.849628759316;6451.3226111257645;6519.445847102859;6614.570052946543;6898.551594146365;4920.532549407801;4934.210526315772;4939.678920870132;4964.826231081895;4970.763156579482;5563.610547261653;6222.315545289924;6443.516736244894;6596.769113081019;6782.864342713019;6160;6440.9033864493;6510.283868774336;6523.4884569440155;6526.771562995273;6416.454601358937;6478.445173158502;6507.219133703986;6515.250746164252;6538;4762.285657151317;5242.816501422432;5920.407959204217;6366.2360516736435;6382.138411314599;6427.589653879795;6493.772717954849;6508.219013718384;6522.641254731036;6533.497295622129;5598.776048957996;6120.441255049921;6288.5283603728985;6357.566913866461;6392.360763923571 07:17:57 INFO - PID 1641 | |5;yui.html;727.1528669100497;739.9889001664974;766.3179770004693;811.1482942909943;836.6026137584648;13333.399997000133;16823.327066917325;16834.747478787798;16839.747403788937;16846.98918064917;13164.670883227924;14846.257687115654;15527.611809704764;15684.05895646262;15687.29407176677;942.4533770413144;950.9524523773819;951.9381240219399;953.8187744328555;955.8996305387939;977.0961860279249;978.227200511595;980.1472718734675;980.8136454073739;1001.2940876681922;1009.9747506312327;1023.0843395161326;1023.6826583759058;1025.907668309852;1026.9897301027006;1019.7399663085903;1048.428606409505;1057;1058.1006144776954;1060.5333653192608;766.4634755670996;767.5624893810531;768.8654485465021;770.684019551981;770.818857568471;16846.24191911367;16916.915415422965;16962.06708631025;17008.149592520323;17054.23255953473;16842.663146736995;16954.40659576921;17215.913920430445;17364.39224627132;17652;14177.503787367392;14311.141331520143;14370.353334099991;14457.421703131968;14562.490312839105;3578.624244454347;3609.5488063992;3613.0064232336053;3616.023673608111;3633.4731463937846;101411.49294253555;123690;124246;124680.75319246874;127234;13383.732325353632;13427.865721342661;13599.252041137832;13606.591802245948;13737.313134343243;25717.242310172678;25775.355616109748;25933.74066259351;26318;26583.601245981325;7395.445341599294;7524.435667324972;7610.391168706601;7611.238876112345;7613.162552119263;3757.3800322946954;3887.669548088444;3889.533256009297;3895.24042811649;3897.629725176104;4323.740575565476;4368.4321038264825;4395.934060989088;4409.889752756207;4416.690831641754;857.5969294431607;861.9310455163571;871.7559083456642;874.6676263020012;876.9693060742843;643.2152773616181;667.4226793823308;673.1988933169611;673.2964052565081;685.8833998220315;11209.719757005976;11913.642590722293;11956.88043119575;12057.07219443881;12198.451069701885;626.2015929689591;631.602090682876;642.4218203616689;670.6747227594612;676.5839009009522;4355.412019377343;5646.774129034792;5654.575906807006;5727.1695604138;5742.511886489695;102478;103292.45061324086;104177.47911260395;104227.4788626052;106250.4062439064;86098;91080.54459727791;91192;92245.5387723057;93709;50933.98132037339;62643.686781566714;78930.60534697404;78997.60501197458;82029.3086811083;12330.075244356529;12695.36523173856;12701.491940322283;12708.87291127077;12758.553450629184;32598;40468.595314046484;41170;41610.37584436296;41882.58117418787;53673.463265366845;54069.45930540802;54509.36471905849;55270;55591;16078.67842643164;16236.51290461288;16328.836711632732;16397.180140992663;16593.834061659712;18028.909855451162;18293.868963737707;18337.908310458362;18429.447116586525;18572.907135464236;16408.261628226996;16829.831701682826;16909;16978.745318820474;17195.828041719422;16315.673686525966;16376.67246655084;16852;16876.24056917417;16930.407435740184;16107.516774496784;16177.514674559312;16503.33986640521;16699.99800012003;16743.665126697153;11841.703957401134;11895.345755983159;11980.64058078259;11997.820032699341;12075.154739168174;12542.811857821958;12788.593254741785;12893.677658058623;12918.966482681551;12960.222386656831 07:17:57 INFO - PID 1641 | __end_tp_report 07:17:57 INFO - PID 1641 | __start_cc_report 07:17:57 INFO - PID 1641 | _x_x_mozilla_cycle_collect,2011 07:17:57 INFO - PID 1641 | __end_cc_report 07:17:57 INFO - PID 1641 | __startTimestamp1494598677926__endTimestamp 07:17:57 INFO - PID 1641 | 07:17:57 INFO - PID 1641 | ------- Summary: start ------- 07:17:57 INFO - PID 1641 | Number of tests: 6 07:17:57 INFO - PID 1641 | 07:17:57 INFO - PID 1641 | [#0] dojo.html Cycles:165 Average:6080.06 Median:6331.97 stddev:733.36 (11.6%) stddev-sans-first:693.64 07:17:57 INFO - PID 1641 | Values: 2962.7 3538.2 3561.3 3581.2 3605.4 5355.6 5514.9 6270.8 6273.7 6284.8 6151.8 6184.8 6202.0 6221.9 6279.2 5206.2 5243.1 5365.7 5402.6 5443.4 5459.8 5496.8 5504.2 5512.7 5521.8 5283.7 5339.2 5341.6 5364.9 5453.3 5353.4 5365.7 5367.8 5381.2 5388.4 5298.7 5309.8 5355.1 5363.3 5365.9 5900.6 6188.4 6248.9 6249.8 6291.7 6540.8 6580.3 6596.1 6596.7 6601.8 6422.0 6583.3 6672.8 6725.6 6743.1 6170.8 6188.8 6270.9 6335.5 6344.6 6815.2 6819.5 6827.9 6851.1 6853.5 6293.6 6358.6 6372.2 6393.4 6455.3 6700.2 6701.1 6708.8 6717.7 6719.9 6331.7 6402.3 6478.4 6501.9 6573.7 6557.7 6575.1 6594.4 6596.8 6607.0 5239.1 5248.4 5263.1 5276.4 5303.1 4459.5 4683.8 4697.3 4721.1 4738.0 6144.8 6262.3 6332.0 6335.5 6339.5 6638.5 6712.7 6716.4 6730.0 6730.2 6322.7 6327.6 6334.0 6336.7 6337.0 5655.7 5736.1 5748.9 5762.1 5829.0 6690.7 6698.0 6711.8 6719.2 6719.7 6513.0 6522.9 6641.6 6650.4 6741.6 6854.7 6878.3 6885.7 6895.5 6901.0 6576.4 6588.7 6595.2 6595.7 6603.6 6410.1 6465.5 6487.1 6658.0 6706.2 5417.4 6364.4 6440.5 6441.7 6444.8 6419.1 6441.2 6443.5 6451.2 6458.0 5273.4 6290.7 6324.7 6329.3 6336.2 5257.7 6196.6 6309.4 6432.3 6454.5 6249.8 6281.5 6305.1 6314.7 6325.5 07:17:57 INFO - PID 1641 | 07:17:57 INFO - PID 1641 | [#1] ext.html Cycles:180 Average:42232.68 Median:304210.50 stddev:73602.61 (24.2%) stddev-sans-first:73743.19 07:17:57 INFO - PID 1641 | Values: 750.2 797.0 811.7 1118.2 1133.1 27483.5 27747.4 27828.3 27844.0 27863.6 27766.0 38835.0 38913.8 38946.4 38956.2 8371.3 8529.4 8535.8 8542.1 8548.3 6049.5 8422.2 8545.3 8568.9 8604.0 6162.5 8395.9 8507.0 8545.1 8590.7 8487.7 8531.4 8541.1 8541.9 8550.3 5973.8 8323.8 8396.5 8416.8 8426.8 25815.1 35722.3 35885.5 35944.6 35988.5 3193.8 3609.9 3637.2 3638.9 3644.1 30057.1 30106.9 30112.4 30169.7 30253.6 3139.9 3168.8 3184.9 3187.6 3194.1 276808.0 277204.6 277348.0 277693.0 277798.2 47959.8 48054.8 48093.5 48128.5 48146.0 50072.7 50216.7 50241.7 50256.5 50262.0 13440.7 13617.0 13622.5 13633.2 13634.4 10988.8 10992.2 11001.0 11011.9 11016.8 10361.3 10405.6 12114.6 12362.1 12413.0 5045.7 5168.0 5195.1 5201.7 5218.7 995.8 1008.6 1010.5 1045.2 1050.0 19632.2 22352.3 24302.0 24329.6 24411.0 1088.3 1097.9 1124.8 1133.5 1141.3 11907.1 12363.1 12384.1 12398.8 12404.7 303911.5 303920.0 303989.0 304432.0 304640.0 51642.7 51878.4 51948.5 51959.7 52124.7 1487.7 1526.7 1530.2 1545.8 1549.3 23681.0 23796.4 23847.9 23862.9 23884.5 37074.3 37195.1 37223.0 37227.8 37340.6 225431.0 265276.7 266211.0 266307.0 267477.0 31678.4 31804.0 32467.0 32592.5 32730.8 35488.5 35499.6 35500.5 35504.8 42726.8 25409.5 26864.5 29372.6 29549.9 29753.9 26700.7 29163.0 29222.6 29410.0 29629.9 33146.0 33913.5 34841.7 35233.5 35421.0 28400.0 28637.6 29426.7 29481.0 29838.7 18899.5 22560.8 22938.7 23269.0 23415.6 07:17:57 INFO - PID 1641 | 07:17:57 INFO - PID 1641 | [#2] jquery.html Cycles:180 Average:36019.33 Median:22466.11 stddev:94788.10 (421.9%) stddev-sans-first:95016.36 07:17:57 INFO - PID 1641 | Values: 438.9 440.6 442.3 446.9 461.1 21297.8 21380.3 21588.9 21984.6 22080.6 21891.9 22671.5 23541.5 23656.9 23943.3 4589.0 5981.4 6214.1 6224.7 6227.8 3625.9 3693.5 3693.7 5375.1 5977.1 6069.8 6072.7 6080.9 6085.4 6113.5 5875.7 6050.7 6072.2 6109.3 6130.1 5304.5 5440.1 5445.3 5447.5 5449.5 27999.0 28037.0 28544.3 28601.9 28906.0 2134.8 2149.6 2158.7 2175.2 2181.0 17766.4 17860.9 17894.7 18293.4 18426.1 2098.8 2154.5 2172.9 2176.9 2186.8 154140.0 157750.0 159967.0 160398.0 162246.2 11955.8 12610.8 12624.8 12628.6 12686.9 16513.4 16514.9 16517.2 16518.1 16564.4 8557.6 8753.0 8770.0 8855.0 8897.0 8148.3 8162.7 8176.1 8347.2 8353.5 7706.2 7851.9 7866.0 7868.2 7900.6 2072.9 2156.5 2157.2 2184.7 2304.6 936.4 936.9 970.9 982.3 982.7 20115.0 21368.0 21385.9 21595.5 21615.5 869.9 975.1 1001.1 1003.2 1003.9 11033.9 11255.4 11274.8 11305.9 11321.5 547817.0 556600.0 560346.0 563241.0 567533.0 119216.4 124880.0 125816.4 131638.0 132667.0 1175.1 1196.5 1236.5 1240.7 1245.6 15980.8 21388.0 22413.4 22518.8 22960.1 56944.0 57212.4 57674.4 58308.7 58654.0 58965.6 80345.6 80859.0 83492.0 83840.0 8722.6 8773.6 8804.8 9300.7 9343.9 13786.2 14290.0 14433.2 14694.9 14908.6 11884.6 12030.4 12193.6 12287.9 12303.4 10519.3 11191.1 11436.8 11664.5 11844.6 11838.8 12046.3 12354.5 12387.6 12443.2 8728.8 8775.2 8784.6 8954.9 9110.9 11726.4 11905.4 12081.9 12156.9 12169.2 07:17:57 INFO - PID 1641 | 07:17:57 INFO - PID 1641 | [#3] mootools.html Cycles:180 Average:7149.13 Median:3601.82 stddev:4538.89 (126.0%) stddev-sans-first:4531.23 07:17:57 INFO - PID 1641 | Values: 1423.3 1442.9 1469.9 1473.9 1478.1 11552.3 12034.4 12049.5 12050.3 12084.9 11537.1 12140.6 12187.9 12199.9 12229.1 2506.5 2580.9 2583.5 2585.9 2589.0 2150.0 2255.6 2502.7 2580.6 2589.7 2207.1 2519.3 2606.8 2611.8 2613.6 2526.7 2541.4 2551.3 2553.4 2557.2 2137.4 2520.0 2536.7 2546.2 2546.5 11249.5 11532.2 11550.7 11553.6 11612.9 6433.5 6677.7 6679.8 6687.5 6691.4 4073.7 4224.8 4299.5 4361.2 4370.0 1116.3 1229.2 1246.6 1267.7 1277.1 15734.9 15946.5 16349.0 16352.6 16387.8 5740.2 5772.0 5958.4 6019.2 6065.1 13852.4 13888.5 13889.0 13912.0 13926.2 6795.2 6795.2 6797.8 6799.2 6802.4 5657.8 6118.4 6136.4 6193.3 6239.9 4512.5 4629.2 4639.8 4672.3 4713.6 1307.3 1421.7 1465.8 1469.9 1487.4 660.9 675.2 753.2 772.4 798.5 5967.7 5997.6 6026.8 6186.7 6190.1 893.9 910.0 918.4 927.7 940.2 3469.3 3734.3 3846.3 3881.9 3886.2 14419.1 14616.9 14718.6 14751.4 14760.0 14336.1 14608.1 14886.6 15032.5 15033.3 8426.0 8522.8 8526.1 8537.0 8543.6 6284.8 6512.3 6757.3 6763.4 6782.3 11773.4 13165.5 13450.1 13486.6 13738.6 13149.3 13711.1 13938.8 13972.9 14020.6 8959.4 9202.4 9401.8 9423.3 9426.0 10659.6 10882.5 10883.2 10904.6 10926.0 8845.1 9042.4 9096.9 9213.8 9227.2 8861.5 8868.6 8930.9 8973.2 9161.6 6937.8 7901.3 8064.5 8104.7 8208.5 5969.2 6012.8 6021.7 6070.2 6136.0 5052.9 5941.5 6115.1 6134.0 6182.8 07:17:57 INFO - PID 1641 | 07:17:57 INFO - PID 1641 | [#4] prototype.html Cycles:180 Average:5156.93 Median:5917.51 stddev:1625.05 (27.5%) stddev-sans-first:1588.98 07:17:57 INFO - PID 1641 | Values: 345.6 361.4 391.1 393.3 404.2 5202.0 5961.3 6037.9 6054.5 6078.4 4706.4 5256.8 5655.3 5921.9 6014.4 4333.2 4426.7 4430.4 4434.8 4494.5 4433.9 4443.2 4449.2 4450.6 4476.6 4168.8 4373.6 4421.8 4423.8 4423.9 4338.2 4350.8 4379.6 4382.9 4426.8 3159.8 3377.5 3736.3 3781.9 3782.8 4843.3 5658.0 5906.9 5912.2 5914.6 5198.6 5203.2 5224.3 5255.3 5284.7 6413.5 6439.0 6439.6 6447.9 6477.3 4160.5 4220.2 4288.0 4300.3 4315.5 5966.7 5974.6 6233.4 6578.2 6709.7 3526.7 4211.9 4220.9 4222.7 4238.3 3761.0 4244.8 4264.9 4405.3 4416.2 5018.7 5117.3 5193.9 5202.8 5210.2 6386.2 6470.3 6476.3 6476.7 6479.8 1161.3 1434.6 1494.0 1506.3 1517.9 824.3 843.6 876.5 933.0 999.3 4916.3 6029.2 6056.5 6089.3 6096.7 5946.2 6056.8 6668.7 6672.1 6688.9 4683.7 5249.0 5848.9 6072.6 6093.1 3275.7 3447.6 3458.0 3471.7 3489.7 5690.7 6295.2 6768.7 6852.3 6887.4 5845.8 6829.6 6857.3 6859.3 6871.9 6095.5 6465.0 6810.0 6821.0 6836.7 6375.6 6495.2 6508.2 6512.4 6549.7 5479.9 5826.9 6016.7 6313.8 6513.3 6014.8 6451.3 6519.4 6614.6 6898.6 4920.5 4934.2 4939.7 4964.8 4970.8 5563.6 6222.3 6443.5 6596.8 6782.9 6160.0 6440.9 6510.3 6523.5 6526.8 6416.5 6478.4 6507.2 6515.3 6538.0 4762.3 5242.8 5920.4 6366.2 6382.1 6427.6 6493.8 6508.2 6522.6 6533.5 5598.8 6120.4 6288.5 6357.6 6392.4 07:17:57 INFO - PID 1641 | 07:17:57 INFO - PID 1641 | [#5] yui.html Cycles:180 Average:21273.58 Median:17840.45 stddev:29609.47 (166.0%) stddev-sans-first:29652.34 07:17:57 INFO - PID 1641 | Values: 727.2 740.0 766.3 811.1 836.6 13333.4 16823.3 16834.7 16839.7 16847.0 13164.7 14846.3 15527.6 15684.1 15687.3 942.5 951.0 951.9 953.8 955.9 977.1 978.2 980.1 980.8 1001.3 1010.0 1023.1 1023.7 1025.9 1027.0 1019.7 1048.4 1057.0 1058.1 1060.5 766.5 767.6 768.9 770.7 770.8 16846.2 16916.9 16962.1 17008.1 17054.2 16842.7 16954.4 17215.9 17364.4 17652.0 14177.5 14311.1 14370.4 14457.4 14562.5 3578.6 3609.5 3613.0 3616.0 3633.5 101411.5 123690.0 124246.0 124680.8 127234.0 13383.7 13427.9 13599.3 13606.6 13737.3 25717.2 25775.4 25933.7 26318.0 26583.6 7395.4 7524.4 7610.4 7611.2 7613.2 3757.4 3887.7 3889.5 3895.2 3897.6 4323.7 4368.4 4395.9 4409.9 4416.7 857.6 861.9 871.8 874.7 877.0 643.2 667.4 673.2 673.3 685.9 11209.7 11913.6 11956.9 12057.1 12198.5 626.2 631.6 642.4 670.7 676.6 4355.4 5646.8 5654.6 5727.2 5742.5 102478.0 103292.5 104177.5 104227.5 106250.4 86098.0 91080.5 91192.0 92245.5 93709.0 50934.0 62643.7 78930.6 78997.6 82029.3 12330.1 12695.4 12701.5 12708.9 12758.6 32598.0 40468.6 41170.0 41610.4 41882.6 53673.5 54069.5 54509.4 55270.0 55591.0 16078.7 16236.5 16328.8 16397.2 16593.8 18028.9 18293.9 18337.9 18429.4 18572.9 16408.3 16829.8 16909.0 16978.7 17195.8 16315.7 16376.7 16852.0 16876.2 16930.4 16107.5 16177.5 16503.3 16700.0 16743.7 11841.7 11895.3 11980.6 11997.8 12075.2 12542.8 12788.6 12893.7 12919.0 12960.2 07:17:57 INFO - PID 1641 | -------- Summary: end -------- 07:17:57 INFO - PID 1641 | 07:17:58 INFO - TEST-INFO | 1641: exit 0 07:17:58 INFO - TEST-OK | dromaeo_css | took 1117560ms 07:17:58 INFO - TEST-START | kraken 07:17:58 INFO - operating with platform_type : mac_ 07:17:58 INFO - Initialising browser for kraken test... 07:17:58 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmp1MfviY/profile http://localhost:49225/getInfo.html) 07:18:01 INFO - PID 1652 | __metrics Screen width/height:1600/1200 07:18:01 INFO - PID 1652 | colorDepth:24 07:18:01 INFO - PID 1652 | Browser inner width/height: 1024/691 07:18:01 INFO - PID 1652 | __metrics 07:18:01 INFO - PID 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:18:01 INFO - PID 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:18:01 INFO - TEST-INFO | 1652: exit 0 07:18:01 INFO - Browser initialized. 07:18:01 INFO - Running cycle 1/1 for kraken test... 07:18:01 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/T/tmp1MfviY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:18:13 INFO - PID 1653 | RSS: Main: 234348544 07:18:13 INFO - PID 1653 | 07:18:16 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49225/tests/kraken/driver.html?testName=audio-beat-detection) 07:18:17 INFO - PID 1653 | RSS: Main: 303403008 07:18:17 INFO - PID 1653 | 07:18:20 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49225/tests/kraken/driver.html?testName=audio-dft) 07:18:20 INFO - PID 1653 | RSS: Main: 286785536 07:18:20 INFO - PID 1653 | 07:18:24 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49225/tests/kraken/driver.html?testName=audio-fft) 07:18:24 INFO - PID 1653 | RSS: Main: 379957248 07:18:24 INFO - PID 1653 | 07:18:26 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49225/tests/kraken/driver.html?testName=audio-oscillator) 07:18:27 INFO - PID 1653 | RSS: Main: 281853952 07:18:27 INFO - PID 1653 | 07:18:29 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49225/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:18:29 INFO - PID 1653 | RSS: Main: 284770304 07:18:29 INFO - PID 1653 | 07:18:32 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49225/tests/kraken/driver.html?testName=imaging-darkroom) 07:18:33 INFO - PID 1653 | RSS: Main: 348184576 07:18:33 INFO - PID 1653 | 07:18:36 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49225/tests/kraken/driver.html?testName=imaging-desaturate) 07:18:37 INFO - PID 1653 | RSS: Main: 372060160 07:18:37 INFO - PID 1653 | 07:18:39 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49225/tests/kraken/driver.html?testName=json-parse-financial) 07:18:40 INFO - PID 1653 | RSS: Main: 386064384 07:18:40 INFO - PID 1653 | 07:18:41 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49225/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:18:42 INFO - PID 1653 | RSS: Main: 327098368 07:18:42 INFO - PID 1653 | 07:18:44 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:18:44 INFO - PID 1653 | RSS: Main: 328015872 07:18:44 INFO - PID 1653 | 07:18:46 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:18:47 INFO - PID 1653 | RSS: Main: 327573504 07:18:47 INFO - PID 1653 | 07:18:50 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:18:51 INFO - PID 1653 | RSS: Main: 346513408 07:18:51 INFO - PID 1653 | 07:18:54 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:18:54 INFO - PID 1653 | RSS: Main: 339709952 07:18:54 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49225/tests/kraken/driver.html?testName=ai-astar) 07:18:56 INFO - PID 1653 | RSS: Main: 382701568 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | __start_tp_report 07:18:56 INFO - PID 1653 | _x_x_mozilla_page_load 07:18:56 INFO - PID 1653 | _x_x_mozilla_page_load_details 07:18:56 INFO - PID 1653 | |i|pagename|runs| 07:18:56 INFO - PID 1653 | |0;ai-astar;110;110;110;111;110;112;110;111;110;112 07:18:56 INFO - PID 1653 | |1;audio-beat-detection;141;108;107;148;109;106;107;107;133;105 07:18:56 INFO - PID 1653 | |2;audio-dft;192;185;198;257;187;263;182;181;180;185 07:18:56 INFO - PID 1653 | |3;audio-fft;93;57;58;86;65;59;84;49;87;72 07:18:56 INFO - PID 1653 | |4;audio-oscillator;90;72;85;70;69;69;86;69;69;89 07:18:56 INFO - PID 1653 | |5;imaging-gaussian-blur;88;88;88;87;88;88;88;88;87;88 07:18:56 INFO - PID 1653 | |6;imaging-darkroom;93;95;94;95;94;111;145;94;94;95 07:18:56 INFO - PID 1653 | |7;imaging-desaturate;85;84;84;84;85;84;84;84;84;84 07:18:56 INFO - PID 1653 | |8;json-parse-financial;49;46;46;47;49;48;47;47;47;49 07:18:56 INFO - PID 1653 | |9;json-stringify-tinderbox;54;55;58;61;66;62;59;57;57;56 07:18:56 INFO - PID 1653 | |10;stanford-crypto-aes;82;82;83;83;81;83;82;81;82;83 07:18:56 INFO - PID 1653 | |11;stanford-crypto-ccm;136;136;132;136;133;135;135;138;195;144 07:18:56 INFO - PID 1653 | |12;stanford-crypto-pbkdf2;185;186;219;189;189;190;187;181;192;180 07:18:56 INFO - PID 1653 | |13;stanford-crypto-sha256-iterative;69;67;69;66;68;67;69;66;67;67 07:18:56 INFO - PID 1653 | __end_tp_report 07:18:56 INFO - PID 1653 | __start_cc_report 07:18:56 INFO - PID 1653 | _x_x_mozilla_cycle_collect,2095 07:18:56 INFO - PID 1653 | __end_cc_report 07:18:56 INFO - PID 1653 | __startTimestamp1494598736819__endTimestamp 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | ------- Summary: start ------- 07:18:56 INFO - PID 1653 | Number of tests: 14 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#0] ai-astar Cycles:10 Average:110.60 Median:110.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 07:18:56 INFO - PID 1653 | Values: 110.0 110.0 110.0 111.0 110.0 112.0 110.0 111.0 110.0 112.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#1] audio-beat-detection Cycles:10 Average:117.10 Median:108.50 stddev:16.68 (15.4%) stddev-sans-first:15.28 07:18:56 INFO - PID 1653 | Values: 141.0 108.0 107.0 148.0 109.0 106.0 107.0 107.0 133.0 105.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#2] audio-dft Cycles:10 Average:201.00 Median:189.50 stddev:31.59 (16.7%) stddev-sans-first:33.34 07:18:56 INFO - PID 1653 | Values: 192.0 185.0 198.0 257.0 187.0 263.0 182.0 181.0 180.0 185.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#3] audio-fft Cycles:10 Average:71.00 Median:78.00 stddev:15.51 (19.9%) stddev-sans-first:14.26 07:18:56 INFO - PID 1653 | Values: 93.0 57.0 58.0 86.0 65.0 59.0 84.0 49.0 87.0 72.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:78.50 stddev:9.35 (11.9%) stddev-sans-first:8.62 07:18:56 INFO - PID 1653 | Values: 90.0 72.0 85.0 70.0 69.0 69.0 86.0 69.0 69.0 89.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 07:18:56 INFO - PID 1653 | Values: 88.0 88.0 88.0 87.0 88.0 88.0 88.0 88.0 87.0 88.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#6] imaging-darkroom Cycles:10 Average:101.00 Median:94.00 stddev:16.34 (17.4%) stddev-sans-first:17.08 07:18:56 INFO - PID 1653 | Values: 93.0 95.0 94.0 95.0 94.0 111.0 145.0 94.0 94.0 95.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.33 07:18:56 INFO - PID 1653 | Values: 85.0 84.0 84.0 84.0 85.0 84.0 84.0 84.0 84.0 84.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#8] json-parse-financial Cycles:10 Average:47.50 Median:47.50 stddev:1.18 (2.5%) stddev-sans-first:1.12 07:18:56 INFO - PID 1653 | Values: 49.0 46.0 46.0 47.0 49.0 48.0 47.0 47.0 47.0 49.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:58.50 stddev:3.63 (6.2%) stddev-sans-first:3.46 07:18:56 INFO - PID 1653 | Values: 54.0 55.0 58.0 61.0 66.0 62.0 59.0 57.0 57.0 56.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:0.79 (1.0%) stddev-sans-first:0.83 07:18:56 INFO - PID 1653 | Values: 82.0 82.0 83.0 83.0 81.0 83.0 82.0 81.0 82.0 83.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:136.00 stddev:18.90 (13.9%) stddev-sans-first:19.92 07:18:56 INFO - PID 1653 | Values: 136.0 136.0 132.0 136.0 133.0 135.0 135.0 138.0 195.0 144.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.80 Median:189.00 stddev:10.94 (5.8%) stddev-sans-first:11.47 07:18:56 INFO - PID 1653 | Values: 185.0 186.0 219.0 189.0 189.0 190.0 187.0 181.0 192.0 180.0 07:18:56 INFO - PID 1653 | 07:18:56 INFO - PID 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.50 stddev:1.18 (1.7%) stddev-sans-first:1.12 07:18:56 INFO - PID 1653 | Values: 69.0 67.0 69.0 66.0 68.0 67.0 69.0 66.0 67.0 67.0 07:18:56 INFO - PID 1653 | -------- Summary: end -------- 07:18:56 INFO - PID 1653 | 07:18:57 INFO - TEST-INFO | 1653: exit 0 07:18:57 INFO - TEST-OK | kraken | took 59159ms 07:18:57 INFO - SUITE-END | took 1176s 07:18:57 INFO - Completed test suite (00:19:36) 07:18:57 INFO - javascript benchmark 07:18:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7753.542251173384, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2962.688917663645, 3538.186217170049, 3561.3233485637725, 3581.1763294442276, 3605.3870841956864, 5355.571554275658, 5514.869451762389, 6270.780522681707, 6273.686315684215, 6284.780032698851, 6151.753929842801, 6184.845378865531, 6202.0, 6221.875562488759, 6279.215098112736, 5206.245094461301, 5243.082460569404, 5365.651232669884, 5402.567794576435, 5443.401225865152, 5459.781608735646, 5496.7526461309135, 5504.2294078829, 5512.724363781815, 5521.751521181536, 5283.682979021271, 5339.172428273624, 5341.599380046512, 5364.946350536484, 5453.31833520808, 5353.437889021636, 5365.651232669903, 5367.785288588452, 5381.165919282517, 5388.407275199725, 5298.681574516795, 5309.814156504543, 5355.062863998824, 5363.302770639831, 5365.919511207335, 5900.616459930134, 6188.350223226541, 6248.87502249957, 6249.843753906189, 6291.685415729241, 6540.771073012422, 6580.276169621337, 6596.109525214083, 6596.736130554772, 6601.834954126137, 6421.967890160566, 6583.275839657634, 6672.833179170511, 6725.630090345029, 6743.055972163901, 6170.7531698732, 6188.752449901998, 6270.905936410957, 6335.524835637346, 6344.587601805868, 6815.182178138556, 6819.488538359643, 6827.897581536281, 6851.143607049119, 6853.451723862079, 6293.590916590407, 6358.554901156875, 6372.1716176897635, 6393.360663933569, 6455.289918109004, 6700.195976482853, 6701.128853249046, 6708.798736037927, 6717.731290748413, 6719.899201511981, 6331.651759153291, 6402.327755585689, 6478.449331806849, 6501.869962600722, 6573.704183311763, 6557.704903279268, 6575.079488871466, 6594.3735345143095, 6596.835079122964, 6607.0, 5239.083160446907, 5248.448912864171, 5263.078961181778, 5276.36683597963, 5303.071962406563, 4459.509453960061, 4683.7892294846815, 4697.342372067913, 4721.079389519079, 4738.0, 6144.832481828438, 6262.279837818618, 6331.96834015827, 6335.493160547145, 6339.492840572743, 6638.4689224861895, 6712.697928593225, 6716.3955244028275, 6730.0, 6730.192376914802, 6322.683865806784, 6327.588706734047, 6333.96833015832, 6336.714847831859, 6337.04944258365, 5655.7172141393585, 5736.110902810071, 5748.885022299614, 5762.135679648002, 5829.0, 6690.732370705312, 6698.0, 6711.798646040626, 6719.160104986877, 6719.731210751515, 6513.0, 6522.902156467562, 6641.634710090992, 6650.3682150195655, 6741.629210393476, 6854.725810967506, 6878.312168783082, 6885.655717214219, 6895.482838787011, 6901.0, 6576.408123268929, 6588.703508342041, 6595.241547222131, 6595.703193356215, 6603.636799976048, 6410.0705397718, 6465.482761379172, 6487.0593763903025, 6658.0345849852465, 6706.195256569243, 5417.43116972728, 6364.363563643784, 6440.516961228021, 6441.677916104082, 6444.774432895014, 6419.133416988833, 6441.1626488556185, 6443.484521238383, 6451.1936007999, 6457.967710161419, 5273.367195936512, 6290.654014029273, 6324.715387807468, 6329.303776584664, 6336.176297081534, 5257.658252213594, 6196.628202307876, 6309.432151106423, 6432.324605916311, 6454.515911306765, 6249.78125765596, 6281.528885333527, 6305.054241863757, 6314.684265786784, 6325.525585581007], "value": 6030.064659716435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.1935419424117, 797.0236460336088, 811.667216441259, 1118.189312748258, 1133.087864269264, 27483.450330993368, 27747.445051098966, 27828.304292392673, 27844.025459108936, 27863.582046269297, 27766.0, 38835.0, 38913.805430972876, 38946.41580376297, 38956.22087558247, 8371.330293576515, 8529.360297977646, 8535.786605334853, 8542.060373358925, 8548.31613470924, 6049.546284028694, 8422.199891010345, 8545.31637469001, 8568.871466928002, 8604.0, 6162.5069994400565, 8395.916040839606, 8507.0, 8545.102764209762, 8590.711393290994, 8487.66049358028, 8531.360147988926, 8541.145885411472, 8541.914580854174, 8550.2732267757, 5973.820785376446, 8323.791905202357, 8396.454230475061, 8416.789580260542, 8426.78933026673, 25815.09647162359, 35722.28555428903, 35885.46171807399, 35944.64055359439, 35988.460173097425, 3193.8243396613175, 3609.8809369095666, 3637.1634524059614, 3638.909027274313, 3644.1436262478296, 30057.098287051424, 30106.94625688112, 30112.397752044835, 30169.698303016907, 30253.63858626367, 3139.9058028259187, 3168.8098714077228, 3184.8885289015006, 3187.553742476055, 3194.1216165554424, 276808.0, 277204.61397693085, 277348.0, 277693.0, 277798.2220177813, 47959.801004975154, 48054.75972620115, 48093.5190648096, 48128.5187148131, 48146.0, 50072.74963625159, 50216.74891625519, 50241.74879125654, 50256.497435025914, 50262.0, 13440.731185376238, 13617.0, 13622.455101796015, 13633.182009079486, 13634.386452609657, 10988.835167472495, 10992.230543861853, 11001.00990910822, 11011.944940275407, 11016.834747478793, 10361.274710770174, 10405.635802746867, 12114.636560903187, 12362.134650574373, 12413.0, 5045.697258164522, 5167.974160129251, 5195.116830138885, 5201.687898726089, 5218.712970786567, 995.7610173558294, 1008.6368907193405, 1010.4644538394663, 1045.2369770067894, 1049.9790004199874, 19632.21471141167, 22352.329430117123, 24302.027918883046, 24329.63505547418, 24411.0, 1088.3306766338803, 1097.8847221041676, 1124.7525544380223, 1133.54091592905, 1141.315210873486, 11907.106966977512, 12363.072769542321, 12384.071194660257, 12398.752024959631, 12404.689882753004, 303911.48044259637, 303920.0, 303989.0, 304432.0, 304640.0, 51642.741786290826, 51878.406079695866, 51948.48051519512, 51959.74020129875, 52124.739376302874, 1487.6727120033574, 1526.7480865657042, 1530.2195880101006, 1545.768134779792, 1549.3105568022347, 23681.0, 23796.405089872893, 23847.92684329244, 23862.88068559646, 23884.52230955406, 37074.258514829016, 37195.07012324713, 37223.0, 37227.813860930524, 37340.626593733716, 225431.0, 265276.67361663067, 266211.0, 266307.0, 267477.0, 31678.366432670755, 31804.0, 32467.0, 32592.511112333807, 32730.83634581812, 35488.46767298441, 35499.58001679904, 35500.467492988144, 35504.82247588746, 42726.78636606922, 25409.491810163323, 26864.462710746066, 29372.55941160927, 29549.852250738608, 29753.85123074371, 26700.732992669826, 29163.0, 29222.561661575517, 29410.0, 29629.851850740608, 33146.0, 33913.49129763105, 34841.651583484854, 35233.471497927036, 35421.0, 28400.0, 28637.570436443053, 29426.705732942395, 29481.0, 29838.701612983594, 18899.527511812314, 22560.774392255866, 22938.738369389845, 23269.0, 23415.648765268194], "value": 16644.074216597935, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [438.86614582552306, 440.61886468205, 442.32324543448516, 446.8726412972303, 461.06173936040165, 21297.828619425927, 21380.25169119081, 21588.892055539738, 21984.560308793814, 22080.558388832233, 21891.90540472974, 22671.546569068607, 23541.529169416644, 23656.935437905293, 23943.28170154898, 4588.977055114719, 5981.4018598140165, 6214.0989556514505, 6224.657643829588, 6227.750889964419, 3625.8912232633065, 3693.5013773140686, 3693.741438099334, 5375.0593646111965, 5977.133315669225, 6069.848253793669, 6072.696365181745, 6080.939190608082, 6085.361037091086, 6113.510919126482, 5875.735591898375, 6050.667213303266, 6072.240969878765, 6109.266887973427, 6130.141780150782, 5304.522592966651, 5440.102383106782, 5445.292112025451, 5447.4824891635235, 5449.536789372908, 27999.020034298905, 28037.0, 28544.28639284014, 28601.85699071512, 28905.988290409736, 2134.8292136629034, 2149.580831737812, 2158.6761985702115, 2175.2495389090736, 2180.967285490719, 17766.378176763752, 17860.928344299384, 17894.731579026324, 18293.359732409433, 18426.078696065142, 2098.8425868059803, 2154.515234072337, 2172.945676358088, 2176.858504197222, 2186.7813218678166, 154140.0, 157750.0, 159967.0, 160398.0, 162246.18876905658, 11955.815464587498, 12610.847288177956, 12624.843789052737, 12628.621141365773, 12686.873131268754, 16513.422030228885, 16514.93563304587, 16517.174141292886, 16518.091504967342, 16564.420245291356, 8557.614907329185, 8753.0, 8769.956150219336, 8855.025947145938, 8896.955515222382, 8148.329592433537, 8162.7143049992965, 8176.059753128347, 8347.248747612623, 8353.457025293337, 7706.229377062361, 7851.921480785233, 7865.960670196612, 7868.213178682086, 7900.604969751489, 2072.9424099453486, 2156.5255643758346, 2157.20183532091, 2184.7050648162294, 2304.550612630521, 936.4287784451479, 936.9203617692436, 970.9320347575602, 982.3320142303303, 982.7420901246415, 20115.0, 21368.0, 21385.89307053455, 21595.460113497287, 21615.527742720922, 869.9086595907465, 975.0882924465648, 1001.0940099210227, 1003.242551873331, 1003.859459675646, 11033.889661103447, 11255.380954047443, 11274.774504509864, 11305.943470282597, 11321.547138114383, 547817.0, 556600.0, 560346.0, 563241.0, 567533.0, 119216.40391797986, 124880.0, 125816.37091814482, 131638.0, 132667.0, 1175.0834349207462, 1196.5393323570313, 1236.505397840871, 1240.665020444493, 1245.5578269714301, 15980.760288595913, 21388.0, 22413.43966400853, 22518.774812251668, 22960.08159673661, 56944.0, 57212.42787572071, 57674.42325576858, 58308.70845645745, 58654.0, 58965.58583648162, 80345.59827200827, 80859.0, 83492.0, 83840.0, 8722.607482663168, 8773.56132193375, 8804.779880503038, 9300.72097837066, 9343.906560934576, 13786.172829630254, 14290.0, 14433.20617366055, 14694.853051469776, 14908.62728431798, 11884.584039558575, 12030.398480076135, 12193.57322493744, 12287.93856030714, 12303.446344914679, 10519.26365154432, 11191.104711623213, 11436.771264574829, 11664.475098620753, 11844.644660660195, 11838.763224735629, 12046.337451440255, 12354.505819767108, 12387.566435174725, 12443.191192572454, 8728.825423491622, 8775.166359195866, 8784.560771961504, 8954.865677014981, 9110.908890911007, 11726.41367931617, 11905.40472976365, 12081.879181208076, 12156.939215303866, 12169.20900141488], "value": 10443.289903631172, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1423.3381477612909, 1442.9494967676128, 1469.8897582681302, 1473.9336729847148, 1478.1426772471968, 11552.342961118937, 12034.398280086005, 12049.518019279218, 12050.276983380993, 12084.939575302133, 11537.134714896374, 12140.575079872184, 12187.939060304709, 12199.878001219986, 12229.082818788582, 2506.511230310086, 2580.948381032378, 2583.547879121156, 2585.8836352364096, 2588.961165582518, 2149.9570008599817, 2255.616545187322, 2502.749725027501, 2580.58710606303, 2589.676290463692, 2207.073029327686, 2519.3197836584113, 2606.7784238339764, 2611.8302310349864, 2613.607958806185, 2526.734692857242, 2541.3646588352913, 2551.2983929419465, 2553.3871870750977, 2557.1561384743177, 2137.4015275722822, 2519.987400062988, 2536.720960694322, 2546.1597672767944, 2546.5161619292276, 11249.493772780163, 11532.192746507748, 11550.653480395602, 11553.595624153115, 11612.883871161264, 6433.485321174295, 6677.666116694146, 6679.766208182739, 6687.465002799764, 6691.397774200345, 4073.735207211522, 4224.809883555247, 4299.527052024275, 4361.214981303364, 4369.956300436987, 1116.3357802107814, 1229.1825935752713, 1246.5637027040555, 1267.689416093054, 1277.086882878746, 15734.9213253933, 15946.521604351889, 16349.0, 16352.591185220346, 16387.83612163875, 5740.225069615549, 5772.0, 5958.433948774859, 6019.157317975487, 6065.059915713072, 13852.376643050886, 13888.513902013381, 13889.02776805614, 13911.956603254795, 13926.164430134224, 6795.18457785059, 6795.1845778506895, 6797.796066118024, 6799.218089919624, 6802.387785099266, 5657.830265092054, 6118.357572454917, 6136.447719705248, 6193.287771906198, 6239.875202496016, 4512.5261847505535, 4629.236176030917, 4639.837605683785, 4672.345871577982, 4713.552212539872, 1307.2875282970804, 1421.7440860644977, 1465.7801329800616, 1469.8677119059337, 1487.4199062365685, 660.867826434715, 675.2470994840717, 753.179034852014, 772.3743767548303, 798.469018102955, 5967.701614919237, 5997.640141591519, 6026.789062382795, 6186.690665466709, 6190.133381326618, 893.8614514750224, 909.9909000910038, 918.4443411735937, 927.7077720518015, 940.2431043010306, 3469.2887957968555, 3734.3464893643504, 3846.288436639231, 3881.902952426212, 3886.1839013807416, 14419.062760920506, 14616.926915365355, 14718.55844324672, 14751.40994360235, 14760.0, 14336.068155569854, 14608.05047671898, 14886.553403397915, 15032.549023529311, 15033.323500442506, 8425.95787021061, 8522.78693032679, 8526.147385261424, 8536.975562932488, 8543.615537300837, 6284.811455656338, 6512.34876512345, 6757.256701762703, 6763.357481039294, 6782.28785977485, 11773.411329433666, 13165.473381065034, 13450.058495905192, 13486.595402137558, 13738.587842364745, 13149.342532873126, 13711.108777929403, 13938.790918136034, 13972.904064390423, 14020.579382618538, 8959.372843900865, 9202.447853128833, 9401.764955876159, 9423.340366174301, 9426.0, 10659.573617055232, 10882.45587720595, 10883.23817332779, 10904.61833835812, 10926.0, 8845.071267517076, 9042.412243204171, 9096.90903090987, 9213.769655758391, 9227.21568666644, 8861.51261680588, 8868.645254190018, 8930.910690893008, 8973.192412682889, 9161.633534658806, 6937.7571784987285, 7901.328387086932, 8064.475809072392, 8104.716334928249, 8208.507489550646, 5969.194158788681, 6012.849678758066, 6021.668808215415, 6070.18052562916, 6136.0, 5052.9388828346455, 5941.494972927349, 6115.052166914135, 6134.0, 6182.783602573888], "value": 5398.842089215048, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.5968766806763, 361.3892521638429, 391.06925517268894, 393.323483608194, 404.22994196056516, 5201.973990130049, 5961.344252132273, 6037.909431358527, 6054.490413723513, 6078.392160783919, 4706.388169537955, 5256.8160114396005, 5655.26481557398, 5921.85195370116, 6014.398560143984, 4333.176696427684, 4426.690131690783, 4430.424044874162, 4434.800433980478, 4494.4831344395325, 4433.866983990485, 4443.15580039793, 4449.221386257408, 4450.643948484129, 4476.597106260436, 4168.812403441837, 4373.628241599452, 4421.7840093974255, 4423.823047078113, 4423.942866567046, 4338.175746608134, 4350.825966961318, 4379.583939525756, 4382.868513944587, 4426.845060422886, 3159.8104113753247, 3377.459606462954, 3736.3461394255896, 3781.9054523636855, 3782.8108594570435, 4843.346148269974, 5658.0, 5906.852328691774, 5912.17229587858, 5914.61554998928, 5198.584113270929, 5203.178887389421, 5224.268602395668, 5255.290535777659, 5284.656497327662, 6413.454856337217, 6438.967805160991, 6439.645819479973, 6447.903281450782, 6477.287498375175, 4160.45914031174, 4220.198162349144, 4288.004474786901, 4300.290452075404, 4315.4821421429315, 5966.671833049137, 5974.61165024272, 6233.407826256498, 6578.243501997236, 6709.664516774142, 3526.682598566141, 4211.936820947688, 4220.85227017053, 4222.683298752544, 4238.279492486285, 3760.981195094007, 4244.830206791694, 4264.9079417422745, 4405.273129933525, 4416.1609294233995, 5018.734076035341, 5117.309163262987, 5193.922091168635, 5202.76587553561, 5210.244514545369, 6386.233651961795, 6470.320616335312, 6476.283784797032, 6476.740930362733, 6479.838004049842, 1161.3496441992343, 1434.6413396650837, 1493.9775903361458, 1506.314626844783, 1517.9165145916859, 824.3034635732796, 843.6119385082808, 876.5456721180668, 932.9737288982066, 999.2805180270194, 4916.3451736062125, 6029.186059881948, 6056.454919057306, 6089.299730530957, 6096.719688865299, 5946.167536544887, 6056.788012419544, 6668.666566671647, 6672.065910772496, 6688.929771236676, 4683.672142949961, 5249.0, 5848.941510584925, 6072.574919755663, 6093.055576385579, 3275.7051865332232, 3447.5690538682666, 3457.9827100864836, 3471.6701913318193, 3489.685928266468, 5690.715464226855, 6295.18162638854, 6768.661566921634, 6852.349026842442, 6887.449004079662, 5845.795397161079, 6829.590224586541, 6857.314268573103, 6859.348361905611, 6871.896921546181, 6095.542834287357, 6465.013631052934, 6810.0, 6821.0, 6836.726530938806, 6375.585586936834, 6495.220573531206, 6508.219013718384, 6512.446442052478, 6549.7380104795275, 5479.890082438172, 5826.94173058264, 6016.699165041818, 6313.842153946188, 6513.250976137615, 6014.849628759316, 6451.3226111257645, 6519.445847102859, 6614.570052946543, 6898.551594146365, 4920.532549407801, 4934.210526315772, 4939.678920870132, 4964.826231081895, 4970.763156579482, 5563.610547261653, 6222.315545289924, 6443.516736244894, 6596.769113081019, 6782.864342713019, 6160.0, 6440.9033864493, 6510.283868774336, 6523.4884569440155, 6526.771562995273, 6416.454601358937, 6478.445173158502, 6507.219133703986, 6515.250746164252, 6538.0, 4762.285657151317, 5242.816501422432, 5920.407959204217, 6366.2360516736435, 6382.138411314599, 6427.589653879795, 6493.772717954849, 6508.219013718384, 6522.641254731036, 6533.497295622129, 5598.776048957996, 6120.441255049921, 6288.5283603728985, 6357.566913866461, 6392.360763923571], "value": 4635.735361348951, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.1528669100497, 739.9889001664974, 766.3179770004693, 811.1482942909943, 836.6026137584648, 13333.399997000133, 16823.327066917325, 16834.747478787798, 16839.747403788937, 16846.98918064917, 13164.670883227924, 14846.257687115654, 15527.611809704764, 15684.05895646262, 15687.29407176677, 942.4533770413144, 950.9524523773819, 951.9381240219399, 953.8187744328555, 955.8996305387939, 977.0961860279249, 978.227200511595, 980.1472718734675, 980.8136454073739, 1001.2940876681922, 1009.9747506312327, 1023.0843395161326, 1023.6826583759058, 1025.907668309852, 1026.9897301027006, 1019.7399663085903, 1048.428606409505, 1057.0, 1058.1006144776954, 1060.5333653192608, 766.4634755670996, 767.5624893810531, 768.8654485465021, 770.684019551981, 770.818857568471, 16846.24191911367, 16916.915415422965, 16962.06708631025, 17008.149592520323, 17054.23255953473, 16842.663146736995, 16954.40659576921, 17215.913920430445, 17364.39224627132, 17652.0, 14177.503787367392, 14311.141331520143, 14370.353334099991, 14457.421703131968, 14562.490312839105, 3578.624244454347, 3609.5488063992, 3613.0064232336053, 3616.023673608111, 3633.4731463937846, 101411.49294253555, 123690.0, 124246.0, 124680.75319246874, 127234.0, 13383.732325353632, 13427.865721342661, 13599.252041137832, 13606.591802245948, 13737.313134343243, 25717.242310172678, 25775.355616109748, 25933.74066259351, 26318.0, 26583.601245981325, 7395.445341599294, 7524.435667324972, 7610.391168706601, 7611.238876112345, 7613.162552119263, 3757.3800322946954, 3887.669548088444, 3889.533256009297, 3895.24042811649, 3897.629725176104, 4323.740575565476, 4368.4321038264825, 4395.934060989088, 4409.889752756207, 4416.690831641754, 857.5969294431607, 861.9310455163571, 871.7559083456642, 874.6676263020012, 876.9693060742843, 643.2152773616181, 667.4226793823308, 673.1988933169611, 673.2964052565081, 685.8833998220315, 11209.719757005976, 11913.642590722293, 11956.88043119575, 12057.07219443881, 12198.451069701885, 626.2015929689591, 631.602090682876, 642.4218203616689, 670.6747227594612, 676.5839009009522, 4355.412019377343, 5646.774129034792, 5654.575906807006, 5727.1695604138, 5742.511886489695, 102478.0, 103292.45061324086, 104177.47911260395, 104227.4788626052, 106250.4062439064, 86098.0, 91080.54459727791, 91192.0, 92245.5387723057, 93709.0, 50933.98132037339, 62643.686781566714, 78930.60534697404, 78997.60501197458, 82029.3086811083, 12330.075244356529, 12695.36523173856, 12701.491940322283, 12708.87291127077, 12758.553450629184, 32598.0, 40468.595314046484, 41170.0, 41610.37584436296, 41882.58117418787, 53673.463265366845, 54069.45930540802, 54509.36471905849, 55270.0, 55591.0, 16078.67842643164, 16236.51290461288, 16328.836711632732, 16397.180140992663, 16593.834061659712, 18028.909855451162, 18293.868963737707, 18337.908310458362, 18429.447116586525, 18572.907135464236, 16408.261628226996, 16829.831701682826, 16909.0, 16978.745318820474, 17195.828041719422, 16315.673686525966, 16376.67246655084, 16852.0, 16876.24056917417, 16930.407435740184, 16107.516774496784, 16177.514674559312, 16503.33986640521, 16699.99800012003, 16743.665126697153, 11841.703957401134, 11895.345755983159, 11980.64058078259, 11997.820032699341, 12075.154739168174, 12542.811857821958, 12788.593254741785, 12893.677658058623, 12918.966482681551, 12960.222386656831], "value": 8281.949085368029, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1437.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 110.0, 111.0, 110.0, 112.0, 110.0, 111.0, 110.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 108.0, 107.0, 148.0, 109.0, 106.0, 107.0, 107.0, 133.0, 105.0], "value": 117.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 185.0, 198.0, 257.0, 187.0, 263.0, 182.0, 181.0, 180.0, 185.0], "value": 201.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 57.0, 58.0, 86.0, 65.0, 59.0, 84.0, 49.0, 87.0, 72.0], "value": 71.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 85.0, 70.0, 69.0, 69.0, 86.0, 69.0, 69.0, 89.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 87.0, 88.0, 88.0, 88.0, 88.0, 87.0, 88.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 95.0, 94.0, 111.0, 145.0, 94.0, 94.0, 95.0], "value": 101.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 46.0, 46.0, 47.0, 49.0, 48.0, 47.0, 47.0, 47.0, 49.0], "value": 47.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 58.0, 61.0, 66.0, 62.0, 59.0, 57.0, 57.0, 56.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 83.0, 81.0, 83.0, 82.0, 81.0, 82.0, 83.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 132.0, 136.0, 133.0, 135.0, 135.0, 138.0, 195.0, 144.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 219.0, 189.0, 189.0, 190.0, 187.0, 181.0, 192.0, 180.0], "value": 189.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 66.0, 68.0, 67.0, 69.0, 66.0, 67.0, 67.0], "value": 67.5, "unit": "score"}]}]} 07:18:58 INFO - Return code: 0 07:18:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:18:58 INFO - # TBPL SUCCESS # 07:18:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:18:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:18:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:18:58 INFO - 2017-05-12 07:18:58.153 screenresolution[1658:10002] starting screenresolution argv=screenresolution get 07:18:58 INFO - 2017-05-12 07:18:58.156 screenresolution[1658:10002] Display 0: 1600x1200x32@60 07:18:58 INFO - 2017-05-12 07:18:58.162 screenresolution[1659:10005] starting screenresolution argv=screenresolution list 07:18:58 INFO - Available Modes on Display 0 07:18:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:18:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:18:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:18:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:18:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:18:58 INFO - Intel Iris: 07:18:58 INFO - Chipset Model: Intel Iris 07:18:58 INFO - Type: GPU 07:18:58 INFO - Bus: Built-In 07:18:58 INFO - VRAM (Dynamic, Max): 1536 MB 07:18:58 INFO - Vendor: Intel (0x8086) 07:18:58 INFO - Device ID: 0x0a2e 07:18:58 INFO - Revision ID: 0x0009 07:18:58 INFO - Displays: 07:18:58 INFO - Display: 07:18:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:18:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:18:58 INFO - Display Serial Number: 1600x1200 60 07:18:58 INFO - Main Display: Yes 07:18:58 INFO - Mirror: Off 07:18:58 INFO - Online: Yes 07:18:58 INFO - Rotation: Supported 07:18:58 INFO - Return code: 0 07:18:58 INFO - Running post-action listener: _resource_record_post_action 07:18:58 INFO - [mozharness: 2017-05-12 14:18:58.402911Z] Finished run-tests step (success) 07:18:58 INFO - Running post-run listener: _resource_record_post_run 07:18:58 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 38409728; Write bytes: 530265088; Read time: 247; Write time: 1606 07:18:58 INFO - TinderboxPrint: CPU usage
53.4% 07:18:58 INFO - TinderboxPrint: I/O read bytes / time
38,409,728 / 247 07:18:58 INFO - TinderboxPrint: I/O write bytes / time
530,265,088 / 1,606 07:18:58 INFO - TinderboxPrint: CPU idle
2,231.6 (46.6%) 07:18:58 INFO - TinderboxPrint: CPU system
954.9 (19.9%) 07:18:58 INFO - TinderboxPrint: CPU user
1,607.2 (33.5%) 07:18:58 INFO - TinderboxPrint: Swap in / out
252,825,600 / 0 07:18:58 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 207829504; Write bytes: 205414400; Read time: 15816; Write time: 440 07:18:58 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 37479936; Write bytes: 314950656; Read time: 236; Write time: 1133 07:18:58 INFO - Running post-run listener: _upload_blobber_files 07:18:58 INFO - Blob upload gear active. 07:18:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:18:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:18:58 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'] 07:18:58 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 07:18:59 INFO - (blobuploader) - INFO - Open directory for files ... 07:18:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:18:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:19:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:00 INFO - (blobuploader) - INFO - Done attempting. 07:19:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:19:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:19:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:01 INFO - (blobuploader) - INFO - Done attempting. 07:19:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:19:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:19:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:02 INFO - (blobuploader) - INFO - Done attempting. 07:19:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:19:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:19:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:19:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:19:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:19:04 INFO - (blobuploader) - INFO - Done attempting. 07:19:04 INFO - (blobuploader) - INFO - Iteration through files over. 07:19:04 INFO - Return code: 0 07:19:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:19:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:19:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0780406c9fb98acd849ba391263a6043fd611b964d48c70a8a72b892aa3945f6e6771a2b4f22a332cdaacab084aec08777cfdf7b77b3098767852b2d0b9087ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/329657a3bd1bc45ebe51bda6802b164aef57cb98ebb605e0c06b7dc047f540cc2d4671d02e3da0f3645daaae2eadad15dd25a577586c46805f9fe1b521ffc067", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/033b6579925c5dcf65ab75d1a9085ca33ebe3e6ac6feff5fa8d9ebc76f69279e009ce8398fbdf4c426b6430f7edc5790b8ce59ad1f7353114e47a97f78b5f222", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4180c3887b894724a2732ff4923c4b4cfd64618f729102beb84cc66a01b827df87558c44af58aa62748bf0e04938623f5c2a30fa477e838c043bef2367bd7136"} 07:19:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:19:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:19:04 INFO - Contents: 07:19:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0780406c9fb98acd849ba391263a6043fd611b964d48c70a8a72b892aa3945f6e6771a2b4f22a332cdaacab084aec08777cfdf7b77b3098767852b2d0b9087ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/329657a3bd1bc45ebe51bda6802b164aef57cb98ebb605e0c06b7dc047f540cc2d4671d02e3da0f3645daaae2eadad15dd25a577586c46805f9fe1b521ffc067", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/033b6579925c5dcf65ab75d1a9085ca33ebe3e6ac6feff5fa8d9ebc76f69279e009ce8398fbdf4c426b6430f7edc5790b8ce59ad1f7353114e47a97f78b5f222", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4180c3887b894724a2732ff4923c4b4cfd64618f729102beb84cc66a01b827df87558c44af58aa62748bf0e04938623f5c2a30fa477e838c043bef2367bd7136"} 07:19:04 INFO - Running post-run listener: copy_logs_to_upload_dir 07:19:04 INFO - Copying logs to upload dir... 07:19:04 INFO - mkdir: /builds/slave/test/build/upload/logs 07:19:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.030366 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-05-12 07:19:04.594017) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 07:19:04.597850) ========= 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.OITsMlCfG0/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.gL5kZ68SUd/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0780406c9fb98acd849ba391263a6043fd611b964d48c70a8a72b892aa3945f6e6771a2b4f22a332cdaacab084aec08777cfdf7b77b3098767852b2d0b9087ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/329657a3bd1bc45ebe51bda6802b164aef57cb98ebb605e0c06b7dc047f540cc2d4671d02e3da0f3645daaae2eadad15dd25a577586c46805f9fe1b521ffc067", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/033b6579925c5dcf65ab75d1a9085ca33ebe3e6ac6feff5fa8d9ebc76f69279e009ce8398fbdf4c426b6430f7edc5790b8ce59ad1f7353114e47a97f78b5f222", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4180c3887b894724a2732ff4923c4b4cfd64618f729102beb84cc66a01b827df87558c44af58aa62748bf0e04938623f5c2a30fa477e838c043bef2367bd7136"} build_url:https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010812 build_url: 'https://queue.taskcluster.net/v1/task/BWX4BTA0R-66tGAAkAc8SQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0780406c9fb98acd849ba391263a6043fd611b964d48c70a8a72b892aa3945f6e6771a2b4f22a332cdaacab084aec08777cfdf7b77b3098767852b2d0b9087ae", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/329657a3bd1bc45ebe51bda6802b164aef57cb98ebb605e0c06b7dc047f540cc2d4671d02e3da0f3645daaae2eadad15dd25a577586c46805f9fe1b521ffc067", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/033b6579925c5dcf65ab75d1a9085ca33ebe3e6ac6feff5fa8d9ebc76f69279e009ce8398fbdf4c426b6430f7edc5790b8ce59ad1f7353114e47a97f78b5f222", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4180c3887b894724a2732ff4923c4b4cfd64618f729102beb84cc66a01b827df87558c44af58aa62748bf0e04938623f5c2a30fa477e838c043bef2367bd7136"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 07:19:04.633599) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:19:04.633958) ========= 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.OITsMlCfG0/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.gL5kZ68SUd/Listeners TMPDIR=/var/folders/hs/v2yc1m995s13wd7f6m2b870c00000w/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.004962 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 07:19:04.682225) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 07:19:04.682550) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 07:19:04.682891) ========= ========= Total master_lag: 0.18 =========