builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0312 starttime: 1493156229.7 results: success (0) buildid: 20170425130325 builduid: fb27fef2380a44aeb4dc43ddf1800552 revision: 10ecc167ef4af98ab2659d20ec799eb765165cfd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 14:37:09.702318) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-25 14:37:09.702763) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 14:37:09.703042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-25 14:37:09.729847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 14:37:09.730187) ========= 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.3iWJdLHBAz/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.jabGaalwWx/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-04-25 14:37:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 66.4M=0s 2017-04-25 14:37:09 (66.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089535 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 14:37:09.844529) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 14:37:09.844866) ========= 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.3iWJdLHBAz/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.jabGaalwWx/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.037102 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 14:37:09.904681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 14:37:09.905030) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 10ecc167ef4af98ab2659d20ec799eb765165cfd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 10ecc167ef4af98ab2659d20ec799eb765165cfd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3iWJdLHBAz/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.jabGaalwWx/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-04-25 14:37:10,025 truncating revision to first 12 chars 2017-04-25 14:37:10,026 Setting DEBUG logging. 2017-04-25 14:37:10,026 attempt 1/10 2017-04-25 14:37:10,026 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/10ecc167ef4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-25 14:37:11,123 unpacking tar archive at: mozilla-central-10ecc167ef4a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.381778 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-25 14:37:11.311334) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 14:37:11.311658) ========= script_repo_revision: 10ecc167ef4af98ab2659d20ec799eb765165cfd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-25 14:37:11.312040) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 14:37:11.312321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-25 14:37:11.332519) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-25 14:37:11.332835) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3iWJdLHBAz/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.jabGaalwWx/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:37:11 INFO - MultiFileLogger online at 20170425 14:37:11 in /builds/slave/test 14:37:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:37:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:37:11 INFO - {'append_to_log': False, 14:37:11 INFO - 'base_work_dir': '/builds/slave/test', 14:37:11 INFO - 'blob_upload_branch': 'Firefox', 14:37:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:37:11 INFO - 'branch': 'Firefox', 14:37:11 INFO - 'buildbot_json_path': 'buildprops.json', 14:37:11 INFO - 'config_files': ('talos/mac_config.py',), 14:37:11 INFO - 'default_actions': ('clobber', 14:37:11 INFO - 'read-buildbot-config', 14:37:11 INFO - 'download-and-extract', 14:37:11 INFO - 'populate-webroot', 14:37:11 INFO - 'create-virtualenv', 14:37:11 INFO - 'install', 14:37:11 INFO - 'run-tests'), 14:37:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:37:11 INFO - 'download_minidump_stackwalk': True, 14:37:11 INFO - 'download_symbols': 'ondemand', 14:37:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:37:11 INFO - 'tooltool.py': '/tools/tooltool.py', 14:37:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:37:11 INFO - '/tools/misc-python/virtualenv.py')}, 14:37:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:37:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:37:11 INFO - 'gecko_profile': False, 14:37:11 INFO - 'gecko_profile_interval': 0, 14:37:11 INFO - 'installer_path': 'installer.exe', 14:37:11 INFO - 'log_level': 'info', 14:37:11 INFO - 'log_name': 'talos', 14:37:11 INFO - 'log_to_console': True, 14:37:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:37:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:37:11 INFO - 'opt_config_files': (), 14:37:11 INFO - 'pip_index': False, 14:37:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:37:11 INFO - 'cmd': ('bash', 14:37:11 INFO - '-c', 14:37:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:37:11 INFO - 'enabled': True, 14:37:11 INFO - 'halt_on_failure': False, 14:37:11 INFO - 'name': 'check_screen_resolution'},), 14:37:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:37:11 INFO - 'cmd': ('bash', 14:37:11 INFO - '-c', 14:37:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:37:11 INFO - 'enabled': True, 14:37:11 INFO - 'halt_on_failure': False, 14:37:11 INFO - 'name': 'check_screen_resolution'},), 14:37:11 INFO - 'run_cmd_checks_enabled': True, 14:37:11 INFO - 'suite': 'dromaeojs-e10s', 14:37:11 INFO - 'system_bits': '32', 14:37:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:37:11 INFO - 'title': 't-yosemite-r7-0312', 14:37:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:37:11 INFO - 'use_talos_json': True, 14:37:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:37:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:37:11 INFO - 'work_dir': 'build'} 14:37:11 INFO - [mozharness: 2017-04-25 21:37:11.556178Z] Running clobber step. 14:37:11 INFO - Running pre-action listener: _resource_record_pre_action 14:37:11 INFO - Running main action method: clobber 14:37:11 INFO - rmtree: /builds/slave/test/build 14:37:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:37:15 INFO - Running post-action listener: _resource_record_post_action 14:37:15 INFO - [mozharness: 2017-04-25 21:37:15.930331Z] Finished clobber step (success) 14:37:15 INFO - [mozharness: 2017-04-25 21:37:15.930447Z] Running read-buildbot-config step. 14:37:15 INFO - Running pre-action listener: _resource_record_pre_action 14:37:15 INFO - Running main action method: read_buildbot_config 14:37:15 INFO - Using buildbot properties: 14:37:15 INFO - { 14:37:15 INFO - "project": "", 14:37:15 INFO - "product": "firefox", 14:37:15 INFO - "script_repo_revision": "production", 14:37:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:37:15 INFO - "repository": "", 14:37:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:37:15 INFO - "buildid": "20170425130325", 14:37:15 INFO - "pgo_build": "False", 14:37:15 INFO - "basedir": "/builds/slave/test", 14:37:15 INFO - "buildnumber": 41, 14:37:15 INFO - "slavename": "t-yosemite-r7-0312", 14:37:15 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 14:37:15 INFO - "platform": "yosemite_r7", 14:37:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:37:15 INFO - "branch": "mozilla-central", 14:37:15 INFO - "repo_path": "mozilla-central", 14:37:15 INFO - "revision": "10ecc167ef4af98ab2659d20ec799eb765165cfd", 14:37:15 INFO - "stage_platform": "macosx64", 14:37:15 INFO - "builduid": "fb27fef2380a44aeb4dc43ddf1800552", 14:37:15 INFO - "slavebuilddir": "test" 14:37:15 INFO - } 14:37:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 14:37:15 INFO - Running post-action listener: _resource_record_post_action 14:37:15 INFO - [mozharness: 2017-04-25 21:37:15.933509Z] Finished read-buildbot-config step (success) 14:37:15 INFO - [mozharness: 2017-04-25 21:37:15.933615Z] Running download-and-extract step. 14:37:15 INFO - Running pre-action listener: _resource_record_pre_action 14:37:15 INFO - Running main action method: download_and_extract 14:37:15 INFO - mkdir: /builds/slave/test/build/tests 14:37:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:15 INFO - trying https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 14:37:15 INFO - Downloading https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/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 14:37:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/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 14:37:16 INFO - Downloaded 1325 bytes. 14:37:16 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:37:16 INFO - Using the following test package requirements: 14:37:16 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:37:16 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 14:37:16 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:37:16 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:37:16 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 14:37:16 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:37:16 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 14:37:16 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:37:16 INFO - u'jsshell-mac.zip'], 14:37:16 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:37:16 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 14:37:16 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:37:16 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:37:16 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 14:37:16 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:37:16 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 14:37:16 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:37:16 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 14:37:16 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:37:16 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 14:37:16 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:37:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:37:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:37:16 INFO - Fetch https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:37:18 INFO - Content-Length response header: 52526775 14:37:18 INFO - Bytes received: 52526775 14:37:34 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 14:37:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:37:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:37:34 INFO - Fetch https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:37:36 INFO - Content-Length response header: 52526775 14:37:36 INFO - Bytes received: 52526775 14:37:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 14:37:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:37:51 INFO - Fetch https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 14:37:53 INFO - Content-Length response header: 14408809 14:37:53 INFO - Bytes received: 14408809 14:37:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:37:53 INFO - trying https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:37:53 INFO - Downloading https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 14:37:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/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 14:37:55 INFO - Downloaded 71139202 bytes. 14:37:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:37:55 INFO - mkdir: /builds/slave/test/properties 14:37:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:37:55 INFO - Writing to file /builds/slave/test/properties/build_url 14:37:55 INFO - Contents: 14:37:55 INFO - build_url:https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:37:56 INFO - Running post-action listener: _resource_record_post_action 14:37:56 INFO - Running post-action listener: set_extra_try_arguments 14:37:56 INFO - [mozharness: 2017-04-25 21:37:56.239230Z] Finished download-and-extract step (success) 14:37:56 INFO - [mozharness: 2017-04-25 21:37:56.239376Z] Running populate-webroot step. 14:37:56 INFO - Running pre-action listener: _resource_record_pre_action 14:37:56 INFO - Running main action method: populate_webroot 14:37:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:37:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:37:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:37:56 INFO - '--tppagecycles', 14:37:56 INFO - '7'], 14:37:56 INFO - 'tests': ['tsvgm']}}, 14:37:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:37:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:37:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:37:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:37:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:37:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:37:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:37:56 INFO - 'talos_options': ['--disable-e10s'], 14:37:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:37:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:37:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:37:56 INFO - 'talos_options': ['--disable-e10s'], 14:37:56 INFO - 'tests': ['damp', 'tps']}, 14:37:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:37:56 INFO - 'tests': ['damp', 'tps']}, 14:37:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:37:56 INFO - 'tests': ['dromaeo_dom']}, 14:37:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:37:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:37:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:37:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:37:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:37:56 INFO - 'tests': ['a11yr', 14:37:56 INFO - 'ts_paint', 14:37:56 INFO - 'tpaint', 14:37:56 INFO - 'sessionrestore', 14:37:56 INFO - 'sessionrestore_no_auto_restore', 14:37:56 INFO - 'tabpaint']}, 14:37:56 INFO - 'other-e10s': {'tests': ['a11yr', 14:37:56 INFO - 'ts_paint', 14:37:56 INFO - 'tpaint', 14:37:56 INFO - 'sessionrestore', 14:37:56 INFO - 'sessionrestore_no_auto_restore', 14:37:56 INFO - 'tabpaint']}, 14:37:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:37:56 INFO - 'ts_paint', 14:37:56 INFO - 'tpaint', 14:37:56 INFO - 'sessionrestore', 14:37:56 INFO - 'sessionrestore_no_auto_restore', 14:37:56 INFO - 'tabpaint']}, 14:37:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:37:56 INFO - 'ts_paint', 14:37:56 INFO - 'tpaint', 14:37:56 INFO - 'sessionrestore', 14:37:56 INFO - 'sessionrestore_no_auto_restore', 14:37:56 INFO - 'tabpaint']}, 14:37:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:37:56 INFO - 'tests': ['a11yr', 14:37:56 INFO - 'ts_paint', 14:37:56 INFO - 'tpaint', 14:37:56 INFO - 'sessionrestore', 14:37:56 INFO - 'sessionrestore_no_auto_restore', 14:37:56 INFO - 'tabpaint']}, 14:37:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:37:56 INFO - 'tests': ['a11yr', 14:37:56 INFO - 'ts_paint', 14:37:56 INFO - 'tpaint', 14:37:56 INFO - 'sessionrestore', 14:37:56 INFO - 'sessionrestore_no_auto_restore', 14:37:56 INFO - 'tabpaint']}, 14:37:56 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:37:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:37:56 INFO - 'bloom_basic_ref']}, 14:37:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:37:56 INFO - 'tests': ['tsvgx', 14:37:56 INFO - 'tsvgr_opacity', 14:37:56 INFO - 'tart', 14:37:56 INFO - 'tscrollx', 14:37:56 INFO - 'cart', 14:37:56 INFO - 'tsvg_static']}, 14:37:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:37:56 INFO - 'tsvgr_opacity', 14:37:56 INFO - 'tart', 14:37:56 INFO - 'tscrollx', 14:37:56 INFO - 'cart', 14:37:56 INFO - 'tsvg_static']}, 14:37:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:37:56 INFO - 'talos_options': ['--disable-e10s'], 14:37:56 INFO - 'tests': ['tp5o']}, 14:37:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:37:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:37:56 INFO - 'talos_options': ['--disable-e10s', 14:37:56 INFO - '--xperf_path', 14:37:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:56 INFO - 'tests': ['tp5n']}, 14:37:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:37:56 INFO - 'talos_options': ['--xperf_path', 14:37:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:37:56 INFO - 'tests': ['tp5n']}}, 14:37:56 INFO - 'talos.zip': {'path': '', 14:37:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:37:56 INFO - Running post-action listener: _resource_record_post_action 14:37:56 INFO - [mozharness: 2017-04-25 21:37:56.258380Z] Finished populate-webroot step (success) 14:37:56 INFO - [mozharness: 2017-04-25 21:37:56.258515Z] Running create-virtualenv step. 14:37:56 INFO - Running pre-action listener: _resource_record_pre_action 14:37:56 INFO - Running main action method: create_virtualenv 14:37:56 INFO - Creating virtualenv /builds/slave/test/build/venv 14:37:56 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 14:37:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:37:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:37:56 INFO - Using real prefix '/tools/python27' 14:37:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:37:57 INFO - Installing distribute.............................................................................................................................................................................................done. 14:37:59 INFO - Installing pip.................done. 14:37:59 INFO - Return code: 0 14:37:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:38:00 INFO - Reading from file tmpfile_stdout 14:38:00 INFO - Output received: 14:38:00 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) 14:38:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbdb4aa210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a84d30>, '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 0x1089aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a79be8>, '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.3iWJdLHBAz/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.jabGaalwWx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3iWJdLHBAz/Render', 14:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:00 INFO - 'HOME': '/Users/cltbld', 14:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:00 INFO - 'LOGNAME': 'cltbld', 14:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:00 INFO - 'MOZ_NO_REMOTE': '1', 14:38:00 INFO - 'NO_EM_RESTART': '1', 14:38:00 INFO - 'PAGER': '/bin/cat', 14:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:00 INFO - 'PWD': '/builds/slave/test', 14:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:00 INFO - 'SHELL': '/bin/bash', 14:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jabGaalwWx/Listeners', 14:38:00 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:00 INFO - 'USER': 'cltbld', 14:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:00 INFO - 'XPC_FLAGS': '0x0', 14:38:00 INFO - 'XPC_SERVICE_NAME': '0', 14:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:00 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 14:38:00 INFO - Cleaning up... 14:38:00 INFO - Return code: 0 14:38:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbdb4aa210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a84d30>, '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 0x1089aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a79be8>, '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.3iWJdLHBAz/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.jabGaalwWx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3iWJdLHBAz/Render', 14:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:00 INFO - 'HOME': '/Users/cltbld', 14:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:00 INFO - 'LOGNAME': 'cltbld', 14:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:00 INFO - 'MOZ_NO_REMOTE': '1', 14:38:00 INFO - 'NO_EM_RESTART': '1', 14:38:00 INFO - 'PAGER': '/bin/cat', 14:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:00 INFO - 'PWD': '/builds/slave/test', 14:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:00 INFO - 'SHELL': '/bin/bash', 14:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jabGaalwWx/Listeners', 14:38:00 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:00 INFO - 'USER': 'cltbld', 14:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:00 INFO - 'XPC_FLAGS': '0x0', 14:38:00 INFO - 'XPC_SERVICE_NAME': '0', 14:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:00 INFO - Downloading/unpacking psutil>=3.1.1 14:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:38:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:38:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:38:04 INFO - Installing collected packages: psutil 14:38:04 INFO - Running setup.py install for psutil 14:38:04 INFO - building 'psutil._psutil_osx' extension 14:38:04 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 14:38:04 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 14:38:04 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 14:38:05 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 14:38:05 INFO - building 'psutil._psutil_posix' extension 14:38:05 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 14:38:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:38:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:38:05 INFO - ^ 14:38:05 INFO - 1 warning generated. 14:38:05 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 14:38:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:38:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:38:05 INFO - Successfully installed psutil 14:38:05 INFO - Cleaning up... 14:38:05 INFO - Return code: 0 14:38:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:38:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbdb4aa210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a84d30>, '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 0x1089aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a79be8>, '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.3iWJdLHBAz/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.jabGaalwWx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:38:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:38:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3iWJdLHBAz/Render', 14:38:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:06 INFO - 'HOME': '/Users/cltbld', 14:38:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:06 INFO - 'LOGNAME': 'cltbld', 14:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:06 INFO - 'MOZ_NO_REMOTE': '1', 14:38:06 INFO - 'NO_EM_RESTART': '1', 14:38:06 INFO - 'PAGER': '/bin/cat', 14:38:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:06 INFO - 'PWD': '/builds/slave/test', 14:38:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:06 INFO - 'SHELL': '/bin/bash', 14:38:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jabGaalwWx/Listeners', 14:38:06 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:38:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:06 INFO - 'USER': 'cltbld', 14:38:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:06 INFO - 'XPC_FLAGS': '0x0', 14:38:06 INFO - 'XPC_SERVICE_NAME': '0', 14:38:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:38:06 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 14:38:06 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 14:38:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:06 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 14:38:06 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 14:38:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:38:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:38:09 INFO - Installing collected packages: mozsystemmonitor 14:38:09 INFO - Running setup.py install for mozsystemmonitor 14:38:09 INFO - Successfully installed mozsystemmonitor 14:38:09 INFO - Cleaning up... 14:38:10 INFO - Return code: 0 14:38:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbdb4aa210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a84d30>, '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 0x1089aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a79be8>, '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.3iWJdLHBAz/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.jabGaalwWx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:38:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3iWJdLHBAz/Render', 14:38:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:10 INFO - 'HOME': '/Users/cltbld', 14:38:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:10 INFO - 'LOGNAME': 'cltbld', 14:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:10 INFO - 'MOZ_NO_REMOTE': '1', 14:38:10 INFO - 'NO_EM_RESTART': '1', 14:38:10 INFO - 'PAGER': '/bin/cat', 14:38:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:10 INFO - 'PWD': '/builds/slave/test', 14:38:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:10 INFO - 'SHELL': '/bin/bash', 14:38:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jabGaalwWx/Listeners', 14:38:10 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:38:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:10 INFO - 'USER': 'cltbld', 14:38:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:10 INFO - 'XPC_FLAGS': '0x0', 14:38:10 INFO - 'XPC_SERVICE_NAME': '0', 14:38:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:10 INFO - Downloading/unpacking jsonschema==2.5.1 14:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:38:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:13 INFO - Downloading functools32-3.2.3-2.tar.gz 14:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:38:13 INFO - warning: no files found matching '*.txt' 14:38:13 INFO - no previously-included directories found matching 'build' 14:38:13 INFO - no previously-included directories found matching 'dist' 14:38:13 INFO - no previously-included directories found matching '.git*' 14:38:13 INFO - Installing collected packages: jsonschema, functools32 14:38:13 INFO - Running setup.py install for functools32 14:38:13 INFO - warning: no files found matching '*.txt' 14:38:13 INFO - no previously-included directories found matching 'build' 14:38:13 INFO - no previously-included directories found matching 'dist' 14:38:13 INFO - no previously-included directories found matching '.git*' 14:38:13 INFO - Successfully installed jsonschema functools32 14:38:13 INFO - Cleaning up... 14:38:13 INFO - Return code: 0 14:38:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbdb4aa210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a84d30>, '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 0x1089aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a79be8>, '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.3iWJdLHBAz/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.jabGaalwWx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:38:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3iWJdLHBAz/Render', 14:38:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:13 INFO - 'HOME': '/Users/cltbld', 14:38:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:13 INFO - 'LOGNAME': 'cltbld', 14:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:13 INFO - 'MOZ_NO_REMOTE': '1', 14:38:13 INFO - 'NO_EM_RESTART': '1', 14:38:13 INFO - 'PAGER': '/bin/cat', 14:38:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:13 INFO - 'PWD': '/builds/slave/test', 14:38:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:13 INFO - 'SHELL': '/bin/bash', 14:38:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jabGaalwWx/Listeners', 14:38:13 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:38:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:13 INFO - 'USER': 'cltbld', 14:38:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:13 INFO - 'XPC_FLAGS': '0x0', 14:38:13 INFO - 'XPC_SERVICE_NAME': '0', 14:38:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:38:14 INFO - Cleaning up... 14:38:14 INFO - Return code: 0 14:38:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbdb4aa210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a84d30>, '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 0x1089aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a79be8>, '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.3iWJdLHBAz/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.jabGaalwWx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:38:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3iWJdLHBAz/Render', 14:38:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:14 INFO - 'HOME': '/Users/cltbld', 14:38:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:14 INFO - 'LOGNAME': 'cltbld', 14:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:14 INFO - 'MOZ_NO_REMOTE': '1', 14:38:14 INFO - 'NO_EM_RESTART': '1', 14:38:14 INFO - 'PAGER': '/bin/cat', 14:38:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:14 INFO - 'PWD': '/builds/slave/test', 14:38:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:14 INFO - 'SHELL': '/bin/bash', 14:38:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jabGaalwWx/Listeners', 14:38:14 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:38:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:14 INFO - 'USER': 'cltbld', 14:38:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:14 INFO - 'XPC_FLAGS': '0x0', 14:38:14 INFO - 'XPC_SERVICE_NAME': '0', 14:38:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:14 INFO - Downloading/unpacking blobuploader==1.2.4 14:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:38:16 INFO - Downloading blobuploader-1.2.4.tar.gz 14:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:38:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:38:17 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 14:38:17 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 14:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:17 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 14:38:17 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 14:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:38:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:38:17 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 14:38:17 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 14:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:17 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 14:38:17 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 14:38:18 INFO - Downloading docopt-0.6.1.tar.gz 14:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:38:18 INFO - Installing collected packages: blobuploader, requests, docopt 14:38:18 INFO - Running setup.py install for blobuploader 14:38:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:38:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:38:18 INFO - Running setup.py install for requests 14:38:18 INFO - Running setup.py install for docopt 14:38:19 INFO - Successfully installed blobuploader requests docopt 14:38:19 INFO - Cleaning up... 14:38:19 INFO - Return code: 0 14:38:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbdb4aa210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a84d30>, '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 0x1089aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a79be8>, '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.3iWJdLHBAz/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.jabGaalwWx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:38:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:38:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:38:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3iWJdLHBAz/Render', 14:38:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:19 INFO - 'HOME': '/Users/cltbld', 14:38:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:19 INFO - 'LOGNAME': 'cltbld', 14:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:19 INFO - 'MOZ_NO_REMOTE': '1', 14:38:19 INFO - 'NO_EM_RESTART': '1', 14:38:19 INFO - 'PAGER': '/bin/cat', 14:38:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:19 INFO - 'PWD': '/builds/slave/test', 14:38:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:19 INFO - 'SHELL': '/bin/bash', 14:38:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jabGaalwWx/Listeners', 14:38:19 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:38:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:19 INFO - 'USER': 'cltbld', 14:38:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:19 INFO - 'XPC_FLAGS': '0x0', 14:38:19 INFO - 'XPC_SERVICE_NAME': '0', 14:38:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:38:19 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-HB1ZlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:38:19 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Hn0_rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:38:19 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-sK8gVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:38:19 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-yS828y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:38:19 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-RThYo_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:38:19 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-JD0YiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:38:19 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-wG1Ugo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:38:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-QRBqfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:38:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-VtbVE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:38:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-szsFFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:38:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-XOgnM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:38:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-GSICOz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:38:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-XwXk9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:38:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-izV5LA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-PXzQbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:38:20 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-69w8W2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:38:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-n8cdCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:38:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:38:21 INFO - Running setup.py install for manifestparser 14:38:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:38:21 INFO - Running setup.py install for mozcrash 14:38:21 INFO - Running setup.py install for mozdebug 14:38:21 INFO - Running setup.py install for mozdevice 14:38:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:38:21 INFO - Running setup.py install for mozfile 14:38:21 INFO - Running setup.py install for mozhttpd 14:38:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:38:21 INFO - Running setup.py install for mozinfo 14:38:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:38:22 INFO - Running setup.py install for mozInstall 14:38:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:38:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:38:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:38:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:38:22 INFO - Running setup.py install for mozleak 14:38:22 INFO - Running setup.py install for mozlog 14:38:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:38:22 INFO - Running setup.py install for moznetwork 14:38:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:38:22 INFO - Running setup.py install for mozprocess 14:38:22 INFO - Running setup.py install for mozprofile 14:38:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:38:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:38:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:38:23 INFO - Running setup.py install for mozrunner 14:38:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:38:23 INFO - Running setup.py install for mozscreenshot 14:38:23 INFO - Running setup.py install for moztest 14:38:23 INFO - Running setup.py install for mozversion 14:38:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:38:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:38:23 INFO - Cleaning up... 14:38:23 INFO - Return code: 0 14:38:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbdb4aa210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a84d30>, '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 0x1089aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a79be8>, '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.3iWJdLHBAz/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.jabGaalwWx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:38:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:38:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:38:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3iWJdLHBAz/Render', 14:38:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:23 INFO - 'HOME': '/Users/cltbld', 14:38:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:23 INFO - 'LOGNAME': 'cltbld', 14:38:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:23 INFO - 'MOZ_NO_REMOTE': '1', 14:38:23 INFO - 'NO_EM_RESTART': '1', 14:38:23 INFO - 'PAGER': '/bin/cat', 14:38:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:23 INFO - 'PWD': '/builds/slave/test', 14:38:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:23 INFO - 'SHELL': '/bin/bash', 14:38:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jabGaalwWx/Listeners', 14:38:23 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:38:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:23 INFO - 'USER': 'cltbld', 14:38:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:23 INFO - 'XPC_FLAGS': '0x0', 14:38:23 INFO - 'XPC_SERVICE_NAME': '0', 14:38:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:38:23 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-aPJS3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:38:24 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)) 14:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:38:24 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-d78Wnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:38:24 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)) 14:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:38:24 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-lMBMeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:38:24 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)) 14:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:38:24 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-R6A7Q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:38:24 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)) 14:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:38:24 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-WK4mog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:38:24 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)) 14:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:38:24 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-n4aVba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:38:24 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)) 14:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:38:24 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-1GSK60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:38:24 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)) 14:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:38:24 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-nZDebd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:38:24 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)) 14:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:38:24 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-OPuVtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:38:24 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)) 14:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:38:24 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-HruAU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:38:24 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)) 14:38:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:38:24 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-zrPkx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:38:25 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)) 14:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:38:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-MQKCp6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:38:25 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)) 14:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:38:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-odHH5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:38:25 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)) 14:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:38:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-My7jGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:38:25 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)) 14:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-MVzzxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:38:25 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)) 14:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:38:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ENDcgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:38:25 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)) 14:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:38:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-JrVYvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:38:25 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)) 14:38:25 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)) 14:38:25 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)) 14:38:25 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)) 14:38:25 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)) 14:38:25 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)) 14:38:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:38:25 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 14:38:25 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 14:38:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:38:25 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 14:38:25 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 14:38:28 INFO - Downloading blessings-1.6.tar.gz 14:38:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:38:28 INFO - Installing collected packages: blessings 14:38:28 INFO - Running setup.py install for blessings 14:38:28 INFO - Successfully installed blessings 14:38:28 INFO - Cleaning up... 14:38:28 INFO - Return code: 0 14:38:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:38:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:38:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:38:29 INFO - Reading from file tmpfile_stdout 14:38:29 INFO - Current package versions: 14:38:29 INFO - blessings == 1.6 14:38:29 INFO - blobuploader == 1.2.4 14:38:29 INFO - docopt == 0.6.1 14:38:29 INFO - functools32 == 3.2.3-2 14:38:29 INFO - jsonschema == 2.5.1 14:38:29 INFO - manifestparser == 1.1 14:38:29 INFO - mozInstall == 1.12 14:38:29 INFO - mozcrash == 1.0 14:38:29 INFO - mozdebug == 0.1 14:38:29 INFO - mozdevice == 0.50 14:38:29 INFO - mozfile == 1.2 14:38:29 INFO - mozhttpd == 0.7 14:38:29 INFO - mozinfo == 0.9 14:38:29 INFO - mozleak == 0.1 14:38:29 INFO - mozlog == 3.4 14:38:29 INFO - moznetwork == 0.27 14:38:29 INFO - mozprocess == 0.25 14:38:29 INFO - mozprofile == 0.28 14:38:29 INFO - mozrunner == 6.13 14:38:29 INFO - mozscreenshot == 0.1 14:38:29 INFO - mozsystemmonitor == 0.3 14:38:29 INFO - moztest == 0.8 14:38:29 INFO - mozversion == 1.4 14:38:29 INFO - psutil == 3.1.1 14:38:29 INFO - requests == 1.2.3 14:38:29 INFO - wsgiref == 0.1.2 14:38:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbdb4aa210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a84d30>, '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 0x1089aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a79be8>, '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.3iWJdLHBAz/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.jabGaalwWx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:38:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3iWJdLHBAz/Render', 14:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:29 INFO - 'HOME': '/Users/cltbld', 14:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:29 INFO - 'LOGNAME': 'cltbld', 14:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:29 INFO - 'MOZ_NO_REMOTE': '1', 14:38:29 INFO - 'NO_EM_RESTART': '1', 14:38:29 INFO - 'PAGER': '/bin/cat', 14:38:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:29 INFO - 'PWD': '/builds/slave/test', 14:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:29 INFO - 'SHELL': '/bin/bash', 14:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jabGaalwWx/Listeners', 14:38:29 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:29 INFO - 'USER': 'cltbld', 14:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:29 INFO - 'XPC_FLAGS': '0x0', 14:38:29 INFO - 'XPC_SERVICE_NAME': '0', 14:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:29 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)) 14:38:29 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)) 14:38:29 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)) 14:38:29 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)) 14:38:29 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)) 14:38:29 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)) 14:38:29 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)) 14:38:29 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)) 14:38:29 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)) 14:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:38:29 INFO - Cleaning up... 14:38:29 INFO - Return code: 0 14:38:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:38:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108ca6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108ca9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbbdb4aa210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108a84d30>, '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 0x1089aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a79be8>, '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.3iWJdLHBAz/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.jabGaalwWx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:38:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:38:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3iWJdLHBAz/Render', 14:38:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:29 INFO - 'HOME': '/Users/cltbld', 14:38:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:29 INFO - 'LOGNAME': 'cltbld', 14:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:29 INFO - 'MOZ_NO_REMOTE': '1', 14:38:29 INFO - 'NO_EM_RESTART': '1', 14:38:29 INFO - 'PAGER': '/bin/cat', 14:38:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:29 INFO - 'PWD': '/builds/slave/test', 14:38:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:29 INFO - 'SHELL': '/bin/bash', 14:38:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jabGaalwWx/Listeners', 14:38:29 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:38:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:29 INFO - 'USER': 'cltbld', 14:38:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:29 INFO - 'XPC_FLAGS': '0x0', 14:38:29 INFO - 'XPC_SERVICE_NAME': '0', 14:38:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:38:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:38:29 INFO - Cleaning up... 14:38:29 INFO - Return code: 0 14:38:29 INFO - Running post-action listener: _resource_record_post_action 14:38:29 INFO - Running post-action listener: _start_resource_monitoring 14:38:29 INFO - Starting resource monitoring. 14:38:29 INFO - [mozharness: 2017-04-25 21:38:29.626462Z] Finished create-virtualenv step (success) 14:38:29 INFO - [mozharness: 2017-04-25 21:38:29.627406Z] Running install step. 14:38:29 INFO - Running pre-action listener: _resource_record_pre_action 14:38:29 INFO - Running main action method: install 14:38:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:38:29 INFO - Reading from file tmpfile_stdout 14:38:29 INFO - Detecting whether we're running mozinstall >=1.0... 14:38:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:38:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:38:29 INFO - Reading from file tmpfile_stdout 14:38:29 INFO - Output received: 14:38:29 INFO - Usage: mozinstall [options] installer 14:38:29 INFO - Options: 14:38:29 INFO - -h, --help show this help message and exit 14:38:29 INFO - -d DEST, --destination=DEST 14:38:29 INFO - Directory to install application into. [default: 14:38:29 INFO - "/builds/slave/test"] 14:38:29 INFO - --app=APP Application being installed. [default: firefox] 14:38:29 INFO - mkdir: /builds/slave/test/build/application 14:38:29 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'] 14:38:29 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 14:38:49 INFO - Reading from file tmpfile_stdout 14:38:49 INFO - Output received: 14:38:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:38:49 INFO - Running post-action listener: _resource_record_post_action 14:38:49 INFO - [mozharness: 2017-04-25 21:38:49.770280Z] Finished install step (success) 14:38:49 INFO - [mozharness: 2017-04-25 21:38:49.770418Z] Running run-tests step. 14:38:49 INFO - Running pre-action listener: _resource_record_pre_action 14:38:49 INFO - Running main action method: run_tests 14:38:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:38:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:38:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:38:49 INFO - 2017-04-25 14:38:49.784 screenresolution[1627:7411] starting screenresolution argv=screenresolution get 14:38:49 INFO - 2017-04-25 14:38:49.787 screenresolution[1627:7411] Display 0: 1600x1200x32@60 14:38:49 INFO - 2017-04-25 14:38:49.793 screenresolution[1628:7413] starting screenresolution argv=screenresolution list 14:38:49 INFO - Available Modes on Display 0 14:38:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:38:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:38:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:38:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:38:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:38:50 INFO - Intel Iris: 14:38:50 INFO - Chipset Model: Intel Iris 14:38:50 INFO - Type: GPU 14:38:50 INFO - Bus: Built-In 14:38:50 INFO - VRAM (Dynamic, Max): 1536 MB 14:38:50 INFO - Vendor: Intel (0x8086) 14:38:50 INFO - Device ID: 0x0a2e 14:38:50 INFO - Revision ID: 0x0009 14:38:50 INFO - Displays: 14:38:50 INFO - Display: 14:38:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:38:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:38:50 INFO - Display Serial Number: 1600x1200 60 14:38:50 INFO - Main Display: Yes 14:38:50 INFO - Mirror: Off 14:38:50 INFO - Online: Yes 14:38:50 INFO - Rotation: Supported 14:38:50 INFO - Return code: 0 14:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:38:50 INFO - Python 2.7.3 14:38:50 INFO - Return code: 0 14:38:50 INFO - grabbing minidump binary from tooltool 14:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:50 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 0x108a84d30>, '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 0x1089aadb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108a79be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:38:50 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 14:38:50 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 14:38:50 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 14:38:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:38:50 INFO - Return code: 0 14:38:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:38:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:38:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:38:50 INFO - ENV: RUST_BACKTRACE is now 1 14:38:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:38:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3iWJdLHBAz/Render', 14:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:38:50 INFO - 'HOME': '/Users/cltbld', 14:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:38:50 INFO - 'LOGNAME': 'cltbld', 14:38:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:38:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:38:50 INFO - 'MOZ_NO_REMOTE': '1', 14:38:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:38:50 INFO - 'NO_EM_RESTART': '1', 14:38:50 INFO - 'PAGER': '/bin/cat', 14:38:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:38:50 INFO - 'PWD': '/builds/slave/test', 14:38:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:38:50 INFO - 'RUST_BACKTRACE': '1', 14:38:50 INFO - 'SHELL': '/bin/bash', 14:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jabGaalwWx/Listeners', 14:38:50 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:38:50 INFO - 'USER': 'cltbld', 14:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:38:50 INFO - 'XPC_FLAGS': '0x0', 14:38:50 INFO - 'XPC_SERVICE_NAME': '0', 14:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:38:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:38:50 INFO - mozversion application_buildid: 20170425130325 14:38:50 INFO - mozversion application_changeset: 10ecc167ef4af98ab2659d20ec799eb765165cfd 14:38:50 INFO - mozversion application_display_name: Nightly 14:38:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:38:50 INFO - mozversion application_name: Firefox 14:38:50 INFO - mozversion application_remotingname: firefox 14:38:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:38:50 INFO - mozversion application_vendor: Mozilla 14:38:50 INFO - mozversion application_version: 55.0a1 14:38:50 INFO - mozversion platform_buildid: 20170425130325 14:38:50 INFO - mozversion platform_changeset: 10ecc167ef4af98ab2659d20ec799eb765165cfd 14:38:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:38:50 INFO - mozversion platform_version: 55.0a1 14:38:50 INFO - using testdate: 1493156330 14:38:50 INFO - actual date: 1493156330 14:38:50 INFO - starting webserver on 'localhost:49240' 14:38:50 INFO - SUITE-START | Running 2 tests 14:38:50 INFO - TEST-START | dromaeo_css 14:38:50 INFO - operating with platform_type : mac_ 14:38:50 INFO - Initialising browser for dromaeo_css test... 14:38:50 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpI9k7QV/profile http://localhost:49240/getInfo.html) 14:38:53 INFO - PID 1638 | 2017-04-25 14:38:53.355 plugin-container[1640:7588] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x973f, name = 'com.apple.tsm.portname' 14:38:53 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:38:53 INFO - PID 1638 | 2017-04-25 14:38:53.358 plugin-container[1640:7588] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9c0b, name = 'com.apple.CFPasteboardClient' 14:38:53 INFO - PID 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:38:53 INFO - PID 1638 | 2017-04-25 14:38:53.358 plugin-container[1640:7588] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:38:53 INFO - PID 1638 | __metrics Screen width/height:1600/1200 14:38:53 INFO - PID 1638 | colorDepth:24 14:38:53 INFO - PID 1638 | Browser inner width/height: 1024/689 14:38:53 INFO - PID 1638 | __metrics 14:38:53 ERROR - PID 1638 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3414: TypeError: this.tabs is undefined 14:38:54 INFO - TEST-INFO | 1638: exit 0 14:38:54 INFO - Browser initialized. 14:38:54 INFO - Running cycle 1/1 for dromaeo_css test... 14:38:54 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpI9k7QV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:38:56 INFO - PID 1641 | 2017-04-25 14:38:56.676 plugin-container[1642:7731] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 14:38:56 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:38:56 INFO - PID 1641 | 2017-04-25 14:38:56.676 plugin-container[1642:7731] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x961f, name = 'com.apple.CFPasteboardClient' 14:38:56 INFO - PID 1641 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:38:56 INFO - PID 1641 | 2017-04-25 14:38:56.676 plugin-container[1642:7731] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:39:06 INFO - PID 1641 | RSS: Main: 236003328 14:39:06 INFO - PID 1641 | 14:42:09 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 14:42:11 INFO - PID 1641 | RSS: Main: 257044480 14:42:11 INFO - PID 1641 | 14:43:54 INFO - PID 1641 | ************************* 14:43:54 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 14:43:54 INFO - PID 1641 | 14:43:54 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:43:54 INFO - PID 1641 | Full stack: 14:43:54 INFO - PID 1641 | ************************* 14:43:54 INFO - PID 1641 | ************************* 14:43:54 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 14:43:54 INFO - PID 1641 | 14:43:54 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:43:54 INFO - PID 1641 | Full stack: 14:43:54 INFO - PID 1641 | ************************* 14:43:54 INFO - PID 1641 | ************************* 14:43:54 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 14:43:54 INFO - PID 1641 | 14:43:54 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:43:54 INFO - PID 1641 | Full stack: 14:43:54 INFO - PID 1641 | ************************* 14:43:54 INFO - PID 1641 | ************************* 14:43:54 INFO - PID 1641 | A coding exception was thrown and uncaught in a Task. 14:43:54 INFO - PID 1641 | 14:43:54 ERROR - PID 1641 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:43:54 INFO - PID 1641 | Full stack: 14:43:54 INFO - PID 1641 | ************************* 14:45:13 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 14:45:14 INFO - PID 1641 | RSS: Main: 260239360 14:45:14 INFO - PID 1641 | 14:48:15 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 14:48:16 INFO - PID 1641 | RSS: Main: 269881344 14:48:16 INFO - PID 1641 | 14:51:18 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 14:51:18 INFO - PID 1641 | RSS: Main: 262696960 14:51:18 INFO - PID 1641 | 14:54:21 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 14:54:22 INFO - PID 1641 | RSS: Main: 271286272 14:54:22 INFO - PID 1641 | 14:57:24 INFO - PID 1641 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 14:57:24 INFO - PID 1641 | RSS: Main: 266510336 14:57:24 INFO - PID 1641 | 14:57:24 INFO - PID 1641 | __start_tp_report 14:57:24 INFO - PID 1641 | _x_x_mozilla_page_load 14:57:24 INFO - PID 1641 | _x_x_mozilla_page_load_details 14:57:24 INFO - PID 1641 | |i|pagename|runs| 14:57:24 INFO - PID 1641 | |0;dojo.html;2970.183199620104;3562.412201986671;3583.3370826397136;3603.405438102713;3608.6932610728086;5455.91816122758;5976.581639285241;5999.610025348349;6207.162033125526;6220.875582488353;5130.153524668425;6108.4634918426245;6117.2965109012475;6133.01871700528;6155.507559395249;4658.673892827495;5343.812966546172;5344.4922732340365;5349.7057661828585;5422.213779002042;4424.734515929038;5349.090654588729;5397.973010134944;5441.619086663935;5478.178273259023;5256.710880901549;5327.147656374961;5363.570914326844;5390.838274851761;5426.023315803154;5362.839114826562;5369.570434365241;5380.811671591476;5439.728013599344;5495.972520137414;5331.653442526263;5333.919991200135;5344.385395679507;5348.91976620351;5368.812091576815;5112.437631860493;5898.8230353089475;6022.45797878193;6028.909566356509;6103.755849766048;6282.308946015934;6507.186601674791;6587.50593705474;6596.175478065242;6597.86804263912;6661.200655921272;6668.466522678174;6683.4987375947;6695.129633147709;6695.430888374494;6297.842553936188;6313.715882785285;6318.524811353829;6319.462845658125;6341.8097457076365;6510.316416776265;6604;6715.932840671629;6757;6790.660466976631;6243.375662433811;6307.590006649553;6408.423241908251;6450.838729031718;6547.836304092436;5392.67879369557;6215.34738852423;6460.967695161588;6607.273199948002;6718.395344418928;6578.967105164539;6584.86830263392;6602.141721576164;6606.207255129415;6608.504362172856;6254.937450625526;6283.905741413882;6307.495400368051;6438.3883531064475;6582.572132811352;5203.27154198405;5224.190250511177;5263.157894736901;5269.341332333458;5272.130098533776;4679.9298010529865;4685.461171965199;4707.7175369477945;4710.222813235846;4726.054789042205;6148.616561273767;6328.303886572473;6332.715027823759;6352.523560732963;6372.585781924253;6300.7998887802105;6476.060971159155;6626.171728533934;6665.400113989765;6694.263631000586;6319.8104056878365;6339;6358.1734374531015;6365.681715914186;6372.299047104908;5810.0994345875615;5817.301923769175;5823.5341172706085;5826.563007774434;5850.268716410449;6132.44807967294;6236.158118653923;6690.732370705312;6788.490863185182;6844.828879278058;6717.261101278953;6722.1261236039;6751.257361690112;6767.763128290486;6793.048973143863;6802.285759995327;6905.240423553506;6913.93086069153;6926.653667316513;6938.965305173442;5515.972420137874;6289.7484100635465;6339.270983836917;6401.29585745577;6433.967830160819;5618.129189975561;6678.83302917431;6717.496187785838;6733.091032710718;6748.257691654012;6339;6351.98368261076;6506.186726659168;6506.967465162644;6644.7009884554345;6242.812715618538;6383.170187875547;6441.3880681335195;6443;6493.318201588765;5429;5918.934591773522;6195.938040619716;6326.588771729823;6338.080978258219;6471.676416179266;6509.674516274262;6513.967430163008;6516.120323756422;6517;5145.305383773143;6245.156903818108;6255.843603909939;6275.058741188858;6277.2153480814895 14:57:24 INFO - PID 1641 | |1;ext.html;732.2384719891313;799.7320897499337;820.8440396324696;1052.5000624703266;1094.1137678480436;35311.82344088279;36234.45648315271;36385.272294554095;36396;36399;38607.22785544288;38810;38919.610803891956;39059.0235244119;39092;7203.783886483414;8435.620397082115;8542.10307917669;8554.35842311826;8724.214820666139;7451.329380355767;8590.140985901422;8635.309175265964;8739.4756314621;8748.956255218714;8676;8740.257078148365;8754.6935857245;8756.737297881074;8780.736577902673;8691.869621955675;8727.301815854717;8738.519381434018;8746.300295976307;8758;8466.619002144918;8492.490450572985;8522.531260780655;8537.829243415097;8553.615087321086;37810.43284350737;37827.621723782686;37835.81082094572;37852;37914.24171516554;3109.8445077746023;3594.964050359489;3638.7998660073686;3645.54430696163;3650.3611867923273;30890.536641950388;30925.381492370252;30948.845255773802;30962;30964.0710778677;3158.526221066835;3189.282411457427;3194.073718621597;3194.648588655246;3196.8081915085168;181588.18411815845;244322;250388;274266.999999998;294928;47478.52521474741;47540.14759114464;47570.76214618974;47706.04587908222;47779.76110119497;49159;49322.260166097534;49414.764630884514;49440.50559494359;49682;13781.104228225133;13861.930690346484;13977.3710183042;13993.16041037541;13999.300034998412;11332.6033588824;11369.2609980351;11377.65867023974;11415.885841141648;11421.37182454973;13190.802137967938;13296;13302.800457993138;13316;13419.329033548283;5788.0739081746715;5831.387704290988;5846.649201047866;5857.47282744555;5863.061910094364;856.2037305306125;918;926.7277849115571;958.3722661656626;991.2615101749243;19485.805141948684;24124.758752412603;24151.516969660508;24493.87753061259;24528.264152075466;1079.4279032112993;1097.3375336365414;1108.8059589571792;1108.844761733358;1120.327803318019;12048.518059277707;12371;12544.121911466109;16133.838661613469;16346.264418101215;293783.06216937985;298189;327196;327317;328262.358688205;55331.72334138303;55591.55267578584;55679;55725.72137139289;55791;1463.370750577262;1467.325030485967;1503.5339044896118;1503.676709507461;1509.562226954171;29142.97999570005;29426.852865735535;29784.404311914073;30090.69909300879;30183.641736122365;35975.820120899225;36019.639803601625;36146.63853361433;36203.81898090493;36312.63687363092;293705.59441607964;295059;295632;296091;296543;27815.887364505194;28215.43569128565;32079.67920320767;32863.014109576754;33636.66363336335;41467.7926610365;42023.15953680848;42126.7893660542;42570.510032148726;42603.7869810649;29293.560596591495;29650.258743531584;29661;29685.406291874475;29980.85009574938;25318.49363012766;30606.846965765028;30750.384992300475;31494.37011259716;31711.682883170874;33686;34337.828310858284;37364.813175933945;37704.81147594244;37929;27971.720282796912;30973;31316.53025204578;31383;31474.842625786725;24272.936800372165;24311.392215194763;24459.633105503075;24736.50526989414;24916.252512424657 14:57:24 INFO - PID 1641 | |2;jquery.html;433.87200775771146;441.2476727180158;442.0121029499069;456.8720758187708;459.84365315792644;16317.592060198502;21144.25995090172;21855.781442185573;21982.560348793013;22118;21722.456938576543;21744.8912755436;21801.345959621238;21864.45338866529;22290.219842305523;4803.687760295578;5170.715610641413;5984.5511586630955;6045.486133678643;6046.365131661179;5702.914456283159;5849.502792262641;5879.2063071485445;5920.88158236835;5945.583809133363;5852.67810270435;5900.409959004108;5920.5559583031445;5929.614575052629;5930.703464826742;5829.125631155318;6060.909086363708;6103.084537319393;6103.450689437972;6113.174721412642;5323.813666521692;5363.839084827422;5403.621746477748;5418.376886658046;5458.781648734046;26066.73933260662;26521.602175967375;26665;26721.06476273321;26960.191194264204;1863.9561845366638;2050.641137800894;2120.067170444999;2126.9361919142452;2127.053461209762;17067.743983840253;17196.828031719648;17606.47180584572;17714.645707085914;17869.642607147784;1920.9615807683908;2067.6174907641985;2078.3453212238096;2167.981048907027;2206.3711842125076;147285.52714472826;164035.53946690809;165019;167004;168161;11126.109911207084;12074.973627241783;12395.653173643066;12650.367481625883;12720.427580758887;16324.265408056666;16342;16359;16367.345306187619;16380.590485237964;7513.549187048685;8597.226249637562;8933.687320943736;8935.553222338856;9058.592363343665;8321.791955201168;8405.495670259805;8471.788205294793;8593.742187734379;8610.612522436506;6631.469482441393;6804.421624161902;7752.457327987099;7850.725224617111;7902.68087403292;2139.550694354172;2147.8389120816;2148.688440176166;2151.107290474467;2304.7580004099664;862.3920136303891;932.9813403731887;952.7808604021114;968.5109019944882;986.4673076538733;20338.796612033988;20975.370738877857;20993.16027358919;21015.369538913856;21257.941486676533;921.8384835107812;997.8802543694803;1022.5551884930079;1024.3853687787268;1026.984595231072;10601.734956626146;10630.574777008833;10765.784684306427;10823.188260880466;10823.783524329627;463235;543827;555238;562169.1891540516;567314;129941.35029324793;130223.34888325498;134194.32902835423;135953;136740.31629841786;1204.5302332090491;1233.3155098920186;1235.765204611121;1255.8430196225472;1256.5727652598162;16292.592685182964;17133.485995419658;17708;18085.90957045259;18102.637947241245;55231;55276;55670;55808.72095639496;56546.15180772374;77273.61363193148;78514;79116.60441697754;79311.60344198241;82451;7688;8581.098984606777;8658.354912566592;8724.56377181151;8833.381663283508;11503.884961150616;13270.933645331712;13485.190888546718;13556.661083472993;13618.93190534041;9700.23342275408;11835.171537992257;11937.164398492023;11978.64064078079;12004.819927701266;10935.234533582572;11034.282771619819;11040;11362.829557556477;11381.260218085798;11915.2255103418;12053.939730301292;12081.093917956365;12163.749706304008;12180.390980451119;8722.040575536812;8869.157430044135;8899.599518021576;8907.287417006753;8957.372983891066;11722;11769.293842369485;12031.097667674785;12123.969462595778;12127.81808272859 14:57:24 INFO - PID 1641 | |3;mootools.html;1265.2598230035428;1303.7913933770596;1406.9366878490466;1447.9864095133403;1459.6423876150345;11649.999999999989;11816.763664726712;11826.467808948597;12047.975922046637;12148.574799882006;11816.7636647267;11837.881621183808;12011.879881201185;12048.21686590371;12105.21316114452;2518.949621007583;2577.329894227505;2577.6004719268544;2579.703334116582;2581.4966081614093;2053.8048885355943;2181.520065585569;2543.2370288913344;2545.3891066144083;2547.885345159463;2268.421552504109;2495.3137887081016;2518.672572565573;2546.31249562618;2550.298667866333;2472.295395812194;2491.2526242127287;2522.7225005249593;2522.7729504344516;2530.278870521902;2426.623873299641;2505.185814610259;2512.2839990602774;2516.9370765731005;2549.2861998640224;11848.17062805604;11947.283163010161;11958.940205299004;11968.940155299168;11971.162018658697;6584.670766461658;6816.352446517622;6853.040574319599;6854.10896583441;6857.314268573103;4020.8994775130564;4369.12617476506;4403.669724770655;4414.602685758297;4466.0398014427055;1129.7514546799691;1257.9622611321674;1280.6030130659526;1311.3084121483275;1326.4097476622906;16271.593210169722;16624.168791560372;16736.581585460463;16748.665026699397;16833.91583042089;5550.27846379968;5625.156226565966;5653.632513886584;5750.511206547407;5810.244668193192;11776.58781942645;11870.88129118715;11929.522819087313;11957.162998590014;11987.940060299643;6521.543491955613;6601.108850305147;6623.701933413008;6633.900491492632;6640.601563906181;6009.06859436788;6189.164462797555;6224.315325314212;6281.2462504498835;6289.779857704958;4196.139791342767;4378.599507494947;4401.6698747594055;4406.074724307867;4441.511433742286;1262.1795832708813;1289.0589869395394;1296.494367196794;1308.3719814489098;1312.08154291996;775.4610545670705;798.9560574168477;805.7083395272758;806.2864365036867;821.080389963245;5921.970390148108;6103.816885493442;6198.6280823149855;6225.315215326311;6336.714847831859;495.51687105072267;518.5359103602254;585.9619124756878;605.8519106293548;612.1552257884091;3588.928221435609;3812.618738126165;3896.805159742058;3916.686665066788;4417.668674849399;14551.85448145505;15334.769978450333;15344;15365.769513457308;15382.000169988914;14331.498397556245;14798;14846.777298340534;14917.030393024419;15168.393264269305;8342.16578342161;8366.790830229414;8504.31965442763;8612.78468038304;8639.827203455896;6773.627450490073;6831.419329356861;6960.512764106464;7040.401565866959;7145;10866.782664346827;11736.767639398082;13293.867061329649;13641.386137623633;13667.589972300846;12650.493980240688;13509.932450337685;13671.521496747964;13959.930200348934;14098.788518172441;10562.102221310966;10819.729506762395;10957.671269861918;10979.28634638746;10984.670459886216;10881;10934.398608076313;11014.669559913216;11106.055985241344;11110.777814440567;9160.038195989591;9162.954185229031;9180.127887850644;9228.492432915986;9244.121808428188;8705.434146780439;8822.867656985021;8925.866112008196;8940.955295223483;9064.818703626022;8151;8331.0002799662;8332.083470818085;8338.332933365195;8344.666213351398;5237.869053273546;5998.790042348497;6010.819675409744;6066.605670631395;6148.16999705052;6045.727942242697;6062.666553339609;6131.693415329127;6208.9689551551955;6348.206474190726 14:57:24 INFO - PID 1641 | |4;prototype.html;388.28749245135174;411.41373542701655;415.0640306109722;416.4648426771597;416.77494153157295;4889.315495830582;5387.730613469321;5402.405735369106;5732.713364331782;6265.530085243602;6063.6058656187315;6156.4766994805495;6170.598911070777;6170.876582468348;6184.257889053309;3848.672862806665;3996.220736956295;4184.267753143203;4459.620932220765;4472.821087156518;4224.5353011168745;4421.491528474235;4466.5483717791685;4472.53038430965;4491.146682130385;3802.429635554661;4360.149770794696;4374.300111982084;4381.6635926042545;4405.251107311765;3656.0859785053735;4376.715513491628;4403.339499075132;4413.845515406945;4474;3593.964060359389;3783.9054023649355;3799.8670046548236;3801.657850793414;3807.7715337079585;5617.9719101404235;5838.299404071538;5869.80095847764;5963.344032156459;5968.418369132183;4324.994129080291;4599.172149013176;5238.214267859814;5268.894622107575;5282.313299271109;5459.3994660587305;5770.249867517238;5969.224000879901;6168.96915515424;6573.572717773377;4290.613844753987;4299.849505267301;4299.97850010748;4301.763403012833;4302.849400270976;6657.167854018247;6847.589144651337;6893.517453778238;6914.412274956635;6941.271166527493;3329.5172200031343;4324.956750432519;4329.19909816685;4390.143921935192;4416.823327066945;3872.980635096863;4415;4424;4425.601695847389;4449.443819522559;5123.333966584395;5214.243934629533;5259.526642602184;5275.920861187085;5279.973600132052;6589.76935807254;6590.242122155918;6599.142111525567;6600.966995165089;6615.213892249066;1270.4854533913779;1491.5010414533542;1499.5951093204774;1502.1738044075714;1507.1785876697227;856.3277826905849;903.746950853762;969.6654654144309;976.9267304952157;982.5627595719836;5132.640715149903;6129;6185.8144255672405;6219.47134493564;6244.594101383486;6237.563370564108;6557.344265573404;6811.829704257433;6818;6890.276520965327;6110.388961103854;6212.254529456494;6219.1342597220655;6219.19643303446;6276.874462510816;3020.969790302113;3288.753343499247;3475.878344257939;3562.1628917204434;3583.2475180211927;6496.220453545605;6753.831154221184;7013.614251216232;7017.193022802341;7063.092964899449;5999.280086389661;6376.7130479128555;6828.7609933653075;7016.403605693573;7037.894431583531;5870.534375562274;6691.531592788556;7039.894401583878;7044.859102818017;7049.836776931851;5656.943430565641;6549.214094308713;6763;6813.8637227254185;6832.487563432862;5657.43425657431;6305.243370795534;6424.325445828307;6676.265610782907;6680.231773345933;6923.169219693669;7042.260562640849;7051.330123638246;7058.752943646948;7077;4339.956600434081;4344.695871288979;4345.804438800198;4354.869353919387;4356.150550642595;5599.356074051373;6406.84676758188;6812.523123381316;6893.586384816927;6911.827204319932;5785.8553536161935;5961.672108034099;6332.915269651141;6628.767993120217;6652.83367915806;6360.395762402564;6544;6593.099036423958;6632.900506492503;6637.601743895381;5085.5931525477135;5327.04584736199;5402.486763757437;6420.7158568285595;6475.417212450902;6176.289726681489;6313;6607.504437167136;6626.602403855784;6630.668466576555;6309.255473868881;6339.524535659752;6455.644939528183;6462.4183823456115;6464.159659244268 14:57:24 INFO - PID 1641 | |5;yui.html;679;704.9612271325075;826.5743142281726;836.6193382011186;841.6591280531383;16584.502464926056;16982.91508542457;16992.830071699263;18528.44414667559;19089.427317180507;17657.293708251687;17848;18019;18105.09474526272;18202;902.0888902208784;918.8422587539682;940.5485367023832;942.7077605942145;962.1533050915219;893.8480458322068;922.7047344849651;971.3055165556625;974.28390133252;976.6581696406237;988.7874107066979;1009.2834087797672;1012.2054187462843;1012.817692815293;1018.0176130034515;1003.9247056470757;1009.8737657792776;1010.4240582867768;1013.771901322204;1017.3133135133792;714.1572943926164;734.5445823589355;738.5937734246144;746.1903834339748;750.2010358967682;13976.860231397759;16760.497185084467;16834.747478787827;16845.494635160965;16847.32610695571;14819;16440.260188291555;16870.409535666317;17080.572985675335;17242.0516871572;14002.387338118027;14030.43878244869;14179.645508862257;14335.713285734331;14340.928295358457;3046.2536678513907;3556.733245006609;3557.6442355764475;3563.002359339389;3568.518250036238;132125;132204.33897830546;133162.3341883294;133919.99120013206;135738;9149.496777677292;11408.543658253577;13336.933315333556;13662.11196272239;13828.446862125402;18686.43940681782;24913.87887545065;25184.622230666555;25264.747352526607;25435.10977115792;7685.500442471333;7788.104367997753;7908.5650289234645;7912.683492660344;7925.960370198112;3896.376579747227;3957.3272543667645;3962.5046869141356;3964.623360780721;3965.088029753173;4302;4726.787294571753;4811.013742182844;4863.416390033148;4912.557869791664;964.262339310428;980.6812785844629;981.5386768219068;997.9850302245472;999.6101520407047;638.0970926139553;647.9578827376206;658.2397331082607;661.2131563439492;674.184237073147;11065.336079835235;11923;12013.459394327276;12062.155649104654;12153.210041347284;630.2153818496001;634.0869148426251;638.3712043637014;649.389573800626;665.1021121485956;5537.307836520435;5711.514521265656;5724.971375143097;5805.506531944748;5837.532997360201;95459.52270238605;98000.05999820017;98674;98769;100149;79686.40627187424;83225;97816;97855;99681;85501;87240;87422;88091.11908880957;88573.55713221393;9243.260539156985;11229.989300962952;11304.943475282571;11492.195546311677;11694.70763230926;41672.583274168086;41700.79149604232;42002.57997419986;42700;42993.78503107464;64370.35629643644;72184;74938;76786.23213767791;77751;16105.597360066093;16199.838001619833;16329.428470003493;16356.18219089017;16428.260728267494;15431.305591248196;17681.204345804726;17913.910430447766;18020.63958720792;18632.534186645444;17318.567035824206;17323.566910826827;17336.39322623702;17546;17664.02847843381;16410.507684769476;16949.23728432199;17058.48824535266;17167.79825412259;17423.82576174222;16318.836811631732;16490.58773530671;16821;16830.495085147464;17089.401870934456;11688.94155529217;11715.472803724024;12183.573574924834;12332.876671233173;12422.875771242534;12603.621891343275;13109.672258193621;13677;13782.65543361424;13803.447862085404 14:57:24 INFO - PID 1641 | __end_tp_report 14:57:24 INFO - PID 1641 | __start_cc_report 14:57:24 INFO - PID 1641 | _x_x_mozilla_cycle_collect,414 14:57:24 INFO - PID 1641 | __end_cc_report 14:57:24 INFO - PID 1641 | __startTimestamp1493157444301__endTimestamp 14:57:24 INFO - PID 1641 | 14:57:24 INFO - PID 1641 | ------- Summary: start ------- 14:57:24 INFO - PID 1641 | Number of tests: 6 14:57:24 INFO - PID 1641 | 14:57:24 INFO - PID 1641 | [#0] dojo.html Cycles:165 Average:6027.35 Median:6300.80 stddev:740.19 (11.7%) stddev-sans-first:702.54 14:57:24 INFO - PID 1641 | Values: 2970.2 3562.4 3583.3 3603.4 3608.7 5455.9 5976.6 5999.6 6207.2 6220.9 5130.2 6108.5 6117.3 6133.0 6155.5 4658.7 5343.8 5344.5 5349.7 5422.2 4424.7 5349.1 5398.0 5441.6 5478.2 5256.7 5327.1 5363.6 5390.8 5426.0 5362.8 5369.6 5380.8 5439.7 5496.0 5331.7 5333.9 5344.4 5348.9 5368.8 5112.4 5898.8 6022.5 6028.9 6103.8 6282.3 6507.2 6587.5 6596.2 6597.9 6661.2 6668.5 6683.5 6695.1 6695.4 6297.8 6313.7 6318.5 6319.5 6341.8 6510.3 6604.0 6715.9 6757.0 6790.7 6243.4 6307.6 6408.4 6450.8 6547.8 5392.7 6215.3 6461.0 6607.3 6718.4 6579.0 6584.9 6602.1 6606.2 6608.5 6254.9 6283.9 6307.5 6438.4 6582.6 5203.3 5224.2 5263.2 5269.3 5272.1 4679.9 4685.5 4707.7 4710.2 4726.1 6148.6 6328.3 6332.7 6352.5 6372.6 6300.8 6476.1 6626.2 6665.4 6694.3 6319.8 6339.0 6358.2 6365.7 6372.3 5810.1 5817.3 5823.5 5826.6 5850.3 6132.4 6236.2 6690.7 6788.5 6844.8 6717.3 6722.1 6751.3 6767.8 6793.0 6802.3 6905.2 6913.9 6926.7 6939.0 5516.0 6289.7 6339.3 6401.3 6434.0 5618.1 6678.8 6717.5 6733.1 6748.3 6339.0 6352.0 6506.2 6507.0 6644.7 6242.8 6383.2 6441.4 6443.0 6493.3 5429.0 5918.9 6195.9 6326.6 6338.1 6471.7 6509.7 6514.0 6516.1 6517.0 5145.3 6245.2 6255.8 6275.1 6277.2 14:57:24 INFO - PID 1641 | 14:57:24 INFO - PID 1641 | [#1] ext.html Cycles:180 Average:43927.96 Median:180562.69 stddev:75671.97 (41.9%) stddev-sans-first:75814.74 14:57:24 INFO - PID 1641 | Values: 732.2 799.7 820.8 1052.5 1094.1 35311.8 36234.5 36385.3 36396.0 36399.0 38607.2 38810.0 38919.6 39059.0 39092.0 7203.8 8435.6 8542.1 8554.4 8724.2 7451.3 8590.1 8635.3 8739.5 8749.0 8676.0 8740.3 8754.7 8756.7 8780.7 8691.9 8727.3 8738.5 8746.3 8758.0 8466.6 8492.5 8522.5 8537.8 8553.6 37810.4 37827.6 37835.8 37852.0 37914.2 3109.8 3595.0 3638.8 3645.5 3650.4 30890.5 30925.4 30948.8 30962.0 30964.1 3158.5 3189.3 3194.1 3194.6 3196.8 181588.2 244322.0 250388.0 274267.0 294928.0 47478.5 47540.1 47570.8 47706.0 47779.8 49159.0 49322.3 49414.8 49440.5 49682.0 13781.1 13861.9 13977.4 13993.2 13999.3 11332.6 11369.3 11377.7 11415.9 11421.4 13190.8 13296.0 13302.8 13316.0 13419.3 5788.1 5831.4 5846.6 5857.5 5863.1 856.2 918.0 926.7 958.4 991.3 19485.8 24124.8 24151.5 24493.9 24528.3 1079.4 1097.3 1108.8 1108.8 1120.3 12048.5 12371.0 12544.1 16133.8 16346.3 293783.1 298189.0 327196.0 327317.0 328262.4 55331.7 55591.6 55679.0 55725.7 55791.0 1463.4 1467.3 1503.5 1503.7 1509.6 29143.0 29426.9 29784.4 30090.7 30183.6 35975.8 36019.6 36146.6 36203.8 36312.6 293705.6 295059.0 295632.0 296091.0 296543.0 27815.9 28215.4 32079.7 32863.0 33636.7 41467.8 42023.2 42126.8 42570.5 42603.8 29293.6 29650.3 29661.0 29685.4 29980.9 25318.5 30606.8 30750.4 31494.4 31711.7 33686.0 34337.8 37364.8 37704.8 37929.0 27971.7 30973.0 31316.5 31383.0 31474.8 24272.9 24311.4 24459.6 24736.5 24916.3 14:57:24 INFO - PID 1641 | 14:57:24 INFO - PID 1641 | [#2] jquery.html Cycles:180 Average:35382.77 Median:21860.12 stddev:92194.03 (421.7%) stddev-sans-first:92415.31 14:57:24 INFO - PID 1641 | Values: 433.9 441.2 442.0 456.9 459.8 16317.6 21144.3 21855.8 21982.6 22118.0 21722.5 21744.9 21801.3 21864.5 22290.2 4803.7 5170.7 5984.6 6045.5 6046.4 5702.9 5849.5 5879.2 5920.9 5945.6 5852.7 5900.4 5920.6 5929.6 5930.7 5829.1 6060.9 6103.1 6103.5 6113.2 5323.8 5363.8 5403.6 5418.4 5458.8 26066.7 26521.6 26665.0 26721.1 26960.2 1864.0 2050.6 2120.1 2126.9 2127.1 17067.7 17196.8 17606.5 17714.6 17869.6 1921.0 2067.6 2078.3 2168.0 2206.4 147285.5 164035.5 165019.0 167004.0 168161.0 11126.1 12075.0 12395.7 12650.4 12720.4 16324.3 16342.0 16359.0 16367.3 16380.6 7513.5 8597.2 8933.7 8935.6 9058.6 8321.8 8405.5 8471.8 8593.7 8610.6 6631.5 6804.4 7752.5 7850.7 7902.7 2139.6 2147.8 2148.7 2151.1 2304.8 862.4 933.0 952.8 968.5 986.5 20338.8 20975.4 20993.2 21015.4 21257.9 921.8 997.9 1022.6 1024.4 1027.0 10601.7 10630.6 10765.8 10823.2 10823.8 463235.0 543827.0 555238.0 562169.2 567314.0 129941.4 130223.3 134194.3 135953.0 136740.3 1204.5 1233.3 1235.8 1255.8 1256.6 16292.6 17133.5 17708.0 18085.9 18102.6 55231.0 55276.0 55670.0 55808.7 56546.2 77273.6 78514.0 79116.6 79311.6 82451.0 7688.0 8581.1 8658.4 8724.6 8833.4 11503.9 13270.9 13485.2 13556.7 13618.9 9700.2 11835.2 11937.2 11978.6 12004.8 10935.2 11034.3 11040.0 11362.8 11381.3 11915.2 12053.9 12081.1 12163.7 12180.4 8722.0 8869.2 8899.6 8907.3 8957.4 11722.0 11769.3 12031.1 12124.0 12127.8 14:57:24 INFO - PID 1641 | 14:57:24 INFO - PID 1641 | [#3] mootools.html Cycles:180 Average:7169.69 Median:2563.81 stddev:4563.34 (178.0%) stddev-sans-first:4554.57 14:57:24 INFO - PID 1641 | Values: 1265.3 1303.8 1406.9 1448.0 1459.6 11650.0 11816.8 11826.5 12048.0 12148.6 11816.8 11837.9 12011.9 12048.2 12105.2 2518.9 2577.3 2577.6 2579.7 2581.5 2053.8 2181.5 2543.2 2545.4 2547.9 2268.4 2495.3 2518.7 2546.3 2550.3 2472.3 2491.3 2522.7 2522.8 2530.3 2426.6 2505.2 2512.3 2516.9 2549.3 11848.2 11947.3 11958.9 11968.9 11971.2 6584.7 6816.4 6853.0 6854.1 6857.3 4020.9 4369.1 4403.7 4414.6 4466.0 1129.8 1258.0 1280.6 1311.3 1326.4 16271.6 16624.2 16736.6 16748.7 16833.9 5550.3 5625.2 5653.6 5750.5 5810.2 11776.6 11870.9 11929.5 11957.2 11987.9 6521.5 6601.1 6623.7 6633.9 6640.6 6009.1 6189.2 6224.3 6281.2 6289.8 4196.1 4378.6 4401.7 4406.1 4441.5 1262.2 1289.1 1296.5 1308.4 1312.1 775.5 799.0 805.7 806.3 821.1 5922.0 6103.8 6198.6 6225.3 6336.7 495.5 518.5 586.0 605.9 612.2 3588.9 3812.6 3896.8 3916.7 4417.7 14551.9 15334.8 15344.0 15365.8 15382.0 14331.5 14798.0 14846.8 14917.0 15168.4 8342.2 8366.8 8504.3 8612.8 8639.8 6773.6 6831.4 6960.5 7040.4 7145.0 10866.8 11736.8 13293.9 13641.4 13667.6 12650.5 13509.9 13671.5 13959.9 14098.8 10562.1 10819.7 10957.7 10979.3 10984.7 10881.0 10934.4 11014.7 11106.1 11110.8 9160.0 9163.0 9180.1 9228.5 9244.1 8705.4 8822.9 8925.9 8941.0 9064.8 8151.0 8331.0 8332.1 8338.3 8344.7 5237.9 5998.8 6010.8 6066.6 6148.2 6045.7 6062.7 6131.7 6209.0 6348.2 14:57:24 INFO - PID 1641 | 14:57:24 INFO - PID 1641 | [#4] prototype.html Cycles:180 Average:5231.62 Median:5968.82 stddev:1691.51 (28.3%) stddev-sans-first:1656.73 14:57:24 INFO - PID 1641 | Values: 388.3 411.4 415.1 416.5 416.8 4889.3 5387.7 5402.4 5732.7 6265.5 6063.6 6156.5 6170.6 6170.9 6184.3 3848.7 3996.2 4184.3 4459.6 4472.8 4224.5 4421.5 4466.5 4472.5 4491.1 3802.4 4360.1 4374.3 4381.7 4405.3 3656.1 4376.7 4403.3 4413.8 4474.0 3594.0 3783.9 3799.9 3801.7 3807.8 5618.0 5838.3 5869.8 5963.3 5968.4 4325.0 4599.2 5238.2 5268.9 5282.3 5459.4 5770.2 5969.2 6169.0 6573.6 4290.6 4299.8 4300.0 4301.8 4302.8 6657.2 6847.6 6893.5 6914.4 6941.3 3329.5 4325.0 4329.2 4390.1 4416.8 3873.0 4415.0 4424.0 4425.6 4449.4 5123.3 5214.2 5259.5 5275.9 5280.0 6589.8 6590.2 6599.1 6601.0 6615.2 1270.5 1491.5 1499.6 1502.2 1507.2 856.3 903.7 969.7 976.9 982.6 5132.6 6129.0 6185.8 6219.5 6244.6 6237.6 6557.3 6811.8 6818.0 6890.3 6110.4 6212.3 6219.1 6219.2 6276.9 3021.0 3288.8 3475.9 3562.2 3583.2 6496.2 6753.8 7013.6 7017.2 7063.1 5999.3 6376.7 6828.8 7016.4 7037.9 5870.5 6691.5 7039.9 7044.9 7049.8 5656.9 6549.2 6763.0 6813.9 6832.5 5657.4 6305.2 6424.3 6676.3 6680.2 6923.2 7042.3 7051.3 7058.8 7077.0 4340.0 4344.7 4345.8 4354.9 4356.2 5599.4 6406.8 6812.5 6893.6 6911.8 5785.9 5961.7 6332.9 6628.8 6652.8 6360.4 6544.0 6593.1 6632.9 6637.6 5085.6 5327.0 5402.5 6420.7 6475.4 6176.3 6313.0 6607.5 6626.6 6630.7 6309.3 6339.5 6455.6 6462.4 6464.2 14:57:24 INFO - PID 1641 | 14:57:24 INFO - PID 1641 | [#5] yui.html Cycles:180 Average:22540.08 Median:25224.68 stddev:32027.99 (127.0%) stddev-sans-first:32075.77 14:57:24 INFO - PID 1641 | Values: 679.0 705.0 826.6 836.6 841.7 16584.5 16982.9 16992.8 18528.4 19089.4 17657.3 17848.0 18019.0 18105.1 18202.0 902.1 918.8 940.5 942.7 962.2 893.8 922.7 971.3 974.3 976.7 988.8 1009.3 1012.2 1012.8 1018.0 1003.9 1009.9 1010.4 1013.8 1017.3 714.2 734.5 738.6 746.2 750.2 13976.9 16760.5 16834.7 16845.5 16847.3 14819.0 16440.3 16870.4 17080.6 17242.1 14002.4 14030.4 14179.6 14335.7 14340.9 3046.3 3556.7 3557.6 3563.0 3568.5 132125.0 132204.3 133162.3 133920.0 135738.0 9149.5 11408.5 13336.9 13662.1 13828.4 18686.4 24913.9 25184.6 25264.7 25435.1 7685.5 7788.1 7908.6 7912.7 7926.0 3896.4 3957.3 3962.5 3964.6 3965.1 4302.0 4726.8 4811.0 4863.4 4912.6 964.3 980.7 981.5 998.0 999.6 638.1 648.0 658.2 661.2 674.2 11065.3 11923.0 12013.5 12062.2 12153.2 630.2 634.1 638.4 649.4 665.1 5537.3 5711.5 5725.0 5805.5 5837.5 95459.5 98000.1 98674.0 98769.0 100149.0 79686.4 83225.0 97816.0 97855.0 99681.0 85501.0 87240.0 87422.0 88091.1 88573.6 9243.3 11230.0 11304.9 11492.2 11694.7 41672.6 41700.8 42002.6 42700.0 42993.8 64370.4 72184.0 74938.0 76786.2 77751.0 16105.6 16199.8 16329.4 16356.2 16428.3 15431.3 17681.2 17913.9 18020.6 18632.5 17318.6 17323.6 17336.4 17546.0 17664.0 16410.5 16949.2 17058.5 17167.8 17423.8 16318.8 16490.6 16821.0 16830.5 17089.4 11688.9 11715.5 12183.6 12332.9 12422.9 12603.6 13109.7 13677.0 13782.7 13803.4 14:57:24 INFO - PID 1641 | -------- Summary: end -------- 14:57:24 INFO - PID 1641 | 14:57:25 INFO - TEST-INFO | 1641: exit 0 14:57:25 INFO - TEST-OK | dromaeo_css | took 1114702ms 14:57:25 INFO - TEST-START | kraken 14:57:25 INFO - operating with platform_type : mac_ 14:57:25 INFO - Initialising browser for kraken test... 14:57:25 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpq_Tz9b/profile http://localhost:49240/getInfo.html) 14:57:27 INFO - PID 1653 | 2017-04-25 14:57:27.883 plugin-container[1654:10212] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 14:57:27 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:57:27 INFO - PID 1653 | 2017-04-25 14:57:27.885 plugin-container[1654:10212] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 14:57:27 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:57:27 INFO - PID 1653 | 2017-04-25 14:57:27.886 plugin-container[1654:10212] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:57:27 INFO - PID 1653 | __metrics Screen width/height:1600/1200 14:57:27 INFO - PID 1653 | colorDepth:24 14:57:27 INFO - PID 1653 | Browser inner width/height: 1024/689 14:57:27 INFO - PID 1653 | __metrics 14:57:28 ERROR - PID 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3414: TypeError: this.tabs is undefined 14:57:29 INFO - TEST-INFO | 1653: exit 0 14:57:29 INFO - Browser initialized. 14:57:29 INFO - Running cycle 1/1 for kraken test... 14:57:29 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpq_Tz9b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:57:31 INFO - PID 1655 | 2017-04-25 14:57:31.340 plugin-container[1656:10339] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 14:57:31 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:57:31 INFO - PID 1655 | 2017-04-25 14:57:31.342 plugin-container[1656:10339] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 14:57:31 INFO - PID 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:57:31 INFO - PID 1655 | 2017-04-25 14:57:31.343 plugin-container[1656:10339] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:57:41 INFO - PID 1655 | RSS: Main: 237252608 14:57:41 INFO - PID 1655 | 14:57:43 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 14:57:44 INFO - PID 1655 | RSS: Main: 249114624 14:57:44 INFO - PID 1655 | 14:57:47 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 14:57:48 INFO - PID 1655 | RSS: Main: 257478656 14:57:48 INFO - PID 1655 | 14:57:51 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 14:57:52 INFO - PID 1655 | RSS: Main: 259788800 14:57:52 INFO - PID 1655 | 14:57:54 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 14:57:54 INFO - PID 1655 | RSS: Main: 262279168 14:57:54 INFO - PID 1655 | 14:57:56 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:57:57 INFO - PID 1655 | RSS: Main: 262377472 14:57:57 INFO - PID 1655 | 14:58:00 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 14:58:00 INFO - PID 1655 | RSS: Main: 268017664 14:58:00 INFO - PID 1655 | 14:58:03 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 14:58:04 INFO - PID 1655 | RSS: Main: 269537280 14:58:04 INFO - PID 1655 | 14:58:07 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 14:58:07 INFO - PID 1655 | RSS: Main: 268963840 14:58:07 INFO - PID 1655 | 14:58:09 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:58:10 INFO - PID 1655 | RSS: Main: 268763136 14:58:10 INFO - PID 1655 | 14:58:11 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:58:12 INFO - PID 1655 | RSS: Main: 268513280 14:58:12 INFO - PID 1655 | 14:58:14 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:58:15 INFO - PID 1655 | RSS: Main: 268099584 14:58:15 INFO - PID 1655 | 14:58:18 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:58:18 INFO - PID 1655 | RSS: Main: 268140544 14:58:18 INFO - PID 1655 | 14:58:21 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:58:22 INFO - PID 1655 | RSS: Main: 268439552 14:58:22 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 14:58:24 INFO - PID 1655 | RSS: Main: 269987840 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | __start_tp_report 14:58:24 INFO - PID 1655 | _x_x_mozilla_page_load 14:58:24 INFO - PID 1655 | _x_x_mozilla_page_load_details 14:58:24 INFO - PID 1655 | |i|pagename|runs| 14:58:24 INFO - PID 1655 | |0;ai-astar;104;114;114;117;124;169;166;117;114;115 14:58:24 INFO - PID 1655 | |1;audio-beat-detection;158;91;127;180;140;130;111;114;138;109 14:58:24 INFO - PID 1655 | |2;audio-dft;189;198;204;219;215;206;194;204;277;267 14:58:24 INFO - PID 1655 | |3;audio-fft;74;56;57;87;56;56;62;59;76;56 14:58:24 INFO - PID 1655 | |4;audio-oscillator;90;71;83;103;102;103;103;68;79;90 14:58:24 INFO - PID 1655 | |5;imaging-gaussian-blur;88;89;88;89;89;89;127;88;89;89 14:58:24 INFO - PID 1655 | |6;imaging-darkroom;96;98;97;97;97;96;97;97;97;96 14:58:24 INFO - PID 1655 | |7;imaging-desaturate;91;96;93;90;92;90;91;92;93;96 14:58:24 INFO - PID 1655 | |8;json-parse-financial;49;51;49;52;50;53;52;52;52;51 14:58:24 INFO - PID 1655 | |9;json-stringify-tinderbox;55;61;55;56;67;62;85;58;58;55 14:58:24 INFO - PID 1655 | |10;stanford-crypto-aes;82;83;82;83;82;85;82;85;82;82 14:58:24 INFO - PID 1655 | |11;stanford-crypto-ccm;136;136;139;134;154;135;158;152;199;156 14:58:24 INFO - PID 1655 | |12;stanford-crypto-pbkdf2;209;260;238;193;189;189;191;184;190;184 14:58:24 INFO - PID 1655 | |13;stanford-crypto-sha256-iterative;56;95;99;66;77;73;60;91;99;97 14:58:24 INFO - PID 1655 | __end_tp_report 14:58:24 INFO - PID 1655 | __start_cc_report 14:58:24 INFO - PID 1655 | _x_x_mozilla_cycle_collect,983 14:58:24 INFO - PID 1655 | __end_cc_report 14:58:24 INFO - PID 1655 | __startTimestamp1493157504737__endTimestamp 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | ------- Summary: start ------- 14:58:24 INFO - PID 1655 | Number of tests: 14 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#0] ai-astar Cycles:10 Average:125.40 Median:117.00 stddev:22.73 (19.4%) stddev-sans-first:22.75 14:58:24 INFO - PID 1655 | Values: 104.0 114.0 114.0 117.0 124.0 169.0 166.0 117.0 114.0 115.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:139.00 stddev:25.90 (18.6%) stddev-sans-first:25.38 14:58:24 INFO - PID 1655 | Values: 158.0 91.0 127.0 180.0 140.0 130.0 111.0 114.0 138.0 109.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#2] audio-dft Cycles:10 Average:217.30 Median:210.50 stddev:30.26 (14.4%) stddev-sans-first:30.31 14:58:24 INFO - PID 1655 | Values: 189.0 198.0 204.0 219.0 215.0 206.0 194.0 204.0 277.0 267.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#3] audio-fft Cycles:10 Average:63.90 Median:60.50 stddev:11.09 (18.3%) stddev-sans-first:11.14 14:58:24 INFO - PID 1655 | Values: 74.0 56.0 57.0 87.0 56.0 56.0 62.0 59.0 76.0 56.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:75.00 stddev:13.58 (18.1%) stddev-sans-first:14.40 14:58:24 INFO - PID 1655 | Values: 90.0 71.0 83.0 103.0 102.0 103.0 103.0 68.0 79.0 90.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:92.50 Median:89.00 stddev:12.13 (13.6%) stddev-sans-first:12.76 14:58:24 INFO - PID 1655 | Values: 88.0 89.0 88.0 89.0 89.0 89.0 127.0 88.0 89.0 89.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#6] imaging-darkroom Cycles:10 Average:96.80 Median:97.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 14:58:24 INFO - PID 1655 | Values: 96.0 98.0 97.0 97.0 97.0 96.0 97.0 97.0 97.0 96.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:92.50 stddev:2.17 (2.3%) stddev-sans-first:2.24 14:58:24 INFO - PID 1655 | Values: 91.0 96.0 93.0 90.0 92.0 90.0 91.0 92.0 93.0 96.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:52.00 stddev:1.37 (2.6%) stddev-sans-first:1.22 14:58:24 INFO - PID 1655 | Values: 49.0 51.0 49.0 52.0 50.0 53.0 52.0 52.0 52.0 51.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:59.50 stddev:9.21 (15.5%) stddev-sans-first:9.49 14:58:24 INFO - PID 1655 | Values: 55.0 61.0 55.0 56.0 67.0 62.0 85.0 58.0 58.0 55.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.50 stddev:1.23 (1.5%) stddev-sans-first:1.27 14:58:24 INFO - PID 1655 | Values: 82.0 83.0 82.0 83.0 82.0 85.0 82.0 85.0 82.0 82.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:149.90 Median:153.00 stddev:19.76 (12.9%) stddev-sans-first:20.31 14:58:24 INFO - PID 1655 | Values: 136.0 136.0 139.0 134.0 154.0 135.0 158.0 152.0 199.0 156.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:202.70 Median:192.00 stddev:25.90 (13.5%) stddev-sans-first:27.37 14:58:24 INFO - PID 1655 | Values: 209.0 260.0 238.0 193.0 189.0 189.0 191.0 184.0 190.0 184.0 14:58:24 INFO - PID 1655 | 14:58:24 INFO - PID 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.30 Median:93.00 stddev:16.90 (18.2%) stddev-sans-first:15.24 14:58:24 INFO - PID 1655 | Values: 56.0 95.0 99.0 66.0 77.0 73.0 60.0 91.0 99.0 97.0 14:58:24 INFO - PID 1655 | -------- Summary: end -------- 14:58:24 INFO - PID 1655 | 14:58:25 INFO - TEST-INFO | 1655: exit 0 14:58:25 INFO - TEST-OK | kraken | took 60715ms 14:58:25 INFO - SUITE-END | took 1175s 14:58:25 INFO - Completed test suite (00:19:35) 14:58:25 INFO - javascript benchmark 14:58:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7807.126071475282, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2970.183199620104, 3562.412201986671, 3583.3370826397136, 3603.405438102713, 3608.6932610728086, 5455.91816122758, 5976.581639285241, 5999.610025348349, 6207.162033125526, 6220.875582488353, 5130.153524668425, 6108.4634918426245, 6117.2965109012475, 6133.01871700528, 6155.507559395249, 4658.673892827495, 5343.812966546172, 5344.4922732340365, 5349.7057661828585, 5422.213779002042, 4424.734515929038, 5349.090654588729, 5397.973010134944, 5441.619086663935, 5478.178273259023, 5256.710880901549, 5327.147656374961, 5363.570914326844, 5390.838274851761, 5426.023315803154, 5362.839114826562, 5369.570434365241, 5380.811671591476, 5439.728013599344, 5495.972520137414, 5331.653442526263, 5333.919991200135, 5344.385395679507, 5348.91976620351, 5368.812091576815, 5112.437631860493, 5898.8230353089475, 6022.45797878193, 6028.909566356509, 6103.755849766048, 6282.308946015934, 6507.186601674791, 6587.50593705474, 6596.175478065242, 6597.86804263912, 6661.200655921272, 6668.466522678174, 6683.4987375947, 6695.129633147709, 6695.430888374494, 6297.842553936188, 6313.715882785285, 6318.524811353829, 6319.462845658125, 6341.8097457076365, 6510.316416776265, 6604.0, 6715.932840671629, 6757.0, 6790.660466976631, 6243.375662433811, 6307.590006649553, 6408.423241908251, 6450.838729031718, 6547.836304092436, 5392.67879369557, 6215.34738852423, 6460.967695161588, 6607.273199948002, 6718.395344418928, 6578.967105164539, 6584.86830263392, 6602.141721576164, 6606.207255129415, 6608.504362172856, 6254.937450625526, 6283.905741413882, 6307.495400368051, 6438.3883531064475, 6582.572132811352, 5203.27154198405, 5224.190250511177, 5263.157894736901, 5269.341332333458, 5272.130098533776, 4679.9298010529865, 4685.461171965199, 4707.7175369477945, 4710.222813235846, 4726.054789042205, 6148.616561273767, 6328.303886572473, 6332.715027823759, 6352.523560732963, 6372.585781924253, 6300.7998887802105, 6476.060971159155, 6626.171728533934, 6665.400113989765, 6694.263631000586, 6319.8104056878365, 6339.0, 6358.1734374531015, 6365.681715914186, 6372.299047104908, 5810.0994345875615, 5817.301923769175, 5823.5341172706085, 5826.563007774434, 5850.268716410449, 6132.44807967294, 6236.158118653923, 6690.732370705312, 6788.490863185182, 6844.828879278058, 6717.261101278953, 6722.1261236039, 6751.257361690112, 6767.763128290486, 6793.048973143863, 6802.285759995327, 6905.240423553506, 6913.93086069153, 6926.653667316513, 6938.965305173442, 5515.972420137874, 6289.7484100635465, 6339.270983836917, 6401.29585745577, 6433.967830160819, 5618.129189975561, 6678.83302917431, 6717.496187785838, 6733.091032710718, 6748.257691654012, 6339.0, 6351.98368261076, 6506.186726659168, 6506.967465162644, 6644.7009884554345, 6242.812715618538, 6383.170187875547, 6441.3880681335195, 6443.0, 6493.318201588765, 5429.0, 5918.934591773522, 6195.938040619716, 6326.588771729823, 6338.080978258219, 6471.676416179266, 6509.674516274262, 6513.967430163008, 6516.120323756422, 6517.0, 5145.305383773143, 6245.156903818108, 6255.843603909939, 6275.058741188858, 6277.2153480814895], "value": 5978.944872398986, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [732.2384719891313, 799.7320897499337, 820.8440396324696, 1052.5000624703266, 1094.1137678480436, 35311.82344088279, 36234.45648315271, 36385.272294554095, 36396.0, 36399.0, 38607.22785544288, 38810.0, 38919.610803891956, 39059.0235244119, 39092.0, 7203.783886483414, 8435.620397082115, 8542.10307917669, 8554.35842311826, 8724.214820666139, 7451.329380355767, 8590.140985901422, 8635.309175265964, 8739.4756314621, 8748.956255218714, 8676.0, 8740.257078148365, 8754.6935857245, 8756.737297881074, 8780.736577902673, 8691.869621955675, 8727.301815854717, 8738.519381434018, 8746.300295976307, 8758.0, 8466.619002144918, 8492.490450572985, 8522.531260780655, 8537.829243415097, 8553.615087321086, 37810.43284350737, 37827.621723782686, 37835.81082094572, 37852.0, 37914.24171516554, 3109.8445077746023, 3594.964050359489, 3638.7998660073686, 3645.54430696163, 3650.3611867923273, 30890.536641950388, 30925.381492370252, 30948.845255773802, 30962.0, 30964.0710778677, 3158.526221066835, 3189.282411457427, 3194.073718621597, 3194.648588655246, 3196.8081915085168, 181588.18411815845, 244322.0, 250388.0, 274266.999999998, 294928.0, 47478.52521474741, 47540.14759114464, 47570.76214618974, 47706.04587908222, 47779.76110119497, 49159.0, 49322.260166097534, 49414.764630884514, 49440.50559494359, 49682.0, 13781.104228225133, 13861.930690346484, 13977.3710183042, 13993.16041037541, 13999.300034998412, 11332.6033588824, 11369.2609980351, 11377.65867023974, 11415.885841141648, 11421.37182454973, 13190.802137967938, 13296.0, 13302.800457993138, 13316.0, 13419.329033548283, 5788.0739081746715, 5831.387704290988, 5846.649201047866, 5857.47282744555, 5863.061910094364, 856.2037305306125, 918.0, 926.7277849115571, 958.3722661656626, 991.2615101749243, 19485.805141948684, 24124.758752412603, 24151.516969660508, 24493.87753061259, 24528.264152075466, 1079.4279032112993, 1097.3375336365414, 1108.8059589571792, 1108.844761733358, 1120.327803318019, 12048.518059277707, 12371.0, 12544.121911466109, 16133.838661613469, 16346.264418101215, 293783.06216937985, 298189.0, 327196.0, 327317.0, 328262.358688205, 55331.72334138303, 55591.55267578584, 55679.0, 55725.72137139289, 55791.0, 1463.370750577262, 1467.325030485967, 1503.5339044896118, 1503.676709507461, 1509.562226954171, 29142.97999570005, 29426.852865735535, 29784.404311914073, 30090.69909300879, 30183.641736122365, 35975.820120899225, 36019.639803601625, 36146.63853361433, 36203.81898090493, 36312.63687363092, 293705.59441607964, 295059.0, 295632.0, 296091.0, 296543.0, 27815.887364505194, 28215.43569128565, 32079.67920320767, 32863.014109576754, 33636.66363336335, 41467.7926610365, 42023.15953680848, 42126.7893660542, 42570.510032148726, 42603.7869810649, 29293.560596591495, 29650.258743531584, 29661.0, 29685.406291874475, 29980.85009574938, 25318.49363012766, 30606.846965765028, 30750.384992300475, 31494.37011259716, 31711.682883170874, 33686.0, 34337.828310858284, 37364.813175933945, 37704.81147594244, 37929.0, 27971.720282796912, 30973.0, 31316.53025204578, 31383.0, 31474.842625786725, 24272.936800372165, 24311.392215194763, 24459.633105503075, 24736.50526989414, 24916.252512424657], "value": 17419.981481223767, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.87200775771146, 441.2476727180158, 442.0121029499069, 456.8720758187708, 459.84365315792644, 16317.592060198502, 21144.25995090172, 21855.781442185573, 21982.560348793013, 22118.0, 21722.456938576543, 21744.8912755436, 21801.345959621238, 21864.45338866529, 22290.219842305523, 4803.687760295578, 5170.715610641413, 5984.5511586630955, 6045.486133678643, 6046.365131661179, 5702.914456283159, 5849.502792262641, 5879.2063071485445, 5920.88158236835, 5945.583809133363, 5852.67810270435, 5900.409959004108, 5920.5559583031445, 5929.614575052629, 5930.703464826742, 5829.125631155318, 6060.909086363708, 6103.084537319393, 6103.450689437972, 6113.174721412642, 5323.813666521692, 5363.839084827422, 5403.621746477748, 5418.376886658046, 5458.781648734046, 26066.73933260662, 26521.602175967375, 26665.0, 26721.06476273321, 26960.191194264204, 1863.9561845366638, 2050.641137800894, 2120.067170444999, 2126.9361919142452, 2127.053461209762, 17067.743983840253, 17196.828031719648, 17606.47180584572, 17714.645707085914, 17869.642607147784, 1920.9615807683908, 2067.6174907641985, 2078.3453212238096, 2167.981048907027, 2206.3711842125076, 147285.52714472826, 164035.53946690809, 165019.0, 167004.0, 168161.0, 11126.109911207084, 12074.973627241783, 12395.653173643066, 12650.367481625883, 12720.427580758887, 16324.265408056666, 16342.0, 16359.0, 16367.345306187619, 16380.590485237964, 7513.549187048685, 8597.226249637562, 8933.687320943736, 8935.553222338856, 9058.592363343665, 8321.791955201168, 8405.495670259805, 8471.788205294793, 8593.742187734379, 8610.612522436506, 6631.469482441393, 6804.421624161902, 7752.457327987099, 7850.725224617111, 7902.68087403292, 2139.550694354172, 2147.8389120816, 2148.688440176166, 2151.107290474467, 2304.7580004099664, 862.3920136303891, 932.9813403731887, 952.7808604021114, 968.5109019944882, 986.4673076538733, 20338.796612033988, 20975.370738877857, 20993.16027358919, 21015.369538913856, 21257.941486676533, 921.8384835107812, 997.8802543694803, 1022.5551884930079, 1024.3853687787268, 1026.984595231072, 10601.734956626146, 10630.574777008833, 10765.784684306427, 10823.188260880466, 10823.783524329627, 463235.0, 543827.0, 555238.0, 562169.1891540516, 567314.0, 129941.35029324793, 130223.34888325498, 134194.32902835423, 135953.0, 136740.31629841786, 1204.5302332090491, 1233.3155098920186, 1235.765204611121, 1255.8430196225472, 1256.5727652598162, 16292.592685182964, 17133.485995419658, 17708.0, 18085.90957045259, 18102.637947241245, 55231.0, 55276.0, 55670.0, 55808.72095639496, 56546.15180772374, 77273.61363193148, 78514.0, 79116.60441697754, 79311.60344198241, 82451.0, 7688.0, 8581.098984606777, 8658.354912566592, 8724.56377181151, 8833.381663283508, 11503.884961150616, 13270.933645331712, 13485.190888546718, 13556.661083472993, 13618.93190534041, 9700.23342275408, 11835.171537992257, 11937.164398492023, 11978.64064078079, 12004.819927701266, 10935.234533582572, 11034.282771619819, 11040.0, 11362.829557556477, 11381.260218085798, 11915.2255103418, 12053.939730301292, 12081.093917956365, 12163.749706304008, 12180.390980451119, 8722.040575536812, 8869.157430044135, 8899.599518021576, 8907.287417006753, 8957.372983891066, 11722.0, 11769.293842369485, 12031.097667674785, 12123.969462595778, 12127.81808272859], "value": 10266.822388946448, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1265.2598230035428, 1303.7913933770596, 1406.9366878490466, 1447.9864095133403, 1459.6423876150345, 11649.999999999989, 11816.763664726712, 11826.467808948597, 12047.975922046637, 12148.574799882006, 11816.7636647267, 11837.881621183808, 12011.879881201185, 12048.21686590371, 12105.21316114452, 2518.949621007583, 2577.329894227505, 2577.6004719268544, 2579.703334116582, 2581.4966081614093, 2053.8048885355943, 2181.520065585569, 2543.2370288913344, 2545.3891066144083, 2547.885345159463, 2268.421552504109, 2495.3137887081016, 2518.672572565573, 2546.31249562618, 2550.298667866333, 2472.295395812194, 2491.2526242127287, 2522.7225005249593, 2522.7729504344516, 2530.278870521902, 2426.623873299641, 2505.185814610259, 2512.2839990602774, 2516.9370765731005, 2549.2861998640224, 11848.17062805604, 11947.283163010161, 11958.940205299004, 11968.940155299168, 11971.162018658697, 6584.670766461658, 6816.352446517622, 6853.040574319599, 6854.10896583441, 6857.314268573103, 4020.8994775130564, 4369.12617476506, 4403.669724770655, 4414.602685758297, 4466.0398014427055, 1129.7514546799691, 1257.9622611321674, 1280.6030130659526, 1311.3084121483275, 1326.4097476622906, 16271.593210169722, 16624.168791560372, 16736.581585460463, 16748.665026699397, 16833.91583042089, 5550.27846379968, 5625.156226565966, 5653.632513886584, 5750.511206547407, 5810.244668193192, 11776.58781942645, 11870.88129118715, 11929.522819087313, 11957.162998590014, 11987.940060299643, 6521.543491955613, 6601.108850305147, 6623.701933413008, 6633.900491492632, 6640.601563906181, 6009.06859436788, 6189.164462797555, 6224.315325314212, 6281.2462504498835, 6289.779857704958, 4196.139791342767, 4378.599507494947, 4401.6698747594055, 4406.074724307867, 4441.511433742286, 1262.1795832708813, 1289.0589869395394, 1296.494367196794, 1308.3719814489098, 1312.08154291996, 775.4610545670705, 798.9560574168477, 805.7083395272758, 806.2864365036867, 821.080389963245, 5921.970390148108, 6103.816885493442, 6198.6280823149855, 6225.315215326311, 6336.714847831859, 495.51687105072267, 518.5359103602254, 585.9619124756878, 605.8519106293548, 612.1552257884091, 3588.928221435609, 3812.618738126165, 3896.805159742058, 3916.686665066788, 4417.668674849399, 14551.85448145505, 15334.769978450333, 15344.0, 15365.769513457308, 15382.000169988914, 14331.498397556245, 14798.0, 14846.777298340534, 14917.030393024419, 15168.393264269305, 8342.16578342161, 8366.790830229414, 8504.31965442763, 8612.78468038304, 8639.827203455896, 6773.627450490073, 6831.419329356861, 6960.512764106464, 7040.401565866959, 7145.0, 10866.782664346827, 11736.767639398082, 13293.867061329649, 13641.386137623633, 13667.589972300846, 12650.493980240688, 13509.932450337685, 13671.521496747964, 13959.930200348934, 14098.788518172441, 10562.102221310966, 10819.729506762395, 10957.671269861918, 10979.28634638746, 10984.670459886216, 10881.0, 10934.398608076313, 11014.669559913216, 11106.055985241344, 11110.777814440567, 9160.038195989591, 9162.954185229031, 9180.127887850644, 9228.492432915986, 9244.121808428188, 8705.434146780439, 8822.867656985021, 8925.866112008196, 8940.955295223483, 9064.818703626022, 8151.0, 8331.0002799662, 8332.083470818085, 8338.332933365195, 8344.666213351398, 5237.869053273546, 5998.790042348497, 6010.819675409744, 6066.605670631395, 6148.16999705052, 6045.727942242697, 6062.666553339609, 6131.693415329127, 6208.9689551551955, 6348.206474190726], "value": 5342.016612242837, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.28749245135174, 411.41373542701655, 415.0640306109722, 416.4648426771597, 416.77494153157295, 4889.315495830582, 5387.730613469321, 5402.405735369106, 5732.713364331782, 6265.530085243602, 6063.6058656187315, 6156.4766994805495, 6170.598911070777, 6170.876582468348, 6184.257889053309, 3848.672862806665, 3996.220736956295, 4184.267753143203, 4459.620932220765, 4472.821087156518, 4224.5353011168745, 4421.491528474235, 4466.5483717791685, 4472.53038430965, 4491.146682130385, 3802.429635554661, 4360.149770794696, 4374.300111982084, 4381.6635926042545, 4405.251107311765, 3656.0859785053735, 4376.715513491628, 4403.339499075132, 4413.845515406945, 4474.0, 3593.964060359389, 3783.9054023649355, 3799.8670046548236, 3801.657850793414, 3807.7715337079585, 5617.9719101404235, 5838.299404071538, 5869.80095847764, 5963.344032156459, 5968.418369132183, 4324.994129080291, 4599.172149013176, 5238.214267859814, 5268.894622107575, 5282.313299271109, 5459.3994660587305, 5770.249867517238, 5969.224000879901, 6168.96915515424, 6573.572717773377, 4290.613844753987, 4299.849505267301, 4299.97850010748, 4301.763403012833, 4302.849400270976, 6657.167854018247, 6847.589144651337, 6893.517453778238, 6914.412274956635, 6941.271166527493, 3329.5172200031343, 4324.956750432519, 4329.19909816685, 4390.143921935192, 4416.823327066945, 3872.980635096863, 4415.0, 4424.0, 4425.601695847389, 4449.443819522559, 5123.333966584395, 5214.243934629533, 5259.526642602184, 5275.920861187085, 5279.973600132052, 6589.76935807254, 6590.242122155918, 6599.142111525567, 6600.966995165089, 6615.213892249066, 1270.4854533913779, 1491.5010414533542, 1499.5951093204774, 1502.1738044075714, 1507.1785876697227, 856.3277826905849, 903.746950853762, 969.6654654144309, 976.9267304952157, 982.5627595719836, 5132.640715149903, 6129.0, 6185.8144255672405, 6219.47134493564, 6244.594101383486, 6237.563370564108, 6557.344265573404, 6811.829704257433, 6818.0, 6890.276520965327, 6110.388961103854, 6212.254529456494, 6219.1342597220655, 6219.19643303446, 6276.874462510816, 3020.969790302113, 3288.753343499247, 3475.878344257939, 3562.1628917204434, 3583.2475180211927, 6496.220453545605, 6753.831154221184, 7013.614251216232, 7017.193022802341, 7063.092964899449, 5999.280086389661, 6376.7130479128555, 6828.7609933653075, 7016.403605693573, 7037.894431583531, 5870.534375562274, 6691.531592788556, 7039.894401583878, 7044.859102818017, 7049.836776931851, 5656.943430565641, 6549.214094308713, 6763.0, 6813.8637227254185, 6832.487563432862, 5657.43425657431, 6305.243370795534, 6424.325445828307, 6676.265610782907, 6680.231773345933, 6923.169219693669, 7042.260562640849, 7051.330123638246, 7058.752943646948, 7077.0, 4339.956600434081, 4344.695871288979, 4345.804438800198, 4354.869353919387, 4356.150550642595, 5599.356074051373, 6406.84676758188, 6812.523123381316, 6893.586384816927, 6911.827204319932, 5785.8553536161935, 5961.672108034099, 6332.915269651141, 6628.767993120217, 6652.83367915806, 6360.395762402564, 6544.0, 6593.099036423958, 6632.900506492503, 6637.601743895381, 5085.5931525477135, 5327.04584736199, 5402.486763757437, 6420.7158568285595, 6475.417212450902, 6176.289726681489, 6313.0, 6607.504437167136, 6626.602403855784, 6630.668466576555, 6309.255473868881, 6339.524535659752, 6455.644939528183, 6462.4183823456115, 6464.159659244268], "value": 4701.743846902896, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [679.0, 704.9612271325075, 826.5743142281726, 836.6193382011186, 841.6591280531383, 16584.502464926056, 16982.91508542457, 16992.830071699263, 18528.44414667559, 19089.427317180507, 17657.293708251687, 17848.0, 18019.0, 18105.09474526272, 18202.0, 902.0888902208784, 918.8422587539682, 940.5485367023832, 942.7077605942145, 962.1533050915219, 893.8480458322068, 922.7047344849651, 971.3055165556625, 974.28390133252, 976.6581696406237, 988.7874107066979, 1009.2834087797672, 1012.2054187462843, 1012.817692815293, 1018.0176130034515, 1003.9247056470757, 1009.8737657792776, 1010.4240582867768, 1013.771901322204, 1017.3133135133792, 714.1572943926164, 734.5445823589355, 738.5937734246144, 746.1903834339748, 750.2010358967682, 13976.860231397759, 16760.497185084467, 16834.747478787827, 16845.494635160965, 16847.32610695571, 14819.0, 16440.260188291555, 16870.409535666317, 17080.572985675335, 17242.0516871572, 14002.387338118027, 14030.43878244869, 14179.645508862257, 14335.713285734331, 14340.928295358457, 3046.2536678513907, 3556.733245006609, 3557.6442355764475, 3563.002359339389, 3568.518250036238, 132125.0, 132204.33897830546, 133162.3341883294, 133919.99120013206, 135738.0, 9149.496777677292, 11408.543658253577, 13336.933315333556, 13662.11196272239, 13828.446862125402, 18686.43940681782, 24913.87887545065, 25184.622230666555, 25264.747352526607, 25435.10977115792, 7685.500442471333, 7788.104367997753, 7908.5650289234645, 7912.683492660344, 7925.960370198112, 3896.376579747227, 3957.3272543667645, 3962.5046869141356, 3964.623360780721, 3965.088029753173, 4302.0, 4726.787294571753, 4811.013742182844, 4863.416390033148, 4912.557869791664, 964.262339310428, 980.6812785844629, 981.5386768219068, 997.9850302245472, 999.6101520407047, 638.0970926139553, 647.9578827376206, 658.2397331082607, 661.2131563439492, 674.184237073147, 11065.336079835235, 11923.0, 12013.459394327276, 12062.155649104654, 12153.210041347284, 630.2153818496001, 634.0869148426251, 638.3712043637014, 649.389573800626, 665.1021121485956, 5537.307836520435, 5711.514521265656, 5724.971375143097, 5805.506531944748, 5837.532997360201, 95459.52270238605, 98000.05999820017, 98674.0, 98769.0, 100149.0, 79686.40627187424, 83225.0, 97816.0, 97855.0, 99681.0, 85501.0, 87240.0, 87422.0, 88091.11908880957, 88573.55713221393, 9243.260539156985, 11229.989300962952, 11304.943475282571, 11492.195546311677, 11694.70763230926, 41672.583274168086, 41700.79149604232, 42002.57997419986, 42700.0, 42993.78503107464, 64370.35629643644, 72184.0, 74938.0, 76786.23213767791, 77751.0, 16105.597360066093, 16199.838001619833, 16329.428470003493, 16356.18219089017, 16428.260728267494, 15431.305591248196, 17681.204345804726, 17913.910430447766, 18020.63958720792, 18632.534186645444, 17318.567035824206, 17323.566910826827, 17336.39322623702, 17546.0, 17664.02847843381, 16410.507684769476, 16949.23728432199, 17058.48824535266, 17167.79825412259, 17423.82576174222, 16318.836811631732, 16490.58773530671, 16821.0, 16830.495085147464, 17089.401870934456, 11688.94155529217, 11715.472803724024, 12183.573574924834, 12332.876671233173, 12422.875771242534, 12603.621891343275, 13109.672258193621, 13677.0, 13782.65543361424, 13803.447862085404], "value": 8430.307056640464, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 117.0, 124.0, 169.0, 166.0, 117.0, 114.0, 115.0], "value": 125.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 91.0, 127.0, 180.0, 140.0, 130.0, 111.0, 114.0, 138.0, 109.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 198.0, 204.0, 219.0, 215.0, 206.0, 194.0, 204.0, 277.0, 267.0], "value": 217.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 56.0, 57.0, 87.0, 56.0, 56.0, 62.0, 59.0, 76.0, 56.0], "value": 63.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 83.0, 103.0, 102.0, 103.0, 103.0, 68.0, 79.0, 90.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 89.0, 89.0, 89.0, 127.0, 88.0, 89.0, 89.0], "value": 92.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 97.0, 97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 96.0, 93.0, 90.0, 92.0, 90.0, 91.0, 92.0, 93.0, 96.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 51.0, 49.0, 52.0, 50.0, 53.0, 52.0, 52.0, 52.0, 51.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 61.0, 55.0, 56.0, 67.0, 62.0, 85.0, 58.0, 58.0, 55.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 82.0, 83.0, 82.0, 85.0, 82.0, 85.0, 82.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 139.0, 134.0, 154.0, 135.0, 158.0, 152.0, 199.0, 156.0], "value": 149.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 260.0, 238.0, 193.0, 189.0, 189.0, 191.0, 184.0, 190.0, 184.0], "value": 202.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 95.0, 99.0, 66.0, 77.0, 73.0, 60.0, 91.0, 99.0, 97.0], "value": 81.3, "unit": "score"}]}]} 14:58:25 INFO - Return code: 0 14:58:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:58:26 ERROR - # TBPL SUCCESS # 14:58:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:58:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:58:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:58:26 INFO - 2017-04-25 14:58:26.048 screenresolution[1660:10728] starting screenresolution argv=screenresolution get 14:58:26 INFO - 2017-04-25 14:58:26.051 screenresolution[1660:10728] Display 0: 1600x1200x32@60 14:58:26 INFO - 2017-04-25 14:58:26.057 screenresolution[1661:10731] starting screenresolution argv=screenresolution list 14:58:26 INFO - Available Modes on Display 0 14:58:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:58:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:58:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:58:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:58:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:58:26 INFO - Intel Iris: 14:58:26 INFO - Chipset Model: Intel Iris 14:58:26 INFO - Type: GPU 14:58:26 INFO - Bus: Built-In 14:58:26 INFO - VRAM (Dynamic, Max): 1536 MB 14:58:26 INFO - Vendor: Intel (0x8086) 14:58:26 INFO - Device ID: 0x0a2e 14:58:26 INFO - Revision ID: 0x0009 14:58:26 INFO - Displays: 14:58:26 INFO - Display: 14:58:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:58:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:58:26 INFO - Display Serial Number: 1600x1200 60 14:58:26 INFO - Main Display: Yes 14:58:26 INFO - Mirror: Off 14:58:26 INFO - Online: Yes 14:58:26 INFO - Rotation: Supported 14:58:26 INFO - Return code: 0 14:58:26 INFO - Running post-action listener: _resource_record_post_action 14:58:26 INFO - [mozharness: 2017-04-25 21:58:26.299250Z] Finished run-tests step (success) 14:58:26 INFO - Running post-run listener: _resource_record_post_run 14:58:26 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 39552512; Write bytes: 514540544; Read time: 256; Write time: 1609 14:58:26 INFO - TinderboxPrint: CPU usage
54.3% 14:58:26 INFO - TinderboxPrint: I/O read bytes / time
39,552,512 / 256 14:58:26 INFO - TinderboxPrint: I/O write bytes / time
514,540,544 / 1,609 14:58:26 INFO - TinderboxPrint: CPU idle
2,189.0 (45.7%) 14:58:26 INFO - TinderboxPrint: CPU system
964.3 (20.2%) 14:58:26 INFO - TinderboxPrint: CPU user
1,632.3 (34.1%) 14:58:26 INFO - TinderboxPrint: Swap in / out
247,685,120 / 0 14:58:26 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209678848; Write bytes: 208152576; Read time: 16245; Write time: 439 14:58:26 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 35571200; Write bytes: 301206528; Read time: 230; Write time: 1146 14:58:26 INFO - Running post-run listener: _upload_blobber_files 14:58:26 INFO - Blob upload gear active. 14:58:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:58:26 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 14:58:26 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'] 14:58:26 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 14:58:27 INFO - (blobuploader) - INFO - Open directory for files ... 14:58:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:58:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:58:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:28 INFO - (blobuploader) - INFO - Done attempting. 14:58:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:58:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:58:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:29 INFO - (blobuploader) - INFO - Done attempting. 14:58:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:58:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:58:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:30 INFO - (blobuploader) - INFO - Done attempting. 14:58:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:58:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:58:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:58:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:58:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:58:32 INFO - (blobuploader) - INFO - Done attempting. 14:58:32 INFO - (blobuploader) - INFO - Iteration through files over. 14:58:32 INFO - Return code: 0 14:58:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:58:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:58:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26a54eb8cadc0f295f8d05b1e0eb4a7cda3a1ea22b16b0d0c48e996296a7c4ebb8e7177f88c4595830ce09b5b6eab456e01a3bc3c2d7d60905e79c3d77891c06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66e06f2bd57e0e733a0856f29adff1c13a4f8d01252943b4ba57100143a8e620c31c2f96a892a951890d99b4de41212b278b6555faf3120953e4475ed40493ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/251b86344eebcddf66fa30cb61076a93f42b77a39ab102c4d62a152e590d628a383c1ad5ffe33972c645ec1b9498c1f13669531535a0474ddfd52e98a6b85670", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98555f1df6d67d25e622d9de95abdfbc6d6305617587362323cd07c68fd717c6e8b0af9ce4ca20183a252d527a9338a62baa8d88c39ea0599da99d8e34ae8a2e"} 14:58:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:58:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:58:32 INFO - Contents: 14:58:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26a54eb8cadc0f295f8d05b1e0eb4a7cda3a1ea22b16b0d0c48e996296a7c4ebb8e7177f88c4595830ce09b5b6eab456e01a3bc3c2d7d60905e79c3d77891c06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66e06f2bd57e0e733a0856f29adff1c13a4f8d01252943b4ba57100143a8e620c31c2f96a892a951890d99b4de41212b278b6555faf3120953e4475ed40493ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/251b86344eebcddf66fa30cb61076a93f42b77a39ab102c4d62a152e590d628a383c1ad5ffe33972c645ec1b9498c1f13669531535a0474ddfd52e98a6b85670", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98555f1df6d67d25e622d9de95abdfbc6d6305617587362323cd07c68fd717c6e8b0af9ce4ca20183a252d527a9338a62baa8d88c39ea0599da99d8e34ae8a2e"} 14:58:32 INFO - Running post-run listener: copy_logs_to_upload_dir 14:58:32 INFO - Copying logs to upload dir... 14:58:32 INFO - mkdir: /builds/slave/test/build/upload/logs 14:58:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.469450 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-25 14:58:32.841578) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 14:58:32.844647) ========= 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.3iWJdLHBAz/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.jabGaalwWx/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26a54eb8cadc0f295f8d05b1e0eb4a7cda3a1ea22b16b0d0c48e996296a7c4ebb8e7177f88c4595830ce09b5b6eab456e01a3bc3c2d7d60905e79c3d77891c06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66e06f2bd57e0e733a0856f29adff1c13a4f8d01252943b4ba57100143a8e620c31c2f96a892a951890d99b4de41212b278b6555faf3120953e4475ed40493ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/251b86344eebcddf66fa30cb61076a93f42b77a39ab102c4d62a152e590d628a383c1ad5ffe33972c645ec1b9498c1f13669531535a0474ddfd52e98a6b85670", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98555f1df6d67d25e622d9de95abdfbc6d6305617587362323cd07c68fd717c6e8b0af9ce4ca20183a252d527a9338a62baa8d88c39ea0599da99d8e34ae8a2e"} build_url:https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011237 build_url: 'https://queue.taskcluster.net/v1/task/eML4bH2OTW-knw-2KatpUw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26a54eb8cadc0f295f8d05b1e0eb4a7cda3a1ea22b16b0d0c48e996296a7c4ebb8e7177f88c4595830ce09b5b6eab456e01a3bc3c2d7d60905e79c3d77891c06", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66e06f2bd57e0e733a0856f29adff1c13a4f8d01252943b4ba57100143a8e620c31c2f96a892a951890d99b4de41212b278b6555faf3120953e4475ed40493ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/251b86344eebcddf66fa30cb61076a93f42b77a39ab102c4d62a152e590d628a383c1ad5ffe33972c645ec1b9498c1f13669531535a0474ddfd52e98a6b85670", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98555f1df6d67d25e622d9de95abdfbc6d6305617587362323cd07c68fd717c6e8b0af9ce4ca20183a252d527a9338a62baa8d88c39ea0599da99d8e34ae8a2e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-25 14:58:32.880250) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 14:58:32.880567) ========= 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.3iWJdLHBAz/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.jabGaalwWx/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005036 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-25 14:58:32.929064) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 14:58:32.929387) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-25 14:58:32.929705) ========= ========= Total master_lag: 0.18 =========