builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-072 starttime: 1502195006.11 results: success (0) revision: 8c7788eda00e4cb4445638bdb7500009cd4cbe59 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 05:23:26.110870) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 05:23:26.111429) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 05:23:26.111725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 05:23:26.128248) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 05:23:26.128597) ========= 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=199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-08 05:23:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.8M=0s 2017-08-08 05:23:26 (69.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130733 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 05:23:26.274199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 05:23:26.274712) ========= 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=199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018172 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 05:23:26.325437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-08 05:23:26.325831) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8c7788eda00e4cb4445638bdb7500009cd4cbe59 --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 8c7788eda00e4cb4445638bdb7500009cd4cbe59 --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=199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-08 05:23:26,450 truncating revision to first 12 chars 2017-08-08 05:23:26,450 Setting DEBUG logging. 2017-08-08 05:23:26,450 attempt 1/10 2017-08-08 05:23:26,451 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8c7788eda00e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-08 05:23:27,471 unpacking tar archive at: mozilla-central-8c7788eda00e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.354010 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-08 05:23:27.702013) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 05:23:27.702473) ========= script_repo_revision: 8c7788eda00e4cb4445638bdb7500009cd4cbe59 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 05:23:27.703020) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 05:23:27.703419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 05:23:27.713754) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-08 05:23:27.714276) ========= /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=199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:23:27 INFO - MultiFileLogger online at 20170808 05:23:27 in /builds/slave/test 05:23:27 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 05:23:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:27 INFO - {'append_to_log': False, 05:23:27 INFO - 'base_work_dir': '/builds/slave/test', 05:23:27 INFO - 'blob_upload_branch': 'Firefox', 05:23:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:27 INFO - 'branch': 'Firefox', 05:23:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:27 INFO - 'code_coverage': False, 05:23:27 INFO - 'config_files': ('talos/linux_config.py',), 05:23:27 INFO - 'default_actions': ('clobber', 05:23:27 INFO - 'read-buildbot-config', 05:23:27 INFO - 'download-and-extract', 05:23:27 INFO - 'populate-webroot', 05:23:27 INFO - 'create-virtualenv', 05:23:27 INFO - 'install', 05:23:27 INFO - 'setup-mitmproxy', 05:23:27 INFO - 'run-tests'), 05:23:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:27 INFO - 'disable_ccov_upload': False, 05:23:27 INFO - 'download_minidump_stackwalk': True, 05:23:27 INFO - 'download_symbols': 'ondemand', 05:23:27 INFO - 'enable_stylo': False, 05:23:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:27 INFO - 'gecko_profile': False, 05:23:27 INFO - 'gecko_profile_interval': 0, 05:23:27 INFO - 'installer_path': 'installer.exe', 05:23:27 INFO - 'log_level': 'info', 05:23:27 INFO - 'log_name': 'talos', 05:23:27 INFO - 'log_to_console': True, 05:23:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:23:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:23:27 INFO - 'opt_config_files': (), 05:23:27 INFO - 'pip_index': False, 05:23:27 INFO - 'suite': 'dromaeojs-e10s', 05:23:27 INFO - 'system_bits': '32', 05:23:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:27 INFO - 'title': 'talos-linux64-ix-072', 05:23:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:27 INFO - 'use_talos_json': True, 05:23:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:27 INFO - 'work_dir': 'build'} 05:23:27 INFO - [mozharness: 2017-08-08 12:23:27.940878Z] Running clobber step. 05:23:27 INFO - Running pre-action listener: _resource_record_pre_action 05:23:27 INFO - Running main action method: clobber 05:23:27 INFO - rmtree: /builds/slave/test/build 05:23:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:23:29 INFO - Running post-action listener: _resource_record_post_action 05:23:29 INFO - [mozharness: 2017-08-08 12:23:29.460332Z] Finished clobber step (success) 05:23:29 INFO - [mozharness: 2017-08-08 12:23:29.460434Z] Running read-buildbot-config step. 05:23:29 INFO - Running pre-action listener: _resource_record_pre_action 05:23:29 INFO - Running main action method: read_buildbot_config 05:23:29 INFO - Using buildbot properties: 05:23:29 INFO - { 05:23:29 INFO - "project": "", 05:23:29 INFO - "product": "firefox", 05:23:29 INFO - "who": "cbook@mozilla.com", 05:23:29 INFO - "installer_path": "public/build/target.tar.bz2", 05:23:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:23:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 05:23:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:23:29 INFO - "stage_platform": "linux64-pgo", 05:23:29 INFO - "basedir": "/builds/slave/test", 05:23:29 INFO - "buildnumber": 112, 05:23:29 INFO - "platform": "ubuntu64_hw", 05:23:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:23:29 INFO - "slavebuilddir": "test", 05:23:29 INFO - "taskId": "URyf85sTTmCP13T2PgnOgQ", 05:23:29 INFO - "branch": "mozilla-central", 05:23:29 INFO - "script_repo_revision": "production", 05:23:29 INFO - "revision": "8c7788eda00e4cb4445638bdb7500009cd4cbe59", 05:23:29 INFO - "slavename": "talos-linux64-ix-072", 05:23:29 INFO - "repo_path": "mozilla-central" 05:23:29 INFO - } 05:23:29 INFO - Finding installer, test and symbols from parent task. 05:23:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/URyf85sTTmCP13T2PgnOgQ'}, attempt #1 05:23:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/URyf85sTTmCP13T2PgnOgQ'}, attempt #1 05:23:30 INFO - Task dependencies: U7IrLBmAS-ad_k0TvlzqjA 05:23:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA'}, attempt #1 05:23:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.tar.bz2 05:23:30 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.test_packages.json 05:23:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.crashreporter-symbols.zip 05:23:30 INFO - Running post-action listener: _resource_record_post_action 05:23:30 INFO - [mozharness: 2017-08-08 12:23:30.874906Z] Finished read-buildbot-config step (success) 05:23:30 INFO - [mozharness: 2017-08-08 12:23:30.875128Z] Running download-and-extract step. 05:23:30 INFO - Running pre-action listener: _resource_record_pre_action 05:23:30 INFO - Running main action method: download_and_extract 05:23:30 INFO - mkdir: /builds/slave/test/build/tests 05:23:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:23:30 INFO - trying https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.test_packages.json 05:23:30 INFO - Downloading https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:23:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:23:31 INFO - Downloaded 989 bytes. 05:23:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:23:31 INFO - Using the following test package requirements: 05:23:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:23:31 INFO - u'common': [u'target.common.tests.zip'], 05:23:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:23:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:23:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:23:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:23:31 INFO - u'mozbase': [u'target.common.tests.zip'], 05:23:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:23:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:23:31 INFO - u'web-platform': [u'target.common.tests.zip', 05:23:31 INFO - u'target.web-platform.tests.tar.gz'], 05:23:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:23:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:23:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.common.tests.zip 05:23:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:23:31 INFO - Fetch https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.common.tests.zip into memory 05:23:33 INFO - Content-Length response header: 54900122 05:23:33 INFO - Bytes received: 54900122 05:23:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:23:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.common.tests.zip 05:23:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:23:44 INFO - Fetch https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.common.tests.zip into memory 05:23:45 INFO - Content-Length response header: 54900122 05:23:45 INFO - Bytes received: 54900122 05:23:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.talos.tests.zip 05:23:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:23:57 INFO - Fetch https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.talos.tests.zip into memory 05:23:58 INFO - Content-Length response header: 14496008 05:23:58 INFO - Bytes received: 14496008 05:23: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')]} 05:23:59 INFO - trying https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.tar.bz2 05:23:59 INFO - Downloading https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:23:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:24:00 INFO - Downloaded 62677009 bytes. 05:24:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.tar.bz2 05:24:00 INFO - mkdir: /builds/slave/test/properties 05:24:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:24:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:24:00 INFO - Contents: 05:24:00 INFO - build_url:https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.tar.bz2 05:24:00 INFO - Running post-action listener: _resource_record_post_action 05:24:00 INFO - Running post-action listener: set_extra_try_arguments 05:24:00 INFO - [mozharness: 2017-08-08 12:24:00.690094Z] Finished download-and-extract step (success) 05:24:00 INFO - [mozharness: 2017-08-08 12:24:00.690193Z] Running populate-webroot step. 05:24:00 INFO - Running pre-action listener: _resource_record_pre_action 05:24:00 INFO - Running main action method: populate_webroot 05:24:00 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:24:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:24:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:24:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:24:00 INFO - 'tests': ['damp', 'tps']}, 05:24:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:24:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:24:00 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:24:00 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:24:00 INFO - 'other-e10s': {'tests': ['a11yr', 05:24:00 INFO - 'ts_paint', 05:24:00 INFO - 'tpaint', 05:24:00 INFO - 'sessionrestore', 05:24:00 INFO - 'sessionrestore_many_windows', 05:24:00 INFO - 'sessionrestore_no_auto_restore', 05:24:00 INFO - 'tabpaint']}, 05:24:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:24:00 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:24:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:24:00 INFO - 'tsvgr_opacity', 05:24:00 INFO - 'tart', 05:24:00 INFO - 'tscrollx', 05:24:00 INFO - 'tsvg_static']}, 05:24:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:24:00 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:24:00 INFO - 'talos_options': ['--mitmproxy', 05:24:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:24:00 INFO - '--firstNonBlankPaint'], 05:24:00 INFO - 'tests': ['tp6_google', 05:24:00 INFO - 'tp6_youtube', 05:24:00 INFO - 'tp6_amazon', 05:24:00 INFO - 'tp6_facebook']}, 05:24:00 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:24:00 INFO - 'talos_options': ['--stylo', 05:24:00 INFO - '--mitmproxy', 05:24:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:24:00 INFO - '--firstNonBlankPaint'], 05:24:00 INFO - 'tests': ['tp6_google', 05:24:00 INFO - 'tp6_youtube', 05:24:00 INFO - 'tp6_amazon', 05:24:00 INFO - 'tp6_facebook']}, 05:24:00 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:24:00 INFO - 'talos_options': ['--stylo', 05:24:00 INFO - '--stylo-threads=1', 05:24:00 INFO - '--mitmproxy', 05:24:00 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:24:00 INFO - '--firstNonBlankPaint'], 05:24:00 INFO - 'tests': ['tp6_google', 05:24:00 INFO - 'tp6_youtube', 05:24:00 INFO - 'tp6_amazon', 05:24:00 INFO - 'tp6_facebook']}, 05:24:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:24:00 INFO - 'talos_options': ['--xperf_path', 05:24:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:00 INFO - 'tests': ['tp5n']}}} 05:24:00 INFO - Running post-action listener: _resource_record_post_action 05:24:00 INFO - [mozharness: 2017-08-08 12:24:00.698730Z] Finished populate-webroot step (success) 05:24:00 INFO - [mozharness: 2017-08-08 12:24:00.698820Z] Running create-virtualenv step. 05:24:00 INFO - Running pre-action listener: _resource_record_pre_action 05:24:00 INFO - Running main action method: create_virtualenv 05:24:00 INFO - Creating virtualenv /builds/slave/test/build/venv 05:24:00 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 05:24:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:24:00 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:24:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:24:00 INFO - Using real prefix '/usr' 05:24:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:24:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:03 INFO - Installing pip.................done. 05:24:03 INFO - Return code: 0 05:24:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:24:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:24:03 INFO - Reading from file tmpfile_stdout 05:24:03 INFO - Output received: 05:24:03 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) 05:24:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24: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')]} 05:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ceb0>, '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 0x260ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e240>, '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': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', '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 05:24: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', 'pip>=1.5'] in /builds/slave/test/build 05:24: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 pip>=1.5 05:24:03 INFO - Using env: {'DISPLAY': ':0', 05:24:03 INFO - 'HOME': '/home/cltbld', 05:24:03 INFO - 'LANG': 'en_US.UTF-8', 05:24:03 INFO - 'LANGUAGE': 'en_US:en', 05:24:03 INFO - 'LOGNAME': 'cltbld', 05:24:03 INFO - 'MAIL': '/var/mail/cltbld', 05:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:03 INFO - 'MOZ_NO_REMOTE': '1', 05:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:03 INFO - 'NO_EM_RESTART': '1', 05:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:03 INFO - 'PWD': '/builds/slave/test', 05:24:03 INFO - 'SHELL': '/bin/bash', 05:24:03 INFO - 'SHLVL': '1', 05:24:03 INFO - 'TERM': 'linux', 05:24:03 INFO - 'TMOUT': '86400', 05:24:03 INFO - 'USER': 'cltbld', 05:24:03 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', 05:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:03 INFO - '_': '/tools/buildbot/bin/python'} 05:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:03 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 05:24:03 INFO - Cleaning up... 05:24:03 INFO - Return code: 0 05:24:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24: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')]} 05:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24: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', '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 0x22a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ceb0>, '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 0x260ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e240>, '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': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', '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 05:24: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:24: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 psutil>=3.1.1 05:24:03 INFO - Using env: {'DISPLAY': ':0', 05:24:03 INFO - 'HOME': '/home/cltbld', 05:24:03 INFO - 'LANG': 'en_US.UTF-8', 05:24:03 INFO - 'LANGUAGE': 'en_US:en', 05:24:03 INFO - 'LOGNAME': 'cltbld', 05:24:03 INFO - 'MAIL': '/var/mail/cltbld', 05:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:03 INFO - 'MOZ_NO_REMOTE': '1', 05:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:03 INFO - 'NO_EM_RESTART': '1', 05:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:03 INFO - 'PWD': '/builds/slave/test', 05:24:03 INFO - 'SHELL': '/bin/bash', 05:24:03 INFO - 'SHLVL': '1', 05:24:03 INFO - 'TERM': 'linux', 05:24:03 INFO - 'TMOUT': '86400', 05:24:03 INFO - 'USER': 'cltbld', 05:24:03 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', 05:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:03 INFO - '_': '/tools/buildbot/bin/python'} 05:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:03 INFO - Downloading/unpacking psutil>=3.1.1 05:24: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 05:24: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 05:24: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 05:24: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 05:24:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:24:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:05 INFO - Installing collected packages: psutil 05:24:05 INFO - Running setup.py install for psutil 05:24:05 INFO - building 'psutil._psutil_linux' extension 05:24:05 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 05:24:05 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 05:24:05 INFO - building 'psutil._psutil_posix' extension 05:24:05 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 05:24:05 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 05:24:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:05 INFO - Successfully installed psutil 05:24:05 INFO - Cleaning up... 05:24:05 INFO - Return code: 0 05:24:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:24:05 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')]} 05:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:05 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')]} 05:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:05 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 0x22a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ceb0>, '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 0x260ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e240>, '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': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', '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 05:24:05 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 05:24:05 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 05:24:05 INFO - Using env: {'DISPLAY': ':0', 05:24:05 INFO - 'HOME': '/home/cltbld', 05:24:05 INFO - 'LANG': 'en_US.UTF-8', 05:24:05 INFO - 'LANGUAGE': 'en_US:en', 05:24:05 INFO - 'LOGNAME': 'cltbld', 05:24:05 INFO - 'MAIL': '/var/mail/cltbld', 05:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:05 INFO - 'MOZ_NO_REMOTE': '1', 05:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:05 INFO - 'NO_EM_RESTART': '1', 05:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:05 INFO - 'PWD': '/builds/slave/test', 05:24:05 INFO - 'SHELL': '/bin/bash', 05:24:05 INFO - 'SHLVL': '1', 05:24:05 INFO - 'TERM': 'linux', 05:24:05 INFO - 'TMOUT': '86400', 05:24:05 INFO - 'USER': 'cltbld', 05:24:05 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', 05:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:05 INFO - '_': '/tools/buildbot/bin/python'} 05:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:24: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 05:24: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 05:24: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 05:24: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 05:24:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:24:07 INFO - Installing collected packages: mozsystemmonitor 05:24:07 INFO - Running setup.py install for mozsystemmonitor 05:24:07 INFO - Successfully installed mozsystemmonitor 05:24:07 INFO - Cleaning up... 05:24:07 INFO - Return code: 0 05:24:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24: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')]} 05:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:07 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 0x22a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ceb0>, '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 0x260ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e240>, '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': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', '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 05:24:07 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 05:24:07 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 05:24:07 INFO - Using env: {'DISPLAY': ':0', 05:24:07 INFO - 'HOME': '/home/cltbld', 05:24:07 INFO - 'LANG': 'en_US.UTF-8', 05:24:07 INFO - 'LANGUAGE': 'en_US:en', 05:24:07 INFO - 'LOGNAME': 'cltbld', 05:24:07 INFO - 'MAIL': '/var/mail/cltbld', 05:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:07 INFO - 'MOZ_NO_REMOTE': '1', 05:24:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:07 INFO - 'NO_EM_RESTART': '1', 05:24:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:07 INFO - 'PWD': '/builds/slave/test', 05:24:07 INFO - 'SHELL': '/bin/bash', 05:24:07 INFO - 'SHLVL': '1', 05:24:07 INFO - 'TERM': 'linux', 05:24:07 INFO - 'TMOUT': '86400', 05:24:07 INFO - 'USER': 'cltbld', 05:24:07 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', 05:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:07 INFO - '_': '/tools/buildbot/bin/python'} 05:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:07 INFO - Downloading/unpacking jsonschema==2.5.1 05:24:07 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 05:24:07 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 05:24:07 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 05:24:07 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 05:24:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:24:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:24:08 INFO - warning: no files found matching '*.txt' 05:24:08 INFO - no previously-included directories found matching 'build' 05:24:08 INFO - no previously-included directories found matching 'dist' 05:24:08 INFO - no previously-included directories found matching '.git*' 05:24:08 INFO - Installing collected packages: jsonschema, functools32 05:24:08 INFO - Running setup.py install for functools32 05:24:08 INFO - warning: no files found matching '*.txt' 05:24:08 INFO - no previously-included directories found matching 'build' 05:24:08 INFO - no previously-included directories found matching 'dist' 05:24:08 INFO - no previously-included directories found matching '.git*' 05:24:08 INFO - Successfully installed jsonschema functools32 05:24:08 INFO - Cleaning up... 05:24:08 INFO - Return code: 0 05:24:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:24:08 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')]} 05:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:08 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')]} 05:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ceb0>, '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 0x260ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e240>, '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': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', '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 05:24:08 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 05:24:08 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 05:24:08 INFO - Using env: {'DISPLAY': ':0', 05:24:08 INFO - 'HOME': '/home/cltbld', 05:24:08 INFO - 'LANG': 'en_US.UTF-8', 05:24:08 INFO - 'LANGUAGE': 'en_US:en', 05:24:08 INFO - 'LOGNAME': 'cltbld', 05:24:08 INFO - 'MAIL': '/var/mail/cltbld', 05:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:08 INFO - 'MOZ_NO_REMOTE': '1', 05:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:08 INFO - 'NO_EM_RESTART': '1', 05:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:08 INFO - 'PWD': '/builds/slave/test', 05:24:08 INFO - 'SHELL': '/bin/bash', 05:24:08 INFO - 'SHLVL': '1', 05:24:08 INFO - 'TERM': 'linux', 05:24:08 INFO - 'TMOUT': '86400', 05:24:08 INFO - 'USER': 'cltbld', 05:24:08 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', 05:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:08 INFO - '_': '/tools/buildbot/bin/python'} 05:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:24:09 INFO - Cleaning up... 05:24:09 INFO - Return code: 0 05:24:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x22a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ceb0>, '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 0x260ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e240>, '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': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', '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 05:24:09 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 05:24:09 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 05:24:09 INFO - Using env: {'DISPLAY': ':0', 05:24:09 INFO - 'HOME': '/home/cltbld', 05:24:09 INFO - 'LANG': 'en_US.UTF-8', 05:24:09 INFO - 'LANGUAGE': 'en_US:en', 05:24:09 INFO - 'LOGNAME': 'cltbld', 05:24:09 INFO - 'MAIL': '/var/mail/cltbld', 05:24:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:09 INFO - 'MOZ_NO_REMOTE': '1', 05:24:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:09 INFO - 'NO_EM_RESTART': '1', 05:24:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:09 INFO - 'PWD': '/builds/slave/test', 05:24:09 INFO - 'SHELL': '/bin/bash', 05:24:09 INFO - 'SHLVL': '1', 05:24:09 INFO - 'TERM': 'linux', 05:24:09 INFO - 'TMOUT': '86400', 05:24:09 INFO - 'USER': 'cltbld', 05:24:09 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', 05:24:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:09 INFO - '_': '/tools/buildbot/bin/python'} 05:24:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:09 INFO - Downloading/unpacking blobuploader==1.2.4 05:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:10 INFO - Downloading blobuploader-1.2.4.tar.gz 05:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:24:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:24:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:10 INFO - Downloading docopt-0.6.1.tar.gz 05:24:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:24:11 INFO - Installing collected packages: blobuploader, requests, docopt 05:24:11 INFO - Running setup.py install for blobuploader 05:24:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:24:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:24:11 INFO - Running setup.py install for requests 05:24:11 INFO - Running setup.py install for docopt 05:24:11 INFO - Successfully installed blobuploader requests docopt 05:24:11 INFO - Cleaning up... 05:24:11 INFO - Return code: 0 05:24:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:11 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')]} 05:24:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:11 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')]} 05:24:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:11 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 0x22a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ceb0>, '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 0x260ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e240>, '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': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', '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 05:24:11 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 05:24:11 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 05:24:11 INFO - Using env: {'DISPLAY': ':0', 05:24:11 INFO - 'HOME': '/home/cltbld', 05:24:11 INFO - 'LANG': 'en_US.UTF-8', 05:24:11 INFO - 'LANGUAGE': 'en_US:en', 05:24:11 INFO - 'LOGNAME': 'cltbld', 05:24:11 INFO - 'MAIL': '/var/mail/cltbld', 05:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:11 INFO - 'MOZ_NO_REMOTE': '1', 05:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:11 INFO - 'NO_EM_RESTART': '1', 05:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:11 INFO - 'PWD': '/builds/slave/test', 05:24:11 INFO - 'SHELL': '/bin/bash', 05:24:11 INFO - 'SHLVL': '1', 05:24:11 INFO - 'TERM': 'linux', 05:24:11 INFO - 'TMOUT': '86400', 05:24:11 INFO - 'USER': 'cltbld', 05:24:11 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', 05:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:11 INFO - '_': '/tools/buildbot/bin/python'} 05:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:11 INFO - Running setup.py (path:/tmp/pip-3NgTnw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:11 INFO - Running setup.py (path:/tmp/pip-WcAp8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:12 INFO - Running setup.py (path:/tmp/pip-mR10wN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:12 INFO - Running setup.py (path:/tmp/pip-HtYDsv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:12 INFO - Running setup.py (path:/tmp/pip-sGcZKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:12 INFO - Running setup.py (path:/tmp/pip-IOinkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:12 INFO - Running setup.py (path:/tmp/pip-W2uC8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:12 INFO - Running setup.py (path:/tmp/pip-evBPBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:12 INFO - Running setup.py (path:/tmp/pip-4MkRYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:12 INFO - Running setup.py (path:/tmp/pip-LhmvME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:12 INFO - Running setup.py (path:/tmp/pip-TKpZFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:12 INFO - Running setup.py (path:/tmp/pip-QI1Uah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:12 INFO - Running setup.py (path:/tmp/pip-z6mKTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:12 INFO - Running setup.py (path:/tmp/pip-YroaWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:12 INFO - Running setup.py (path:/tmp/pip-OpN3NT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:12 INFO - Running setup.py (path:/tmp/pip-mdp10Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:13 INFO - Running setup.py (path:/tmp/pip-2Dkgia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:24:13 INFO - Running setup.py install for manifestparser 05:24:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:24:13 INFO - Running setup.py install for mozcrash 05:24:13 INFO - Running setup.py install for mozdebug 05:24:13 INFO - Running setup.py install for mozdevice 05:24:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:24:13 INFO - Running setup.py install for mozfile 05:24:13 INFO - Running setup.py install for mozhttpd 05:24:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:24:13 INFO - Running setup.py install for mozinfo 05:24:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:24:13 INFO - Running setup.py install for mozInstall 05:24:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:24:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:24:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:24:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:24:13 INFO - Running setup.py install for mozleak 05:24:13 INFO - Running setup.py install for mozlog 05:24:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Running setup.py install for moznetwork 05:24:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Running setup.py install for mozprocess 05:24:14 INFO - Running setup.py install for mozprofile 05:24:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Running setup.py install for mozrunner 05:24:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Running setup.py install for mozscreenshot 05:24:14 INFO - Running setup.py install for moztest 05:24:14 INFO - Running setup.py install for mozversion 05:24:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:24:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:24:14 INFO - Cleaning up... 05:24:14 INFO - Return code: 0 05:24:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:14 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')]} 05:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:14 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')]} 05:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:14 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 0x22a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ceb0>, '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 0x260ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e240>, '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': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', '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 05:24:14 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 05:24:14 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 05:24:14 INFO - Using env: {'DISPLAY': ':0', 05:24:14 INFO - 'HOME': '/home/cltbld', 05:24:14 INFO - 'LANG': 'en_US.UTF-8', 05:24:14 INFO - 'LANGUAGE': 'en_US:en', 05:24:14 INFO - 'LOGNAME': 'cltbld', 05:24:14 INFO - 'MAIL': '/var/mail/cltbld', 05:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:14 INFO - 'MOZ_NO_REMOTE': '1', 05:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:14 INFO - 'NO_EM_RESTART': '1', 05:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:14 INFO - 'PWD': '/builds/slave/test', 05:24:14 INFO - 'SHELL': '/bin/bash', 05:24:14 INFO - 'SHLVL': '1', 05:24:14 INFO - 'TERM': 'linux', 05:24:14 INFO - 'TMOUT': '86400', 05:24:14 INFO - 'USER': 'cltbld', 05:24:14 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', 05:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:14 INFO - '_': '/tools/buildbot/bin/python'} 05:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:15 INFO - Running setup.py (path:/tmp/pip-ZrAuMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:15 INFO - Running setup.py (path:/tmp/pip-PgxFm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:15 INFO - Running setup.py (path:/tmp/pip-dKMR90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:15 INFO - Running setup.py (path:/tmp/pip-2WxLnX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:15 INFO - Running setup.py (path:/tmp/pip-SE_rpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:15 INFO - Running setup.py (path:/tmp/pip-370h6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:15 INFO - Running setup.py (path:/tmp/pip-c0IXmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:15 INFO - Running setup.py (path:/tmp/pip-C10KcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:15 INFO - Running setup.py (path:/tmp/pip-LCLzgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:15 INFO - Running setup.py (path:/tmp/pip-gU0dpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:15 INFO - Running setup.py (path:/tmp/pip-re1hbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:15 INFO - Running setup.py (path:/tmp/pip-8M5R9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:15 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)) 05:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:15 INFO - Running setup.py (path:/tmp/pip-HSB9vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:16 INFO - Running setup.py (path:/tmp/pip-viOSnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:16 INFO - Running setup.py (path:/tmp/pip-YzSruX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:16 INFO - Running setup.py (path:/tmp/pip-VC5CqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:16 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)) 05:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:16 INFO - Running setup.py (path:/tmp/pip-2Wltcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:16 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)) 05:24:16 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)) 05:24:16 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)) 05:24:16 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)) 05:24:16 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)) 05:24:16 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)) 05:24:16 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)) 05:24:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:16 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 05:24:16 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 05:24:16 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 05:24:16 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 05:24:17 INFO - Downloading blessings-1.6.tar.gz 05:24:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:24:17 INFO - Installing collected packages: blessings 05:24:17 INFO - Running setup.py install for blessings 05:24:17 INFO - Successfully installed blessings 05:24:17 INFO - Cleaning up... 05:24:17 INFO - Return code: 0 05:24:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:24:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:17 INFO - Reading from file tmpfile_stdout 05:24:17 INFO - Current package versions: 05:24:17 INFO - argparse == 1.2.1 05:24:17 INFO - blessings == 1.6 05:24:17 INFO - blobuploader == 1.2.4 05:24:17 INFO - docopt == 0.6.1 05:24:17 INFO - functools32 == 3.2.3-2 05:24:17 INFO - jsonschema == 2.5.1 05:24:17 INFO - manifestparser == 1.1 05:24:17 INFO - mozInstall == 1.13 05:24:17 INFO - mozcrash == 1.0 05:24:17 INFO - mozdebug == 0.1 05:24:17 INFO - mozdevice == 0.51 05:24:17 INFO - mozfile == 1.2 05:24:17 INFO - mozhttpd == 0.7 05:24:17 INFO - mozinfo == 0.10 05:24:17 INFO - mozleak == 0.1 05:24:17 INFO - mozlog == 3.5 05:24:17 INFO - moznetwork == 0.27 05:24:17 INFO - mozprocess == 0.25 05:24:17 INFO - mozprofile == 0.28 05:24:17 INFO - mozrunner == 6.13 05:24:17 INFO - mozscreenshot == 0.1 05:24:17 INFO - mozsystemmonitor == 0.3 05:24:17 INFO - moztest == 0.8 05:24:17 INFO - mozversion == 1.4 05:24:17 INFO - psutil == 3.1.1 05:24:17 INFO - requests == 1.2.3 05:24:17 INFO - wsgiref == 0.1.2 05:24:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:17 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')]} 05:24:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:17 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')]} 05:24:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:17 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 0x22a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ceb0>, '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 0x260ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e240>, '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': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', '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 05:24:17 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 05:24:17 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 05:24:17 INFO - Using env: {'DISPLAY': ':0', 05:24:17 INFO - 'HOME': '/home/cltbld', 05:24:17 INFO - 'LANG': 'en_US.UTF-8', 05:24:17 INFO - 'LANGUAGE': 'en_US:en', 05:24:17 INFO - 'LOGNAME': 'cltbld', 05:24:17 INFO - 'MAIL': '/var/mail/cltbld', 05:24:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:17 INFO - 'MOZ_NO_REMOTE': '1', 05:24:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:17 INFO - 'NO_EM_RESTART': '1', 05:24:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:17 INFO - 'PWD': '/builds/slave/test', 05:24:17 INFO - 'SHELL': '/bin/bash', 05:24:17 INFO - 'SHLVL': '1', 05:24:17 INFO - 'TERM': 'linux', 05:24:17 INFO - 'TMOUT': '86400', 05:24:17 INFO - 'USER': 'cltbld', 05:24:17 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', 05:24:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:17 INFO - '_': '/tools/buildbot/bin/python'} 05:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:18 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)) 05:24:18 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)) 05:24:18 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)) 05:24:18 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)) 05:24:18 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)) 05:24:18 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)) 05:24:18 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)) 05:24:18 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)) 05:24:18 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)) 05:24:18 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:24:18 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 05:24:18 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 05:24:18 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 05:24:18 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 05:24:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:24:19 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)) 05:24:19 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)) 05:24:19 INFO - Installing collected packages: simplejson 05:24:19 INFO - Running setup.py install for simplejson 05:24:19 INFO - building 'simplejson._speedups' extension 05:24:19 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 05:24:20 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 05:24:20 INFO - Successfully installed simplejson 05:24:20 INFO - Cleaning up... 05:24:20 INFO - Return code: 0 05:24:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:24:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:20 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 0x22a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x260fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ceb0>, '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 0x260ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e240>, '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': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', '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 05:24:20 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 05:24:20 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 05:24:20 INFO - Using env: {'DISPLAY': ':0', 05:24:20 INFO - 'HOME': '/home/cltbld', 05:24:20 INFO - 'LANG': 'en_US.UTF-8', 05:24:20 INFO - 'LANGUAGE': 'en_US:en', 05:24:20 INFO - 'LOGNAME': 'cltbld', 05:24:20 INFO - 'MAIL': '/var/mail/cltbld', 05:24:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:20 INFO - 'MOZ_NO_REMOTE': '1', 05:24:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:20 INFO - 'NO_EM_RESTART': '1', 05:24:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:20 INFO - 'PWD': '/builds/slave/test', 05:24:20 INFO - 'SHELL': '/bin/bash', 05:24:20 INFO - 'SHLVL': '1', 05:24:20 INFO - 'TERM': 'linux', 05:24:20 INFO - 'TMOUT': '86400', 05:24:20 INFO - 'USER': 'cltbld', 05:24:20 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', 05:24:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:20 INFO - '_': '/tools/buildbot/bin/python'} 05:24:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:24:20 INFO - Cleaning up... 05:24:20 INFO - Return code: 0 05:24:20 INFO - Running post-action listener: _resource_record_post_action 05:24:20 INFO - Running post-action listener: _start_resource_monitoring 05:24:20 INFO - Starting resource monitoring. 05:24:20 INFO - [mozharness: 2017-08-08 12:24:20.810246Z] Finished create-virtualenv step (success) 05:24:20 INFO - [mozharness: 2017-08-08 12:24:20.810720Z] Running install step. 05:24:20 INFO - Running pre-action listener: _resource_record_pre_action 05:24:20 INFO - Running main action method: install 05:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:21 INFO - Reading from file tmpfile_stdout 05:24:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:24:21 INFO - Reading from file tmpfile_stdout 05:24:21 INFO - Output received: 05:24:21 INFO - Usage: mozinstall [options] installer 05:24:21 INFO - Options: 05:24:21 INFO - -h, --help show this help message and exit 05:24:21 INFO - -d DEST, --destination=DEST 05:24:21 INFO - Directory to install application into. [default: 05:24:21 INFO - "/builds/slave/test"] 05:24:21 INFO - --app=APP Application being installed. [default: firefox] 05:24:21 INFO - mkdir: /builds/slave/test/build/application 05:24:21 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'] 05:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:24:38 INFO - Reading from file tmpfile_stdout 05:24:38 INFO - Output received: 05:24:38 INFO - /builds/slave/test/build/application/firefox/firefox 05:24:38 INFO - Running post-action listener: _resource_record_post_action 05:24:38 INFO - [mozharness: 2017-08-08 12:24:38.954837Z] Finished install step (success) 05:24:38 INFO - [mozharness: 2017-08-08 12:24:38.955094Z] Running setup-mitmproxy step. 05:24:38 INFO - Running pre-action listener: _resource_record_pre_action 05:24:38 INFO - Running main action method: setup_mitmproxy 05:24:38 INFO - Skipping: mitmproxy is not required 05:24:38 INFO - Running post-action listener: _resource_record_post_action 05:24:38 INFO - [mozharness: 2017-08-08 12:24:38.956363Z] Finished setup-mitmproxy step (success) 05:24:38 INFO - [mozharness: 2017-08-08 12:24:38.956586Z] Running run-tests step. 05:24:38 INFO - Running pre-action listener: _resource_record_pre_action 05:24:38 INFO - Running pre-action listener: _set_gcov_prefix 05:24:38 INFO - Running main action method: run_tests 05:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:24:38 INFO - Python 2.7.3 05:24:38 INFO - Return code: 0 05:24:38 INFO - grabbing minidump binary from tooltool 05:24:38 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')]} 05:24:38 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 0x260ceb0>, '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 0x260ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x260e240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:24:38 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 05:24:38 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 05:24:38 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 05:24:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:24:39 INFO - Return code: 0 05:24:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:24:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:24:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:24:39 INFO - ENV: RUST_BACKTRACE is now 1 05:24:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:24:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:24:39 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/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 05:24:39 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/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --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 05:24:39 INFO - Using env: {'DISPLAY': ':0', 05:24:39 INFO - 'HOME': '/home/cltbld', 05:24:39 INFO - 'LANG': 'en_US.UTF-8', 05:24:39 INFO - 'LANGUAGE': 'en_US:en', 05:24:39 INFO - 'LOGNAME': 'cltbld', 05:24:39 INFO - 'MAIL': '/var/mail/cltbld', 05:24:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:24:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:39 INFO - 'MOZ_NO_REMOTE': '1', 05:24:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:24:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:39 INFO - 'NO_EM_RESTART': '1', 05:24:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:39 INFO - 'PWD': '/builds/slave/test', 05:24:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:24:39 INFO - 'RUST_BACKTRACE': '1', 05:24:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:24:39 INFO - 'SHELL': '/bin/bash', 05:24:39 INFO - 'SHLVL': '1', 05:24:39 INFO - 'TERM': 'linux', 05:24:39 INFO - 'TMOUT': '86400', 05:24:39 INFO - 'USER': 'cltbld', 05:24:39 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516', 05:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:39 INFO - '_': '/tools/buildbot/bin/python'} 05:24:39 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/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 05:24:39 INFO - mozversion application_buildid: 20170808111607 05:24:39 INFO - mozversion application_changeset: 8c7788eda00e4cb4445638bdb7500009cd4cbe59 05:24:39 INFO - mozversion application_display_name: Nightly 05:24:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:24:39 INFO - mozversion application_name: Firefox 05:24:39 INFO - mozversion application_remotingname: firefox 05:24:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:24:39 INFO - mozversion application_vendor: Mozilla 05:24:39 INFO - mozversion application_version: 57.0a1 05:24:39 INFO - mozversion platform_buildid: 20170808111607 05:24:39 INFO - mozversion platform_changeset: 8c7788eda00e4cb4445638bdb7500009cd4cbe59 05:24:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:24:39 INFO - mozversion platform_version: 57.0a1 05:24:39 INFO - using testdate: 1502195079 05:24:39 INFO - actual date: 1502195079 05:24:39 INFO - starting webserver on 'localhost:57808' 05:24:39 INFO - SUITE-START | Running 2 tests 05:24:39 INFO - TEST-START | dromaeo_css 05:24:39 INFO - Initialising browser for dromaeo_css test... 05:24:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57808/getInfo.html -profile /tmp/tmpzogB25/profile 05:24:39 INFO - TEST-INFO | started process 14677 (/builds/slave/test/build/application/firefox/firefox http://localhost:57808/getInfo.html) 05:24:45 INFO - TEST-INFO | 14677: exit 0 05:24:45 INFO - Browser initialized. 05:24:45 INFO - Running cycle 1/1 for dromaeo_css test... 05:24:45 INFO - TEST-INFO | started process 14885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzogB25/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:46 INFO - PID 14885 | 05:24:46 INFO - PID 14885 | (/builds/slave/test/build/application/firefox/firefox:14933): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:24:46 INFO - PID 14885 | 05:24:56 INFO - PID 14885 | RSS: Main: 161402880 05:24:56 INFO - PID 14885 | 05:27:54 INFO - PID 14885 | Cycle 1(1): loaded http://localhost:57808/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57808/tests/dromaeo/cssquery-ext.html) 05:27:55 INFO - PID 14885 | RSS: Main: 166998016 05:27:55 INFO - PID 14885 | 05:30:57 INFO - PID 14885 | Cycle 1(1): loaded http://localhost:57808/tests/dromaeo/cssquery-ext.html (next: http://localhost:57808/tests/dromaeo/cssquery-jquery.html) 05:30:58 INFO - PID 14885 | RSS: Main: 164233216 05:30:58 INFO - PID 14885 | 05:33:59 INFO - PID 14885 | Cycle 1(1): loaded http://localhost:57808/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57808/tests/dromaeo/cssquery-mootools.html) 05:34:00 INFO - PID 14885 | RSS: Main: 166092800 05:34:00 INFO - PID 14885 | 05:37:01 INFO - PID 14885 | Cycle 1(1): loaded http://localhost:57808/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57808/tests/dromaeo/cssquery-prototype.html) 05:37:02 INFO - PID 14885 | RSS: Main: 163528704 05:37:02 INFO - PID 14885 | 05:40:06 INFO - PID 14885 | Cycle 1(1): loaded http://localhost:57808/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57808/tests/dromaeo/cssquery-yui.html) 05:40:06 INFO - PID 14885 | RSS: Main: 167989248 05:40:06 INFO - PID 14885 | 05:43:08 INFO - PID 14885 | Cycle 1(1): loaded http://localhost:57808/tests/dromaeo/cssquery-yui.html (next: http://localhost:57808/tests/dromaeo/cssquery-dojo.html) 05:43:08 INFO - PID 14885 | RSS: Main: 168960000 05:43:08 INFO - PID 14885 | 05:43:08 INFO - PID 14885 | __start_tp_report 05:43:08 INFO - PID 14885 | _x_x_mozilla_page_load 05:43:08 INFO - PID 14885 | _x_x_mozilla_page_load_details 05:43:08 INFO - PID 14885 | |i|pagename|runs| 05:43:08 INFO - PID 14885 | |0;dojo.html;3453.6373680763536;3492.8602855885765;3512.560929883764;3542.43321068629;3573.178169021125;6187.5359348048905;6359.58662686925;6367.968160159205;6371.808845734624;6377.521685873555;6165.660888651122;6185.226846644169;6209.534284928637;6210.316865144841;6275.780347687832;5447.836564903039;5475.288212532365;5478.369987451434;5486.972565137169;5514.476124768141;5503.147012213113;5545.473180047909;5547.25112109864;5590.245316882229;5626.324841019084;5495.972520137394;5512.173174023888;5558.944410555903;5559.388467268597;5622.522085622706;5478.068728316196;5558.86102847428;5620.803271885485;5628.746706398222;5636.408177141403;5344.679319240858;5382.811601593926;5406.83779486616;5499.175123731432;5505.834824955257;6057.606255593372;6090.116933044728;6093.116498107794;6101.267847858241;6167.136600875881;6618.966905165444;6630.900536491957;6696.933030669679;6704.731810727565;6726.630035348054;6861.897071543931;6889.724411023553;6891.931080689179;6897.931020689779;6942.444604431684;6319.715612797435;6362.9045564316575;6371.585846919936;6386.2975072741965;6394.968025159891;6968.477364197604;7000.789976300719;7014.5440546364325;7095.432365410755;7101.254368291255;6637.966810165918;6653.367930046637;6656.36764507371;6682.431993280528;6720.932790672128;6771.966140169267;6772.93227067723;6830.385265326145;6855.245922948472;6856.931430685729;6533.575317604341;6723.596584204964;6737.764178253738;6830.487713421513;6831.2144103427745;6673.1992160941;6694;6741.629210393377;6747.898781518281;6793;4841.471100546386;4900.730459824744;4926.6551341406475;4928;4931.876703082452;4323.048929235563;4330.805113769888;4352.086061926968;4354.976580503642;4367.934480982788;6188.721507532172;6351.777687780906;6410.67946602668;6453.419192272718;6454.903176452357;6789.1852977643;6793.93206067933;6836.965815170893;6862.519623626298;6872.793816185523;6357.141785858942;6380.7128679209545;6444.903326450107;6447.2907980122145;6451.3226111257645;5260.92108618371;5335.439778823245;5341.813036543703;5342.358916929993;5434.538064264502;7123.679434425463;7143.249958754256;7144.714211431485;7146.678399471933;7148.714051437988;6775.71261460321;6777.728890844508;6782.898256526255;6843.520953533205;6868.484863635147;7020.157581090302;7029.859402812018;7101.041359416413;7130.607816570138;7188.964055179691;6739.831504212434;6784.76253331131;6790.830229244309;6794.4904132189295;6794.966025169842;6832.180138383425;6855.383015528626;6859.279775623488;6907.378335949788;6926.445884329342;6447.2263328400895;6579.17760279965;6639.601623902581;6714.496412768965;6747.628880411625;6449.161608990801;6452.161219041494;6461.160049193575;6461.870762584816;6593.406593406617;6516.087747715418;6521.478281737354;6526.869462610816;6538.673066346569;6544.509161812978;6461.903071453838;6503.414692677682;6524.771632993013;6541.280459149394;6553.606783593;6348.77779277723;6369.808905732835;6370.55406121567;6371.139896113966;6407.167068281094 05:43:08 INFO - PID 14885 | |1;ext.html;903.5301643145565;924.6532550293635;944.4144630329197;973.8003709239607;977.5063592885592;45278.09443811126;45855.77072114635;45916.770416147876;46069.30896036562;46278.76860615696;41661.375079373836;41678.58321416785;41963;42020.36969445461;42031.789841050755;6905.482088843344;7015.9298407015785;7017.157941047081;7019.333163349474;7023.0167776511325;6887.862242755142;6954.860902781967;6958.408535274508;6958.65206739661;6959;6865.347791959756;6957.199922008957;6997.300269973013;6997.405220556258;7002.01971723959;6915;6951.443884489228;6958.547694399847;6984.266652001517;6984.546004509691;6361.077643741632;6405.7757978471;6409.230892292955;6411.93588064118;6412.070249813751;37593;37891.62108378908;37896;37966;37989.240215195816;3420.538227339302;3454.602720687103;3459.411899976985;3461.152017755666;3464.6015708193627;29326.85336573325;29332.41335173306;29387.55918661222;29427.705722942927;29429.70570294291;4624.190766615862;4646.744429056401;4649;4653.232216684243;4693.061387722435;213375;217935;217966.91016544975;219010;219953;52394;52682.946341072966;52753.736231318595;52759.472405276225;53921.46078539243;54470.45529544654;54662.72668636632;54840.72579637156;54990.725046375315;55099;14672.046316989361;16472.176391180394;16579.17104144788;16599.336026559045;16605.91697041507;13351.599452016455;13506.797398039038;13513.729725405437;13519.391627376595;13555.525556605471;14712.705745885236;14753.33609987553;14792.92603536997;14840.703185936221;14915.627109322353;5718;5731.220358126306;5769.798057067983;5796.536277097906;5834.795782147605;1047.7060829875097;1079.3092420850662;1081.7241603391242;1082.2045796339685;1102.73534351755;24359.878200608884;24516.38709032253;24674.259772206864;24744.545981723462;24752.648498392624;1187.5724739093919;1190.470240742861;1191.9523219071314;1196.8623608284984;1203.5246077799395;12889.806652900214;13191.40638671262;13280.402381892838;13306.935445164558;13324.933375333061;260660;261900;262976;263080;263285;55014.724926375115;55075.449245507836;55234.447655523734;55455;55569.444305556426;1482.407037185113;1503.88720845937;1510.2146883620676;1538.1617018724821;1555.3156611091083;24128.517429650958;24200;24204.273871783873;24229.636555452034;24278.393040174138;40067;40174.397384038675;40312.59687403088;40333.798331008154;40336.3949540763;220637;221942;222113;222526;224782;35980.820095899355;38520.80739596284;39794;39945.40081898716;39952.800235998635;49021.75489122532;50578;50609.24086138784;50715.74642126766;50863.237051445;36487.27025459423;36554.8172259137;36904.630953691194;37324.81337593294;37346.813265933495;36544;36713;36934.261314773015;37151.256974860895;37391.81304093462;41042.58957410507;41904.79047604743;41905.16189676128;41966.79016604897;42290.788546057076;35115;35261.47107793334;35325.293494130485;35400.291994160485;35514;25844.286349932987;26247.475050499266;26300.21099367022;26762.330941725835;26787.19638410851 05:43:08 INFO - PID 14885 | |2;jquery.html;574.6293640601815;577.4687287695323;578.7193211292525;590.9556783241258;591.5238233222257;22984.77015229847;23274.18540351088;23974.280771576858;24015.75984240157;24043.519129617398;24048.51902961944;24602;24727.75272247277;24750.628740568907;24766.628500572508;6291.1821463209835;6405.935940640604;6412.487001039905;6421.165248517686;6431.646259455728;5911.290645122592;6316.368363163693;6357.364263573651;6414.390632889868;6429.35706429358;6407.327230640785;6409.2949775524885;6412.03819427085;6414.134091897581;6419.03714442835;6355.809325720235;6373.044043393505;6382.36176382358;6399.93600063998;6405.679716014204;5940.821775346746;5953.464188223081;5965.612235204698;5969.074793406985;5990.071538911432;29404.26489337762;30137;30236.848815756;30877;31092.533611995837;2212.7676593957563;2262.751097379287;2262.762409946965;2269.103704036913;2291.3813270416895;20445.182192712422;21044.368668939955;21145.894270528548;21172.682409763867;21187.04658290365;2465.9753402465926;2502.1617758051075;2539.7333280005705;2564.2563656539583;2573.819832611718;161613;167067;167647;167857;167934;15430.382784688487;15698.529044128694;15800.92099539495;16011.199440027953;16371.59071023234;24674.87662561676;24883.62674559883;24931.750682493304;24998.37504062413;25057.248282551554;9753.463559504295;9753.512324383752;9950.40297582133;10070.546825392876;10085.193184545218;8565.357598180162;8721;8743.825123497494;8778.156587116777;8834.55827208637;8715.738527844174;9874.160696340748;9965.053319934595;9988.500574971222;10048.296619236584;2813.2826129336886;2867.569864520339;2878.481873262833;2884.1059271625863;2935.4569404660206;1046.6859942017516;1063.3938654966594;1067.204932325407;1073.9301945373525;1082.8375743638517;21233.78766212318;21534.569308614053;21626.486145969946;21719.56560868774;21949.890250548644;1135.1656532448644;1146.827975803636;1148.115950717959;1148.26511032939;1150.4822829726656;11533.711657208636;11857.822132668018;11906.107041971887;11933.641990740292;11970.700732481757;540109;540180;548789;549358;552181;133001;136742;138311;138964;139320;1231.5258625429094;1269.9047571431995;1288.3493835613142;1290.5934630591335;1292.476546998467;19030.42908712741;19396.612067758848;23060.192893248655;23433.179838705564;23993.16023939154;66833.33166668465;67753.6612316955;68209;68351.65824171047;68613.3138668607;81365.59317203375;82262.58868705618;82463.5876820612;83184.16815832007;83563;13289.867101328862;14014.649633759238;15453.922730386275;15934.282957267184;15969.281382337591;24938.12716554912;25045.12342068019;25239.62140567856;25456.363590910376;25482.490350192522;20036.799632003494;20358.79641203628;20376;20588.176472940915;20589.794102058786;17630.1184940755;17926.372576959744;17939.820601793814;18211.635767284315;18449.354272600394;21201.89399052995;21674.458138546663;21694.45763855853;21704.565908682052;21874.343769686933;15373.308201130752;15429.614259643598;15555.611109722347;15563.84436155624;15671.059736415851;20160.697589535874;20337;20350.694739578623;20408.795912041285;20573.691394629393 05:43:08 INFO - PID 14885 | |3;mootools.html;1426.4650755966513;1496.5136330692521;1513.3492598182784;1519.3770554072833;1527.6486408126138;14626.414943402264;15131.394744210245;15387.692246155084;15398.30707618157;15454.768178477332;15627.843721562782;15972.361105555763;16030.919845400756;16031.83968160318;16054.678906421865;2699.4061306512535;2749.092799376201;2749.202731207957;2750.7936904732223;2761.654793150856;2602.08926875593;2662.7204143564936;2664.3472349274457;2717.3342531079816;2719.809613327058;2718.768904643108;2742.3418379588957;2748.670159580853;2754.380264440505;2754.834709917401;2673.5187666219977;2695.689995650496;2703.5674292113167;2706.580480025589;2712.1999010291815;2564.333273348924;2615.6599642046413;2636.6176904348954;2637.3274814922074;2639.5644718621406;14969.550913472613;15148.091114533163;15251.542453726406;15255.771163432557;15304.311305991147;7972.3622110231045;8235.588220588947;8253.174682531759;8253.752387428387;8267.751967440987;5458.863528411782;5557.694326812024;5600.859978500529;5685.857853553653;5695.515881150107;1896.715492676096;1916.6358391905494;1928.6142771445627;1951.2292644405381;1958.608278344337;26384.0765573204;26430.339241518923;26459.470810583873;26639;26658;7376.926230737624;7431.108267007994;7532.8493430132185;7603.581803000778;7651.273129052731;18075.819241807676;18145.09274536268;18200;18201.817981820277;18244.361447349278;8071.515709057476;8264.752057438287;8290;8290.709825156091;8291.8341633167;7467.626618669045;7589.962050189713;7617.619119044026;7692.692292308245;7707.653155608011;5275.630705850554;5475.753591088411;5484.780608775604;5488.69812160327;5521.3926468088475;1442.5600191941348;1480.3634437191895;1569.670369222476;1573.638063245437;1575.3068649794054;949.9097585729345;967.2793768642406;972.4894430424084;976.2677991506371;986.0927946289288;8829.78246690204;9292.72121836346;9311.767205819773;9322.207612353026;9340.673076442428;759.2407592407592;766.3332900376597;773.7485317271909;774.1987043410044;833.9617176615153;5484.561235101182;5728.570357223225;5772.105323674838;5892.558058145656;5916.940830591639;21189.682154767692;22044.559108817735;22417.775822241896;22715.432114197276;22715.886420567793;22167.556648866932;22300;22418;22517.099316027503;22604.095836166696;11017.504212310465;11643.301401915913;11835.585754498552;12003.459844306852;12111.697207569881;8080.757577272691;8317.376196785144;8320.16798320163;8338.624761885609;8535.06114327411;19313;19319.51701207481;19660.50848728793;19762.308319209333;19821;19696.507587309858;19761.60476790485;19782.90108549448;19876.70184947256;19974.500637483598;11601.767964640829;11839.348835814113;11847.170698051053;11847.822282665938;11851.70370740704;13928.651783705083;13953.790693139814;14137;14199.858001420267;14203.715925681636;10332.431716255378;10391.688249352532;10425.582976681151;10475.790484190122;10733.946330268298;11036.061934735317;11127.610533631609;11164.832527511931;11260.324380537195;11297.774044519228;9926.503674816086;10171.491425428847;10254.230932680228;10364.740881478023;10367.0151335623;7154.570725756471;7187.496875218684;7233.276672332725;7305.269473052652;7315.414766818748;7606.695732170651;7674.808129796576;7705.922940770521;7710.575918324322;7720.266574675396 05:43:08 INFO - PID 14885 | |4;prototype.html;498.4815791576759;507.94347756666116;533.1203514201567;540.2355666731575;541.2584758880334;6134.227450118178;6201.379862013802;6210.596311239767;6292.402221788929;6307.306196318401;5901.5573831962665;6070.726817293222;6082.543809214305;6100.2679678438535;6128.540359473035;4770.332153498513;4779.522047795219;4784.545468180518;4796.616270698353;4813.951860481403;4719.268513380432;4789.640776941726;4790.137775200463;4790.329353890441;4844.781984810675;4818.397700287464;4818.638602104838;4830.565249127578;4830.637702172351;4843.854684359475;4805.975970120145;4813.66304358695;4815.277708343741;4819.421669399694;4822.059698358804;4386.232409328387;4392.363107349448;4393.340998850166;4393.484247934458;4399.802008909607;6055.424734650202;6099.725512351911;6103.115048318014;6106.358832322587;6131.3868613138775;5594;5656.547476201894;5721.599488035839;5800.8839823203725;5805.5065319447895;6547.672616369163;6603.7688680895935;6637;6640;6667;4899.314096026559;4931.161702510546;4941.925871111936;4942.802287908479;4957.3059771632;6787.626680532618;6821.317868213188;6829.385355318045;6854.10896583446;6883.8967415488805;5040.647154699136;5082.771275292621;5090.490950904954;5094.5669618082875;5100.897982040338;5155.561777248976;5175.094358487325;5198.324217851655;5200.557952574073;5228.424873263938;5693.17448969897;5721.342045664802;5724.370319264877;5757.424257574209;5794.188813566104;6572.901406478906;6605.348662834292;6612.636305003271;6613.603183808987;6647.268800431949;1714.2285971312958;1738.2004278031993;1753.7281721333213;1755.4996825904811;1777.5644966983173;1229.299299399334;1240.3860089255877;1241.4847838147248;1262.4571434283162;1270.7267937393506;6193.380661933861;6257.8748425031245;6340.873182536324;6357.96821015892;6361.823062733317;6469.288378278386;6497.675116244169;6541.215054193527;6734.158230221223;6769.356911093439;6196.845078873064;6227.875442491216;6275.901717199563;6284.622922624657;6306.936930630727;3487.8256087195537;3513.9648603514147;3516.40221162403;3528.6294939031545;3566.821658917044;6869.427897493276;6915.75794847188;7006.719731210796;7033.9296607033275;7105.43156547475;6886.8622627548175;6918.965405173042;6929.3070692930305;6944.618046007417;6960.164780226304;7110.608916509642;7111.217766045731;7113.253108423644;7128.394086502705;7129.857402851914;6614.437772789174;6700.688262549413;6784.694688739118;6792.93207067923;6824.829379265359;6565.573237739532;6592.90110648331;6597.60414375139;6639.634820084942;6731.865362692816;6898;7017;7039.366457018688;7043.859122817413;7059.188193357624;5067.239914012927;5086.109930762176;5102.974485127551;5122.308488354024;5135.512126347991;6817.000519771284;6820.147481564804;6832.521723479309;6837.008633748178;6866.965665171642;6395.42441180296;6489.643069631215;6495.382938620824;6559.62179477579;6566.704498297492;6371.267304260069;6452.483801295791;6503.471684154126;6534.215894092739;6548.410643042149;6109.908351374822;6284.591501552384;6371.5221358397375;6386.361363863763;6441.742330306735;6497.5126865484335;6536.575122617015;6541.476681865344;6567.835804104936;6652.83367915806;6287.2140982377205;6319.345874732531;6360.395762402564;6362.650054247061;6377.521685873486 05:43:08 INFO - PID 14885 | |5;yui.html;942.9811403771929;951.1487218939048;975.6195083917273;978.530305453382;979.5200351827605;19125.521861953457;19437.708434373497;19487.512812179684;19922.800771992275;23326.533469330647;21690;22009.66985495219;22096.668549971764;22097.116115355366;22148;1049.559185142242;1085.6308854989302;1091.4597274349208;1091.4870011094772;1091.612477570463;1035.2908257843364;1093.0435868614961;1103.569607852938;1110.7278716714416;1111.5776005118043;1166.8949794518492;1167.7897978363892;1168.415792103948;1169.3510101893446;1170.3387586013916;1159.7390587117957;1159.9768004639943;1160.2748282323548;1160.9535618575246;1160.970975725605;846.9195426434479;852.1052894460853;854.0647990450447;854.8418542569582;855.7603870916154;19872.205111795654;20399.286024989204;20487.590248194952;20588.27941022072;20629.793702062936;22447.21434749776;22462.55074898493;22493.775062249333;22563.774362256332;22957.426064348358;17026.659466810717;17198.570035749082;17283.04943228122;17345;17421.825781742275;3810.2950954073585;3825.9426108608395;3831.3678243089857;3842.4812650292133;3842.903927401809;149794;150837.24581377133;151450.24274878556;152325;153120;16990.830091699172;17039.14804259782;17541.736873946902;17685.646287074444;17701.38045168413;32119;32392.514112288336;32718.345633087203;32751.50872736911;33816;8777.078406767325;9135.954320228357;9136.543172841331;9142.268618510503;9270.490123043162;4579.633629309647;4669.369635099286;4681.297805329228;4686.742229177428;4692.178868697964;5592.189132575835;5607.074832652566;5656.745446454919;5683.175939488751;5699.230603868507;1171.244547267008;1187.4062968515743;1194.8386967759416;1202;1202.1584890576632;711.1430725975291;724.9855002899913;729.5877829026583;737.8598066367481;749.5615065186818;12445.937770311091;13200.405981730653;13433.529826456223;13442.126261792951;13582.93208533951;740.3780824107776;751.7894989402976;753.1489416958801;756.7578374920083;765.7855800375904;6419.903701444482;7028.894566581505;7189.424846012306;7287.161976372679;7419.59192244421;125169.23815333021;129241;129731.45939892247;131047;132285.3385733065;114580.42709786398;116763;118193.40903295428;120187;122760.74293878455;99396.02415903282;100619.49690251502;103005.48497257466;105999.94000060055;106196.46901765597;13975.30123493801;14309.785353219502;14350.641233968816;14354.138751674933;14630.707385852436;46754;47202.29196561986;47826.760866195444;48511.75744121398;48692.513074868795;61608.38391616027;62332;62332.06501902566;63212.68393658186;64866.67566662136;18855.811441885406;20346.18615255373;20818.79181208229;20863.37409877706;21070.367888963356;21821.672674909572;21824.127034918427;21864.45338866541;21878.23426180076;22223.666645000016;20391.4902127448;20646.17415303371;20647.483812904196;20730.48173795667;21070.367888963356;20471.078801453674;20636.17455301771;20957.685634715795;21008;21152.78847211508;20686.17255309771;20739.170433183106;20815.583688326453;20818.58362832765;20902.16391344329;13912;14045.578632641038;14072.78890816659;14181.574552763434;14310.713785724436;15479.458218962282;15625.453109141126;15705.136217508147;15705.68588628244;15851.207439628202 05:43:08 INFO - PID 14885 | __end_tp_report 05:43:08 INFO - PID 14885 | __start_cc_report 05:43:08 INFO - PID 14885 | _x_x_mozilla_cycle_collect,326 05:43:08 INFO - PID 14885 | __end_cc_report 05:43:08 INFO - PID 14885 | __startTimestamp1502196188444__endTimestamp 05:43:08 INFO - PID 14885 | 05:43:08 INFO - PID 14885 | ------- Summary: start ------- 05:43:08 INFO - PID 14885 | Number of tests: 6 05:43:08 INFO - PID 14885 | 05:43:08 INFO - PID 14885 | [#0] dojo.html Cycles:165 Average:6216.19 Median:6454.90 stddev:817.36 (12.7%) stddev-sans-first:790.61 05:43:08 INFO - PID 14885 | Values: 3453.6 3492.9 3512.6 3542.4 3573.2 6187.5 6359.6 6368.0 6371.8 6377.5 6165.7 6185.2 6209.5 6210.3 6275.8 5447.8 5475.3 5478.4 5487.0 5514.5 5503.1 5545.5 5547.3 5590.2 5626.3 5496.0 5512.2 5558.9 5559.4 5622.5 5478.1 5558.9 5620.8 5628.7 5636.4 5344.7 5382.8 5406.8 5499.2 5505.8 6057.6 6090.1 6093.1 6101.3 6167.1 6619.0 6630.9 6696.9 6704.7 6726.6 6861.9 6889.7 6891.9 6897.9 6942.4 6319.7 6362.9 6371.6 6386.3 6395.0 6968.5 7000.8 7014.5 7095.4 7101.3 6638.0 6653.4 6656.4 6682.4 6720.9 6772.0 6772.9 6830.4 6855.2 6856.9 6533.6 6723.6 6737.8 6830.5 6831.2 6673.2 6694.0 6741.6 6747.9 6793.0 4841.5 4900.7 4926.7 4928.0 4931.9 4323.0 4330.8 4352.1 4355.0 4367.9 6188.7 6351.8 6410.7 6453.4 6454.9 6789.2 6793.9 6837.0 6862.5 6872.8 6357.1 6380.7 6444.9 6447.3 6451.3 5260.9 5335.4 5341.8 5342.4 5434.5 7123.7 7143.2 7144.7 7146.7 7148.7 6775.7 6777.7 6782.9 6843.5 6868.5 7020.2 7029.9 7101.0 7130.6 7189.0 6739.8 6784.8 6790.8 6794.5 6795.0 6832.2 6855.4 6859.3 6907.4 6926.4 6447.2 6579.2 6639.6 6714.5 6747.6 6449.2 6452.2 6461.2 6461.9 6593.4 6516.1 6521.5 6526.9 6538.7 6544.5 6461.9 6503.4 6524.8 6541.3 6553.6 6348.8 6369.8 6370.6 6371.1 6407.2 05:43:08 INFO - PID 14885 | 05:43:08 INFO - PID 14885 | [#1] ext.html Cycles:180 Average:41295.15 Median:37492.41 stddev:61119.25 (163.0%) stddev-sans-first:61215.45 05:43:08 INFO - PID 14885 | Values: 903.5 924.7 944.4 973.8 977.5 45278.1 45855.8 45916.8 46069.3 46278.8 41661.4 41678.6 41963.0 42020.4 42031.8 6905.5 7015.9 7017.2 7019.3 7023.0 6887.9 6954.9 6958.4 6958.7 6959.0 6865.3 6957.2 6997.3 6997.4 7002.0 6915.0 6951.4 6958.5 6984.3 6984.5 6361.1 6405.8 6409.2 6411.9 6412.1 37593.0 37891.6 37896.0 37966.0 37989.2 3420.5 3454.6 3459.4 3461.2 3464.6 29326.9 29332.4 29387.6 29427.7 29429.7 4624.2 4646.7 4649.0 4653.2 4693.1 213375.0 217935.0 217966.9 219010.0 219953.0 52394.0 52682.9 52753.7 52759.5 53921.5 54470.5 54662.7 54840.7 54990.7 55099.0 14672.0 16472.2 16579.2 16599.3 16605.9 13351.6 13506.8 13513.7 13519.4 13555.5 14712.7 14753.3 14792.9 14840.7 14915.6 5718.0 5731.2 5769.8 5796.5 5834.8 1047.7 1079.3 1081.7 1082.2 1102.7 24359.9 24516.4 24674.3 24744.5 24752.6 1187.6 1190.5 1192.0 1196.9 1203.5 12889.8 13191.4 13280.4 13306.9 13324.9 260660.0 261900.0 262976.0 263080.0 263285.0 55014.7 55075.4 55234.4 55455.0 55569.4 1482.4 1503.9 1510.2 1538.2 1555.3 24128.5 24200.0 24204.3 24229.6 24278.4 40067.0 40174.4 40312.6 40333.8 40336.4 220637.0 221942.0 222113.0 222526.0 224782.0 35980.8 38520.8 39794.0 39945.4 39952.8 49021.8 50578.0 50609.2 50715.7 50863.2 36487.3 36554.8 36904.6 37324.8 37346.8 36544.0 36713.0 36934.3 37151.3 37391.8 41042.6 41904.8 41905.2 41966.8 42290.8 35115.0 35261.5 35325.3 35400.3 35514.0 25844.3 26247.5 26300.2 26762.3 26787.2 05:43:08 INFO - PID 14885 | 05:43:08 INFO - PID 14885 | [#2] jquery.html Cycles:180 Average:38988.09 Median:24004.46 stddev:92941.04 (387.2%) stddev-sans-first:93157.01 05:43:08 INFO - PID 14885 | Values: 574.6 577.5 578.7 591.0 591.5 22984.8 23274.2 23974.3 24015.8 24043.5 24048.5 24602.0 24727.8 24750.6 24766.6 6291.2 6405.9 6412.5 6421.2 6431.6 5911.3 6316.4 6357.4 6414.4 6429.4 6407.3 6409.3 6412.0 6414.1 6419.0 6355.8 6373.0 6382.4 6399.9 6405.7 5940.8 5953.5 5965.6 5969.1 5990.1 29404.3 30137.0 30236.8 30877.0 31092.5 2212.8 2262.8 2262.8 2269.1 2291.4 20445.2 21044.4 21145.9 21172.7 21187.0 2466.0 2502.2 2539.7 2564.3 2573.8 161613.0 167067.0 167647.0 167857.0 167934.0 15430.4 15698.5 15800.9 16011.2 16371.6 24674.9 24883.6 24931.8 24998.4 25057.2 9753.5 9753.5 9950.4 10070.5 10085.2 8565.4 8721.0 8743.8 8778.2 8834.6 8715.7 9874.2 9965.1 9988.5 10048.3 2813.3 2867.6 2878.5 2884.1 2935.5 1046.7 1063.4 1067.2 1073.9 1082.8 21233.8 21534.6 21626.5 21719.6 21949.9 1135.2 1146.8 1148.1 1148.3 1150.5 11533.7 11857.8 11906.1 11933.6 11970.7 540109.0 540180.0 548789.0 549358.0 552181.0 133001.0 136742.0 138311.0 138964.0 139320.0 1231.5 1269.9 1288.3 1290.6 1292.5 19030.4 19396.6 23060.2 23433.2 23993.2 66833.3 67753.7 68209.0 68351.7 68613.3 81365.6 82262.6 82463.6 83184.2 83563.0 13289.9 14014.6 15453.9 15934.3 15969.3 24938.1 25045.1 25239.6 25456.4 25482.5 20036.8 20358.8 20376.0 20588.2 20589.8 17630.1 17926.4 17939.8 18211.6 18449.4 21201.9 21674.5 21694.5 21704.6 21874.3 15373.3 15429.6 15555.6 15563.8 15671.1 20160.7 20337.0 20350.7 20408.8 20573.7 05:43:08 INFO - PID 14885 | 05:43:08 INFO - PID 14885 | [#3] mootools.html Cycles:180 Average:9597.87 Median:14534.95 stddev:6839.63 (47.1%) stddev-sans-first:6831.27 05:43:08 INFO - PID 14885 | Values: 1426.5 1496.5 1513.3 1519.4 1527.6 14626.4 15131.4 15387.7 15398.3 15454.8 15627.8 15972.4 16030.9 16031.8 16054.7 2699.4 2749.1 2749.2 2750.8 2761.7 2602.1 2662.7 2664.3 2717.3 2719.8 2718.8 2742.3 2748.7 2754.4 2754.8 2673.5 2695.7 2703.6 2706.6 2712.2 2564.3 2615.7 2636.6 2637.3 2639.6 14969.6 15148.1 15251.5 15255.8 15304.3 7972.4 8235.6 8253.2 8253.8 8267.8 5458.9 5557.7 5600.9 5685.9 5695.5 1896.7 1916.6 1928.6 1951.2 1958.6 26384.1 26430.3 26459.5 26639.0 26658.0 7376.9 7431.1 7532.8 7603.6 7651.3 18075.8 18145.1 18200.0 18201.8 18244.4 8071.5 8264.8 8290.0 8290.7 8291.8 7467.6 7590.0 7617.6 7692.7 7707.7 5275.6 5475.8 5484.8 5488.7 5521.4 1442.6 1480.4 1569.7 1573.6 1575.3 949.9 967.3 972.5 976.3 986.1 8829.8 9292.7 9311.8 9322.2 9340.7 759.2 766.3 773.7 774.2 834.0 5484.6 5728.6 5772.1 5892.6 5916.9 21189.7 22044.6 22417.8 22715.4 22715.9 22167.6 22300.0 22418.0 22517.1 22604.1 11017.5 11643.3 11835.6 12003.5 12111.7 8080.8 8317.4 8320.2 8338.6 8535.1 19313.0 19319.5 19660.5 19762.3 19821.0 19696.5 19761.6 19782.9 19876.7 19974.5 11601.8 11839.3 11847.2 11847.8 11851.7 13928.7 13953.8 14137.0 14199.9 14203.7 10332.4 10391.7 10425.6 10475.8 10733.9 11036.1 11127.6 11164.8 11260.3 11297.8 9926.5 10171.5 10254.2 10364.7 10367.0 7154.6 7187.5 7233.3 7305.3 7315.4 7606.7 7674.8 7705.9 7710.6 7720.3 05:43:08 INFO - PID 14885 | 05:43:08 INFO - PID 14885 | [#4] prototype.html Cycles:180 Average:5569.02 Median:6219.24 stddev:1593.20 (25.6%) stddev-sans-first:1551.55 05:43:08 INFO - PID 14885 | Values: 498.5 507.9 533.1 540.2 541.3 6134.2 6201.4 6210.6 6292.4 6307.3 5901.6 6070.7 6082.5 6100.3 6128.5 4770.3 4779.5 4784.5 4796.6 4814.0 4719.3 4789.6 4790.1 4790.3 4844.8 4818.4 4818.6 4830.6 4830.6 4843.9 4806.0 4813.7 4815.3 4819.4 4822.1 4386.2 4392.4 4393.3 4393.5 4399.8 6055.4 6099.7 6103.1 6106.4 6131.4 5594.0 5656.5 5721.6 5800.9 5805.5 6547.7 6603.8 6637.0 6640.0 6667.0 4899.3 4931.2 4941.9 4942.8 4957.3 6787.6 6821.3 6829.4 6854.1 6883.9 5040.6 5082.8 5090.5 5094.6 5100.9 5155.6 5175.1 5198.3 5200.6 5228.4 5693.2 5721.3 5724.4 5757.4 5794.2 6572.9 6605.3 6612.6 6613.6 6647.3 1714.2 1738.2 1753.7 1755.5 1777.6 1229.3 1240.4 1241.5 1262.5 1270.7 6193.4 6257.9 6340.9 6358.0 6361.8 6469.3 6497.7 6541.2 6734.2 6769.4 6196.8 6227.9 6275.9 6284.6 6306.9 3487.8 3514.0 3516.4 3528.6 3566.8 6869.4 6915.8 7006.7 7033.9 7105.4 6886.9 6919.0 6929.3 6944.6 6960.2 7110.6 7111.2 7113.3 7128.4 7129.9 6614.4 6700.7 6784.7 6792.9 6824.8 6565.6 6592.9 6597.6 6639.6 6731.9 6898.0 7017.0 7039.4 7043.9 7059.2 5067.2 5086.1 5103.0 5122.3 5135.5 6817.0 6820.1 6832.5 6837.0 6867.0 6395.4 6489.6 6495.4 6559.6 6566.7 6371.3 6452.5 6503.5 6534.2 6548.4 6109.9 6284.6 6371.5 6386.4 6441.7 6497.5 6536.6 6541.5 6567.8 6652.8 6287.2 6319.3 6360.4 6362.7 6377.5 05:43:08 INFO - PID 14885 | 05:43:08 INFO - PID 14885 | [#5] yui.html Cycles:180 Average:26864.77 Median:20708.33 stddev:37886.55 (183.0%) stddev-sans-first:37942.83 05:43:08 INFO - PID 14885 | Values: 943.0 951.1 975.6 978.5 979.5 19125.5 19437.7 19487.5 19922.8 23326.5 21690.0 22009.7 22096.7 22097.1 22148.0 1049.6 1085.6 1091.5 1091.5 1091.6 1035.3 1093.0 1103.6 1110.7 1111.6 1166.9 1167.8 1168.4 1169.4 1170.3 1159.7 1160.0 1160.3 1161.0 1161.0 846.9 852.1 854.1 854.8 855.8 19872.2 20399.3 20487.6 20588.3 20629.8 22447.2 22462.6 22493.8 22563.8 22957.4 17026.7 17198.6 17283.0 17345.0 17421.8 3810.3 3825.9 3831.4 3842.5 3842.9 149794.0 150837.2 151450.2 152325.0 153120.0 16990.8 17039.1 17541.7 17685.6 17701.4 32119.0 32392.5 32718.3 32751.5 33816.0 8777.1 9136.0 9136.5 9142.3 9270.5 4579.6 4669.4 4681.3 4686.7 4692.2 5592.2 5607.1 5656.7 5683.2 5699.2 1171.2 1187.4 1194.8 1202.0 1202.2 711.1 725.0 729.6 737.9 749.6 12445.9 13200.4 13433.5 13442.1 13582.9 740.4 751.8 753.1 756.8 765.8 6419.9 7028.9 7189.4 7287.2 7419.6 125169.2 129241.0 129731.5 131047.0 132285.3 114580.4 116763.0 118193.4 120187.0 122760.7 99396.0 100619.5 103005.5 105999.9 106196.5 13975.3 14309.8 14350.6 14354.1 14630.7 46754.0 47202.3 47826.8 48511.8 48692.5 61608.4 62332.0 62332.1 63212.7 64866.7 18855.8 20346.2 20818.8 20863.4 21070.4 21821.7 21824.1 21864.5 21878.2 22223.7 20391.5 20646.2 20647.5 20730.5 21070.4 20471.1 20636.2 20957.7 21008.0 21152.8 20686.2 20739.2 20815.6 20818.6 20902.2 13912.0 14045.6 14072.8 14181.6 14310.7 15479.5 15625.5 15705.1 15705.7 15851.2 05:43:08 INFO - PID 14885 | -------- Summary: end -------- 05:43:08 INFO - PID 14885 | 05:43:09 INFO - TEST-INFO | 14885: exit 0 05:43:09 INFO - TEST-OK | dromaeo_css | took 1109872ms 05:43:09 INFO - TEST-START | kraken 05:43:09 INFO - Initialising browser for kraken test... 05:43:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57808/getInfo.html -profile /tmp/tmpsuYJua/profile 05:43:09 INFO - TEST-INFO | started process 15249 (/builds/slave/test/build/application/firefox/firefox http://localhost:57808/getInfo.html) 05:43:14 INFO - TEST-INFO | 15249: exit 0 05:43:15 INFO - Browser initialized. 05:43:15 INFO - Running cycle 1/1 for kraken test... 05:43:15 INFO - TEST-INFO | started process 15460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsuYJua/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:43:15 INFO - PID 15460 | 05:43:15 INFO - PID 15460 | (/builds/slave/test/build/application/firefox/firefox:15509): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 05:43:15 INFO - PID 15460 | 05:43:26 INFO - PID 15460 | RSS: Main: 165007360 05:43:26 INFO - PID 15460 | 05:43:28 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57808/tests/kraken/driver.html?testName=audio-beat-detection) 05:43:29 INFO - PID 15460 | RSS: Main: 168804352 05:43:29 INFO - PID 15460 | 05:43:32 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57808/tests/kraken/driver.html?testName=audio-dft) 05:43:32 INFO - PID 15460 | RSS: Main: 169213952 05:43:32 INFO - PID 15460 | 05:43:35 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57808/tests/kraken/driver.html?testName=audio-fft) 05:43:36 INFO - PID 15460 | RSS: Main: 163323904 05:43:36 INFO - PID 15460 | 05:43:38 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57808/tests/kraken/driver.html?testName=audio-oscillator) 05:43:39 INFO - PID 15460 | RSS: Main: 164569088 05:43:39 INFO - PID 15460 | 05:43:41 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57808/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:43:41 INFO - PID 15460 | RSS: Main: 164859904 05:43:41 INFO - PID 15460 | 05:43:44 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57808/tests/kraken/driver.html?testName=imaging-darkroom) 05:43:45 INFO - PID 15460 | RSS: Main: 167968768 05:43:45 INFO - PID 15460 | 05:43:49 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57808/tests/kraken/driver.html?testName=imaging-desaturate) 05:43:49 INFO - PID 15460 | RSS: Main: 170119168 05:43:49 INFO - PID 15460 | 05:43:52 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57808/tests/kraken/driver.html?testName=json-parse-financial) 05:43:53 INFO - PID 15460 | RSS: Main: 168710144 05:43:53 INFO - PID 15460 | 05:43:54 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57808/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:43:55 INFO - PID 15460 | RSS: Main: 168058880 05:43:55 INFO - PID 15460 | 05:43:56 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:43:57 INFO - PID 15460 | RSS: Main: 168341504 05:43:57 INFO - PID 15460 | 05:43:59 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:44:00 INFO - PID 15460 | RSS: Main: 165548032 05:44:00 INFO - PID 15460 | 05:44:02 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:44:03 INFO - PID 15460 | RSS: Main: 165085184 05:44:03 INFO - PID 15460 | 05:44:06 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:44:06 INFO - PID 15460 | RSS: Main: 165715968 05:44:06 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | Cycle 1(1): loaded http://localhost:57808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57808/tests/kraken/driver.html?testName=ai-astar) 05:44:08 INFO - PID 15460 | RSS: Main: 167886848 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | __start_tp_report 05:44:08 INFO - PID 15460 | _x_x_mozilla_page_load 05:44:08 INFO - PID 15460 | _x_x_mozilla_page_load_details 05:44:08 INFO - PID 15460 | |i|pagename|runs| 05:44:08 INFO - PID 15460 | |0;ai-astar;101;107;93;108;107;108;111;105;106;107 05:44:08 INFO - PID 15460 | |1;audio-beat-detection;141;118;133;163;117;150;138;129;166;118 05:44:08 INFO - PID 15460 | |2;audio-dft;162;164;161;163;170;161;160;161;170;166 05:44:08 INFO - PID 15460 | |3;audio-fft;75;75;74;180;75;76;75;90;100;76 05:44:08 INFO - PID 15460 | |4;audio-oscillator;79;78;143;77;78;78;138;78;81;130 05:44:08 INFO - PID 15460 | |5;imaging-gaussian-blur;114;114;113;114;114;114;113;115;114;114 05:44:08 INFO - PID 15460 | |6;imaging-darkroom;147;148;148;147;147;147;148;148;148;148 05:44:08 INFO - PID 15460 | |7;imaging-desaturate;94;95;93;94;94;94;94;94;94;94 05:44:08 INFO - PID 15460 | |8;json-parse-financial;48;58;48;47;49;48;51;50;48;48 05:44:08 INFO - PID 15460 | |9;json-stringify-tinderbox;55;54;54;54;54;57;58;54;53;54 05:44:08 INFO - PID 15460 | |10;stanford-crypto-aes;74;75;77;76;78;74;74;76;75;73 05:44:08 INFO - PID 15460 | |11;stanford-crypto-ccm;122;116;117;118;123;120;117;125;117;161 05:44:08 INFO - PID 15460 | |12;stanford-crypto-pbkdf2;187;165;159;167;167;169;172;164;167;163 05:44:08 INFO - PID 15460 | |13;stanford-crypto-sha256-iterative;63;62;63;60;60;63;63;60;63;62 05:44:08 INFO - PID 15460 | __end_tp_report 05:44:08 INFO - PID 15460 | __start_cc_report 05:44:08 INFO - PID 15460 | _x_x_mozilla_cycle_collect,848 05:44:08 INFO - PID 15460 | __end_cc_report 05:44:08 INFO - PID 15460 | __startTimestamp1502196248886__endTimestamp 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | ------- Summary: start ------- 05:44:08 INFO - PID 15460 | Number of tests: 14 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#0] ai-astar Cycles:10 Average:105.30 Median:107.50 stddev:5.01 (4.7%) stddev-sans-first:5.07 05:44:08 INFO - PID 15460 | Values: 101.0 107.0 93.0 108.0 107.0 108.0 111.0 105.0 106.0 107.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:139.50 stddev:17.96 (12.9%) stddev-sans-first:19.00 05:44:08 INFO - PID 15460 | Values: 141.0 118.0 133.0 163.0 117.0 150.0 138.0 129.0 166.0 118.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.50 stddev:3.71 (2.3%) stddev-sans-first:3.87 05:44:08 INFO - PID 15460 | Values: 162.0 164.0 161.0 163.0 170.0 161.0 160.0 161.0 170.0 166.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#3] audio-fft Cycles:10 Average:89.60 Median:75.00 stddev:32.91 (43.9%) stddev-sans-first:34.48 05:44:08 INFO - PID 15460 | Values: 75.0 75.0 74.0 180.0 75.0 76.0 75.0 90.0 100.0 76.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:78.00 stddev:28.48 (36.5%) stddev-sans-first:29.54 05:44:08 INFO - PID 15460 | Values: 79.0 78.0 143.0 77.0 78.0 78.0 138.0 78.0 81.0 130.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:44:08 INFO - PID 15460 | Values: 114.0 114.0 113.0 114.0 114.0 114.0 113.0 115.0 114.0 114.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.52 (0.3%) stddev-sans-first:0.50 05:44:08 INFO - PID 15460 | Values: 147.0 148.0 148.0 147.0 147.0 147.0 148.0 148.0 148.0 148.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 05:44:08 INFO - PID 15460 | Values: 94.0 95.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:48.50 stddev:3.21 (6.6%) stddev-sans-first:3.35 05:44:08 INFO - PID 15460 | Values: 48.0 58.0 48.0 47.0 49.0 48.0 51.0 50.0 48.0 48.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:54.00 stddev:1.57 (2.9%) stddev-sans-first:1.66 05:44:08 INFO - PID 15460 | Values: 55.0 54.0 54.0 54.0 54.0 57.0 58.0 54.0 53.0 54.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#10] stanford-crypto-aes Cycles:10 Average:75.20 Median:75.50 stddev:1.55 (2.1%) stddev-sans-first:1.58 05:44:08 INFO - PID 15460 | Values: 74.0 75.0 77.0 76.0 78.0 74.0 74.0 76.0 75.0 73.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:121.00 stddev:13.48 (11.1%) stddev-sans-first:14.29 05:44:08 INFO - PID 15460 | Values: 122.0 116.0 117.0 118.0 123.0 120.0 117.0 125.0 117.0 161.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:167.00 stddev:7.54 (4.5%) stddev-sans-first:3.72 05:44:08 INFO - PID 15460 | Values: 187.0 165.0 159.0 167.0 167.0 169.0 172.0 164.0 167.0 163.0 05:44:08 INFO - PID 15460 | 05:44:08 INFO - PID 15460 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:63.00 stddev:1.37 (2.2%) stddev-sans-first:1.39 05:44:08 INFO - PID 15460 | Values: 63.0 62.0 63.0 60.0 60.0 63.0 63.0 60.0 63.0 62.0 05:44:08 INFO - PID 15460 | -------- Summary: end -------- 05:44:08 INFO - PID 15460 | 05:44:09 INFO - PID 15460 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:44:09 INFO - TEST-INFO | 15460: exit 0 05:44:09 INFO - TEST-OK | kraken | took 60330ms 05:44:09 INFO - SUITE-END | took 1170s 05:44:09 INFO - Completed test suite (00:19:30) 05:44:09 INFO - javascript benchmark 05:44:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8891.076090142624, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3453.6373680763536, 3492.8602855885765, 3512.560929883764, 3542.43321068629, 3573.178169021125, 6187.5359348048905, 6359.58662686925, 6367.968160159205, 6371.808845734624, 6377.521685873555, 6165.660888651122, 6185.226846644169, 6209.534284928637, 6210.316865144841, 6275.780347687832, 5447.836564903039, 5475.288212532365, 5478.369987451434, 5486.972565137169, 5514.476124768141, 5503.147012213113, 5545.473180047909, 5547.25112109864, 5590.245316882229, 5626.324841019084, 5495.972520137394, 5512.173174023888, 5558.944410555903, 5559.388467268597, 5622.522085622706, 5478.068728316196, 5558.86102847428, 5620.803271885485, 5628.746706398222, 5636.408177141403, 5344.679319240858, 5382.811601593926, 5406.83779486616, 5499.175123731432, 5505.834824955257, 6057.606255593372, 6090.116933044728, 6093.116498107794, 6101.267847858241, 6167.136600875881, 6618.966905165444, 6630.900536491957, 6696.933030669679, 6704.731810727565, 6726.630035348054, 6861.897071543931, 6889.724411023553, 6891.931080689179, 6897.931020689779, 6942.444604431684, 6319.715612797435, 6362.9045564316575, 6371.585846919936, 6386.2975072741965, 6394.968025159891, 6968.477364197604, 7000.789976300719, 7014.5440546364325, 7095.432365410755, 7101.254368291255, 6637.966810165918, 6653.367930046637, 6656.36764507371, 6682.431993280528, 6720.932790672128, 6771.966140169267, 6772.93227067723, 6830.385265326145, 6855.245922948472, 6856.931430685729, 6533.575317604341, 6723.596584204964, 6737.764178253738, 6830.487713421513, 6831.2144103427745, 6673.1992160941, 6694.0, 6741.629210393377, 6747.898781518281, 6793.0, 4841.471100546386, 4900.730459824744, 4926.6551341406475, 4928.0, 4931.876703082452, 4323.048929235563, 4330.805113769888, 4352.086061926968, 4354.976580503642, 4367.934480982788, 6188.721507532172, 6351.777687780906, 6410.67946602668, 6453.419192272718, 6454.903176452357, 6789.1852977643, 6793.93206067933, 6836.965815170893, 6862.519623626298, 6872.793816185523, 6357.141785858942, 6380.7128679209545, 6444.903326450107, 6447.2907980122145, 6451.3226111257645, 5260.92108618371, 5335.439778823245, 5341.813036543703, 5342.358916929993, 5434.538064264502, 7123.679434425463, 7143.249958754256, 7144.714211431485, 7146.678399471933, 7148.714051437988, 6775.71261460321, 6777.728890844508, 6782.898256526255, 6843.520953533205, 6868.484863635147, 7020.157581090302, 7029.859402812018, 7101.041359416413, 7130.607816570138, 7188.964055179691, 6739.831504212434, 6784.76253331131, 6790.830229244309, 6794.4904132189295, 6794.966025169842, 6832.180138383425, 6855.383015528626, 6859.279775623488, 6907.378335949788, 6926.445884329342, 6447.2263328400895, 6579.17760279965, 6639.601623902581, 6714.496412768965, 6747.628880411625, 6449.161608990801, 6452.161219041494, 6461.160049193575, 6461.870762584816, 6593.406593406617, 6516.087747715418, 6521.478281737354, 6526.869462610816, 6538.673066346569, 6544.509161812978, 6461.903071453838, 6503.414692677682, 6524.771632993013, 6541.280459149394, 6553.606783593, 6348.77779277723, 6369.808905732835, 6370.55406121567, 6371.139896113966, 6407.167068281094], "value": 6152.938655595043, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.5301643145565, 924.6532550293635, 944.4144630329197, 973.8003709239607, 977.5063592885592, 45278.09443811126, 45855.77072114635, 45916.770416147876, 46069.30896036562, 46278.76860615696, 41661.375079373836, 41678.58321416785, 41963.0, 42020.36969445461, 42031.789841050755, 6905.482088843344, 7015.9298407015785, 7017.157941047081, 7019.333163349474, 7023.0167776511325, 6887.862242755142, 6954.860902781967, 6958.408535274508, 6958.65206739661, 6959.0, 6865.347791959756, 6957.199922008957, 6997.300269973013, 6997.405220556258, 7002.01971723959, 6915.0, 6951.443884489228, 6958.547694399847, 6984.266652001517, 6984.546004509691, 6361.077643741632, 6405.7757978471, 6409.230892292955, 6411.93588064118, 6412.070249813751, 37593.0, 37891.62108378908, 37896.0, 37966.0, 37989.240215195816, 3420.538227339302, 3454.602720687103, 3459.411899976985, 3461.152017755666, 3464.6015708193627, 29326.85336573325, 29332.41335173306, 29387.55918661222, 29427.705722942927, 29429.70570294291, 4624.190766615862, 4646.744429056401, 4649.0, 4653.232216684243, 4693.061387722435, 213375.0, 217935.0, 217966.91016544975, 219010.0, 219953.0, 52394.0, 52682.946341072966, 52753.736231318595, 52759.472405276225, 53921.46078539243, 54470.45529544654, 54662.72668636632, 54840.72579637156, 54990.725046375315, 55099.0, 14672.046316989361, 16472.176391180394, 16579.17104144788, 16599.336026559045, 16605.91697041507, 13351.599452016455, 13506.797398039038, 13513.729725405437, 13519.391627376595, 13555.525556605471, 14712.705745885236, 14753.33609987553, 14792.92603536997, 14840.703185936221, 14915.627109322353, 5718.0, 5731.220358126306, 5769.798057067983, 5796.536277097906, 5834.795782147605, 1047.7060829875097, 1079.3092420850662, 1081.7241603391242, 1082.2045796339685, 1102.73534351755, 24359.878200608884, 24516.38709032253, 24674.259772206864, 24744.545981723462, 24752.648498392624, 1187.5724739093919, 1190.470240742861, 1191.9523219071314, 1196.8623608284984, 1203.5246077799395, 12889.806652900214, 13191.40638671262, 13280.402381892838, 13306.935445164558, 13324.933375333061, 260660.0, 261900.0, 262976.0, 263080.0, 263285.0, 55014.724926375115, 55075.449245507836, 55234.447655523734, 55455.0, 55569.444305556426, 1482.407037185113, 1503.88720845937, 1510.2146883620676, 1538.1617018724821, 1555.3156611091083, 24128.517429650958, 24200.0, 24204.273871783873, 24229.636555452034, 24278.393040174138, 40067.0, 40174.397384038675, 40312.59687403088, 40333.798331008154, 40336.3949540763, 220637.0, 221942.0, 222113.0, 222526.0, 224782.0, 35980.820095899355, 38520.80739596284, 39794.0, 39945.40081898716, 39952.800235998635, 49021.75489122532, 50578.0, 50609.24086138784, 50715.74642126766, 50863.237051445, 36487.27025459423, 36554.8172259137, 36904.630953691194, 37324.81337593294, 37346.813265933495, 36544.0, 36713.0, 36934.261314773015, 37151.256974860895, 37391.81304093462, 41042.58957410507, 41904.79047604743, 41905.16189676128, 41966.79016604897, 42290.788546057076, 35115.0, 35261.47107793334, 35325.293494130485, 35400.291994160485, 35514.0, 25844.286349932987, 26247.475050499266, 26300.21099367022, 26762.330941725835, 26787.19638410851], "value": 17872.36930602962, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.6293640601815, 577.4687287695323, 578.7193211292525, 590.9556783241258, 591.5238233222257, 22984.77015229847, 23274.18540351088, 23974.280771576858, 24015.75984240157, 24043.519129617398, 24048.51902961944, 24602.0, 24727.75272247277, 24750.628740568907, 24766.628500572508, 6291.1821463209835, 6405.935940640604, 6412.487001039905, 6421.165248517686, 6431.646259455728, 5911.290645122592, 6316.368363163693, 6357.364263573651, 6414.390632889868, 6429.35706429358, 6407.327230640785, 6409.2949775524885, 6412.03819427085, 6414.134091897581, 6419.03714442835, 6355.809325720235, 6373.044043393505, 6382.36176382358, 6399.93600063998, 6405.679716014204, 5940.821775346746, 5953.464188223081, 5965.612235204698, 5969.074793406985, 5990.071538911432, 29404.26489337762, 30137.0, 30236.848815756, 30877.0, 31092.533611995837, 2212.7676593957563, 2262.751097379287, 2262.762409946965, 2269.103704036913, 2291.3813270416895, 20445.182192712422, 21044.368668939955, 21145.894270528548, 21172.682409763867, 21187.04658290365, 2465.9753402465926, 2502.1617758051075, 2539.7333280005705, 2564.2563656539583, 2573.819832611718, 161613.0, 167067.0, 167647.0, 167857.0, 167934.0, 15430.382784688487, 15698.529044128694, 15800.92099539495, 16011.199440027953, 16371.59071023234, 24674.87662561676, 24883.62674559883, 24931.750682493304, 24998.37504062413, 25057.248282551554, 9753.463559504295, 9753.512324383752, 9950.40297582133, 10070.546825392876, 10085.193184545218, 8565.357598180162, 8721.0, 8743.825123497494, 8778.156587116777, 8834.55827208637, 8715.738527844174, 9874.160696340748, 9965.053319934595, 9988.500574971222, 10048.296619236584, 2813.2826129336886, 2867.569864520339, 2878.481873262833, 2884.1059271625863, 2935.4569404660206, 1046.6859942017516, 1063.3938654966594, 1067.204932325407, 1073.9301945373525, 1082.8375743638517, 21233.78766212318, 21534.569308614053, 21626.486145969946, 21719.56560868774, 21949.890250548644, 1135.1656532448644, 1146.827975803636, 1148.115950717959, 1148.26511032939, 1150.4822829726656, 11533.711657208636, 11857.822132668018, 11906.107041971887, 11933.641990740292, 11970.700732481757, 540109.0, 540180.0, 548789.0, 549358.0, 552181.0, 133001.0, 136742.0, 138311.0, 138964.0, 139320.0, 1231.5258625429094, 1269.9047571431995, 1288.3493835613142, 1290.5934630591335, 1292.476546998467, 19030.42908712741, 19396.612067758848, 23060.192893248655, 23433.179838705564, 23993.16023939154, 66833.33166668465, 67753.6612316955, 68209.0, 68351.65824171047, 68613.3138668607, 81365.59317203375, 82262.58868705618, 82463.5876820612, 83184.16815832007, 83563.0, 13289.867101328862, 14014.649633759238, 15453.922730386275, 15934.282957267184, 15969.281382337591, 24938.12716554912, 25045.12342068019, 25239.62140567856, 25456.363590910376, 25482.490350192522, 20036.799632003494, 20358.79641203628, 20376.0, 20588.176472940915, 20589.794102058786, 17630.1184940755, 17926.372576959744, 17939.820601793814, 18211.635767284315, 18449.354272600394, 21201.89399052995, 21674.458138546663, 21694.45763855853, 21704.565908682052, 21874.343769686933, 15373.308201130752, 15429.614259643598, 15555.611109722347, 15563.84436155624, 15671.059736415851, 20160.697589535874, 20337.0, 20350.694739578623, 20408.795912041285, 20573.691394629393], "value": 12772.414887574052, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.4650755966513, 1496.5136330692521, 1513.3492598182784, 1519.3770554072833, 1527.6486408126138, 14626.414943402264, 15131.394744210245, 15387.692246155084, 15398.30707618157, 15454.768178477332, 15627.843721562782, 15972.361105555763, 16030.919845400756, 16031.83968160318, 16054.678906421865, 2699.4061306512535, 2749.092799376201, 2749.202731207957, 2750.7936904732223, 2761.654793150856, 2602.08926875593, 2662.7204143564936, 2664.3472349274457, 2717.3342531079816, 2719.809613327058, 2718.768904643108, 2742.3418379588957, 2748.670159580853, 2754.380264440505, 2754.834709917401, 2673.5187666219977, 2695.689995650496, 2703.5674292113167, 2706.580480025589, 2712.1999010291815, 2564.333273348924, 2615.6599642046413, 2636.6176904348954, 2637.3274814922074, 2639.5644718621406, 14969.550913472613, 15148.091114533163, 15251.542453726406, 15255.771163432557, 15304.311305991147, 7972.3622110231045, 8235.588220588947, 8253.174682531759, 8253.752387428387, 8267.751967440987, 5458.863528411782, 5557.694326812024, 5600.859978500529, 5685.857853553653, 5695.515881150107, 1896.715492676096, 1916.6358391905494, 1928.6142771445627, 1951.2292644405381, 1958.608278344337, 26384.0765573204, 26430.339241518923, 26459.470810583873, 26639.0, 26658.0, 7376.926230737624, 7431.108267007994, 7532.8493430132185, 7603.581803000778, 7651.273129052731, 18075.819241807676, 18145.09274536268, 18200.0, 18201.817981820277, 18244.361447349278, 8071.515709057476, 8264.752057438287, 8290.0, 8290.709825156091, 8291.8341633167, 7467.626618669045, 7589.962050189713, 7617.619119044026, 7692.692292308245, 7707.653155608011, 5275.630705850554, 5475.753591088411, 5484.780608775604, 5488.69812160327, 5521.3926468088475, 1442.5600191941348, 1480.3634437191895, 1569.670369222476, 1573.638063245437, 1575.3068649794054, 949.9097585729345, 967.2793768642406, 972.4894430424084, 976.2677991506371, 986.0927946289288, 8829.78246690204, 9292.72121836346, 9311.767205819773, 9322.207612353026, 9340.673076442428, 759.2407592407592, 766.3332900376597, 773.7485317271909, 774.1987043410044, 833.9617176615153, 5484.561235101182, 5728.570357223225, 5772.105323674838, 5892.558058145656, 5916.940830591639, 21189.682154767692, 22044.559108817735, 22417.775822241896, 22715.432114197276, 22715.886420567793, 22167.556648866932, 22300.0, 22418.0, 22517.099316027503, 22604.095836166696, 11017.504212310465, 11643.301401915913, 11835.585754498552, 12003.459844306852, 12111.697207569881, 8080.757577272691, 8317.376196785144, 8320.16798320163, 8338.624761885609, 8535.06114327411, 19313.0, 19319.51701207481, 19660.50848728793, 19762.308319209333, 19821.0, 19696.507587309858, 19761.60476790485, 19782.90108549448, 19876.70184947256, 19974.500637483598, 11601.767964640829, 11839.348835814113, 11847.170698051053, 11847.822282665938, 11851.70370740704, 13928.651783705083, 13953.790693139814, 14137.0, 14199.858001420267, 14203.715925681636, 10332.431716255378, 10391.688249352532, 10425.582976681151, 10475.790484190122, 10733.946330268298, 11036.061934735317, 11127.610533631609, 11164.832527511931, 11260.324380537195, 11297.774044519228, 9926.503674816086, 10171.491425428847, 10254.230932680228, 10364.740881478023, 10367.0151335623, 7154.570725756471, 7187.496875218684, 7233.276672332725, 7305.269473052652, 7315.414766818748, 7606.695732170651, 7674.808129796576, 7705.922940770521, 7710.575918324322, 7720.266574675396], "value": 6831.685013243838, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [498.4815791576759, 507.94347756666116, 533.1203514201567, 540.2355666731575, 541.2584758880334, 6134.227450118178, 6201.379862013802, 6210.596311239767, 6292.402221788929, 6307.306196318401, 5901.5573831962665, 6070.726817293222, 6082.543809214305, 6100.2679678438535, 6128.540359473035, 4770.332153498513, 4779.522047795219, 4784.545468180518, 4796.616270698353, 4813.951860481403, 4719.268513380432, 4789.640776941726, 4790.137775200463, 4790.329353890441, 4844.781984810675, 4818.397700287464, 4818.638602104838, 4830.565249127578, 4830.637702172351, 4843.854684359475, 4805.975970120145, 4813.66304358695, 4815.277708343741, 4819.421669399694, 4822.059698358804, 4386.232409328387, 4392.363107349448, 4393.340998850166, 4393.484247934458, 4399.802008909607, 6055.424734650202, 6099.725512351911, 6103.115048318014, 6106.358832322587, 6131.3868613138775, 5594.0, 5656.547476201894, 5721.599488035839, 5800.8839823203725, 5805.5065319447895, 6547.672616369163, 6603.7688680895935, 6637.0, 6640.0, 6667.0, 4899.314096026559, 4931.161702510546, 4941.925871111936, 4942.802287908479, 4957.3059771632, 6787.626680532618, 6821.317868213188, 6829.385355318045, 6854.10896583446, 6883.8967415488805, 5040.647154699136, 5082.771275292621, 5090.490950904954, 5094.5669618082875, 5100.897982040338, 5155.561777248976, 5175.094358487325, 5198.324217851655, 5200.557952574073, 5228.424873263938, 5693.17448969897, 5721.342045664802, 5724.370319264877, 5757.424257574209, 5794.188813566104, 6572.901406478906, 6605.348662834292, 6612.636305003271, 6613.603183808987, 6647.268800431949, 1714.2285971312958, 1738.2004278031993, 1753.7281721333213, 1755.4996825904811, 1777.5644966983173, 1229.299299399334, 1240.3860089255877, 1241.4847838147248, 1262.4571434283162, 1270.7267937393506, 6193.380661933861, 6257.8748425031245, 6340.873182536324, 6357.96821015892, 6361.823062733317, 6469.288378278386, 6497.675116244169, 6541.215054193527, 6734.158230221223, 6769.356911093439, 6196.845078873064, 6227.875442491216, 6275.901717199563, 6284.622922624657, 6306.936930630727, 3487.8256087195537, 3513.9648603514147, 3516.40221162403, 3528.6294939031545, 3566.821658917044, 6869.427897493276, 6915.75794847188, 7006.719731210796, 7033.9296607033275, 7105.43156547475, 6886.8622627548175, 6918.965405173042, 6929.3070692930305, 6944.618046007417, 6960.164780226304, 7110.608916509642, 7111.217766045731, 7113.253108423644, 7128.394086502705, 7129.857402851914, 6614.437772789174, 6700.688262549413, 6784.694688739118, 6792.93207067923, 6824.829379265359, 6565.573237739532, 6592.90110648331, 6597.60414375139, 6639.634820084942, 6731.865362692816, 6898.0, 7017.0, 7039.366457018688, 7043.859122817413, 7059.188193357624, 5067.239914012927, 5086.109930762176, 5102.974485127551, 5122.308488354024, 5135.512126347991, 6817.000519771284, 6820.147481564804, 6832.521723479309, 6837.008633748178, 6866.965665171642, 6395.42441180296, 6489.643069631215, 6495.382938620824, 6559.62179477579, 6566.704498297492, 6371.267304260069, 6452.483801295791, 6503.471684154126, 6534.215894092739, 6548.410643042149, 6109.908351374822, 6284.591501552384, 6371.5221358397375, 6386.361363863763, 6441.742330306735, 6497.5126865484335, 6536.575122617015, 6541.476681865344, 6567.835804104936, 6652.83367915806, 6287.2140982377205, 6319.345874732531, 6360.395762402564, 6362.650054247061, 6377.521685873486], "value": 5102.306561331306, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [942.9811403771929, 951.1487218939048, 975.6195083917273, 978.530305453382, 979.5200351827605, 19125.521861953457, 19437.708434373497, 19487.512812179684, 19922.800771992275, 23326.533469330647, 21690.0, 22009.66985495219, 22096.668549971764, 22097.116115355366, 22148.0, 1049.559185142242, 1085.6308854989302, 1091.4597274349208, 1091.4870011094772, 1091.612477570463, 1035.2908257843364, 1093.0435868614961, 1103.569607852938, 1110.7278716714416, 1111.5776005118043, 1166.8949794518492, 1167.7897978363892, 1168.415792103948, 1169.3510101893446, 1170.3387586013916, 1159.7390587117957, 1159.9768004639943, 1160.2748282323548, 1160.9535618575246, 1160.970975725605, 846.9195426434479, 852.1052894460853, 854.0647990450447, 854.8418542569582, 855.7603870916154, 19872.205111795654, 20399.286024989204, 20487.590248194952, 20588.27941022072, 20629.793702062936, 22447.21434749776, 22462.55074898493, 22493.775062249333, 22563.774362256332, 22957.426064348358, 17026.659466810717, 17198.570035749082, 17283.04943228122, 17345.0, 17421.825781742275, 3810.2950954073585, 3825.9426108608395, 3831.3678243089857, 3842.4812650292133, 3842.903927401809, 149794.0, 150837.24581377133, 151450.24274878556, 152325.0, 153120.0, 16990.830091699172, 17039.14804259782, 17541.736873946902, 17685.646287074444, 17701.38045168413, 32119.0, 32392.514112288336, 32718.345633087203, 32751.50872736911, 33816.0, 8777.078406767325, 9135.954320228357, 9136.543172841331, 9142.268618510503, 9270.490123043162, 4579.633629309647, 4669.369635099286, 4681.297805329228, 4686.742229177428, 4692.178868697964, 5592.189132575835, 5607.074832652566, 5656.745446454919, 5683.175939488751, 5699.230603868507, 1171.244547267008, 1187.4062968515743, 1194.8386967759416, 1202.0, 1202.1584890576632, 711.1430725975291, 724.9855002899913, 729.5877829026583, 737.8598066367481, 749.5615065186818, 12445.937770311091, 13200.405981730653, 13433.529826456223, 13442.126261792951, 13582.93208533951, 740.3780824107776, 751.7894989402976, 753.1489416958801, 756.7578374920083, 765.7855800375904, 6419.903701444482, 7028.894566581505, 7189.424846012306, 7287.161976372679, 7419.59192244421, 125169.23815333021, 129241.0, 129731.45939892247, 131047.0, 132285.3385733065, 114580.42709786398, 116763.0, 118193.40903295428, 120187.0, 122760.74293878455, 99396.02415903282, 100619.49690251502, 103005.48497257466, 105999.94000060055, 106196.46901765597, 13975.30123493801, 14309.785353219502, 14350.641233968816, 14354.138751674933, 14630.707385852436, 46754.0, 47202.29196561986, 47826.760866195444, 48511.75744121398, 48692.513074868795, 61608.38391616027, 62332.0, 62332.06501902566, 63212.68393658186, 64866.67566662136, 18855.811441885406, 20346.18615255373, 20818.79181208229, 20863.37409877706, 21070.367888963356, 21821.672674909572, 21824.127034918427, 21864.45338866541, 21878.23426180076, 22223.666645000016, 20391.4902127448, 20646.17415303371, 20647.483812904196, 20730.48173795667, 21070.367888963356, 20471.078801453674, 20636.17455301771, 20957.685634715795, 21008.0, 21152.78847211508, 20686.17255309771, 20739.170433183106, 20815.583688326453, 20818.58362832765, 20902.16391344329, 13912.0, 14045.578632641038, 14072.78890816659, 14181.574552763434, 14310.713785724436, 15479.458218962282, 15625.453109141126, 15705.136217508147, 15705.68588628244, 15851.207439628202], "value": 10089.422562668084, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1480.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 107.0, 93.0, 108.0, 107.0, 108.0, 111.0, 105.0, 106.0, 107.0], "value": 105.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 133.0, 163.0, 117.0, 150.0, 138.0, 129.0, 166.0, 118.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 163.0, 170.0, 161.0, 160.0, 161.0, 170.0, 166.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 180.0, 75.0, 76.0, 75.0, 90.0, 100.0, 76.0], "value": 89.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 143.0, 77.0, 78.0, 78.0, 138.0, 78.0, 81.0, 130.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 113.0, 115.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 58.0, 48.0, 47.0, 49.0, 48.0, 51.0, 50.0, 48.0, 48.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 54.0, 57.0, 58.0, 54.0, 53.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 77.0, 76.0, 78.0, 74.0, 74.0, 76.0, 75.0, 73.0], "value": 75.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 116.0, 117.0, 118.0, 123.0, 120.0, 117.0, 125.0, 117.0, 161.0], "value": 123.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 165.0, 159.0, 167.0, 167.0, 169.0, 172.0, 164.0, 167.0, 163.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 60.0, 60.0, 63.0, 63.0, 60.0, 63.0, 62.0], "value": 61.9, "unit": "score"}]}]} 05:44:09 INFO - Return code: 0 05:44:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:44:09 INFO - # TBPL SUCCESS # 05:44:09 INFO - Running post-action listener: _package_coverage_data 05:44:09 INFO - Running post-action listener: _resource_record_post_action 05:44:09 INFO - [mozharness: 2017-08-08 12:44:09.692390Z] Finished run-tests step (success) 05:44:09 INFO - Running post-run listener: _resource_record_post_run 05:44:09 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433979392; Read time: 8; Write time: 379848 05:44:09 INFO - TinderboxPrint: CPU usage
13.1% 05:44:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 05:44:09 INFO - TinderboxPrint: I/O write bytes / time
433,979,392 / 379,848 05:44:09 INFO - TinderboxPrint: CPU idle
8,233.4 (86.9%) 05:44:09 INFO - TinderboxPrint: CPU user
1,189.2 (12.6%) 05:44:09 INFO - TinderboxPrint: Swap in / out
0 / 0 05:44:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 115961856; Read time: 0; Write time: 112764 05:44:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:44:09 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 0; Write bytes: 318017536; Read time: 0; Write time: 267084 05:44:10 INFO - Running post-run listener: _upload_blobber_files 05:44:10 INFO - Blob upload gear active. 05:44:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:44:10 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 05:44:10 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'] 05:44:10 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 05:44:10 INFO - (blobuploader) - INFO - Open directory for files ... 05:44:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:44:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:44:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:17 INFO - (blobuploader) - INFO - Done attempting. 05:44:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:44:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:44:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:18 INFO - (blobuploader) - INFO - Done attempting. 05:44:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:44:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:44:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:18 INFO - (blobuploader) - INFO - Done attempting. 05:44:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:44:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:44:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:44:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:44:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:44:19 INFO - (blobuploader) - INFO - Done attempting. 05:44:19 INFO - (blobuploader) - INFO - Iteration through files over. 05:44:19 INFO - Return code: 0 05:44:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:44:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:44:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/002598b1295c09bc09a303f2efa1abf6466b9a751084bf9cc084812aed79e009c835358cbfcf1dcce257dcb657ddc8605d5587815539f224e7d1fd3dd908c53a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d0775129d07a79a47ab6acadcda0097b12d610d80708c5d17c26f338125f33bc27abfdbb5365ac0c7dfd17038cbd5adfab33a9cc2a7724a28d1e04edc31a6d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/011eae7de84b138069a07bf835aa895317cb3e52c0c2e437459bf7f464f7855c9975e66965e82c8468b4ddbb371a1917ecbb1d0d435604b6fed0ca674c365ccd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6655689feac5a630f5f54e0163d1229e564d44d4c45f68783a310b5987c6eb97437d5c412e12a6cbd8d51a5d87c38ee5eeaab66f6c4fa122499062d47a33afe"} 05:44:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:44:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:44:19 INFO - Contents: 05:44:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/002598b1295c09bc09a303f2efa1abf6466b9a751084bf9cc084812aed79e009c835358cbfcf1dcce257dcb657ddc8605d5587815539f224e7d1fd3dd908c53a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d0775129d07a79a47ab6acadcda0097b12d610d80708c5d17c26f338125f33bc27abfdbb5365ac0c7dfd17038cbd5adfab33a9cc2a7724a28d1e04edc31a6d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/011eae7de84b138069a07bf835aa895317cb3e52c0c2e437459bf7f464f7855c9975e66965e82c8468b4ddbb371a1917ecbb1d0d435604b6fed0ca674c365ccd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6655689feac5a630f5f54e0163d1229e564d44d4c45f68783a310b5987c6eb97437d5c412e12a6cbd8d51a5d87c38ee5eeaab66f6c4fa122499062d47a33afe"} 05:44:19 INFO - Running post-run listener: copy_logs_to_upload_dir 05:44:19 INFO - Copying logs to upload dir... 05:44:19 INFO - mkdir: /builds/slave/test/build/upload/logs 05:44:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.079686 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-08 05:44:19.822074) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 05:44:19.825935) ========= 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=199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/002598b1295c09bc09a303f2efa1abf6466b9a751084bf9cc084812aed79e009c835358cbfcf1dcce257dcb657ddc8605d5587815539f224e7d1fd3dd908c53a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d0775129d07a79a47ab6acadcda0097b12d610d80708c5d17c26f338125f33bc27abfdbb5365ac0c7dfd17038cbd5adfab33a9cc2a7724a28d1e04edc31a6d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/011eae7de84b138069a07bf835aa895317cb3e52c0c2e437459bf7f464f7855c9975e66965e82c8468b4ddbb371a1917ecbb1d0d435604b6fed0ca674c365ccd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6655689feac5a630f5f54e0163d1229e564d44d4c45f68783a310b5987c6eb97437d5c412e12a6cbd8d51a5d87c38ee5eeaab66f6c4fa122499062d47a33afe"} build_url:https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/U7IrLBmAS-ad_k0TvlzqjA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/002598b1295c09bc09a303f2efa1abf6466b9a751084bf9cc084812aed79e009c835358cbfcf1dcce257dcb657ddc8605d5587815539f224e7d1fd3dd908c53a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d0775129d07a79a47ab6acadcda0097b12d610d80708c5d17c26f338125f33bc27abfdbb5365ac0c7dfd17038cbd5adfab33a9cc2a7724a28d1e04edc31a6d0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/011eae7de84b138069a07bf835aa895317cb3e52c0c2e437459bf7f464f7855c9975e66965e82c8468b4ddbb371a1917ecbb1d0d435604b6fed0ca674c365ccd", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6655689feac5a630f5f54e0163d1229e564d44d4c45f68783a310b5987c6eb97437d5c412e12a6cbd8d51a5d87c38ee5eeaab66f6c4fa122499062d47a33afe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 05:44:19.854652) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 05:44:19.855358) ========= 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=199fb4c72b90437b990b419b000001c5-1502194966.572507-670767516 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 05:44:19.940678) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 05:44:19.941380) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 05:44:19.941944) ========= ========= Total master_lag: 0.20 =========