builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1502230400.24 results: success (0) revision: be392d4638052977f11e3fdd7fe6aac78057351c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:20.236139) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:20.236555) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:20.237933) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:20.269151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:20.269440) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-08 15:13: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% 111M=0s 2017-08-08 15:13:20 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124030 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:20.413283) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:20.413566) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020456 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:20.463806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:20.464142) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev be392d4638052977f11e3fdd7fe6aac78057351c --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 be392d4638052977f11e3fdd7fe6aac78057351c --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=a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-08 15:13:20,824 truncating revision to first 12 chars 2017-08-08 15:13:20,824 Setting DEBUG logging. 2017-08-08 15:13:20,824 attempt 1/10 2017-08-08 15:13:20,824 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/be392d463805?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-08 15:13:21,373 unpacking tar archive at: mozilla-central-be392d463805/testing/mozharness/ program finished with exit code 0 elapsedTime=0.850393 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:21.328222) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:21.328538) ========= script_repo_revision: be392d4638052977f11e3fdd7fe6aac78057351c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:21.328906) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:21.329215) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 15:13:21.338166) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-08 15:13:21.338433) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:13:21 INFO - MultiFileLogger online at 20170808 15:13:21 in /builds/slave/test 15:13:21 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 15:13:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:13:21 INFO - {'append_to_log': False, 15:13:21 INFO - 'base_work_dir': '/builds/slave/test', 15:13:21 INFO - 'blob_upload_branch': 'Firefox', 15:13:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:13:21 INFO - 'branch': 'Firefox', 15:13:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:13:21 INFO - 'code_coverage': False, 15:13:21 INFO - 'config_files': ('talos/linux_config.py',), 15:13:21 INFO - 'default_actions': ('clobber', 15:13:21 INFO - 'read-buildbot-config', 15:13:21 INFO - 'download-and-extract', 15:13:21 INFO - 'populate-webroot', 15:13:21 INFO - 'create-virtualenv', 15:13:21 INFO - 'install', 15:13:21 INFO - 'setup-mitmproxy', 15:13:21 INFO - 'run-tests'), 15:13:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:13:21 INFO - 'disable_ccov_upload': False, 15:13:21 INFO - 'download_minidump_stackwalk': True, 15:13:21 INFO - 'download_symbols': 'ondemand', 15:13:21 INFO - 'enable_stylo': False, 15:13:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:13:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:13:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:13:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:13:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:13:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:13:21 INFO - 'gecko_profile': False, 15:13:21 INFO - 'gecko_profile_interval': 0, 15:13:21 INFO - 'installer_path': 'installer.exe', 15:13:21 INFO - 'log_level': 'info', 15:13:21 INFO - 'log_name': 'talos', 15:13:21 INFO - 'log_to_console': True, 15:13:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:13:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:13:21 INFO - 'opt_config_files': (), 15:13:21 INFO - 'pip_index': False, 15:13:21 INFO - 'suite': 'dromaeojs-e10s', 15:13:21 INFO - 'system_bits': '32', 15:13:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:13:21 INFO - 'title': 'talos-linux64-ix-062', 15:13:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:13:21 INFO - 'use_talos_json': True, 15:13:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:13:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:13:21 INFO - 'work_dir': 'build'} 15:13:21 INFO - [mozharness: 2017-08-08 22:13:21.810738Z] Running clobber step. 15:13:21 INFO - Running pre-action listener: _resource_record_pre_action 15:13:21 INFO - Running main action method: clobber 15:13:21 INFO - rmtree: /builds/slave/test/build 15:13:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:13:23 INFO - Running post-action listener: _resource_record_post_action 15:13:23 INFO - [mozharness: 2017-08-08 22:13:23.382853Z] Finished clobber step (success) 15:13:23 INFO - [mozharness: 2017-08-08 22:13:23.382955Z] Running read-buildbot-config step. 15:13:23 INFO - Running pre-action listener: _resource_record_pre_action 15:13:23 INFO - Running main action method: read_buildbot_config 15:13:23 INFO - Using buildbot properties: 15:13:23 INFO - { 15:13:23 INFO - "project": "", 15:13:23 INFO - "product": "firefox", 15:13:23 INFO - "who": "kwierso@gmail.com", 15:13:23 INFO - "installer_path": "public/build/target.tar.bz2", 15:13:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:13:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 15:13:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 15:13:23 INFO - "stage_platform": "linux64-pgo", 15:13:23 INFO - "basedir": "/builds/slave/test", 15:13:23 INFO - "buildnumber": 113, 15:13:23 INFO - "platform": "ubuntu64_hw", 15:13:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:13:23 INFO - "slavebuilddir": "test", 15:13:23 INFO - "taskId": "AqiQIrCKQQG-dLsBbnAjAQ", 15:13:23 INFO - "branch": "mozilla-central", 15:13:23 INFO - "script_repo_revision": "production", 15:13:23 INFO - "revision": "be392d4638052977f11e3fdd7fe6aac78057351c", 15:13:23 INFO - "slavename": "talos-linux64-ix-062", 15:13:23 INFO - "repo_path": "mozilla-central" 15:13:23 INFO - } 15:13:23 INFO - Finding installer, test and symbols from parent task. 15:13:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AqiQIrCKQQG-dLsBbnAjAQ'}, attempt #1 15:13:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AqiQIrCKQQG-dLsBbnAjAQ'}, attempt #1 15:13:24 INFO - Task dependencies: eE2JpUv1QuiQ2P2aH43FZQ 15:13:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ'}, attempt #1 15:13:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.tar.bz2 15:13:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.test_packages.json 15:13:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.crashreporter-symbols.zip 15:13:24 INFO - Running post-action listener: _resource_record_post_action 15:13:24 INFO - [mozharness: 2017-08-08 22:13:24.768766Z] Finished read-buildbot-config step (success) 15:13:24 INFO - [mozharness: 2017-08-08 22:13:24.768990Z] Running download-and-extract step. 15:13:24 INFO - Running pre-action listener: _resource_record_pre_action 15:13:24 INFO - Running main action method: download_and_extract 15:13:24 INFO - mkdir: /builds/slave/test/build/tests 15:13:24 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')]} 15:13:24 INFO - trying https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.test_packages.json 15:13:24 INFO - Downloading https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 15:13:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 15:13:25 INFO - Downloaded 989 bytes. 15:13:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 15:13:25 INFO - Using the following test package requirements: 15:13:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 15:13:25 INFO - u'common': [u'target.common.tests.zip'], 15:13:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 15:13:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 15:13:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 15:13:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 15:13:25 INFO - u'mozbase': [u'target.common.tests.zip'], 15:13:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 15:13:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 15:13:25 INFO - u'web-platform': [u'target.common.tests.zip', 15:13:25 INFO - u'target.web-platform.tests.tar.gz'], 15:13:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 15:13:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 15:13:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.common.tests.zip 15:13:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:13:25 INFO - Fetch https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.common.tests.zip into memory 15:13:28 INFO - Content-Length response header: 54886654 15:13:28 INFO - Bytes received: 54886654 15:13:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 15:13:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.common.tests.zip 15:13:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 15:13:39 INFO - Fetch https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.common.tests.zip into memory 15:13:41 INFO - Content-Length response header: 54886654 15:13:41 INFO - Bytes received: 54886654 15:13:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.talos.tests.zip 15:13:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 15:13:53 INFO - Fetch https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.talos.tests.zip into memory 15:13:53 INFO - Content-Length response header: 14496008 15:13:53 INFO - Bytes received: 14496008 15:13:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:13:54 INFO - trying https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.tar.bz2 15:13:54 INFO - Downloading https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 15:13:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 15:13:56 INFO - Downloaded 62643195 bytes. 15:13:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.tar.bz2 15:13:56 INFO - mkdir: /builds/slave/test/properties 15:13:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:13:56 INFO - Writing to file /builds/slave/test/properties/build_url 15:13:56 INFO - Contents: 15:13:56 INFO - build_url:https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.tar.bz2 15:13:56 INFO - Running post-action listener: _resource_record_post_action 15:13:56 INFO - Running post-action listener: set_extra_try_arguments 15:13:56 INFO - [mozharness: 2017-08-08 22:13:56.477867Z] Finished download-and-extract step (success) 15:13:56 INFO - [mozharness: 2017-08-08 22:13:56.478047Z] Running populate-webroot step. 15:13:56 INFO - Running pre-action listener: _resource_record_pre_action 15:13:56 INFO - Running main action method: populate_webroot 15:13:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:13:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:13:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:13:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:13:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:13:56 INFO - 'tests': ['damp', 'tps']}, 15:13:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:13:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 15:13:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 15:13:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 15:13:56 INFO - 'other-e10s': {'tests': ['a11yr', 15:13:56 INFO - 'ts_paint', 15:13:56 INFO - 'tpaint', 15:13:56 INFO - 'sessionrestore', 15:13:56 INFO - 'sessionrestore_many_windows', 15:13:56 INFO - 'sessionrestore_no_auto_restore', 15:13:56 INFO - 'tabpaint']}, 15:13:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 15:13:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 15:13:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:13:56 INFO - 'tsvgr_opacity', 15:13:56 INFO - 'tart', 15:13:56 INFO - 'tscrollx', 15:13:56 INFO - 'tsvg_static']}, 15:13:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:13:56 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:13:56 INFO - 'talos_options': ['--mitmproxy', 15:13:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:13:56 INFO - '--firstNonBlankPaint'], 15:13:56 INFO - 'tests': ['tp6_google', 15:13:56 INFO - 'tp6_youtube', 15:13:56 INFO - 'tp6_amazon', 15:13:56 INFO - 'tp6_facebook']}, 15:13:56 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:13:56 INFO - 'talos_options': ['--stylo', 15:13:56 INFO - '--mitmproxy', 15:13:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:13:56 INFO - '--firstNonBlankPaint'], 15:13:56 INFO - 'tests': ['tp6_google', 15:13:56 INFO - 'tp6_youtube', 15:13:56 INFO - 'tp6_amazon', 15:13:56 INFO - 'tp6_facebook']}, 15:13:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 15:13:56 INFO - 'talos_options': ['--stylo', 15:13:56 INFO - '--stylo-threads=1', 15:13:56 INFO - '--mitmproxy', 15:13:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 15:13:56 INFO - '--firstNonBlankPaint'], 15:13:56 INFO - 'tests': ['tp6_google', 15:13:56 INFO - 'tp6_youtube', 15:13:56 INFO - 'tp6_amazon', 15:13:56 INFO - 'tp6_facebook']}, 15:13:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:13:56 INFO - 'talos_options': ['--xperf_path', 15:13:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:13:56 INFO - 'tests': ['tp5n']}}} 15:13:56 INFO - Running post-action listener: _resource_record_post_action 15:13:56 INFO - [mozharness: 2017-08-08 22:13:56.492040Z] Finished populate-webroot step (success) 15:13:56 INFO - [mozharness: 2017-08-08 22:13:56.492131Z] Running create-virtualenv step. 15:13:56 INFO - Running pre-action listener: _resource_record_pre_action 15:13:56 INFO - Running main action method: create_virtualenv 15:13:56 INFO - Creating virtualenv /builds/slave/test/build/venv 15:13:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:13:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:13:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 15:13:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:13:56 INFO - Using real prefix '/usr' 15:13:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:13:57 INFO - Installing distribute.............................................................................................................................................................................................done. 15:13:59 INFO - Installing pip.................done. 15:13:59 INFO - Return code: 0 15:13:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:13:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:13:59 INFO - Reading from file tmpfile_stdout 15:13:59 INFO - Output received: 15:13:59 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) 15:13:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:13: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')]} 15:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13: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')]} 15:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7eb0>, '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 0x1fd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', '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 15:13: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', 'pip>=1.5'] in /builds/slave/test/build 15:13: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 pip>=1.5 15:13:59 INFO - Using env: {'DISPLAY': ':0', 15:13:59 INFO - 'HOME': '/home/cltbld', 15:13:59 INFO - 'LANG': 'en_US.UTF-8', 15:13:59 INFO - 'LANGUAGE': 'en_US:en', 15:13:59 INFO - 'LOGNAME': 'cltbld', 15:13:59 INFO - 'MAIL': '/var/mail/cltbld', 15:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:59 INFO - 'MOZ_NO_REMOTE': '1', 15:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:59 INFO - 'NO_EM_RESTART': '1', 15:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:59 INFO - 'PWD': '/builds/slave/test', 15:13:59 INFO - 'SHELL': '/bin/bash', 15:13:59 INFO - 'SHLVL': '1', 15:13:59 INFO - 'TERM': 'linux', 15:13:59 INFO - 'TMOUT': '86400', 15:13:59 INFO - 'USER': 'cltbld', 15:13:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', 15:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:59 INFO - '_': '/tools/buildbot/bin/python'} 15:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:59 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 15:13:59 INFO - Cleaning up... 15:13:59 INFO - Return code: 0 15:13:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:13: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')]} 15:13:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:13: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')]} 15:13:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:13: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', '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 0x1c6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7eb0>, '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 0x1fd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', '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 15:13: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', 'psutil>=3.1.1'] in /builds/slave/test/build 15:13: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 psutil>=3.1.1 15:13:59 INFO - Using env: {'DISPLAY': ':0', 15:13:59 INFO - 'HOME': '/home/cltbld', 15:13:59 INFO - 'LANG': 'en_US.UTF-8', 15:13:59 INFO - 'LANGUAGE': 'en_US:en', 15:13:59 INFO - 'LOGNAME': 'cltbld', 15:13:59 INFO - 'MAIL': '/var/mail/cltbld', 15:13:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:13:59 INFO - 'MOZ_NO_REMOTE': '1', 15:13:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:13:59 INFO - 'NO_EM_RESTART': '1', 15:13:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:13:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:13:59 INFO - 'PWD': '/builds/slave/test', 15:13:59 INFO - 'SHELL': '/bin/bash', 15:13:59 INFO - 'SHLVL': '1', 15:13:59 INFO - 'TERM': 'linux', 15:13:59 INFO - 'TMOUT': '86400', 15:13:59 INFO - 'USER': 'cltbld', 15:13:59 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', 15:13:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:13:59 INFO - '_': '/tools/buildbot/bin/python'} 15:13:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:13:59 INFO - Downloading/unpacking psutil>=3.1.1 15:13: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 15:13: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 15:13: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 15:13: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 15:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:14:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:00 INFO - Installing collected packages: psutil 15:14:00 INFO - Running setup.py install for psutil 15:14:01 INFO - building 'psutil._psutil_linux' extension 15:14:01 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 15:14:01 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 15:14:01 INFO - building 'psutil._psutil_posix' extension 15:14:01 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 15:14:01 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 15:14:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:14:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:14:01 INFO - Successfully installed psutil 15:14:01 INFO - Cleaning up... 15:14:01 INFO - Return code: 0 15:14:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:14: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')]} 15:14:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14: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')]} 15:14:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7eb0>, '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 0x1fd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', '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 15:14: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:14: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 mozsystemmonitor==0.3 15:14:01 INFO - Using env: {'DISPLAY': ':0', 15:14:01 INFO - 'HOME': '/home/cltbld', 15:14:01 INFO - 'LANG': 'en_US.UTF-8', 15:14:01 INFO - 'LANGUAGE': 'en_US:en', 15:14:01 INFO - 'LOGNAME': 'cltbld', 15:14:01 INFO - 'MAIL': '/var/mail/cltbld', 15:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:01 INFO - 'MOZ_NO_REMOTE': '1', 15:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:01 INFO - 'NO_EM_RESTART': '1', 15:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:01 INFO - 'PWD': '/builds/slave/test', 15:14:01 INFO - 'SHELL': '/bin/bash', 15:14:01 INFO - 'SHLVL': '1', 15:14:01 INFO - 'TERM': 'linux', 15:14:01 INFO - 'TMOUT': '86400', 15:14:01 INFO - 'USER': 'cltbld', 15:14:01 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', 15:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:01 INFO - '_': '/tools/buildbot/bin/python'} 15:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:14: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 15:14: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 15:14: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 15:14: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 15:14:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:14:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:14:02 INFO - Installing collected packages: mozsystemmonitor 15:14:02 INFO - Running setup.py install for mozsystemmonitor 15:14:02 INFO - Successfully installed mozsystemmonitor 15:14:02 INFO - Cleaning up... 15:14:03 INFO - Return code: 0 15:14:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:14: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')]} 15:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14: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')]} 15:14:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7eb0>, '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 0x1fd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', '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 15:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:14:03 INFO - Using env: {'DISPLAY': ':0', 15:14:03 INFO - 'HOME': '/home/cltbld', 15:14:03 INFO - 'LANG': 'en_US.UTF-8', 15:14:03 INFO - 'LANGUAGE': 'en_US:en', 15:14:03 INFO - 'LOGNAME': 'cltbld', 15:14:03 INFO - 'MAIL': '/var/mail/cltbld', 15:14:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:03 INFO - 'MOZ_NO_REMOTE': '1', 15:14:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:03 INFO - 'NO_EM_RESTART': '1', 15:14:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:03 INFO - 'PWD': '/builds/slave/test', 15:14:03 INFO - 'SHELL': '/bin/bash', 15:14:03 INFO - 'SHLVL': '1', 15:14:03 INFO - 'TERM': 'linux', 15:14:03 INFO - 'TMOUT': '86400', 15:14:03 INFO - 'USER': 'cltbld', 15:14:03 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', 15:14:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:03 INFO - '_': '/tools/buildbot/bin/python'} 15:14:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:03 INFO - Downloading/unpacking jsonschema==2.5.1 15:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:14:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:14:04 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 15:14:04 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 15:14:04 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 15:14:04 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 15:14:04 INFO - Downloading functools32-3.2.3-2.tar.gz 15:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:14:04 INFO - warning: no files found matching '*.txt' 15:14:04 INFO - no previously-included directories found matching 'build' 15:14:04 INFO - no previously-included directories found matching 'dist' 15:14:04 INFO - no previously-included directories found matching '.git*' 15:14:04 INFO - Installing collected packages: jsonschema, functools32 15:14:04 INFO - Running setup.py install for functools32 15:14:04 INFO - warning: no files found matching '*.txt' 15:14:04 INFO - no previously-included directories found matching 'build' 15:14:04 INFO - no previously-included directories found matching 'dist' 15:14:04 INFO - no previously-included directories found matching '.git*' 15:14:04 INFO - Successfully installed jsonschema functools32 15:14:04 INFO - Cleaning up... 15:14:04 INFO - Return code: 0 15:14:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:14:04 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')]} 15:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:04 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')]} 15:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:04 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 0x1c6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7eb0>, '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 0x1fd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', '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 15:14:04 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 15:14:04 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 15:14:04 INFO - Using env: {'DISPLAY': ':0', 15:14:04 INFO - 'HOME': '/home/cltbld', 15:14:04 INFO - 'LANG': 'en_US.UTF-8', 15:14:04 INFO - 'LANGUAGE': 'en_US:en', 15:14:04 INFO - 'LOGNAME': 'cltbld', 15:14:04 INFO - 'MAIL': '/var/mail/cltbld', 15:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:04 INFO - 'MOZ_NO_REMOTE': '1', 15:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:04 INFO - 'NO_EM_RESTART': '1', 15:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:04 INFO - 'PWD': '/builds/slave/test', 15:14:04 INFO - 'SHELL': '/bin/bash', 15:14:04 INFO - 'SHLVL': '1', 15:14:04 INFO - 'TERM': 'linux', 15:14:04 INFO - 'TMOUT': '86400', 15:14:04 INFO - 'USER': 'cltbld', 15:14:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', 15:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:04 INFO - '_': '/tools/buildbot/bin/python'} 15:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:14:04 INFO - Cleaning up... 15:14:04 INFO - Return code: 0 15:14:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:14:04 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')]} 15:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:04 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')]} 15:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:04 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 0x1c6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7eb0>, '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 0x1fd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', '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 15:14:04 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 15:14:04 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 15:14:04 INFO - Using env: {'DISPLAY': ':0', 15:14:04 INFO - 'HOME': '/home/cltbld', 15:14:04 INFO - 'LANG': 'en_US.UTF-8', 15:14:04 INFO - 'LANGUAGE': 'en_US:en', 15:14:04 INFO - 'LOGNAME': 'cltbld', 15:14:04 INFO - 'MAIL': '/var/mail/cltbld', 15:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:04 INFO - 'MOZ_NO_REMOTE': '1', 15:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:04 INFO - 'NO_EM_RESTART': '1', 15:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:04 INFO - 'PWD': '/builds/slave/test', 15:14:04 INFO - 'SHELL': '/bin/bash', 15:14:04 INFO - 'SHLVL': '1', 15:14:04 INFO - 'TERM': 'linux', 15:14:04 INFO - 'TMOUT': '86400', 15:14:04 INFO - 'USER': 'cltbld', 15:14:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', 15:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:04 INFO - '_': '/tools/buildbot/bin/python'} 15:14:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:05 INFO - Downloading/unpacking blobuploader==1.2.4 15:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:06 INFO - Downloading blobuploader-1.2.4.tar.gz 15:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:14:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:14:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:06 INFO - Downloading docopt-0.6.1.tar.gz 15:14:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:14:06 INFO - Installing collected packages: blobuploader, requests, docopt 15:14:06 INFO - Running setup.py install for blobuploader 15:14:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:14:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:14:06 INFO - Running setup.py install for requests 15:14:07 INFO - Running setup.py install for docopt 15:14:07 INFO - Successfully installed blobuploader requests docopt 15:14:07 INFO - Cleaning up... 15:14:07 INFO - Return code: 0 15:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:07 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 0x1c6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7eb0>, '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 0x1fd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', '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 15:14:07 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 15:14:07 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 15:14:07 INFO - Using env: {'DISPLAY': ':0', 15:14:07 INFO - 'HOME': '/home/cltbld', 15:14:07 INFO - 'LANG': 'en_US.UTF-8', 15:14:07 INFO - 'LANGUAGE': 'en_US:en', 15:14:07 INFO - 'LOGNAME': 'cltbld', 15:14:07 INFO - 'MAIL': '/var/mail/cltbld', 15:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:07 INFO - 'MOZ_NO_REMOTE': '1', 15:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:07 INFO - 'NO_EM_RESTART': '1', 15:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:07 INFO - 'PWD': '/builds/slave/test', 15:14:07 INFO - 'SHELL': '/bin/bash', 15:14:07 INFO - 'SHLVL': '1', 15:14:07 INFO - 'TERM': 'linux', 15:14:07 INFO - 'TMOUT': '86400', 15:14:07 INFO - 'USER': 'cltbld', 15:14:07 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', 15:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:07 INFO - '_': '/tools/buildbot/bin/python'} 15:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:07 INFO - Running setup.py (path:/tmp/pip-rw7ohL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:07 INFO - Running setup.py (path:/tmp/pip-HacMnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:07 INFO - Running setup.py (path:/tmp/pip-0XFbxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:07 INFO - Running setup.py (path:/tmp/pip-dqiLAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:07 INFO - Running setup.py (path:/tmp/pip-fNmAPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:07 INFO - Running setup.py (path:/tmp/pip-NfrMAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:08 INFO - Running setup.py (path:/tmp/pip-vexau4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:08 INFO - Running setup.py (path:/tmp/pip-1rOJCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:08 INFO - Running setup.py (path:/tmp/pip-YGBRZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:08 INFO - Running setup.py (path:/tmp/pip-lXzGtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:08 INFO - Running setup.py (path:/tmp/pip-4jPzUj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:08 INFO - Running setup.py (path:/tmp/pip-GdkIwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:08 INFO - Running setup.py (path:/tmp/pip-j0I4tQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:08 INFO - Running setup.py (path:/tmp/pip-AkUo2G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:08 INFO - Running setup.py (path:/tmp/pip-LqbJ0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:08 INFO - Running setup.py (path:/tmp/pip-6J0ru8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:08 INFO - Running setup.py (path:/tmp/pip-_gTLg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:14:08 INFO - Running setup.py install for manifestparser 15:14:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:14:08 INFO - Running setup.py install for mozcrash 15:14:09 INFO - Running setup.py install for mozdebug 15:14:09 INFO - Running setup.py install for mozdevice 15:14:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:14:09 INFO - Running setup.py install for mozfile 15:14:09 INFO - Running setup.py install for mozhttpd 15:14:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:14:09 INFO - Running setup.py install for mozinfo 15:14:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:14:09 INFO - Running setup.py install for mozInstall 15:14:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:14:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:14:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:14:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:14:09 INFO - Running setup.py install for mozleak 15:14:09 INFO - Running setup.py install for mozlog 15:14:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:14:09 INFO - Running setup.py install for moznetwork 15:14:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:14:09 INFO - Running setup.py install for mozprocess 15:14:10 INFO - Running setup.py install for mozprofile 15:14:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:14:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:14:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:14:10 INFO - Running setup.py install for mozrunner 15:14:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:14:10 INFO - Running setup.py install for mozscreenshot 15:14:10 INFO - Running setup.py install for moztest 15:14:10 INFO - Running setup.py install for mozversion 15:14:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:14:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:14:10 INFO - Cleaning up... 15:14:10 INFO - Return code: 0 15:14:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:10 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')]} 15:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:10 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')]} 15:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:10 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 0x1c6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7eb0>, '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 0x1fd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', '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 15:14:10 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 15:14:10 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 15:14:10 INFO - Using env: {'DISPLAY': ':0', 15:14:10 INFO - 'HOME': '/home/cltbld', 15:14:10 INFO - 'LANG': 'en_US.UTF-8', 15:14:10 INFO - 'LANGUAGE': 'en_US:en', 15:14:10 INFO - 'LOGNAME': 'cltbld', 15:14:10 INFO - 'MAIL': '/var/mail/cltbld', 15:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:10 INFO - 'MOZ_NO_REMOTE': '1', 15:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:10 INFO - 'NO_EM_RESTART': '1', 15:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:10 INFO - 'PWD': '/builds/slave/test', 15:14:10 INFO - 'SHELL': '/bin/bash', 15:14:10 INFO - 'SHLVL': '1', 15:14:10 INFO - 'TERM': 'linux', 15:14:10 INFO - 'TMOUT': '86400', 15:14:10 INFO - 'USER': 'cltbld', 15:14:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', 15:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:10 INFO - '_': '/tools/buildbot/bin/python'} 15:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:14:10 INFO - Running setup.py (path:/tmp/pip-af8Chb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:14:10 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)) 15:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:14:10 INFO - Running setup.py (path:/tmp/pip-LdJ0JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:14:11 INFO - Running setup.py (path:/tmp/pip-Xu6PVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:14:11 INFO - Running setup.py (path:/tmp/pip-kr_Msm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:14:11 INFO - Running setup.py (path:/tmp/pip-1C3IHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:14:11 INFO - Running setup.py (path:/tmp/pip-BnQvBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:14:11 INFO - Running setup.py (path:/tmp/pip-BLOhVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:14:11 INFO - Running setup.py (path:/tmp/pip-1G4VzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:14:11 INFO - Running setup.py (path:/tmp/pip-EkjkLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:14:11 INFO - Running setup.py (path:/tmp/pip-E0rXE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:14:11 INFO - Running setup.py (path:/tmp/pip-LzN15S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:14:11 INFO - Running setup.py (path:/tmp/pip-GNQjHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:14:11 INFO - Running setup.py (path:/tmp/pip-Tg4b08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:14:11 INFO - Running setup.py (path:/tmp/pip-6vyoxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:11 INFO - Running setup.py (path:/tmp/pip-oM9AHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:14:11 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)) 15:14:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:14:11 INFO - Running setup.py (path:/tmp/pip-HbbIFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:14:12 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)) 15:14:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:14:12 INFO - Running setup.py (path:/tmp/pip-9RxHNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:14:12 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)) 15:14:12 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)) 15:14:12 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)) 15:14:12 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)) 15:14:12 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)) 15:14:12 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)) 15:14:12 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)) 15:14:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:14:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:14:13 INFO - Downloading blessings-1.6.tar.gz 15:14:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:14:13 INFO - Installing collected packages: blessings 15:14:13 INFO - Running setup.py install for blessings 15:14:13 INFO - Successfully installed blessings 15:14:13 INFO - Cleaning up... 15:14:13 INFO - Return code: 0 15:14:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:14:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:13 INFO - Reading from file tmpfile_stdout 15:14:13 INFO - Current package versions: 15:14:13 INFO - argparse == 1.2.1 15:14:13 INFO - blessings == 1.6 15:14:13 INFO - blobuploader == 1.2.4 15:14:13 INFO - docopt == 0.6.1 15:14:13 INFO - functools32 == 3.2.3-2 15:14:13 INFO - jsonschema == 2.5.1 15:14:13 INFO - manifestparser == 1.1 15:14:13 INFO - mozInstall == 1.13 15:14:13 INFO - mozcrash == 1.0 15:14:13 INFO - mozdebug == 0.1 15:14:13 INFO - mozdevice == 0.51 15:14:13 INFO - mozfile == 1.2 15:14:13 INFO - mozhttpd == 0.7 15:14:13 INFO - mozinfo == 0.10 15:14:13 INFO - mozleak == 0.1 15:14:13 INFO - mozlog == 3.5 15:14:13 INFO - moznetwork == 0.27 15:14:13 INFO - mozprocess == 0.25 15:14:13 INFO - mozprofile == 0.28 15:14:13 INFO - mozrunner == 6.13 15:14:13 INFO - mozscreenshot == 0.1 15:14:13 INFO - mozsystemmonitor == 0.3 15:14:13 INFO - moztest == 0.8 15:14:13 INFO - mozversion == 1.4 15:14:13 INFO - psutil == 3.1.1 15:14:13 INFO - requests == 1.2.3 15:14:13 INFO - wsgiref == 0.1.2 15:14:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:14:13 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')]} 15:14:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:13 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')]} 15:14:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:13 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 0x1c6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7eb0>, '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 0x1fd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', '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 15:14:13 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 15:14:13 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 15:14:13 INFO - Using env: {'DISPLAY': ':0', 15:14:13 INFO - 'HOME': '/home/cltbld', 15:14:13 INFO - 'LANG': 'en_US.UTF-8', 15:14:13 INFO - 'LANGUAGE': 'en_US:en', 15:14:13 INFO - 'LOGNAME': 'cltbld', 15:14:13 INFO - 'MAIL': '/var/mail/cltbld', 15:14:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:13 INFO - 'MOZ_NO_REMOTE': '1', 15:14:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:13 INFO - 'NO_EM_RESTART': '1', 15:14:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:13 INFO - 'PWD': '/builds/slave/test', 15:14:13 INFO - 'SHELL': '/bin/bash', 15:14:13 INFO - 'SHLVL': '1', 15:14:13 INFO - 'TERM': 'linux', 15:14:13 INFO - 'TMOUT': '86400', 15:14:13 INFO - 'USER': 'cltbld', 15:14:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', 15:14:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:13 INFO - '_': '/tools/buildbot/bin/python'} 15:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:13 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)) 15:14:13 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)) 15:14:13 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)) 15:14:13 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)) 15:14:13 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)) 15:14:13 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)) 15:14:13 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)) 15:14:13 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)) 15:14:13 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)) 15:14:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 15:14:13 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 15:14:13 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 15:14:13 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 15:14:13 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 15:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 15:14:15 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)) 15:14:15 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)) 15:14:15 INFO - Installing collected packages: simplejson 15:14:15 INFO - Running setup.py install for simplejson 15:14:15 INFO - building 'simplejson._speedups' extension 15:14:15 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 15:14:15 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 15:14:16 INFO - Successfully installed simplejson 15:14:16 INFO - Cleaning up... 15:14:16 INFO - Return code: 0 15:14:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:14:16 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')]} 15:14:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:14:16 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')]} 15:14:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:14:16 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 0x1c6b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e37a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fdad10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7eb0>, '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 0x1fd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', '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 15:14:16 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 15:14:16 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 15:14:16 INFO - Using env: {'DISPLAY': ':0', 15:14:16 INFO - 'HOME': '/home/cltbld', 15:14:16 INFO - 'LANG': 'en_US.UTF-8', 15:14:16 INFO - 'LANGUAGE': 'en_US:en', 15:14:16 INFO - 'LOGNAME': 'cltbld', 15:14:16 INFO - 'MAIL': '/var/mail/cltbld', 15:14:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:16 INFO - 'MOZ_NO_REMOTE': '1', 15:14:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:16 INFO - 'NO_EM_RESTART': '1', 15:14:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:16 INFO - 'PWD': '/builds/slave/test', 15:14:16 INFO - 'SHELL': '/bin/bash', 15:14:16 INFO - 'SHLVL': '1', 15:14:16 INFO - 'TERM': 'linux', 15:14:16 INFO - 'TMOUT': '86400', 15:14:16 INFO - 'USER': 'cltbld', 15:14:16 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', 15:14:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:16 INFO - '_': '/tools/buildbot/bin/python'} 15:14:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:14:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:14:16 INFO - Cleaning up... 15:14:16 INFO - Return code: 0 15:14:16 INFO - Running post-action listener: _resource_record_post_action 15:14:16 INFO - Running post-action listener: _start_resource_monitoring 15:14:16 INFO - Starting resource monitoring. 15:14:16 INFO - [mozharness: 2017-08-08 22:14:16.412464Z] Finished create-virtualenv step (success) 15:14:16 INFO - [mozharness: 2017-08-08 22:14:16.413048Z] Running install step. 15:14:16 INFO - Running pre-action listener: _resource_record_pre_action 15:14:16 INFO - Running main action method: install 15:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:14:16 INFO - Reading from file tmpfile_stdout 15:14:16 INFO - Detecting whether we're running mozinstall >=1.0... 15:14:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:14:16 INFO - Reading from file tmpfile_stdout 15:14:16 INFO - Output received: 15:14:16 INFO - Usage: mozinstall [options] installer 15:14:16 INFO - Options: 15:14:16 INFO - -h, --help show this help message and exit 15:14:16 INFO - -d DEST, --destination=DEST 15:14:16 INFO - Directory to install application into. [default: 15:14:16 INFO - "/builds/slave/test"] 15:14:16 INFO - --app=APP Application being installed. [default: firefox] 15:14:16 INFO - mkdir: /builds/slave/test/build/application 15:14:16 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'] 15:14:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 15:14:34 INFO - Reading from file tmpfile_stdout 15:14:34 INFO - Output received: 15:14:34 INFO - /builds/slave/test/build/application/firefox/firefox 15:14:34 INFO - Running post-action listener: _resource_record_post_action 15:14:34 INFO - [mozharness: 2017-08-08 22:14:34.523575Z] Finished install step (success) 15:14:34 INFO - [mozharness: 2017-08-08 22:14:34.523923Z] Running setup-mitmproxy step. 15:14:34 INFO - Running pre-action listener: _resource_record_pre_action 15:14:34 INFO - Running main action method: setup_mitmproxy 15:14:34 INFO - Skipping: mitmproxy is not required 15:14:34 INFO - Running post-action listener: _resource_record_post_action 15:14:34 INFO - [mozharness: 2017-08-08 22:14:34.525640Z] Finished setup-mitmproxy step (success) 15:14:34 INFO - [mozharness: 2017-08-08 22:14:34.525951Z] Running run-tests step. 15:14:34 INFO - Running pre-action listener: _resource_record_pre_action 15:14:34 INFO - Running pre-action listener: _set_gcov_prefix 15:14:34 INFO - Running main action method: run_tests 15:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:14:34 INFO - Python 2.7.3 15:14:34 INFO - Return code: 0 15:14:34 INFO - grabbing minidump binary from tooltool 15:14:34 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')]} 15:14:34 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 0x1fd7eb0>, '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 0x1fd8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd9240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:14:34 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 15:14:34 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 15:14:34 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 15:14:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:14:34 INFO - Return code: 0 15:14:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:14:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:14:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:14:34 INFO - ENV: RUST_BACKTRACE is now 1 15:14:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:14:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:14:34 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/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 15:14:34 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/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 15:14:34 INFO - Using env: {'DISPLAY': ':0', 15:14:34 INFO - 'HOME': '/home/cltbld', 15:14:34 INFO - 'LANG': 'en_US.UTF-8', 15:14:34 INFO - 'LANGUAGE': 'en_US:en', 15:14:34 INFO - 'LOGNAME': 'cltbld', 15:14:34 INFO - 'MAIL': '/var/mail/cltbld', 15:14:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:14:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:14:34 INFO - 'MOZ_NO_REMOTE': '1', 15:14:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:14:34 INFO - 'NO_EM_RESTART': '1', 15:14:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:14:34 INFO - 'PWD': '/builds/slave/test', 15:14:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:14:34 INFO - 'RUST_BACKTRACE': '1', 15:14:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 15:14:34 INFO - 'SHELL': '/bin/bash', 15:14:34 INFO - 'SHLVL': '1', 15:14:34 INFO - 'TERM': 'linux', 15:14:34 INFO - 'TMOUT': '86400', 15:14:34 INFO - 'USER': 'cltbld', 15:14:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441', 15:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:14:34 INFO - '_': '/tools/buildbot/bin/python'} 15:14:34 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/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 15:14:34 INFO - mozversion application_buildid: 20170808210644 15:14:34 INFO - mozversion application_changeset: be392d4638052977f11e3fdd7fe6aac78057351c 15:14:34 INFO - mozversion application_display_name: Nightly 15:14:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:14:34 INFO - mozversion application_name: Firefox 15:14:34 INFO - mozversion application_remotingname: firefox 15:14:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:14:34 INFO - mozversion application_vendor: Mozilla 15:14:34 INFO - mozversion application_version: 57.0a1 15:14:34 INFO - mozversion platform_buildid: 20170808210644 15:14:34 INFO - mozversion platform_changeset: be392d4638052977f11e3fdd7fe6aac78057351c 15:14:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:14:34 INFO - mozversion platform_version: 57.0a1 15:14:34 INFO - using testdate: 1502230474 15:14:34 INFO - actual date: 1502230474 15:14:34 INFO - starting webserver on 'localhost:38599' 15:14:34 INFO - SUITE-START | Running 2 tests 15:14:34 INFO - TEST-START | dromaeo_css 15:14:34 INFO - Initialising browser for dromaeo_css test... 15:14:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38599/getInfo.html -profile /tmp/tmpp4cQ_x/profile 15:14:34 INFO - TEST-INFO | started process 3137 (/builds/slave/test/build/application/firefox/firefox http://localhost:38599/getInfo.html) 15:14:40 INFO - TEST-INFO | 3137: exit 0 15:14:40 INFO - Browser initialized. 15:14:40 INFO - Running cycle 1/1 for dromaeo_css test... 15:14:40 INFO - TEST-INFO | started process 3352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp4cQ_x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:14:41 INFO - PID 3352 | 15:14:41 INFO - PID 3352 | (/builds/slave/test/build/application/firefox/firefox:3401): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:14:41 INFO - PID 3352 | 15:14:51 INFO - PID 3352 | RSS: Main: 161406976 15:14:51 INFO - PID 3352 | 15:17:50 INFO - PID 3352 | Cycle 1(1): loaded http://localhost:38599/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38599/tests/dromaeo/cssquery-ext.html) 15:17:51 INFO - PID 3352 | RSS: Main: 167002112 15:17:51 INFO - PID 3352 | 15:20:53 INFO - PID 3352 | Cycle 1(1): loaded http://localhost:38599/tests/dromaeo/cssquery-ext.html (next: http://localhost:38599/tests/dromaeo/cssquery-jquery.html) 15:20:54 INFO - PID 3352 | RSS: Main: 164835328 15:20:54 INFO - PID 3352 | 15:23:55 INFO - PID 3352 | Cycle 1(1): loaded http://localhost:38599/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38599/tests/dromaeo/cssquery-mootools.html) 15:23:56 INFO - PID 3352 | RSS: Main: 165724160 15:23:56 INFO - PID 3352 | 15:26:57 INFO - PID 3352 | Cycle 1(1): loaded http://localhost:38599/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38599/tests/dromaeo/cssquery-prototype.html) 15:26:58 INFO - PID 3352 | RSS: Main: 164143104 15:26:58 INFO - PID 3352 | 15:30:02 INFO - PID 3352 | Cycle 1(1): loaded http://localhost:38599/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38599/tests/dromaeo/cssquery-yui.html) 15:30:02 INFO - PID 3352 | RSS: Main: 167706624 15:30:02 INFO - PID 3352 | 15:33:04 INFO - PID 3352 | Cycle 1(1): loaded http://localhost:38599/tests/dromaeo/cssquery-yui.html (next: http://localhost:38599/tests/dromaeo/cssquery-dojo.html) 15:33:04 INFO - PID 3352 | RSS: Main: 168857600 15:33:04 INFO - PID 3352 | 15:33:04 INFO - PID 3352 | __start_tp_report 15:33:04 INFO - PID 3352 | _x_x_mozilla_page_load 15:33:04 INFO - PID 3352 | _x_x_mozilla_page_load_details 15:33:04 INFO - PID 3352 | |i|pagename|runs| 15:33:04 INFO - PID 3352 | |0;dojo.html;3367.6969072783445;3462.0652423845577;3473.565804274466;3510.2979404119174;3536.6109727929925;6230.5327100467475;6230.999999999989;6244.843878903024;6361.618302901829;6413.326600706917;6185.1650027246305;6251.312355640887;6266.060090986354;6266.62400255985;6315.799998000388;5454.7818087276655;5482.424345443731;5487.917681234785;5499.422560631137;5584.804531841386;5574.442555744434;5577.972110139464;5600.27196464459;5619.7471113799775;5662.462066103713;5466.098093814516;5525.392206857243;5541.501264886179;5546.722663866791;5554.888902221953;5387.299651045379;5453.563714902798;5480.342358916916;5494.780208791643;5561.4716601922755;5414.40441551429;5439.728013599304;5485.314335708036;5497.367802702701;5497.8075767347955;6173.567850250484;6213.875722485525;6238.781642642486;6263.686815659199;6273.215848018997;6667.366600172976;6781.11845460092;6781.355771201728;6806.523543351967;6837.418819400307;6782.626955517445;6835.14560679915;6845.281245469254;6852.314768523158;6885.001674757183;6241.313455519889;6241.407066328691;6335.11308416822;6388.137601423841;6398.264199617057;6685.532012759158;6769.559978601375;6812.420944219797;6900.03399524067;7080.610566418896;6682.198136223684;6694.430973367318;6748.4938629602975;6765.255821859591;6773.153355830521;6792.626405547742;6814.011968264574;6848.178218613699;6852.965735171292;6899;6514.837129071811;6596.175478065242;6786.524943254023;6851.657417129223;6860.965695171492;6559.114519539897;6612.140421745238;6631.204255489276;6783.287754785775;6853.314668533107;4900.828471003569;4900.926486102711;4908.214685650279;4917.950820491749;4966.776495057731;4321.373400856858;4364.41080454141;4372.950491881926;4390.209762242827;4416.779161041999;6338.58799178052;6342.809715708444;6369.299377068519;6372.936270637327;6405.775797847146;6702.664866756642;6711.597304161766;6723.865522689616;6772.5936443813525;6786.219584747817;6300.59046161998;6310.7791227306825;6359.872802543923;6387.265464471645;6428.292887782341;5386.542143917733;5514.751836167382;5526.115821468546;5531.751071201806;5533.391326954032;7096.92903070973;7188.5327453715345;7220.638968051577;7236.095488063992;7237.203907570163;6701.6314102723845;6783.59298442095;6815.216250131299;6853.760118395832;6910.170779506491;7043.190033146254;7077.398421134261;7121.928780712334;7158.749443769443;7220.3862671671395;6757.797266082025;6781.050652908498;6808.114945057111;6813.863722725617;6815.659217039228;6892.551984121016;6905.136857892763;6908.378245957888;6937.618430986142;6959.338862808025;6660.100886380276;6661;6732.427743641845;6748.763793267212;6756.087928129836;6481.708323125376;6528.347165283433;6609.405153536205;6660.200775906922;6741.359570840762;6691.631960242234;6703.66481675924;6706.094677218513;6715.429188518835;6729.427998620172;6708.698108585223;6709.161354830646;6735.797926062226;6737.056812046416;6770.119884414995;6420.871582568416;6480.675966201577;6540.542162048611;6623.138991931018;6633.336666333328 15:33:04 INFO - PID 3352 | |1;ext.html;873.1957299554103;906.9138431848972;936.2463217110226;958.5925981457879;960.716588606361;41993.58006419935;42634;42712.572874271245;42829.57170428295;42913.78543107284;38790.8060459698;38982;39199;39522.40716389257;39522.60477395233;6803.183617965827;6864.313568643146;6868.759593414232;6908.620025898574;6933.4106600938985;6650.700718467657;6682.398584127428;6718.563293385939;6730;6787.457003439713;6765.526413151081;7345.265473452639;7519.774406767806;7534.886976695327;7546.660400282;7414.147373052114;7414.332710056121;7423.406127509813;7424.146223184295;7463.3283004529585;7143;7145.499815012951;7244.8551028979655;7286;7349.853002939912;38865;39277.41083883744;39438;39595.80202099;39811.20377592432;3425.4348032574844;3471.375152472554;3473.9652603473896;3476.4959080933377;3486.6513348665185;30397;30416.847915760278;30481.390372192433;30544.694553054407;30546.236344091354;4943.950560494385;4951;4963.950360496385;4964.280179374006;4975.825846095406;248900;252383;253064;255576;256859;50372.74813625982;50416.983320667496;50731.74634126806;50813.23780143301;50821.71302291406;53173;53179;53309.46690533045;53557.46442535525;53680.73159634177;15990.840091599168;16242.431514897158;16339.59151021234;16350.591235218977;16357.345706171858;13199.40602672882;13226.140300880412;13237.933810330887;13289.667758305926;13371.732565348639;14254.287285635677;14301.78547321791;14312.499062532761;14468.131912085308;14510.637234069021;5733.8566535836935;5760.913586296209;5804.968261108578;5805.477507024388;5815.098659707667;1047.1727335404944;1047.2355180718118;1082.285691443659;1083.701981954953;1091.3560999010622;24004.39989000289;24057.064296957527;29850.253743656147;30730.231744206572;30975.225619359695;1165.6036947437913;1169.8654654714646;1171.2913687219109;1176.670532250971;1180.9232399893979;12734.61796146117;13283.601491955256;13349.66625834362;13381.264030478416;17195.914020429816;265596;265915;267198;268049;270502;55517;60220;60569.394306056376;60735.08897366543;60788.39211607827;1472.34480656107;1493.9701205976037;1507.6532397548406;1509.215208091786;1521.246982743549;28967.855160724903;29381.85309073441;29804.850975744983;30031.549526757553;30839.537406939362;40180.39729404003;40223.396649049704;40264.59735402608;40299.79850100731;40562.391564125974;237909;238333;238531;238607;239211;36509.817450912575;36929.815350923076;36933.63066369302;36978;37004.81497592495;43956.12087758291;45819.77090114528;45978.31032534582;46164.53835461737;46310;33298.833505832314;33574.160645983065;33693.49459758057;33694;34207.48688769621;32653.836730816194;32728.836355818068;33091.83454082714;33103;33840.49239261364;37293;37757.4336384949;37969.24061518699;38037.619623804516;38103.80948095242;32024.839875800473;32359.676403236608;32585.511217332234;32789.67210327866;33000.66999330072;22782.633042017533;24438.266851994467;24657.137000205625;24850.627240591766;24862.254132376056 15:33:04 INFO - PID 3352 | |2;jquery.html;577.9393163717809;580.4630716587155;580.5558747558116;586.1998372221916;596.5823923253722;22371;23024.309270721864;23233.070677172913;23253.302400927958;23338.64992025121;25201.87399063002;27452.313692157706;27513;27566.724332756665;27813.304667383327;6163.291221509517;6318.589291696025;6318.84202894929;6321.209848768904;6323.367663233686;5965.22452081231;6153.138560601519;6231.844203894893;6246.750129994817;6302.653354065525;6180.81457556274;6182.319944806068;6186.536009799283;6190.164327815754;6277.968610156943;6141.324454310023;6180.72186751595;6182.969085154568;6184.041473571604;6199.845003874917;5768;5777.942220577783;5779.1620215069;5782;5788.507976821975;30560.54159187614;31345.686543134503;31442.37115257705;31737;31970.680293197;2086.2176683743596;2122.5967066257363;2129.350548082834;2142.8500004999655;2143.024923659731;20147.294844680513;20739.377818665464;20774.896125519277;20782.376528704164;20809;2364.0780095762666;2370.3955491349766;2389.924533959725;2422.9515409691885;2487.3035550046015;151050;156606;157742;157926.21036894858;159047;14872.851271487363;15940.202989850693;16146.838531614769;16254.349826006828;16310.75533866993;23711.762882371302;24806.5116093035;24834.875825620755;24919.875400623245;25018.874905625355;10756.408397538211;10770.838437423445;10886.67339979802;10977.506012229469;11114.166437517057;9941.65204217849;10037.498125093716;10117.848232276521;10178.949105254575;10258.846117308247;9663.226941844636;9919.950400247953;10094.49527523621;10202.183825293958;10285.588576456857;2847.1031625038045;2863.541833306661;2885.29310318969;2885.379643376642;2898.420315936821;1034.6689059500889;1051.3008849115254;1054;1062.2298833345762;1064.6486659402378;20929.26747563828;21066.368008959755;21651.458713532287;21682.024308906137;21775.020124094455;1104.1663544024211;1129.2829053551054;1130.5364800431782;1134.625573560723;1141.2923987128033;11572.322013308023;12198.634040978784;12284;12285.262884226975;12287.631371058882;593128;593825;598392;599635;612032;120963;121731.39134304272;121751.39124304322;122612;125879.37060314823;1218.3542722357165;1235.5366737473448;1263.589333466627;1266.9936650316874;1278.2905487454366;19436.514087147934;19771.70342444836;19840.305589304306;19864.801351986294;20274.493137671678;49314.506854930994;55912;59524;61017.694911525155;62924;73958.63020684863;75290;75297.24702752903;75354.62322688571;77756.22243777716;15012.699746005237;15287.235638218268;15350.462733804263;15366.615834603777;15484.225788710744;24243.878780605985;24389.14637987662;24408.75591244136;24448.266552003468;24623.753762462864;19536.21855125779;19818.51361147891;20051.29820456277;20223.79776202278;20303.4924126898;17474.12629368552;17674.734878976567;17769.46691599254;17925.19336629829;17930.462086137435;20183.69724454105;20392.96070392949;20425.69361459609;20445.18219271272;20545;14967.32647030908;15298.77051844201;15306.464273750365;15325.540233793005;15374.308156133224;19796.703049453983;19956.50108747293;20008.49978750543;20008.59982800365;20168 15:33:04 INFO - PID 3352 | |3;mootools.html;1417.8865690744742;1449.137763030997;1491.5749011531716;1503.9097654140753;1510.675204830961;14642.414303427864;15056.397744090224;15157;15200.315985780639;15257.38970441181;15559.066456012619;15642;15757.290921908512;15800.288986995583;15822.208889555533;2694.043614516848;2746.5605503119505;2753.1465245773775;2756.738109879558;2758.7655049320833;2462.212092130519;2567.884445199961;2620.3842097107163;2684.3691732442862;2746.217328061503;2649.2052384284734;2671.318813702503;2679.825811322268;2681.302861256068;2681.6513853199153;2513.2711513661106;2534.8479091254585;2556.156468365444;2559.9744002560014;2561.385267535778;2559.744025597444;2575.25317657879;2596.6883973923063;2597.5194589000907;2599.4671092426197;14799.630009249855;15140.242987850563;15169.24153792306;15198.316075776616;15199.240037998055;7604.2395760423515;7874.228298632762;7880.408969327266;7882.935803666489;7919.128895821455;4815.036992601494;4945.629077819178;4953.554180123806;5009.724465154415;5035.59715222785;1913.2825190553542;1923.5960448305873;1924.8845069295746;1937.060525645061;1980.4949737816908;26012.34969125787;26165.345866353302;26188.345291367677;26422.6036609451;26474.73525264742;6697.095892054608;6797.422219111431;6896.793096207121;7005.194402643761;7038.894416583756;17495.737563936553;18316.358927437475;18374.265029398943;18417;18418;7837.960810195913;8002.839943201104;8013.2387423194705;8018.398620103516;8024.679012839538;7177.7487787927175;7298.306660867315;7325.7802265932105;7335.789594716919;7340.486165968331;5344.225087362311;5465.562754979592;5470.124780035255;5487.533559647474;5633.915491267634;1517.3854588891516;1529.296523599157;1529.908205507673;1538.9461368852037;1540.306861912144;947.677789551542;952.9190018848476;964.8600952861796;966.9661561845302;980.1081016275298;8024.117347091816;8043.718469853527;8084.83830323402;8170.632321545545;8224.177582241728;748.3227678950558;751.7030772844696;770.9460337776302;1033.9224558158169;1042.3120740311358;6091.969540152271;6264.655443950535;6269.843253918597;6300.432961033529;6470.870582588322;22360.664590031163;22446.214382496535;22504;22663.773362266496;22877.88561057184;21778.455538611663;21798.128074877146;22499.212527561456;22533.4366640832;22582.435439114153;11967;12019.278843269432;12025.218360806519;12040.458179381949;12167.939160304319;8680.82638347217;9224.492652904155;9371.531423428665;9374.062593740571;9393.154616084585;18399.448016559523;18784.906075469535;18957.810421895603;19471.123799428777;19649.90175049173;18845.24619015224;19133.139008744918;19226.134823932676;19257.903710481358;19316.903415482833;12277;12424.627261182179;12503.312317822607;12561.309127998047;12708.745825083632;14039.227842468763;14119.152850828983;14195;14195.793357564722;14198.574042778733;11458.369789661649;11528.9623933843;11658;11831.11266654987;12041.157119001586;11231.831522527333;11343.546258149581;11349.716257093638;11472.254303470248;11652.067834573045;10253.538590763583;10313;10341.482925853526;10374.17006639452;10388.636397726043;7698.114716807415;7810.648520816463;7901.130875603794;7937.682492700458;7999.720009799629;7853.489523180975;7993.920060799318;8026.879596805936;8092.150324215872;8098.676052957816 15:33:04 INFO - PID 3352 | |4;prototype.html;492.3304306143643;510.2779566912819;533.5544820075237;545.6044367833321;550.9559235261177;5994.602159136348;6061.515078793697;6095.817125486237;6189.473894718949;6192.287886893008;5953.333066741319;6017.976943919533;6023.2169817923605;6041.365656606059;6070.878582428349;4761.738104404265;4778.4265888093305;4825.517448255164;4827.744786355555;4839.830605928793;4718.740469274188;4780.689255198401;4844.442889067749;4852.738288045099;4894.388201474816;4806.3030860525205;4830.951690483085;4850.466448690659;4857.854264372075;4871.244957031666;4728.503507131753;4729.314249433813;4784.40194975628;4814.566688998007;4816.109019831325;4353.62994145498;4372.40972468719;4394.318880573516;4398.152775834157;4405.163019026407;6063.484603808637;6069.393060693896;6071.1803906472505;6082.665453400061;6117.3695311016245;5629.634073785191;5671.7731290748325;5735.770569177228;5745.597808153431;5797.4782269595935;6511.576747511444;6531.902021469682;6540.93459065408;6555.180602424697;6624.542600627854;4929.605631549467;4930.506949305077;4931.728754918478;4932.383452068491;4975.328330675348;6712.597244165366;6761.8647627047185;6840.521163518556;6925.896111558331;6938.653067346663;5108.259302401131;5109.182530795055;5119.180931051088;5120.948790512047;5133.922991155136;5111.565516931102;5208.739563021833;5223.973880130575;5240.423553409122;5253.4221235664045;5670.5180059695385;5679.659220446786;5694.572907031989;5694.715264236772;5721.284839395075;6480.967595162088;6506.284308726036;6513.478921686254;6558.737650493927;6598.208215014133;1709.2223038517693;1714.391391056157;1748.7726595542752;1787.0796539782023;1788.3293764838186;1249.6813312605227;1256.8114782782473;1261.1928365845865;1280.6990357266036;1285.318781046047;6118;6169.96915015431;6192.792405480888;6215.844603884939;6221.253449586078;6515.4787616990525;6598.406143447113;6610.107635469246;6690.524505932836;6743.865122697519;6287.528435367274;6297.685115744194;6304.527160462983;6316.463100636405;6355.491560675227;3452.6202117767025;3516.9648303516637;3528.712020112692;3553.9466907996402;3573.5354403927845;6987.1266091738535;7032.3783251625455;7062.4703147263135;7070.257622949619;7102.289771022856;6801.285864984205;6857.759978400832;6895;6956;6980.650967451607;6921.8961715575315;6929.688164032631;6995.510314278054;7022.613756243456;7090.256891917564;6667.599944003376;6676.165479315086;6691.453529629304;6806.897896531655;6826.726930922708;6641.468682505485;6644.700988455627;6678.499112566674;6733.69698363565;6748.797536073926;6986.161660600557;7010.123734533184;7034.155901291878;7063.823404414725;7084.787456376317;5025.497450254945;5082.669626474268;5089.26205700164;5095.700596347908;5099.92350114756;6716.764913228014;6720.630365329954;6744.393004629411;6756.121704178426;6852.246252912076;6529.67351632426;6537.411632953057;6591.802245932629;6643;6662.267150613332;6263;6383.648899310582;6466.547341686037;6521.608703477807;6532.314107018885;6219;6245.6252624842655;6407.917426836204;6408.198975128109;6513.7068831903625;6396.936030639634;6475.1582294303325;6478.0524861187105;6479.736451391933;6483.222013358427;6361.395667411589;6378.872422551616;6384.648844313608;6400.39196276353;6431.807045788634 15:33:04 INFO - PID 3352 | |5;yui.html;924.6763632728546;930.9115634014767;942.7501712046304;949.4255975135043;953.3136141977776;17952.46142615722;18633.813661863376;18712.62574748506;18762.530936726573;22111.778882211172;19148.268597696115;19193.712094318595;19756.901215493937;19769.703454448158;20010.399688009347;947.4552132523809;1025.825609646358;1026.8716410448694;1027.219313321877;1027.830407982682;1045.9644951498;1047.0262655730169;1048.6696690542492;1049.2235745548278;1053.2679787547656;1015.7003683913264;1047.7066421401983;1057.196530636714;1077.3320541264427;1084.1922767538194;1034.3845411979898;1037.4190453346112;1044.7962647283782;1045.5974449836792;1048.072455876547;775.4649291988567;778.9610519474061;782.8003859015971;784.5214419204281;784.8469548438056;17936.372226971995;18539.81460185408;19886.105125269398;20155.798442015537;20191.19235230589;21746.673799893015;21899.562008759895;22165.556688866294;22165.889170554045;22505.437364065867;16502.17489125539;16690.165491725365;16787;16915.323387064625;16973.57566060846;3449.3618680544178;3453.1194545390763;3507.7895326280504;3508.578970523528;3508.719302455823;145913;146186;146821;146961.26519367335;151297;15150.924245378703;15393.769093463607;15552;15611;15629.3748250071;26597.248939497607;26823.597646035327;26901;26927.192184234504;26992.460150797266;8822.86765698515;8907.331950103768;8918.241949434241;8931.285497160212;9030.909690903138;4236.894077648022;4366;4379.978100109479;4381.84663536781;4384.758838263926;5212.635115541952;5275.155975044051;6126.846828829315;6342.302346741854;6390.648514331663;1174.7885380631396;1215.5380955236953;1215.8601760797621;1220.9816852747038;1226.8466441694789;696.0811728518408;708.5394493579112;712.7077898061873;724.3734169942961;731.5427857589007;11590.594329198437;11671.183017188885;12950;13034.152780069455;13357.799633005512;678.1556961582861;691.837418206721;702.553878287281;707.1620130145793;711.861187068527;5850.5904586678525;5961.403859614091;6250.812475625738;6563.343665633399;6898.758543450955;124819.37590312172;127997;129355;130470;131281;111246.44376778064;113939.43030284795;114356.42821785838;116329.41835290939;117623;95686;97392;100182.49726254257;100608;103177;11899.702507437038;12035.338056406981;12205.084618653815;12229.633111006684;12820.23078615286;43469;44279.77860110679;44355;44632.33051504295;45747.54252457433;78129;78136.21863781517;79544.60227698824;80560;82078;17516.91241543835;17601.64796704033;17651.205695743465;17927;18032.90983545074;18786.436406907815;21209.7879021214;21685.891570542048;21807.672884907057;21962.670559941293;20009.299674511323;20266.392008239778;20403.183872644928;20521.794782051988;20632.58734825265;18333.54166145857;18515.444536663923;18620.627587448445;18801.05994700287;18812.52968675794;19415.708764368264;19899;19942.700859486828;19966.90016549966;20083.397498075083;9510.762230944281;9589.712308630753;9735.464549449849;10155.289129760846;10191.286609937233;14867.553973380816;15133.319000645217;15201.163935983184;15481.922590386976;15640.374385024927 15:33:04 INFO - PID 3352 | __end_tp_report 15:33:04 INFO - PID 3352 | __start_cc_report 15:33:04 INFO - PID 3352 | _x_x_mozilla_cycle_collect,330 15:33:04 INFO - PID 3352 | __end_cc_report 15:33:04 INFO - PID 3352 | __startTimestamp1502231584539__endTimestamp 15:33:04 INFO - PID 3352 | 15:33:04 INFO - PID 3352 | ------- Summary: start ------- 15:33:04 INFO - PID 3352 | Number of tests: 6 15:33:04 INFO - PID 3352 | 15:33:04 INFO - PID 3352 | [#0] dojo.html Cycles:165 Average:6242.50 Median:6596.18 stddev:823.76 (12.5%) stddev-sans-first:794.81 15:33:04 INFO - PID 3352 | Values: 3367.7 3462.1 3473.6 3510.3 3536.6 6230.5 6231.0 6244.8 6361.6 6413.3 6185.2 6251.3 6266.1 6266.6 6315.8 5454.8 5482.4 5487.9 5499.4 5584.8 5574.4 5578.0 5600.3 5619.7 5662.5 5466.1 5525.4 5541.5 5546.7 5554.9 5387.3 5453.6 5480.3 5494.8 5561.5 5414.4 5439.7 5485.3 5497.4 5497.8 6173.6 6213.9 6238.8 6263.7 6273.2 6667.4 6781.1 6781.4 6806.5 6837.4 6782.6 6835.1 6845.3 6852.3 6885.0 6241.3 6241.4 6335.1 6388.1 6398.3 6685.5 6769.6 6812.4 6900.0 7080.6 6682.2 6694.4 6748.5 6765.3 6773.2 6792.6 6814.0 6848.2 6853.0 6899.0 6514.8 6596.2 6786.5 6851.7 6861.0 6559.1 6612.1 6631.2 6783.3 6853.3 4900.8 4900.9 4908.2 4918.0 4966.8 4321.4 4364.4 4373.0 4390.2 4416.8 6338.6 6342.8 6369.3 6372.9 6405.8 6702.7 6711.6 6723.9 6772.6 6786.2 6300.6 6310.8 6359.9 6387.3 6428.3 5386.5 5514.8 5526.1 5531.8 5533.4 7096.9 7188.5 7220.6 7236.1 7237.2 6701.6 6783.6 6815.2 6853.8 6910.2 7043.2 7077.4 7121.9 7158.7 7220.4 6757.8 6781.1 6808.1 6813.9 6815.7 6892.6 6905.1 6908.4 6937.6 6959.3 6660.1 6661.0 6732.4 6748.8 6756.1 6481.7 6528.3 6609.4 6660.2 6741.4 6691.6 6703.7 6706.1 6715.4 6729.4 6708.7 6709.2 6735.8 6737.1 6770.1 6420.9 6480.7 6540.5 6623.1 6633.3 15:33:04 INFO - PID 3352 | 15:33:04 INFO - PID 3352 | [#1] ext.html Cycles:180 Average:42471.81 Median:36719.82 stddev:65951.92 (179.6%) stddev-sans-first:66062.97 15:33:04 INFO - PID 3352 | Values: 873.2 906.9 936.2 958.6 960.7 41993.6 42634.0 42712.6 42829.6 42913.8 38790.8 38982.0 39199.0 39522.4 39522.6 6803.2 6864.3 6868.8 6908.6 6933.4 6650.7 6682.4 6718.6 6730.0 6787.5 6765.5 7345.3 7519.8 7534.9 7546.7 7414.1 7414.3 7423.4 7424.1 7463.3 7143.0 7145.5 7244.9 7286.0 7349.9 38865.0 39277.4 39438.0 39595.8 39811.2 3425.4 3471.4 3474.0 3476.5 3486.7 30397.0 30416.8 30481.4 30544.7 30546.2 4944.0 4951.0 4964.0 4964.3 4975.8 248900.0 252383.0 253064.0 255576.0 256859.0 50372.7 50417.0 50731.7 50813.2 50821.7 53173.0 53179.0 53309.5 53557.5 53680.7 15990.8 16242.4 16339.6 16350.6 16357.3 13199.4 13226.1 13237.9 13289.7 13371.7 14254.3 14301.8 14312.5 14468.1 14510.6 5733.9 5760.9 5805.0 5805.5 5815.1 1047.2 1047.2 1082.3 1083.7 1091.4 24004.4 24057.1 29850.3 30730.2 30975.2 1165.6 1169.9 1171.3 1176.7 1180.9 12734.6 13283.6 13349.7 13381.3 17195.9 265596.0 265915.0 267198.0 268049.0 270502.0 55517.0 60220.0 60569.4 60735.1 60788.4 1472.3 1494.0 1507.7 1509.2 1521.2 28967.9 29381.9 29804.9 30031.5 30839.5 40180.4 40223.4 40264.6 40299.8 40562.4 237909.0 238333.0 238531.0 238607.0 239211.0 36509.8 36929.8 36933.6 36978.0 37004.8 43956.1 45819.8 45978.3 46164.5 46310.0 33298.8 33574.2 33693.5 33694.0 34207.5 32653.8 32728.8 33091.8 33103.0 33840.5 37293.0 37757.4 37969.2 38037.6 38103.8 32024.8 32359.7 32585.5 32789.7 33000.7 22782.6 24438.3 24657.1 24850.6 24862.3 15:33:04 INFO - PID 3352 | 15:33:04 INFO - PID 3352 | [#2] jquery.html Cycles:180 Average:39280.51 Median:2125.97 stddev:100284.07 (4717.1%) stddev-sans-first:100523.29 15:33:04 INFO - PID 3352 | Values: 577.9 580.5 580.6 586.2 596.6 22371.0 23024.3 23233.1 23253.3 23338.6 25201.9 27452.3 27513.0 27566.7 27813.3 6163.3 6318.6 6318.8 6321.2 6323.4 5965.2 6153.1 6231.8 6246.8 6302.7 6180.8 6182.3 6186.5 6190.2 6278.0 6141.3 6180.7 6183.0 6184.0 6199.8 5768.0 5777.9 5779.2 5782.0 5788.5 30560.5 31345.7 31442.4 31737.0 31970.7 2086.2 2122.6 2129.4 2142.9 2143.0 20147.3 20739.4 20774.9 20782.4 20809.0 2364.1 2370.4 2389.9 2423.0 2487.3 151050.0 156606.0 157742.0 157926.2 159047.0 14872.9 15940.2 16146.8 16254.3 16310.8 23711.8 24806.5 24834.9 24919.9 25018.9 10756.4 10770.8 10886.7 10977.5 11114.2 9941.7 10037.5 10117.8 10178.9 10258.8 9663.2 9920.0 10094.5 10202.2 10285.6 2847.1 2863.5 2885.3 2885.4 2898.4 1034.7 1051.3 1054.0 1062.2 1064.6 20929.3 21066.4 21651.5 21682.0 21775.0 1104.2 1129.3 1130.5 1134.6 1141.3 11572.3 12198.6 12284.0 12285.3 12287.6 593128.0 593825.0 598392.0 599635.0 612032.0 120963.0 121731.4 121751.4 122612.0 125879.4 1218.4 1235.5 1263.6 1267.0 1278.3 19436.5 19771.7 19840.3 19864.8 20274.5 49314.5 55912.0 59524.0 61017.7 62924.0 73958.6 75290.0 75297.2 75354.6 77756.2 15012.7 15287.2 15350.5 15366.6 15484.2 24243.9 24389.1 24408.8 24448.3 24623.8 19536.2 19818.5 20051.3 20223.8 20303.5 17474.1 17674.7 17769.5 17925.2 17930.5 20183.7 20393.0 20425.7 20445.2 20545.0 14967.3 15298.8 15306.5 15325.5 15374.3 19796.7 19956.5 20008.5 20008.6 20168.0 15:33:04 INFO - PID 3352 | 15:33:04 INFO - PID 3352 | [#3] mootools.html Cycles:180 Average:9592.57 Median:2557.95 stddev:6811.69 (266.3%) stddev-sans-first:6803.10 15:33:04 INFO - PID 3352 | Values: 1417.9 1449.1 1491.6 1503.9 1510.7 14642.4 15056.4 15157.0 15200.3 15257.4 15559.1 15642.0 15757.3 15800.3 15822.2 2694.0 2746.6 2753.1 2756.7 2758.8 2462.2 2567.9 2620.4 2684.4 2746.2 2649.2 2671.3 2679.8 2681.3 2681.7 2513.3 2534.8 2556.2 2560.0 2561.4 2559.7 2575.3 2596.7 2597.5 2599.5 14799.6 15140.2 15169.2 15198.3 15199.2 7604.2 7874.2 7880.4 7882.9 7919.1 4815.0 4945.6 4953.6 5009.7 5035.6 1913.3 1923.6 1924.9 1937.1 1980.5 26012.3 26165.3 26188.3 26422.6 26474.7 6697.1 6797.4 6896.8 7005.2 7038.9 17495.7 18316.4 18374.3 18417.0 18418.0 7838.0 8002.8 8013.2 8018.4 8024.7 7177.7 7298.3 7325.8 7335.8 7340.5 5344.2 5465.6 5470.1 5487.5 5633.9 1517.4 1529.3 1529.9 1538.9 1540.3 947.7 952.9 964.9 967.0 980.1 8024.1 8043.7 8084.8 8170.6 8224.2 748.3 751.7 770.9 1033.9 1042.3 6092.0 6264.7 6269.8 6300.4 6470.9 22360.7 22446.2 22504.0 22663.8 22877.9 21778.5 21798.1 22499.2 22533.4 22582.4 11967.0 12019.3 12025.2 12040.5 12167.9 8680.8 9224.5 9371.5 9374.1 9393.2 18399.4 18784.9 18957.8 19471.1 19649.9 18845.2 19133.1 19226.1 19257.9 19316.9 12277.0 12424.6 12503.3 12561.3 12708.7 14039.2 14119.2 14195.0 14195.8 14198.6 11458.4 11529.0 11658.0 11831.1 12041.2 11231.8 11343.5 11349.7 11472.3 11652.1 10253.5 10313.0 10341.5 10374.2 10388.6 7698.1 7810.6 7901.1 7937.7 7999.7 7853.5 7993.9 8026.9 8092.2 8098.7 15:33:04 INFO - PID 3352 | 15:33:04 INFO - PID 3352 | [#4] prototype.html Cycles:180 Average:5558.39 Median:6190.88 stddev:1584.45 (25.6%) stddev-sans-first:1542.59 15:33:04 INFO - PID 3352 | Values: 492.3 510.3 533.6 545.6 551.0 5994.6 6061.5 6095.8 6189.5 6192.3 5953.3 6018.0 6023.2 6041.4 6070.9 4761.7 4778.4 4825.5 4827.7 4839.8 4718.7 4780.7 4844.4 4852.7 4894.4 4806.3 4831.0 4850.5 4857.9 4871.2 4728.5 4729.3 4784.4 4814.6 4816.1 4353.6 4372.4 4394.3 4398.2 4405.2 6063.5 6069.4 6071.2 6082.7 6117.4 5629.6 5671.8 5735.8 5745.6 5797.5 6511.6 6531.9 6540.9 6555.2 6624.5 4929.6 4930.5 4931.7 4932.4 4975.3 6712.6 6761.9 6840.5 6925.9 6938.7 5108.3 5109.2 5119.2 5120.9 5133.9 5111.6 5208.7 5224.0 5240.4 5253.4 5670.5 5679.7 5694.6 5694.7 5721.3 6481.0 6506.3 6513.5 6558.7 6598.2 1709.2 1714.4 1748.8 1787.1 1788.3 1249.7 1256.8 1261.2 1280.7 1285.3 6118.0 6170.0 6192.8 6215.8 6221.3 6515.5 6598.4 6610.1 6690.5 6743.9 6287.5 6297.7 6304.5 6316.5 6355.5 3452.6 3517.0 3528.7 3553.9 3573.5 6987.1 7032.4 7062.5 7070.3 7102.3 6801.3 6857.8 6895.0 6956.0 6980.7 6921.9 6929.7 6995.5 7022.6 7090.3 6667.6 6676.2 6691.5 6806.9 6826.7 6641.5 6644.7 6678.5 6733.7 6748.8 6986.2 7010.1 7034.2 7063.8 7084.8 5025.5 5082.7 5089.3 5095.7 5099.9 6716.8 6720.6 6744.4 6756.1 6852.2 6529.7 6537.4 6591.8 6643.0 6662.3 6263.0 6383.6 6466.5 6521.6 6532.3 6219.0 6245.6 6407.9 6408.2 6513.7 6396.9 6475.2 6478.1 6479.7 6483.2 6361.4 6378.9 6384.6 6400.4 6431.8 15:33:04 INFO - PID 3352 | 15:33:04 INFO - PID 3352 | [#5] yui.html Cycles:180 Average:26078.61 Median:19827.90 stddev:37684.11 (190.1%) stddev-sans-first:37742.49 15:33:04 INFO - PID 3352 | Values: 924.7 930.9 942.8 949.4 953.3 17952.5 18633.8 18712.6 18762.5 22111.8 19148.3 19193.7 19756.9 19769.7 20010.4 947.5 1025.8 1026.9 1027.2 1027.8 1046.0 1047.0 1048.7 1049.2 1053.3 1015.7 1047.7 1057.2 1077.3 1084.2 1034.4 1037.4 1044.8 1045.6 1048.1 775.5 779.0 782.8 784.5 784.8 17936.4 18539.8 19886.1 20155.8 20191.2 21746.7 21899.6 22165.6 22165.9 22505.4 16502.2 16690.2 16787.0 16915.3 16973.6 3449.4 3453.1 3507.8 3508.6 3508.7 145913.0 146186.0 146821.0 146961.3 151297.0 15150.9 15393.8 15552.0 15611.0 15629.4 26597.2 26823.6 26901.0 26927.2 26992.5 8822.9 8907.3 8918.2 8931.3 9030.9 4236.9 4366.0 4380.0 4381.8 4384.8 5212.6 5275.2 6126.8 6342.3 6390.6 1174.8 1215.5 1215.9 1221.0 1226.8 696.1 708.5 712.7 724.4 731.5 11590.6 11671.2 12950.0 13034.2 13357.8 678.2 691.8 702.6 707.2 711.9 5850.6 5961.4 6250.8 6563.3 6898.8 124819.4 127997.0 129355.0 130470.0 131281.0 111246.4 113939.4 114356.4 116329.4 117623.0 95686.0 97392.0 100182.5 100608.0 103177.0 11899.7 12035.3 12205.1 12229.6 12820.2 43469.0 44279.8 44355.0 44632.3 45747.5 78129.0 78136.2 79544.6 80560.0 82078.0 17516.9 17601.6 17651.2 17927.0 18032.9 18786.4 21209.8 21685.9 21807.7 21962.7 20009.3 20266.4 20403.2 20521.8 20632.6 18333.5 18515.4 18620.6 18801.1 18812.5 19415.7 19899.0 19942.7 19966.9 20083.4 9510.8 9589.7 9735.5 10155.3 10191.3 14867.6 15133.3 15201.2 15481.9 15640.4 15:33:04 INFO - PID 3352 | -------- Summary: end -------- 15:33:04 INFO - PID 3352 | 15:33:05 INFO - TEST-INFO | 3352: exit 0 15:33:05 INFO - TEST-OK | dromaeo_css | took 1110323ms 15:33:05 INFO - TEST-START | kraken 15:33:05 INFO - Initialising browser for kraken test... 15:33:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38599/getInfo.html -profile /tmp/tmpgOKyuF/profile 15:33:05 INFO - TEST-INFO | started process 3725 (/builds/slave/test/build/application/firefox/firefox http://localhost:38599/getInfo.html) 15:33:10 INFO - TEST-INFO | 3725: exit 0 15:33:10 INFO - Browser initialized. 15:33:10 INFO - Running cycle 1/1 for kraken test... 15:33:10 INFO - TEST-INFO | started process 3933 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgOKyuF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 15:33:11 INFO - PID 3933 | 15:33:11 INFO - PID 3933 | (/builds/slave/test/build/application/firefox/firefox:3981): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 15:33:11 INFO - PID 3933 | 15:33:22 INFO - PID 3933 | RSS: Main: 161370112 15:33:22 INFO - PID 3933 | 15:33:24 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38599/tests/kraken/driver.html?testName=audio-beat-detection) 15:33:25 INFO - PID 3933 | RSS: Main: 166334464 15:33:25 INFO - PID 3933 | 15:33:28 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38599/tests/kraken/driver.html?testName=audio-dft) 15:33:28 INFO - PID 3933 | RSS: Main: 166670336 15:33:28 INFO - PID 3933 | 15:33:31 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38599/tests/kraken/driver.html?testName=audio-fft) 15:33:32 INFO - PID 3933 | RSS: Main: 160501760 15:33:32 INFO - PID 3933 | 15:33:34 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38599/tests/kraken/driver.html?testName=audio-oscillator) 15:33:34 INFO - PID 3933 | RSS: Main: 162242560 15:33:34 INFO - PID 3933 | 15:33:37 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38599/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:33:37 INFO - PID 3933 | RSS: Main: 162168832 15:33:37 INFO - PID 3933 | 15:33:40 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38599/tests/kraken/driver.html?testName=imaging-darkroom) 15:33:41 INFO - PID 3933 | RSS: Main: 165531648 15:33:41 INFO - PID 3933 | 15:33:44 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38599/tests/kraken/driver.html?testName=imaging-desaturate) 15:33:45 INFO - PID 3933 | RSS: Main: 166764544 15:33:45 INFO - PID 3933 | 15:33:48 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38599/tests/kraken/driver.html?testName=json-parse-financial) 15:33:48 INFO - PID 3933 | RSS: Main: 165769216 15:33:48 INFO - PID 3933 | 15:33:50 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38599/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:33:51 INFO - PID 3933 | RSS: Main: 165781504 15:33:51 INFO - PID 3933 | 15:33:52 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38599/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:33:53 INFO - PID 3933 | RSS: Main: 165560320 15:33:53 INFO - PID 3933 | 15:33:55 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38599/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:33:56 INFO - PID 3933 | RSS: Main: 166010880 15:33:56 INFO - PID 3933 | 15:33:58 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38599/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:33:59 INFO - PID 3933 | RSS: Main: 165834752 15:33:59 INFO - PID 3933 | 15:34:02 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38599/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:34:02 INFO - PID 3933 | RSS: Main: 166088704 15:34:02 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | Cycle 1(1): loaded http://localhost:38599/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38599/tests/kraken/driver.html?testName=ai-astar) 15:34:04 INFO - PID 3933 | RSS: Main: 168099840 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | __start_tp_report 15:34:04 INFO - PID 3933 | _x_x_mozilla_page_load 15:34:04 INFO - PID 3933 | _x_x_mozilla_page_load_details 15:34:04 INFO - PID 3933 | |i|pagename|runs| 15:34:04 INFO - PID 3933 | |0;ai-astar;98;106;100;108;107;111;117;101;110;109 15:34:04 INFO - PID 3933 | |1;audio-beat-detection;141;113;138;170;118;138;150;116;174;113 15:34:04 INFO - PID 3933 | |2;audio-dft;163;165;162;165;165;165;166;165;166;169 15:34:04 INFO - PID 3933 | |3;audio-fft;76;77;74;180;75;75;74;86;95;76 15:34:04 INFO - PID 3933 | |4;audio-oscillator;79;78;130;79;80;79;129;84;79;137 15:34:04 INFO - PID 3933 | |5;imaging-gaussian-blur;115;130;114;114;114;114;114;114;114;115 15:34:04 INFO - PID 3933 | |6;imaging-darkroom;149;151;149;149;159;149;148;150;148;149 15:34:04 INFO - PID 3933 | |7;imaging-desaturate;94;95;95;94;94;94;94;94;95;95 15:34:04 INFO - PID 3933 | |8;json-parse-financial;49;48;48;48;49;48;49;47;47;50 15:34:04 INFO - PID 3933 | |9;json-stringify-tinderbox;54;54;54;54;54;56;54;55;55;54 15:34:04 INFO - PID 3933 | |10;stanford-crypto-aes;83;86;76;76;74;74;73;75;75;76 15:34:04 INFO - PID 3933 | |11;stanford-crypto-ccm;125;121;119;130;115;128;118;117;127;157 15:34:04 INFO - PID 3933 | |12;stanford-crypto-pbkdf2;167;160;166;162;162;172;162;165;167;162 15:34:04 INFO - PID 3933 | |13;stanford-crypto-sha256-iterative;63;64;61;60;61;61;60;63;61;61 15:34:04 INFO - PID 3933 | __end_tp_report 15:34:04 INFO - PID 3933 | __start_cc_report 15:34:04 INFO - PID 3933 | _x_x_mozilla_cycle_collect,858 15:34:04 INFO - PID 3933 | __end_cc_report 15:34:04 INFO - PID 3933 | __startTimestamp1502231644794__endTimestamp 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | ------- Summary: start ------- 15:34:04 INFO - PID 3933 | Number of tests: 14 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#0] ai-astar Cycles:10 Average:106.70 Median:109.50 stddev:5.74 (5.2%) stddev-sans-first:5.15 15:34:04 INFO - PID 3933 | Values: 98.0 106.0 100.0 108.0 107.0 111.0 117.0 101.0 110.0 109.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:139.50 stddev:22.61 (16.2%) stddev-sans-first:23.93 15:34:04 INFO - PID 3933 | Values: 141.0 113.0 138.0 170.0 118.0 138.0 150.0 116.0 174.0 113.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:1.85 (1.1%) stddev-sans-first:1.80 15:34:04 INFO - PID 3933 | Values: 163.0 165.0 162.0 165.0 165.0 165.0 166.0 165.0 166.0 169.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#3] audio-fft Cycles:10 Average:88.80 Median:76.00 stddev:32.74 (43.1%) stddev-sans-first:34.40 15:34:04 INFO - PID 3933 | Values: 76.0 77.0 74.0 180.0 75.0 75.0 74.0 86.0 95.0 76.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:79.00 stddev:25.39 (32.1%) stddev-sans-first:26.23 15:34:04 INFO - PID 3933 | Values: 79.0 78.0 130.0 79.0 80.0 79.0 129.0 84.0 79.0 137.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:114.00 stddev:5.01 (4.4%) stddev-sans-first:5.30 15:34:04 INFO - PID 3933 | Values: 115.0 130.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 115.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:149.00 stddev:3.25 (2.2%) stddev-sans-first:3.42 15:34:04 INFO - PID 3933 | Values: 149.0 151.0 149.0 149.0 159.0 149.0 148.0 150.0 148.0 149.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 15:34:04 INFO - PID 3933 | Values: 94.0 95.0 95.0 94.0 94.0 94.0 94.0 94.0 95.0 95.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#8] json-parse-financial Cycles:10 Average:48.30 Median:48.50 stddev:0.95 (2.0%) stddev-sans-first:0.97 15:34:04 INFO - PID 3933 | Values: 49.0 48.0 48.0 48.0 49.0 48.0 49.0 47.0 47.0 50.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:54.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 15:34:04 INFO - PID 3933 | Values: 54.0 54.0 54.0 54.0 54.0 56.0 54.0 55.0 55.0 54.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.00 stddev:4.24 (5.6%) stddev-sans-first:3.86 15:34:04 INFO - PID 3933 | Values: 83.0 86.0 76.0 76.0 74.0 74.0 73.0 75.0 75.0 76.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#11] stanford-crypto-ccm Cycles:10 Average:125.70 Median:126.00 stddev:12.12 (9.6%) stddev-sans-first:12.85 15:34:04 INFO - PID 3933 | Values: 125.0 121.0 119.0 130.0 115.0 128.0 118.0 117.0 127.0 157.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:165.50 stddev:3.60 (2.2%) stddev-sans-first:3.70 15:34:04 INFO - PID 3933 | Values: 167.0 160.0 166.0 162.0 162.0 172.0 162.0 165.0 167.0 162.0 15:34:04 INFO - PID 3933 | 15:34:04 INFO - PID 3933 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.00 stddev:1.35 (2.2%) stddev-sans-first:1.32 15:34:04 INFO - PID 3933 | Values: 63.0 64.0 61.0 60.0 61.0 61.0 60.0 63.0 61.0 61.0 15:34:04 INFO - PID 3933 | -------- Summary: end -------- 15:34:04 INFO - PID 3933 | 15:34:05 INFO - PID 3933 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 15:34:05 INFO - TEST-INFO | 3933: exit 0 15:34:05 INFO - TEST-OK | kraken | took 60296ms 15:34:05 INFO - SUITE-END | took 1170s 15:34:05 INFO - Completed test suite (00:19:31) 15:34:05 INFO - javascript benchmark 15:34:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8787.655307068231, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3367.6969072783445, 3462.0652423845577, 3473.565804274466, 3510.2979404119174, 3536.6109727929925, 6230.5327100467475, 6230.999999999989, 6244.843878903024, 6361.618302901829, 6413.326600706917, 6185.1650027246305, 6251.312355640887, 6266.060090986354, 6266.62400255985, 6315.799998000388, 5454.7818087276655, 5482.424345443731, 5487.917681234785, 5499.422560631137, 5584.804531841386, 5574.442555744434, 5577.972110139464, 5600.27196464459, 5619.7471113799775, 5662.462066103713, 5466.098093814516, 5525.392206857243, 5541.501264886179, 5546.722663866791, 5554.888902221953, 5387.299651045379, 5453.563714902798, 5480.342358916916, 5494.780208791643, 5561.4716601922755, 5414.40441551429, 5439.728013599304, 5485.314335708036, 5497.367802702701, 5497.8075767347955, 6173.567850250484, 6213.875722485525, 6238.781642642486, 6263.686815659199, 6273.215848018997, 6667.366600172976, 6781.11845460092, 6781.355771201728, 6806.523543351967, 6837.418819400307, 6782.626955517445, 6835.14560679915, 6845.281245469254, 6852.314768523158, 6885.001674757183, 6241.313455519889, 6241.407066328691, 6335.11308416822, 6388.137601423841, 6398.264199617057, 6685.532012759158, 6769.559978601375, 6812.420944219797, 6900.03399524067, 7080.610566418896, 6682.198136223684, 6694.430973367318, 6748.4938629602975, 6765.255821859591, 6773.153355830521, 6792.626405547742, 6814.011968264574, 6848.178218613699, 6852.965735171292, 6899.0, 6514.837129071811, 6596.175478065242, 6786.524943254023, 6851.657417129223, 6860.965695171492, 6559.114519539897, 6612.140421745238, 6631.204255489276, 6783.287754785775, 6853.314668533107, 4900.828471003569, 4900.926486102711, 4908.214685650279, 4917.950820491749, 4966.776495057731, 4321.373400856858, 4364.41080454141, 4372.950491881926, 4390.209762242827, 4416.779161041999, 6338.58799178052, 6342.809715708444, 6369.299377068519, 6372.936270637327, 6405.775797847146, 6702.664866756642, 6711.597304161766, 6723.865522689616, 6772.5936443813525, 6786.219584747817, 6300.59046161998, 6310.7791227306825, 6359.872802543923, 6387.265464471645, 6428.292887782341, 5386.542143917733, 5514.751836167382, 5526.115821468546, 5531.751071201806, 5533.391326954032, 7096.92903070973, 7188.5327453715345, 7220.638968051577, 7236.095488063992, 7237.203907570163, 6701.6314102723845, 6783.59298442095, 6815.216250131299, 6853.760118395832, 6910.170779506491, 7043.190033146254, 7077.398421134261, 7121.928780712334, 7158.749443769443, 7220.3862671671395, 6757.797266082025, 6781.050652908498, 6808.114945057111, 6813.863722725617, 6815.659217039228, 6892.551984121016, 6905.136857892763, 6908.378245957888, 6937.618430986142, 6959.338862808025, 6660.100886380276, 6661.0, 6732.427743641845, 6748.763793267212, 6756.087928129836, 6481.708323125376, 6528.347165283433, 6609.405153536205, 6660.200775906922, 6741.359570840762, 6691.631960242234, 6703.66481675924, 6706.094677218513, 6715.429188518835, 6729.427998620172, 6708.698108585223, 6709.161354830646, 6735.797926062226, 6737.056812046416, 6770.119884414995, 6420.871582568416, 6480.675966201577, 6540.542162048611, 6623.138991931018, 6633.336666333328], "value": 6178.052730555569, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [873.1957299554103, 906.9138431848972, 936.2463217110226, 958.5925981457879, 960.716588606361, 41993.58006419935, 42634.0, 42712.572874271245, 42829.57170428295, 42913.78543107284, 38790.8060459698, 38982.0, 39199.0, 39522.40716389257, 39522.60477395233, 6803.183617965827, 6864.313568643146, 6868.759593414232, 6908.620025898574, 6933.4106600938985, 6650.700718467657, 6682.398584127428, 6718.563293385939, 6730.0, 6787.457003439713, 6765.526413151081, 7345.265473452639, 7519.774406767806, 7534.886976695327, 7546.660400282, 7414.147373052114, 7414.332710056121, 7423.406127509813, 7424.146223184295, 7463.3283004529585, 7143.0, 7145.499815012951, 7244.8551028979655, 7286.0, 7349.853002939912, 38865.0, 39277.41083883744, 39438.0, 39595.80202099, 39811.20377592432, 3425.4348032574844, 3471.375152472554, 3473.9652603473896, 3476.4959080933377, 3486.6513348665185, 30397.0, 30416.847915760278, 30481.390372192433, 30544.694553054407, 30546.236344091354, 4943.950560494385, 4951.0, 4963.950360496385, 4964.280179374006, 4975.825846095406, 248900.0, 252383.0, 253064.0, 255576.0, 256859.0, 50372.74813625982, 50416.983320667496, 50731.74634126806, 50813.23780143301, 50821.71302291406, 53173.0, 53179.0, 53309.46690533045, 53557.46442535525, 53680.73159634177, 15990.840091599168, 16242.431514897158, 16339.59151021234, 16350.591235218977, 16357.345706171858, 13199.40602672882, 13226.140300880412, 13237.933810330887, 13289.667758305926, 13371.732565348639, 14254.287285635677, 14301.78547321791, 14312.499062532761, 14468.131912085308, 14510.637234069021, 5733.8566535836935, 5760.913586296209, 5804.968261108578, 5805.477507024388, 5815.098659707667, 1047.1727335404944, 1047.2355180718118, 1082.285691443659, 1083.701981954953, 1091.3560999010622, 24004.39989000289, 24057.064296957527, 29850.253743656147, 30730.231744206572, 30975.225619359695, 1165.6036947437913, 1169.8654654714646, 1171.2913687219109, 1176.670532250971, 1180.9232399893979, 12734.61796146117, 13283.601491955256, 13349.66625834362, 13381.264030478416, 17195.914020429816, 265596.0, 265915.0, 267198.0, 268049.0, 270502.0, 55517.0, 60220.0, 60569.394306056376, 60735.08897366543, 60788.39211607827, 1472.34480656107, 1493.9701205976037, 1507.6532397548406, 1509.215208091786, 1521.246982743549, 28967.855160724903, 29381.85309073441, 29804.850975744983, 30031.549526757553, 30839.537406939362, 40180.39729404003, 40223.396649049704, 40264.59735402608, 40299.79850100731, 40562.391564125974, 237909.0, 238333.0, 238531.0, 238607.0, 239211.0, 36509.817450912575, 36929.815350923076, 36933.63066369302, 36978.0, 37004.81497592495, 43956.12087758291, 45819.77090114528, 45978.31032534582, 46164.53835461737, 46310.0, 33298.833505832314, 33574.160645983065, 33693.49459758057, 33694.0, 34207.48688769621, 32653.836730816194, 32728.836355818068, 33091.83454082714, 33103.0, 33840.49239261364, 37293.0, 37757.4336384949, 37969.24061518699, 38037.619623804516, 38103.80948095242, 32024.839875800473, 32359.676403236608, 32585.511217332234, 32789.67210327866, 33000.66999330072, 22782.633042017533, 24438.266851994467, 24657.137000205625, 24850.627240591766, 24862.254132376056], "value": 17933.191716779293, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.9393163717809, 580.4630716587155, 580.5558747558116, 586.1998372221916, 596.5823923253722, 22371.0, 23024.309270721864, 23233.070677172913, 23253.302400927958, 23338.64992025121, 25201.87399063002, 27452.313692157706, 27513.0, 27566.724332756665, 27813.304667383327, 6163.291221509517, 6318.589291696025, 6318.84202894929, 6321.209848768904, 6323.367663233686, 5965.22452081231, 6153.138560601519, 6231.844203894893, 6246.750129994817, 6302.653354065525, 6180.81457556274, 6182.319944806068, 6186.536009799283, 6190.164327815754, 6277.968610156943, 6141.324454310023, 6180.72186751595, 6182.969085154568, 6184.041473571604, 6199.845003874917, 5768.0, 5777.942220577783, 5779.1620215069, 5782.0, 5788.507976821975, 30560.54159187614, 31345.686543134503, 31442.37115257705, 31737.0, 31970.680293197, 2086.2176683743596, 2122.5967066257363, 2129.350548082834, 2142.8500004999655, 2143.024923659731, 20147.294844680513, 20739.377818665464, 20774.896125519277, 20782.376528704164, 20809.0, 2364.0780095762666, 2370.3955491349766, 2389.924533959725, 2422.9515409691885, 2487.3035550046015, 151050.0, 156606.0, 157742.0, 157926.21036894858, 159047.0, 14872.851271487363, 15940.202989850693, 16146.838531614769, 16254.349826006828, 16310.75533866993, 23711.762882371302, 24806.5116093035, 24834.875825620755, 24919.875400623245, 25018.874905625355, 10756.408397538211, 10770.838437423445, 10886.67339979802, 10977.506012229469, 11114.166437517057, 9941.65204217849, 10037.498125093716, 10117.848232276521, 10178.949105254575, 10258.846117308247, 9663.226941844636, 9919.950400247953, 10094.49527523621, 10202.183825293958, 10285.588576456857, 2847.1031625038045, 2863.541833306661, 2885.29310318969, 2885.379643376642, 2898.420315936821, 1034.6689059500889, 1051.3008849115254, 1054.0, 1062.2298833345762, 1064.6486659402378, 20929.26747563828, 21066.368008959755, 21651.458713532287, 21682.024308906137, 21775.020124094455, 1104.1663544024211, 1129.2829053551054, 1130.5364800431782, 1134.625573560723, 1141.2923987128033, 11572.322013308023, 12198.634040978784, 12284.0, 12285.262884226975, 12287.631371058882, 593128.0, 593825.0, 598392.0, 599635.0, 612032.0, 120963.0, 121731.39134304272, 121751.39124304322, 122612.0, 125879.37060314823, 1218.3542722357165, 1235.5366737473448, 1263.589333466627, 1266.9936650316874, 1278.2905487454366, 19436.514087147934, 19771.70342444836, 19840.305589304306, 19864.801351986294, 20274.493137671678, 49314.506854930994, 55912.0, 59524.0, 61017.694911525155, 62924.0, 73958.63020684863, 75290.0, 75297.24702752903, 75354.62322688571, 77756.22243777716, 15012.699746005237, 15287.235638218268, 15350.462733804263, 15366.615834603777, 15484.225788710744, 24243.878780605985, 24389.14637987662, 24408.75591244136, 24448.266552003468, 24623.753762462864, 19536.21855125779, 19818.51361147891, 20051.29820456277, 20223.79776202278, 20303.4924126898, 17474.12629368552, 17674.734878976567, 17769.46691599254, 17925.19336629829, 17930.462086137435, 20183.69724454105, 20392.96070392949, 20425.69361459609, 20445.18219271272, 20545.0, 14967.32647030908, 15298.77051844201, 15306.464273750365, 15325.540233793005, 15374.308156133224, 19796.703049453983, 19956.50108747293, 20008.49978750543, 20008.59982800365, 20168.0], "value": 12603.041152680884, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1417.8865690744742, 1449.137763030997, 1491.5749011531716, 1503.9097654140753, 1510.675204830961, 14642.414303427864, 15056.397744090224, 15157.0, 15200.315985780639, 15257.38970441181, 15559.066456012619, 15642.0, 15757.290921908512, 15800.288986995583, 15822.208889555533, 2694.043614516848, 2746.5605503119505, 2753.1465245773775, 2756.738109879558, 2758.7655049320833, 2462.212092130519, 2567.884445199961, 2620.3842097107163, 2684.3691732442862, 2746.217328061503, 2649.2052384284734, 2671.318813702503, 2679.825811322268, 2681.302861256068, 2681.6513853199153, 2513.2711513661106, 2534.8479091254585, 2556.156468365444, 2559.9744002560014, 2561.385267535778, 2559.744025597444, 2575.25317657879, 2596.6883973923063, 2597.5194589000907, 2599.4671092426197, 14799.630009249855, 15140.242987850563, 15169.24153792306, 15198.316075776616, 15199.240037998055, 7604.2395760423515, 7874.228298632762, 7880.408969327266, 7882.935803666489, 7919.128895821455, 4815.036992601494, 4945.629077819178, 4953.554180123806, 5009.724465154415, 5035.59715222785, 1913.2825190553542, 1923.5960448305873, 1924.8845069295746, 1937.060525645061, 1980.4949737816908, 26012.34969125787, 26165.345866353302, 26188.345291367677, 26422.6036609451, 26474.73525264742, 6697.095892054608, 6797.422219111431, 6896.793096207121, 7005.194402643761, 7038.894416583756, 17495.737563936553, 18316.358927437475, 18374.265029398943, 18417.0, 18418.0, 7837.960810195913, 8002.839943201104, 8013.2387423194705, 8018.398620103516, 8024.679012839538, 7177.7487787927175, 7298.306660867315, 7325.7802265932105, 7335.789594716919, 7340.486165968331, 5344.225087362311, 5465.562754979592, 5470.124780035255, 5487.533559647474, 5633.915491267634, 1517.3854588891516, 1529.296523599157, 1529.908205507673, 1538.9461368852037, 1540.306861912144, 947.677789551542, 952.9190018848476, 964.8600952861796, 966.9661561845302, 980.1081016275298, 8024.117347091816, 8043.718469853527, 8084.83830323402, 8170.632321545545, 8224.177582241728, 748.3227678950558, 751.7030772844696, 770.9460337776302, 1033.9224558158169, 1042.3120740311358, 6091.969540152271, 6264.655443950535, 6269.843253918597, 6300.432961033529, 6470.870582588322, 22360.664590031163, 22446.214382496535, 22504.0, 22663.773362266496, 22877.88561057184, 21778.455538611663, 21798.128074877146, 22499.212527561456, 22533.4366640832, 22582.435439114153, 11967.0, 12019.278843269432, 12025.218360806519, 12040.458179381949, 12167.939160304319, 8680.82638347217, 9224.492652904155, 9371.531423428665, 9374.062593740571, 9393.154616084585, 18399.448016559523, 18784.906075469535, 18957.810421895603, 19471.123799428777, 19649.90175049173, 18845.24619015224, 19133.139008744918, 19226.134823932676, 19257.903710481358, 19316.903415482833, 12277.0, 12424.627261182179, 12503.312317822607, 12561.309127998047, 12708.745825083632, 14039.227842468763, 14119.152850828983, 14195.0, 14195.793357564722, 14198.574042778733, 11458.369789661649, 11528.9623933843, 11658.0, 11831.11266654987, 12041.157119001586, 11231.831522527333, 11343.546258149581, 11349.716257093638, 11472.254303470248, 11652.067834573045, 10253.538590763583, 10313.0, 10341.482925853526, 10374.17006639452, 10388.636397726043, 7698.114716807415, 7810.648520816463, 7901.130875603794, 7937.682492700458, 7999.720009799629, 7853.489523180975, 7993.920060799318, 8026.879596805936, 8092.150324215872, 8098.676052957816], "value": 6826.269956752744, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.3304306143643, 510.2779566912819, 533.5544820075237, 545.6044367833321, 550.9559235261177, 5994.602159136348, 6061.515078793697, 6095.817125486237, 6189.473894718949, 6192.287886893008, 5953.333066741319, 6017.976943919533, 6023.2169817923605, 6041.365656606059, 6070.878582428349, 4761.738104404265, 4778.4265888093305, 4825.517448255164, 4827.744786355555, 4839.830605928793, 4718.740469274188, 4780.689255198401, 4844.442889067749, 4852.738288045099, 4894.388201474816, 4806.3030860525205, 4830.951690483085, 4850.466448690659, 4857.854264372075, 4871.244957031666, 4728.503507131753, 4729.314249433813, 4784.40194975628, 4814.566688998007, 4816.109019831325, 4353.62994145498, 4372.40972468719, 4394.318880573516, 4398.152775834157, 4405.163019026407, 6063.484603808637, 6069.393060693896, 6071.1803906472505, 6082.665453400061, 6117.3695311016245, 5629.634073785191, 5671.7731290748325, 5735.770569177228, 5745.597808153431, 5797.4782269595935, 6511.576747511444, 6531.902021469682, 6540.93459065408, 6555.180602424697, 6624.542600627854, 4929.605631549467, 4930.506949305077, 4931.728754918478, 4932.383452068491, 4975.328330675348, 6712.597244165366, 6761.8647627047185, 6840.521163518556, 6925.896111558331, 6938.653067346663, 5108.259302401131, 5109.182530795055, 5119.180931051088, 5120.948790512047, 5133.922991155136, 5111.565516931102, 5208.739563021833, 5223.973880130575, 5240.423553409122, 5253.4221235664045, 5670.5180059695385, 5679.659220446786, 5694.572907031989, 5694.715264236772, 5721.284839395075, 6480.967595162088, 6506.284308726036, 6513.478921686254, 6558.737650493927, 6598.208215014133, 1709.2223038517693, 1714.391391056157, 1748.7726595542752, 1787.0796539782023, 1788.3293764838186, 1249.6813312605227, 1256.8114782782473, 1261.1928365845865, 1280.6990357266036, 1285.318781046047, 6118.0, 6169.96915015431, 6192.792405480888, 6215.844603884939, 6221.253449586078, 6515.4787616990525, 6598.406143447113, 6610.107635469246, 6690.524505932836, 6743.865122697519, 6287.528435367274, 6297.685115744194, 6304.527160462983, 6316.463100636405, 6355.491560675227, 3452.6202117767025, 3516.9648303516637, 3528.712020112692, 3553.9466907996402, 3573.5354403927845, 6987.1266091738535, 7032.3783251625455, 7062.4703147263135, 7070.257622949619, 7102.289771022856, 6801.285864984205, 6857.759978400832, 6895.0, 6956.0, 6980.650967451607, 6921.8961715575315, 6929.688164032631, 6995.510314278054, 7022.613756243456, 7090.256891917564, 6667.599944003376, 6676.165479315086, 6691.453529629304, 6806.897896531655, 6826.726930922708, 6641.468682505485, 6644.700988455627, 6678.499112566674, 6733.69698363565, 6748.797536073926, 6986.161660600557, 7010.123734533184, 7034.155901291878, 7063.823404414725, 7084.787456376317, 5025.497450254945, 5082.669626474268, 5089.26205700164, 5095.700596347908, 5099.92350114756, 6716.764913228014, 6720.630365329954, 6744.393004629411, 6756.121704178426, 6852.246252912076, 6529.67351632426, 6537.411632953057, 6591.802245932629, 6643.0, 6662.267150613332, 6263.0, 6383.648899310582, 6466.547341686037, 6521.608703477807, 6532.314107018885, 6219.0, 6245.6252624842655, 6407.917426836204, 6408.198975128109, 6513.7068831903625, 6396.936030639634, 6475.1582294303325, 6478.0524861187105, 6479.736451391933, 6483.222013358427, 6361.395667411589, 6378.872422551616, 6384.648844313608, 6400.39196276353, 6431.807045788634], "value": 5096.379554535122, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [924.6763632728546, 930.9115634014767, 942.7501712046304, 949.4255975135043, 953.3136141977776, 17952.46142615722, 18633.813661863376, 18712.62574748506, 18762.530936726573, 22111.778882211172, 19148.268597696115, 19193.712094318595, 19756.901215493937, 19769.703454448158, 20010.399688009347, 947.4552132523809, 1025.825609646358, 1026.8716410448694, 1027.219313321877, 1027.830407982682, 1045.9644951498, 1047.0262655730169, 1048.6696690542492, 1049.2235745548278, 1053.2679787547656, 1015.7003683913264, 1047.7066421401983, 1057.196530636714, 1077.3320541264427, 1084.1922767538194, 1034.3845411979898, 1037.4190453346112, 1044.7962647283782, 1045.5974449836792, 1048.072455876547, 775.4649291988567, 778.9610519474061, 782.8003859015971, 784.5214419204281, 784.8469548438056, 17936.372226971995, 18539.81460185408, 19886.105125269398, 20155.798442015537, 20191.19235230589, 21746.673799893015, 21899.562008759895, 22165.556688866294, 22165.889170554045, 22505.437364065867, 16502.17489125539, 16690.165491725365, 16787.0, 16915.323387064625, 16973.57566060846, 3449.3618680544178, 3453.1194545390763, 3507.7895326280504, 3508.578970523528, 3508.719302455823, 145913.0, 146186.0, 146821.0, 146961.26519367335, 151297.0, 15150.924245378703, 15393.769093463607, 15552.0, 15611.0, 15629.3748250071, 26597.248939497607, 26823.597646035327, 26901.0, 26927.192184234504, 26992.460150797266, 8822.86765698515, 8907.331950103768, 8918.241949434241, 8931.285497160212, 9030.909690903138, 4236.894077648022, 4366.0, 4379.978100109479, 4381.84663536781, 4384.758838263926, 5212.635115541952, 5275.155975044051, 6126.846828829315, 6342.302346741854, 6390.648514331663, 1174.7885380631396, 1215.5380955236953, 1215.8601760797621, 1220.9816852747038, 1226.8466441694789, 696.0811728518408, 708.5394493579112, 712.7077898061873, 724.3734169942961, 731.5427857589007, 11590.594329198437, 11671.183017188885, 12950.0, 13034.152780069455, 13357.799633005512, 678.1556961582861, 691.837418206721, 702.553878287281, 707.1620130145793, 711.861187068527, 5850.5904586678525, 5961.403859614091, 6250.812475625738, 6563.343665633399, 6898.758543450955, 124819.37590312172, 127997.0, 129355.0, 130470.0, 131281.0, 111246.44376778064, 113939.43030284795, 114356.42821785838, 116329.41835290939, 117623.0, 95686.0, 97392.0, 100182.49726254257, 100608.0, 103177.0, 11899.702507437038, 12035.338056406981, 12205.084618653815, 12229.633111006684, 12820.23078615286, 43469.0, 44279.77860110679, 44355.0, 44632.33051504295, 45747.54252457433, 78129.0, 78136.21863781517, 79544.60227698824, 80560.0, 82078.0, 17516.91241543835, 17601.64796704033, 17651.205695743465, 17927.0, 18032.90983545074, 18786.436406907815, 21209.7879021214, 21685.891570542048, 21807.672884907057, 21962.670559941293, 20009.299674511323, 20266.392008239778, 20403.183872644928, 20521.794782051988, 20632.58734825265, 18333.54166145857, 18515.444536663923, 18620.627587448445, 18801.05994700287, 18812.52968675794, 19415.708764368264, 19899.0, 19942.700859486828, 19966.90016549966, 20083.397498075083, 9510.762230944281, 9589.712308630753, 9735.464549449849, 10155.289129760846, 10191.286609937233, 14867.553973380816, 15133.319000645217, 15201.163935983184, 15481.922590386976, 15640.374385024927], "value": 9479.407820664743, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 106.0, 100.0, 108.0, 107.0, 111.0, 117.0, 101.0, 110.0, 109.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 113.0, 138.0, 170.0, 118.0, 138.0, 150.0, 116.0, 174.0, 113.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 162.0, 165.0, 165.0, 165.0, 166.0, 165.0, 166.0, 169.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 180.0, 75.0, 75.0, 74.0, 86.0, 95.0, 76.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 130.0, 79.0, 80.0, 79.0, 129.0, 84.0, 79.0, 137.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 130.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 149.0, 149.0, 159.0, 149.0, 148.0, 150.0, 148.0, 149.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 48.0, 48.0, 49.0, 48.0, 49.0, 47.0, 47.0, 50.0], "value": 48.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 56.0, 54.0, 55.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 76.0, 76.0, 74.0, 74.0, 73.0, 75.0, 75.0, 76.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 121.0, 119.0, 130.0, 115.0, 128.0, 118.0, 117.0, 127.0, 157.0], "value": 125.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 160.0, 166.0, 162.0, 162.0, 172.0, 162.0, 165.0, 167.0, 162.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 61.0, 60.0, 61.0, 61.0, 60.0, 63.0, 61.0, 61.0], "value": 61.5, "unit": "score"}]}]} 15:34:06 INFO - Return code: 0 15:34:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:34:06 INFO - # TBPL SUCCESS # 15:34:06 INFO - Running post-action listener: _package_coverage_data 15:34:06 INFO - Running post-action listener: _resource_record_post_action 15:34:06 INFO - [mozharness: 2017-08-08 22:34:06.070696Z] Finished run-tests step (success) 15:34:06 INFO - Running post-run listener: _resource_record_post_run 15:34:06 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 430096384; Read time: 0; Write time: 372964 15:34:06 INFO - TinderboxPrint: CPU usage
13.1% 15:34:06 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 15:34:06 INFO - TinderboxPrint: I/O write bytes / time
430,096,384 / 372,964 15:34:06 INFO - TinderboxPrint: CPU idle
8,235.3 (86.9%) 15:34:06 INFO - TinderboxPrint: CPU user
1,195.3 (12.6%) 15:34:06 INFO - TinderboxPrint: Swap in / out
0 / 0 15:34:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107249664; Read time: 0; Write time: 90364 15:34:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 15:34:06 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 322846720; Read time: 0; Write time: 282600 15:34:06 INFO - Running post-run listener: _upload_blobber_files 15:34:06 INFO - Blob upload gear active. 15:34:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:34:06 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 15:34:06 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'] 15:34:06 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 15:34:07 INFO - (blobuploader) - INFO - Open directory for files ... 15:34:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:34:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:34:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:07 INFO - (blobuploader) - INFO - Done attempting. 15:34:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:34:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:34:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:08 INFO - (blobuploader) - INFO - Done attempting. 15:34:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:34:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:34:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:15 INFO - (blobuploader) - INFO - Done attempting. 15:34:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:34:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:34:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:34:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:34:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:34:16 INFO - (blobuploader) - INFO - Done attempting. 15:34:16 INFO - (blobuploader) - INFO - Iteration through files over. 15:34:16 INFO - Return code: 0 15:34:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:34:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:34:16 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c2ddc6280c4a05d99882ba499970b667f02a65fe371b558fa2a8092a0ebb5c886104499e76701c91c83f4d5bd9702ff05a49a7a34ba02297f69395932d9bcc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c49ae98621d56732d49814b87008976a4b50ba2bbaaf50a612844c29e789cec2e8ca67382ef970651f77c54defa4857c0c65aa153dae821ef46a98388190037", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72b15e5f3c75f9afea6059deb999d3050de4fb2afd7e88f579262a312841682a00d6891533e070a3224b944dd8291cab7c244ea3775885ff74bb35194028d95d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1f16093f6816c2c918fae2fce0eb5a0e4e80291d8358611f1182550bb0ee099b173aa3978b7d87c5ce4c1b98d6d142ec28ed34bdb3d78a578175a40db568b79"} 15:34:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:34:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:34:16 INFO - Contents: 15:34:16 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c2ddc6280c4a05d99882ba499970b667f02a65fe371b558fa2a8092a0ebb5c886104499e76701c91c83f4d5bd9702ff05a49a7a34ba02297f69395932d9bcc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c49ae98621d56732d49814b87008976a4b50ba2bbaaf50a612844c29e789cec2e8ca67382ef970651f77c54defa4857c0c65aa153dae821ef46a98388190037", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72b15e5f3c75f9afea6059deb999d3050de4fb2afd7e88f579262a312841682a00d6891533e070a3224b944dd8291cab7c244ea3775885ff74bb35194028d95d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1f16093f6816c2c918fae2fce0eb5a0e4e80291d8358611f1182550bb0ee099b173aa3978b7d87c5ce4c1b98d6d142ec28ed34bdb3d78a578175a40db568b79"} 15:34:16 INFO - Running post-run listener: copy_logs_to_upload_dir 15:34:16 INFO - Copying logs to upload dir... 15:34:16 INFO - mkdir: /builds/slave/test/build/upload/logs 15:34:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.914850 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-08-08 15:34:16.275227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 15:34:16.278647) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c2ddc6280c4a05d99882ba499970b667f02a65fe371b558fa2a8092a0ebb5c886104499e76701c91c83f4d5bd9702ff05a49a7a34ba02297f69395932d9bcc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c49ae98621d56732d49814b87008976a4b50ba2bbaaf50a612844c29e789cec2e8ca67382ef970651f77c54defa4857c0c65aa153dae821ef46a98388190037", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72b15e5f3c75f9afea6059deb999d3050de4fb2afd7e88f579262a312841682a00d6891533e070a3224b944dd8291cab7c244ea3775885ff74bb35194028d95d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1f16093f6816c2c918fae2fce0eb5a0e4e80291d8358611f1182550bb0ee099b173aa3978b7d87c5ce4c1b98d6d142ec28ed34bdb3d78a578175a40db568b79"} build_url:https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011389 build_url: 'https://queue.taskcluster.net/v1/task/eE2JpUv1QuiQ2P2aH43FZQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c2ddc6280c4a05d99882ba499970b667f02a65fe371b558fa2a8092a0ebb5c886104499e76701c91c83f4d5bd9702ff05a49a7a34ba02297f69395932d9bcc0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c49ae98621d56732d49814b87008976a4b50ba2bbaaf50a612844c29e789cec2e8ca67382ef970651f77c54defa4857c0c65aa153dae821ef46a98388190037", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72b15e5f3c75f9afea6059deb999d3050de4fb2afd7e88f579262a312841682a00d6891533e070a3224b944dd8291cab7c244ea3775885ff74bb35194028d95d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c1f16093f6816c2c918fae2fce0eb5a0e4e80291d8358611f1182550bb0ee099b173aa3978b7d87c5ce4c1b98d6d142ec28ed34bdb3d78a578175a40db568b79"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 15:34:16.306741) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:34:16.307425) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1502229922.313399-935189441 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004445 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 15:34:16.391030) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 15:34:16.391735) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 15:34:16.392413) ========= ========= Total master_lag: 0.18 =========