builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-079 starttime: 1502579960.23 results: success (0) revision: 30e6b0fd69ff4b3599eb6744ba12ccb75ea28598 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-12 16:19:20.231816) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-12 16:19:20.232495) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-12 16:19:20.232840) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-12 16:19:20.256528) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 16:19:20.256953) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-12 16:19:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-08-12 16:19:21 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107972 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 16:19:20.402661) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 16:19:20.402989) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019915 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 16:19:20.453860) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-12 16:19:20.454296) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 30e6b0fd69ff4b3599eb6744ba12ccb75ea28598 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 30e6b0fd69ff4b3599eb6744ba12ccb75ea28598 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-12 16:19:21,193 truncating revision to first 12 chars 2017-08-12 16:19:21,193 Setting DEBUG logging. 2017-08-12 16:19:21,193 attempt 1/10 2017-08-12 16:19:21,194 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/30e6b0fd69ff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-12 16:19:22,283 unpacking tar archive at: mozilla-central-30e6b0fd69ff/testing/mozharness/ program finished with exit code 0 elapsedTime=1.414575 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-12 16:19:21.886371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-12 16:19:21.887136) ========= script_repo_revision: 30e6b0fd69ff4b3599eb6744ba12ccb75ea28598 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-12 16:19:21.888077) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-12 16:19:21.888736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-12 16:19:21.900238) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-12 16:19:21.900571) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_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', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:19:22 INFO - MultiFileLogger online at 20170812 16:19:22 in /builds/slave/test 16:19:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:19:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:19:22 INFO - {'append_to_log': False, 16:19:22 INFO - 'base_work_dir': '/builds/slave/test', 16:19:22 INFO - 'blob_upload_branch': 'Firefox', 16:19:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:19:22 INFO - 'branch': 'Firefox', 16:19:22 INFO - 'buildbot_json_path': 'buildprops.json', 16:19:22 INFO - 'code_coverage': False, 16:19:22 INFO - 'config_files': ('talos/linux_config.py',), 16:19:22 INFO - 'default_actions': ('clobber', 16:19:22 INFO - 'read-buildbot-config', 16:19:22 INFO - 'download-and-extract', 16:19:22 INFO - 'populate-webroot', 16:19:22 INFO - 'create-virtualenv', 16:19:22 INFO - 'install', 16:19:22 INFO - 'setup-mitmproxy', 16:19:22 INFO - 'run-tests'), 16:19:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:19:22 INFO - 'disable_ccov_upload': False, 16:19:22 INFO - 'download_minidump_stackwalk': True, 16:19:22 INFO - 'download_symbols': 'ondemand', 16:19:22 INFO - 'enable_stylo': False, 16:19:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:19:22 INFO - 'tooltool.py': '/tools/tooltool.py', 16:19:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:19:22 INFO - '/tools/misc-python/virtualenv.py')}, 16:19:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:19:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:19:22 INFO - 'gecko_profile': False, 16:19:22 INFO - 'gecko_profile_interval': 0, 16:19:22 INFO - 'installer_path': 'installer.exe', 16:19:22 INFO - 'log_level': 'info', 16:19:22 INFO - 'log_name': 'talos', 16:19:22 INFO - 'log_to_console': True, 16:19:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:19:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:19:22 INFO - 'opt_config_files': (), 16:19:22 INFO - 'pip_index': False, 16:19:22 INFO - 'suite': 'dromaeojs-e10s', 16:19:22 INFO - 'system_bits': '32', 16:19:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:19:22 INFO - 'title': 'talos-linux64-ix-079', 16:19:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:19:22 INFO - 'use_talos_json': True, 16:19:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:19:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:19:22 INFO - 'work_dir': 'build'} 16:19:22 INFO - [mozharness: 2017-08-12 23:19:22.748826Z] Running clobber step. 16:19:22 INFO - Running pre-action listener: _resource_record_pre_action 16:19:22 INFO - Running main action method: clobber 16:19:22 INFO - rmtree: /builds/slave/test/build 16:19:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:19:23 INFO - Running post-action listener: _resource_record_post_action 16:19:23 INFO - [mozharness: 2017-08-12 23:19:23.782002Z] Finished clobber step (success) 16:19:23 INFO - [mozharness: 2017-08-12 23:19:23.782105Z] Running read-buildbot-config step. 16:19:23 INFO - Running pre-action listener: _resource_record_pre_action 16:19:23 INFO - Running main action method: read_buildbot_config 16:19:23 INFO - Using buildbot properties: 16:19:23 INFO - { 16:19:23 INFO - "project": "", 16:19:23 INFO - "product": "firefox", 16:19:23 INFO - "who": "jdolske@mozilla.com", 16:19:23 INFO - "installer_path": "public/build/target.tar.bz2", 16:19:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 16:19:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:19:23 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 16:19:23 INFO - "stage_platform": "linux64-stylosequential", 16:19:23 INFO - "basedir": "/builds/slave/test", 16:19:23 INFO - "buildnumber": 185, 16:19:23 INFO - "platform": "ubuntu64_hw_styloseq", 16:19:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:19:23 INFO - "slavebuilddir": "test", 16:19:23 INFO - "taskId": "PHdWFMJhRQqScJWtb4vzjQ", 16:19:23 INFO - "branch": "mozilla-central", 16:19:23 INFO - "script_repo_revision": "production", 16:19:23 INFO - "revision": "30e6b0fd69ff4b3599eb6744ba12ccb75ea28598", 16:19:23 INFO - "slavename": "talos-linux64-ix-079", 16:19:23 INFO - "repo_path": "mozilla-central" 16:19:23 INFO - } 16:19:23 INFO - Finding installer, test and symbols from parent task. 16:19:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PHdWFMJhRQqScJWtb4vzjQ'}, attempt #1 16:19:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PHdWFMJhRQqScJWtb4vzjQ'}, attempt #1 16:19:24 INFO - Task dependencies: eRGUWGbpQu2kTLRetgvcig 16:19:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig'}, attempt #1 16:19:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.tar.bz2 16:19:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.test_packages.json 16:19:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.crashreporter-symbols.zip 16:19:25 INFO - Running post-action listener: _resource_record_post_action 16:19:25 INFO - [mozharness: 2017-08-12 23:19:25.112728Z] Finished read-buildbot-config step (success) 16:19:25 INFO - [mozharness: 2017-08-12 23:19:25.112952Z] Running download-and-extract step. 16:19:25 INFO - Running pre-action listener: _resource_record_pre_action 16:19:25 INFO - Running main action method: download_and_extract 16:19:25 INFO - mkdir: /builds/slave/test/build/tests 16:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:25 INFO - trying https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.test_packages.json 16:19:25 INFO - Downloading https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:19:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:19:25 INFO - Downloaded 989 bytes. 16:19:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:19:25 INFO - Using the following test package requirements: 16:19:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:19:25 INFO - u'common': [u'target.common.tests.zip'], 16:19:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:19:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:19:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:19:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:19:25 INFO - u'mozbase': [u'target.common.tests.zip'], 16:19:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:19:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:19:25 INFO - u'web-platform': [u'target.common.tests.zip', 16:19:25 INFO - u'target.web-platform.tests.tar.gz'], 16:19:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:19:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:19:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.common.tests.zip 16:19:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:19:25 INFO - Fetch https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.common.tests.zip into memory 16:19:26 INFO - Content-Length response header: 54034059 16:19:26 INFO - Bytes received: 54034059 16:19:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:19:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.common.tests.zip 16:19:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:19:37 INFO - Fetch https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.common.tests.zip into memory 16:19:38 INFO - Content-Length response header: 54034059 16:19:38 INFO - Bytes received: 54034059 16:19:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.talos.tests.zip 16:19:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:19:50 INFO - Fetch https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.talos.tests.zip into memory 16:19:51 INFO - Content-Length response header: 14496050 16:19:51 INFO - Bytes received: 14496050 16:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:51 INFO - trying https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.tar.bz2 16:19:51 INFO - Downloading https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:19:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:19:52 INFO - Downloaded 61821479 bytes. 16:19:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.tar.bz2 16:19:52 INFO - mkdir: /builds/slave/test/properties 16:19:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:19:52 INFO - Writing to file /builds/slave/test/properties/build_url 16:19:52 INFO - Contents: 16:19:52 INFO - build_url:https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.tar.bz2 16:19:52 INFO - Running post-action listener: _resource_record_post_action 16:19:52 INFO - Running post-action listener: set_extra_try_arguments 16:19:52 INFO - [mozharness: 2017-08-12 23:19:52.841919Z] Finished download-and-extract step (success) 16:19:52 INFO - [mozharness: 2017-08-12 23:19:52.842019Z] Running populate-webroot step. 16:19:52 INFO - Running pre-action listener: _resource_record_pre_action 16:19:52 INFO - Running main action method: populate_webroot 16:19:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:19:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:19:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:19:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:19:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:19:52 INFO - 'tests': ['damp', 'tps']}, 16:19:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:19:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:19:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:19:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:19:52 INFO - 'other-e10s': {'tests': ['a11yr', 16:19:52 INFO - 'ts_paint', 16:19:52 INFO - 'tpaint', 16:19:52 INFO - 'sessionrestore', 16:19:52 INFO - 'sessionrestore_many_windows', 16:19:52 INFO - 'sessionrestore_no_auto_restore', 16:19:52 INFO - 'tabpaint']}, 16:19:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:19:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:19:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:19:52 INFO - 'tsvgr_opacity', 16:19:52 INFO - 'tart', 16:19:52 INFO - 'tscrollx', 16:19:52 INFO - 'tsvg_static']}, 16:19:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:19:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:19:52 INFO - 'talos_options': ['--mitmproxy', 16:19:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:19:52 INFO - '--firstNonBlankPaint'], 16:19:52 INFO - 'tests': ['tp6_google', 16:19:52 INFO - 'tp6_youtube', 16:19:52 INFO - 'tp6_amazon', 16:19:52 INFO - 'tp6_facebook']}, 16:19:52 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:19:52 INFO - 'talos_options': ['--stylo', 16:19:52 INFO - '--mitmproxy', 16:19:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:19:52 INFO - '--firstNonBlankPaint'], 16:19:52 INFO - 'tests': ['tp6_google', 16:19:52 INFO - 'tp6_youtube', 16:19:52 INFO - 'tp6_amazon', 16:19:52 INFO - 'tp6_facebook']}, 16:19:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:19:52 INFO - 'talos_options': ['--stylo', 16:19:52 INFO - '--stylo-threads=1', 16:19:52 INFO - '--mitmproxy', 16:19:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:19:52 INFO - '--firstNonBlankPaint'], 16:19:52 INFO - 'tests': ['tp6_google', 16:19:52 INFO - 'tp6_youtube', 16:19:52 INFO - 'tp6_amazon', 16:19:52 INFO - 'tp6_facebook']}, 16:19:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:19:52 INFO - 'talos_options': ['--xperf_path', 16:19:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:19:52 INFO - 'tests': ['tp5n']}}} 16:19:52 INFO - Running post-action listener: _resource_record_post_action 16:19:52 INFO - [mozharness: 2017-08-12 23:19:52.850546Z] Finished populate-webroot step (success) 16:19:52 INFO - [mozharness: 2017-08-12 23:19:52.850638Z] Running create-virtualenv step. 16:19:52 INFO - Running pre-action listener: _resource_record_pre_action 16:19:52 INFO - Running main action method: create_virtualenv 16:19:52 INFO - Creating virtualenv /builds/slave/test/build/venv 16:19:52 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 16:19:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:19:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:19:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:19:52 INFO - Using real prefix '/usr' 16:19:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:19:53 INFO - Installing distribute.............................................................................................................................................................................................done. 16:19:55 INFO - Installing pip.................done. 16:19:55 INFO - Return code: 0 16:19:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:19:55 INFO - Reading from file tmpfile_stdout 16:19:55 INFO - Output received: 16:19:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:19:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1202b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f00>, '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 0x1200ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1201050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:19:55 INFO - Using env: {'DISPLAY': ':0', 16:19:55 INFO - 'HOME': '/home/cltbld', 16:19:55 INFO - 'LANG': 'en_US.UTF-8', 16:19:55 INFO - 'LANGUAGE': 'en_US:en', 16:19:55 INFO - 'LOGNAME': 'cltbld', 16:19:55 INFO - 'MAIL': '/var/mail/cltbld', 16:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:55 INFO - 'MOZ_NO_REMOTE': '1', 16:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:55 INFO - 'NO_EM_RESTART': '1', 16:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:55 INFO - 'PWD': '/builds/slave/test', 16:19:55 INFO - 'SHELL': '/bin/bash', 16:19:55 INFO - 'SHLVL': '1', 16:19:55 INFO - 'TERM': 'linux', 16:19:55 INFO - 'TMOUT': '86400', 16:19:55 INFO - 'USER': 'cltbld', 16:19:55 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 16:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:55 INFO - '_': '/tools/buildbot/bin/python'} 16:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:19:55 INFO - Cleaning up... 16:19:55 INFO - Return code: 0 16:19:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1202b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f00>, '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 0x1200ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1201050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:19:55 INFO - Using env: {'DISPLAY': ':0', 16:19:55 INFO - 'HOME': '/home/cltbld', 16:19:55 INFO - 'LANG': 'en_US.UTF-8', 16:19:55 INFO - 'LANGUAGE': 'en_US:en', 16:19:55 INFO - 'LOGNAME': 'cltbld', 16:19:55 INFO - 'MAIL': '/var/mail/cltbld', 16:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:55 INFO - 'MOZ_NO_REMOTE': '1', 16:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:55 INFO - 'NO_EM_RESTART': '1', 16:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:55 INFO - 'PWD': '/builds/slave/test', 16:19:55 INFO - 'SHELL': '/bin/bash', 16:19:55 INFO - 'SHLVL': '1', 16:19:55 INFO - 'TERM': 'linux', 16:19:55 INFO - 'TMOUT': '86400', 16:19:55 INFO - 'USER': 'cltbld', 16:19:55 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 16:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:55 INFO - '_': '/tools/buildbot/bin/python'} 16:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:56 INFO - Downloading/unpacking psutil>=3.1.1 16:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:19:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:57 INFO - Installing collected packages: psutil 16:19:57 INFO - Running setup.py install for psutil 16:19:57 INFO - building 'psutil._psutil_linux' extension 16:19:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:19:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:19:57 INFO - building 'psutil._psutil_posix' extension 16:19:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:19:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:19:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:19:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:19:57 INFO - Successfully installed psutil 16:19:57 INFO - Cleaning up... 16:19:57 INFO - Return code: 0 16:19:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1202b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f00>, '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 0x1200ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1201050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:19:57 INFO - Using env: {'DISPLAY': ':0', 16:19:57 INFO - 'HOME': '/home/cltbld', 16:19:57 INFO - 'LANG': 'en_US.UTF-8', 16:19:57 INFO - 'LANGUAGE': 'en_US:en', 16:19:57 INFO - 'LOGNAME': 'cltbld', 16:19:57 INFO - 'MAIL': '/var/mail/cltbld', 16:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:57 INFO - 'MOZ_NO_REMOTE': '1', 16:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:57 INFO - 'NO_EM_RESTART': '1', 16:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:57 INFO - 'PWD': '/builds/slave/test', 16:19:57 INFO - 'SHELL': '/bin/bash', 16:19:57 INFO - 'SHLVL': '1', 16:19:57 INFO - 'TERM': 'linux', 16:19:57 INFO - 'TMOUT': '86400', 16:19:57 INFO - 'USER': 'cltbld', 16:19:57 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 16:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:57 INFO - '_': '/tools/buildbot/bin/python'} 16:19:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:19:57 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 16:19:57 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 16:19:57 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 16:19:57 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 16:19:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:19:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:19:59 INFO - Installing collected packages: mozsystemmonitor 16:19:59 INFO - Running setup.py install for mozsystemmonitor 16:19:59 INFO - Successfully installed mozsystemmonitor 16:19:59 INFO - Cleaning up... 16:19:59 INFO - Return code: 0 16:19:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1202b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f00>, '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 0x1200ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1201050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:19:59 INFO - Using env: {'DISPLAY': ':0', 16:19:59 INFO - 'HOME': '/home/cltbld', 16:19:59 INFO - 'LANG': 'en_US.UTF-8', 16:19:59 INFO - 'LANGUAGE': 'en_US:en', 16:19:59 INFO - 'LOGNAME': 'cltbld', 16:19:59 INFO - 'MAIL': '/var/mail/cltbld', 16:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:19:59 INFO - 'MOZ_NO_REMOTE': '1', 16:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:19:59 INFO - 'NO_EM_RESTART': '1', 16:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:19:59 INFO - 'PWD': '/builds/slave/test', 16:19:59 INFO - 'SHELL': '/bin/bash', 16:19:59 INFO - 'SHLVL': '1', 16:19:59 INFO - 'TERM': 'linux', 16:19:59 INFO - 'TMOUT': '86400', 16:19:59 INFO - 'USER': 'cltbld', 16:19:59 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 16:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:19:59 INFO - '_': '/tools/buildbot/bin/python'} 16:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:19:59 INFO - Downloading/unpacking jsonschema==2.5.1 16:19:59 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 16:19:59 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 16:19:59 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 16:19:59 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 16:20:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:20:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:00 INFO - Downloading functools32-3.2.3-2.tar.gz 16:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:20:00 INFO - warning: no files found matching '*.txt' 16:20:00 INFO - no previously-included directories found matching 'build' 16:20:00 INFO - no previously-included directories found matching 'dist' 16:20:00 INFO - no previously-included directories found matching '.git*' 16:20:00 INFO - Installing collected packages: jsonschema, functools32 16:20:00 INFO - Running setup.py install for functools32 16:20:00 INFO - warning: no files found matching '*.txt' 16:20:00 INFO - no previously-included directories found matching 'build' 16:20:00 INFO - no previously-included directories found matching 'dist' 16:20:00 INFO - no previously-included directories found matching '.git*' 16:20:00 INFO - Successfully installed jsonschema functools32 16:20:00 INFO - Cleaning up... 16:20:00 INFO - Return code: 0 16:20:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1202b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f00>, '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 0x1200ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1201050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:20:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:20:00 INFO - Using env: {'DISPLAY': ':0', 16:20:00 INFO - 'HOME': '/home/cltbld', 16:20:00 INFO - 'LANG': 'en_US.UTF-8', 16:20:00 INFO - 'LANGUAGE': 'en_US:en', 16:20:00 INFO - 'LOGNAME': 'cltbld', 16:20:00 INFO - 'MAIL': '/var/mail/cltbld', 16:20:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:00 INFO - 'MOZ_NO_REMOTE': '1', 16:20:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:00 INFO - 'NO_EM_RESTART': '1', 16:20:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:00 INFO - 'PWD': '/builds/slave/test', 16:20:00 INFO - 'SHELL': '/bin/bash', 16:20:00 INFO - 'SHLVL': '1', 16:20:00 INFO - 'TERM': 'linux', 16:20:00 INFO - 'TMOUT': '86400', 16:20:00 INFO - 'USER': 'cltbld', 16:20:00 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 16:20:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:00 INFO - '_': '/tools/buildbot/bin/python'} 16:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:20:01 INFO - Cleaning up... 16:20:01 INFO - Return code: 0 16:20:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1202b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f00>, '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 0x1200ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1201050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:20:01 INFO - Using env: {'DISPLAY': ':0', 16:20:01 INFO - 'HOME': '/home/cltbld', 16:20:01 INFO - 'LANG': 'en_US.UTF-8', 16:20:01 INFO - 'LANGUAGE': 'en_US:en', 16:20:01 INFO - 'LOGNAME': 'cltbld', 16:20:01 INFO - 'MAIL': '/var/mail/cltbld', 16:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:01 INFO - 'MOZ_NO_REMOTE': '1', 16:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:01 INFO - 'NO_EM_RESTART': '1', 16:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:01 INFO - 'PWD': '/builds/slave/test', 16:20:01 INFO - 'SHELL': '/bin/bash', 16:20:01 INFO - 'SHLVL': '1', 16:20:01 INFO - 'TERM': 'linux', 16:20:01 INFO - 'TMOUT': '86400', 16:20:01 INFO - 'USER': 'cltbld', 16:20:01 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 16:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:01 INFO - '_': '/tools/buildbot/bin/python'} 16:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:01 INFO - Downloading/unpacking blobuploader==1.2.4 16:20:01 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 16:20:01 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 16:20:01 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 16:20:01 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 16:20:02 INFO - Downloading blobuploader-1.2.4.tar.gz 16:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:20:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:20:02 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 16:20:02 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 16:20:02 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 16:20:02 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 16:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:20:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:20:02 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 16:20:02 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 16:20:02 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 16:20:02 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 16:20:03 INFO - Downloading docopt-0.6.1.tar.gz 16:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:20:03 INFO - Installing collected packages: blobuploader, requests, docopt 16:20:03 INFO - Running setup.py install for blobuploader 16:20:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:20:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:20:03 INFO - Running setup.py install for requests 16:20:03 INFO - Running setup.py install for docopt 16:20:03 INFO - Successfully installed blobuploader requests docopt 16:20:03 INFO - Cleaning up... 16:20:03 INFO - Return code: 0 16:20:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1202b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f00>, '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 0x1200ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1201050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:20:03 INFO - Using env: {'DISPLAY': ':0', 16:20:03 INFO - 'HOME': '/home/cltbld', 16:20:03 INFO - 'LANG': 'en_US.UTF-8', 16:20:03 INFO - 'LANGUAGE': 'en_US:en', 16:20:03 INFO - 'LOGNAME': 'cltbld', 16:20:03 INFO - 'MAIL': '/var/mail/cltbld', 16:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:03 INFO - 'MOZ_NO_REMOTE': '1', 16:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:03 INFO - 'NO_EM_RESTART': '1', 16:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:03 INFO - 'PWD': '/builds/slave/test', 16:20:03 INFO - 'SHELL': '/bin/bash', 16:20:03 INFO - 'SHLVL': '1', 16:20:03 INFO - 'TERM': 'linux', 16:20:03 INFO - 'TMOUT': '86400', 16:20:03 INFO - 'USER': 'cltbld', 16:20:03 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 16:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:03 INFO - '_': '/tools/buildbot/bin/python'} 16:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:20:03 INFO - Running setup.py (path:/tmp/pip-KfCifi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:20:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:20:03 INFO - Running setup.py (path:/tmp/pip-C5NGCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:20:04 INFO - Running setup.py (path:/tmp/pip-gY1B2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:20:04 INFO - Running setup.py (path:/tmp/pip-waOjRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:20:04 INFO - Running setup.py (path:/tmp/pip-3U3Wi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:20:04 INFO - Running setup.py (path:/tmp/pip-vWehak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:20:04 INFO - Running setup.py (path:/tmp/pip-7Kb3Nu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:20:04 INFO - Running setup.py (path:/tmp/pip-I6lJ3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:20:04 INFO - Running setup.py (path:/tmp/pip-4d1Str-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:20:04 INFO - Running setup.py (path:/tmp/pip-MJWbzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:20:04 INFO - Running setup.py (path:/tmp/pip-OB66Gl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:20:04 INFO - Running setup.py (path:/tmp/pip-ZUxw_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:20:04 INFO - Running setup.py (path:/tmp/pip-kI3Rvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:20:04 INFO - Running setup.py (path:/tmp/pip-Obl3rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:04 INFO - Running setup.py (path:/tmp/pip-XRD7U5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:20:04 INFO - Running setup.py (path:/tmp/pip-Pri11B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:20:05 INFO - Running setup.py (path:/tmp/pip-qG0keW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:20:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:20:05 INFO - Running setup.py install for manifestparser 16:20:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:20:05 INFO - Running setup.py install for mozcrash 16:20:05 INFO - Running setup.py install for mozdebug 16:20:05 INFO - Running setup.py install for mozdevice 16:20:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:20:05 INFO - Running setup.py install for mozfile 16:20:05 INFO - Running setup.py install for mozhttpd 16:20:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:20:05 INFO - Running setup.py install for mozinfo 16:20:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:20:05 INFO - Running setup.py install for mozInstall 16:20:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:20:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:20:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:20:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:20:05 INFO - Running setup.py install for mozleak 16:20:06 INFO - Running setup.py install for mozlog 16:20:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:20:06 INFO - Running setup.py install for moznetwork 16:20:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:20:06 INFO - Running setup.py install for mozprocess 16:20:06 INFO - Running setup.py install for mozprofile 16:20:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:20:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:20:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:20:06 INFO - Running setup.py install for mozrunner 16:20:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:20:06 INFO - Running setup.py install for mozscreenshot 16:20:06 INFO - Running setup.py install for moztest 16:20:06 INFO - Running setup.py install for mozversion 16:20:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:20:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:20:06 INFO - Cleaning up... 16:20:06 INFO - Return code: 0 16:20:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1202b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f00>, '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 0x1200ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1201050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:20:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:20:06 INFO - Using env: {'DISPLAY': ':0', 16:20:06 INFO - 'HOME': '/home/cltbld', 16:20:06 INFO - 'LANG': 'en_US.UTF-8', 16:20:06 INFO - 'LANGUAGE': 'en_US:en', 16:20:06 INFO - 'LOGNAME': 'cltbld', 16:20:06 INFO - 'MAIL': '/var/mail/cltbld', 16:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:06 INFO - 'MOZ_NO_REMOTE': '1', 16:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:06 INFO - 'NO_EM_RESTART': '1', 16:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:06 INFO - 'PWD': '/builds/slave/test', 16:20:06 INFO - 'SHELL': '/bin/bash', 16:20:06 INFO - 'SHLVL': '1', 16:20:06 INFO - 'TERM': 'linux', 16:20:06 INFO - 'TMOUT': '86400', 16:20:06 INFO - 'USER': 'cltbld', 16:20:06 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 16:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:06 INFO - '_': '/tools/buildbot/bin/python'} 16:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:20:07 INFO - Running setup.py (path:/tmp/pip-FfjL2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:20:07 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)) 16:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:20:07 INFO - Running setup.py (path:/tmp/pip-hG2AQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:20:07 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)) 16:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:20:07 INFO - Running setup.py (path:/tmp/pip-YIjQTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:20:07 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)) 16:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:20:07 INFO - Running setup.py (path:/tmp/pip-ZHztcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:20:07 INFO - Running setup.py (path:/tmp/pip-vjgbRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:20:07 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)) 16:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:20:07 INFO - Running setup.py (path:/tmp/pip-1DfXaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:20:07 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)) 16:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:20:07 INFO - Running setup.py (path:/tmp/pip-1F0PQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:20:07 INFO - Running setup.py (path:/tmp/pip-a3ZHcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:20:07 INFO - Running setup.py (path:/tmp/pip-0yKsUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:20:07 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)) 16:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:20:07 INFO - Running setup.py (path:/tmp/pip-JVGrt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 16:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:20:07 INFO - Running setup.py (path:/tmp/pip-sTYFCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:20:07 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)) 16:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:20:07 INFO - Running setup.py (path:/tmp/pip-Dz3GzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:20:08 INFO - Running setup.py (path:/tmp/pip-qr9p3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:20:08 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)) 16:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:20:08 INFO - Running setup.py (path:/tmp/pip-05Kpu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:20:08 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)) 16:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:08 INFO - Running setup.py (path:/tmp/pip-vcvoXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:20:08 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)) 16:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:20:08 INFO - Running setup.py (path:/tmp/pip-oUxt70-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:20:08 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)) 16:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:20:08 INFO - Running setup.py (path:/tmp/pip-bmtPDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:20:08 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)) 16:20:08 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)) 16:20:08 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)) 16:20:08 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)) 16:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:20:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:09 INFO - Downloading blessings-1.6.tar.gz 16:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:20:09 INFO - Installing collected packages: blessings 16:20:09 INFO - Running setup.py install for blessings 16:20:09 INFO - Successfully installed blessings 16:20:09 INFO - Cleaning up... 16:20:09 INFO - Return code: 0 16:20:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:20:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:20:09 INFO - Reading from file tmpfile_stdout 16:20:09 INFO - Current package versions: 16:20:09 INFO - argparse == 1.2.1 16:20:09 INFO - blessings == 1.6 16:20:09 INFO - blobuploader == 1.2.4 16:20:09 INFO - docopt == 0.6.1 16:20:09 INFO - functools32 == 3.2.3-2 16:20:09 INFO - jsonschema == 2.5.1 16:20:09 INFO - manifestparser == 1.1 16:20:09 INFO - mozInstall == 1.13 16:20:09 INFO - mozcrash == 1.0 16:20:09 INFO - mozdebug == 0.1 16:20:09 INFO - mozdevice == 0.51 16:20:09 INFO - mozfile == 1.2 16:20:09 INFO - mozhttpd == 0.7 16:20:09 INFO - mozinfo == 0.10 16:20:09 INFO - mozleak == 0.1 16:20:09 INFO - mozlog == 3.5 16:20:09 INFO - moznetwork == 0.27 16:20:09 INFO - mozprocess == 0.25 16:20:09 INFO - mozprofile == 0.28 16:20:09 INFO - mozrunner == 6.13 16:20:09 INFO - mozscreenshot == 0.1 16:20:09 INFO - mozsystemmonitor == 0.3 16:20:09 INFO - moztest == 0.8 16:20:09 INFO - mozversion == 1.4 16:20:09 INFO - psutil == 3.1.1 16:20:09 INFO - requests == 1.2.3 16:20:09 INFO - wsgiref == 0.1.2 16:20:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1202b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f00>, '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 0x1200ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1201050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:20:09 INFO - Using env: {'DISPLAY': ':0', 16:20:09 INFO - 'HOME': '/home/cltbld', 16:20:09 INFO - 'LANG': 'en_US.UTF-8', 16:20:09 INFO - 'LANGUAGE': 'en_US:en', 16:20:09 INFO - 'LOGNAME': 'cltbld', 16:20:09 INFO - 'MAIL': '/var/mail/cltbld', 16:20:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:09 INFO - 'MOZ_NO_REMOTE': '1', 16:20:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:09 INFO - 'NO_EM_RESTART': '1', 16:20:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:09 INFO - 'PWD': '/builds/slave/test', 16:20:09 INFO - 'SHELL': '/bin/bash', 16:20:09 INFO - 'SHLVL': '1', 16:20:09 INFO - 'TERM': 'linux', 16:20:09 INFO - 'TMOUT': '86400', 16:20:09 INFO - 'USER': 'cltbld', 16:20:09 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 16:20:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:09 INFO - '_': '/tools/buildbot/bin/python'} 16:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:10 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)) 16:20:10 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)) 16:20:10 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)) 16:20:10 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)) 16:20:10 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)) 16:20:10 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)) 16:20:10 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)) 16:20:10 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)) 16:20:10 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)) 16:20:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:20:11 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)) 16:20:11 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)) 16:20:11 INFO - Installing collected packages: simplejson 16:20:11 INFO - Running setup.py install for simplejson 16:20:11 INFO - building 'simplejson._speedups' extension 16:20:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 16:20:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 16:20:12 INFO - Successfully installed simplejson 16:20:12 INFO - Cleaning up... 16:20:12 INFO - Return code: 0 16:20:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1061a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1202b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f00>, '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 0x1200ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1201050>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:20:12 INFO - Using env: {'DISPLAY': ':0', 16:20:12 INFO - 'HOME': '/home/cltbld', 16:20:12 INFO - 'LANG': 'en_US.UTF-8', 16:20:12 INFO - 'LANGUAGE': 'en_US:en', 16:20:12 INFO - 'LOGNAME': 'cltbld', 16:20:12 INFO - 'MAIL': '/var/mail/cltbld', 16:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:12 INFO - 'MOZ_NO_REMOTE': '1', 16:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:12 INFO - 'NO_EM_RESTART': '1', 16:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:12 INFO - 'PWD': '/builds/slave/test', 16:20:12 INFO - 'SHELL': '/bin/bash', 16:20:12 INFO - 'SHLVL': '1', 16:20:12 INFO - 'TERM': 'linux', 16:20:12 INFO - 'TMOUT': '86400', 16:20:12 INFO - 'USER': 'cltbld', 16:20:12 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 16:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:12 INFO - '_': '/tools/buildbot/bin/python'} 16:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:20:12 INFO - Cleaning up... 16:20:12 INFO - Return code: 0 16:20:12 INFO - Running post-action listener: _resource_record_post_action 16:20:12 INFO - Running post-action listener: _start_resource_monitoring 16:20:12 INFO - Starting resource monitoring. 16:20:12 INFO - [mozharness: 2017-08-12 23:20:12.631650Z] Finished create-virtualenv step (success) 16:20:12 INFO - [mozharness: 2017-08-12 23:20:12.632161Z] Running install step. 16:20:12 INFO - Running pre-action listener: _resource_record_pre_action 16:20:12 INFO - Running main action method: install 16:20:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:20:12 INFO - Reading from file tmpfile_stdout 16:20:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:20:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:20:12 INFO - Reading from file tmpfile_stdout 16:20:12 INFO - Output received: 16:20:12 INFO - Usage: mozinstall [options] installer 16:20:12 INFO - Options: 16:20:12 INFO - -h, --help show this help message and exit 16:20:12 INFO - -d DEST, --destination=DEST 16:20:12 INFO - Directory to install application into. [default: 16:20:12 INFO - "/builds/slave/test"] 16:20:12 INFO - --app=APP Application being installed. [default: firefox] 16:20:12 INFO - mkdir: /builds/slave/test/build/application 16:20:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:20:30 INFO - Reading from file tmpfile_stdout 16:20:30 INFO - Output received: 16:20:30 INFO - /builds/slave/test/build/application/firefox/firefox 16:20:30 INFO - Running post-action listener: _resource_record_post_action 16:20:30 INFO - [mozharness: 2017-08-12 23:20:30.968304Z] Finished install step (success) 16:20:30 INFO - [mozharness: 2017-08-12 23:20:30.968559Z] Running setup-mitmproxy step. 16:20:30 INFO - Running pre-action listener: _resource_record_pre_action 16:20:30 INFO - Running main action method: setup_mitmproxy 16:20:30 INFO - Skipping: mitmproxy is not required 16:20:30 INFO - Running post-action listener: _resource_record_post_action 16:20:30 INFO - [mozharness: 2017-08-12 23:20:30.969763Z] Finished setup-mitmproxy step (success) 16:20:30 INFO - [mozharness: 2017-08-12 23:20:30.969988Z] Running run-tests step. 16:20:30 INFO - Running pre-action listener: _resource_record_pre_action 16:20:30 INFO - Running pre-action listener: _set_gcov_prefix 16:20:30 INFO - Running main action method: run_tests 16:20:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:20:30 INFO - Python 2.7.3 16:20:30 INFO - Return code: 0 16:20:30 INFO - grabbing minidump binary from tooltool 16:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:20:30 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/linux64/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 0x1205f00>, '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 0x1200ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1201050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:20:30 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:20:30 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/linux64/releng.manifest -o -c /builds/tooltool_cache 16:20:30 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:20:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:20:31 INFO - Return code: 0 16:20:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:20:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:20:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:20:31 INFO - ENV: RUST_BACKTRACE is now full 16:20:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:20:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:20:31 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/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 16:20:31 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/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-079 --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 16:20:31 INFO - Using env: {'DISPLAY': ':0', 16:20:31 INFO - 'HOME': '/home/cltbld', 16:20:31 INFO - 'LANG': 'en_US.UTF-8', 16:20:31 INFO - 'LANGUAGE': 'en_US:en', 16:20:31 INFO - 'LOGNAME': 'cltbld', 16:20:31 INFO - 'MAIL': '/var/mail/cltbld', 16:20:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:20:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:31 INFO - 'MOZ_NO_REMOTE': '1', 16:20:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:31 INFO - 'NO_EM_RESTART': '1', 16:20:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:31 INFO - 'PWD': '/builds/slave/test', 16:20:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:20:31 INFO - 'RUST_BACKTRACE': 'full', 16:20:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:20:31 INFO - 'SHELL': '/bin/bash', 16:20:31 INFO - 'SHLVL': '1', 16:20:31 INFO - 'STYLO_FORCE_ENABLED': '1', 16:20:31 INFO - 'TERM': 'linux', 16:20:31 INFO - 'TMOUT': '86400', 16:20:31 INFO - 'USER': 'cltbld', 16:20:31 INFO - 'XDG_SESSION_COOKIE': '1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434', 16:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:31 INFO - '_': '/tools/buildbot/bin/python'} 16:20:31 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/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-079', '--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 16:20:31 INFO - mozversion application_buildid: 20170812223654 16:20:31 INFO - mozversion application_changeset: 30e6b0fd69ff4b3599eb6744ba12ccb75ea28598 16:20:31 INFO - mozversion application_display_name: Nightly 16:20:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:20:31 INFO - mozversion application_name: Firefox 16:20:31 INFO - mozversion application_remotingname: firefox 16:20:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:20:31 INFO - mozversion application_vendor: Mozilla 16:20:31 INFO - mozversion application_version: 57.0a1 16:20:31 INFO - mozversion platform_buildid: 20170812223654 16:20:31 INFO - mozversion platform_changeset: 30e6b0fd69ff4b3599eb6744ba12ccb75ea28598 16:20:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:20:31 INFO - mozversion platform_version: 57.0a1 16:20:31 INFO - using testdate: 1502580031 16:20:31 INFO - actual date: 1502580031 16:20:31 INFO - starting webserver on 'localhost:47962' 16:20:31 INFO - SUITE-START | Running 2 tests 16:20:31 INFO - TEST-START | dromaeo_css 16:20:31 INFO - Initialising browser for dromaeo_css test... 16:20:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47962/getInfo.html -profile /tmp/tmp7P4yxH/profile 16:20:31 INFO - TEST-INFO | started process 8946 (/builds/slave/test/build/application/firefox/firefox http://localhost:47962/getInfo.html) 16:20:38 INFO - TEST-INFO | 8946: exit 0 16:20:38 INFO - Browser initialized. 16:20:38 INFO - Running cycle 1/1 for dromaeo_css test... 16:20:38 INFO - TEST-INFO | started process 9180 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7P4yxH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:39 INFO - PID 9180 | 16:20:39 INFO - PID 9180 | (/builds/slave/test/build/application/firefox/firefox:9233): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:20:39 INFO - PID 9180 | 16:20:49 INFO - PID 9180 | RSS: Main: 167735296 16:20:49 INFO - PID 9180 | 16:23:48 INFO - PID 9180 | Cycle 1(1): loaded http://localhost:47962/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47962/tests/dromaeo/cssquery-ext.html) 16:23:49 INFO - PID 9180 | RSS: Main: 175116288 16:23:49 INFO - PID 9180 | 16:26:51 INFO - PID 9180 | Cycle 1(1): loaded http://localhost:47962/tests/dromaeo/cssquery-ext.html (next: http://localhost:47962/tests/dromaeo/cssquery-jquery.html) 16:26:52 INFO - PID 9180 | RSS: Main: 172482560 16:26:52 INFO - PID 9180 | 16:29:54 INFO - PID 9180 | Cycle 1(1): loaded http://localhost:47962/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47962/tests/dromaeo/cssquery-mootools.html) 16:29:54 INFO - PID 9180 | RSS: Main: 175374336 16:29:54 INFO - PID 9180 | 16:32:56 INFO - PID 9180 | Cycle 1(1): loaded http://localhost:47962/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47962/tests/dromaeo/cssquery-prototype.html) 16:32:57 INFO - PID 9180 | RSS: Main: 173486080 16:32:57 INFO - PID 9180 | 16:36:00 INFO - PID 9180 | Cycle 1(1): loaded http://localhost:47962/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47962/tests/dromaeo/cssquery-yui.html) 16:36:01 INFO - PID 9180 | RSS: Main: 176726016 16:36:01 INFO - PID 9180 | 16:39:03 INFO - PID 9180 | Cycle 1(1): loaded http://localhost:47962/tests/dromaeo/cssquery-yui.html (next: http://localhost:47962/tests/dromaeo/cssquery-dojo.html) 16:39:03 INFO - PID 9180 | RSS: Main: 177475584 16:39:03 INFO - PID 9180 | 16:39:03 INFO - PID 9180 | __start_tp_report 16:39:03 INFO - PID 9180 | _x_x_mozilla_page_load 16:39:03 INFO - PID 9180 | _x_x_mozilla_page_load_details 16:39:03 INFO - PID 9180 | |i|pagename|runs| 16:39:03 INFO - PID 9180 | |0;dojo.html;3140.1992491914566;3149.842507874606;3180.6024246969127;3182.5862637857076;3188.3145123798377;6211.50307975362;6243;6261.029540421237;6278.183836101301;6288.5912415693;6142.232220972379;6169.16716243307;6175.691215439232;6203.100550420187;6215.59598626089;5692.0323544997345;5712.285964254447;5721.170430287606;5770.567207459437;5854.619449735775;5736.4550367715;5755.971220143914;5757.1364295355825;5764.221830052931;5787.971060144693;5529.585281103893;5699.829005129853;5740.081586946089;5848.941510584882;5874.353821079678;5653.632513886584;5696.401877802854;5754.827355179351;5789.363170051291;5803.071508558611;5679.204911312419;5704.286964129484;5732.5127364174095;5756.194132821408;5762.74067666956;6081.209442772411;6094.756209751605;6154.353792851731;6207.348228435994;6221.191245138149;6663.600183988928;6687.632180230085;6696.83257918556;6740.797776066725;6740.93259067408;6678.565893216974;6730.83172920676;6748.19021717397;6773.153355830521;6825.283345248727;6077.1491991121275;6250.812475625738;6264.5301602380005;6322.87354252917;6347.5874068185885;6760.898586521206;6840.623765692835;6880.277570855088;6888.207856096513;6892.448604111659;6497.642629655415;6546.9017964730565;6629.7348106075215;6632.104665870046;6650.301718319603;6672.666366681744;6675.699593518303;6756.527043106936;6758.155230596176;6760.290169532227;6533.444657204096;6633.436157926534;6637.502187335969;6650.3682150195655;6743.898841517381;6593.835154121185;6692.063111164441;6693.431058360094;6696.83257918556;6697.531172817856;5412.621116521885;5458.344998600193;5463.890722185534;5480.068388373986;5481.725913704299;4645.837395691202;4674.579287864109;4708.340832283483;4710.081534100817;4711.929321060187;5668.744906479218;5786.421357864264;5803.100519419497;5867.735951882176;5868.295804503487;6730.966345168243;6733.764318248838;6738;6763.93236067633;6764.019217213477;5751.367349591542;5771.567132465082;5786.942130578725;5810.302763668386;5830.038043722823;5786.826395208151;5799.88400231993;5864;5878.735456904449;5880.558958078162;6296.622202667854;6304.243490781136;6393.200849893763;6399.584027038228;6408.67956602168;6549.181352330958;6593.835154121185;6625.536212465081;6687.063811066358;6713.865722685617;6476.319986401549;6485.254195767548;6485.675716214076;6491.545591808528;6510.902336464862;6553.180852393451;6653.135092437952;6657.533972622064;6662.966685166543;6666.400023997863;6769;6769.424598909148;6817.965910170417;6855.862882742417;6858.3141685831015;6414.454771344488;6503.609783412821;6508;6514.869702605826;6608.768693095719;6496.0255961606135;6510.153680021567;6513.8697226056165;6514.413702766774;6526.771562995273;6357.1735674362035;6442.903356449563;6453.806385808433;6455.741770329134;6466.353364663496;6450.935490645221;6498.707558159799;6520.510961677988;6540.247871494648;6547.508936829661;6327.303996560467;6329.7151628175925;6341.4292713656;6353.809385718436;6442.935570644421 16:39:03 INFO - PID 9180 | |1;ext.html;793.8452001859636;832.2759199496431;860.1226748716308;889.7686601483613;889.875417441558;39676;40535.79732101339;40542.18915621693;40598.99999999996;40600;37126.628733712656;37523;37617.62382376175;37629.059273518105;37631.05922351943;6784.7964561063245;6900.27547107554;6901.896471552931;6903.516753827234;6903.827404314907;6803.047573339712;7375.262473752636;7587.355074818647;7624.313811756941;7627.351675107595;7541;7606;7612.314891659749;7614.162442131361;7632.9236707633045;7540.095188577351;7596.734114305973;7598.202188770182;7598.962005189994;7607.315341619254;7448.851022979564;7516.323530882247;7516.398688104939;7520.586367749772;7527.172011078777;37654.43518347227;37914.0521486965;37935;37973.24053518942;37979.43030854512;3534.3461459630053;3573.857045718168;3576.6065732769375;3577.177249232691;3580.606133325332;30313;30400;30552.84723576368;30660.386792264253;30698.386032279454;4967.279744437073;5008.7996480140755;5016.372953380827;5026.547610715017;5052.949470505321;184725;186938;192259;193537;199176.99999999854;50063.74968125209;50154;50215.49784502181;50262.24606630903;50592.49407505951;52511.474885251424;53003.20495192575;53040;53169;53196.46803531915;14749.262536873328;14790.742786863237;14899.851001490064;14928.62678433048;14990.400383984519;12365.876341236652;12371.257724536557;12415;12480;12507.124501285005;14313.78529322061;14377.56867293983;14388;14455.27723613815;14607.85392146065;5856.941430585724;5911.113333000085;5990.251218597676;5993.190919225849;6100.145979562864;959.3907868503551;996.1781530237583;1016.6695823857128;1021.6475316015963;1026.856240126383;23217.651735223986;23312.3006309811;23431;23515.17696880601;23744;1101.427257825926;1103.4593049405732;1117.1732917640886;1120.2662256222188;1125.971850703739;12571.18287311322;12612.81080783789;12660.81008784869;12708.110432269652;12813.615591532269;242731;243389;243892;244168;245225;53812.73093634585;54258;54410;54449;54586.18120728192;1424.750668632985;1465.6702241995465;1475.203390169318;1485.8217013958395;1488.9851101489064;22090.55818883581;22822.201222957116;23030.193943211907;23112.191073312355;23241.3027609172;32125.839370802998;32538.186545336557;36548.45177322289;36665.45001824921;36699.26601468009;208349;208402;208418;208487;208833;29871.70128298689;30393.848030759706;30515.694843052173;33337.66662333443;34237;41869.371959421245;43209;43346.78326608347;43474.13051738884;43495;32182.35635287328;32450.188745281557;32656;32740.50889236711;32786.508202376506;31510;31787.20531986626;32248;32345.191370215933;32783.67216327806;35182.12044698903;35334;35491.46762798508;35605.64394356023;35615.28769424545;31288;31556.053318399565;33423.498647519824;34169;34459;24440.75559244385;24719.876400617883;24927.626085609092;25314;25533.616995744705 16:39:03 INFO - PID 9180 | |2;jquery.html;562.5499600319744;564.9435056494349;566.2299272988737;569.8945695046416;586.7711592478933;22120.88939555302;23089.307320780383;23203;23386.415339616477;23862.40343991401;27499.31251718703;27807.86096069517;27956.580651290195;28032.299192520197;28087.57868631967;6824.795256142312;6996.650167491605;7000.299970002984;7001.754938577151;7008.579485230877;6300.21247344082;6744.156980377453;6912.688928998182;6946.235914049451;6952.791416257495;6938.583684978892;6950.548214366076;6951.617661028641;6952.165740111169;6953.443724502028;6869.141357330333;6931.618760968145;6932.826679333057;6937.202221744488;6945.895811562856;6780.491463140284;6782.457403407765;6790.7623233186605;6794.3545363190415;6819.113515243036;30368.240793980105;31034.844825775726;31219.531707024413;31253.37493250122;31648.525272120936;1964.3223088034606;1991.8107779760899;2000.4898750818447;2007.6687346587796;2009.4674911148556;19067.237310507564;20904.37286881396;20906.37280881576;20927.476813079644;21055.052522636517;2443.218170185541;2497.9500409991697;2521.6721826162666;2557.514072326252;2574.832635878681;139266;142009;142635.99999999895;142735.28632356875;143257;21040.684389734168;21733.891330543247;22555.323340299816;22705.432364191027;22831.689405036177;44248.55751442444;44265.33601995972;44336.77831610821;44359.33460998088;44394.00226989793;11066;11141.554337826396;11194.776104478027;11222.55109795599;11404.429778511041;9018.053104424072;9030.86453703195;9080.182783549511;9156.862647060167;9158.542072896329;11852.170348075724;12167.2699638022;12168.574099906638;12248.265104093784;12282.201656892274;4303.376010478463;4491;4536.251518499411;4548.385967894358;4580.198465268565;917.1882883648019;958.9089036541517;974.8342781727123;980.2354163752285;992.4541502173776;19516.804831951784;19641.901790491243;19718.507037323896;20132.698009529868;20323.08546115428;1024.882138554061;1032.8812186598486;1036.9377837329785;1039.3815679670583;1046.5499835070993;10980.725481862857;11360;11369.886301137049;11386.715332116597;11426.771464570662;506426;510728;511977;521417;525437;126050;127949;128543;128669.35665321613;131014;1055.150603763962;1108.0304733358312;1165.6444784340858;1198.1852340408607;1241.975160496803;21137.213213752937;21823.78176218281;21932.561348773255;22015;22072.448188794766;58502.70748646229;59825.70087149536;60100;62016.379836201064;62062.379376207464;75897;76075;76179;76349;76742;14542.345594448487;15026.699466010838;15045.548633541011;15100.320485578395;15212.46756363522;23394.76605233926;23562;23715;23827.642585360885;24027.75972240325;18368.17343219585;18621.068946552346;18689.345872894384;18790.718139228196;18795.436136915916;16508.504744857673;16750.832491674926;16915.66168676644;17166.485005449857;17258.22337994768;18777.718334225272;18994.810051899305;19299.324523641604;19442;19487.220511179396;14798.186099764616;14829.25853707332;14939.477118300807;14954.177520236492;21350.572988540454;19119.713204302225;19175.808241917402;19484.61030779405;19494.70757938604;19598.412047638594 16:39:03 INFO - PID 9180 | |3;mootools.html;1370.1094288712336;1417.4967886400327;1427.5503216486807;1430.8926830487717;1442.9278536073193;14144.504942327021;14165.433382664707;14763.999999999987;14847;14890.10659360439;14817.777733333982;15214.315355808987;15217.163056031914;15223.619409514768;15231.39074437024;2747.6428064351608;2795.846228457434;2800.2439341377817;2801.9859900700467;2802.4395120975782;2661.8269812462227;2668.693100293462;2693.771029462498;2711.698384775309;2804.761595264405;2697.9190624281205;2723.0741547873718;2729.713380095091;2731.9180424587194;2736.151792944194;2573.8069644776715;2590.7409259074034;2599.857007864576;2600;2607.895684172631;2535.366158460385;2544.5165418570414;2555.7060937992183;2561.180422264876;2561.244432892301;14346.56960291193;14641.633959151;14651.12093274407;14655.267236638125;14660.56018319452;7366.263373662645;7563.357114645261;7579.242075792432;7601.429892758065;7610.695572177106;5024.949750502485;5167.715775632339;5428.67427954324;5476.58925580579;5563;1946.1728765274843;1950.3368854589507;1963.106786412179;1976.6540855350256;2014.788447213036;24389.51220975588;24562.140325088716;24563.263102106965;24579.508409831702;24616.753832461804;6581.605103693793;6586.341365863471;6609.438197753245;6746.494012949049;6781.796546103625;16512.33950641985;16546.33814647425;16550.66898662044;16554.751678724828;16564.088975106242;7230.096237970254;7453.739119130804;7458.888116678254;7462.888056679154;7474.738384156529;6786.728530858809;6930.272321406281;6933.895991560131;6948.6178260195165;6987.266337034538;5011.774470148852;5122;5184.818531351385;5185.948140518546;5223.503767142115;1390.4160252693894;1435.655442693746;1479.970400591982;1531.035447667962;1532.3793863485307;916;934.5887809363858;940.47333493244;945.1871390604075;949.197927751063;8395.62219700115;8478.576071196416;8653.567321633893;8668.046514883357;8763.123687631314;935.2891802230218;990.7467054176473;1008.6570566007592;1016.3292227130058;1018.556927736437;5136.2295655651205;5448.346198456132;5497.697626630574;5531.280933478622;5624.775008999676;18802.341918032802;18936.05319734008;19344.613107737765;19653.8034619652;19664;18954.715679264824;19430.319938802073;19514.609707805765;19547.804521954884;19559.706604400944;10420.739481512872;10590.523426445829;10606.416647084485;10747.355158690347;10782.029617334321;8130.430869839054;8266.214709602578;8291.62687679068;8356.289715374018;8421;16346.427875024317;17028.829711702725;17238.138093095044;17285;17470.86439381436;17020.65958680844;17234.741478878077;17255.22351494161;17534.386296479563;17773.289068437116;10627.36235825853;10729.731756706145;10732.248742587944;10748.140148787921;10777.568897244022;13157.934210328887;13190.60428187156;13260.138091024053;13306.800397994231;13322.933385333012;10102.747431314276;10224.233182511192;10272.897271027194;10434.269601128151;10513.89486105129;10703.946480267548;10705.678829635124;10737.624183153552;10870.347779133277;10894.400807955639;9631.662891798753;9761.511924403609;9782.951085244527;9791.167750740982;9796;7308.269173082862;7339.082614673166;7378.29906158914;7471.252874712485;7477;7348.77953661391;7355.632218389166;7592.620368981418;7657.770266892002;7706.803560985092 16:39:03 INFO - PID 9180 | |4;prototype.html;490.66468970091876;499.06923587509306;519.361185741538;528.7541293298615;532.2229544864498;6303.212098487695;6335.80992570223;6354.364563543643;6357.110004599348;6382.297947225808;5999.6700181490005;6150.477209437203;6181.227346581677;6190.535709821759;6224.719887605057;4992.500749925015;5024.296598476198;5033.496650334974;5043.208951496075;5056.721880296583;4887.16918123918;5046.192609182532;5067.265246539249;5070.619703522232;5072.670276432039;4985.601151907857;5001.874953126165;5003.549680528752;5007;5018.824341148061;5030.06943715412;5032.245163225509;5039.546440820307;5050.9242361364795;5058.140116180221;4512.706674066175;4515.14212299662;4523.208438523246;4527.954720452786;4529.230030894756;6067.362926892657;6068.21113255274;6078.209832721762;6090.68057908441;6096.817095487142;5697.119950416352;5758.827235182951;5797.797077102324;5819.992102724554;5826.359100498942;6440;6463.418292353711;6493.220813502363;6518.425222037316;6560.343965603449;4929.901401971941;4934.777934992934;4935.80256789728;4936.6297527685565;4953.950460495421;6871.931280687179;6941.0629565008585;6970.965145174343;7064.611446370448;7065.434765218822;5010.724410157476;5029.5724863386295;5044.117279476077;5057.266696329085;5069.89599316287;5108.080545501771;5144.356955380577;5144.819931302386;5157.813702848366;5164.302819119371;5725.312962444534;5767.394423585463;5797.420257974169;5797.565182611321;5799.478046975708;6547.967260163764;6581.177352830896;6627.536072474977;6644.700988455531;6718.857794175002;1701.676681430549;1747.8339557741995;1751.8686098542405;1771.6988112020988;1786.9195886185153;1222.3765879401392;1240.528599132342;1243.8072098824696;1252.4407113144193;1252.9248245105323;5622.437756224426;5695.943040569624;5706.629069110494;5734.340550836707;5738.8278351649515;6653.833654158685;6680.958020397687;6688.29772873851;6826.146731658543;6851.794446166623;5678.801241956512;5724.627899186539;5727.3699893011735;5790.334111577138;5802.448767367177;3601.3697602919383;3627.800470974069;3668.119651283726;3669.504616876741;3683.4843121962945;6426.550141490051;6540.2805691373915;6555.475561955032;6573.3426657333885;6636.668166591651;6920.30796920304;6976.546524475994;7011.544249623758;7027.472939529555;7098.3256590623805;6417.871642567029;6510.511711621647;6537.823191825422;6547.607143571401;6599.175103112111;6679.899801503078;6681.33186681328;6742.292059333896;6755.290694477206;6775.661216939035;6622.8344291393105;6733.3939945405145;6766.763163289262;6776.661166941732;6797.796066118024;6447.806565803034;6474.223093228843;6494.350564943468;6562.901556476752;6574.342565743387;4955.677880937872;4980.153373926369;4992.226204938241;4996.750162491933;5014.373203349582;6599.172479961707;6720.395164435225;6802.3537763912345;6802.455803535804;6833.692483838338;6546.0508226307875;6554.542910820688;6556.3774490202395;6585.452418681511;6641.767538136142;6419.614823110628;6536.215654121535;6546.803595892131;6548.577026500226;6612.867742645217;6156.876862462816;6244.406781355764;6344.682765861596;6484.967575162094;6553.574017688835;6489.967550162219;6497.18785151856;6499.870002600016;6535.117759102461;6610.636414997221;6300.7479700811455;6317.494600432046;6351.714172862325;6380.457661098673;6441.838954026187 16:39:03 INFO - PID 9180 | |5;yui.html;912.6258234124008;918.2378625740636;932.4917919733745;940.2900809888533;949.9097585729355;17303.740443893337;17795.73306400405;17838.554036149104;17946.730799038025;17971.371002014934;17132.743008854875;17194.39819606314;19482.020121526057;22582.774172258272;22673;1022.2282176956406;1053.2469284461608;1055.1031623120364;1058.481344141369;1058.925875188737;970.6942313171364;1019.3017782818756;1052.9578816847318;1056.023178559833;1056.6829951014704;1105.7401510644993;1109.7225693576606;1110.4281295133012;1111.9332840029583;1112.3881864974271;1097.6103483263487;1113.521185890067;1114.3202646385657;1114.788190243855;1117.0616681987128;810.5217921426387;813.4996976859248;814.7800093974594;815.3192084609358;816.3632366753941;19759.703604445946;20235.291764788308;20427.080781364875;20475.2833650823;20517.692234616494;21952.231671891408;22103.778962210494;22488;22529.21147759837;22697.09211631533;15725.135117568529;15909;15956.601084972852;16884.07137607431;17410.825891741046;3529.7176225901867;3537.982310088433;3547.929041419183;3549.680528752399;3550.6449355064547;123543.38228308801;124991;125872.37063814714;129951.99999999905;130550;16976.40582579604;17250;17417.477475675496;17596.12019399025;17655.73516397255;31773.682263177074;32196.678033219836;32241.193970150463;32579.18552036218;32755.83622081922;8503.872441913376;8578.528180949983;8586.270167035871;8593.69922052725;8604.526751028628;4109.815058322323;4139.875803725893;4218.557051509609;4228.4080228768;4271.530131685512;5427.7244847460815;5448.645838020516;5495.642783219078;5527.447255274521;5529.806456773994;998.4259051045677;1016.5222345497605;1018.2057994764095;1022.8619136416488;1029.2023681646783;638.958467699598;653.7777155767062;668.9565178263397;676.1210426445601;676.202081543783;11143.944280278709;11713.849805051683;11811.173217874666;11937.28376297425;12084.093692973061;676.6075676107846;689.36233983565;698.8218004408843;703.3353480960443;712.3731116617447;5623.746931388097;5631.802886898939;5816.563757718188;6165.938340616626;6406.135171751847;110988;114290;115666.42166789112;116210.41894790641;121773.39113304377;79002;96453.51773241229;98687.01312986921;99718.50140749395;104323.4783826076;82662.58668706618;86460.56769716238;91255;91821.54089229644;91989;12471.563495277622;12773.872261277269;12938.288394138037;12944.611661650166;13352.465901363837;39679;41074.58925410708;41214;41498.37752433776;42368;69675;70172;72936;73884.63057684677;76008;18485.53786155357;19201.903990479957;19333.226670933003;19533.902330488258;19540.8045919539;21098.789012109683;21656;21660.566788663822;21695.78304217001;21766.89116554407;18426.35507757222;18990.715139273198;19054.618907621494;19070.14184361679;19378.515537111685;18858;19198.61602767909;19243.1340589671;19270.132844022333;19487;17821.554461138574;17838.19728112212;17880.46358609244;17936.820631793515;18001.369952051617;13457.663558411117;13681.657958551115;13733;13808.171509709047;14322.928385358007;13095.541656042375;14118.152910825384;14495.492657756928;15131.621709457351;15404.614884627526 16:39:03 INFO - PID 9180 | __end_tp_report 16:39:03 INFO - PID 9180 | __start_cc_report 16:39:03 INFO - PID 9180 | _x_x_mozilla_cycle_collect,368 16:39:03 INFO - PID 9180 | __end_cc_report 16:39:03 INFO - PID 9180 | __startTimestamp1502581143582__endTimestamp 16:39:03 INFO - PID 9180 | 16:39:03 INFO - PID 9180 | ------- Summary: start ------- 16:39:03 INFO - PID 9180 | Number of tests: 6 16:39:03 INFO - PID 9180 | 16:39:03 INFO - PID 9180 | [#0] dojo.html Cycles:165 Average:6159.32 Median:6393.20 stddev:718.36 (11.2%) stddev-sans-first:680.40 16:39:03 INFO - PID 9180 | Values: 3140.2 3149.8 3180.6 3182.6 3188.3 6211.5 6243.0 6261.0 6278.2 6288.6 6142.2 6169.2 6175.7 6203.1 6215.6 5692.0 5712.3 5721.2 5770.6 5854.6 5736.5 5756.0 5757.1 5764.2 5788.0 5529.6 5699.8 5740.1 5848.9 5874.4 5653.6 5696.4 5754.8 5789.4 5803.1 5679.2 5704.3 5732.5 5756.2 5762.7 6081.2 6094.8 6154.4 6207.3 6221.2 6663.6 6687.6 6696.8 6740.8 6740.9 6678.6 6730.8 6748.2 6773.2 6825.3 6077.1 6250.8 6264.5 6322.9 6347.6 6760.9 6840.6 6880.3 6888.2 6892.4 6497.6 6546.9 6629.7 6632.1 6650.3 6672.7 6675.7 6756.5 6758.2 6760.3 6533.4 6633.4 6637.5 6650.4 6743.9 6593.8 6692.1 6693.4 6696.8 6697.5 5412.6 5458.3 5463.9 5480.1 5481.7 4645.8 4674.6 4708.3 4710.1 4711.9 5668.7 5786.4 5803.1 5867.7 5868.3 6731.0 6733.8 6738.0 6763.9 6764.0 5751.4 5771.6 5786.9 5810.3 5830.0 5786.8 5799.9 5864.0 5878.7 5880.6 6296.6 6304.2 6393.2 6399.6 6408.7 6549.2 6593.8 6625.5 6687.1 6713.9 6476.3 6485.3 6485.7 6491.5 6510.9 6553.2 6653.1 6657.5 6663.0 6666.4 6769.0 6769.4 6818.0 6855.9 6858.3 6414.5 6503.6 6508.0 6514.9 6608.8 6496.0 6510.2 6513.9 6514.4 6526.8 6357.2 6442.9 6453.8 6455.7 6466.4 6450.9 6498.7 6520.5 6540.2 6547.5 6327.3 6329.7 6341.4 6353.8 6442.9 16:39:03 INFO - PID 9180 | 16:39:03 INFO - PID 9180 | [#1] ext.html Cycles:180 Average:38111.48 Median:35258.06 stddev:56007.65 (158.9%) stddev-sans-first:56094.67 16:39:03 INFO - PID 9180 | Values: 793.8 832.3 860.1 889.8 889.9 39676.0 40535.8 40542.2 40599.0 40600.0 37126.6 37523.0 37617.6 37629.1 37631.1 6784.8 6900.3 6901.9 6903.5 6903.8 6803.0 7375.3 7587.4 7624.3 7627.4 7541.0 7606.0 7612.3 7614.2 7632.9 7540.1 7596.7 7598.2 7599.0 7607.3 7448.9 7516.3 7516.4 7520.6 7527.2 37654.4 37914.1 37935.0 37973.2 37979.4 3534.3 3573.9 3576.6 3577.2 3580.6 30313.0 30400.0 30552.8 30660.4 30698.4 4967.3 5008.8 5016.4 5026.5 5052.9 184725.0 186938.0 192259.0 193537.0 199177.0 50063.7 50154.0 50215.5 50262.2 50592.5 52511.5 53003.2 53040.0 53169.0 53196.5 14749.3 14790.7 14899.9 14928.6 14990.4 12365.9 12371.3 12415.0 12480.0 12507.1 14313.8 14377.6 14388.0 14455.3 14607.9 5856.9 5911.1 5990.3 5993.2 6100.1 959.4 996.2 1016.7 1021.6 1026.9 23217.7 23312.3 23431.0 23515.2 23744.0 1101.4 1103.5 1117.2 1120.3 1126.0 12571.2 12612.8 12660.8 12708.1 12813.6 242731.0 243389.0 243892.0 244168.0 245225.0 53812.7 54258.0 54410.0 54449.0 54586.2 1424.8 1465.7 1475.2 1485.8 1489.0 22090.6 22822.2 23030.2 23112.2 23241.3 32125.8 32538.2 36548.5 36665.5 36699.3 208349.0 208402.0 208418.0 208487.0 208833.0 29871.7 30393.8 30515.7 33337.7 34237.0 41869.4 43209.0 43346.8 43474.1 43495.0 32182.4 32450.2 32656.0 32740.5 32786.5 31510.0 31787.2 32248.0 32345.2 32783.7 35182.1 35334.0 35491.5 35605.6 35615.3 31288.0 31556.1 33423.5 34169.0 34459.0 24440.8 24719.9 24927.6 25314.0 25533.6 16:39:03 INFO - PID 9180 | 16:39:03 INFO - PID 9180 | [#2] jquery.html Cycles:180 Average:37586.28 Median:22960.50 stddev:86840.19 (378.2%) stddev-sans-first:87039.31 16:39:03 INFO - PID 9180 | Values: 562.5 564.9 566.2 569.9 586.8 22120.9 23089.3 23203.0 23386.4 23862.4 27499.3 27807.9 27956.6 28032.3 28087.6 6824.8 6996.7 7000.3 7001.8 7008.6 6300.2 6744.2 6912.7 6946.2 6952.8 6938.6 6950.5 6951.6 6952.2 6953.4 6869.1 6931.6 6932.8 6937.2 6945.9 6780.5 6782.5 6790.8 6794.4 6819.1 30368.2 31034.8 31219.5 31253.4 31648.5 1964.3 1991.8 2000.5 2007.7 2009.5 19067.2 20904.4 20906.4 20927.5 21055.1 2443.2 2498.0 2521.7 2557.5 2574.8 139266.0 142009.0 142636.0 142735.3 143257.0 21040.7 21733.9 22555.3 22705.4 22831.7 44248.6 44265.3 44336.8 44359.3 44394.0 11066.0 11141.6 11194.8 11222.6 11404.4 9018.1 9030.9 9080.2 9156.9 9158.5 11852.2 12167.3 12168.6 12248.3 12282.2 4303.4 4491.0 4536.3 4548.4 4580.2 917.2 958.9 974.8 980.2 992.5 19516.8 19641.9 19718.5 20132.7 20323.1 1024.9 1032.9 1036.9 1039.4 1046.5 10980.7 11360.0 11369.9 11386.7 11426.8 506426.0 510728.0 511977.0 521417.0 525437.0 126050.0 127949.0 128543.0 128669.4 131014.0 1055.2 1108.0 1165.6 1198.2 1242.0 21137.2 21823.8 21932.6 22015.0 22072.4 58502.7 59825.7 60100.0 62016.4 62062.4 75897.0 76075.0 76179.0 76349.0 76742.0 14542.3 15026.7 15045.5 15100.3 15212.5 23394.8 23562.0 23715.0 23827.6 24027.8 18368.2 18621.1 18689.3 18790.7 18795.4 16508.5 16750.8 16915.7 17166.5 17258.2 18777.7 18994.8 19299.3 19442.0 19487.2 14798.2 14829.3 14939.5 14954.2 21350.6 19119.7 19175.8 19484.6 19494.7 19598.4 16:39:03 INFO - PID 9180 | 16:39:03 INFO - PID 9180 | [#3] mootools.html Cycles:180 Average:8899.52 Median:2558.44 stddev:6096.38 (238.3%) stddev-sans-first:6087.23 16:39:03 INFO - PID 9180 | Values: 1370.1 1417.5 1427.6 1430.9 1442.9 14144.5 14165.4 14764.0 14847.0 14890.1 14817.8 15214.3 15217.2 15223.6 15231.4 2747.6 2795.8 2800.2 2802.0 2802.4 2661.8 2668.7 2693.8 2711.7 2804.8 2697.9 2723.1 2729.7 2731.9 2736.2 2573.8 2590.7 2599.9 2600.0 2607.9 2535.4 2544.5 2555.7 2561.2 2561.2 14346.6 14641.6 14651.1 14655.3 14660.6 7366.3 7563.4 7579.2 7601.4 7610.7 5024.9 5167.7 5428.7 5476.6 5563.0 1946.2 1950.3 1963.1 1976.7 2014.8 24389.5 24562.1 24563.3 24579.5 24616.8 6581.6 6586.3 6609.4 6746.5 6781.8 16512.3 16546.3 16550.7 16554.8 16564.1 7230.1 7453.7 7458.9 7462.9 7474.7 6786.7 6930.3 6933.9 6948.6 6987.3 5011.8 5122.0 5184.8 5185.9 5223.5 1390.4 1435.7 1480.0 1531.0 1532.4 916.0 934.6 940.5 945.2 949.2 8395.6 8478.6 8653.6 8668.0 8763.1 935.3 990.7 1008.7 1016.3 1018.6 5136.2 5448.3 5497.7 5531.3 5624.8 18802.3 18936.1 19344.6 19653.8 19664.0 18954.7 19430.3 19514.6 19547.8 19559.7 10420.7 10590.5 10606.4 10747.4 10782.0 8130.4 8266.2 8291.6 8356.3 8421.0 16346.4 17028.8 17238.1 17285.0 17470.9 17020.7 17234.7 17255.2 17534.4 17773.3 10627.4 10729.7 10732.2 10748.1 10777.6 13157.9 13190.6 13260.1 13306.8 13322.9 10102.7 10224.2 10272.9 10434.3 10513.9 10703.9 10705.7 10737.6 10870.3 10894.4 9631.7 9761.5 9783.0 9791.2 9796.0 7308.3 7339.1 7378.3 7471.3 7477.0 7348.8 7355.6 7592.6 7657.8 7706.8 16:39:03 INFO - PID 9180 | 16:39:03 INFO - PID 9180 | [#4] prototype.html Cycles:180 Average:5540.92 Median:6123.65 stddev:1547.92 (25.3%) stddev-sans-first:1505.13 16:39:03 INFO - PID 9180 | Values: 490.7 499.1 519.4 528.8 532.2 6303.2 6335.8 6354.4 6357.1 6382.3 5999.7 6150.5 6181.2 6190.5 6224.7 4992.5 5024.3 5033.5 5043.2 5056.7 4887.2 5046.2 5067.3 5070.6 5072.7 4985.6 5001.9 5003.5 5007.0 5018.8 5030.1 5032.2 5039.5 5050.9 5058.1 4512.7 4515.1 4523.2 4528.0 4529.2 6067.4 6068.2 6078.2 6090.7 6096.8 5697.1 5758.8 5797.8 5820.0 5826.4 6440.0 6463.4 6493.2 6518.4 6560.3 4929.9 4934.8 4935.8 4936.6 4954.0 6871.9 6941.1 6971.0 7064.6 7065.4 5010.7 5029.6 5044.1 5057.3 5069.9 5108.1 5144.4 5144.8 5157.8 5164.3 5725.3 5767.4 5797.4 5797.6 5799.5 6548.0 6581.2 6627.5 6644.7 6718.9 1701.7 1747.8 1751.9 1771.7 1786.9 1222.4 1240.5 1243.8 1252.4 1252.9 5622.4 5695.9 5706.6 5734.3 5738.8 6653.8 6681.0 6688.3 6826.1 6851.8 5678.8 5724.6 5727.4 5790.3 5802.4 3601.4 3627.8 3668.1 3669.5 3683.5 6426.6 6540.3 6555.5 6573.3 6636.7 6920.3 6976.5 7011.5 7027.5 7098.3 6417.9 6510.5 6537.8 6547.6 6599.2 6679.9 6681.3 6742.3 6755.3 6775.7 6622.8 6733.4 6766.8 6776.7 6797.8 6447.8 6474.2 6494.4 6562.9 6574.3 4955.7 4980.2 4992.2 4996.8 5014.4 6599.2 6720.4 6802.4 6802.5 6833.7 6546.1 6554.5 6556.4 6585.5 6641.8 6419.6 6536.2 6546.8 6548.6 6612.9 6156.9 6244.4 6344.7 6485.0 6553.6 6490.0 6497.2 6499.9 6535.1 6610.6 6300.7 6317.5 6351.7 6380.5 6441.8 16:39:03 INFO - PID 9180 | 16:39:03 INFO - PID 9180 | [#5] yui.html Cycles:180 Average:24254.13 Median:19537.35 stddev:32780.95 (167.8%) stddev-sans-first:32826.05 16:39:03 INFO - PID 9180 | Values: 912.6 918.2 932.5 940.3 949.9 17303.7 17795.7 17838.6 17946.7 17971.4 17132.7 17194.4 19482.0 22582.8 22673.0 1022.2 1053.2 1055.1 1058.5 1058.9 970.7 1019.3 1053.0 1056.0 1056.7 1105.7 1109.7 1110.4 1111.9 1112.4 1097.6 1113.5 1114.3 1114.8 1117.1 810.5 813.5 814.8 815.3 816.4 19759.7 20235.3 20427.1 20475.3 20517.7 21952.2 22103.8 22488.0 22529.2 22697.1 15725.1 15909.0 15956.6 16884.1 17410.8 3529.7 3538.0 3547.9 3549.7 3550.6 123543.4 124991.0 125872.4 129952.0 130550.0 16976.4 17250.0 17417.5 17596.1 17655.7 31773.7 32196.7 32241.2 32579.2 32755.8 8503.9 8578.5 8586.3 8593.7 8604.5 4109.8 4139.9 4218.6 4228.4 4271.5 5427.7 5448.6 5495.6 5527.4 5529.8 998.4 1016.5 1018.2 1022.9 1029.2 639.0 653.8 669.0 676.1 676.2 11143.9 11713.8 11811.2 11937.3 12084.1 676.6 689.4 698.8 703.3 712.4 5623.7 5631.8 5816.6 6165.9 6406.1 110988.0 114290.0 115666.4 116210.4 121773.4 79002.0 96453.5 98687.0 99718.5 104323.5 82662.6 86460.6 91255.0 91821.5 91989.0 12471.6 12773.9 12938.3 12944.6 13352.5 39679.0 41074.6 41214.0 41498.4 42368.0 69675.0 70172.0 72936.0 73884.6 76008.0 18485.5 19201.9 19333.2 19533.9 19540.8 21098.8 21656.0 21660.6 21695.8 21766.9 18426.4 18990.7 19054.6 19070.1 19378.5 18858.0 19198.6 19243.1 19270.1 19487.0 17821.6 17838.2 17880.5 17936.8 18001.4 13457.7 13681.7 13733.0 13808.2 14322.9 13095.5 14118.2 14495.5 15131.6 15404.6 16:39:03 INFO - PID 9180 | -------- Summary: end -------- 16:39:03 INFO - PID 9180 | 16:39:04 INFO - TEST-INFO | 9180: exit 0 16:39:04 INFO - TEST-OK | dromaeo_css | took 1112977ms 16:39:04 INFO - TEST-START | kraken 16:39:04 INFO - Initialising browser for kraken test... 16:39:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47962/getInfo.html -profile /tmp/tmpsJbZGG/profile 16:39:04 INFO - TEST-INFO | started process 9548 (/builds/slave/test/build/application/firefox/firefox http://localhost:47962/getInfo.html) 16:39:10 INFO - TEST-INFO | 9548: exit 0 16:39:10 INFO - Browser initialized. 16:39:10 INFO - Running cycle 1/1 for kraken test... 16:39:10 INFO - TEST-INFO | started process 9780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsJbZGG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:39:11 INFO - PID 9780 | 16:39:11 INFO - PID 9780 | (/builds/slave/test/build/application/firefox/firefox:9834): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:39:11 INFO - PID 9780 | 16:39:21 INFO - PID 9780 | RSS: Main: 171159552 16:39:21 INFO - PID 9780 | 16:39:24 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47962/tests/kraken/driver.html?testName=audio-beat-detection) 16:39:25 INFO - PID 9780 | RSS: Main: 177938432 16:39:25 INFO - PID 9780 | 16:39:28 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47962/tests/kraken/driver.html?testName=audio-dft) 16:39:28 INFO - PID 9780 | RSS: Main: 178184192 16:39:28 INFO - PID 9780 | 16:39:31 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47962/tests/kraken/driver.html?testName=audio-fft) 16:39:32 INFO - PID 9780 | RSS: Main: 173379584 16:39:32 INFO - PID 9780 | 16:39:34 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47962/tests/kraken/driver.html?testName=audio-oscillator) 16:39:35 INFO - PID 9780 | RSS: Main: 173453312 16:39:35 INFO - PID 9780 | 16:39:37 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47962/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:39:38 INFO - PID 9780 | RSS: Main: 173834240 16:39:38 INFO - PID 9780 | 16:39:41 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47962/tests/kraken/driver.html?testName=imaging-darkroom) 16:39:41 INFO - PID 9780 | RSS: Main: 176304128 16:39:41 INFO - PID 9780 | 16:39:45 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47962/tests/kraken/driver.html?testName=imaging-desaturate) 16:39:46 INFO - PID 9780 | RSS: Main: 176484352 16:39:46 INFO - PID 9780 | 16:39:48 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47962/tests/kraken/driver.html?testName=json-parse-financial) 16:39:49 INFO - PID 9780 | RSS: Main: 177020928 16:39:49 INFO - PID 9780 | 16:39:51 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47962/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:39:51 INFO - PID 9780 | RSS: Main: 176934912 16:39:51 INFO - PID 9780 | 16:39:53 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47962/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:39:54 INFO - PID 9780 | RSS: Main: 173993984 16:39:54 INFO - PID 9780 | 16:39:56 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47962/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:39:57 INFO - PID 9780 | RSS: Main: 174039040 16:39:57 INFO - PID 9780 | 16:39:59 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:40:00 INFO - PID 9780 | RSS: Main: 174776320 16:40:00 INFO - PID 9780 | 16:40:03 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:40:04 INFO - PID 9780 | RSS: Main: 175357952 16:40:04 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | Cycle 1(1): loaded http://localhost:47962/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47962/tests/kraken/driver.html?testName=ai-astar) 16:40:06 INFO - PID 9780 | RSS: Main: 176177152 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | __start_tp_report 16:40:06 INFO - PID 9780 | _x_x_mozilla_page_load 16:40:06 INFO - PID 9780 | _x_x_mozilla_page_load_details 16:40:06 INFO - PID 9780 | |i|pagename|runs| 16:40:06 INFO - PID 9780 | |0;ai-astar;98;107;100;109;118;109;110;105;107;108 16:40:06 INFO - PID 9780 | |1;audio-beat-detection;145;119;153;189;117;159;146;122;174;120 16:40:06 INFO - PID 9780 | |2;audio-dft;168;164;161;162;161;162;179;164;167;167 16:40:06 INFO - PID 9780 | |3;audio-fft;75;76;75;169;77;82;74;90;103;82 16:40:06 INFO - PID 9780 | |4;audio-oscillator;78;78;133;80;81;80;127;80;79;133 16:40:06 INFO - PID 9780 | |5;imaging-gaussian-blur;114;113;114;115;119;114;115;117;119;117 16:40:06 INFO - PID 9780 | |6;imaging-darkroom;150;149;154;149;152;150;151;150;151;151 16:40:06 INFO - PID 9780 | |7;imaging-desaturate;95;102;93;94;93;94;94;94;95;95 16:40:06 INFO - PID 9780 | |8;json-parse-financial;59;58;53;53;54;53;58;57;52;57 16:40:06 INFO - PID 9780 | |9;json-stringify-tinderbox;54;54;56;55;54;54;66;55;55;54 16:40:06 INFO - PID 9780 | |10;stanford-crypto-aes;83;77;78;90;76;87;83;87;78;78 16:40:06 INFO - PID 9780 | |11;stanford-crypto-ccm;126;119;126;125;122;121;121;129;124;164 16:40:06 INFO - PID 9780 | |12;stanford-crypto-pbkdf2;176;174;181;173;196;175;200;176;172;180 16:40:06 INFO - PID 9780 | |13;stanford-crypto-sha256-iterative;68;69;74;76;66;67;69;65;66;69 16:40:06 INFO - PID 9780 | __end_tp_report 16:40:06 INFO - PID 9780 | __start_cc_report 16:40:06 INFO - PID 9780 | _x_x_mozilla_cycle_collect,979 16:40:06 INFO - PID 9780 | __end_cc_report 16:40:06 INFO - PID 9780 | __startTimestamp1502581206492__endTimestamp 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | ------- Summary: start ------- 16:40:06 INFO - PID 9780 | Number of tests: 14 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#0] ai-astar Cycles:10 Average:107.10 Median:109.00 stddev:5.51 (5.1%) stddev-sans-first:4.76 16:40:06 INFO - PID 9780 | Values: 98.0 107.0 100.0 109.0 118.0 109.0 110.0 105.0 107.0 108.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:149.50 stddev:25.05 (16.8%) stddev-sans-first:26.57 16:40:06 INFO - PID 9780 | Values: 145.0 119.0 153.0 189.0 117.0 159.0 146.0 122.0 174.0 120.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:5.40 (3.3%) stddev-sans-first:5.65 16:40:06 INFO - PID 9780 | Values: 168.0 164.0 161.0 162.0 161.0 162.0 179.0 164.0 167.0 167.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#3] audio-fft Cycles:10 Average:90.30 Median:76.50 stddev:29.07 (38.0%) stddev-sans-first:30.31 16:40:06 INFO - PID 9780 | Values: 75.0 76.0 75.0 169.0 77.0 82.0 74.0 90.0 103.0 82.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:79.50 stddev:24.98 (31.4%) stddev-sans-first:25.74 16:40:06 INFO - PID 9780 | Values: 78.0 78.0 133.0 80.0 81.0 80.0 127.0 80.0 79.0 133.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:116.00 stddev:2.16 (1.9%) stddev-sans-first:2.20 16:40:06 INFO - PID 9780 | Values: 114.0 113.0 114.0 115.0 119.0 114.0 115.0 117.0 119.0 117.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:1.49 (1.0%) stddev-sans-first:1.56 16:40:06 INFO - PID 9780 | Values: 150.0 149.0 154.0 149.0 152.0 150.0 151.0 150.0 151.0 151.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:94.00 stddev:2.60 (2.8%) stddev-sans-first:2.76 16:40:06 INFO - PID 9780 | Values: 95.0 102.0 93.0 94.0 93.0 94.0 94.0 94.0 95.0 95.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:57.00 stddev:2.63 (4.6%) stddev-sans-first:2.45 16:40:06 INFO - PID 9780 | Values: 59.0 58.0 53.0 53.0 54.0 53.0 58.0 57.0 52.0 57.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.00 stddev:3.68 (6.7%) stddev-sans-first:3.86 16:40:06 INFO - PID 9780 | Values: 54.0 54.0 56.0 55.0 54.0 54.0 66.0 55.0 55.0 54.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:83.00 stddev:4.99 (6.0%) stddev-sans-first:5.27 16:40:06 INFO - PID 9780 | Values: 83.0 77.0 78.0 90.0 76.0 87.0 83.0 87.0 78.0 78.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:125.50 stddev:13.10 (10.4%) stddev-sans-first:13.88 16:40:06 INFO - PID 9780 | Values: 126.0 119.0 126.0 125.0 122.0 121.0 121.0 129.0 124.0 164.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:178.00 stddev:9.79 (5.5%) stddev-sans-first:10.26 16:40:06 INFO - PID 9780 | Values: 176.0 174.0 181.0 173.0 196.0 175.0 200.0 176.0 172.0 180.0 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:3.54 (5.1%) stddev-sans-first:3.74 16:40:06 INFO - PID 9780 | Values: 68.0 69.0 74.0 76.0 66.0 67.0 69.0 65.0 66.0 69.0 16:40:06 INFO - PID 9780 | -------- Summary: end -------- 16:40:06 INFO - PID 9780 | 16:40:06 INFO - PID 9780 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:40:07 INFO - TEST-INFO | 9780: exit 0 16:40:07 INFO - TEST-OK | kraken | took 62851ms 16:40:07 INFO - SUITE-END | took 1175s 16:40:07 INFO - Completed test suite (00:19:36) 16:40:07 INFO - javascript benchmark 16:40:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8659.022568505745, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3140.1992491914566, 3149.842507874606, 3180.6024246969127, 3182.5862637857076, 3188.3145123798377, 6211.50307975362, 6243.0, 6261.029540421237, 6278.183836101301, 6288.5912415693, 6142.232220972379, 6169.16716243307, 6175.691215439232, 6203.100550420187, 6215.59598626089, 5692.0323544997345, 5712.285964254447, 5721.170430287606, 5770.567207459437, 5854.619449735775, 5736.4550367715, 5755.971220143914, 5757.1364295355825, 5764.221830052931, 5787.971060144693, 5529.585281103893, 5699.829005129853, 5740.081586946089, 5848.941510584882, 5874.353821079678, 5653.632513886584, 5696.401877802854, 5754.827355179351, 5789.363170051291, 5803.071508558611, 5679.204911312419, 5704.286964129484, 5732.5127364174095, 5756.194132821408, 5762.74067666956, 6081.209442772411, 6094.756209751605, 6154.353792851731, 6207.348228435994, 6221.191245138149, 6663.600183988928, 6687.632180230085, 6696.83257918556, 6740.797776066725, 6740.93259067408, 6678.565893216974, 6730.83172920676, 6748.19021717397, 6773.153355830521, 6825.283345248727, 6077.1491991121275, 6250.812475625738, 6264.5301602380005, 6322.87354252917, 6347.5874068185885, 6760.898586521206, 6840.623765692835, 6880.277570855088, 6888.207856096513, 6892.448604111659, 6497.642629655415, 6546.9017964730565, 6629.7348106075215, 6632.104665870046, 6650.301718319603, 6672.666366681744, 6675.699593518303, 6756.527043106936, 6758.155230596176, 6760.290169532227, 6533.444657204096, 6633.436157926534, 6637.502187335969, 6650.3682150195655, 6743.898841517381, 6593.835154121185, 6692.063111164441, 6693.431058360094, 6696.83257918556, 6697.531172817856, 5412.621116521885, 5458.344998600193, 5463.890722185534, 5480.068388373986, 5481.725913704299, 4645.837395691202, 4674.579287864109, 4708.340832283483, 4710.081534100817, 4711.929321060187, 5668.744906479218, 5786.421357864264, 5803.100519419497, 5867.735951882176, 5868.295804503487, 6730.966345168243, 6733.764318248838, 6738.0, 6763.93236067633, 6764.019217213477, 5751.367349591542, 5771.567132465082, 5786.942130578725, 5810.302763668386, 5830.038043722823, 5786.826395208151, 5799.88400231993, 5864.0, 5878.735456904449, 5880.558958078162, 6296.622202667854, 6304.243490781136, 6393.200849893763, 6399.584027038228, 6408.67956602168, 6549.181352330958, 6593.835154121185, 6625.536212465081, 6687.063811066358, 6713.865722685617, 6476.319986401549, 6485.254195767548, 6485.675716214076, 6491.545591808528, 6510.902336464862, 6553.180852393451, 6653.135092437952, 6657.533972622064, 6662.966685166543, 6666.400023997863, 6769.0, 6769.424598909148, 6817.965910170417, 6855.862882742417, 6858.3141685831015, 6414.454771344488, 6503.609783412821, 6508.0, 6514.869702605826, 6608.768693095719, 6496.0255961606135, 6510.153680021567, 6513.8697226056165, 6514.413702766774, 6526.771562995273, 6357.1735674362035, 6442.903356449563, 6453.806385808433, 6455.741770329134, 6466.353364663496, 6450.935490645221, 6498.707558159799, 6520.510961677988, 6540.247871494648, 6547.508936829661, 6327.303996560467, 6329.7151628175925, 6341.4292713656, 6353.809385718436, 6442.935570644421], "value": 6105.9524942618455, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.8452001859636, 832.2759199496431, 860.1226748716308, 889.7686601483613, 889.875417441558, 39676.0, 40535.79732101339, 40542.18915621693, 40598.99999999996, 40600.0, 37126.628733712656, 37523.0, 37617.62382376175, 37629.059273518105, 37631.05922351943, 6784.7964561063245, 6900.27547107554, 6901.896471552931, 6903.516753827234, 6903.827404314907, 6803.047573339712, 7375.262473752636, 7587.355074818647, 7624.313811756941, 7627.351675107595, 7541.0, 7606.0, 7612.314891659749, 7614.162442131361, 7632.9236707633045, 7540.095188577351, 7596.734114305973, 7598.202188770182, 7598.962005189994, 7607.315341619254, 7448.851022979564, 7516.323530882247, 7516.398688104939, 7520.586367749772, 7527.172011078777, 37654.43518347227, 37914.0521486965, 37935.0, 37973.24053518942, 37979.43030854512, 3534.3461459630053, 3573.857045718168, 3576.6065732769375, 3577.177249232691, 3580.606133325332, 30313.0, 30400.0, 30552.84723576368, 30660.386792264253, 30698.386032279454, 4967.279744437073, 5008.7996480140755, 5016.372953380827, 5026.547610715017, 5052.949470505321, 184725.0, 186938.0, 192259.0, 193537.0, 199176.99999999854, 50063.74968125209, 50154.0, 50215.49784502181, 50262.24606630903, 50592.49407505951, 52511.474885251424, 53003.20495192575, 53040.0, 53169.0, 53196.46803531915, 14749.262536873328, 14790.742786863237, 14899.851001490064, 14928.62678433048, 14990.400383984519, 12365.876341236652, 12371.257724536557, 12415.0, 12480.0, 12507.124501285005, 14313.78529322061, 14377.56867293983, 14388.0, 14455.27723613815, 14607.85392146065, 5856.941430585724, 5911.113333000085, 5990.251218597676, 5993.190919225849, 6100.145979562864, 959.3907868503551, 996.1781530237583, 1016.6695823857128, 1021.6475316015963, 1026.856240126383, 23217.651735223986, 23312.3006309811, 23431.0, 23515.17696880601, 23744.0, 1101.427257825926, 1103.4593049405732, 1117.1732917640886, 1120.2662256222188, 1125.971850703739, 12571.18287311322, 12612.81080783789, 12660.81008784869, 12708.110432269652, 12813.615591532269, 242731.0, 243389.0, 243892.0, 244168.0, 245225.0, 53812.73093634585, 54258.0, 54410.0, 54449.0, 54586.18120728192, 1424.750668632985, 1465.6702241995465, 1475.203390169318, 1485.8217013958395, 1488.9851101489064, 22090.55818883581, 22822.201222957116, 23030.193943211907, 23112.191073312355, 23241.3027609172, 32125.839370802998, 32538.186545336557, 36548.45177322289, 36665.45001824921, 36699.26601468009, 208349.0, 208402.0, 208418.0, 208487.0, 208833.0, 29871.70128298689, 30393.848030759706, 30515.694843052173, 33337.66662333443, 34237.0, 41869.371959421245, 43209.0, 43346.78326608347, 43474.13051738884, 43495.0, 32182.35635287328, 32450.188745281557, 32656.0, 32740.50889236711, 32786.508202376506, 31510.0, 31787.20531986626, 32248.0, 32345.191370215933, 32783.67216327806, 35182.12044698903, 35334.0, 35491.46762798508, 35605.64394356023, 35615.28769424545, 31288.0, 31556.053318399565, 33423.498647519824, 34169.0, 34459.0, 24440.75559244385, 24719.876400617883, 24927.626085609092, 25314.0, 25533.616995744705], "value": 17040.093290365454, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.5499600319744, 564.9435056494349, 566.2299272988737, 569.8945695046416, 586.7711592478933, 22120.88939555302, 23089.307320780383, 23203.0, 23386.415339616477, 23862.40343991401, 27499.31251718703, 27807.86096069517, 27956.580651290195, 28032.299192520197, 28087.57868631967, 6824.795256142312, 6996.650167491605, 7000.299970002984, 7001.754938577151, 7008.579485230877, 6300.21247344082, 6744.156980377453, 6912.688928998182, 6946.235914049451, 6952.791416257495, 6938.583684978892, 6950.548214366076, 6951.617661028641, 6952.165740111169, 6953.443724502028, 6869.141357330333, 6931.618760968145, 6932.826679333057, 6937.202221744488, 6945.895811562856, 6780.491463140284, 6782.457403407765, 6790.7623233186605, 6794.3545363190415, 6819.113515243036, 30368.240793980105, 31034.844825775726, 31219.531707024413, 31253.37493250122, 31648.525272120936, 1964.3223088034606, 1991.8107779760899, 2000.4898750818447, 2007.6687346587796, 2009.4674911148556, 19067.237310507564, 20904.37286881396, 20906.37280881576, 20927.476813079644, 21055.052522636517, 2443.218170185541, 2497.9500409991697, 2521.6721826162666, 2557.514072326252, 2574.832635878681, 139266.0, 142009.0, 142635.99999999895, 142735.28632356875, 143257.0, 21040.684389734168, 21733.891330543247, 22555.323340299816, 22705.432364191027, 22831.689405036177, 44248.55751442444, 44265.33601995972, 44336.77831610821, 44359.33460998088, 44394.00226989793, 11066.0, 11141.554337826396, 11194.776104478027, 11222.55109795599, 11404.429778511041, 9018.053104424072, 9030.86453703195, 9080.182783549511, 9156.862647060167, 9158.542072896329, 11852.170348075724, 12167.2699638022, 12168.574099906638, 12248.265104093784, 12282.201656892274, 4303.376010478463, 4491.0, 4536.251518499411, 4548.385967894358, 4580.198465268565, 917.1882883648019, 958.9089036541517, 974.8342781727123, 980.2354163752285, 992.4541502173776, 19516.804831951784, 19641.901790491243, 19718.507037323896, 20132.698009529868, 20323.08546115428, 1024.882138554061, 1032.8812186598486, 1036.9377837329785, 1039.3815679670583, 1046.5499835070993, 10980.725481862857, 11360.0, 11369.886301137049, 11386.715332116597, 11426.771464570662, 506426.0, 510728.0, 511977.0, 521417.0, 525437.0, 126050.0, 127949.0, 128543.0, 128669.35665321613, 131014.0, 1055.150603763962, 1108.0304733358312, 1165.6444784340858, 1198.1852340408607, 1241.975160496803, 21137.213213752937, 21823.78176218281, 21932.561348773255, 22015.0, 22072.448188794766, 58502.70748646229, 59825.70087149536, 60100.0, 62016.379836201064, 62062.379376207464, 75897.0, 76075.0, 76179.0, 76349.0, 76742.0, 14542.345594448487, 15026.699466010838, 15045.548633541011, 15100.320485578395, 15212.46756363522, 23394.76605233926, 23562.0, 23715.0, 23827.642585360885, 24027.75972240325, 18368.17343219585, 18621.068946552346, 18689.345872894384, 18790.718139228196, 18795.436136915916, 16508.504744857673, 16750.832491674926, 16915.66168676644, 17166.485005449857, 17258.22337994768, 18777.718334225272, 18994.810051899305, 19299.324523641604, 19442.0, 19487.220511179396, 14798.186099764616, 14829.25853707332, 14939.477118300807, 14954.177520236492, 21350.572988540454, 19119.713204302225, 19175.808241917402, 19484.61030779405, 19494.70757938604, 19598.412047638594], "value": 13096.497179355172, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.1094288712336, 1417.4967886400327, 1427.5503216486807, 1430.8926830487717, 1442.9278536073193, 14144.504942327021, 14165.433382664707, 14763.999999999987, 14847.0, 14890.10659360439, 14817.777733333982, 15214.315355808987, 15217.163056031914, 15223.619409514768, 15231.39074437024, 2747.6428064351608, 2795.846228457434, 2800.2439341377817, 2801.9859900700467, 2802.4395120975782, 2661.8269812462227, 2668.693100293462, 2693.771029462498, 2711.698384775309, 2804.761595264405, 2697.9190624281205, 2723.0741547873718, 2729.713380095091, 2731.9180424587194, 2736.151792944194, 2573.8069644776715, 2590.7409259074034, 2599.857007864576, 2600.0, 2607.895684172631, 2535.366158460385, 2544.5165418570414, 2555.7060937992183, 2561.180422264876, 2561.244432892301, 14346.56960291193, 14641.633959151, 14651.12093274407, 14655.267236638125, 14660.56018319452, 7366.263373662645, 7563.357114645261, 7579.242075792432, 7601.429892758065, 7610.695572177106, 5024.949750502485, 5167.715775632339, 5428.67427954324, 5476.58925580579, 5563.0, 1946.1728765274843, 1950.3368854589507, 1963.106786412179, 1976.6540855350256, 2014.788447213036, 24389.51220975588, 24562.140325088716, 24563.263102106965, 24579.508409831702, 24616.753832461804, 6581.605103693793, 6586.341365863471, 6609.438197753245, 6746.494012949049, 6781.796546103625, 16512.33950641985, 16546.33814647425, 16550.66898662044, 16554.751678724828, 16564.088975106242, 7230.096237970254, 7453.739119130804, 7458.888116678254, 7462.888056679154, 7474.738384156529, 6786.728530858809, 6930.272321406281, 6933.895991560131, 6948.6178260195165, 6987.266337034538, 5011.774470148852, 5122.0, 5184.818531351385, 5185.948140518546, 5223.503767142115, 1390.4160252693894, 1435.655442693746, 1479.970400591982, 1531.035447667962, 1532.3793863485307, 916.0, 934.5887809363858, 940.47333493244, 945.1871390604075, 949.197927751063, 8395.62219700115, 8478.576071196416, 8653.567321633893, 8668.046514883357, 8763.123687631314, 935.2891802230218, 990.7467054176473, 1008.6570566007592, 1016.3292227130058, 1018.556927736437, 5136.2295655651205, 5448.346198456132, 5497.697626630574, 5531.280933478622, 5624.775008999676, 18802.341918032802, 18936.05319734008, 19344.613107737765, 19653.8034619652, 19664.0, 18954.715679264824, 19430.319938802073, 19514.609707805765, 19547.804521954884, 19559.706604400944, 10420.739481512872, 10590.523426445829, 10606.416647084485, 10747.355158690347, 10782.029617334321, 8130.430869839054, 8266.214709602578, 8291.62687679068, 8356.289715374018, 8421.0, 16346.427875024317, 17028.829711702725, 17238.138093095044, 17285.0, 17470.86439381436, 17020.65958680844, 17234.741478878077, 17255.22351494161, 17534.386296479563, 17773.289068437116, 10627.36235825853, 10729.731756706145, 10732.248742587944, 10748.140148787921, 10777.568897244022, 13157.934210328887, 13190.60428187156, 13260.138091024053, 13306.800397994231, 13322.933385333012, 10102.747431314276, 10224.233182511192, 10272.897271027194, 10434.269601128151, 10513.89486105129, 10703.946480267548, 10705.678829635124, 10737.624183153552, 10870.347779133277, 10894.400807955639, 9631.662891798753, 9761.511924403609, 9782.951085244527, 9791.167750740982, 9796.0, 7308.269173082862, 7339.082614673166, 7378.29906158914, 7471.252874712485, 7477.0, 7348.77953661391, 7355.632218389166, 7592.620368981418, 7657.770266892002, 7706.803560985092], "value": 6505.783926874248, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.66468970091876, 499.06923587509306, 519.361185741538, 528.7541293298615, 532.2229544864498, 6303.212098487695, 6335.80992570223, 6354.364563543643, 6357.110004599348, 6382.297947225808, 5999.6700181490005, 6150.477209437203, 6181.227346581677, 6190.535709821759, 6224.719887605057, 4992.500749925015, 5024.296598476198, 5033.496650334974, 5043.208951496075, 5056.721880296583, 4887.16918123918, 5046.192609182532, 5067.265246539249, 5070.619703522232, 5072.670276432039, 4985.601151907857, 5001.874953126165, 5003.549680528752, 5007.0, 5018.824341148061, 5030.06943715412, 5032.245163225509, 5039.546440820307, 5050.9242361364795, 5058.140116180221, 4512.706674066175, 4515.14212299662, 4523.208438523246, 4527.954720452786, 4529.230030894756, 6067.362926892657, 6068.21113255274, 6078.209832721762, 6090.68057908441, 6096.817095487142, 5697.119950416352, 5758.827235182951, 5797.797077102324, 5819.992102724554, 5826.359100498942, 6440.0, 6463.418292353711, 6493.220813502363, 6518.425222037316, 6560.343965603449, 4929.901401971941, 4934.777934992934, 4935.80256789728, 4936.6297527685565, 4953.950460495421, 6871.931280687179, 6941.0629565008585, 6970.965145174343, 7064.611446370448, 7065.434765218822, 5010.724410157476, 5029.5724863386295, 5044.117279476077, 5057.266696329085, 5069.89599316287, 5108.080545501771, 5144.356955380577, 5144.819931302386, 5157.813702848366, 5164.302819119371, 5725.312962444534, 5767.394423585463, 5797.420257974169, 5797.565182611321, 5799.478046975708, 6547.967260163764, 6581.177352830896, 6627.536072474977, 6644.700988455531, 6718.857794175002, 1701.676681430549, 1747.8339557741995, 1751.8686098542405, 1771.6988112020988, 1786.9195886185153, 1222.3765879401392, 1240.528599132342, 1243.8072098824696, 1252.4407113144193, 1252.9248245105323, 5622.437756224426, 5695.943040569624, 5706.629069110494, 5734.340550836707, 5738.8278351649515, 6653.833654158685, 6680.958020397687, 6688.29772873851, 6826.146731658543, 6851.794446166623, 5678.801241956512, 5724.627899186539, 5727.3699893011735, 5790.334111577138, 5802.448767367177, 3601.3697602919383, 3627.800470974069, 3668.119651283726, 3669.504616876741, 3683.4843121962945, 6426.550141490051, 6540.2805691373915, 6555.475561955032, 6573.3426657333885, 6636.668166591651, 6920.30796920304, 6976.546524475994, 7011.544249623758, 7027.472939529555, 7098.3256590623805, 6417.871642567029, 6510.511711621647, 6537.823191825422, 6547.607143571401, 6599.175103112111, 6679.899801503078, 6681.33186681328, 6742.292059333896, 6755.290694477206, 6775.661216939035, 6622.8344291393105, 6733.3939945405145, 6766.763163289262, 6776.661166941732, 6797.796066118024, 6447.806565803034, 6474.223093228843, 6494.350564943468, 6562.901556476752, 6574.342565743387, 4955.677880937872, 4980.153373926369, 4992.226204938241, 4996.750162491933, 5014.373203349582, 6599.172479961707, 6720.395164435225, 6802.3537763912345, 6802.455803535804, 6833.692483838338, 6546.0508226307875, 6554.542910820688, 6556.3774490202395, 6585.452418681511, 6641.767538136142, 6419.614823110628, 6536.215654121535, 6546.803595892131, 6548.577026500226, 6612.867742645217, 6156.876862462816, 6244.406781355764, 6344.682765861596, 6484.967575162094, 6553.574017688835, 6489.967550162219, 6497.18785151856, 6499.870002600016, 6535.117759102461, 6610.636414997221, 6300.7479700811455, 6317.494600432046, 6351.714172862325, 6380.457661098673, 6441.838954026187], "value": 5085.441453022185, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [912.6258234124008, 918.2378625740636, 932.4917919733745, 940.2900809888533, 949.9097585729355, 17303.740443893337, 17795.73306400405, 17838.554036149104, 17946.730799038025, 17971.371002014934, 17132.743008854875, 17194.39819606314, 19482.020121526057, 22582.774172258272, 22673.0, 1022.2282176956406, 1053.2469284461608, 1055.1031623120364, 1058.481344141369, 1058.925875188737, 970.6942313171364, 1019.3017782818756, 1052.9578816847318, 1056.023178559833, 1056.6829951014704, 1105.7401510644993, 1109.7225693576606, 1110.4281295133012, 1111.9332840029583, 1112.3881864974271, 1097.6103483263487, 1113.521185890067, 1114.3202646385657, 1114.788190243855, 1117.0616681987128, 810.5217921426387, 813.4996976859248, 814.7800093974594, 815.3192084609358, 816.3632366753941, 19759.703604445946, 20235.291764788308, 20427.080781364875, 20475.2833650823, 20517.692234616494, 21952.231671891408, 22103.778962210494, 22488.0, 22529.21147759837, 22697.09211631533, 15725.135117568529, 15909.0, 15956.601084972852, 16884.07137607431, 17410.825891741046, 3529.7176225901867, 3537.982310088433, 3547.929041419183, 3549.680528752399, 3550.6449355064547, 123543.38228308801, 124991.0, 125872.37063814714, 129951.99999999905, 130550.0, 16976.40582579604, 17250.0, 17417.477475675496, 17596.12019399025, 17655.73516397255, 31773.682263177074, 32196.678033219836, 32241.193970150463, 32579.18552036218, 32755.83622081922, 8503.872441913376, 8578.528180949983, 8586.270167035871, 8593.69922052725, 8604.526751028628, 4109.815058322323, 4139.875803725893, 4218.557051509609, 4228.4080228768, 4271.530131685512, 5427.7244847460815, 5448.645838020516, 5495.642783219078, 5527.447255274521, 5529.806456773994, 998.4259051045677, 1016.5222345497605, 1018.2057994764095, 1022.8619136416488, 1029.2023681646783, 638.958467699598, 653.7777155767062, 668.9565178263397, 676.1210426445601, 676.202081543783, 11143.944280278709, 11713.849805051683, 11811.173217874666, 11937.28376297425, 12084.093692973061, 676.6075676107846, 689.36233983565, 698.8218004408843, 703.3353480960443, 712.3731116617447, 5623.746931388097, 5631.802886898939, 5816.563757718188, 6165.938340616626, 6406.135171751847, 110988.0, 114290.0, 115666.42166789112, 116210.41894790641, 121773.39113304377, 79002.0, 96453.51773241229, 98687.01312986921, 99718.50140749395, 104323.4783826076, 82662.58668706618, 86460.56769716238, 91255.0, 91821.54089229644, 91989.0, 12471.563495277622, 12773.872261277269, 12938.288394138037, 12944.611661650166, 13352.465901363837, 39679.0, 41074.58925410708, 41214.0, 41498.37752433776, 42368.0, 69675.0, 70172.0, 72936.0, 73884.63057684677, 76008.0, 18485.53786155357, 19201.903990479957, 19333.226670933003, 19533.902330488258, 19540.8045919539, 21098.789012109683, 21656.0, 21660.566788663822, 21695.78304217001, 21766.89116554407, 18426.35507757222, 18990.715139273198, 19054.618907621494, 19070.14184361679, 19378.515537111685, 18858.0, 19198.61602767909, 19243.1340589671, 19270.132844022333, 19487.0, 17821.554461138574, 17838.19728112212, 17880.46358609244, 17936.820631793515, 18001.369952051617, 13457.663558411117, 13681.657958551115, 13733.0, 13808.171509709047, 14322.928385358007, 13095.541656042375, 14118.152910825384, 14495.492657756928, 15131.621709457351, 15404.614884627526], "value": 9349.253781640753, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 100.0, 109.0, 118.0, 109.0, 110.0, 105.0, 107.0, 108.0], "value": 107.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 119.0, 153.0, 189.0, 117.0, 159.0, 146.0, 122.0, 174.0, 120.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 164.0, 161.0, 162.0, 161.0, 162.0, 179.0, 164.0, 167.0, 167.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 169.0, 77.0, 82.0, 74.0, 90.0, 103.0, 82.0], "value": 90.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 133.0, 80.0, 81.0, 80.0, 127.0, 80.0, 79.0, 133.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 115.0, 119.0, 114.0, 115.0, 117.0, 119.0, 117.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 154.0, 149.0, 152.0, 150.0, 151.0, 150.0, 151.0, 151.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 102.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 53.0, 53.0, 54.0, 53.0, 58.0, 57.0, 52.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 56.0, 55.0, 54.0, 54.0, 66.0, 55.0, 55.0, 54.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 78.0, 90.0, 76.0, 87.0, 83.0, 87.0, 78.0, 78.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 119.0, 126.0, 125.0, 122.0, 121.0, 121.0, 129.0, 124.0, 164.0], "value": 127.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 174.0, 181.0, 173.0, 196.0, 175.0, 200.0, 176.0, 172.0, 180.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 74.0, 76.0, 66.0, 67.0, 69.0, 65.0, 66.0, 69.0], "value": 68.9, "unit": "score"}]}]} 16:40:07 INFO - Return code: 0 16:40:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:40:07 INFO - # TBPL SUCCESS # 16:40:07 INFO - Running post-action listener: _package_coverage_data 16:40:07 INFO - Running post-action listener: _resource_record_post_action 16:40:07 INFO - [mozharness: 2017-08-12 23:40:07.783963Z] Finished run-tests step (success) 16:40:07 INFO - Running post-run listener: _resource_record_post_run 16:40:07 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 569344; Write bytes: 432852992; Read time: 252; Write time: 376712 16:40:07 INFO - TinderboxPrint: CPU usage
13.1% 16:40:07 INFO - TinderboxPrint: I/O read bytes / time
569,344 / 252 16:40:07 INFO - TinderboxPrint: I/O write bytes / time
432,852,992 / 376,712 16:40:07 INFO - TinderboxPrint: CPU idle
8,275.1 (86.8%) 16:40:07 INFO - TinderboxPrint: CPU user
1,201.1 (12.6%) 16:40:07 INFO - TinderboxPrint: Swap in / out
0 / 0 16:40:07 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106618880; Read time: 0; Write time: 101340 16:40:07 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:40:07 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 565248; Write bytes: 325111808; Read time: 236; Write time: 275292 16:40:08 INFO - Running post-run listener: _upload_blobber_files 16:40:08 INFO - Blob upload gear active. 16:40:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:40:08 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 16:40:08 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'] 16:40:08 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 16:40:08 INFO - (blobuploader) - INFO - Open directory for files ... 16:40:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:40:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:40:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:09 INFO - (blobuploader) - INFO - Done attempting. 16:40:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:40:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:40:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:10 INFO - (blobuploader) - INFO - Done attempting. 16:40:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:40:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:11 INFO - (blobuploader) - INFO - Done attempting. 16:40:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:40:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:40:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:40:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:40:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:40:14 INFO - (blobuploader) - INFO - Done attempting. 16:40:14 INFO - (blobuploader) - INFO - Iteration through files over. 16:40:14 INFO - Return code: 0 16:40:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:40:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:40:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8854b302b734c03e3ae3967fd4799afede39af099c0eb59298d64810e820644980383ef7f8d05d1f5893241b4547f4a01d2a90a12e58bbc94d6b700ffc3e55a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25d01d113d786a85e7407f45b6582ea1c0df4c06e2e60740cce7bc38987f7cba6b4cca1970521cc816f0233826372f4f77059f6f7c1193ddb0bc00e53e2679d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4198ffed03f52ec33371e6ca2606b3f7cbbcc2dbe2cd09e1c0602bbf4cec478eda35c9c1df891bc107d527150166405e4647a176289d96e83c31ffa1fcf4ff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0e58e86c021ce89e465e6c466ab757fab1f85c24f013a13e395d50beda191bb2ac504408605445226391232f664e17d5483f0704dc4c444d4cdb59c3b96f8e6"} 16:40:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:40:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:40:14 INFO - Contents: 16:40:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8854b302b734c03e3ae3967fd4799afede39af099c0eb59298d64810e820644980383ef7f8d05d1f5893241b4547f4a01d2a90a12e58bbc94d6b700ffc3e55a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25d01d113d786a85e7407f45b6582ea1c0df4c06e2e60740cce7bc38987f7cba6b4cca1970521cc816f0233826372f4f77059f6f7c1193ddb0bc00e53e2679d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4198ffed03f52ec33371e6ca2606b3f7cbbcc2dbe2cd09e1c0602bbf4cec478eda35c9c1df891bc107d527150166405e4647a176289d96e83c31ffa1fcf4ff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0e58e86c021ce89e465e6c466ab757fab1f85c24f013a13e395d50beda191bb2ac504408605445226391232f664e17d5483f0704dc4c444d4cdb59c3b96f8e6"} 16:40:14 INFO - Running post-run listener: copy_logs_to_upload_dir 16:40:14 INFO - Copying logs to upload dir... 16:40:14 INFO - mkdir: /builds/slave/test/build/upload/logs 16:40:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.892908 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-08-12 16:40:13.797627) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-12 16:40:13.801006) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8854b302b734c03e3ae3967fd4799afede39af099c0eb59298d64810e820644980383ef7f8d05d1f5893241b4547f4a01d2a90a12e58bbc94d6b700ffc3e55a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25d01d113d786a85e7407f45b6582ea1c0df4c06e2e60740cce7bc38987f7cba6b4cca1970521cc816f0233826372f4f77059f6f7c1193ddb0bc00e53e2679d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4198ffed03f52ec33371e6ca2606b3f7cbbcc2dbe2cd09e1c0602bbf4cec478eda35c9c1df891bc107d527150166405e4647a176289d96e83c31ffa1fcf4ff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0e58e86c021ce89e465e6c466ab757fab1f85c24f013a13e395d50beda191bb2ac504408605445226391232f664e17d5483f0704dc4c444d4cdb59c3b96f8e6"} build_url:https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/eRGUWGbpQu2kTLRetgvcig/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8854b302b734c03e3ae3967fd4799afede39af099c0eb59298d64810e820644980383ef7f8d05d1f5893241b4547f4a01d2a90a12e58bbc94d6b700ffc3e55a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25d01d113d786a85e7407f45b6582ea1c0df4c06e2e60740cce7bc38987f7cba6b4cca1970521cc816f0233826372f4f77059f6f7c1193ddb0bc00e53e2679d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4198ffed03f52ec33371e6ca2606b3f7cbbcc2dbe2cd09e1c0602bbf4cec478eda35c9c1df891bc107d527150166405e4647a176289d96e83c31ffa1fcf4ff0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f0e58e86c021ce89e465e6c466ab757fab1f85c24f013a13e395d50beda191bb2ac504408605445226391232f664e17d5483f0704dc4c444d4cdb59c3b96f8e6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-12 16:40:13.827189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 16:40:13.827644) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1258088b6da462a47ba2cd90000001a2-1502578861.713223-133126434 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004393 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-12 16:40:13.910265) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-12 16:40:13.910670) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-12 16:40:13.911080) ========= ========= Total master_lag: 0.18 =========