builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0102 starttime: 1483385858.26 results: success (0) buildid: 20170102105519 builduid: d4292c10bf62428e91113b25c1cc8505 revision: c91249f41e3766274131a84f9157a4d9d9949520 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 11:37:38.263428) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 11:37:38.263927) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 11:37:38.264206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 11:37:38.291121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 11:37:38.291409) ========= 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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-01-02 11:37:38-- 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% 17.4M=0.001s 2017-01-02 11:37:38 (17.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.595519 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 11:37:38.910807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 11:37:38.911087) ========= 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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.029976 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 11:37:38.982644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-02 11:37:38.982988) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c91249f41e3766274131a84f9157a4d9d9949520 --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 c91249f41e3766274131a84f9157a4d9d9949520 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.92ecOg7Q2x/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.vYHS1u4H5j/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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-01-02 11:37:39,076 truncating revision to first 12 chars 2017-01-02 11:37:39,076 Setting DEBUG logging. 2017-01-02 11:37:39,076 attempt 1/10 2017-01-02 11:37:39,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c91249f41e37?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-02 11:37:41,073 unpacking tar archive at: mozilla-central-c91249f41e37/testing/mozharness/ program finished with exit code 0 elapsedTime=2.267830 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-01-02 11:37:41.273522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 11:37:41.273842) ========= script_repo_revision: c91249f41e3766274131a84f9157a4d9d9949520 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 11:37:41.274222) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 11:37:41.274516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 11:37:41.294485) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-02 11:37:41.294778) ========= /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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:37:41 INFO - MultiFileLogger online at 20170102 11:37:41 in /builds/slave/test 11:37:41 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 11:37:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:37:41 INFO - {'append_to_log': False, 11:37:41 INFO - 'base_work_dir': '/builds/slave/test', 11:37:41 INFO - 'blob_upload_branch': 'Firefox', 11:37:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:37:41 INFO - 'branch': 'Firefox', 11:37:41 INFO - 'buildbot_json_path': 'buildprops.json', 11:37:41 INFO - 'config_files': ('talos/mac_config.py',), 11:37:41 INFO - 'default_actions': ('clobber', 11:37:41 INFO - 'read-buildbot-config', 11:37:41 INFO - 'download-and-extract', 11:37:41 INFO - 'populate-webroot', 11:37:41 INFO - 'create-virtualenv', 11:37:41 INFO - 'install', 11:37:41 INFO - 'run-tests'), 11:37:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:37:41 INFO - 'download_minidump_stackwalk': True, 11:37:41 INFO - 'download_symbols': 'ondemand', 11:37:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:37:41 INFO - 'tooltool.py': '/tools/tooltool.py', 11:37:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:37:41 INFO - '/tools/misc-python/virtualenv.py')}, 11:37:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:37:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:37:41 INFO - 'installer_path': 'installer.exe', 11:37:41 INFO - 'log_level': 'info', 11:37:41 INFO - 'log_name': 'talos', 11:37:41 INFO - 'log_to_console': True, 11:37:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:37:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:37:41 INFO - 'opt_config_files': (), 11:37:41 INFO - 'pip_index': False, 11:37:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:37:41 INFO - 'cmd': ('bash', 11:37:41 INFO - '-c', 11:37:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:37:41 INFO - 'enabled': True, 11:37:41 INFO - 'halt_on_failure': False, 11:37:41 INFO - 'name': 'check_screen_resolution'},), 11:37:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:37:41 INFO - 'cmd': ('bash', 11:37:41 INFO - '-c', 11:37:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:37:41 INFO - 'enabled': True, 11:37:41 INFO - 'halt_on_failure': False, 11:37:41 INFO - 'name': 'check_screen_resolution'},), 11:37:41 INFO - 'run_cmd_checks_enabled': True, 11:37:41 INFO - 'sps_profile': False, 11:37:41 INFO - 'sps_profile_interval': 0, 11:37:41 INFO - 'suite': 'dromaeojs-e10s', 11:37:41 INFO - 'system_bits': '32', 11:37:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:37:41 INFO - 'title': 't-yosemite-r7-0102', 11:37:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:37:41 INFO - 'use_talos_json': True, 11:37:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:37:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:37:41 INFO - 'work_dir': 'build'} 11:37:41 INFO - [mozharness: 2017-01-02 19:37:41.495461Z] Running clobber step. 11:37:41 INFO - Running pre-action listener: _resource_record_pre_action 11:37:41 INFO - Running main action method: clobber 11:37:41 INFO - rmtree: /builds/slave/test/build 11:37:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:37:43 INFO - Running post-action listener: _resource_record_post_action 11:37:43 INFO - [mozharness: 2017-01-02 19:37:43.756614Z] Finished clobber step (success) 11:37:43 INFO - [mozharness: 2017-01-02 19:37:43.756849Z] Running read-buildbot-config step. 11:37:43 INFO - Running pre-action listener: _resource_record_pre_action 11:37:43 INFO - Running main action method: read_buildbot_config 11:37:43 INFO - Using buildbot properties: 11:37:43 INFO - { 11:37:43 INFO - "project": "", 11:37:43 INFO - "product": "firefox", 11:37:43 INFO - "script_repo_revision": "production", 11:37:43 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 11:37:43 INFO - "repository": "", 11:37:43 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 11:37:43 INFO - "buildid": "20170102105519", 11:37:43 INFO - "pgo_build": "False", 11:37:43 INFO - "basedir": "/builds/slave/test", 11:37:43 INFO - "buildnumber": 32, 11:37:43 INFO - "slavename": "t-yosemite-r7-0102", 11:37:43 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:37:43 INFO - "platform": "yosemite_r7", 11:37:43 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 11:37:43 INFO - "branch": "mozilla-central", 11:37:43 INFO - "repo_path": "mozilla-central", 11:37:43 INFO - "revision": "c91249f41e3766274131a84f9157a4d9d9949520", 11:37:43 INFO - "stage_platform": "macosx64", 11:37:43 INFO - "builduid": "d4292c10bf62428e91113b25c1cc8505", 11:37:43 INFO - "slavebuilddir": "test" 11:37:43 INFO - } 11:37:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 11:37:43 INFO - Running post-action listener: _resource_record_post_action 11:37:43 INFO - [mozharness: 2017-01-02 19:37:43.762571Z] Finished read-buildbot-config step (success) 11:37:43 INFO - [mozharness: 2017-01-02 19:37:43.762803Z] Running download-and-extract step. 11:37:43 INFO - Running pre-action listener: _resource_record_pre_action 11:37:43 INFO - Running main action method: download_and_extract 11:37:43 INFO - mkdir: /builds/slave/test/build/tests 11:37:43 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')]} 11:37:43 INFO - trying https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 11:37:43 INFO - Downloading https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 11:37:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 11:37:44 INFO - Downloaded 1199 bytes. 11:37:44 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 11:37:44 INFO - Using the following test package requirements: 11:37:44 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 11:37:44 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:37:44 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 11:37:44 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:37:44 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 11:37:44 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:37:44 INFO - u'jsshell-mac.zip'], 11:37:44 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:37:44 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 11:37:44 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 11:37:44 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:37:44 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 11:37:44 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:37:44 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 11:37:44 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:37:44 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 11:37:44 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 11:37:44 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 11:37:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:37:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 11:37:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:37:44 INFO - Fetch https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 11:37:45 INFO - Expected file size: 16300420 11:37:45 INFO - Obtained file size: 16300420 11:37:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 11:37:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 11:37:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 11:37:52 INFO - Fetch https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 11:37:54 INFO - Expected file size: 16300420 11:37:54 INFO - Obtained file size: 16300420 11:38:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 11:38:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 11:38:00 INFO - Fetch https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 11:38:01 INFO - Expected file size: 14409776 11:38:01 INFO - Obtained file size: 14409776 11:38:02 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')]} 11:38:02 INFO - trying https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:38:02 INFO - Downloading https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 11:38:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 11:38:04 INFO - Downloaded 69759480 bytes. 11:38:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:38:04 INFO - mkdir: /builds/slave/test/properties 11:38:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:38:04 INFO - Writing to file /builds/slave/test/properties/build_url 11:38:04 INFO - Contents: 11:38:04 INFO - build_url:https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 11:38:04 INFO - Running post-action listener: _resource_record_post_action 11:38:04 INFO - Running post-action listener: set_extra_try_arguments 11:38:04 INFO - [mozharness: 2017-01-02 19:38:04.878463Z] Finished download-and-extract step (success) 11:38:04 INFO - [mozharness: 2017-01-02 19:38:04.878592Z] Running populate-webroot step. 11:38:04 INFO - Running pre-action listener: _resource_record_pre_action 11:38:04 INFO - Running main action method: populate_webroot 11:38:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:38:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:38:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:38:04 INFO - '--tppagecycles', 11:38:04 INFO - '7'], 11:38:04 INFO - 'tests': ['tsvgm']}}, 11:38:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:38:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:38:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:38:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:38:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:38:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:38:04 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:38:04 INFO - 'talos_options': ['--disable-e10s'], 11:38:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:04 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:38:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:38:04 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:38:04 INFO - 'talos_options': ['--disable-e10s'], 11:38:04 INFO - 'tests': ['damp', 'tps']}, 11:38:04 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:38:04 INFO - 'tests': ['damp', 'tps']}, 11:38:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:38:04 INFO - 'tests': ['dromaeo_dom']}, 11:38:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:38:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:38:04 INFO - 'tests': ['basic_compositor_video']}, 11:38:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:38:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:38:04 INFO - 'tests': ['a11yr', 11:38:04 INFO - 'ts_paint', 11:38:04 INFO - 'tpaint', 11:38:04 INFO - 'sessionrestore', 11:38:04 INFO - 'sessionrestore_no_auto_restore', 11:38:04 INFO - 'tabpaint']}, 11:38:04 INFO - 'other-e10s': {'tests': ['a11yr', 11:38:04 INFO - 'ts_paint', 11:38:04 INFO - 'tpaint', 11:38:04 INFO - 'sessionrestore', 11:38:04 INFO - 'sessionrestore_no_auto_restore', 11:38:04 INFO - 'tabpaint']}, 11:38:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:38:04 INFO - 'ts_paint', 11:38:04 INFO - 'tpaint', 11:38:04 INFO - 'sessionrestore', 11:38:04 INFO - 'sessionrestore_no_auto_restore', 11:38:04 INFO - 'tabpaint']}, 11:38:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:38:04 INFO - 'ts_paint', 11:38:04 INFO - 'tpaint', 11:38:04 INFO - 'sessionrestore', 11:38:04 INFO - 'sessionrestore_no_auto_restore', 11:38:04 INFO - 'tabpaint']}, 11:38:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:38:04 INFO - 'tests': ['a11yr', 11:38:04 INFO - 'ts_paint', 11:38:04 INFO - 'tpaint', 11:38:04 INFO - 'sessionrestore', 11:38:04 INFO - 'sessionrestore_no_auto_restore', 11:38:04 INFO - 'tabpaint']}, 11:38:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:38:04 INFO - 'tests': ['a11yr', 11:38:04 INFO - 'ts_paint', 11:38:04 INFO - 'tpaint', 11:38:04 INFO - 'sessionrestore', 11:38:04 INFO - 'sessionrestore_no_auto_restore', 11:38:04 INFO - 'tabpaint']}, 11:38:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:38:04 INFO - 'tests': ['tsvgx', 11:38:04 INFO - 'tsvgr_opacity', 11:38:04 INFO - 'tart', 11:38:04 INFO - 'tscrollx', 11:38:04 INFO - 'cart', 11:38:04 INFO - 'tsvg_static']}, 11:38:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:38:04 INFO - 'tsvgr_opacity', 11:38:04 INFO - 'tart', 11:38:04 INFO - 'tscrollx', 11:38:04 INFO - 'cart', 11:38:04 INFO - 'tsvg_static']}, 11:38:04 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:38:04 INFO - 'talos_options': ['--disable-e10s'], 11:38:04 INFO - 'tests': ['tp5o']}, 11:38:04 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:38:04 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:38:04 INFO - 'talos_options': ['--disable-e10s', 11:38:04 INFO - '--xperf_path', 11:38:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:04 INFO - 'tests': ['tp5n']}, 11:38:04 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:38:04 INFO - 'talos_options': ['--xperf_path', 11:38:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:38:04 INFO - 'tests': ['tp5n']}}, 11:38:04 INFO - 'talos.zip': {'path': '', 11:38:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:38:04 INFO - Running post-action listener: _resource_record_post_action 11:38:04 INFO - [mozharness: 2017-01-02 19:38:04.897000Z] Finished populate-webroot step (success) 11:38:04 INFO - [mozharness: 2017-01-02 19:38:04.897133Z] Running create-virtualenv step. 11:38:04 INFO - Running pre-action listener: _resource_record_pre_action 11:38:04 INFO - Running main action method: create_virtualenv 11:38:04 INFO - Creating virtualenv /builds/slave/test/build/venv 11:38:04 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 11:38:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:38:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:38:05 INFO - Using real prefix '/tools/python27' 11:38:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:38:05 INFO - Installing distribute.............................................................................................................................................................................................done. 11:38:08 INFO - Installing pip.................done. 11:38:08 INFO - Return code: 0 11:38:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:38:08 INFO - Reading from file tmpfile_stdout 11:38:08 INFO - Output received: 11:38:08 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) 11:38:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:38:08 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')]} 11:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:08 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')]} 11:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:08 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 0x10e58eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e591768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff23bd9e000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36cd30>, '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 0x10e293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e361be8>, '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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:38:08 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 11:38:08 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 11:38:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.92ecOg7Q2x/Render', 11:38:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:08 INFO - 'HOME': '/Users/cltbld', 11:38:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:08 INFO - 'LOGNAME': 'cltbld', 11:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:08 INFO - 'MOZ_NO_REMOTE': '1', 11:38:08 INFO - 'NO_EM_RESTART': '1', 11:38:08 INFO - 'PAGER': '/bin/cat', 11:38:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:08 INFO - 'PWD': '/builds/slave/test', 11:38:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:08 INFO - 'SHELL': '/bin/bash', 11:38:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vYHS1u4H5j/Listeners', 11:38:08 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:38:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:08 INFO - 'USER': 'cltbld', 11:38:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:08 INFO - 'XPC_FLAGS': '0x0', 11:38:08 INFO - 'XPC_SERVICE_NAME': '0', 11:38:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:09 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 11:38:09 INFO - Cleaning up... 11:38:09 INFO - Return code: 0 11:38:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:38:09 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')]} 11:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:09 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')]} 11:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x10e58eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e591768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff23bd9e000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36cd30>, '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 0x10e293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e361be8>, '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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:38:09 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 11:38:09 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 11:38:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.92ecOg7Q2x/Render', 11:38:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:09 INFO - 'HOME': '/Users/cltbld', 11:38:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:09 INFO - 'LOGNAME': 'cltbld', 11:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:09 INFO - 'MOZ_NO_REMOTE': '1', 11:38:09 INFO - 'NO_EM_RESTART': '1', 11:38:09 INFO - 'PAGER': '/bin/cat', 11:38:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:09 INFO - 'PWD': '/builds/slave/test', 11:38:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:09 INFO - 'SHELL': '/bin/bash', 11:38:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vYHS1u4H5j/Listeners', 11:38:09 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:38:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:09 INFO - 'USER': 'cltbld', 11:38:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:09 INFO - 'XPC_FLAGS': '0x0', 11:38:09 INFO - 'XPC_SERVICE_NAME': '0', 11:38:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:09 INFO - Downloading/unpacking psutil>=3.1.1 11:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:09 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 11:38:09 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 11:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:38:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:13 INFO - Installing collected packages: psutil 11:38:13 INFO - Running setup.py install for psutil 11:38:13 INFO - building 'psutil._psutil_osx' extension 11:38:13 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 11:38:13 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 11:38:13 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 11:38:14 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 11:38:14 INFO - building 'psutil._psutil_posix' extension 11:38:14 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 11:38:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:38:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:38:14 INFO - ^ 11:38:14 INFO - 1 warning generated. 11:38:14 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 11:38:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:38:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:38:14 INFO - Successfully installed psutil 11:38:14 INFO - Cleaning up... 11:38:14 INFO - Return code: 0 11:38:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11: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')]} 11:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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')]} 11:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e58eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e591768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff23bd9e000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36cd30>, '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 0x10e293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e361be8>, '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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11: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 mozsystemmonitor==0.3 11:38:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.92ecOg7Q2x/Render', 11:38:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:14 INFO - 'HOME': '/Users/cltbld', 11:38:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:14 INFO - 'LOGNAME': 'cltbld', 11:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:14 INFO - 'MOZ_NO_REMOTE': '1', 11:38:14 INFO - 'NO_EM_RESTART': '1', 11:38:14 INFO - 'PAGER': '/bin/cat', 11:38:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:14 INFO - 'PWD': '/builds/slave/test', 11:38:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:14 INFO - 'SHELL': '/bin/bash', 11:38:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vYHS1u4H5j/Listeners', 11:38:14 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:38:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:14 INFO - 'USER': 'cltbld', 11:38:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:14 INFO - 'XPC_FLAGS': '0x0', 11:38:14 INFO - 'XPC_SERVICE_NAME': '0', 11:38:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 11: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 11: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 11: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 11: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 11: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 11: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 11:38:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:38:17 INFO - Installing collected packages: mozsystemmonitor 11:38:17 INFO - Running setup.py install for mozsystemmonitor 11:38:17 INFO - Successfully installed mozsystemmonitor 11:38:17 INFO - Cleaning up... 11:38:17 INFO - Return code: 0 11:38:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:38:17 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')]} 11:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:17 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')]} 11:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:17 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 0x10e58eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e591768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff23bd9e000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36cd30>, '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 0x10e293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e361be8>, '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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:38:17 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 11:38:17 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 11:38:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.92ecOg7Q2x/Render', 11:38:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:17 INFO - 'HOME': '/Users/cltbld', 11:38:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:17 INFO - 'LOGNAME': 'cltbld', 11:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:17 INFO - 'MOZ_NO_REMOTE': '1', 11:38:17 INFO - 'NO_EM_RESTART': '1', 11:38:17 INFO - 'PAGER': '/bin/cat', 11:38:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:17 INFO - 'PWD': '/builds/slave/test', 11:38:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:17 INFO - 'SHELL': '/bin/bash', 11:38:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vYHS1u4H5j/Listeners', 11:38:17 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:38:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:17 INFO - 'USER': 'cltbld', 11:38:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:17 INFO - 'XPC_FLAGS': '0x0', 11:38:17 INFO - 'XPC_SERVICE_NAME': '0', 11:38:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:17 INFO - Downloading/unpacking jsonschema==2.5.1 11: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 11: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 11: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 11: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 11: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 11: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 11:38:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:38:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:38:20 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 11:38:20 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 11:38:20 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 11:38:20 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 11:38:20 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 11:38:20 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 11:38:20 INFO - Downloading functools32-3.2.3-2.tar.gz 11:38:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:38:21 INFO - warning: no files found matching '*.txt' 11:38:21 INFO - no previously-included directories found matching 'build' 11:38:21 INFO - no previously-included directories found matching 'dist' 11:38:21 INFO - no previously-included directories found matching '.git*' 11:38:21 INFO - Installing collected packages: jsonschema, functools32 11:38:21 INFO - Running setup.py install for functools32 11:38:21 INFO - warning: no files found matching '*.txt' 11:38:21 INFO - no previously-included directories found matching 'build' 11:38:21 INFO - no previously-included directories found matching 'dist' 11:38:21 INFO - no previously-included directories found matching '.git*' 11:38:21 INFO - Successfully installed jsonschema functools32 11:38:21 INFO - Cleaning up... 11:38:21 INFO - Return code: 0 11:38:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:38:21 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')]} 11:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:21 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')]} 11:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x10e58eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e591768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff23bd9e000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36cd30>, '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 0x10e293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e361be8>, '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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:38:21 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 11:38:21 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 11:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.92ecOg7Q2x/Render', 11:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:21 INFO - 'HOME': '/Users/cltbld', 11:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:21 INFO - 'LOGNAME': 'cltbld', 11:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:21 INFO - 'MOZ_NO_REMOTE': '1', 11:38:21 INFO - 'NO_EM_RESTART': '1', 11:38:21 INFO - 'PAGER': '/bin/cat', 11:38:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:21 INFO - 'PWD': '/builds/slave/test', 11:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:21 INFO - 'SHELL': '/bin/bash', 11:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vYHS1u4H5j/Listeners', 11:38:21 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:21 INFO - 'USER': 'cltbld', 11:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:21 INFO - 'XPC_FLAGS': '0x0', 11:38:21 INFO - 'XPC_SERVICE_NAME': '0', 11:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:38:21 INFO - Cleaning up... 11:38:21 INFO - Return code: 0 11:38:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:38:21 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')]} 11:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:21 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')]} 11:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x10e58eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e591768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff23bd9e000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36cd30>, '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 0x10e293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e361be8>, '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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:38:21 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 11:38:21 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 11:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.92ecOg7Q2x/Render', 11:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:21 INFO - 'HOME': '/Users/cltbld', 11:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:21 INFO - 'LOGNAME': 'cltbld', 11:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:21 INFO - 'MOZ_NO_REMOTE': '1', 11:38:21 INFO - 'NO_EM_RESTART': '1', 11:38:21 INFO - 'PAGER': '/bin/cat', 11:38:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:21 INFO - 'PWD': '/builds/slave/test', 11:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:21 INFO - 'SHELL': '/bin/bash', 11:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vYHS1u4H5j/Listeners', 11:38:21 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:21 INFO - 'USER': 'cltbld', 11:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:21 INFO - 'XPC_FLAGS': '0x0', 11:38:21 INFO - 'XPC_SERVICE_NAME': '0', 11:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:21 INFO - Downloading/unpacking blobuploader==1.2.4 11:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:21 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 11:38:21 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 11:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:24 INFO - Downloading blobuploader-1.2.4.tar.gz 11:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:38:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:24 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 11:38:24 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 11:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:38:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11: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 11: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 11: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 11: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 11: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 11: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 11:38:25 INFO - Downloading docopt-0.6.1.tar.gz 11:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:38:25 INFO - Installing collected packages: blobuploader, requests, docopt 11:38:25 INFO - Running setup.py install for blobuploader 11:38:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:38:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:38:25 INFO - Running setup.py install for requests 11:38:26 INFO - Running setup.py install for docopt 11:38:26 INFO - Successfully installed blobuploader requests docopt 11:38:26 INFO - Cleaning up... 11:38:26 INFO - Return code: 0 11:38:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:38:26 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')]} 11:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:26 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')]} 11:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:26 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 0x10e58eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e591768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff23bd9e000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36cd30>, '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 0x10e293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e361be8>, '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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:38:26 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 11:38:26 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 11:38:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.92ecOg7Q2x/Render', 11:38:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:26 INFO - 'HOME': '/Users/cltbld', 11:38:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:26 INFO - 'LOGNAME': 'cltbld', 11:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:26 INFO - 'MOZ_NO_REMOTE': '1', 11:38:26 INFO - 'NO_EM_RESTART': '1', 11:38:26 INFO - 'PAGER': '/bin/cat', 11:38:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:26 INFO - 'PWD': '/builds/slave/test', 11:38:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:26 INFO - 'SHELL': '/bin/bash', 11:38:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vYHS1u4H5j/Listeners', 11:38:26 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:38:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:26 INFO - 'USER': 'cltbld', 11:38:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:26 INFO - 'XPC_FLAGS': '0x0', 11:38:26 INFO - 'XPC_SERVICE_NAME': '0', 11:38:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:38:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-PuJ1zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:38:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-FWbHwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:38:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-WoGjtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:38:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-5RE2Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:38:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-xG9QZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:38:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-bVg9MQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:38:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-QPd5s4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:38:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-DZMt82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:38:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-gbnsvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:38:27 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-csuiFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:38:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-N9s8fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:38:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-bDhhJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:38:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-EWCJyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:38:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-SxnZmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-hcnEZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:38:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-96DT2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:38:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:38:28 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Mzjxp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:38:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:38:28 INFO - Running setup.py install for manifestparser 11:38:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:38:28 INFO - Running setup.py install for mozcrash 11:38:29 INFO - Running setup.py install for mozdebug 11:38:29 INFO - Running setup.py install for mozdevice 11:38:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:38:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:38:29 INFO - Running setup.py install for mozfile 11:38:29 INFO - Running setup.py install for mozhttpd 11:38:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:38:29 INFO - Running setup.py install for mozinfo 11:38:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:38:29 INFO - Running setup.py install for mozInstall 11:38:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:38:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:38:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:38:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:38:29 INFO - Running setup.py install for mozleak 11:38:30 INFO - Running setup.py install for mozlog 11:38:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:38:30 INFO - Running setup.py install for moznetwork 11:38:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:38:30 INFO - Running setup.py install for mozprocess 11:38:30 INFO - Running setup.py install for mozprofile 11:38:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:38:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:38:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:38:30 INFO - Running setup.py install for mozrunner 11:38:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:38:30 INFO - Running setup.py install for mozscreenshot 11:38:31 INFO - Running setup.py install for moztest 11:38:31 INFO - Running setup.py install for mozversion 11:38:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:38:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:38:31 INFO - Cleaning up... 11:38:31 INFO - Return code: 0 11:38:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:38:31 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')]} 11:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:31 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')]} 11:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:31 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 0x10e58eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e591768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff23bd9e000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36cd30>, '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 0x10e293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e361be8>, '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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:38:31 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 11:38:31 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 11:38:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.92ecOg7Q2x/Render', 11:38:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:31 INFO - 'HOME': '/Users/cltbld', 11:38:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:31 INFO - 'LOGNAME': 'cltbld', 11:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:31 INFO - 'MOZ_NO_REMOTE': '1', 11:38:31 INFO - 'NO_EM_RESTART': '1', 11:38:31 INFO - 'PAGER': '/bin/cat', 11:38:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:31 INFO - 'PWD': '/builds/slave/test', 11:38:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:31 INFO - 'SHELL': '/bin/bash', 11:38:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vYHS1u4H5j/Listeners', 11:38:31 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:38:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:31 INFO - 'USER': 'cltbld', 11:38:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:31 INFO - 'XPC_FLAGS': '0x0', 11:38:31 INFO - 'XPC_SERVICE_NAME': '0', 11:38:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:38:31 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-zi7jgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:38:31 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)) 11:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:38:31 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ch_XUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:38:31 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)) 11:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:38:31 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-L4jY6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:38:31 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)) 11:38:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:38:31 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-q9HIWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:38:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-wVqUIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:38:32 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)) 11:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:38:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-7tO9c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:38:32 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)) 11:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:38:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-n1RkUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:38:32 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)) 11:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:38:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-kxD1ev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:38:32 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)) 11:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:38:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-IrMGq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:38:32 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)) 11:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:38:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-xgzNc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:38:32 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)) 11:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:38:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-t7pvKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:38:32 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)) 11:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:38:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-uLOZGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:38:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 11:38:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:38:32 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-gkO9Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:38:33 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)) 11:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:38:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-TUFou2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:38:33 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)) 11:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-6A5Lms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:38:33 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)) 11:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:38:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ahXreb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:38:33 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)) 11:38:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:38:33 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-GYmTl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:38:33 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)) 11:38:33 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)) 11:38:33 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)) 11:38:33 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)) 11:38:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:38:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:38:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:38:33 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 11:38:33 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 11:38:33 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 11:38:33 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 11:38:33 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 11:38:33 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 11:38:36 INFO - Downloading blessings-1.6.tar.gz 11:38:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:38:36 INFO - Installing collected packages: blessings 11:38:36 INFO - Running setup.py install for blessings 11:38:36 INFO - Successfully installed blessings 11:38:36 INFO - Cleaning up... 11:38:36 INFO - Return code: 0 11:38:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:38:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:38:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:38:36 INFO - Reading from file tmpfile_stdout 11:38:36 INFO - Current package versions: 11:38:36 INFO - blessings == 1.6 11:38:36 INFO - blobuploader == 1.2.4 11:38:36 INFO - docopt == 0.6.1 11:38:36 INFO - functools32 == 3.2.3-2 11:38:36 INFO - jsonschema == 2.5.1 11:38:36 INFO - manifestparser == 1.1 11:38:36 INFO - mozInstall == 1.12 11:38:36 INFO - mozcrash == 1.0 11:38:36 INFO - mozdebug == 0.1 11:38:36 INFO - mozdevice == 0.49 11:38:36 INFO - mozfile == 1.2 11:38:36 INFO - mozhttpd == 0.7 11:38:36 INFO - mozinfo == 0.9 11:38:36 INFO - mozleak == 0.1 11:38:36 INFO - mozlog == 3.4 11:38:36 INFO - moznetwork == 0.27 11:38:36 INFO - mozprocess == 0.23 11:38:36 INFO - mozprofile == 0.28 11:38:36 INFO - mozrunner == 6.13 11:38:36 INFO - mozscreenshot == 0.1 11:38:36 INFO - mozsystemmonitor == 0.3 11:38:36 INFO - moztest == 0.8 11:38:36 INFO - mozversion == 1.4 11:38:36 INFO - psutil == 3.1.1 11:38:36 INFO - requests == 1.2.3 11:38:36 INFO - wsgiref == 0.1.2 11:38:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:38:36 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')]} 11:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:36 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')]} 11:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:36 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 0x10e58eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e591768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff23bd9e000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36cd30>, '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 0x10e293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e361be8>, '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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:38:36 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 11:38:36 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 11:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.92ecOg7Q2x/Render', 11:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:36 INFO - 'HOME': '/Users/cltbld', 11:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:36 INFO - 'LOGNAME': 'cltbld', 11:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:36 INFO - 'MOZ_NO_REMOTE': '1', 11:38:36 INFO - 'NO_EM_RESTART': '1', 11:38:36 INFO - 'PAGER': '/bin/cat', 11:38:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:36 INFO - 'PWD': '/builds/slave/test', 11:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:36 INFO - 'SHELL': '/bin/bash', 11:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vYHS1u4H5j/Listeners', 11:38:36 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:36 INFO - 'USER': 'cltbld', 11:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:36 INFO - 'XPC_FLAGS': '0x0', 11:38:36 INFO - 'XPC_SERVICE_NAME': '0', 11:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:36 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)) 11:38:36 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)) 11:38:36 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)) 11:38:36 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)) 11:38:36 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)) 11:38:36 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)) 11:38:36 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)) 11:38:36 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)) 11:38:36 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)) 11:38:36 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)) 11:38:36 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)) 11:38:36 INFO - Cleaning up... 11:38:36 INFO - Return code: 0 11:38:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:38:36 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')]} 11:38:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:38:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:36 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')]} 11:38:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:38:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:38:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x10e58eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e591768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff23bd9e000>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e36cd30>, '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 0x10e293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e361be8>, '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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 11:38:36 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 11:38:36 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 11:38:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.92ecOg7Q2x/Render', 11:38:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:38:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:38:36 INFO - 'HOME': '/Users/cltbld', 11:38:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:38:36 INFO - 'LOGNAME': 'cltbld', 11:38:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:38:36 INFO - 'MOZ_NO_REMOTE': '1', 11:38:36 INFO - 'NO_EM_RESTART': '1', 11:38:36 INFO - 'PAGER': '/bin/cat', 11:38:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:38:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:38:36 INFO - 'PWD': '/builds/slave/test', 11:38:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:38:36 INFO - 'SHELL': '/bin/bash', 11:38:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vYHS1u4H5j/Listeners', 11:38:36 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:38:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:38:36 INFO - 'USER': 'cltbld', 11:38:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:38:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:38:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:38:36 INFO - 'XPC_FLAGS': '0x0', 11:38:36 INFO - 'XPC_SERVICE_NAME': '0', 11:38:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:38:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:38:37 INFO - Cleaning up... 11:38:37 INFO - Return code: 0 11:38:37 INFO - Running post-action listener: _resource_record_post_action 11:38:37 INFO - Running post-action listener: _start_resource_monitoring 11:38:37 INFO - Starting resource monitoring. 11:38:37 INFO - [mozharness: 2017-01-02 19:38:37.270759Z] Finished create-virtualenv step (success) 11:38:37 INFO - [mozharness: 2017-01-02 19:38:37.271709Z] Running install step. 11:38:37 INFO - Running pre-action listener: _resource_record_pre_action 11:38:37 INFO - Running main action method: install 11:38:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:38:37 INFO - Reading from file tmpfile_stdout 11:38:37 INFO - Detecting whether we're running mozinstall >=1.0... 11:38:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:38:37 INFO - Reading from file tmpfile_stdout 11:38:37 INFO - Output received: 11:38:37 INFO - Usage: mozinstall [options] installer 11:38:37 INFO - Options: 11:38:37 INFO - -h, --help show this help message and exit 11:38:37 INFO - -d DEST, --destination=DEST 11:38:37 INFO - Directory to install application into. [default: 11:38:37 INFO - "/builds/slave/test"] 11:38:37 INFO - --app=APP Application being installed. [default: firefox] 11:38:37 INFO - mkdir: /builds/slave/test/build/application 11:38:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 11:38:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 11:38:59 INFO - Reading from file tmpfile_stdout 11:38:59 INFO - Output received: 11:38:59 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:38:59 INFO - Running post-action listener: _resource_record_post_action 11:38:59 INFO - [mozharness: 2017-01-02 19:38:59.787100Z] Finished install step (success) 11:38:59 INFO - [mozharness: 2017-01-02 19:38:59.787264Z] Running run-tests step. 11:38:59 INFO - Running pre-action listener: _resource_record_pre_action 11:38:59 INFO - Running main action method: run_tests 11:38:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:38:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:38:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:38:59 INFO - 2017-01-02 11:38:59.801 screenresolution[1637:8956] starting screenresolution argv=screenresolution get 11:38:59 INFO - 2017-01-02 11:38:59.804 screenresolution[1637:8956] Display 0: 1600x1200x32@60 11:38:59 INFO - 2017-01-02 11:38:59.810 screenresolution[1638:8959] starting screenresolution argv=screenresolution list 11:38:59 INFO - Available Modes on Display 0 11:38:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:38:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:38:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:38:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:39:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:39:00 INFO - Intel Iris: 11:39:00 INFO - Chipset Model: Intel Iris 11:39:00 INFO - Type: GPU 11:39:00 INFO - Bus: Built-In 11:39:00 INFO - VRAM (Dynamic, Max): 1536 MB 11:39:00 INFO - Vendor: Intel (0x8086) 11:39:00 INFO - Device ID: 0x0a2e 11:39:00 INFO - Revision ID: 0x0009 11:39:00 INFO - Displays: 11:39:00 INFO - Display: 11:39:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:39:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:39:00 INFO - Display Serial Number: 1600x1200 60 11:39:00 INFO - Main Display: Yes 11:39:00 INFO - Mirror: Off 11:39:00 INFO - Online: Yes 11:39:00 INFO - Rotation: Supported 11:39:00 INFO - Return code: 0 11:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:39:00 INFO - Python 2.7.3 11:39:00 INFO - Return code: 0 11:39:00 INFO - grabbing minidump binary from tooltool 11:39: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')]} 11:39:00 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 0x10e36cd30>, '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 0x10e293db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e361be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:39:00 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 11:39:00 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 11:39:00 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 11:39:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:39:00 INFO - Return code: 0 11:39:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:39:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:39:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:39:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:39:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:39:00 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/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 11:39:00 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/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --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 11:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.92ecOg7Q2x/Render', 11:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:39:00 INFO - 'HOME': '/Users/cltbld', 11:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:39:00 INFO - 'LOGNAME': 'cltbld', 11:39:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:39:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:39:00 INFO - 'MOZ_NO_REMOTE': '1', 11:39:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:39:00 INFO - 'NO_EM_RESTART': '1', 11:39:00 INFO - 'PAGER': '/bin/cat', 11:39:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:39:00 INFO - 'PWD': '/builds/slave/test', 11:39:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:39:00 INFO - 'SHELL': '/bin/bash', 11:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vYHS1u4H5j/Listeners', 11:39:00 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 11:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:39:00 INFO - 'USER': 'cltbld', 11:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:39:00 INFO - 'XPC_FLAGS': '0x0', 11:39:00 INFO - 'XPC_SERVICE_NAME': '0', 11:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:39:00 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/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--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 11:39:00 INFO - mozversion application_buildid: 20170102105519 11:39:00 INFO - mozversion application_changeset: c91249f41e3766274131a84f9157a4d9d9949520 11:39:00 INFO - mozversion application_display_name: Nightly 11:39:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:39:00 INFO - mozversion application_name: Firefox 11:39:00 INFO - mozversion application_remotingname: firefox 11:39:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:39:00 INFO - mozversion application_vendor: Mozilla 11:39:00 INFO - mozversion application_version: 53.0a1 11:39:00 INFO - mozversion platform_buildid: 20170102105519 11:39:00 INFO - mozversion platform_changeset: c91249f41e3766274131a84f9157a4d9d9949520 11:39:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:39:00 INFO - mozversion platform_version: 53.0a1 11:39:00 INFO - using testdate: 1483385940 11:39:00 INFO - actual date: 1483385940 11:39:00 INFO - starting webserver on 'localhost:49236' 11:39:00 INFO - SUITE-START | Running 2 tests 11:39:00 INFO - TEST-START | dromaeo_css 11:39:00 INFO - operating with platform_type : mac_ 11:39:00 INFO - Initialising browser for dromaeo_css test... 11:39:00 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpqq81QQ/profile http://localhost:49236/getInfo.html) 11:39:00 INFO - PROCESS | 1648 | 1483385940970 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 11:39:03 INFO - PROCESS | 1648 | 2017-01-02 11:39:03.401 plugin-container[1650:9125] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 11:39:03 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:39:03 INFO - PROCESS | 1648 | 2017-01-02 11:39:03.404 plugin-container[1650:9125] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c07, name = 'com.apple.CFPasteboardClient' 11:39:03 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:39:03 INFO - PROCESS | 1648 | 2017-01-02 11:39:03.404 plugin-container[1650:9125] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:39:03 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 11:39:03 INFO - PROCESS | 1648 | colorDepth:24 11:39:03 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 11:39:03 INFO - PROCESS | 1648 | __metrics 11:39:03 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 11:39:04 INFO - TEST-INFO | 1648: exit 0 11:39:04 INFO - Browser initialized. 11:39:04 INFO - Running cycle 1/1 for dromaeo_css test... 11:39:04 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpqq81QQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:39:06 INFO - PROCESS | 1652 | 2017-01-02 11:39:06.885 plugin-container[1653:9249] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443b, name = 'com.apple.tsm.portname' 11:39:06 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:39:06 INFO - PROCESS | 1652 | 2017-01-02 11:39:06.886 plugin-container[1653:9249] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x470f, name = 'com.apple.CFPasteboardClient' 11:39:06 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:39:06 INFO - PROCESS | 1652 | 2017-01-02 11:39:06.886 plugin-container[1653:9249] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:39:16 INFO - PROCESS | 1652 | RSS: Main: 232075264 11:39:16 INFO - PROCESS | 1652 | 11:40:06 INFO - PROCESS | 1652 | 1483386006215 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 11:42:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 11:42:21 INFO - PROCESS | 1652 | RSS: Main: 260005888 11:42:21 INFO - PROCESS | 1652 | 11:44:04 INFO - PROCESS | 1652 | ************************* 11:44:04 INFO - PROCESS | 1652 | A coding exception was thrown and uncaught in a Task. 11:44:04 INFO - PROCESS | 1652 | 11:44:04 INFO - PROCESS | 1652 | Full message: ReferenceError: fetch is not defined 11:44:04 INFO - PROCESS | 1652 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 11:44:04 INFO - PROCESS | 1652 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 11:44:04 INFO - PROCESS | 1652 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 11:44:04 INFO - PROCESS | 1652 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:44:04 INFO - PROCESS | 1652 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:44:04 INFO - PROCESS | 1652 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:44:04 INFO - PROCESS | 1652 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 11:44:04 INFO - PROCESS | 1652 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 11:44:04 INFO - PROCESS | 1652 | TaskImpl@resource://gre/modules/Task.jsm:277:3 11:44:04 INFO - PROCESS | 1652 | asyncFunction@resource://gre/modules/Task.jsm:252:14 11:44:04 INFO - PROCESS | 1652 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 11:44:04 INFO - PROCESS | 1652 | 11:44:04 INFO - PROCESS | 1652 | ************************* 11:45:23 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 11:45:24 INFO - PROCESS | 1652 | RSS: Main: 263544832 11:45:24 INFO - PROCESS | 1652 | 11:48:26 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 11:48:27 INFO - PROCESS | 1652 | RSS: Main: 271101952 11:48:27 INFO - PROCESS | 1652 | 11:51:28 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 11:51:29 INFO - PROCESS | 1652 | RSS: Main: 267300864 11:51:29 INFO - PROCESS | 1652 | 11:54:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 11:54:32 INFO - PROCESS | 1652 | RSS: Main: 271933440 11:54:32 INFO - PROCESS | 1652 | 11:57:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 11:57:35 INFO - PROCESS | 1652 | RSS: Main: 274591744 11:57:35 INFO - PROCESS | 1652 | 11:57:35 INFO - PROCESS | 1652 | __start_tp_report 11:57:35 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 11:57:35 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 11:57:35 INFO - PROCESS | 1652 | |i|pagename|runs| 11:57:35 INFO - PROCESS | 1652 | |0;dojo.html;3356.630770615232;3375.088726043968;3398.5242066110764;3400.200952776097;3406.6763657452534;5633.126865335875;5660.575456840738;5682.516986056185;5683.772649094041;5687.374388817227;5489.505944464997;5624.268845050148;5644.774209031634;5672.602917795756;5683.630564013336;5027.899442011158;5133.281340612327;5156.432792392834;5166.07010738067;5185.24813901984;4465;5136.563392111656;5232.764525596357;5241.213817927303;5250;5178.689278643294;5224.503672151159;5225.320708307915;5239.161734122541;5253.711045892474;5010.0981823271795;5011.749412529359;5054.974725126388;5086.46592107827;5147.613928955343;5095.694258344474;5172.663776854492;5177.948220517785;5182.300389447451;5193.766280517386;4319.676024298159;5542.667439953575;5589.888202235973;5701.2018317435595;5712.1431785232135;6050.9410853100535;6077.878442431171;6197.256329240475;6205.317415084337;6226.62640241587;6132.233136608343;6185.257769067695;6188.040853667689;6201.596896201732;6205.596636218676;5747.626404283708;5758.049921762862;5765.365809760923;5768.798092066758;5785.190073389729;6140.385961403824;6295.087212354183;6313.526485513605;6313.715882785285;6321.810345689637;5967.880642387128;6008.939910600925;6017.819465415957;6054.001089820218;6111.877762444727;6147.44672979425;6148.754049837957;6148.862460444832;6165.290991536031;6268.937310626835;4369.737815731066;4499.730016199039;5233.71214583194;5987.952108381016;6185.350538193515;5676.545876329884;6136.12084543884;6160.784372546939;6169.5064394848305;6219.844503887349;4942.5304596063315;4950.950490495049;4951.529604687549;4952.430470495867;4996.575291100297;4299.5270520243375;4353.978230108829;4354.150940566559;4355.7822108894425;4429.379886815848;5879.088741245114;5886.970565147147;5928.318243401977;5932.851678708067;5958.612690175125;6237.407446292595;6257.405546473078;6261.9373806262265;6266.279377871603;6297.244330680348;5745.712714364265;5764.221830052973;5884.588078834526;5909.793157239562;5919.260092488439;5346.198070289488;5361.490658387447;5379.6234263601955;5385.676859388449;5410.215518749759;6297.653629050446;6304.401081897213;6322.0200868865395;6323.715432805627;6339.778107766206;6170.845728856814;6188.226471691039;6271.96864015677;6275.435210831047;6282.1519094921605;6237.064440333987;6258.342873998165;6259.3427690091885;6322;6330.272018717907;6141.539384546088;6199.752009919733;6202.658853762906;6218.502519798315;6228.626282423069;6231.844203894939;6238.189035425366;6251.374862513894;6259.718312676032;6267.2165979252595;5970.97014514942;5973.104034394875;6072.1498990140535;6116.480099191618;6123;5833.9416605835095;5993.460588547052;6027.547933905063;6064.423879731418;6072.757089716539;5733.713314334183;5842.2405087338375;5861.3845546217035;5893.410658934073;6023.367546407564;5994.700264986646;6035.849103772441;6065.727042283196;6085.4523092921845;6100.481459076028;5991.041433370639;6003.129546215861;6017.428344307284;6046.2139921809885;6068.4841788448475 11:57:35 INFO - PROCESS | 1652 | |1;ext.html;461.7829620078562;467.59319392128833;468.4425533614998;478.2061777449434;535.1597991153889;29012.854935725318;39428.80285598572;39429.211415771664;39493.210135797264;39522;40042.399364009565;40812.59187408125;40875.386869196984;40921.97695057618;40990.59009409905;8394;8490.575471226444;9082.182603565661;9173;9529.142377186052;11166.385848778315;11432.085433165368;11433.485493152828;11462;11466.656000320003;11388.373639449826;11452.255603385753;11476.540938362456;11498.367589782558;11517.48171332292;11414.600488982887;11454.427278636118;11457.083433325397;11466.942665286704;11481.655550333504;11375.31748095117;11387.430628468626;11420.143489238257;11421.885781142166;11447.255928364713;39875.800620997;39938.80183594497;40170.39744403836;40362;40377.79811100926;3956.3274243378696;3986.22268657609;3992.441058251847;4026.6376026157495;4029.315016447211;29703.851480742673;30385;30431;30537.847310763525;30860.84569577138;3131.906042818719;3229.160418291238;3258.820764857932;3301.224212310105;3303.7357011439026;452853.73573132255;456541;456742;458871;461949;60172.292246849;60438.39561604416;60550;60565;60756.69621651952;62711.6864415675;62921;63499.142538585875;63644.68177659082;63757.04364434537;15674.608134796721;15861.444849430445;15874.20628968547;15887.52337429879;15888.76166857498;11085.944570277097;11346.602868899548;12061.216020958609;12340.938295308466;12346.753064938652;17095.145242737814;17099.74350384745;17127.14364281781;17196.022457417308;17227.96632202072;5691.800786972436;6756.425703815133;6823.38589526935;6841.521093523405;6860.622665753432;821.6918655504186;826.6858593734343;831.746317373207;834.3033566971646;854.5342788180457;28762;29201.85399072991;29438;29455.85272073626;30086.398272034876;1010.7877345757327;1046.5447530324334;1046.6179844356907;1057.2282233969245;1142.3146112332533;12699.873001270054;14749.926250368679;15310.540683779505;15478.993865398714;15685.764713529306;588355;588885;594306;595302;596785;58646.41353586495;58672;58732.7063364689;58822.70588647029;58941.23176304718;1335.6794369351285;1375.532319011521;1394.0659757961987;1394.2331717555303;1394.4840409048513;28372;28945.710542894303;29005.709942901143;29576.704232958255;30312.393752124393;49303.753481232365;49742.99999999855;49860.75348116326;49899.25151122809;49976;419368;420317;422071;422300;422700;23252.41868953222;23938.80305984659;23993.52012959696;24331.39171520726;39614.801925990185;31911.68088319087;39710.80144599258;40006.39990400204;40982.79508602438;41151.97120072022;25482.362940926625;26818.865905670347;27159.456810863277;34279.82860085684;35190.648093518736;26908.461830762884;32447.02658920236;33645.66354336425;33959.66040339565;34690.47964280487;27273;32247.838760806048;32363.705451781665;32880.50679239861;33085.66914330826;23449;28801.711982879904;30527.084187473523;30537.54193687052;30623.846880765454;16766.413175538797;22453.550928981003;22830.086796527954;23319.76680233176;23333.883330583238 11:57:35 INFO - PROCESS | 1652 | |2;jquery.html;299.4639595124727;344.22892720306515;359.2007782683528;369.42185479724236;388.99250940065224;18780;19336;19965.60068798625;20169.59660806783;20203.696944545805;18923.81076189241;19577.51056223595;19607.41177764666;19774.604507909833;20043.899780501077;5088;5299.364076310848;5305.3898801637915;5308.628396012281;5319.867003324909;4441.777911104448;5902.291724993007;5955.094369801665;6031.547633927451;6037.7584896604085;5092.541671249587;5751.884962300752;5895.233619629442;6003.969980150093;6015.909761353583;5856.443637854397;5932.911006334908;5941.346451890288;5948.940510594882;5961.076033214858;5438.83683489496;5661.5187709044785;5740.397258287861;5744.741486633112;5765.654060756368;12976.35118244084;13049.739005219843;13105.344732763324;13113.213207207598;13126.803097953538;2844.87198076085;2902.8258304501796;2937.500624893773;2944.617199764017;2956.881724731008;9259.212966897821;9774.609015639366;9974.551145198484;10145.594176232942;10274.948625256826;1768.4164225805453;1783.5362805670488;1793.4171394296907;1796.4431026381862;1823.8996855172961;91853;119641.80358196393;122945;123547.5290494194;124405.75594244032;8923.509206993547;11310.943445282886;11489.597864074718;11495.011297062823;11502.907223813725;14349.426022959173;14501.782473262698;14537.563873083824;14539.054961427473;14578;8060.717874874468;8288.129746376664;8305.916940830635;8425.241728244488;8435;6560.245571759213;6575.572587781779;8083.555404452812;8236;8253.628586713492;3672.485851980725;4503.504614492404;4519.41247637805;4519.661025423106;4577.839775607904;1901.8858868467937;1927.816857398545;1931.0923865783059;1931.4837852286169;1932.6617841877614;824.6536454689045;836.4939211776909;853.6670698427494;854.1245223645689;870.9042005379404;18938;19310.03449827503;19445.513862153275;19542.316018939553;19854.70217946732;745.6346390268837;860.4579115157536;863.3567991846115;890.4790697441939;894.1371576428647;8585.65657373698;9886.357386769838;10244.948775256225;10257.33327333721;10297.74255643615;513356.43321783154;547519;547640;550979;558766;78970;80828;81145.18854811376;122184.38907805581;125136.37431812783;975.8243516167158;999.6751055906714;1031.9432431216205;1043.4313299251926;1044.4046893270763;16686;17449.825501745327;17886.28454861843;18008.909955450137;18548.629027419647;42914.35628465638;46801.063978720915;51440.74279628578;51463.742681286356;52068.69828254324;73135.63432182805;74642.62678686572;75168.62415687887;75291;76186;7280.5438912216705;7438.66104101267;7902.604869756604;8024.558649274112;8121.512709237465;8957.193852553302;9886.901130988597;10091.88070505202;10798.082163016232;12944.676383090498;10789.514471848628;11003.504842281956;11403.714907127389;11591.942040289745;11594.594189203337;11013.229073965065;11141.554337826396;11207.66377008691;11228.214025018171;11383.487743051417;9621.422714637145;11432.714182145513;11572.24780389272;11579.594714184963;11643.184977051525;7781.06627204739;7882.290593846581;8003;8236.794080147805;8285.295749861089;8807.295416366547;10568.365898046142;10677.359358438518;11221.775564488828;11338.319700817978 11:57:35 INFO - PROCESS | 1652 | |3;mootools.html;1369.972600547989;1397.0988712280573;1408.0706733555855;1410.5204230561608;1418.538974833179;6456.515761317903;7462.888056679154;7696;8238.052623948248;8370.246677798998;7886.132525422199;8092.352611791057;8128.878066829002;8278.95860520698;8309.878166447528;2256.187772401938;2310.3992961829877;2316.721993360799;2317.212147869724;2317.44381348476;2050.507878109258;2131.968020479694;2280.813976732098;2315.2822624986225;2329.6039673255586;2202.592520383734;2271.1937262271904;2280.065173278956;2283.0297123722435;2294.139697613395;2231.94420139497;2238.183063181935;2263.6830843681896;2286.7141607299086;2324.651302304651;2316.2703748319227;2327.94180145496;2356.670066190735;2356.7525409832065;2362.433016076129;8254.42219044667;8319.459235149756;8372.204640559137;8387.119352467964;8394.45436046655;4996.300517927493;5151;5160.483951604847;5162.5095615916425;5171;3285.444450804206;3421.367047096295;3424.3493736190294;3485.8954231372845;3486.1981744198724;1149.7987852125927;1176.8764279750674;1187.068151501076;1225.2954551133134;1231.8891299783063;10701.518431670516;10708.625198118107;10735.248532602722;10767.515461804238;10801.297915635458;4312.784360781949;4568.33759104928;4616.630669546428;4630.652701047435;4657.5575320344515;9223.769405764775;9277.443353398818;9341.953290233641;9368.67209647659;9369.953150234342;5081.822136225214;5156.664816786897;5157.974210128926;5179.2749015137915;5204.817831375959;4543.909461729228;4626.144163329727;4636.165490211727;4710.976445117821;4718.174319494075;3225.7580681448985;3344.8662053518074;3371.8482668279985;3837.865674701372;3899.5515515716056;958.9760255993516;1193.1051711216587;1243.8383010208615;1250.3810613746073;1258.157034786695;694.5416025423197;751.812046988253;757.6476938223752;776.8329809091073;801.30686955784;5380.7309634518115;5441.918371224435;5545.942720763691;5654.3497497788285;5681.886362272731;898.0974121008345;901.364538000708;903.4759839293195;916.3814425262921;940.7789169545151;3668.6331366863633;3758.0980564664283;3808.295465338921;3810.3141434541494;3819.6753275971296;9169.083091690778;9614.134727874525;9694.36986595869;9822.754431139136;9890.901090988998;9778.9022109778;9781.266405019653;9800.55897484615;9813.950930245446;9819.410835349901;6786.151731033621;7444.962775186089;7652;7749.7287594933905;7758.92241077582;5005.873678422471;5389.703566303734;5412.648177868426;5470.589705772162;5537.584681149011;7865;9008.144226298491;9049.90950090517;9141.222996045411;9227.261819054595;9149.31380146505;9184.30090433272;9222.907770922206;9268.768280793034;9300.488473134043;6921.550099243533;7011.6494175292055;7071.752488662872;7093.716251350094;7101.786946391617;7489.438292128003;7761.340286075747;7845.9215407845195;7853.1361550228285;7868.331191848757;5590.86022849432;6439.615482671248;7053.259407762111;7085.50401471892;7180.174279957663;6877.828054298682;6936.861262774817;6969.16370035599;7032.085828842218;7067.929320706727;6262.937370626236;6283.842903927439;6307.306196318493;6351.68241587928;6366.427021568081;3765.566959799658;4113.91772164549;4449.377087207728;4481.641468682433;4580.633549316113;4724.645651576215;4738.763061846825;4791.544803243686;4799.112164249625;4899.3385892904 11:57:35 INFO - PROCESS | 1652 | |4;prototype.html;272.6687075203627;351.4552443712245;355.65501463580324;358.3746362597268;361.98190090495467;5185.844424667256;5241.449647786984;5305.389880163782;5417;5432.076546987012;5090.974545127269;5312.73436328183;5315.468453154683;5328.49379308966;5332.786688532464;4147.502299724029;4189.518205406372;4190.790460476979;4197.916041679165;4202.243596152692;4019.3167161582455;4162.729422587538;4179.352200408926;4189.6438802701805;4215.683823713219;3747.681447077002;3955.7230993830444;4031.8588849390276;4055.9391609125887;4133.462649855514;3499.6500349964926;4073.207788573033;4099.97950010248;4126.628603425706;4168.499780026386;3666.5233519642543;3674.9448758268645;3676.3933950898067;3681.7238707097076;3707.9629203707887;4201.789910504463;5133.076046311662;5146.562542183919;5171.689698618095;5224.197651810119;4135.669146468275;4692.671512994092;4730.840943968749;4739.549742774466;4777.784999675023;4811.182099043136;5130.71781052042;5552.500274975231;5599.892059906751;5607.495325420732;3670.8164591770305;3889.5138107736534;3968;3976.3439032559595;4059.0110845685404;5189.532942035197;5289.841304760864;5818.563607729395;5881.735321910482;5893.3222679391565;3582.4268117101137;3630.3283892479976;4090.3250963590676;4109.951962249667;4121.26906699187;3500.7724497908066;3836.8465261389233;3869.7484663496784;4067.0333173919666;4174.269502837052;4104.363823607346;4563.817447302071;4665.930011049769;4681.976590117028;4706.294055891575;5118.744062796845;5261.316028916216;5601.915971260434;5645.854575261456;5673.375928647845;1190.214458457414;1248.5193200617828;1263.3746295583744;1304.3673818198167;1358.2190240611687;770.3836930455614;799.7920540659354;818.5907046476761;950.12588418655;956.0773853231665;4520.174890693316;4607.861764147014;4814.6870453420415;4841.394825646794;5142.97428512855;5316.893662126736;5494.450554944554;5537.667739935617;5540.473655002768;5552.611317207838;4242.957570424318;4761.928566072606;5025.547700706881;5045.738565358661;5050.3434553507805;2686.597010448448;2691.179190346963;2772.5702516110036;2876.4966130927423;2935.106856077818;5675.154590771512;5678.886422271531;5693.82918512437;5803.303603567599;5826.213461182686;4491.977540112279;4958.404991401055;5019.858616641212;5317.973410132925;5634.661920284796;5755.8273251801675;5775.84483103381;5787.797427090031;5797.362290147996;5805.680687562309;5512.972435137799;5513.283273174462;5513.558915286687;5541.445855414427;5566.443355664401;4343.500497442708;5081.339425874613;5242.475752424727;5402.405735369185;5433.7554810034435;4956.752162391794;5298.311219541435;5588.720563971704;5706.686132262766;5736.827895163152;3359.2105855124514;3477.565304336958;3900.317444447154;3929.0766669833138;3950.9209815802947;4304.814437316426;4530.750808705553;4725.9291110632685;5064.822126485499;5152.613553983391;5197.402298735694;5342.305500284938;5550.97224513891;5619.775208991595;5644.431783538562;5564.888702226014;5601.6358936668985;5601.7759289629585;5633.8591535211945;5656.85857853557;4740.739259340631;4912.992836468587;4945.986072854984;5485.683435975417;5494.2582751328055;4785.425748910153;5062.949370506248;5491.297697713721;5526.447355264602;5660.943390566042;4886.951130488792;5257.684538927677;5531.336239651107;5547.195656629686;5548.9722551388595 11:57:35 INFO - PROCESS | 1652 | |5;yui.html;690.3131384272649;700.1702981966367;755.9622018899054;778.4511919097038;795.7055889320952;14696.779548306771;15375.461858834942;15384.84615153848;15387.768978481723;15401.460948866792;13861;13997;14022.509212177576;14031.719365612682;14057.367418466169;653.6241661044894;682.5733916302311;814.4258297899996;847.4999750147412;850.7022542110243;837.0374069819695;850.2220468271524;850.2390360627235;850.3707256630111;851.5657014922404;906.102958071511;906.5195446413411;907.4691305586207;908.1917093786535;908.7455512456522;897.273208700951;898.7393655839799;900.086412291528;901.5402144906079;905.9592318345624;659.9835004124888;670.5004771445256;671.5467059734659;672.0356288725694;672.2269390201259;14258.358373873201;14266.64333391663;14505;15173.544793656209;15218.847811521853;13885.375158117808;14160.504382346568;14181.929090354586;14211.502597409144;14287.428502859873;11455.54177832894;11528.077753779762;11589.188756787029;11599.420028998516;11754.29474231549;3592.892213233581;3636.61704023373;3693.316736403774;3716.8141592920515;3833.3291673956946;86286.13713862907;87171;91765.08234917698;100452;102010.48994754978;10081.647142349982;10902.890971090346;10973.725656858642;11015.669529914116;11268.380239086766;18199.727004094686;21811.037006669158;22110.22614208495;22111.44721381978;22120.465304612517;7504.174540800507;7646.694132234759;7667.194944530744;7680.577568233801;7826.4130190235965;4176.0395109125075;4189.413482112506;4195.706300558932;4201.1375387797;4233.957660423418;3408.216110294646;3523.5419395478934;3555.040139162412;3559.4482855157494;3573.714102871764;594.0851089322481;617.0158597037718;633.1547384242089;636.700750647195;647.5240698086902;475.04041835492114;580.5848818095083;630.8518496336715;641.6310621392718;658.9769358072444;7802;8759.824803503894;9228.676996305097;9280.814383712423;9287.860682089775;600.1358044416027;636.2810024672091;637.1684951138808;640.8654182621701;645.0904225042761;3606.5852426971232;4255.107719214534;4484.372187893698;4517.728936263769;4523.7285762854335;104501.23479008435;105738.47130764298;106420;106437.46781266044;106630;92819.60770588447;92860;94245;94496;95020;68152;74441;75802.24197758062;75987.62006189933;77477.22522774813;7669.9616501917135;8202.138775428733;8652.8367908023;8725.345599079967;8745.518996455;38601;54481.18278225751;55040.44959550353;55270.170947435014;55299;70633.64683176756;73691;74446.20530023225;74495;74592;11578.131640126856;11749.236299640495;11791.88208117908;11865.40672966331;11946.163768536118;9779.364341317792;12483.251004939733;12577.748445031231;12593.559225427067;13215.537456188988;11216;11733.178677492493;11745.236559623598;12186.14696971239;13284.737949894745;11316;13488;13718.794218086936;14041.859581404464;14077.436902523785;13333.533326333532;13343.199408035549;13539.729205415639;13616.52342168059;13941.860581394056;8546.572671366532;10414.427206503715;10730.839037414602;10917.454127293762;11222.66332010041;9829.4102353859;10995.285306455055;11179.832302515631;11454;11549.898480433203 11:57:35 INFO - PROCESS | 1652 | __end_tp_report 11:57:35 INFO - PROCESS | 1652 | __start_cc_report 11:57:35 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,393 11:57:35 INFO - PROCESS | 1652 | __end_cc_report 11:57:35 INFO - PROCESS | 1652 | __startTimestamp1483387055896__endTimestamp 11:57:35 INFO - PROCESS | 1652 | 11:57:35 INFO - PROCESS | 1652 | ------- Summary: start ------- 11:57:35 INFO - PROCESS | 1652 | Number of tests: 6 11:57:35 INFO - PROCESS | 1652 | 11:57:35 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5685.49 Median:5932.85 stddev:663.72 (11.2%) stddev-sans-first:640.11 11:57:35 INFO - PROCESS | 1652 | Values: 3356.6 3375.1 3398.5 3400.2 3406.7 5633.1 5660.6 5682.5 5683.8 5687.4 5489.5 5624.3 5644.8 5672.6 5683.6 5027.9 5133.3 5156.4 5166.1 5185.2 4465.0 5136.6 5232.8 5241.2 5250.0 5178.7 5224.5 5225.3 5239.2 5253.7 5010.1 5011.7 5055.0 5086.5 5147.6 5095.7 5172.7 5177.9 5182.3 5193.8 4319.7 5542.7 5589.9 5701.2 5712.1 6050.9 6077.9 6197.3 6205.3 6226.6 6132.2 6185.3 6188.0 6201.6 6205.6 5747.6 5758.0 5765.4 5768.8 5785.2 6140.4 6295.1 6313.5 6313.7 6321.8 5967.9 6008.9 6017.8 6054.0 6111.9 6147.4 6148.8 6148.9 6165.3 6268.9 4369.7 4499.7 5233.7 5988.0 6185.4 5676.5 6136.1 6160.8 6169.5 6219.8 4942.5 4951.0 4951.5 4952.4 4996.6 4299.5 4354.0 4354.2 4355.8 4429.4 5879.1 5887.0 5928.3 5932.9 5958.6 6237.4 6257.4 6261.9 6266.3 6297.2 5745.7 5764.2 5884.6 5909.8 5919.3 5346.2 5361.5 5379.6 5385.7 5410.2 6297.7 6304.4 6322.0 6323.7 6339.8 6170.8 6188.2 6272.0 6275.4 6282.2 6237.1 6258.3 6259.3 6322.0 6330.3 6141.5 6199.8 6202.7 6218.5 6228.6 6231.8 6238.2 6251.4 6259.7 6267.2 5971.0 5973.1 6072.1 6116.5 6123.0 5833.9 5993.5 6027.5 6064.4 6072.8 5733.7 5842.2 5861.4 5893.4 6023.4 5994.7 6035.8 6065.7 6085.5 6100.5 5991.0 6003.1 6017.4 6046.2 6068.5 11:57:35 INFO - PROCESS | 1652 | 11:57:35 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:62580.86 Median:17852.92 stddev:132252.30 (740.8%) stddev-sans-first:132541.07 11:57:35 INFO - PROCESS | 1652 | Values: 461.8 467.6 468.4 478.2 535.2 29012.9 39428.8 39429.2 39493.2 39522.0 40042.4 40812.6 40875.4 40922.0 40990.6 8394.0 8490.6 9082.2 9173.0 9529.1 11166.4 11432.1 11433.5 11462.0 11466.7 11388.4 11452.3 11476.5 11498.4 11517.5 11414.6 11454.4 11457.1 11466.9 11481.7 11375.3 11387.4 11420.1 11421.9 11447.3 39875.8 39938.8 40170.4 40362.0 40377.8 3956.3 3986.2 3992.4 4026.6 4029.3 29703.9 30385.0 30431.0 30537.8 30860.8 3131.9 3229.2 3258.8 3301.2 3303.7 452853.7 456541.0 456742.0 458871.0 461949.0 60172.3 60438.4 60550.0 60565.0 60756.7 62711.7 62921.0 63499.1 63644.7 63757.0 15674.6 15861.4 15874.2 15887.5 15888.8 11085.9 11346.6 12061.2 12340.9 12346.8 17095.1 17099.7 17127.1 17196.0 17228.0 5691.8 6756.4 6823.4 6841.5 6860.6 821.7 826.7 831.7 834.3 854.5 28762.0 29201.9 29438.0 29455.9 30086.4 1010.8 1046.5 1046.6 1057.2 1142.3 12699.9 14749.9 15310.5 15479.0 15685.8 588355.0 588885.0 594306.0 595302.0 596785.0 58646.4 58672.0 58732.7 58822.7 58941.2 1335.7 1375.5 1394.1 1394.2 1394.5 28372.0 28945.7 29005.7 29576.7 30312.4 49303.8 49743.0 49860.8 49899.3 49976.0 419368.0 420317.0 422071.0 422300.0 422700.0 23252.4 23938.8 23993.5 24331.4 39614.8 31911.7 39710.8 40006.4 40982.8 41152.0 25482.4 26818.9 27159.5 34279.8 35190.6 26908.5 32447.0 33645.7 33959.7 34690.5 27273.0 32247.8 32363.7 32880.5 33085.7 23449.0 28801.7 30527.1 30537.5 30623.8 16766.4 22453.6 22830.1 23319.8 23333.9 11:57:35 INFO - PROCESS | 1652 | 11:57:35 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:31804.57 Median:23678.07 stddev:90672.08 (382.9%) stddev-sans-first:90895.58 11:57:35 INFO - PROCESS | 1652 | Values: 299.5 344.2 359.2 369.4 389.0 18780.0 19336.0 19965.6 20169.6 20203.7 18923.8 19577.5 19607.4 19774.6 20043.9 5088.0 5299.4 5305.4 5308.6 5319.9 4441.8 5902.3 5955.1 6031.5 6037.8 5092.5 5751.9 5895.2 6004.0 6015.9 5856.4 5932.9 5941.3 5948.9 5961.1 5438.8 5661.5 5740.4 5744.7 5765.7 12976.4 13049.7 13105.3 13113.2 13126.8 2844.9 2902.8 2937.5 2944.6 2956.9 9259.2 9774.6 9974.6 10145.6 10274.9 1768.4 1783.5 1793.4 1796.4 1823.9 91853.0 119641.8 122945.0 123547.5 124405.8 8923.5 11310.9 11489.6 11495.0 11502.9 14349.4 14501.8 14537.6 14539.1 14578.0 8060.7 8288.1 8305.9 8425.2 8435.0 6560.2 6575.6 8083.6 8236.0 8253.6 3672.5 4503.5 4519.4 4519.7 4577.8 1901.9 1927.8 1931.1 1931.5 1932.7 824.7 836.5 853.7 854.1 870.9 18938.0 19310.0 19445.5 19542.3 19854.7 745.6 860.5 863.4 890.5 894.1 8585.7 9886.4 10244.9 10257.3 10297.7 513356.4 547519.0 547640.0 550979.0 558766.0 78970.0 80828.0 81145.2 122184.4 125136.4 975.8 999.7 1031.9 1043.4 1044.4 16686.0 17449.8 17886.3 18008.9 18548.6 42914.4 46801.1 51440.7 51463.7 52068.7 73135.6 74642.6 75168.6 75291.0 76186.0 7280.5 7438.7 7902.6 8024.6 8121.5 8957.2 9886.9 10091.9 10798.1 12944.7 10789.5 11003.5 11403.7 11591.9 11594.6 11013.2 11141.6 11207.7 11228.2 11383.5 9621.4 11432.7 11572.2 11579.6 11643.2 7781.1 7882.3 8003.0 8236.8 8285.3 8807.3 10568.4 10677.4 11221.8 11338.3 11:57:35 INFO - PROCESS | 1652 | 11:57:35 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5305.35 Median:5385.22 stddev:2908.18 (54.0%) stddev-sans-first:2901.30 11:57:35 INFO - PROCESS | 1652 | Values: 1370.0 1397.1 1408.1 1410.5 1418.5 6456.5 7462.9 7696.0 8238.1 8370.2 7886.1 8092.4 8128.9 8279.0 8309.9 2256.2 2310.4 2316.7 2317.2 2317.4 2050.5 2132.0 2280.8 2315.3 2329.6 2202.6 2271.2 2280.1 2283.0 2294.1 2231.9 2238.2 2263.7 2286.7 2324.7 2316.3 2327.9 2356.7 2356.8 2362.4 8254.4 8319.5 8372.2 8387.1 8394.5 4996.3 5151.0 5160.5 5162.5 5171.0 3285.4 3421.4 3424.3 3485.9 3486.2 1149.8 1176.9 1187.1 1225.3 1231.9 10701.5 10708.6 10735.2 10767.5 10801.3 4312.8 4568.3 4616.6 4630.7 4657.6 9223.8 9277.4 9342.0 9368.7 9370.0 5081.8 5156.7 5158.0 5179.3 5204.8 4543.9 4626.1 4636.2 4711.0 4718.2 3225.8 3344.9 3371.8 3837.9 3899.6 959.0 1193.1 1243.8 1250.4 1258.2 694.5 751.8 757.6 776.8 801.3 5380.7 5441.9 5545.9 5654.3 5681.9 898.1 901.4 903.5 916.4 940.8 3668.6 3758.1 3808.3 3810.3 3819.7 9169.1 9614.1 9694.4 9822.8 9890.9 9778.9 9781.3 9800.6 9814.0 9819.4 6786.2 7445.0 7652.0 7749.7 7758.9 5005.9 5389.7 5412.6 5470.6 5537.6 7865.0 9008.1 9049.9 9141.2 9227.3 9149.3 9184.3 9222.9 9268.8 9300.5 6921.6 7011.6 7071.8 7093.7 7101.8 7489.4 7761.3 7845.9 7853.1 7868.3 5590.9 6439.6 7053.3 7085.5 7180.2 6877.8 6936.9 6969.2 7032.1 7067.9 6262.9 6283.8 6307.3 6351.7 6366.4 3765.6 4113.9 4449.4 4481.6 4580.6 4724.6 4738.8 4791.5 4799.1 4899.3 11:57:35 INFO - PROCESS | 1652 | 11:57:35 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4479.02 Median:5022.70 stddev:1338.52 (26.6%) stddev-sans-first:1304.51 11:57:35 INFO - PROCESS | 1652 | Values: 272.7 351.5 355.7 358.4 362.0 5185.8 5241.4 5305.4 5417.0 5432.1 5091.0 5312.7 5315.5 5328.5 5332.8 4147.5 4189.5 4190.8 4197.9 4202.2 4019.3 4162.7 4179.4 4189.6 4215.7 3747.7 3955.7 4031.9 4055.9 4133.5 3499.7 4073.2 4100.0 4126.6 4168.5 3666.5 3674.9 3676.4 3681.7 3708.0 4201.8 5133.1 5146.6 5171.7 5224.2 4135.7 4692.7 4730.8 4739.5 4777.8 4811.2 5130.7 5552.5 5599.9 5607.5 3670.8 3889.5 3968.0 3976.3 4059.0 5189.5 5289.8 5818.6 5881.7 5893.3 3582.4 3630.3 4090.3 4110.0 4121.3 3500.8 3836.8 3869.7 4067.0 4174.3 4104.4 4563.8 4665.9 4682.0 4706.3 5118.7 5261.3 5601.9 5645.9 5673.4 1190.2 1248.5 1263.4 1304.4 1358.2 770.4 799.8 818.6 950.1 956.1 4520.2 4607.9 4814.7 4841.4 5143.0 5316.9 5494.5 5537.7 5540.5 5552.6 4243.0 4761.9 5025.5 5045.7 5050.3 2686.6 2691.2 2772.6 2876.5 2935.1 5675.2 5678.9 5693.8 5803.3 5826.2 4492.0 4958.4 5019.9 5318.0 5634.7 5755.8 5775.8 5787.8 5797.4 5805.7 5513.0 5513.3 5513.6 5541.4 5566.4 4343.5 5081.3 5242.5 5402.4 5433.8 4956.8 5298.3 5588.7 5706.7 5736.8 3359.2 3477.6 3900.3 3929.1 3950.9 4304.8 4530.8 4725.9 5064.8 5152.6 5197.4 5342.3 5551.0 5619.8 5644.4 5564.9 5601.6 5601.8 5633.9 5656.9 4740.7 4913.0 4946.0 5485.7 5494.3 4785.4 5062.9 5491.3 5526.4 5660.9 4887.0 5257.7 5531.3 5547.2 5549.0 11:57:35 INFO - PROCESS | 1652 | 11:57:35 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:20176.55 Median:4244.53 stddev:29287.06 (690.0%) stddev-sans-first:29332.67 11:57:35 INFO - PROCESS | 1652 | Values: 690.3 700.2 756.0 778.5 795.7 14696.8 15375.5 15384.8 15387.8 15401.5 13861.0 13997.0 14022.5 14031.7 14057.4 653.6 682.6 814.4 847.5 850.7 837.0 850.2 850.2 850.4 851.6 906.1 906.5 907.5 908.2 908.7 897.3 898.7 900.1 901.5 906.0 660.0 670.5 671.5 672.0 672.2 14258.4 14266.6 14505.0 15173.5 15218.8 13885.4 14160.5 14181.9 14211.5 14287.4 11455.5 11528.1 11589.2 11599.4 11754.3 3592.9 3636.6 3693.3 3716.8 3833.3 86286.1 87171.0 91765.1 100452.0 102010.5 10081.6 10902.9 10973.7 11015.7 11268.4 18199.7 21811.0 22110.2 22111.4 22120.5 7504.2 7646.7 7667.2 7680.6 7826.4 4176.0 4189.4 4195.7 4201.1 4234.0 3408.2 3523.5 3555.0 3559.4 3573.7 594.1 617.0 633.2 636.7 647.5 475.0 580.6 630.9 641.6 659.0 7802.0 8759.8 9228.7 9280.8 9287.9 600.1 636.3 637.2 640.9 645.1 3606.6 4255.1 4484.4 4517.7 4523.7 104501.2 105738.5 106420.0 106437.5 106630.0 92819.6 92860.0 94245.0 94496.0 95020.0 68152.0 74441.0 75802.2 75987.6 77477.2 7670.0 8202.1 8652.8 8725.3 8745.5 38601.0 54481.2 55040.4 55270.2 55299.0 70633.6 73691.0 74446.2 74495.0 74592.0 11578.1 11749.2 11791.9 11865.4 11946.2 9779.4 12483.3 12577.7 12593.6 13215.5 11216.0 11733.2 11745.2 12186.1 13284.7 11316.0 13488.0 13718.8 14041.9 14077.4 13333.5 13343.2 13539.7 13616.5 13941.9 8546.6 10414.4 10730.8 10917.5 11222.7 9829.4 10995.3 11179.8 11454.0 11549.9 11:57:35 INFO - PROCESS | 1652 | -------- Summary: end -------- 11:57:35 INFO - PROCESS | 1652 | 11:57:36 INFO - TEST-INFO | 1652: exit 0 11:57:36 INFO - TEST-OK | dromaeo_css | took 1116158ms 11:57:36 INFO - TEST-START | kraken 11:57:36 INFO - operating with platform_type : mac_ 11:57:36 INFO - Initialising browser for kraken test... 11:57:36 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpDzhDzy/profile http://localhost:49236/getInfo.html) 11:57:37 INFO - PROCESS | 1660 | 1483387057052 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4986 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2097 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3827 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2831 < callProvider()@resource://gre/modules/AddonManager.jsm:264 < _startProvider()@resource://gre/modules/AddonManager.jsm:771 < startup()@resource://gre/modules/AddonManager.jsm:957 < startup()@resource://gre/modules/AddonManager.jsm:2923 < observe()@resource://gre/components/addonManager.js:65 11:57:39 INFO - PROCESS | 1660 | 2017-01-02 11:57:39.102 plugin-container[1661:11516] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 11:57:39 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:57:39 INFO - PROCESS | 1660 | 2017-01-02 11:57:39.105 plugin-container[1661:11516] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 11:57:39 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:57:39 INFO - PROCESS | 1660 | 2017-01-02 11:57:39.105 plugin-container[1661:11516] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:57:39 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 11:57:39 INFO - PROCESS | 1660 | colorDepth:24 11:57:39 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 11:57:39 INFO - PROCESS | 1660 | __metrics 11:57:39 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3256: TypeError: this.tabs is undefined 11:57:39 INFO - TEST-INFO | 1660: exit 0 11:57:39 INFO - Browser initialized. 11:57:39 INFO - Running cycle 1/1 for kraken test... 11:57:39 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpDzhDzy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:57:42 INFO - PROCESS | 1662 | 2017-01-02 11:57:42.135 plugin-container[1663:11631] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4547, name = 'com.apple.tsm.portname' 11:57:42 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:57:42 INFO - PROCESS | 1662 | 2017-01-02 11:57:42.135 plugin-container[1663:11631] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 11:57:42 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 11:57:42 INFO - PROCESS | 1662 | 2017-01-02 11:57:42.135 plugin-container[1663:11631] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 11:57:51 INFO - PROCESS | 1662 | RSS: Main: 232296448 11:57:51 INFO - PROCESS | 1662 | 11:57:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 11:57:55 INFO - PROCESS | 1662 | RSS: Main: 245096448 11:57:55 INFO - PROCESS | 1662 | 11:57:58 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 11:57:59 INFO - PROCESS | 1662 | RSS: Main: 252731392 11:57:59 INFO - PROCESS | 1662 | 11:58:02 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 11:58:03 INFO - PROCESS | 1662 | RSS: Main: 255320064 11:58:03 INFO - PROCESS | 1662 | 11:58:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 11:58:06 INFO - PROCESS | 1662 | RSS: Main: 256581632 11:58:06 INFO - PROCESS | 1662 | 11:58:08 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:58:08 INFO - PROCESS | 1662 | RSS: Main: 256892928 11:58:08 INFO - PROCESS | 1662 | 11:58:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 11:58:12 INFO - PROCESS | 1662 | RSS: Main: 263741440 11:58:12 INFO - PROCESS | 1662 | 11:58:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 11:58:16 INFO - PROCESS | 1662 | RSS: Main: 262729728 11:58:16 INFO - PROCESS | 1662 | 11:58:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 11:58:19 INFO - PROCESS | 1662 | RSS: Main: 262889472 11:58:19 INFO - PROCESS | 1662 | 11:58:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:58:22 INFO - PROCESS | 1662 | RSS: Main: 262213632 11:58:22 INFO - PROCESS | 1662 | 11:58:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:58:24 INFO - PROCESS | 1662 | RSS: Main: 262238208 11:58:24 INFO - PROCESS | 1662 | 11:58:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:58:27 INFO - PROCESS | 1662 | RSS: Main: 262303744 11:58:27 INFO - PROCESS | 1662 | 11:58:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:58:31 INFO - PROCESS | 1662 | RSS: Main: 262774784 11:58:31 INFO - PROCESS | 1662 | 11:58:34 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:58:34 INFO - PROCESS | 1662 | RSS: Main: 262561792 11:58:34 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 11:58:36 INFO - PROCESS | 1662 | RSS: Main: 264491008 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | __start_tp_report 11:58:36 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 11:58:36 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 11:58:36 INFO - PROCESS | 1662 | |i|pagename|runs| 11:58:36 INFO - PROCESS | 1662 | |0;ai-astar;106;109;165;173;159;176;141;118;123;140 11:58:36 INFO - PROCESS | 1662 | |1;audio-beat-detection;143;115;113;149;115;114;128;144;173;144 11:58:36 INFO - PROCESS | 1662 | |2;audio-dft;206;202;271;262;285;237;200;194;192;197 11:58:36 INFO - PROCESS | 1662 | |3;audio-fft;84;59;60;87;61;63;76;84;99;56 11:58:36 INFO - PROCESS | 1662 | |4;audio-oscillator;93;78;115;106;101;71;83;71;74;97 11:58:36 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;138;133;92;97;93;90;121;105;92;87 11:58:36 INFO - PROCESS | 1662 | |6;imaging-darkroom;106;102;102;102;104;150;175;100;102;102 11:58:36 INFO - PROCESS | 1662 | |7;imaging-desaturate;93;121;144;144;90;93;96;115;132;85 11:58:36 INFO - PROCESS | 1662 | |8;json-parse-financial;60;61;61;62;63;62;63;62;62;62 11:58:36 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;70;76;69;77;77;69;70;72;63;91 11:58:36 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;90;89;79;103;111;76;105;75;98;80 11:58:36 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;147;159;155;137;145;141;158;157;212;159 11:58:36 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;175;173;177;173;176;176;173;176;173;182 11:58:36 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;67;65;68;69;71;65;69;67;62;67 11:58:36 INFO - PROCESS | 1662 | __end_tp_report 11:58:36 INFO - PROCESS | 1662 | __start_cc_report 11:58:36 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,952 11:58:36 INFO - PROCESS | 1662 | __end_cc_report 11:58:36 INFO - PROCESS | 1662 | __startTimestamp1483387116920__endTimestamp 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | ------- Summary: start ------- 11:58:36 INFO - PROCESS | 1662 | Number of tests: 14 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:141.00 Median:150.00 stddev:26.36 (17.6%) stddev-sans-first:24.73 11:58:36 INFO - PROCESS | 1662 | Values: 106.0 109.0 165.0 173.0 159.0 176.0 141.0 118.0 123.0 140.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:143.50 stddev:20.07 (14.0%) stddev-sans-first:21.01 11:58:36 INFO - PROCESS | 1662 | Values: 143.0 115.0 113.0 149.0 115.0 114.0 128.0 144.0 173.0 144.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:224.60 Median:221.50 stddev:35.86 (16.2%) stddev-sans-first:37.40 11:58:36 INFO - PROCESS | 1662 | Values: 206.0 202.0 271.0 262.0 285.0 237.0 200.0 194.0 192.0 197.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:72.90 Median:80.00 stddev:14.98 (18.7%) stddev-sans-first:15.35 11:58:36 INFO - PROCESS | 1662 | Values: 84.0 59.0 60.0 87.0 61.0 63.0 76.0 84.0 99.0 56.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:76.00 stddev:15.70 (20.7%) stddev-sans-first:16.58 11:58:36 INFO - PROCESS | 1662 | Values: 93.0 78.0 115.0 106.0 101.0 71.0 83.0 71.0 74.0 97.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:104.80 Median:91.00 stddev:18.93 (20.8%) stddev-sans-first:15.81 11:58:36 INFO - PROCESS | 1662 | Values: 138.0 133.0 92.0 97.0 93.0 90.0 121.0 105.0 92.0 87.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:114.50 Median:103.00 stddev:26.02 (25.3%) stddev-sans-first:27.42 11:58:36 INFO - PROCESS | 1662 | Values: 106.0 102.0 102.0 102.0 104.0 150.0 175.0 100.0 102.0 102.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:111.30 Median:87.50 stddev:22.91 (26.2%) stddev-sans-first:23.32 11:58:36 INFO - PROCESS | 1662 | Values: 93.0 121.0 144.0 144.0 90.0 93.0 96.0 115.0 132.0 85.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:62.00 stddev:0.92 (1.5%) stddev-sans-first:0.71 11:58:36 INFO - PROCESS | 1662 | Values: 60.0 61.0 61.0 62.0 63.0 62.0 63.0 62.0 62.0 62.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:73.40 Median:74.00 stddev:7.56 (10.2%) stddev-sans-first:7.92 11:58:36 INFO - PROCESS | 1662 | Values: 70.0 76.0 69.0 77.0 77.0 69.0 70.0 72.0 63.0 91.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:90.60 Median:79.50 stddev:13.07 (16.4%) stddev-sans-first:13.87 11:58:36 INFO - PROCESS | 1662 | Values: 90.0 89.0 79.0 103.0 111.0 76.0 105.0 75.0 98.0 80.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:157.00 Median:157.50 stddev:20.92 (13.3%) stddev-sans-first:21.87 11:58:36 INFO - PROCESS | 1662 | Values: 147.0 159.0 155.0 137.0 145.0 141.0 158.0 157.0 212.0 159.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:176.00 stddev:2.80 (1.6%) stddev-sans-first:2.96 11:58:36 INFO - PROCESS | 1662 | Values: 175.0 173.0 177.0 173.0 176.0 176.0 173.0 176.0 173.0 182.0 11:58:36 INFO - PROCESS | 1662 | 11:58:36 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.50 stddev:2.54 (3.8%) stddev-sans-first:2.69 11:58:36 INFO - PROCESS | 1662 | Values: 67.0 65.0 68.0 69.0 71.0 65.0 69.0 67.0 62.0 67.0 11:58:36 INFO - PROCESS | 1662 | -------- Summary: end -------- 11:58:36 INFO - PROCESS | 1662 | 11:58:37 INFO - TEST-INFO | 1662: exit 0 11:58:37 INFO - TEST-OK | kraken | took 61229ms 11:58:37 INFO - SUITE-END | took 1177s 11:58:38 INFO - Completed test suite (00:19:37) 11:58:38 INFO - javascript benchmark 11:58:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7055.9576135458465, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3356.630770615232, 3375.088726043968, 3398.5242066110764, 3400.200952776097, 3406.6763657452534, 5633.126865335875, 5660.575456840738, 5682.516986056185, 5683.772649094041, 5687.374388817227, 5489.505944464997, 5624.268845050148, 5644.774209031634, 5672.602917795756, 5683.630564013336, 5027.899442011158, 5133.281340612327, 5156.432792392834, 5166.07010738067, 5185.24813901984, 4465.0, 5136.563392111656, 5232.764525596357, 5241.213817927303, 5250.0, 5178.689278643294, 5224.503672151159, 5225.320708307915, 5239.161734122541, 5253.711045892474, 5010.0981823271795, 5011.749412529359, 5054.974725126388, 5086.46592107827, 5147.613928955343, 5095.694258344474, 5172.663776854492, 5177.948220517785, 5182.300389447451, 5193.766280517386, 4319.676024298159, 5542.667439953575, 5589.888202235973, 5701.2018317435595, 5712.1431785232135, 6050.9410853100535, 6077.878442431171, 6197.256329240475, 6205.317415084337, 6226.62640241587, 6132.233136608343, 6185.257769067695, 6188.040853667689, 6201.596896201732, 6205.596636218676, 5747.626404283708, 5758.049921762862, 5765.365809760923, 5768.798092066758, 5785.190073389729, 6140.385961403824, 6295.087212354183, 6313.526485513605, 6313.715882785285, 6321.810345689637, 5967.880642387128, 6008.939910600925, 6017.819465415957, 6054.001089820218, 6111.877762444727, 6147.44672979425, 6148.754049837957, 6148.862460444832, 6165.290991536031, 6268.937310626835, 4369.737815731066, 4499.730016199039, 5233.71214583194, 5987.952108381016, 6185.350538193515, 5676.545876329884, 6136.12084543884, 6160.784372546939, 6169.5064394848305, 6219.844503887349, 4942.5304596063315, 4950.950490495049, 4951.529604687549, 4952.430470495867, 4996.575291100297, 4299.5270520243375, 4353.978230108829, 4354.150940566559, 4355.7822108894425, 4429.379886815848, 5879.088741245114, 5886.970565147147, 5928.318243401977, 5932.851678708067, 5958.612690175125, 6237.407446292595, 6257.405546473078, 6261.9373806262265, 6266.279377871603, 6297.244330680348, 5745.712714364265, 5764.221830052973, 5884.588078834526, 5909.793157239562, 5919.260092488439, 5346.198070289488, 5361.490658387447, 5379.6234263601955, 5385.676859388449, 5410.215518749759, 6297.653629050446, 6304.401081897213, 6322.0200868865395, 6323.715432805627, 6339.778107766206, 6170.845728856814, 6188.226471691039, 6271.96864015677, 6275.435210831047, 6282.1519094921605, 6237.064440333987, 6258.342873998165, 6259.3427690091885, 6322.0, 6330.272018717907, 6141.539384546088, 6199.752009919733, 6202.658853762906, 6218.502519798315, 6228.626282423069, 6231.844203894939, 6238.189035425366, 6251.374862513894, 6259.718312676032, 6267.2165979252595, 5970.97014514942, 5973.104034394875, 6072.1498990140535, 6116.480099191618, 6123.0, 5833.9416605835095, 5993.460588547052, 6027.547933905063, 6064.423879731418, 6072.757089716539, 5733.713314334183, 5842.2405087338375, 5861.3845546217035, 5893.410658934073, 6023.367546407564, 5994.700264986646, 6035.849103772441, 6065.727042283196, 6085.4523092921845, 6100.481459076028, 5991.041433370639, 6003.129546215861, 6017.428344307284, 6046.2139921809885, 6068.4841788448475], "value": 5643.602772544803, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.7829620078562, 467.59319392128833, 468.4425533614998, 478.2061777449434, 535.1597991153889, 29012.854935725318, 39428.80285598572, 39429.211415771664, 39493.210135797264, 39522.0, 40042.399364009565, 40812.59187408125, 40875.386869196984, 40921.97695057618, 40990.59009409905, 8394.0, 8490.575471226444, 9082.182603565661, 9173.0, 9529.142377186052, 11166.385848778315, 11432.085433165368, 11433.485493152828, 11462.0, 11466.656000320003, 11388.373639449826, 11452.255603385753, 11476.540938362456, 11498.367589782558, 11517.48171332292, 11414.600488982887, 11454.427278636118, 11457.083433325397, 11466.942665286704, 11481.655550333504, 11375.31748095117, 11387.430628468626, 11420.143489238257, 11421.885781142166, 11447.255928364713, 39875.800620997, 39938.80183594497, 40170.39744403836, 40362.0, 40377.79811100926, 3956.3274243378696, 3986.22268657609, 3992.441058251847, 4026.6376026157495, 4029.315016447211, 29703.851480742673, 30385.0, 30431.0, 30537.847310763525, 30860.84569577138, 3131.906042818719, 3229.160418291238, 3258.820764857932, 3301.224212310105, 3303.7357011439026, 452853.73573132255, 456541.0, 456742.0, 458871.0, 461949.0, 60172.292246849, 60438.39561604416, 60550.0, 60565.0, 60756.69621651952, 62711.6864415675, 62921.0, 63499.142538585875, 63644.68177659082, 63757.04364434537, 15674.608134796721, 15861.444849430445, 15874.20628968547, 15887.52337429879, 15888.76166857498, 11085.944570277097, 11346.602868899548, 12061.216020958609, 12340.938295308466, 12346.753064938652, 17095.145242737814, 17099.74350384745, 17127.14364281781, 17196.022457417308, 17227.96632202072, 5691.800786972436, 6756.425703815133, 6823.38589526935, 6841.521093523405, 6860.622665753432, 821.6918655504186, 826.6858593734343, 831.746317373207, 834.3033566971646, 854.5342788180457, 28762.0, 29201.85399072991, 29438.0, 29455.85272073626, 30086.398272034876, 1010.7877345757327, 1046.5447530324334, 1046.6179844356907, 1057.2282233969245, 1142.3146112332533, 12699.873001270054, 14749.926250368679, 15310.540683779505, 15478.993865398714, 15685.764713529306, 588355.0, 588885.0, 594306.0, 595302.0, 596785.0, 58646.41353586495, 58672.0, 58732.7063364689, 58822.70588647029, 58941.23176304718, 1335.6794369351285, 1375.532319011521, 1394.0659757961987, 1394.2331717555303, 1394.4840409048513, 28372.0, 28945.710542894303, 29005.709942901143, 29576.704232958255, 30312.393752124393, 49303.753481232365, 49742.99999999855, 49860.75348116326, 49899.25151122809, 49976.0, 419368.0, 420317.0, 422071.0, 422300.0, 422700.0, 23252.41868953222, 23938.80305984659, 23993.52012959696, 24331.39171520726, 39614.801925990185, 31911.68088319087, 39710.80144599258, 40006.39990400204, 40982.79508602438, 41151.97120072022, 25482.362940926625, 26818.865905670347, 27159.456810863277, 34279.82860085684, 35190.648093518736, 26908.461830762884, 32447.02658920236, 33645.66354336425, 33959.66040339565, 34690.47964280487, 27273.0, 32247.838760806048, 32363.705451781665, 32880.50679239861, 33085.66914330826, 23449.0, 28801.711982879904, 30527.084187473523, 30537.54193687052, 30623.846880765454, 16766.413175538797, 22453.550928981003, 22830.086796527954, 23319.76680233176, 23333.883330583238], "value": 19168.96635066995, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.4639595124727, 344.22892720306515, 359.2007782683528, 369.42185479724236, 388.99250940065224, 18780.0, 19336.0, 19965.60068798625, 20169.59660806783, 20203.696944545805, 18923.81076189241, 19577.51056223595, 19607.41177764666, 19774.604507909833, 20043.899780501077, 5088.0, 5299.364076310848, 5305.3898801637915, 5308.628396012281, 5319.867003324909, 4441.777911104448, 5902.291724993007, 5955.094369801665, 6031.547633927451, 6037.7584896604085, 5092.541671249587, 5751.884962300752, 5895.233619629442, 6003.969980150093, 6015.909761353583, 5856.443637854397, 5932.911006334908, 5941.346451890288, 5948.940510594882, 5961.076033214858, 5438.83683489496, 5661.5187709044785, 5740.397258287861, 5744.741486633112, 5765.654060756368, 12976.35118244084, 13049.739005219843, 13105.344732763324, 13113.213207207598, 13126.803097953538, 2844.87198076085, 2902.8258304501796, 2937.500624893773, 2944.617199764017, 2956.881724731008, 9259.212966897821, 9774.609015639366, 9974.551145198484, 10145.594176232942, 10274.948625256826, 1768.4164225805453, 1783.5362805670488, 1793.4171394296907, 1796.4431026381862, 1823.8996855172961, 91853.0, 119641.80358196393, 122945.0, 123547.5290494194, 124405.75594244032, 8923.509206993547, 11310.943445282886, 11489.597864074718, 11495.011297062823, 11502.907223813725, 14349.426022959173, 14501.782473262698, 14537.563873083824, 14539.054961427473, 14578.0, 8060.717874874468, 8288.129746376664, 8305.916940830635, 8425.241728244488, 8435.0, 6560.245571759213, 6575.572587781779, 8083.555404452812, 8236.0, 8253.628586713492, 3672.485851980725, 4503.504614492404, 4519.41247637805, 4519.661025423106, 4577.839775607904, 1901.8858868467937, 1927.816857398545, 1931.0923865783059, 1931.4837852286169, 1932.6617841877614, 824.6536454689045, 836.4939211776909, 853.6670698427494, 854.1245223645689, 870.9042005379404, 18938.0, 19310.03449827503, 19445.513862153275, 19542.316018939553, 19854.70217946732, 745.6346390268837, 860.4579115157536, 863.3567991846115, 890.4790697441939, 894.1371576428647, 8585.65657373698, 9886.357386769838, 10244.948775256225, 10257.33327333721, 10297.74255643615, 513356.43321783154, 547519.0, 547640.0, 550979.0, 558766.0, 78970.0, 80828.0, 81145.18854811376, 122184.38907805581, 125136.37431812783, 975.8243516167158, 999.6751055906714, 1031.9432431216205, 1043.4313299251926, 1044.4046893270763, 16686.0, 17449.825501745327, 17886.28454861843, 18008.909955450137, 18548.629027419647, 42914.35628465638, 46801.063978720915, 51440.74279628578, 51463.742681286356, 52068.69828254324, 73135.63432182805, 74642.62678686572, 75168.62415687887, 75291.0, 76186.0, 7280.5438912216705, 7438.66104101267, 7902.604869756604, 8024.558649274112, 8121.512709237465, 8957.193852553302, 9886.901130988597, 10091.88070505202, 10798.082163016232, 12944.676383090498, 10789.514471848628, 11003.504842281956, 11403.714907127389, 11591.942040289745, 11594.594189203337, 11013.229073965065, 11141.554337826396, 11207.66377008691, 11228.214025018171, 11383.487743051417, 9621.422714637145, 11432.714182145513, 11572.24780389272, 11579.594714184963, 11643.184977051525, 7781.06627204739, 7882.290593846581, 8003.0, 8236.794080147805, 8285.295749861089, 8807.295416366547, 10568.365898046142, 10677.359358438518, 11221.775564488828, 11338.319700817978], "value": 9020.931091332517, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.972600547989, 1397.0988712280573, 1408.0706733555855, 1410.5204230561608, 1418.538974833179, 6456.515761317903, 7462.888056679154, 7696.0, 8238.052623948248, 8370.246677798998, 7886.132525422199, 8092.352611791057, 8128.878066829002, 8278.95860520698, 8309.878166447528, 2256.187772401938, 2310.3992961829877, 2316.721993360799, 2317.212147869724, 2317.44381348476, 2050.507878109258, 2131.968020479694, 2280.813976732098, 2315.2822624986225, 2329.6039673255586, 2202.592520383734, 2271.1937262271904, 2280.065173278956, 2283.0297123722435, 2294.139697613395, 2231.94420139497, 2238.183063181935, 2263.6830843681896, 2286.7141607299086, 2324.651302304651, 2316.2703748319227, 2327.94180145496, 2356.670066190735, 2356.7525409832065, 2362.433016076129, 8254.42219044667, 8319.459235149756, 8372.204640559137, 8387.119352467964, 8394.45436046655, 4996.300517927493, 5151.0, 5160.483951604847, 5162.5095615916425, 5171.0, 3285.444450804206, 3421.367047096295, 3424.3493736190294, 3485.8954231372845, 3486.1981744198724, 1149.7987852125927, 1176.8764279750674, 1187.068151501076, 1225.2954551133134, 1231.8891299783063, 10701.518431670516, 10708.625198118107, 10735.248532602722, 10767.515461804238, 10801.297915635458, 4312.784360781949, 4568.33759104928, 4616.630669546428, 4630.652701047435, 4657.5575320344515, 9223.769405764775, 9277.443353398818, 9341.953290233641, 9368.67209647659, 9369.953150234342, 5081.822136225214, 5156.664816786897, 5157.974210128926, 5179.2749015137915, 5204.817831375959, 4543.909461729228, 4626.144163329727, 4636.165490211727, 4710.976445117821, 4718.174319494075, 3225.7580681448985, 3344.8662053518074, 3371.8482668279985, 3837.865674701372, 3899.5515515716056, 958.9760255993516, 1193.1051711216587, 1243.8383010208615, 1250.3810613746073, 1258.157034786695, 694.5416025423197, 751.812046988253, 757.6476938223752, 776.8329809091073, 801.30686955784, 5380.7309634518115, 5441.918371224435, 5545.942720763691, 5654.3497497788285, 5681.886362272731, 898.0974121008345, 901.364538000708, 903.4759839293195, 916.3814425262921, 940.7789169545151, 3668.6331366863633, 3758.0980564664283, 3808.295465338921, 3810.3141434541494, 3819.6753275971296, 9169.083091690778, 9614.134727874525, 9694.36986595869, 9822.754431139136, 9890.901090988998, 9778.9022109778, 9781.266405019653, 9800.55897484615, 9813.950930245446, 9819.410835349901, 6786.151731033621, 7444.962775186089, 7652.0, 7749.7287594933905, 7758.92241077582, 5005.873678422471, 5389.703566303734, 5412.648177868426, 5470.589705772162, 5537.584681149011, 7865.0, 9008.144226298491, 9049.90950090517, 9141.222996045411, 9227.261819054595, 9149.31380146505, 9184.30090433272, 9222.907770922206, 9268.768280793034, 9300.488473134043, 6921.550099243533, 7011.6494175292055, 7071.752488662872, 7093.716251350094, 7101.786946391617, 7489.438292128003, 7761.340286075747, 7845.9215407845195, 7853.1361550228285, 7868.331191848757, 5590.86022849432, 6439.615482671248, 7053.259407762111, 7085.50401471892, 7180.174279957663, 6877.828054298682, 6936.861262774817, 6969.16370035599, 7032.085828842218, 7067.929320706727, 6262.937370626236, 6283.842903927439, 6307.306196318493, 6351.68241587928, 6366.427021568081, 3765.566959799658, 4113.91772164549, 4449.377087207728, 4481.641468682433, 4580.633549316113, 4724.645651576215, 4738.763061846825, 4791.544803243686, 4799.112164249625, 4899.3385892904], "value": 4298.904013027283, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [272.6687075203627, 351.4552443712245, 355.65501463580324, 358.3746362597268, 361.98190090495467, 5185.844424667256, 5241.449647786984, 5305.389880163782, 5417.0, 5432.076546987012, 5090.974545127269, 5312.73436328183, 5315.468453154683, 5328.49379308966, 5332.786688532464, 4147.502299724029, 4189.518205406372, 4190.790460476979, 4197.916041679165, 4202.243596152692, 4019.3167161582455, 4162.729422587538, 4179.352200408926, 4189.6438802701805, 4215.683823713219, 3747.681447077002, 3955.7230993830444, 4031.8588849390276, 4055.9391609125887, 4133.462649855514, 3499.6500349964926, 4073.207788573033, 4099.97950010248, 4126.628603425706, 4168.499780026386, 3666.5233519642543, 3674.9448758268645, 3676.3933950898067, 3681.7238707097076, 3707.9629203707887, 4201.789910504463, 5133.076046311662, 5146.562542183919, 5171.689698618095, 5224.197651810119, 4135.669146468275, 4692.671512994092, 4730.840943968749, 4739.549742774466, 4777.784999675023, 4811.182099043136, 5130.71781052042, 5552.500274975231, 5599.892059906751, 5607.495325420732, 3670.8164591770305, 3889.5138107736534, 3968.0, 3976.3439032559595, 4059.0110845685404, 5189.532942035197, 5289.841304760864, 5818.563607729395, 5881.735321910482, 5893.3222679391565, 3582.4268117101137, 3630.3283892479976, 4090.3250963590676, 4109.951962249667, 4121.26906699187, 3500.7724497908066, 3836.8465261389233, 3869.7484663496784, 4067.0333173919666, 4174.269502837052, 4104.363823607346, 4563.817447302071, 4665.930011049769, 4681.976590117028, 4706.294055891575, 5118.744062796845, 5261.316028916216, 5601.915971260434, 5645.854575261456, 5673.375928647845, 1190.214458457414, 1248.5193200617828, 1263.3746295583744, 1304.3673818198167, 1358.2190240611687, 770.3836930455614, 799.7920540659354, 818.5907046476761, 950.12588418655, 956.0773853231665, 4520.174890693316, 4607.861764147014, 4814.6870453420415, 4841.394825646794, 5142.97428512855, 5316.893662126736, 5494.450554944554, 5537.667739935617, 5540.473655002768, 5552.611317207838, 4242.957570424318, 4761.928566072606, 5025.547700706881, 5045.738565358661, 5050.3434553507805, 2686.597010448448, 2691.179190346963, 2772.5702516110036, 2876.4966130927423, 2935.106856077818, 5675.154590771512, 5678.886422271531, 5693.82918512437, 5803.303603567599, 5826.213461182686, 4491.977540112279, 4958.404991401055, 5019.858616641212, 5317.973410132925, 5634.661920284796, 5755.8273251801675, 5775.84483103381, 5787.797427090031, 5797.362290147996, 5805.680687562309, 5512.972435137799, 5513.283273174462, 5513.558915286687, 5541.445855414427, 5566.443355664401, 4343.500497442708, 5081.339425874613, 5242.475752424727, 5402.405735369185, 5433.7554810034435, 4956.752162391794, 5298.311219541435, 5588.720563971704, 5706.686132262766, 5736.827895163152, 3359.2105855124514, 3477.565304336958, 3900.317444447154, 3929.0766669833138, 3950.9209815802947, 4304.814437316426, 4530.750808705553, 4725.9291110632685, 5064.822126485499, 5152.613553983391, 5197.402298735694, 5342.305500284938, 5550.97224513891, 5619.775208991595, 5644.431783538562, 5564.888702226014, 5601.6358936668985, 5601.7759289629585, 5633.8591535211945, 5656.85857853557, 4740.739259340631, 4912.992836468587, 4945.986072854984, 5485.683435975417, 5494.2582751328055, 4785.425748910153, 5062.949370506248, 5491.297697713721, 5526.447355264602, 5660.943390566042, 4886.951130488792, 5257.684538927677, 5531.336239651107, 5547.195656629686, 5548.9722551388595], "value": 4056.989140415626, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [690.3131384272649, 700.1702981966367, 755.9622018899054, 778.4511919097038, 795.7055889320952, 14696.779548306771, 15375.461858834942, 15384.84615153848, 15387.768978481723, 15401.460948866792, 13861.0, 13997.0, 14022.509212177576, 14031.719365612682, 14057.367418466169, 653.6241661044894, 682.5733916302311, 814.4258297899996, 847.4999750147412, 850.7022542110243, 837.0374069819695, 850.2220468271524, 850.2390360627235, 850.3707256630111, 851.5657014922404, 906.102958071511, 906.5195446413411, 907.4691305586207, 908.1917093786535, 908.7455512456522, 897.273208700951, 898.7393655839799, 900.086412291528, 901.5402144906079, 905.9592318345624, 659.9835004124888, 670.5004771445256, 671.5467059734659, 672.0356288725694, 672.2269390201259, 14258.358373873201, 14266.64333391663, 14505.0, 15173.544793656209, 15218.847811521853, 13885.375158117808, 14160.504382346568, 14181.929090354586, 14211.502597409144, 14287.428502859873, 11455.54177832894, 11528.077753779762, 11589.188756787029, 11599.420028998516, 11754.29474231549, 3592.892213233581, 3636.61704023373, 3693.316736403774, 3716.8141592920515, 3833.3291673956946, 86286.13713862907, 87171.0, 91765.08234917698, 100452.0, 102010.48994754978, 10081.647142349982, 10902.890971090346, 10973.725656858642, 11015.669529914116, 11268.380239086766, 18199.727004094686, 21811.037006669158, 22110.22614208495, 22111.44721381978, 22120.465304612517, 7504.174540800507, 7646.694132234759, 7667.194944530744, 7680.577568233801, 7826.4130190235965, 4176.0395109125075, 4189.413482112506, 4195.706300558932, 4201.1375387797, 4233.957660423418, 3408.216110294646, 3523.5419395478934, 3555.040139162412, 3559.4482855157494, 3573.714102871764, 594.0851089322481, 617.0158597037718, 633.1547384242089, 636.700750647195, 647.5240698086902, 475.04041835492114, 580.5848818095083, 630.8518496336715, 641.6310621392718, 658.9769358072444, 7802.0, 8759.824803503894, 9228.676996305097, 9280.814383712423, 9287.860682089775, 600.1358044416027, 636.2810024672091, 637.1684951138808, 640.8654182621701, 645.0904225042761, 3606.5852426971232, 4255.107719214534, 4484.372187893698, 4517.728936263769, 4523.7285762854335, 104501.23479008435, 105738.47130764298, 106420.0, 106437.46781266044, 106630.0, 92819.60770588447, 92860.0, 94245.0, 94496.0, 95020.0, 68152.0, 74441.0, 75802.24197758062, 75987.62006189933, 77477.22522774813, 7669.9616501917135, 8202.138775428733, 8652.8367908023, 8725.345599079967, 8745.518996455, 38601.0, 54481.18278225751, 55040.44959550353, 55270.170947435014, 55299.0, 70633.64683176756, 73691.0, 74446.20530023225, 74495.0, 74592.0, 11578.131640126856, 11749.236299640495, 11791.88208117908, 11865.40672966331, 11946.163768536118, 9779.364341317792, 12483.251004939733, 12577.748445031231, 12593.559225427067, 13215.537456188988, 11216.0, 11733.178677492493, 11745.236559623598, 12186.14696971239, 13284.737949894745, 11316.0, 13488.0, 13718.794218086936, 14041.859581404464, 14077.436902523785, 13333.533326333532, 13343.199408035549, 13539.729205415639, 13616.52342168059, 13941.860581394056, 8546.572671366532, 10414.427206503715, 10730.839037414602, 10917.454127293762, 11222.66332010041, 9829.4102353859, 10995.285306455055, 11179.832302515631, 11454.0, 11549.898480433203], "value": 7249.720614572558, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1617.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 109.0, 165.0, 173.0, 159.0, 176.0, 141.0, 118.0, 123.0, 140.0], "value": 141.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 115.0, 113.0, 149.0, 115.0, 114.0, 128.0, 144.0, 173.0, 144.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 202.0, 271.0, 262.0, 285.0, 237.0, 200.0, 194.0, 192.0, 197.0], "value": 224.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 60.0, 87.0, 61.0, 63.0, 76.0, 84.0, 99.0, 56.0], "value": 72.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 78.0, 115.0, 106.0, 101.0, 71.0, 83.0, 71.0, 74.0, 97.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 92.0, 97.0, 93.0, 90.0, 121.0, 105.0, 92.0, 87.0], "value": 104.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 102.0, 102.0, 102.0, 104.0, 150.0, 175.0, 100.0, 102.0, 102.0], "value": 114.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 121.0, 144.0, 144.0, 90.0, 93.0, 96.0, 115.0, 132.0, 85.0], "value": 111.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 62.0, 63.0, 62.0, 63.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 69.0, 77.0, 77.0, 69.0, 70.0, 72.0, 63.0, 91.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 79.0, 103.0, 111.0, 76.0, 105.0, 75.0, 98.0, 80.0], "value": 90.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 159.0, 155.0, 137.0, 145.0, 141.0, 158.0, 157.0, 212.0, 159.0], "value": 157.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 173.0, 177.0, 173.0, 176.0, 176.0, 173.0, 176.0, 173.0, 182.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 68.0, 69.0, 71.0, 65.0, 69.0, 67.0, 62.0, 67.0], "value": 67.0, "unit": "score"}]}]} 11:58:38 INFO - Return code: 0 11:58:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:58:38 ERROR - # TBPL SUCCESS # 11:58:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:58:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:58:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:58:38 INFO - 2017-01-02 11:58:38.267 screenresolution[1667:12021] starting screenresolution argv=screenresolution get 11:58:38 INFO - 2017-01-02 11:58:38.269 screenresolution[1667:12021] Display 0: 1600x1200x32@60 11:58:38 INFO - 2017-01-02 11:58:38.275 screenresolution[1668:12024] starting screenresolution argv=screenresolution list 11:58:38 INFO - Available Modes on Display 0 11:58:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:58:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:58:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:58:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:58:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:58:38 INFO - Intel Iris: 11:58:38 INFO - Chipset Model: Intel Iris 11:58:38 INFO - Type: GPU 11:58:38 INFO - Bus: Built-In 11:58:38 INFO - VRAM (Dynamic, Max): 1536 MB 11:58:38 INFO - Vendor: Intel (0x8086) 11:58:38 INFO - Device ID: 0x0a2e 11:58:38 INFO - Revision ID: 0x0009 11:58:38 INFO - Displays: 11:58:38 INFO - Display: 11:58:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:58:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:58:38 INFO - Display Serial Number: 1600x1200 60 11:58:38 INFO - Main Display: Yes 11:58:38 INFO - Mirror: Off 11:58:38 INFO - Online: Yes 11:58:38 INFO - Rotation: Supported 11:58:38 INFO - Return code: 0 11:58:38 INFO - Running post-action listener: _resource_record_post_action 11:58:38 INFO - [mozharness: 2017-01-02 19:58:38.516927Z] Finished run-tests step (success) 11:58:38 INFO - Running post-run listener: _resource_record_post_run 11:58:38 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 34263552; Write bytes: 555780096; Read time: 331; Write time: 2211 11:58:38 INFO - TinderboxPrint: CPU usage
54.4% 11:58:38 INFO - TinderboxPrint: I/O read bytes / time
34,263,552 / 331 11:58:38 INFO - TinderboxPrint: I/O write bytes / time
555,780,096 / 2,211 11:58:38 INFO - TinderboxPrint: CPU idle
2,190.9 (45.6%) 11:58:38 INFO - TinderboxPrint: CPU system
964.9 (20.1%) 11:58:38 INFO - TinderboxPrint: CPU user
1,645.8 (34.3%) 11:58:38 INFO - TinderboxPrint: Swap in / out
279,683,072 / 0 11:58:38 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 241586688; Write bytes: 236455936; Read time: 17914; Write time: 544 11:58:38 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 32276992; Write bytes: 301989888; Read time: 307; Write time: 1628 11:58:38 INFO - Running post-run listener: _upload_blobber_files 11:58:38 INFO - Blob upload gear active. 11:58:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:58:38 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 11:58:38 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'] 11:58:38 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 11:58:39 INFO - (blobuploader) - INFO - Open directory for files ... 11:58:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:58:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:58:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:40 INFO - (blobuploader) - INFO - Done attempting. 11:58:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:58:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:58:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:41 INFO - (blobuploader) - INFO - Done attempting. 11:58:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:58:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:58:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:42 INFO - (blobuploader) - INFO - Done attempting. 11:58:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:58:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:58:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:58:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:58:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:58:44 INFO - (blobuploader) - INFO - Done attempting. 11:58:44 INFO - (blobuploader) - INFO - Iteration through files over. 11:58:44 INFO - Return code: 0 11:58:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:58:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:58:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bc6540e3d90834a2b75650ccd5100c8d4c98151df6255b8ce9285274151805edd7f4ed33f8b6541d91507c30cb3d7ed9ea650f6a94f0e7d40f4944fcbd8d713", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/429b61fe1d593b18b431b680a15abe269ddf81b6cc9e43c00299faaafa1a15bba5852ec28d3fa8f3dff7dc86eb8f2880927e57b33ec70b0e241b89f5a6eff1a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd35ee1cddb567b58ab6e5529d43ab5c56f8546f98fdd66810d5005d111d502775a7005722f323ff5b2944bad75832718ad74ecf0d7af16bba184921d3fa0f4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9eee838ddf9a33d1d5099ca3fc4d18b42771afaccefd00a428ce8d915487a9fc101a941e03b0dc48e0c0d81d750ebda36197f05dff294e57dddac43990504fd"} 11:58:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:58:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:58:44 INFO - Contents: 11:58:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bc6540e3d90834a2b75650ccd5100c8d4c98151df6255b8ce9285274151805edd7f4ed33f8b6541d91507c30cb3d7ed9ea650f6a94f0e7d40f4944fcbd8d713", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/429b61fe1d593b18b431b680a15abe269ddf81b6cc9e43c00299faaafa1a15bba5852ec28d3fa8f3dff7dc86eb8f2880927e57b33ec70b0e241b89f5a6eff1a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd35ee1cddb567b58ab6e5529d43ab5c56f8546f98fdd66810d5005d111d502775a7005722f323ff5b2944bad75832718ad74ecf0d7af16bba184921d3fa0f4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9eee838ddf9a33d1d5099ca3fc4d18b42771afaccefd00a428ce8d915487a9fc101a941e03b0dc48e0c0d81d750ebda36197f05dff294e57dddac43990504fd"} 11:58:44 INFO - Running post-run listener: copy_logs_to_upload_dir 11:58:44 INFO - Copying logs to upload dir... 11:58:44 INFO - mkdir: /builds/slave/test/build/upload/logs 11:58:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.970990 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-01-02 11:58:44.308335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 11:58:44.311797) ========= 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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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/5bc6540e3d90834a2b75650ccd5100c8d4c98151df6255b8ce9285274151805edd7f4ed33f8b6541d91507c30cb3d7ed9ea650f6a94f0e7d40f4944fcbd8d713", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/429b61fe1d593b18b431b680a15abe269ddf81b6cc9e43c00299faaafa1a15bba5852ec28d3fa8f3dff7dc86eb8f2880927e57b33ec70b0e241b89f5a6eff1a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd35ee1cddb567b58ab6e5529d43ab5c56f8546f98fdd66810d5005d111d502775a7005722f323ff5b2944bad75832718ad74ecf0d7af16bba184921d3fa0f4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9eee838ddf9a33d1d5099ca3fc4d18b42771afaccefd00a428ce8d915487a9fc101a941e03b0dc48e0c0d81d750ebda36197f05dff294e57dddac43990504fd"} build_url:https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/LjayOvF_SJeQaMuQReZttw/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5bc6540e3d90834a2b75650ccd5100c8d4c98151df6255b8ce9285274151805edd7f4ed33f8b6541d91507c30cb3d7ed9ea650f6a94f0e7d40f4944fcbd8d713", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/429b61fe1d593b18b431b680a15abe269ddf81b6cc9e43c00299faaafa1a15bba5852ec28d3fa8f3dff7dc86eb8f2880927e57b33ec70b0e241b89f5a6eff1a5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dd35ee1cddb567b58ab6e5529d43ab5c56f8546f98fdd66810d5005d111d502775a7005722f323ff5b2944bad75832718ad74ecf0d7af16bba184921d3fa0f4e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c9eee838ddf9a33d1d5099ca3fc4d18b42771afaccefd00a428ce8d915487a9fc101a941e03b0dc48e0c0d81d750ebda36197f05dff294e57dddac43990504fd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 11:58:44.346997) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 11:58:44.347289) ========= 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.92ecOg7Q2x/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.vYHS1u4H5j/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.005066 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 11:58:44.395084) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 11:58:44.395390) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 11:58:44.395693) ========= ========= Total master_lag: 0.20 =========