builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-006 starttime: 1501525460.26 results: success (0) revision: 87824406b9feb420a3150720707b424d7cee5915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:20.257171) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:20.257810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:20.258136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:20.298888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:20.299217) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-31 11:24:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 204M=0s 2017-07-31 11:24:20 (204 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.226063 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:20.560263) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:20.560623) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014406 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:20.612709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:20.613524) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 87824406b9feb420a3150720707b424d7cee5915 --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 87824406b9feb420a3150720707b424d7cee5915 --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=e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-31 11:24:20,716 truncating revision to first 12 chars 2017-07-31 11:24:20,716 Setting DEBUG logging. 2017-07-31 11:24:20,716 attempt 1/10 2017-07-31 11:24:20,716 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/87824406b9fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-31 11:24:21,376 unpacking tar archive at: mozilla-central-87824406b9fe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.977635 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:21.605503) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:21.605924) ========= script_repo_revision: 87824406b9feb420a3150720707b424d7cee5915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:21.606416) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:21.606748) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 11:24:21.616518) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-07-31 11:24:21.617115) ========= /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=e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:24:21 INFO - MultiFileLogger online at 20170731 11:24:21 in /builds/slave/test 11:24:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:24:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:24:21 INFO - {'append_to_log': False, 11:24:21 INFO - 'base_work_dir': '/builds/slave/test', 11:24:21 INFO - 'blob_upload_branch': 'Firefox', 11:24:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:24:21 INFO - 'branch': 'Firefox', 11:24:21 INFO - 'buildbot_json_path': 'buildprops.json', 11:24:21 INFO - 'code_coverage': False, 11:24:21 INFO - 'config_files': ('talos/linux_config.py',), 11:24:21 INFO - 'default_actions': ('clobber', 11:24:21 INFO - 'read-buildbot-config', 11:24:21 INFO - 'download-and-extract', 11:24:21 INFO - 'populate-webroot', 11:24:21 INFO - 'create-virtualenv', 11:24:21 INFO - 'install', 11:24:21 INFO - 'setup-mitmproxy', 11:24:21 INFO - 'run-tests'), 11:24:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:24:21 INFO - 'disable_ccov_upload': False, 11:24:21 INFO - 'download_minidump_stackwalk': True, 11:24:21 INFO - 'download_symbols': 'ondemand', 11:24:21 INFO - 'enable_stylo': False, 11:24:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:24:21 INFO - 'tooltool.py': '/tools/tooltool.py', 11:24:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:24:21 INFO - '/tools/misc-python/virtualenv.py')}, 11:24:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:24:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:24:21 INFO - 'gecko_profile': False, 11:24:21 INFO - 'gecko_profile_interval': 0, 11:24:21 INFO - 'installer_path': 'installer.exe', 11:24:21 INFO - 'log_level': 'info', 11:24:21 INFO - 'log_name': 'talos', 11:24:21 INFO - 'log_to_console': True, 11:24:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:24:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:24:21 INFO - 'opt_config_files': (), 11:24:21 INFO - 'pip_index': False, 11:24:21 INFO - 'suite': 'dromaeojs-e10s', 11:24:21 INFO - 'system_bits': '32', 11:24:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:24:21 INFO - 'title': 'talos-linux64-ix-006', 11:24:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:24:21 INFO - 'use_talos_json': True, 11:24:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:24:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:24:21 INFO - 'work_dir': 'build'} 11:24:21 INFO - [mozharness: 2017-07-31 18:24:21.943580Z] Running clobber step. 11:24:21 INFO - Running pre-action listener: _resource_record_pre_action 11:24:21 INFO - Running main action method: clobber 11:24:21 INFO - rmtree: /builds/slave/test/build 11:24:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:24:22 INFO - Running post-action listener: _resource_record_post_action 11:24:22 INFO - [mozharness: 2017-07-31 18:24:22.922071Z] Finished clobber step (success) 11:24:22 INFO - [mozharness: 2017-07-31 18:24:22.922172Z] Running read-buildbot-config step. 11:24:22 INFO - Running pre-action listener: _resource_record_pre_action 11:24:22 INFO - Running main action method: read_buildbot_config 11:24:22 INFO - Using buildbot properties: 11:24:22 INFO - { 11:24:22 INFO - "project": "", 11:24:22 INFO - "product": "firefox", 11:24:22 INFO - "who": "rstrong@mozilla.com", 11:24:22 INFO - "installer_path": "public/build/target.tar.bz2", 11:24:22 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 11:24:22 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:24:22 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 11:24:22 INFO - "stage_platform": "linux64-stylosequential", 11:24:22 INFO - "basedir": "/builds/slave/test", 11:24:22 INFO - "buildnumber": 162, 11:24:22 INFO - "platform": "ubuntu64_hw_styloseq", 11:24:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:24:22 INFO - "slavebuilddir": "test", 11:24:22 INFO - "taskId": "L1029G2LSlSqoliVnf5rJA", 11:24:22 INFO - "branch": "mozilla-central", 11:24:22 INFO - "script_repo_revision": "production", 11:24:22 INFO - "revision": "87824406b9feb420a3150720707b424d7cee5915", 11:24:22 INFO - "slavename": "talos-linux64-ix-006", 11:24:22 INFO - "repo_path": "mozilla-central" 11:24:22 INFO - } 11:24:22 INFO - Finding installer, test and symbols from parent task. 11:24:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L1029G2LSlSqoliVnf5rJA'}, attempt #1 11:24:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L1029G2LSlSqoliVnf5rJA'}, attempt #1 11:24:23 INFO - Task dependencies: KJBAMiYNQ1qnxmumtVmpOA 11:24:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA'}, attempt #1 11:24:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.tar.bz2 11:24:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.test_packages.json 11:24:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.crashreporter-symbols.zip 11:24:24 INFO - Running post-action listener: _resource_record_post_action 11:24:24 INFO - [mozharness: 2017-07-31 18:24:24.326292Z] Finished read-buildbot-config step (success) 11:24:24 INFO - [mozharness: 2017-07-31 18:24:24.326513Z] Running download-and-extract step. 11:24:24 INFO - Running pre-action listener: _resource_record_pre_action 11:24:24 INFO - Running main action method: download_and_extract 11:24:24 INFO - mkdir: /builds/slave/test/build/tests 11:24:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:24 INFO - trying https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.test_packages.json 11:24:24 INFO - Downloading https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:24:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:24:24 INFO - Downloaded 989 bytes. 11:24:24 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:24:24 INFO - Using the following test package requirements: 11:24:24 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:24:24 INFO - u'common': [u'target.common.tests.zip'], 11:24:24 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:24:24 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:24:24 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:24:24 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:24:24 INFO - u'mozbase': [u'target.common.tests.zip'], 11:24:24 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:24:24 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:24:24 INFO - u'web-platform': [u'target.common.tests.zip', 11:24:24 INFO - u'target.web-platform.tests.tar.gz'], 11:24:24 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:24:24 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:24:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.common.tests.zip 11:24:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:24:24 INFO - Fetch https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.common.tests.zip into memory 11:24:26 INFO - Content-Length response header: 72397708 11:24:26 INFO - Bytes received: 72397708 11:24:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:24:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.common.tests.zip 11:24:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:24:37 INFO - Fetch https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.common.tests.zip into memory 11:24:38 INFO - Content-Length response header: 72397708 11:24:38 INFO - Bytes received: 72397708 11:24:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.talos.tests.zip 11:24:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:24:52 INFO - Fetch https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.talos.tests.zip into memory 11:24:53 INFO - Content-Length response header: 14496686 11:24:53 INFO - Bytes received: 14496686 11:24:53 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')]} 11:24:53 INFO - trying https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.tar.bz2 11:24:53 INFO - Downloading https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:24:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:24:54 INFO - Downloaded 62335221 bytes. 11:24:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.tar.bz2 11:24:54 INFO - mkdir: /builds/slave/test/properties 11:24:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:24:54 INFO - Writing to file /builds/slave/test/properties/build_url 11:24:54 INFO - Contents: 11:24:54 INFO - build_url:https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.tar.bz2 11:24:54 INFO - Running post-action listener: _resource_record_post_action 11:24:54 INFO - Running post-action listener: set_extra_try_arguments 11:24:54 INFO - [mozharness: 2017-07-31 18:24:54.786582Z] Finished download-and-extract step (success) 11:24:54 INFO - [mozharness: 2017-07-31 18:24:54.786680Z] Running populate-webroot step. 11:24:54 INFO - Running pre-action listener: _resource_record_pre_action 11:24:54 INFO - Running main action method: populate_webroot 11:24:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:24:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:24:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:24:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:24:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:24:54 INFO - 'tests': ['damp', 'tps']}, 11:24:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:24:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:24:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:24:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:24:54 INFO - 'other-e10s': {'tests': ['a11yr', 11:24:54 INFO - 'ts_paint', 11:24:54 INFO - 'tpaint', 11:24:54 INFO - 'sessionrestore', 11:24:54 INFO - 'sessionrestore_many_windows', 11:24:54 INFO - 'sessionrestore_no_auto_restore', 11:24:54 INFO - 'tabpaint']}, 11:24:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:24:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:24:54 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:54 INFO - 'talos_options': ['--mitmproxy', 11:24:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:54 INFO - '--firstNonBlankPaint'], 11:24:54 INFO - 'tests': ['quantum_pageload_google', 11:24:54 INFO - 'quantum_pageload_youtube', 11:24:54 INFO - 'quantum_pageload_amazon', 11:24:54 INFO - 'quantum_pageload_facebook']}, 11:24:54 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:54 INFO - 'talos_options': ['--stylo', 11:24:54 INFO - '--mitmproxy', 11:24:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:54 INFO - '--firstNonBlankPaint'], 11:24:54 INFO - 'tests': ['quantum_pageload_google', 11:24:54 INFO - 'quantum_pageload_youtube', 11:24:54 INFO - 'quantum_pageload_amazon', 11:24:54 INFO - 'quantum_pageload_facebook']}, 11:24:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:24:54 INFO - 'tsvgr_opacity', 11:24:54 INFO - 'tart', 11:24:54 INFO - 'tscrollx', 11:24:54 INFO - 'cart', 11:24:54 INFO - 'tsvg_static']}, 11:24:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:24:54 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:24:54 INFO - 'talos_options': ['--stylo', 11:24:54 INFO - '--stylo-threads=1', 11:24:54 INFO - '--mitmproxy', 11:24:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:24:54 INFO - '--firstNonBlankPaint'], 11:24:54 INFO - 'tests': ['tp6_google', 11:24:54 INFO - 'tp6_youtube', 11:24:54 INFO - 'tp6_amazon', 11:24:54 INFO - 'tp6_facebook']}, 11:24:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:24:54 INFO - 'talos_options': ['--xperf_path', 11:24:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:24:54 INFO - 'tests': ['tp5n']}}} 11:24:54 INFO - Running post-action listener: _resource_record_post_action 11:24:54 INFO - [mozharness: 2017-07-31 18:24:54.795296Z] Finished populate-webroot step (success) 11:24:54 INFO - [mozharness: 2017-07-31 18:24:54.795386Z] Running create-virtualenv step. 11:24:54 INFO - Running pre-action listener: _resource_record_pre_action 11:24:54 INFO - Running main action method: create_virtualenv 11:24:54 INFO - Creating virtualenv /builds/slave/test/build/venv 11:24:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:24:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:24:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:24:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:24:54 INFO - Using real prefix '/usr' 11:24:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:24:55 INFO - Installing distribute.............................................................................................................................................................................................done. 11:24:57 INFO - Installing pip.................done. 11:24:57 INFO - Return code: 0 11:24:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:24:57 INFO - Reading from file tmpfile_stdout 11:24:57 INFO - Output received: 11:24:57 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) 11:24:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, '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 0xf66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', '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 11:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:24:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:24:57 INFO - Using env: {'DISPLAY': ':0', 11:24:57 INFO - 'HOME': '/home/cltbld', 11:24:57 INFO - 'LANG': 'en_US.UTF-8', 11:24:57 INFO - 'LANGUAGE': 'en_US:en', 11:24:57 INFO - 'LOGNAME': 'cltbld', 11:24:57 INFO - 'MAIL': '/var/mail/cltbld', 11:24:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:57 INFO - 'MOZ_NO_REMOTE': '1', 11:24:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:57 INFO - 'NO_EM_RESTART': '1', 11:24:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:57 INFO - 'PWD': '/builds/slave/test', 11:24:57 INFO - 'SHELL': '/bin/bash', 11:24:57 INFO - 'SHLVL': '1', 11:24:57 INFO - 'TERM': 'linux', 11:24:57 INFO - 'TMOUT': '86400', 11:24:57 INFO - 'USER': 'cltbld', 11:24:57 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', 11:24:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:57 INFO - '_': '/tools/buildbot/bin/python'} 11:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:24:57 INFO - Cleaning up... 11:24:57 INFO - Return code: 0 11:24:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:24:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:24:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:24:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, '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 0xf66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', '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 11:24:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:24:58 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 11:24:58 INFO - Using env: {'DISPLAY': ':0', 11:24:58 INFO - 'HOME': '/home/cltbld', 11:24:58 INFO - 'LANG': 'en_US.UTF-8', 11:24:58 INFO - 'LANGUAGE': 'en_US:en', 11:24:58 INFO - 'LOGNAME': 'cltbld', 11:24:58 INFO - 'MAIL': '/var/mail/cltbld', 11:24:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:24:58 INFO - 'MOZ_NO_REMOTE': '1', 11:24:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:24:58 INFO - 'NO_EM_RESTART': '1', 11:24:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:24:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:24:58 INFO - 'PWD': '/builds/slave/test', 11:24:58 INFO - 'SHELL': '/bin/bash', 11:24:58 INFO - 'SHLVL': '1', 11:24:58 INFO - 'TERM': 'linux', 11:24:58 INFO - 'TMOUT': '86400', 11:24:58 INFO - 'USER': 'cltbld', 11:24:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', 11:24:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:24:58 INFO - '_': '/tools/buildbot/bin/python'} 11:24:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:24:58 INFO - Downloading/unpacking psutil>=3.1.1 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:24:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:24:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:24:59 INFO - Installing collected packages: psutil 11:24:59 INFO - Running setup.py install for psutil 11:24:59 INFO - building 'psutil._psutil_linux' extension 11:24:59 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 11:25:00 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 11:25:00 INFO - building 'psutil._psutil_posix' extension 11:25:00 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 11:25:00 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 11:25:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:25:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:25:00 INFO - Successfully installed psutil 11:25:00 INFO - Cleaning up... 11:25:01 INFO - Return code: 0 11:25:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, '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 0xf66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', '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 11:25:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:25:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:25:01 INFO - Using env: {'DISPLAY': ':0', 11:25:01 INFO - 'HOME': '/home/cltbld', 11:25:01 INFO - 'LANG': 'en_US.UTF-8', 11:25:01 INFO - 'LANGUAGE': 'en_US:en', 11:25:01 INFO - 'LOGNAME': 'cltbld', 11:25:01 INFO - 'MAIL': '/var/mail/cltbld', 11:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:01 INFO - 'MOZ_NO_REMOTE': '1', 11:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:01 INFO - 'NO_EM_RESTART': '1', 11:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:01 INFO - 'PWD': '/builds/slave/test', 11:25:01 INFO - 'SHELL': '/bin/bash', 11:25:01 INFO - 'SHLVL': '1', 11:25:01 INFO - 'TERM': 'linux', 11:25:01 INFO - 'TMOUT': '86400', 11:25:01 INFO - 'USER': 'cltbld', 11:25:01 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', 11:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:01 INFO - '_': '/tools/buildbot/bin/python'} 11:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:25:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:25:02 INFO - Installing collected packages: mozsystemmonitor 11:25:02 INFO - Running setup.py install for mozsystemmonitor 11:25:02 INFO - Successfully installed mozsystemmonitor 11:25:02 INFO - Cleaning up... 11:25:02 INFO - Return code: 0 11:25:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:25:02 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')]} 11:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:02 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')]} 11:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:02 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 0xbf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, '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 0xf66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', '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 11:25:02 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 11:25:02 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 11:25:02 INFO - Using env: {'DISPLAY': ':0', 11:25:02 INFO - 'HOME': '/home/cltbld', 11:25:02 INFO - 'LANG': 'en_US.UTF-8', 11:25:02 INFO - 'LANGUAGE': 'en_US:en', 11:25:02 INFO - 'LOGNAME': 'cltbld', 11:25:02 INFO - 'MAIL': '/var/mail/cltbld', 11:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:02 INFO - 'MOZ_NO_REMOTE': '1', 11:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:02 INFO - 'NO_EM_RESTART': '1', 11:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:02 INFO - 'PWD': '/builds/slave/test', 11:25:02 INFO - 'SHELL': '/bin/bash', 11:25:02 INFO - 'SHLVL': '1', 11:25:02 INFO - 'TERM': 'linux', 11:25:02 INFO - 'TMOUT': '86400', 11:25:02 INFO - 'USER': 'cltbld', 11:25:02 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', 11:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:02 INFO - '_': '/tools/buildbot/bin/python'} 11:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:02 INFO - Downloading/unpacking jsonschema==2.5.1 11:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:25:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:25: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 11:25: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 11:25: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 11:25: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 11:25:03 INFO - Downloading functools32-3.2.3-2.tar.gz 11:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:25:03 INFO - warning: no files found matching '*.txt' 11:25:04 INFO - no previously-included directories found matching 'build' 11:25:04 INFO - no previously-included directories found matching 'dist' 11:25:04 INFO - no previously-included directories found matching '.git*' 11:25:04 INFO - Installing collected packages: jsonschema, functools32 11:25:04 INFO - Running setup.py install for functools32 11:25:04 INFO - warning: no files found matching '*.txt' 11:25:04 INFO - no previously-included directories found matching 'build' 11:25:04 INFO - no previously-included directories found matching 'dist' 11:25:04 INFO - no previously-included directories found matching '.git*' 11:25:04 INFO - Successfully installed jsonschema functools32 11:25:04 INFO - Cleaning up... 11:25:04 INFO - Return code: 0 11:25:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, '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 0xf66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', '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 11:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:25:04 INFO - Using env: {'DISPLAY': ':0', 11:25:04 INFO - 'HOME': '/home/cltbld', 11:25:04 INFO - 'LANG': 'en_US.UTF-8', 11:25:04 INFO - 'LANGUAGE': 'en_US:en', 11:25:04 INFO - 'LOGNAME': 'cltbld', 11:25:04 INFO - 'MAIL': '/var/mail/cltbld', 11:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:04 INFO - 'MOZ_NO_REMOTE': '1', 11:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:04 INFO - 'NO_EM_RESTART': '1', 11:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:04 INFO - 'PWD': '/builds/slave/test', 11:25:04 INFO - 'SHELL': '/bin/bash', 11:25:04 INFO - 'SHLVL': '1', 11:25:04 INFO - 'TERM': 'linux', 11:25:04 INFO - 'TMOUT': '86400', 11:25:04 INFO - 'USER': 'cltbld', 11:25:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', 11:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:04 INFO - '_': '/tools/buildbot/bin/python'} 11:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:25:04 INFO - Cleaning up... 11:25:04 INFO - Return code: 0 11:25:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, '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 0xf66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', '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 11:25:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:25:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:25:04 INFO - Using env: {'DISPLAY': ':0', 11:25:04 INFO - 'HOME': '/home/cltbld', 11:25:04 INFO - 'LANG': 'en_US.UTF-8', 11:25:04 INFO - 'LANGUAGE': 'en_US:en', 11:25:04 INFO - 'LOGNAME': 'cltbld', 11:25:04 INFO - 'MAIL': '/var/mail/cltbld', 11:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:04 INFO - 'MOZ_NO_REMOTE': '1', 11:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:04 INFO - 'NO_EM_RESTART': '1', 11:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:04 INFO - 'PWD': '/builds/slave/test', 11:25:04 INFO - 'SHELL': '/bin/bash', 11:25:04 INFO - 'SHLVL': '1', 11:25:04 INFO - 'TERM': 'linux', 11:25:04 INFO - 'TMOUT': '86400', 11:25:04 INFO - 'USER': 'cltbld', 11:25:04 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', 11:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:04 INFO - '_': '/tools/buildbot/bin/python'} 11:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:04 INFO - Downloading/unpacking blobuploader==1.2.4 11:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:05 INFO - Downloading blobuploader-1.2.4.tar.gz 11:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:25:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:25: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 11:25: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 11:25: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 11:25: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 11:25:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:25:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:06 INFO - Downloading docopt-0.6.1.tar.gz 11:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:25:06 INFO - Installing collected packages: blobuploader, requests, docopt 11:25:06 INFO - Running setup.py install for blobuploader 11:25:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:25:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:25:06 INFO - Running setup.py install for requests 11:25:06 INFO - Running setup.py install for docopt 11:25:06 INFO - Successfully installed blobuploader requests docopt 11:25:06 INFO - Cleaning up... 11:25:06 INFO - Return code: 0 11:25:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:06 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 0xbf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, '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 0xf66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', '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 11:25:06 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 11:25:06 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 11:25:06 INFO - Using env: {'DISPLAY': ':0', 11:25:06 INFO - 'HOME': '/home/cltbld', 11:25:06 INFO - 'LANG': 'en_US.UTF-8', 11:25:06 INFO - 'LANGUAGE': 'en_US:en', 11:25:06 INFO - 'LOGNAME': 'cltbld', 11:25:06 INFO - 'MAIL': '/var/mail/cltbld', 11:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:06 INFO - 'MOZ_NO_REMOTE': '1', 11:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:06 INFO - 'NO_EM_RESTART': '1', 11:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:06 INFO - 'PWD': '/builds/slave/test', 11:25:06 INFO - 'SHELL': '/bin/bash', 11:25:06 INFO - 'SHLVL': '1', 11:25:06 INFO - 'TERM': 'linux', 11:25:06 INFO - 'TMOUT': '86400', 11:25:06 INFO - 'USER': 'cltbld', 11:25:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', 11:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:06 INFO - '_': '/tools/buildbot/bin/python'} 11:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:07 INFO - Running setup.py (path:/tmp/pip-322nAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:07 INFO - Running setup.py (path:/tmp/pip-QzKAzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:07 INFO - Running setup.py (path:/tmp/pip-EoYkkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:07 INFO - Running setup.py (path:/tmp/pip-X_XrFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:07 INFO - Running setup.py (path:/tmp/pip-S2EwRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:07 INFO - Running setup.py (path:/tmp/pip-GJLBs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:07 INFO - Running setup.py (path:/tmp/pip-pB0ryQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:07 INFO - Running setup.py (path:/tmp/pip-zyhMd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:07 INFO - Running setup.py (path:/tmp/pip-6XuCyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:07 INFO - Running setup.py (path:/tmp/pip-gSlLkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:07 INFO - Running setup.py (path:/tmp/pip-ooHz1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:07 INFO - Running setup.py (path:/tmp/pip-aeovAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:08 INFO - Running setup.py (path:/tmp/pip-HG86IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:08 INFO - Running setup.py (path:/tmp/pip-wb_nya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:08 INFO - Running setup.py (path:/tmp/pip-RNs7my-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:08 INFO - Running setup.py (path:/tmp/pip-b8CLuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:08 INFO - Running setup.py (path:/tmp/pip-zpT7Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:25:08 INFO - Running setup.py install for manifestparser 11:25:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:25:08 INFO - Running setup.py install for mozcrash 11:25:08 INFO - Running setup.py install for mozdebug 11:25:08 INFO - Running setup.py install for mozdevice 11:25:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:25:08 INFO - Running setup.py install for mozfile 11:25:08 INFO - Running setup.py install for mozhttpd 11:25:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:25:08 INFO - Running setup.py install for mozinfo 11:25:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Running setup.py install for mozInstall 11:25:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Running setup.py install for mozleak 11:25:09 INFO - Running setup.py install for mozlog 11:25:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Running setup.py install for moznetwork 11:25:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Running setup.py install for mozprocess 11:25:09 INFO - Running setup.py install for mozprofile 11:25:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Running setup.py install for mozrunner 11:25:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:25:09 INFO - Running setup.py install for mozscreenshot 11:25:09 INFO - Running setup.py install for moztest 11:25:09 INFO - Running setup.py install for mozversion 11:25:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:25:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:25:10 INFO - Cleaning up... 11:25:10 INFO - Return code: 0 11:25:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, '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 0xf66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', '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 11:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:25:10 INFO - Using env: {'DISPLAY': ':0', 11:25:10 INFO - 'HOME': '/home/cltbld', 11:25:10 INFO - 'LANG': 'en_US.UTF-8', 11:25:10 INFO - 'LANGUAGE': 'en_US:en', 11:25:10 INFO - 'LOGNAME': 'cltbld', 11:25:10 INFO - 'MAIL': '/var/mail/cltbld', 11:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:10 INFO - 'MOZ_NO_REMOTE': '1', 11:25:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:10 INFO - 'NO_EM_RESTART': '1', 11:25:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:10 INFO - 'PWD': '/builds/slave/test', 11:25:10 INFO - 'SHELL': '/bin/bash', 11:25:10 INFO - 'SHLVL': '1', 11:25:10 INFO - 'TERM': 'linux', 11:25:10 INFO - 'TMOUT': '86400', 11:25:10 INFO - 'USER': 'cltbld', 11:25:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', 11:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:10 INFO - '_': '/tools/buildbot/bin/python'} 11:25:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:25:10 INFO - Running setup.py (path:/tmp/pip-fS1L02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:25:10 INFO - Running setup.py (path:/tmp/pip-JofbVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:25:10 INFO - Running setup.py (path:/tmp/pip-utGEpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:25:10 INFO - Running setup.py (path:/tmp/pip-GtzcRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:25:10 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)) 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:25:10 INFO - Running setup.py (path:/tmp/pip-DveOLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:25:10 INFO - Running setup.py (path:/tmp/pip-eJB_l8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:25:10 INFO - Running setup.py (path:/tmp/pip-VBh_Ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:25:10 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)) 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:25:10 INFO - Running setup.py (path:/tmp/pip-THjIzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:25:10 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)) 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:25:10 INFO - Running setup.py (path:/tmp/pip-M3co3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:25:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:25:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:25:10 INFO - Running setup.py (path:/tmp/pip-IYAEu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:25:11 INFO - Running setup.py (path:/tmp/pip-Mxj1ik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:25:11 INFO - Running setup.py (path:/tmp/pip-THLmyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:25:11 INFO - Running setup.py (path:/tmp/pip-KeQXxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:25:11 INFO - Running setup.py (path:/tmp/pip-V6MoxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:11 INFO - Running setup.py (path:/tmp/pip-iN1ZI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:25:11 INFO - Running setup.py (path:/tmp/pip-2Vd1Np-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:25:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:25:11 INFO - Running setup.py (path:/tmp/pip-Gpxtk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:25:11 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)) 11:25:11 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)) 11:25:11 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)) 11:25:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:12 INFO - Downloading blessings-1.6.tar.gz 11:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:25:12 INFO - Installing collected packages: blessings 11:25:12 INFO - Running setup.py install for blessings 11:25:12 INFO - Successfully installed blessings 11:25:12 INFO - Cleaning up... 11:25:12 INFO - Return code: 0 11:25:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:25:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:13 INFO - Reading from file tmpfile_stdout 11:25:13 INFO - Current package versions: 11:25:13 INFO - argparse == 1.2.1 11:25:13 INFO - blessings == 1.6 11:25:13 INFO - blobuploader == 1.2.4 11:25:13 INFO - docopt == 0.6.1 11:25:13 INFO - functools32 == 3.2.3-2 11:25:13 INFO - jsonschema == 2.5.1 11:25:13 INFO - manifestparser == 1.1 11:25:13 INFO - mozInstall == 1.13 11:25:13 INFO - mozcrash == 1.0 11:25:13 INFO - mozdebug == 0.1 11:25:13 INFO - mozdevice == 0.51 11:25:13 INFO - mozfile == 1.2 11:25:13 INFO - mozhttpd == 0.7 11:25:13 INFO - mozinfo == 0.10 11:25:13 INFO - mozleak == 0.1 11:25:13 INFO - mozlog == 3.5 11:25:13 INFO - moznetwork == 0.27 11:25:13 INFO - mozprocess == 0.25 11:25:13 INFO - mozprofile == 0.28 11:25:13 INFO - mozrunner == 6.13 11:25:13 INFO - mozscreenshot == 0.1 11:25:13 INFO - mozsystemmonitor == 0.3 11:25:13 INFO - moztest == 0.8 11:25:13 INFO - mozversion == 1.4 11:25:13 INFO - psutil == 3.1.1 11:25:13 INFO - requests == 1.2.3 11:25:13 INFO - wsgiref == 0.1.2 11:25:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, '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 0xf66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', '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 11:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:25:13 INFO - Using env: {'DISPLAY': ':0', 11:25:13 INFO - 'HOME': '/home/cltbld', 11:25:13 INFO - 'LANG': 'en_US.UTF-8', 11:25:13 INFO - 'LANGUAGE': 'en_US:en', 11:25:13 INFO - 'LOGNAME': 'cltbld', 11:25:13 INFO - 'MAIL': '/var/mail/cltbld', 11:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:13 INFO - 'MOZ_NO_REMOTE': '1', 11:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:13 INFO - 'NO_EM_RESTART': '1', 11:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:13 INFO - 'PWD': '/builds/slave/test', 11:25:13 INFO - 'SHELL': '/bin/bash', 11:25:13 INFO - 'SHLVL': '1', 11:25:13 INFO - 'TERM': 'linux', 11:25:13 INFO - 'TMOUT': '86400', 11:25:13 INFO - 'USER': 'cltbld', 11:25:13 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', 11:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:13 INFO - '_': '/tools/buildbot/bin/python'} 11:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:25:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:25:13 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:14 INFO - Downloading marionette_driver-1.4.0.tar.gz 11:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 11:25:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 11:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:25:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:25:14 INFO - Installing collected packages: marionette-driver, simplejson 11:25:14 INFO - Running setup.py install for marionette-driver 11:25:14 INFO - Running setup.py install for simplejson 11:25:14 INFO - building 'simplejson._speedups' extension 11:25:14 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 11:25:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:25:15 INFO - Successfully installed marionette-driver simplejson 11:25:15 INFO - Cleaning up... 11:25:15 INFO - Return code: 0 11:25:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:25:15 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')]} 11:25:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:25:15 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')]} 11:25:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:25:15 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 0xbf91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdc5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf68d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, '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 0xf66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67240>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', '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 11:25:15 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 11:25:15 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 11:25:15 INFO - Using env: {'DISPLAY': ':0', 11:25:15 INFO - 'HOME': '/home/cltbld', 11:25:15 INFO - 'LANG': 'en_US.UTF-8', 11:25:15 INFO - 'LANGUAGE': 'en_US:en', 11:25:15 INFO - 'LOGNAME': 'cltbld', 11:25:15 INFO - 'MAIL': '/var/mail/cltbld', 11:25:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:15 INFO - 'MOZ_NO_REMOTE': '1', 11:25:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:15 INFO - 'NO_EM_RESTART': '1', 11:25:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:15 INFO - 'PWD': '/builds/slave/test', 11:25:15 INFO - 'SHELL': '/bin/bash', 11:25:15 INFO - 'SHLVL': '1', 11:25:15 INFO - 'TERM': 'linux', 11:25:15 INFO - 'TMOUT': '86400', 11:25:15 INFO - 'USER': 'cltbld', 11:25:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', 11:25:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:15 INFO - '_': '/tools/buildbot/bin/python'} 11:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:25:16 INFO - Cleaning up... 11:25:16 INFO - Return code: 0 11:25:16 INFO - Running post-action listener: _resource_record_post_action 11:25:16 INFO - Running post-action listener: _start_resource_monitoring 11:25:16 INFO - Starting resource monitoring. 11:25:16 INFO - [mozharness: 2017-07-31 18:25:16.236170Z] Finished create-virtualenv step (success) 11:25:16 INFO - [mozharness: 2017-07-31 18:25:16.237215Z] Running install step. 11:25:16 INFO - Running pre-action listener: _resource_record_pre_action 11:25:16 INFO - Running main action method: install 11:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:25:16 INFO - Reading from file tmpfile_stdout 11:25:16 INFO - Detecting whether we're running mozinstall >=1.0... 11:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:25:16 INFO - Reading from file tmpfile_stdout 11:25:16 INFO - Output received: 11:25:16 INFO - Usage: mozinstall [options] installer 11:25:16 INFO - Options: 11:25:16 INFO - -h, --help show this help message and exit 11:25:16 INFO - -d DEST, --destination=DEST 11:25:16 INFO - Directory to install application into. [default: 11:25:16 INFO - "/builds/slave/test"] 11:25:16 INFO - --app=APP Application being installed. [default: firefox] 11:25:16 INFO - mkdir: /builds/slave/test/build/application 11:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:25:34 INFO - Reading from file tmpfile_stdout 11:25:34 INFO - Output received: 11:25:34 INFO - /builds/slave/test/build/application/firefox/firefox 11:25:34 INFO - Running post-action listener: _resource_record_post_action 11:25:34 INFO - [mozharness: 2017-07-31 18:25:34.666753Z] Finished install step (success) 11:25:34 INFO - [mozharness: 2017-07-31 18:25:34.666904Z] Running setup-mitmproxy step. 11:25:34 INFO - Running pre-action listener: _resource_record_pre_action 11:25:34 INFO - Running main action method: setup_mitmproxy 11:25:34 INFO - Skipping: mitmproxy is not required 11:25:34 INFO - Running post-action listener: _resource_record_post_action 11:25:34 INFO - [mozharness: 2017-07-31 18:25:34.667607Z] Finished setup-mitmproxy step (success) 11:25:34 INFO - [mozharness: 2017-07-31 18:25:34.667742Z] Running run-tests step. 11:25:34 INFO - Running pre-action listener: _resource_record_pre_action 11:25:34 INFO - Running pre-action listener: _set_gcov_prefix 11:25:34 INFO - Running main action method: run_tests 11:25:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:25:34 INFO - Python 2.7.3 11:25:34 INFO - Return code: 0 11:25:34 INFO - grabbing minidump binary from tooltool 11:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:25:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf65eb0>, '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 0xf66db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf67240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:25:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:25:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:25:34 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:25:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:25:34 INFO - Return code: 0 11:25:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:25:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:25:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:25:34 INFO - ENV: RUST_BACKTRACE is now 1 11:25:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:25:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:25:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:25:34 INFO - Using env: {'DISPLAY': ':0', 11:25:34 INFO - 'HOME': '/home/cltbld', 11:25:34 INFO - 'LANG': 'en_US.UTF-8', 11:25:34 INFO - 'LANGUAGE': 'en_US:en', 11:25:34 INFO - 'LOGNAME': 'cltbld', 11:25:34 INFO - 'MAIL': '/var/mail/cltbld', 11:25:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:25:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:25:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:25:34 INFO - 'MOZ_NO_REMOTE': '1', 11:25:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:25:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:25:34 INFO - 'NO_EM_RESTART': '1', 11:25:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:25:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:25:34 INFO - 'PWD': '/builds/slave/test', 11:25:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:25:34 INFO - 'RUST_BACKTRACE': '1', 11:25:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:25:34 INFO - 'SHELL': '/bin/bash', 11:25:34 INFO - 'SHLVL': '1', 11:25:34 INFO - 'STYLO_FORCE_ENABLED': '1', 11:25:34 INFO - 'TERM': 'linux', 11:25:34 INFO - 'TMOUT': '86400', 11:25:34 INFO - 'USER': 'cltbld', 11:25:34 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517', 11:25:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:25:34 INFO - '_': '/tools/buildbot/bin/python'} 11:25:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:25:35 INFO - mozversion application_buildid: 20170731173448 11:25:35 INFO - mozversion application_changeset: 87824406b9feb420a3150720707b424d7cee5915 11:25:35 INFO - mozversion application_display_name: Nightly 11:25:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:25:35 INFO - mozversion application_name: Firefox 11:25:35 INFO - mozversion application_remotingname: firefox 11:25:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:25:35 INFO - mozversion application_vendor: Mozilla 11:25:35 INFO - mozversion application_version: 56.0a1 11:25:35 INFO - mozversion platform_buildid: 20170731173448 11:25:35 INFO - mozversion platform_changeset: 87824406b9feb420a3150720707b424d7cee5915 11:25:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:25:35 INFO - mozversion platform_version: 56.0a1 11:25:35 INFO - using testdate: 1501525535 11:25:35 INFO - actual date: 1501525535 11:25:35 INFO - starting webserver on 'localhost:38860' 11:25:35 INFO - SUITE-START | Running 2 tests 11:25:35 INFO - TEST-START | dromaeo_css 11:25:35 INFO - Initialising browser for dromaeo_css test... 11:25:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38860/getInfo.html -profile /tmp/tmpmBIfXy/profile 11:25:35 INFO - TEST-INFO | started process 3335 (/builds/slave/test/build/application/firefox/firefox http://localhost:38860/getInfo.html) 11:25:42 INFO - TEST-INFO | 3335: exit 0 11:25:42 INFO - Browser initialized. 11:25:42 INFO - Running cycle 1/1 for dromaeo_css test... 11:25:42 INFO - TEST-INFO | started process 3561 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmBIfXy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:25:43 INFO - PID 3561 | 11:25:43 INFO - PID 3561 | (/builds/slave/test/build/application/firefox/firefox:3615): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:25:43 INFO - PID 3561 | 11:25:54 INFO - PID 3561 | RSS: Main: 173563904 11:25:54 INFO - PID 3561 | 11:28:54 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:38860/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38860/tests/dromaeo/cssquery-ext.html) 11:28:55 INFO - PID 3561 | RSS: Main: 175390720 11:28:55 INFO - PID 3561 | 11:31:57 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:38860/tests/dromaeo/cssquery-ext.html (next: http://localhost:38860/tests/dromaeo/cssquery-jquery.html) 11:31:58 INFO - PID 3561 | RSS: Main: 173449216 11:31:58 INFO - PID 3561 | 11:35:00 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:38860/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38860/tests/dromaeo/cssquery-mootools.html) 11:35:00 INFO - PID 3561 | RSS: Main: 175665152 11:35:00 INFO - PID 3561 | 11:38:02 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:38860/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38860/tests/dromaeo/cssquery-prototype.html) 11:38:03 INFO - PID 3561 | RSS: Main: 173498368 11:38:03 INFO - PID 3561 | 11:41:07 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:38860/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38860/tests/dromaeo/cssquery-yui.html) 11:41:07 INFO - PID 3561 | RSS: Main: 177184768 11:41:07 INFO - PID 3561 | 11:44:09 INFO - PID 3561 | Cycle 1(1): loaded http://localhost:38860/tests/dromaeo/cssquery-yui.html (next: http://localhost:38860/tests/dromaeo/cssquery-dojo.html) 11:44:09 INFO - PID 3561 | RSS: Main: 177770496 11:44:09 INFO - PID 3561 | 11:44:09 INFO - PID 3561 | __start_tp_report 11:44:09 INFO - PID 3561 | _x_x_mozilla_page_load 11:44:09 INFO - PID 3561 | _x_x_mozilla_page_load_details 11:44:09 INFO - PID 3561 | |i|pagename|runs| 11:44:09 INFO - PID 3561 | |0;dojo.html;3096.0711786464053;3132.3108916038473;3132.921676958077;3154.369126174766;3175.857086431112;6084.148219249303;6224.84437889053;6225.159603453538;6248.03155510896;6281.34045925177;6039.486643635296;6174.629522228658;6181.598196117249;6209.099680546318;6219.533534984883;5661.122526008455;5682.6306290091015;5707.486326230638;5713.485786279234;5757.395473475288;5719.628224165416;5738.196652468658;5742.569307301948;5795;5835.474807267345;5702.116171993348;5709.4290570942985;5767.192593036978;5775.971120144393;5842.036064049426;5510.9448905511235;5627.465390787909;5694.032014557535;5761.452661997104;5767.106098554731;5453.890922181534;5582.8325150245555;5625.043742563774;5642.379338272786;5650.180723795068;6020.548458865603;6105.847353816146;6142.447179753799;6196;6213.130161777355;6515;6616;6622.73509059637;6688.9665551672415;6701.463882889358;6627.93372066278;6669.733210671568;6673.733050677967;6702.564333318319;6703.195616525999;6185.0413185955795;6186.783462578788;6191.907121393183;6202.596831205957;6204.224471941007;6791.626460544718;6798.66006699663;6821.113255276881;6821.556598821061;6831.419329356961;6421.775237866652;6508.446782023487;6517.869642607121;6523.934760652332;6524.902126468107;6550.6069635822005;6573.868522629521;6583;6591.868162636721;6631.9388897776125;6551.21385433751;6592.9340706593275;6595.0766892635065;6623.668816559153;6714.563553369016;6562.835929101715;6569.83575410609;6634.170728658918;6725.159355080615;6736;5347.81282655113;5367.597430192751;5369.328833895763;5373.865653358697;5375.381831089397;4585.72485650862;4644.303354496852;4657.720536767804;4689.296605509201;4723.220668589713;5604.159376093537;5698.487136157766;5711.543076553866;5764.164196191528;5772;6560.409563139245;6656.900146497806;6673.866522669519;6715.227748808852;6723.025161351577;5805.88388232233;5819.301683797971;5832.766689332379;5836.533077353802;5842.036064049385;5669.376368599451;5863.882722345529;5917.378675239124;5938.109283607407;5951.7619295227705;6295.118683384329;6389.616623002635;6392.584482008561;6423.325550817097;6503.674816259263;6635.469162467088;6684.966575167093;6690.765823196165;6698.162729658793;6746.089277947414;6426.485881129405;6437.0666253392055;6439.678016099083;6507.023946408077;6531.085648009187;6524.380183882524;6628.171478565179;6631.966840165768;6636.701348439428;6647.069410282467;6568.6058836469965;6655.733770649314;6678.23200331968;6682.69927853238;6760;6413.326600706859;6424.357564243725;6429.839254018687;6434.871302574016;6444.13004244421;6352.809415717536;6412.807615771534;6434.260060093149;6439.291677915519;6443.323451037761;6330.715117819617;6353.68231588428;6355;6360.522960777867;6362.427381535684;6463.935360646334;6491.805245842632;6506.544541882212;6570.244421891543;6616.702248398929;6319.684015799284;6334.271558770801;6396.71214795326;6402.10370548133;6409.903851442139 11:44:09 INFO - PID 3561 | |1;ext.html;801.9398545109115;866.2982983783135;894.7360528644049;896.0725648953332;1003.8193125237464;29351.55972660409;30321.241968950788;39382.60617393825;40211.19577608453;40304.395434068516;40471;40798.59201407985;40910.18179636406;41109.38335924964;41117.17765644685;7242.674079666428;7658.119316278616;7816.17930117338;7817;7873.212678732139;7573.545587264782;7729.922700773005;7735;7737.110232323271;7741.109772376192;7658.119316278644;7678.117016543113;7689.577073260996;7702.46082774206;7772.689092436296;7715.189905059972;7746.573938433384;7751.844963100734;7758.534487930714;7759.922400775977;7645.3119219269975;7707.576083315415;7708.152103268636;7709.344705699966;7709.807254818618;38089;38188.80905595482;38362.232755345016;38507;38581;3503.1942653189653;3512.016635342108;3518.2259902821593;3545.8758943436856;3547.5033495310677;30746.231344216572;30776.768929242804;30798.384032319227;30894.845525772453;31210;4637.234856248715;4852.2721591761165;4867;4882.267659851015;4909.21452567591;184283;184796;185807;186110;186791;47005;47256.291155632;47293.5270647296;47293.5270647296;47435.76282118636;49632;49944.50055499471;50169;50214.24678629824;50316.24525632045;14949.626259343604;15268.770968435483;15285;15317.387304507918;15324.310406031755;10398.844017339747;10614.628488002883;11361.886381136082;11601.709957251136;12452.81320780189;14220.786688199685;14222.2177780221;14318.498852540111;14318.85681143196;14381.209033503257;5796.1305804129715;5811.4479124483105;5895.557833162444;5911.9704401478575;5912.201852749909;979.5053497983473;995.7759504111661;1004.3321191407632;1025.8820235672845;1031.0874875734878;22863.31410057701;22929.426764331027;23059.769402306098;23408.18071367494;23440.882795585912;1077.4612693653173;1079.8704155501391;1111.1666250312267;1114.7213196700825;1118.0831717991332;12014.098942579167;12025.218360806519;12167;12359.25844449336;12502.437390317276;209932;210153;212996;213013;213923;54299.72850135724;54324.72837635865;54444;54829.45170548323;54881.72559137179;1443.8628330308604;1459.7591397419308;1491.1053367979125;1493.8954273200773;1503.8796896248273;21956.89021554882;22138.88930555337;22829.88585057064;23156;23180.652290215996;37927.43108853425;38369.80815095906;38473;38549.61450385572;38856.222875542895;185554;185637;186599;186680;187003;30284.84857575786;31242.21894452657;31439.21401964969;33530.491127898815;34000.489992650626;41793.48331205498;43611;44085.77957110194;44697.776511118536;45107.7744611288;26434.471310574067;27099.72900271051;27424.314392140357;27544.17367478979;27660.72339276662;26057.218283451526;26545.60181597239;27038;27282.72717272802;27299.727002730513;33371.66628333783;34644;34736.82631586826;35053.29893402067;35307.646923531465;29490.705092948796;33706.66293337035;34283.314333713686;34456;34969.65030349664;24562.894669739548;24835.50328993374;24854.254372368858;25040.123595674064;25696.486070278115 11:44:09 INFO - PID 3561 | |2;jquery.html;573.2146958666627;576.6626523483761;578.7511370110851;580.1529766540849;594.1207013619843;22594.096236150555;23433.179838705648;23492.17777377788;23583.882080589618;23602.173923912644;27164.864175679093;28169.436611267764;28191.29521761957;28291.434171316614;28305.150845474618;7098.787036388903;7259.564426134449;7263.709451621929;7267.055282813227;7268.418526517892;6702.43029342504;7051.647417629124;7103.822404439905;7161.033260509843;7224.8193795155275;7049.612271325075;7075.044868942704;7094.716211351565;7094.822629434254;7101.431885449178;7035.296470352975;7082.32717891802;7085.964570177116;7088.1494220693585;7091.609961452118;6836.350546698056;6845.931540684579;6891.586504809728;6925;6926.930730692729;31748;31992.680073199437;32930;33027.3394532108;33159.834200829086;1947.980520194794;2000.0899590686204;2006.528465810548;2008.5480766827493;2011.3664195778283;20358.898205509027;20974.475638109016;21005.68491472629;21037.158513659437;21039.368818935458;2362.4856437700137;2374.2046414451006;2428.5507181171365;2458.8524688518746;2465.716442609105;133421;137272;137901;138082;138563.30718346345;20113.74767606917;22078.558428831333;22563.43591410228;22677.546449070927;23172.53654926892;43861.342079868824;43882.341764873556;43936;43966;43988.12023759507;11748.88251117495;11840.467178976967;11929.761404771856;11995.520179192908;12242.877571224173;7908.209179082046;9818.852717209247;9831.410115393099;9900.55447504864;9950.850737238947;9440.433573985445;11075.280106793032;11343.149263805248;11379.431028448544;11672.824907626393;3590.8204589770407;3967.6429121379215;4048.1903619276263;4174.4364510791265;4447.73313601185;926.1618235496886;931.1433481197315;931.7950050988907;959.4435227568133;981.617169303972;19158.521036974187;19376.903115484612;19948.102335394942;22961.425964350692;25071.62392564113;1012.2104758288547;1029.8043371759343;1038.3302769713493;1048.4128887822844;1063.4204358624568;10922.1808364373;10996.835047474135;11183.329000259848;11216.719582010352;11287.661370158909;495465;504799;509624;512452;513621;126784.36607817086;128987.35506322408;129681;131768;132945;1226.3316492511603;1248.993755031219;1263.5009171377071;1268.4989429175423;1274.847018357803;18120;18150.18324175389;18174;18299;18965;58119.4188058114;58826.705866470395;59857;60286.698566506886;60815.695921520106;71844.64077679579;74610.62694686491;75422.24577754152;75638.62180689062;75961.24038759542;12429.627111186679;13030.869691302965;14436.422543098159;14629.634259143606;15035.699286014436;23546.882265588563;23707;23917.880410597834;23988.28035158948;23990.160344387863;18105.185266662767;19096.809031909503;19269.22923083117;19374.128164232363;19493.317733879245;14620.634484137981;14959.25203739787;15981.200939952723;16139.919300403422;16414.17929103516;18707.71938420952;20062;20344.694829577864;20345.084471199127;20406.59186816285;15211;15322.310496027483;15375.61560960985;15431.691366172388;15464.072155670696;18843.152058157142;19232.942188179786;19345.806541934962;19484.415467535997;19718.80281197227 11:44:09 INFO - PID 3561 | |3;mootools.html;1338.7456383287174;1400.6778440958576;1402.5792262321308;1404.276797449313;1418.9929050354754;13756.312184390777;14311.355988980495;14388.42446302148;14402.783958240609;14408.135511869295;13473.3263336833;14407.78388324176;14592.197429141394;14594.48919287825;14626;2472.171822439485;2517.6349429332736;2522.8738563071865;2524.911628093017;2526.2547548473244;2573.3437973316777;2612.6081087836787;2647.6822781266274;2736.343277613378;2743.2181828178973;2649.6422982897257;2659.880305386262;2713.71505991871;2715.158300926709;2716.6739991201084;2659.56117240656;2690.0988168963227;2708.5530887403556;2710.3495161161377;2724.741149590786;2570.177543186181;2593.7276585958393;2597.181887705367;2647.3249321423104;2648.020232513963;13598.184108953494;13816.723665526633;13838.654033649138;13842.307884605729;13842.86157138436;7266.854662906765;7520.962395188044;7527.736529221505;7528.661210245552;7542.547447153188;4728.598069164125;4930.926036109461;5076.06092872816;5102.591792656615;5122.078025955327;1656.8674506039488;1662.2104500362352;1703.2505697493186;1721.7933847938202;1725;21864.23475178361;22159.667604985938;22326.106955721913;22399.552008959894;22436.887815560982;6566.967165164144;6620.768273110418;6676.065350850885;6800.115984921928;6835.316468353125;17775;17798.288068477374;17801.465956021082;17826.5543361417;17886.642267154584;7337.559746415125;7642.159362470124;7644.350230230492;7649.770506884803;7654;6734.831629209309;6734.932650673529;6804.76183333581;6848.315168483212;6880.793576192722;5205.687658740488;5316.415194328621;5393.649412788156;5399.568034557226;5478.753456094406;1605;1637.8935369200963;1662.1606088925016;1715.408184176457;1724.1982478147722;790.7588185603446;830.339879795564;833.8540755367786;835.3400813357501;850.0691742542031;7083.92916070843;7164.964175179195;7542.094948606093;7569.810754731176;7624.885626715603;889.3063410539789;896.3635818568889;933.2394098809449;941.9529023548795;967.4243824924159;3937.330653788863;4059.939100913489;4157.958420415757;4384.780760961939;4599.195140850338;17616.50259727912;18142.63714725698;18774.436766897015;18823.435296941112;18824.623507529774;18175.54768057347;18401.447956561326;18528.16623251957;18678.34625788091;18688.626227475645;10082.29423940317;10462.947685261524;10465.510029280991;10473;10476.790464190673;6591.373819487141;6982.162140543167;7122.501424900414;7137.500374973702;7226.638668066471;15073.924630376778;15711.685766284381;16353;16355.182240888145;16442.424515141913;16365.427210047592;16499.917500412423;16500.587485312484;16555.178930317896;16666.916665416597;11118.722031948942;11310.095192384753;11311.604093856675;11315.094792416752;11317.490712918103;12602.11785175029;12646.30445325516;12651.810222846481;12669.176503527242;12770.936145319214;9342.766430839283;9687.262012015895;9872.901270987199;9915.405075695482;10086.949565252127;9306.674266400643;9595.13643772064;9772.26707996889;9848.606055757977;9886.85169722469;8073.959630201812;8184.877226841483;8189.836203276021;8452.32381409498;8814.206721395105;5949.7620095197435;6211.81364559064;6294.055891616111;6316.210473690789;6372.776952806629;6207.689615519296;6286.339934307015;6326;6451.967740161457;6468.417842394207 11:44:09 INFO - PID 3561 | |4;prototype.html;499.63776262209905;501.9331882199761;519.2652396858446;522.2610006840321;526.6076772804262;6134.263888333407;6141.9692901535545;6153.600015998957;6174.425521492019;6254.937450625493;5834.199584199576;6040.637561746287;6050.976100892901;6127.264728232607;6156.630602163873;4946.851594452154;4956.87607809804;4984.087491319315;4991.700497970124;5008.624353173508;4801;4981.252812078199;5033.320501732274;5038.773255203525;5051.722155281458;4868.78090485929;4883.438404583465;4940.135476291653;4943.23379876118;4955.628327875405;4878.634102442331;4898.93816364772;4900.411950565919;4925.926111108319;4948.604111671058;4435.578620031092;4469.664775141845;4474.664400169968;4491.9775401123115;4515.977420112911;5923.911141332884;5944.583879128462;5949.553783466257;5965.612235204741;6053.364396738367;5617.4382561743905;5620.718964051781;5693.658380497183;5710.77156913723;5731.197632331477;6324.7470101195895;6344.524160687967;6396.456301214403;6407.789312687116;6451.645159516224;4818.253170758538;4863.635227357927;4898.338724272249;4903.828366007208;4948.57937075349;6779.288174741581;6864.862702745967;6894.827879260538;6929;6961.303869613049;4905.681130726492;4988.4263309719845;4996.2505624156665;5008.69947803133;5033.496650334937;5066.189409694432;5111.565516931102;5128.9230661540105;5144.331236939249;5151.716655583904;5661.377248502661;5665.12190610456;5724.626089738516;5755.453231942959;5759.625624334405;6446.258680251737;6474.805755827333;6481.708323125471;6525.347465253437;6590.439812615981;1655.3130450862757;1707.888987215827;1711.2727090986282;1715.7340612205128;1761.8414342708961;1194.2655267010725;1220.5544976083665;1224.2960297828606;1242.4781591731314;1245.227958665615;5589.133684278943;5609.579281553818;5676.744546495418;5681.772729090872;5711.143328500758;6514.315996820361;6559.967200164064;6616.569922955089;6759.493038022168;6769.492288078315;5512.862178445571;5739.2252045973255;5745;5811.94188058114;5869.8239052828485;3550.6626870447267;3581.265840502743;3596.9280614387567;3597.6941959933697;3624.4382120771324;6401.807945761635;6442.971803252464;6480.773172939019;6487.351264873475;6496.375906023494;6809.761658342033;6953.33943275388;6955.130608673916;6964.79105626832;6969.9303006969285;6465.709043093166;6504.38208370204;6504.512161587805;6511.934880651228;6544.869102617921;6612.966935165294;6658.535122273092;6713.697883595152;6719.630420326929;6719.731210751711;6531.934680653133;6592.604443733391;6596.934030659632;6711.597304161766;6750.8397312859415;6424.582402143846;6499.3175716549085;6509.251436084911;6561.278259391368;6602.504812139013;4969.975150124226;4979.178435558092;4985.576226020684;4992.750362481789;5042.672226305279;6664.633445160563;6761.729530818712;6782.966085169543;6824.215215250111;6828.487863410165;6473.676316184266;6485.44873685742;6530.249021362414;6579.309172537006;6601.867962640817;6158.815235542941;6447.129637498878;6483.546151769331;6585.703643336157;6660.333966603301;6154.292256390572;6434.101939927827;6446.742130314735;6497.642629655415;6512.3162067982175;6455.644939528371;6517.967410162919;6557.245916719638;6577.717345117656;6588.4399826013405;6110.358412366815;6260.186175797299;6298.937010629835;6326.272478665012;6345.048242763438 11:44:09 INFO - PID 3561 | |5;yui.html;890.5769759364301;903.0608167505799;921.9815603687931;928.4290161550645;930.548683888314;18585.349512767058;19202.61594768104;19544.804551954476;19574.608507829835;22134.667979980273;20739.896300518514;21778.673319900176;21782.128714851428;21943.122275109017;22003.559928801413;1001.1340190735035;1035.0580971316103;1037.2998226197324;1039.1946241662697;1039.6205385034445;1027.404105618743;1037.6316407675279;1038.226521241676;1038.392540363888;1039.9584016639326;980.3186785184264;1010.8736407949007;1066.3335415365398;1066.978660426791;1069.4492336446735;1061.5488417422603;1063.7181146996052;1063.930844495109;1065.7815147894662;1066.9573217071347;772.5441989226327;773.1572585881416;773.307889438949;778.7624774443792;778.8286576953061;18685.252589896387;19049.809501904943;19186.712199317022;19344.41966741;19511.121999510055;20594;20841.37475875726;21185.68221476679;21221.469463263387;21309;15914.204289785464;16167.272472738756;16184.75722864158;16213.108279044647;16224.513264602081;3567.9643203567894;3584.6773790358993;3592.964070359289;3595.622459641726;3599.6400359964055;124868.37565812113;126692;129189;131631;132883;16167.919160404123;16525.421610243582;16645.16774161287;16682.249298781582;16685.416010439578;28515.71484285172;29569.704302956696;30402.087937361914;30548.694513054586;30565.23586910345;8091.55496447701;8356.791080222922;8372.372072094617;8397.832043359222;8411.579421028924;4159.542450330461;4232.280512312914;4235.0682849773;4237.512686041083;4253.80857861397;4752.5485078917445;4852.927206091911;4869.464358920516;4880.536349046835;4880.902381952412;949.1694767078806;977.5503268496572;990.9801803964025;992.9177196855318;993.7217579077725;644.3485058982254;671.4796033074407;691.5919607431639;708.0688894104339;715.4205093873978;11170.704642130591;11908.404579770977;11950.940245298892;12165.33090680021;12220.327881966577;644.6100109433819;667.9365460281363;679.3376457953456;688.5490004047357;690.3855568544;5127.256547800623;5216.914604669737;5338.199270109515;5502.642328248651;5701.543876489954;105362.4731876351;105445.47277263718;106026;106775.46612266889;110201.44899275452;84571.57714211389;91091.54454227687;91110;91387;93825.5308723452;71759.6412017947;72639.63680181565;75732;77736.61131694418;80154.59922700466;11581.247218930743;11773.529058837894;11779.057675385777;11894.405279736151;12288.569900053455;33176.33647327088;34829;35361.82319088388;36144.81927590345;36183.27633447263;43185.56814431815;44752.77623611861;45961.540384595726;46429.303560445944;47182;17760.55598610045;18332.908335458236;18400.631987360444;18422.815771842645;18525.53686157857;15867.285972131513;16101.75847362267;16114.435994740128;16228.837711622733;16283.185840708155;18170.27318907229;18339.816601833812;18590.721139183195;18595.34916277924;18628.81371186325;18613.255469781598;18706.345277915207;18791.624167516846;19082.713759293343;19391.612167756848;17420.912895435442;17481.300747970447;17745.11274436299;17888.642227155124;18029.909850450666;10456.424896630759;10555.680539932508;11359;11636.476358564054;11668.124890633406;12054.51781928713;12057.276563406223;12534.623961281177;12619.369031548202;12870.67823304425 11:44:09 INFO - PID 3561 | __end_tp_report 11:44:09 INFO - PID 3561 | __start_cc_report 11:44:09 INFO - PID 3561 | _x_x_mozilla_cycle_collect,372 11:44:09 INFO - PID 3561 | __end_cc_report 11:44:09 INFO - PID 3561 | __startTimestamp1501526649806__endTimestamp 11:44:09 INFO - PID 3561 | 11:44:09 INFO - PID 3561 | ------- Summary: start ------- 11:44:09 INFO - PID 3561 | Number of tests: 6 11:44:09 INFO - PID 3561 | 11:44:09 INFO - PID 3561 | [#0] dojo.html Cycles:165 Average:6116.49 Median:6360.52 stddev:713.33 (11.2%) stddev-sans-first:675.02 11:44:09 INFO - PID 3561 | Values: 3096.1 3132.3 3132.9 3154.4 3175.9 6084.1 6224.8 6225.2 6248.0 6281.3 6039.5 6174.6 6181.6 6209.1 6219.5 5661.1 5682.6 5707.5 5713.5 5757.4 5719.6 5738.2 5742.6 5795.0 5835.5 5702.1 5709.4 5767.2 5776.0 5842.0 5510.9 5627.5 5694.0 5761.5 5767.1 5453.9 5582.8 5625.0 5642.4 5650.2 6020.5 6105.8 6142.4 6196.0 6213.1 6515.0 6616.0 6622.7 6689.0 6701.5 6627.9 6669.7 6673.7 6702.6 6703.2 6185.0 6186.8 6191.9 6202.6 6204.2 6791.6 6798.7 6821.1 6821.6 6831.4 6421.8 6508.4 6517.9 6523.9 6524.9 6550.6 6573.9 6583.0 6591.9 6631.9 6551.2 6592.9 6595.1 6623.7 6714.6 6562.8 6569.8 6634.2 6725.2 6736.0 5347.8 5367.6 5369.3 5373.9 5375.4 4585.7 4644.3 4657.7 4689.3 4723.2 5604.2 5698.5 5711.5 5764.2 5772.0 6560.4 6656.9 6673.9 6715.2 6723.0 5805.9 5819.3 5832.8 5836.5 5842.0 5669.4 5863.9 5917.4 5938.1 5951.8 6295.1 6389.6 6392.6 6423.3 6503.7 6635.5 6685.0 6690.8 6698.2 6746.1 6426.5 6437.1 6439.7 6507.0 6531.1 6524.4 6628.2 6632.0 6636.7 6647.1 6568.6 6655.7 6678.2 6682.7 6760.0 6413.3 6424.4 6429.8 6434.9 6444.1 6352.8 6412.8 6434.3 6439.3 6443.3 6330.7 6353.7 6355.0 6360.5 6362.4 6463.9 6491.8 6506.5 6570.2 6616.7 6319.7 6334.3 6396.7 6402.1 6409.9 11:44:09 INFO - PID 3561 | 11:44:09 INFO - PID 3561 | [#1] ext.html Cycles:180 Average:36090.63 Median:34550.00 stddev:50498.99 (146.2%) stddev-sans-first:50571.13 11:44:09 INFO - PID 3561 | Values: 801.9 866.3 894.7 896.1 1003.8 29351.6 30321.2 39382.6 40211.2 40304.4 40471.0 40798.6 40910.2 41109.4 41117.2 7242.7 7658.1 7816.2 7817.0 7873.2 7573.5 7729.9 7735.0 7737.1 7741.1 7658.1 7678.1 7689.6 7702.5 7772.7 7715.2 7746.6 7751.8 7758.5 7759.9 7645.3 7707.6 7708.2 7709.3 7709.8 38089.0 38188.8 38362.2 38507.0 38581.0 3503.2 3512.0 3518.2 3545.9 3547.5 30746.2 30776.8 30798.4 30894.8 31210.0 4637.2 4852.3 4867.0 4882.3 4909.2 184283.0 184796.0 185807.0 186110.0 186791.0 47005.0 47256.3 47293.5 47293.5 47435.8 49632.0 49944.5 50169.0 50214.2 50316.2 14949.6 15268.8 15285.0 15317.4 15324.3 10398.8 10614.6 11361.9 11601.7 12452.8 14220.8 14222.2 14318.5 14318.9 14381.2 5796.1 5811.4 5895.6 5912.0 5912.2 979.5 995.8 1004.3 1025.9 1031.1 22863.3 22929.4 23059.8 23408.2 23440.9 1077.5 1079.9 1111.2 1114.7 1118.1 12014.1 12025.2 12167.0 12359.3 12502.4 209932.0 210153.0 212996.0 213013.0 213923.0 54299.7 54324.7 54444.0 54829.5 54881.7 1443.9 1459.8 1491.1 1493.9 1503.9 21956.9 22138.9 22829.9 23156.0 23180.7 37927.4 38369.8 38473.0 38549.6 38856.2 185554.0 185637.0 186599.0 186680.0 187003.0 30284.8 31242.2 31439.2 33530.5 34000.5 41793.5 43611.0 44085.8 44697.8 45107.8 26434.5 27099.7 27424.3 27544.2 27660.7 26057.2 26545.6 27038.0 27282.7 27299.7 33371.7 34644.0 34736.8 35053.3 35307.6 29490.7 33706.7 34283.3 34456.0 34969.7 24562.9 24835.5 24854.3 25040.1 25696.5 11:44:09 INFO - PID 3561 | 11:44:09 INFO - PID 3561 | [#2] jquery.html Cycles:180 Average:37147.16 Median:23519.53 stddev:85486.41 (363.5%) stddev-sans-first:85682.11 11:44:09 INFO - PID 3561 | Values: 573.2 576.7 578.8 580.2 594.1 22594.1 23433.2 23492.2 23583.9 23602.2 27164.9 28169.4 28191.3 28291.4 28305.2 7098.8 7259.6 7263.7 7267.1 7268.4 6702.4 7051.6 7103.8 7161.0 7224.8 7049.6 7075.0 7094.7 7094.8 7101.4 7035.3 7082.3 7086.0 7088.1 7091.6 6836.4 6845.9 6891.6 6925.0 6926.9 31748.0 31992.7 32930.0 33027.3 33159.8 1948.0 2000.1 2006.5 2008.5 2011.4 20358.9 20974.5 21005.7 21037.2 21039.4 2362.5 2374.2 2428.6 2458.9 2465.7 133421.0 137272.0 137901.0 138082.0 138563.3 20113.7 22078.6 22563.4 22677.5 23172.5 43861.3 43882.3 43936.0 43966.0 43988.1 11748.9 11840.5 11929.8 11995.5 12242.9 7908.2 9818.9 9831.4 9900.6 9950.9 9440.4 11075.3 11343.1 11379.4 11672.8 3590.8 3967.6 4048.2 4174.4 4447.7 926.2 931.1 931.8 959.4 981.6 19158.5 19376.9 19948.1 22961.4 25071.6 1012.2 1029.8 1038.3 1048.4 1063.4 10922.2 10996.8 11183.3 11216.7 11287.7 495465.0 504799.0 509624.0 512452.0 513621.0 126784.4 128987.4 129681.0 131768.0 132945.0 1226.3 1249.0 1263.5 1268.5 1274.8 18120.0 18150.2 18174.0 18299.0 18965.0 58119.4 58826.7 59857.0 60286.7 60815.7 71844.6 74610.6 75422.2 75638.6 75961.2 12429.6 13030.9 14436.4 14629.6 15035.7 23546.9 23707.0 23917.9 23988.3 23990.2 18105.2 19096.8 19269.2 19374.1 19493.3 14620.6 14959.3 15981.2 16139.9 16414.2 18707.7 20062.0 20344.7 20345.1 20406.6 15211.0 15322.3 15375.6 15431.7 15464.1 18843.2 19232.9 19345.8 19484.4 19718.8 11:44:09 INFO - PID 3561 | 11:44:09 INFO - PID 3561 | [#3] mootools.html Cycles:180 Average:8439.60 Median:2659.72 stddev:5827.98 (219.1%) stddev-sans-first:5819.90 11:44:09 INFO - PID 3561 | Values: 1338.7 1400.7 1402.6 1404.3 1419.0 13756.3 14311.4 14388.4 14402.8 14408.1 13473.3 14407.8 14592.2 14594.5 14626.0 2472.2 2517.6 2522.9 2524.9 2526.3 2573.3 2612.6 2647.7 2736.3 2743.2 2649.6 2659.9 2713.7 2715.2 2716.7 2659.6 2690.1 2708.6 2710.3 2724.7 2570.2 2593.7 2597.2 2647.3 2648.0 13598.2 13816.7 13838.7 13842.3 13842.9 7266.9 7521.0 7527.7 7528.7 7542.5 4728.6 4930.9 5076.1 5102.6 5122.1 1656.9 1662.2 1703.3 1721.8 1725.0 21864.2 22159.7 22326.1 22399.6 22436.9 6567.0 6620.8 6676.1 6800.1 6835.3 17775.0 17798.3 17801.5 17826.6 17886.6 7337.6 7642.2 7644.4 7649.8 7654.0 6734.8 6734.9 6804.8 6848.3 6880.8 5205.7 5316.4 5393.6 5399.6 5478.8 1605.0 1637.9 1662.2 1715.4 1724.2 790.8 830.3 833.9 835.3 850.1 7083.9 7165.0 7542.1 7569.8 7624.9 889.3 896.4 933.2 942.0 967.4 3937.3 4059.9 4158.0 4384.8 4599.2 17616.5 18142.6 18774.4 18823.4 18824.6 18175.5 18401.4 18528.2 18678.3 18688.6 10082.3 10462.9 10465.5 10473.0 10476.8 6591.4 6982.2 7122.5 7137.5 7226.6 15073.9 15711.7 16353.0 16355.2 16442.4 16365.4 16499.9 16500.6 16555.2 16666.9 11118.7 11310.1 11311.6 11315.1 11317.5 12602.1 12646.3 12651.8 12669.2 12770.9 9342.8 9687.3 9872.9 9915.4 10086.9 9306.7 9595.1 9772.3 9848.6 9886.9 8074.0 8184.9 8189.8 8452.3 8814.2 5949.8 6211.8 6294.1 6316.2 6372.8 6207.7 6286.3 6326.0 6452.0 6468.4 11:44:09 INFO - PID 3561 | 11:44:09 INFO - PID 3561 | [#4] prototype.html Cycles:180 Average:5483.33 Median:6045.81 stddev:1537.06 (25.4%) stddev-sans-first:1495.16 11:44:09 INFO - PID 3561 | Values: 499.6 501.9 519.3 522.3 526.6 6134.3 6142.0 6153.6 6174.4 6254.9 5834.2 6040.6 6051.0 6127.3 6156.6 4946.9 4956.9 4984.1 4991.7 5008.6 4801.0 4981.3 5033.3 5038.8 5051.7 4868.8 4883.4 4940.1 4943.2 4955.6 4878.6 4898.9 4900.4 4925.9 4948.6 4435.6 4469.7 4474.7 4492.0 4516.0 5923.9 5944.6 5949.6 5965.6 6053.4 5617.4 5620.7 5693.7 5710.8 5731.2 6324.7 6344.5 6396.5 6407.8 6451.6 4818.3 4863.6 4898.3 4903.8 4948.6 6779.3 6864.9 6894.8 6929.0 6961.3 4905.7 4988.4 4996.3 5008.7 5033.5 5066.2 5111.6 5128.9 5144.3 5151.7 5661.4 5665.1 5724.6 5755.5 5759.6 6446.3 6474.8 6481.7 6525.3 6590.4 1655.3 1707.9 1711.3 1715.7 1761.8 1194.3 1220.6 1224.3 1242.5 1245.2 5589.1 5609.6 5676.7 5681.8 5711.1 6514.3 6560.0 6616.6 6759.5 6769.5 5512.9 5739.2 5745.0 5811.9 5869.8 3550.7 3581.3 3596.9 3597.7 3624.4 6401.8 6443.0 6480.8 6487.4 6496.4 6809.8 6953.3 6955.1 6964.8 6969.9 6465.7 6504.4 6504.5 6511.9 6544.9 6613.0 6658.5 6713.7 6719.6 6719.7 6531.9 6592.6 6596.9 6711.6 6750.8 6424.6 6499.3 6509.3 6561.3 6602.5 4970.0 4979.2 4985.6 4992.8 5042.7 6664.6 6761.7 6783.0 6824.2 6828.5 6473.7 6485.4 6530.2 6579.3 6601.9 6158.8 6447.1 6483.5 6585.7 6660.3 6154.3 6434.1 6446.7 6497.6 6512.3 6455.6 6518.0 6557.2 6577.7 6588.4 6110.4 6260.2 6298.9 6326.3 6345.0 11:44:09 INFO - PID 3561 | 11:44:09 INFO - PID 3561 | [#5] yui.html Cycles:180 Average:22168.87 Median:19527.96 stddev:30369.30 (155.5%) stddev-sans-first:30412.46 11:44:09 INFO - PID 3561 | Values: 890.6 903.1 922.0 928.4 930.5 18585.3 19202.6 19544.8 19574.6 22134.7 20739.9 21778.7 21782.1 21943.1 22003.6 1001.1 1035.1 1037.3 1039.2 1039.6 1027.4 1037.6 1038.2 1038.4 1040.0 980.3 1010.9 1066.3 1067.0 1069.4 1061.5 1063.7 1063.9 1065.8 1067.0 772.5 773.2 773.3 778.8 778.8 18685.3 19049.8 19186.7 19344.4 19511.1 20594.0 20841.4 21185.7 21221.5 21309.0 15914.2 16167.3 16184.8 16213.1 16224.5 3568.0 3584.7 3593.0 3595.6 3599.6 124868.4 126692.0 129189.0 131631.0 132883.0 16167.9 16525.4 16645.2 16682.2 16685.4 28515.7 29569.7 30402.1 30548.7 30565.2 8091.6 8356.8 8372.4 8397.8 8411.6 4159.5 4232.3 4235.1 4237.5 4253.8 4752.5 4852.9 4869.5 4880.5 4880.9 949.2 977.6 991.0 992.9 993.7 644.3 671.5 691.6 708.1 715.4 11170.7 11908.4 11950.9 12165.3 12220.3 644.6 667.9 679.3 688.5 690.4 5127.3 5216.9 5338.2 5502.6 5701.5 105362.5 105445.5 106026.0 106775.5 110201.4 84571.6 91091.5 91110.0 91387.0 93825.5 71759.6 72639.6 75732.0 77736.6 80154.6 11581.2 11773.5 11779.1 11894.4 12288.6 33176.3 34829.0 35361.8 36144.8 36183.3 43185.6 44752.8 45961.5 46429.3 47182.0 17760.6 18332.9 18400.6 18422.8 18525.5 15867.3 16101.8 16114.4 16228.8 16283.2 18170.3 18339.8 18590.7 18595.3 18628.8 18613.3 18706.3 18791.6 19082.7 19391.6 17420.9 17481.3 17745.1 17888.6 18029.9 10456.4 10555.7 11359.0 11636.5 11668.1 12054.5 12057.3 12534.6 12619.4 12870.7 11:44:09 INFO - PID 3561 | -------- Summary: end -------- 11:44:09 INFO - PID 3561 | 11:44:10 INFO - TEST-INFO | 3561: exit 0 11:44:10 INFO - TEST-OK | dromaeo_css | took 1115395ms 11:44:10 INFO - TEST-START | kraken 11:44:10 INFO - Initialising browser for kraken test... 11:44:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38860/getInfo.html -profile /tmp/tmpxUimFQ/profile 11:44:10 INFO - TEST-INFO | started process 3934 (/builds/slave/test/build/application/firefox/firefox http://localhost:38860/getInfo.html) 11:44:16 INFO - TEST-INFO | 3934: exit 0 11:44:16 INFO - Browser initialized. 11:44:16 INFO - Running cycle 1/1 for kraken test... 11:44:16 INFO - TEST-INFO | started process 4165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxUimFQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:44:17 INFO - PID 4165 | 11:44:17 INFO - PID 4165 | (/builds/slave/test/build/application/firefox/firefox:4219): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:44:17 INFO - PID 4165 | 11:44:27 INFO - PID 4165 | RSS: Main: 173740032 11:44:27 INFO - PID 4165 | 11:44:30 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38860/tests/kraken/driver.html?testName=audio-beat-detection) 11:44:31 INFO - PID 4165 | RSS: Main: 178737152 11:44:31 INFO - PID 4165 | 11:44:34 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38860/tests/kraken/driver.html?testName=audio-dft) 11:44:34 INFO - PID 4165 | RSS: Main: 179240960 11:44:34 INFO - PID 4165 | 11:44:37 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38860/tests/kraken/driver.html?testName=audio-fft) 11:44:38 INFO - PID 4165 | RSS: Main: 174379008 11:44:38 INFO - PID 4165 | 11:44:40 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38860/tests/kraken/driver.html?testName=audio-oscillator) 11:44:41 INFO - PID 4165 | RSS: Main: 174804992 11:44:41 INFO - PID 4165 | 11:44:43 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38860/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:44:44 INFO - PID 4165 | RSS: Main: 175116288 11:44:44 INFO - PID 4165 | 11:44:47 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38860/tests/kraken/driver.html?testName=imaging-darkroom) 11:44:48 INFO - PID 4165 | RSS: Main: 177496064 11:44:48 INFO - PID 4165 | 11:44:51 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38860/tests/kraken/driver.html?testName=imaging-desaturate) 11:44:52 INFO - PID 4165 | RSS: Main: 176844800 11:44:52 INFO - PID 4165 | 11:44:55 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38860/tests/kraken/driver.html?testName=json-parse-financial) 11:44:55 INFO - PID 4165 | RSS: Main: 178393088 11:44:55 INFO - PID 4165 | 11:44:57 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38860/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:44:58 INFO - PID 4165 | RSS: Main: 178139136 11:44:58 INFO - PID 4165 | 11:45:00 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38860/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:45:00 INFO - PID 4165 | RSS: Main: 174993408 11:45:00 INFO - PID 4165 | 11:45:02 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38860/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:45:03 INFO - PID 4165 | RSS: Main: 174997504 11:45:03 INFO - PID 4165 | 11:45:06 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:45:07 INFO - PID 4165 | RSS: Main: 175538176 11:45:07 INFO - PID 4165 | 11:45:10 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:45:11 INFO - PID 4165 | RSS: Main: 175300608 11:45:11 INFO - PID 4165 | 11:45:12 INFO - PID 4165 | Cycle 1(1): loaded http://localhost:38860/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38860/tests/kraken/driver.html?testName=ai-astar) 11:45:13 INFO - PID 4165 | RSS: Main: 177156096 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | __start_tp_report 11:45:13 INFO - PID 4165 | _x_x_mozilla_page_load 11:45:13 INFO - PID 4165 | _x_x_mozilla_page_load_details 11:45:13 INFO - PID 4165 | |i|pagename|runs| 11:45:13 INFO - PID 4165 | |0;ai-astar;100;107;124;107;118;111;110;99;112;114 11:45:13 INFO - PID 4165 | |1;audio-beat-detection;143;116;146;192;119;144;151;129;173;123 11:45:13 INFO - PID 4165 | |2;audio-dft;163;163;168;171;161;167;169;163;161;164 11:45:13 INFO - PID 4165 | |3;audio-fft;78;74;75;173;78;76;76;75;169;77 11:45:13 INFO - PID 4165 | |4;audio-oscillator;83;80;127;78;79;79;140;79;79;126 11:45:13 INFO - PID 4165 | |5;imaging-gaussian-blur;114;114;114;117;115;115;114;118;114;114 11:45:13 INFO - PID 4165 | |6;imaging-darkroom;152;151;152;155;151;151;154;150;152;151 11:45:13 INFO - PID 4165 | |7;imaging-desaturate;94;94;95;95;94;94;93;99;94;98 11:45:13 INFO - PID 4165 | |8;json-parse-financial;57;57;59;56;57;60;56;60;56;57 11:45:13 INFO - PID 4165 | |9;json-stringify-tinderbox;53;59;54;63;55;55;54;55;54;54 11:45:13 INFO - PID 4165 | |10;stanford-crypto-aes;90;93;84;99;80;81;81;94;91;79 11:45:13 INFO - PID 4165 | |11;stanford-crypto-ccm;132;146;136;128;127;138;129;130;127;173 11:45:13 INFO - PID 4165 | |12;stanford-crypto-pbkdf2;181;182;183;186;188;184;186;179;192;178 11:45:13 INFO - PID 4165 | |13;stanford-crypto-sha256-iterative;71;68;65;67;65;69;68;65;68;65 11:45:13 INFO - PID 4165 | __end_tp_report 11:45:13 INFO - PID 4165 | __start_cc_report 11:45:13 INFO - PID 4165 | _x_x_mozilla_cycle_collect,949 11:45:13 INFO - PID 4165 | __end_cc_report 11:45:13 INFO - PID 4165 | __startTimestamp1501526713078__endTimestamp 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | ------- Summary: start ------- 11:45:13 INFO - PID 4165 | Number of tests: 14 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#0] ai-astar Cycles:10 Average:110.20 Median:113.00 stddev:7.60 (6.7%) stddev-sans-first:7.11 11:45:13 INFO - PID 4165 | Values: 100.0 107.0 124.0 107.0 118.0 111.0 110.0 99.0 112.0 114.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:145.00 stddev:24.20 (16.7%) stddev-sans-first:25.67 11:45:13 INFO - PID 4165 | Values: 143.0 116.0 146.0 192.0 119.0 144.0 151.0 129.0 173.0 123.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.50 stddev:3.50 (2.1%) stddev-sans-first:3.63 11:45:13 INFO - PID 4165 | Values: 163.0 163.0 168.0 171.0 161.0 167.0 169.0 163.0 161.0 164.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#3] audio-fft Cycles:10 Average:95.10 Median:76.00 stddev:40.03 (52.7%) stddev-sans-first:41.98 11:45:13 INFO - PID 4165 | Values: 78.0 74.0 75.0 173.0 78.0 76.0 76.0 75.0 169.0 77.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:79.00 stddev:25.15 (31.8%) stddev-sans-first:26.30 11:45:13 INFO - PID 4165 | Values: 83.0 80.0 127.0 78.0 79.0 79.0 140.0 79.0 79.0 126.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.50 stddev:1.45 (1.3%) stddev-sans-first:1.50 11:45:13 INFO - PID 4165 | Values: 114.0 114.0 114.0 117.0 115.0 115.0 114.0 118.0 114.0 114.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:152.00 stddev:1.52 (1.0%) stddev-sans-first:1.62 11:45:13 INFO - PID 4165 | Values: 152.0 151.0 152.0 155.0 151.0 151.0 154.0 150.0 152.0 151.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.50 stddev:1.94 (2.1%) stddev-sans-first:2.03 11:45:13 INFO - PID 4165 | Values: 94.0 94.0 95.0 95.0 94.0 94.0 93.0 99.0 94.0 98.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.00 stddev:1.58 (2.8%) stddev-sans-first:1.67 11:45:13 INFO - PID 4165 | Values: 57.0 57.0 59.0 56.0 57.0 60.0 56.0 60.0 56.0 57.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:55.00 stddev:3.06 (5.6%) stddev-sans-first:3.10 11:45:13 INFO - PID 4165 | Values: 53.0 59.0 54.0 63.0 55.0 55.0 54.0 55.0 54.0 54.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:90.50 stddev:7.05 (7.8%) stddev-sans-first:7.41 11:45:13 INFO - PID 4165 | Values: 90.0 93.0 84.0 99.0 80.0 81.0 81.0 94.0 91.0 79.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:134.00 stddev:14.13 (10.5%) stddev-sans-first:14.89 11:45:13 INFO - PID 4165 | Values: 132.0 146.0 136.0 128.0 127.0 138.0 129.0 130.0 127.0 173.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.90 Median:185.00 stddev:4.25 (2.3%) stddev-sans-first:4.38 11:45:13 INFO - PID 4165 | Values: 181.0 182.0 183.0 186.0 188.0 184.0 186.0 179.0 192.0 178.0 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:68.00 stddev:2.08 (3.1%) stddev-sans-first:1.66 11:45:13 INFO - PID 4165 | Values: 71.0 68.0 65.0 67.0 65.0 69.0 68.0 65.0 68.0 65.0 11:45:13 INFO - PID 4165 | -------- Summary: end -------- 11:45:13 INFO - PID 4165 | 11:45:13 INFO - PID 4165 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:45:13 INFO - TEST-INFO | 4165: exit 0 11:45:13 INFO - TEST-OK | kraken | took 63479ms 11:45:13 INFO - SUITE-END | took 1178s 11:45:14 INFO - Completed test suite (00:19:39) 11:45:14 INFO - javascript benchmark 11:45:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8436.172607131832, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.0711786464053, 3132.3108916038473, 3132.921676958077, 3154.369126174766, 3175.857086431112, 6084.148219249303, 6224.84437889053, 6225.159603453538, 6248.03155510896, 6281.34045925177, 6039.486643635296, 6174.629522228658, 6181.598196117249, 6209.099680546318, 6219.533534984883, 5661.122526008455, 5682.6306290091015, 5707.486326230638, 5713.485786279234, 5757.395473475288, 5719.628224165416, 5738.196652468658, 5742.569307301948, 5795.0, 5835.474807267345, 5702.116171993348, 5709.4290570942985, 5767.192593036978, 5775.971120144393, 5842.036064049426, 5510.9448905511235, 5627.465390787909, 5694.032014557535, 5761.452661997104, 5767.106098554731, 5453.890922181534, 5582.8325150245555, 5625.043742563774, 5642.379338272786, 5650.180723795068, 6020.548458865603, 6105.847353816146, 6142.447179753799, 6196.0, 6213.130161777355, 6515.0, 6616.0, 6622.73509059637, 6688.9665551672415, 6701.463882889358, 6627.93372066278, 6669.733210671568, 6673.733050677967, 6702.564333318319, 6703.195616525999, 6185.0413185955795, 6186.783462578788, 6191.907121393183, 6202.596831205957, 6204.224471941007, 6791.626460544718, 6798.66006699663, 6821.113255276881, 6821.556598821061, 6831.419329356961, 6421.775237866652, 6508.446782023487, 6517.869642607121, 6523.934760652332, 6524.902126468107, 6550.6069635822005, 6573.868522629521, 6583.0, 6591.868162636721, 6631.9388897776125, 6551.21385433751, 6592.9340706593275, 6595.0766892635065, 6623.668816559153, 6714.563553369016, 6562.835929101715, 6569.83575410609, 6634.170728658918, 6725.159355080615, 6736.0, 5347.81282655113, 5367.597430192751, 5369.328833895763, 5373.865653358697, 5375.381831089397, 4585.72485650862, 4644.303354496852, 4657.720536767804, 4689.296605509201, 4723.220668589713, 5604.159376093537, 5698.487136157766, 5711.543076553866, 5764.164196191528, 5772.0, 6560.409563139245, 6656.900146497806, 6673.866522669519, 6715.227748808852, 6723.025161351577, 5805.88388232233, 5819.301683797971, 5832.766689332379, 5836.533077353802, 5842.036064049385, 5669.376368599451, 5863.882722345529, 5917.378675239124, 5938.109283607407, 5951.7619295227705, 6295.118683384329, 6389.616623002635, 6392.584482008561, 6423.325550817097, 6503.674816259263, 6635.469162467088, 6684.966575167093, 6690.765823196165, 6698.162729658793, 6746.089277947414, 6426.485881129405, 6437.0666253392055, 6439.678016099083, 6507.023946408077, 6531.085648009187, 6524.380183882524, 6628.171478565179, 6631.966840165768, 6636.701348439428, 6647.069410282467, 6568.6058836469965, 6655.733770649314, 6678.23200331968, 6682.69927853238, 6760.0, 6413.326600706859, 6424.357564243725, 6429.839254018687, 6434.871302574016, 6444.13004244421, 6352.809415717536, 6412.807615771534, 6434.260060093149, 6439.291677915519, 6443.323451037761, 6330.715117819617, 6353.68231588428, 6355.0, 6360.522960777867, 6362.427381535684, 6463.935360646334, 6491.805245842632, 6506.544541882212, 6570.244421891543, 6616.702248398929, 6319.684015799284, 6334.271558770801, 6396.71214795326, 6402.10370548133, 6409.903851442139], "value": 6063.360270563692, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.9398545109115, 866.2982983783135, 894.7360528644049, 896.0725648953332, 1003.8193125237464, 29351.55972660409, 30321.241968950788, 39382.60617393825, 40211.19577608453, 40304.395434068516, 40471.0, 40798.59201407985, 40910.18179636406, 41109.38335924964, 41117.17765644685, 7242.674079666428, 7658.119316278616, 7816.17930117338, 7817.0, 7873.212678732139, 7573.545587264782, 7729.922700773005, 7735.0, 7737.110232323271, 7741.109772376192, 7658.119316278644, 7678.117016543113, 7689.577073260996, 7702.46082774206, 7772.689092436296, 7715.189905059972, 7746.573938433384, 7751.844963100734, 7758.534487930714, 7759.922400775977, 7645.3119219269975, 7707.576083315415, 7708.152103268636, 7709.344705699966, 7709.807254818618, 38089.0, 38188.80905595482, 38362.232755345016, 38507.0, 38581.0, 3503.1942653189653, 3512.016635342108, 3518.2259902821593, 3545.8758943436856, 3547.5033495310677, 30746.231344216572, 30776.768929242804, 30798.384032319227, 30894.845525772453, 31210.0, 4637.234856248715, 4852.2721591761165, 4867.0, 4882.267659851015, 4909.21452567591, 184283.0, 184796.0, 185807.0, 186110.0, 186791.0, 47005.0, 47256.291155632, 47293.5270647296, 47293.5270647296, 47435.76282118636, 49632.0, 49944.50055499471, 50169.0, 50214.24678629824, 50316.24525632045, 14949.626259343604, 15268.770968435483, 15285.0, 15317.387304507918, 15324.310406031755, 10398.844017339747, 10614.628488002883, 11361.886381136082, 11601.709957251136, 12452.81320780189, 14220.786688199685, 14222.2177780221, 14318.498852540111, 14318.85681143196, 14381.209033503257, 5796.1305804129715, 5811.4479124483105, 5895.557833162444, 5911.9704401478575, 5912.201852749909, 979.5053497983473, 995.7759504111661, 1004.3321191407632, 1025.8820235672845, 1031.0874875734878, 22863.31410057701, 22929.426764331027, 23059.769402306098, 23408.18071367494, 23440.882795585912, 1077.4612693653173, 1079.8704155501391, 1111.1666250312267, 1114.7213196700825, 1118.0831717991332, 12014.098942579167, 12025.218360806519, 12167.0, 12359.25844449336, 12502.437390317276, 209932.0, 210153.0, 212996.0, 213013.0, 213923.0, 54299.72850135724, 54324.72837635865, 54444.0, 54829.45170548323, 54881.72559137179, 1443.8628330308604, 1459.7591397419308, 1491.1053367979125, 1493.8954273200773, 1503.8796896248273, 21956.89021554882, 22138.88930555337, 22829.88585057064, 23156.0, 23180.652290215996, 37927.43108853425, 38369.80815095906, 38473.0, 38549.61450385572, 38856.222875542895, 185554.0, 185637.0, 186599.0, 186680.0, 187003.0, 30284.84857575786, 31242.21894452657, 31439.21401964969, 33530.491127898815, 34000.489992650626, 41793.48331205498, 43611.0, 44085.77957110194, 44697.776511118536, 45107.7744611288, 26434.471310574067, 27099.72900271051, 27424.314392140357, 27544.17367478979, 27660.72339276662, 26057.218283451526, 26545.60181597239, 27038.0, 27282.72717272802, 27299.727002730513, 33371.66628333783, 34644.0, 34736.82631586826, 35053.29893402067, 35307.646923531465, 29490.705092948796, 33706.66293337035, 34283.314333713686, 34456.0, 34969.65030349664, 24562.894669739548, 24835.50328993374, 24854.254372368858, 25040.123595674064, 25696.486070278115], "value": 16756.731893969154, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.2146958666627, 576.6626523483761, 578.7511370110851, 580.1529766540849, 594.1207013619843, 22594.096236150555, 23433.179838705648, 23492.17777377788, 23583.882080589618, 23602.173923912644, 27164.864175679093, 28169.436611267764, 28191.29521761957, 28291.434171316614, 28305.150845474618, 7098.787036388903, 7259.564426134449, 7263.709451621929, 7267.055282813227, 7268.418526517892, 6702.43029342504, 7051.647417629124, 7103.822404439905, 7161.033260509843, 7224.8193795155275, 7049.612271325075, 7075.044868942704, 7094.716211351565, 7094.822629434254, 7101.431885449178, 7035.296470352975, 7082.32717891802, 7085.964570177116, 7088.1494220693585, 7091.609961452118, 6836.350546698056, 6845.931540684579, 6891.586504809728, 6925.0, 6926.930730692729, 31748.0, 31992.680073199437, 32930.0, 33027.3394532108, 33159.834200829086, 1947.980520194794, 2000.0899590686204, 2006.528465810548, 2008.5480766827493, 2011.3664195778283, 20358.898205509027, 20974.475638109016, 21005.68491472629, 21037.158513659437, 21039.368818935458, 2362.4856437700137, 2374.2046414451006, 2428.5507181171365, 2458.8524688518746, 2465.716442609105, 133421.0, 137272.0, 137901.0, 138082.0, 138563.30718346345, 20113.74767606917, 22078.558428831333, 22563.43591410228, 22677.546449070927, 23172.53654926892, 43861.342079868824, 43882.341764873556, 43936.0, 43966.0, 43988.12023759507, 11748.88251117495, 11840.467178976967, 11929.761404771856, 11995.520179192908, 12242.877571224173, 7908.209179082046, 9818.852717209247, 9831.410115393099, 9900.55447504864, 9950.850737238947, 9440.433573985445, 11075.280106793032, 11343.149263805248, 11379.431028448544, 11672.824907626393, 3590.8204589770407, 3967.6429121379215, 4048.1903619276263, 4174.4364510791265, 4447.73313601185, 926.1618235496886, 931.1433481197315, 931.7950050988907, 959.4435227568133, 981.617169303972, 19158.521036974187, 19376.903115484612, 19948.102335394942, 22961.425964350692, 25071.62392564113, 1012.2104758288547, 1029.8043371759343, 1038.3302769713493, 1048.4128887822844, 1063.4204358624568, 10922.1808364373, 10996.835047474135, 11183.329000259848, 11216.719582010352, 11287.661370158909, 495465.0, 504799.0, 509624.0, 512452.0, 513621.0, 126784.36607817086, 128987.35506322408, 129681.0, 131768.0, 132945.0, 1226.3316492511603, 1248.993755031219, 1263.5009171377071, 1268.4989429175423, 1274.847018357803, 18120.0, 18150.18324175389, 18174.0, 18299.0, 18965.0, 58119.4188058114, 58826.705866470395, 59857.0, 60286.698566506886, 60815.695921520106, 71844.64077679579, 74610.62694686491, 75422.24577754152, 75638.62180689062, 75961.24038759542, 12429.627111186679, 13030.869691302965, 14436.422543098159, 14629.634259143606, 15035.699286014436, 23546.882265588563, 23707.0, 23917.880410597834, 23988.28035158948, 23990.160344387863, 18105.185266662767, 19096.809031909503, 19269.22923083117, 19374.128164232363, 19493.317733879245, 14620.634484137981, 14959.25203739787, 15981.200939952723, 16139.919300403422, 16414.17929103516, 18707.71938420952, 20062.0, 20344.694829577864, 20345.084471199127, 20406.59186816285, 15211.0, 15322.310496027483, 15375.61560960985, 15431.691366172388, 15464.072155670696, 18843.152058157142, 19232.942188179786, 19345.806541934962, 19484.415467535997, 19718.80281197227], "value": 13026.67566219143, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.7456383287174, 1400.6778440958576, 1402.5792262321308, 1404.276797449313, 1418.9929050354754, 13756.312184390777, 14311.355988980495, 14388.42446302148, 14402.783958240609, 14408.135511869295, 13473.3263336833, 14407.78388324176, 14592.197429141394, 14594.48919287825, 14626.0, 2472.171822439485, 2517.6349429332736, 2522.8738563071865, 2524.911628093017, 2526.2547548473244, 2573.3437973316777, 2612.6081087836787, 2647.6822781266274, 2736.343277613378, 2743.2181828178973, 2649.6422982897257, 2659.880305386262, 2713.71505991871, 2715.158300926709, 2716.6739991201084, 2659.56117240656, 2690.0988168963227, 2708.5530887403556, 2710.3495161161377, 2724.741149590786, 2570.177543186181, 2593.7276585958393, 2597.181887705367, 2647.3249321423104, 2648.020232513963, 13598.184108953494, 13816.723665526633, 13838.654033649138, 13842.307884605729, 13842.86157138436, 7266.854662906765, 7520.962395188044, 7527.736529221505, 7528.661210245552, 7542.547447153188, 4728.598069164125, 4930.926036109461, 5076.06092872816, 5102.591792656615, 5122.078025955327, 1656.8674506039488, 1662.2104500362352, 1703.2505697493186, 1721.7933847938202, 1725.0, 21864.23475178361, 22159.667604985938, 22326.106955721913, 22399.552008959894, 22436.887815560982, 6566.967165164144, 6620.768273110418, 6676.065350850885, 6800.115984921928, 6835.316468353125, 17775.0, 17798.288068477374, 17801.465956021082, 17826.5543361417, 17886.642267154584, 7337.559746415125, 7642.159362470124, 7644.350230230492, 7649.770506884803, 7654.0, 6734.831629209309, 6734.932650673529, 6804.76183333581, 6848.315168483212, 6880.793576192722, 5205.687658740488, 5316.415194328621, 5393.649412788156, 5399.568034557226, 5478.753456094406, 1605.0, 1637.8935369200963, 1662.1606088925016, 1715.408184176457, 1724.1982478147722, 790.7588185603446, 830.339879795564, 833.8540755367786, 835.3400813357501, 850.0691742542031, 7083.92916070843, 7164.964175179195, 7542.094948606093, 7569.810754731176, 7624.885626715603, 889.3063410539789, 896.3635818568889, 933.2394098809449, 941.9529023548795, 967.4243824924159, 3937.330653788863, 4059.939100913489, 4157.958420415757, 4384.780760961939, 4599.195140850338, 17616.50259727912, 18142.63714725698, 18774.436766897015, 18823.435296941112, 18824.623507529774, 18175.54768057347, 18401.447956561326, 18528.16623251957, 18678.34625788091, 18688.626227475645, 10082.29423940317, 10462.947685261524, 10465.510029280991, 10473.0, 10476.790464190673, 6591.373819487141, 6982.162140543167, 7122.501424900414, 7137.500374973702, 7226.638668066471, 15073.924630376778, 15711.685766284381, 16353.0, 16355.182240888145, 16442.424515141913, 16365.427210047592, 16499.917500412423, 16500.587485312484, 16555.178930317896, 16666.916665416597, 11118.722031948942, 11310.095192384753, 11311.604093856675, 11315.094792416752, 11317.490712918103, 12602.11785175029, 12646.30445325516, 12651.810222846481, 12669.176503527242, 12770.936145319214, 9342.766430839283, 9687.262012015895, 9872.901270987199, 9915.405075695482, 10086.949565252127, 9306.674266400643, 9595.13643772064, 9772.26707996889, 9848.606055757977, 9886.85169722469, 8073.959630201812, 8184.877226841483, 8189.836203276021, 8452.32381409498, 8814.206721395105, 5949.7620095197435, 6211.81364559064, 6294.055891616111, 6316.210473690789, 6372.776952806629, 6207.689615519296, 6286.339934307015, 6326.0, 6451.967740161457, 6468.417842394207], "value": 6163.511293590822, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.63776262209905, 501.9331882199761, 519.2652396858446, 522.2610006840321, 526.6076772804262, 6134.263888333407, 6141.9692901535545, 6153.600015998957, 6174.425521492019, 6254.937450625493, 5834.199584199576, 6040.637561746287, 6050.976100892901, 6127.264728232607, 6156.630602163873, 4946.851594452154, 4956.87607809804, 4984.087491319315, 4991.700497970124, 5008.624353173508, 4801.0, 4981.252812078199, 5033.320501732274, 5038.773255203525, 5051.722155281458, 4868.78090485929, 4883.438404583465, 4940.135476291653, 4943.23379876118, 4955.628327875405, 4878.634102442331, 4898.93816364772, 4900.411950565919, 4925.926111108319, 4948.604111671058, 4435.578620031092, 4469.664775141845, 4474.664400169968, 4491.9775401123115, 4515.977420112911, 5923.911141332884, 5944.583879128462, 5949.553783466257, 5965.612235204741, 6053.364396738367, 5617.4382561743905, 5620.718964051781, 5693.658380497183, 5710.77156913723, 5731.197632331477, 6324.7470101195895, 6344.524160687967, 6396.456301214403, 6407.789312687116, 6451.645159516224, 4818.253170758538, 4863.635227357927, 4898.338724272249, 4903.828366007208, 4948.57937075349, 6779.288174741581, 6864.862702745967, 6894.827879260538, 6929.0, 6961.303869613049, 4905.681130726492, 4988.4263309719845, 4996.2505624156665, 5008.69947803133, 5033.496650334937, 5066.189409694432, 5111.565516931102, 5128.9230661540105, 5144.331236939249, 5151.716655583904, 5661.377248502661, 5665.12190610456, 5724.626089738516, 5755.453231942959, 5759.625624334405, 6446.258680251737, 6474.805755827333, 6481.708323125471, 6525.347465253437, 6590.439812615981, 1655.3130450862757, 1707.888987215827, 1711.2727090986282, 1715.7340612205128, 1761.8414342708961, 1194.2655267010725, 1220.5544976083665, 1224.2960297828606, 1242.4781591731314, 1245.227958665615, 5589.133684278943, 5609.579281553818, 5676.744546495418, 5681.772729090872, 5711.143328500758, 6514.315996820361, 6559.967200164064, 6616.569922955089, 6759.493038022168, 6769.492288078315, 5512.862178445571, 5739.2252045973255, 5745.0, 5811.94188058114, 5869.8239052828485, 3550.6626870447267, 3581.265840502743, 3596.9280614387567, 3597.6941959933697, 3624.4382120771324, 6401.807945761635, 6442.971803252464, 6480.773172939019, 6487.351264873475, 6496.375906023494, 6809.761658342033, 6953.33943275388, 6955.130608673916, 6964.79105626832, 6969.9303006969285, 6465.709043093166, 6504.38208370204, 6504.512161587805, 6511.934880651228, 6544.869102617921, 6612.966935165294, 6658.535122273092, 6713.697883595152, 6719.630420326929, 6719.731210751711, 6531.934680653133, 6592.604443733391, 6596.934030659632, 6711.597304161766, 6750.8397312859415, 6424.582402143846, 6499.3175716549085, 6509.251436084911, 6561.278259391368, 6602.504812139013, 4969.975150124226, 4979.178435558092, 4985.576226020684, 4992.750362481789, 5042.672226305279, 6664.633445160563, 6761.729530818712, 6782.966085169543, 6824.215215250111, 6828.487863410165, 6473.676316184266, 6485.44873685742, 6530.249021362414, 6579.309172537006, 6601.867962640817, 6158.815235542941, 6447.129637498878, 6483.546151769331, 6585.703643336157, 6660.333966603301, 6154.292256390572, 6434.101939927827, 6446.742130314735, 6497.642629655415, 6512.3162067982175, 6455.644939528371, 6517.967410162919, 6557.245916719638, 6577.717345117656, 6588.4399826013405, 6110.358412366815, 6260.186175797299, 6298.937010629835, 6326.272478665012, 6345.048242763438], "value": 5031.402574107887, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.5769759364301, 903.0608167505799, 921.9815603687931, 928.4290161550645, 930.548683888314, 18585.349512767058, 19202.61594768104, 19544.804551954476, 19574.608507829835, 22134.667979980273, 20739.896300518514, 21778.673319900176, 21782.128714851428, 21943.122275109017, 22003.559928801413, 1001.1340190735035, 1035.0580971316103, 1037.2998226197324, 1039.1946241662697, 1039.6205385034445, 1027.404105618743, 1037.6316407675279, 1038.226521241676, 1038.392540363888, 1039.9584016639326, 980.3186785184264, 1010.8736407949007, 1066.3335415365398, 1066.978660426791, 1069.4492336446735, 1061.5488417422603, 1063.7181146996052, 1063.930844495109, 1065.7815147894662, 1066.9573217071347, 772.5441989226327, 773.1572585881416, 773.307889438949, 778.7624774443792, 778.8286576953061, 18685.252589896387, 19049.809501904943, 19186.712199317022, 19344.41966741, 19511.121999510055, 20594.0, 20841.37475875726, 21185.68221476679, 21221.469463263387, 21309.0, 15914.204289785464, 16167.272472738756, 16184.75722864158, 16213.108279044647, 16224.513264602081, 3567.9643203567894, 3584.6773790358993, 3592.964070359289, 3595.622459641726, 3599.6400359964055, 124868.37565812113, 126692.0, 129189.0, 131631.0, 132883.0, 16167.919160404123, 16525.421610243582, 16645.16774161287, 16682.249298781582, 16685.416010439578, 28515.71484285172, 29569.704302956696, 30402.087937361914, 30548.694513054586, 30565.23586910345, 8091.55496447701, 8356.791080222922, 8372.372072094617, 8397.832043359222, 8411.579421028924, 4159.542450330461, 4232.280512312914, 4235.0682849773, 4237.512686041083, 4253.80857861397, 4752.5485078917445, 4852.927206091911, 4869.464358920516, 4880.536349046835, 4880.902381952412, 949.1694767078806, 977.5503268496572, 990.9801803964025, 992.9177196855318, 993.7217579077725, 644.3485058982254, 671.4796033074407, 691.5919607431639, 708.0688894104339, 715.4205093873978, 11170.704642130591, 11908.404579770977, 11950.940245298892, 12165.33090680021, 12220.327881966577, 644.6100109433819, 667.9365460281363, 679.3376457953456, 688.5490004047357, 690.3855568544, 5127.256547800623, 5216.914604669737, 5338.199270109515, 5502.642328248651, 5701.543876489954, 105362.4731876351, 105445.47277263718, 106026.0, 106775.46612266889, 110201.44899275452, 84571.57714211389, 91091.54454227687, 91110.0, 91387.0, 93825.5308723452, 71759.6412017947, 72639.63680181565, 75732.0, 77736.61131694418, 80154.59922700466, 11581.247218930743, 11773.529058837894, 11779.057675385777, 11894.405279736151, 12288.569900053455, 33176.33647327088, 34829.0, 35361.82319088388, 36144.81927590345, 36183.27633447263, 43185.56814431815, 44752.77623611861, 45961.540384595726, 46429.303560445944, 47182.0, 17760.55598610045, 18332.908335458236, 18400.631987360444, 18422.815771842645, 18525.53686157857, 15867.285972131513, 16101.75847362267, 16114.435994740128, 16228.837711622733, 16283.185840708155, 18170.27318907229, 18339.816601833812, 18590.721139183195, 18595.34916277924, 18628.81371186325, 18613.255469781598, 18706.345277915207, 18791.624167516846, 19082.713759293343, 19391.612167756848, 17420.912895435442, 17481.300747970447, 17745.11274436299, 17888.642227155124, 18029.909850450666, 10456.424896630759, 10555.680539932508, 11359.0, 11636.476358564054, 11668.124890633406, 12054.51781928713, 12057.276563406223, 12534.623961281177, 12619.369031548202, 12870.67823304425], "value": 8781.949907932234, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 124.0, 107.0, 118.0, 111.0, 110.0, 99.0, 112.0, 114.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 116.0, 146.0, 192.0, 119.0, 144.0, 151.0, 129.0, 173.0, 123.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 168.0, 171.0, 161.0, 167.0, 169.0, 163.0, 161.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 75.0, 173.0, 78.0, 76.0, 76.0, 75.0, 169.0, 77.0], "value": 95.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 127.0, 78.0, 79.0, 79.0, 140.0, 79.0, 79.0, 126.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 117.0, 115.0, 115.0, 114.0, 118.0, 114.0, 114.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 152.0, 155.0, 151.0, 151.0, 154.0, 150.0, 152.0, 151.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 93.0, 99.0, 94.0, 98.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 59.0, 56.0, 57.0, 60.0, 56.0, 60.0, 56.0, 57.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 59.0, 54.0, 63.0, 55.0, 55.0, 54.0, 55.0, 54.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 84.0, 99.0, 80.0, 81.0, 81.0, 94.0, 91.0, 79.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 146.0, 136.0, 128.0, 127.0, 138.0, 129.0, 130.0, 127.0, 173.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 183.0, 186.0, 188.0, 184.0, 186.0, 179.0, 192.0, 178.0], "value": 183.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 65.0, 67.0, 65.0, 69.0, 68.0, 65.0, 68.0, 65.0], "value": 67.1, "unit": "score"}]}]} 11:45:14 INFO - Return code: 0 11:45:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:45:14 INFO - # TBPL SUCCESS # 11:45:14 INFO - Running post-action listener: _package_coverage_data 11:45:14 INFO - Running post-action listener: _resource_record_post_action 11:45:14 INFO - [mozharness: 2017-07-31 18:45:14.349816Z] Finished run-tests step (success) 11:45:14 INFO - Running post-run listener: _resource_record_post_run 11:45:14 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 6438912; Write bytes: 445927424; Read time: 2528; Write time: 384532 11:45:14 INFO - TinderboxPrint: CPU usage
13.2% 11:45:14 INFO - TinderboxPrint: I/O read bytes / time
6,438,912 / 2,528 11:45:14 INFO - TinderboxPrint: I/O write bytes / time
445,927,424 / 384,532 11:45:14 INFO - TinderboxPrint: CPU idle
8,291.4 (86.8%) 11:45:14 INFO - TinderboxPrint: CPU user
1,204.6 (12.6%) 11:45:14 INFO - TinderboxPrint: Swap in / out
0 / 0 11:45:14 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 120090624; Read time: 168; Write time: 76084 11:45:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:45:14 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4067328; Write bytes: 325836800; Read time: 1812; Write time: 308448 11:45:14 INFO - Running post-run listener: _upload_blobber_files 11:45:14 INFO - Blob upload gear active. 11:45:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:45:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:45:15 INFO - (blobuploader) - INFO - Open directory for files ... 11:45:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:45:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:45:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:16 INFO - (blobuploader) - INFO - Done attempting. 11:45:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:45:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:45:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:27 INFO - (blobuploader) - INFO - Done attempting. 11:45:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:45:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:45:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:28 INFO - (blobuploader) - INFO - Done attempting. 11:45:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:45:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:45:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:45:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:45:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:45:29 INFO - (blobuploader) - INFO - Done attempting. 11:45:29 INFO - (blobuploader) - INFO - Iteration through files over. 11:45:29 INFO - Return code: 0 11:45:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:45:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:45:29 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9256bcf88808de345257adc0e39c639838ee62b2ed073504cca7f2c31914d723660e0dd7d133d17befac601f04d49416c5fc7bae456efd31746ff20e01c62734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c957fc5f1a0972c4bf30e41c17cd916bf985f9c3c481bc6c19023a9ae8847abd205bf6b148b7d15a727dbe4b67c313098c8bde5e351f621e6ed8aa58285cbde8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a6b70c081fd9430d26683f4e2c1f8f3f91d280ad426c6ea1dc8ad65f47824054a2f1968b5c34fb4315e8a7001bdadfbcd9035a4062dfdec2cb0e0541c0684bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa600cfd7a5b5dc787139b8d58cc92fceef3c0e73d6053bfb085e690b79d432fe775f7b04a5a8e28786cbf4850dba7020c87d5e5af1616f89afd304646397e0d"} 11:45:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:45:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:45:29 INFO - Contents: 11:45:29 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9256bcf88808de345257adc0e39c639838ee62b2ed073504cca7f2c31914d723660e0dd7d133d17befac601f04d49416c5fc7bae456efd31746ff20e01c62734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c957fc5f1a0972c4bf30e41c17cd916bf985f9c3c481bc6c19023a9ae8847abd205bf6b148b7d15a727dbe4b67c313098c8bde5e351f621e6ed8aa58285cbde8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a6b70c081fd9430d26683f4e2c1f8f3f91d280ad426c6ea1dc8ad65f47824054a2f1968b5c34fb4315e8a7001bdadfbcd9035a4062dfdec2cb0e0541c0684bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa600cfd7a5b5dc787139b8d58cc92fceef3c0e73d6053bfb085e690b79d432fe775f7b04a5a8e28786cbf4850dba7020c87d5e5af1616f89afd304646397e0d"} 11:45:29 INFO - Running post-run listener: copy_logs_to_upload_dir 11:45:29 INFO - Copying logs to upload dir... 11:45:29 INFO - mkdir: /builds/slave/test/build/upload/logs 11:45:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.901180 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2017-07-31 11:45:29.591007) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 11:45:29.598492) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9256bcf88808de345257adc0e39c639838ee62b2ed073504cca7f2c31914d723660e0dd7d133d17befac601f04d49416c5fc7bae456efd31746ff20e01c62734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c957fc5f1a0972c4bf30e41c17cd916bf985f9c3c481bc6c19023a9ae8847abd205bf6b148b7d15a727dbe4b67c313098c8bde5e351f621e6ed8aa58285cbde8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a6b70c081fd9430d26683f4e2c1f8f3f91d280ad426c6ea1dc8ad65f47824054a2f1968b5c34fb4315e8a7001bdadfbcd9035a4062dfdec2cb0e0541c0684bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa600cfd7a5b5dc787139b8d58cc92fceef3c0e73d6053bfb085e690b79d432fe775f7b04a5a8e28786cbf4850dba7020c87d5e5af1616f89afd304646397e0d"} build_url:https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011213 build_url: 'https://queue.taskcluster.net/v1/task/KJBAMiYNQ1qnxmumtVmpOA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9256bcf88808de345257adc0e39c639838ee62b2ed073504cca7f2c31914d723660e0dd7d133d17befac601f04d49416c5fc7bae456efd31746ff20e01c62734", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c957fc5f1a0972c4bf30e41c17cd916bf985f9c3c481bc6c19023a9ae8847abd205bf6b148b7d15a727dbe4b67c313098c8bde5e351f621e6ed8aa58285cbde8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a6b70c081fd9430d26683f4e2c1f8f3f91d280ad426c6ea1dc8ad65f47824054a2f1968b5c34fb4315e8a7001bdadfbcd9035a4062dfdec2cb0e0541c0684bb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa600cfd7a5b5dc787139b8d58cc92fceef3c0e73d6053bfb085e690b79d432fe775f7b04a5a8e28786cbf4850dba7020c87d5e5af1616f89afd304646397e0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 11:45:29.634353) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 11:45:29.634845) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1501521562.469313-1096728517 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 11:45:29.713616) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 11:45:29.713986) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 11:45:29.714351) ========= ========= Total master_lag: 0.26 =========