builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1501252639.56 results: success (0) revision: 16ffc1d05422a81099ce8b9b59de66dde4c8b2f0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:19.559584) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:19.560395) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:19.560702) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:19.579201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:19.579501) ========= 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=d2a8c569965ab8367867b893000001a1-1501252572.607632-732779493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-28 07:37:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.7M=0s 2017-07-28 07:37:19 (49.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.155522 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:19.751678) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:19.752049) ========= 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=d2a8c569965ab8367867b893000001a1-1501252572.607632-732779493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014484 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:19.805993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:19.806383) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 16ffc1d05422a81099ce8b9b59de66dde4c8b2f0 --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 16ffc1d05422a81099ce8b9b59de66dde4c8b2f0 --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=d2a8c569965ab8367867b893000001a1-1501252572.607632-732779493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-28 07:37:19,816 truncating revision to first 12 chars 2017-07-28 07:37:19,816 Setting DEBUG logging. 2017-07-28 07:37:19,816 attempt 1/10 2017-07-28 07:37:19,816 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/16ffc1d05422?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-28 07:37:20,281 unpacking tar archive at: mozilla-central-16ffc1d05422/testing/mozharness/ program finished with exit code 0 elapsedTime=0.778220 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:20.600263) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:20.600588) ========= script_repo_revision: 16ffc1d05422a81099ce8b9b59de66dde4c8b2f0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:20.601024) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:20.601334) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-28 07:37:20.622165) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-28 07:37:20.622515) ========= /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=d2a8c569965ab8367867b893000001a1-1501252572.607632-732779493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:37:20 INFO - MultiFileLogger online at 20170728 07:37:20 in /builds/slave/test 07:37:20 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 07:37:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:37:20 INFO - {'append_to_log': False, 07:37:20 INFO - 'base_work_dir': '/builds/slave/test', 07:37:20 INFO - 'blob_upload_branch': 'Firefox', 07:37:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:37:20 INFO - 'branch': 'Firefox', 07:37:20 INFO - 'buildbot_json_path': 'buildprops.json', 07:37:20 INFO - 'code_coverage': False, 07:37:20 INFO - 'config_files': ('talos/linux_config.py',), 07:37:20 INFO - 'default_actions': ('clobber', 07:37:20 INFO - 'read-buildbot-config', 07:37:20 INFO - 'download-and-extract', 07:37:20 INFO - 'populate-webroot', 07:37:20 INFO - 'create-virtualenv', 07:37:20 INFO - 'install', 07:37:20 INFO - 'setup-mitmproxy', 07:37:20 INFO - 'run-tests'), 07:37:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:37:20 INFO - 'disable_ccov_upload': False, 07:37:20 INFO - 'download_minidump_stackwalk': True, 07:37:20 INFO - 'download_symbols': 'ondemand', 07:37:20 INFO - 'enable_stylo': False, 07:37:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:37:20 INFO - 'tooltool.py': '/tools/tooltool.py', 07:37:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:37:20 INFO - '/tools/misc-python/virtualenv.py')}, 07:37:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:37:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:37:20 INFO - 'gecko_profile': False, 07:37:20 INFO - 'gecko_profile_interval': 0, 07:37:20 INFO - 'installer_path': 'installer.exe', 07:37:20 INFO - 'log_level': 'info', 07:37:20 INFO - 'log_name': 'talos', 07:37:20 INFO - 'log_to_console': True, 07:37:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:37:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:37:20 INFO - 'opt_config_files': (), 07:37:20 INFO - 'pip_index': False, 07:37:20 INFO - 'suite': 'dromaeojs-e10s', 07:37:20 INFO - 'system_bits': '32', 07:37:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:37:20 INFO - 'title': 'talos-linux64-ix-043', 07:37:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:37:20 INFO - 'use_talos_json': True, 07:37:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:37:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:37:20 INFO - 'work_dir': 'build'} 07:37:20 INFO - [mozharness: 2017-07-28 14:37:20.742254Z] Running clobber step. 07:37:20 INFO - Running pre-action listener: _resource_record_pre_action 07:37:20 INFO - Running main action method: clobber 07:37:20 INFO - rmtree: /builds/slave/test/build 07:37:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:37:21 INFO - Running post-action listener: _resource_record_post_action 07:37:21 INFO - [mozharness: 2017-07-28 14:37:21.776876Z] Finished clobber step (success) 07:37:21 INFO - [mozharness: 2017-07-28 14:37:21.776979Z] Running read-buildbot-config step. 07:37:21 INFO - Running pre-action listener: _resource_record_pre_action 07:37:21 INFO - Running main action method: read_buildbot_config 07:37:21 INFO - Using buildbot properties: 07:37:21 INFO - { 07:37:21 INFO - "project": "", 07:37:21 INFO - "product": "firefox", 07:37:21 INFO - "who": "cbook@mozilla.com", 07:37:21 INFO - "installer_path": "public/build/target.tar.bz2", 07:37:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:37:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 07:37:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 07:37:21 INFO - "stage_platform": "linux64-pgo", 07:37:21 INFO - "basedir": "/builds/slave/test", 07:37:21 INFO - "buildnumber": 97, 07:37:21 INFO - "platform": "ubuntu64_hw", 07:37:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:37:21 INFO - "slavebuilddir": "test", 07:37:21 INFO - "taskId": "N_w6R-C7TveuK_FD3kbHgQ", 07:37:21 INFO - "branch": "mozilla-central", 07:37:21 INFO - "script_repo_revision": "production", 07:37:21 INFO - "revision": "16ffc1d05422a81099ce8b9b59de66dde4c8b2f0", 07:37:21 INFO - "slavename": "talos-linux64-ix-043", 07:37:21 INFO - "repo_path": "mozilla-central" 07:37:21 INFO - } 07:37:21 INFO - Finding installer, test and symbols from parent task. 07:37:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N_w6R-C7TveuK_FD3kbHgQ'}, attempt #1 07:37:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N_w6R-C7TveuK_FD3kbHgQ'}, attempt #1 07:37:22 INFO - Task dependencies: bCmq_jAhSaqKzrkMD7BI5A 07:37:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A'}, attempt #1 07:37:23 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.tar.bz2 07:37:23 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/test_packages.json 07:37:23 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.crashreporter-symbols.zip 07:37:23 INFO - Running post-action listener: _resource_record_post_action 07:37:23 INFO - [mozharness: 2017-07-28 14:37:23.110077Z] Finished read-buildbot-config step (success) 07:37:23 INFO - [mozharness: 2017-07-28 14:37:23.110299Z] Running download-and-extract step. 07:37:23 INFO - Running pre-action listener: _resource_record_pre_action 07:37:23 INFO - Running main action method: download_and_extract 07:37:23 INFO - mkdir: /builds/slave/test/build/tests 07:37:23 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')]} 07:37:23 INFO - trying https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.test_packages.json 07:37:23 INFO - Downloading https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:37:23 INFO - Downloaded 989 bytes. 07:37:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:37:23 INFO - Using the following test package requirements: 07:37:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:37:23 INFO - u'common': [u'target.common.tests.zip'], 07:37:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:37:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:37:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:37:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:37:23 INFO - u'mozbase': [u'target.common.tests.zip'], 07:37:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:37:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:37:23 INFO - u'web-platform': [u'target.common.tests.zip', 07:37:23 INFO - u'target.web-platform.tests.tar.gz'], 07:37:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:37:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:37:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.common.tests.zip 07:37:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:37:23 INFO - Fetch https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.common.tests.zip into memory 07:37:25 INFO - Content-Length response header: 73195330 07:37:25 INFO - Bytes received: 73195330 07:37:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:37:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.common.tests.zip 07:37:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:37:36 INFO - Fetch https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.common.tests.zip into memory 07:37:39 INFO - Content-Length response header: 73195330 07:37:39 INFO - Bytes received: 73195330 07:37:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.talos.tests.zip 07:37:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:37:53 INFO - Fetch https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.talos.tests.zip into memory 07:37:54 INFO - Content-Length response header: 14496686 07:37:54 INFO - Bytes received: 14496686 07:37:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:54 INFO - trying https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.tar.bz2 07:37:54 INFO - Downloading https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:37:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:37:55 INFO - Downloaded 63101082 bytes. 07:37:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.tar.bz2 07:37:55 INFO - mkdir: /builds/slave/test/properties 07:37:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:37:55 INFO - Writing to file /builds/slave/test/properties/build_url 07:37:55 INFO - Contents: 07:37:55 INFO - build_url:https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.tar.bz2 07:37:55 INFO - Running post-action listener: _resource_record_post_action 07:37:55 INFO - Running post-action listener: set_extra_try_arguments 07:37:55 INFO - [mozharness: 2017-07-28 14:37:55.997518Z] Finished download-and-extract step (success) 07:37:55 INFO - [mozharness: 2017-07-28 14:37:55.997616Z] Running populate-webroot step. 07:37:55 INFO - Running pre-action listener: _resource_record_pre_action 07:37:55 INFO - Running main action method: populate_webroot 07:37:56 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:37:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:37:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:37:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:37:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:37:56 INFO - 'tests': ['damp', 'tps']}, 07:37:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:37:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:37:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:37:56 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:37:56 INFO - 'other-e10s': {'tests': ['a11yr', 07:37:56 INFO - 'ts_paint', 07:37:56 INFO - 'tpaint', 07:37:56 INFO - 'sessionrestore', 07:37:56 INFO - 'sessionrestore_many_windows', 07:37:56 INFO - 'sessionrestore_no_auto_restore', 07:37:56 INFO - 'tabpaint']}, 07:37:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:37:56 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 07:37:56 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:37:56 INFO - 'talos_options': ['--mitmproxy', 07:37:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:37:56 INFO - '--firstNonBlankPaint'], 07:37:56 INFO - 'tests': ['quantum_pageload_google', 07:37:56 INFO - 'quantum_pageload_youtube', 07:37:56 INFO - 'quantum_pageload_amazon', 07:37:56 INFO - 'quantum_pageload_facebook']}, 07:37:56 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:37:56 INFO - 'talos_options': ['--stylo', 07:37:56 INFO - '--mitmproxy', 07:37:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:37:56 INFO - '--firstNonBlankPaint'], 07:37:56 INFO - 'tests': ['quantum_pageload_google', 07:37:56 INFO - 'quantum_pageload_youtube', 07:37:56 INFO - 'quantum_pageload_amazon', 07:37:56 INFO - 'quantum_pageload_facebook']}, 07:37:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:37:56 INFO - 'tsvgr_opacity', 07:37:56 INFO - 'tart', 07:37:56 INFO - 'tscrollx', 07:37:56 INFO - 'cart', 07:37:56 INFO - 'tsvg_static']}, 07:37:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:37:56 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:37:56 INFO - 'talos_options': ['--stylo', 07:37:56 INFO - '--stylo-threads=1', 07:37:56 INFO - '--mitmproxy', 07:37:56 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:37:56 INFO - '--firstNonBlankPaint'], 07:37:56 INFO - 'tests': ['tp6_google', 07:37:56 INFO - 'tp6_youtube', 07:37:56 INFO - 'tp6_amazon', 07:37:56 INFO - 'tp6_facebook']}, 07:37:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:37:56 INFO - 'talos_options': ['--xperf_path', 07:37:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:37:56 INFO - 'tests': ['tp5n']}}} 07:37:56 INFO - Running post-action listener: _resource_record_post_action 07:37:56 INFO - [mozharness: 2017-07-28 14:37:56.006312Z] Finished populate-webroot step (success) 07:37:56 INFO - [mozharness: 2017-07-28 14:37:56.006402Z] Running create-virtualenv step. 07:37:56 INFO - Running pre-action listener: _resource_record_pre_action 07:37:56 INFO - Running main action method: create_virtualenv 07:37:56 INFO - Creating virtualenv /builds/slave/test/build/venv 07:37:56 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:37:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:37:56 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:37:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:37:56 INFO - Using real prefix '/usr' 07:37:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:37:56 INFO - Installing distribute.............................................................................................................................................................................................done. 07:37:58 INFO - Installing pip.................done. 07:37:58 INFO - Return code: 0 07:37:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:37:58 INFO - Reading from file tmpfile_stdout 07:37:58 INFO - Output received: 07:37:58 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) 07:37:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:37:58 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')]} 07:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:58 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')]} 07:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:58 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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', '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 07:37:58 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 07:37: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 pip>=1.5 07:37:58 INFO - Using env: {'DISPLAY': ':0', 07:37:58 INFO - 'HOME': '/home/cltbld', 07:37:58 INFO - 'LANG': 'en_US.UTF-8', 07:37:58 INFO - 'LANGUAGE': 'en_US:en', 07:37:58 INFO - 'LOGNAME': 'cltbld', 07:37:58 INFO - 'MAIL': '/var/mail/cltbld', 07:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:58 INFO - 'MOZ_NO_REMOTE': '1', 07:37:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:58 INFO - 'NO_EM_RESTART': '1', 07:37:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:58 INFO - 'PWD': '/builds/slave/test', 07:37:58 INFO - 'SHELL': '/bin/bash', 07:37:58 INFO - 'SHLVL': '1', 07:37:58 INFO - 'TERM': 'linux', 07:37:58 INFO - 'TMOUT': '86400', 07:37:58 INFO - 'USER': 'cltbld', 07:37:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', 07:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:58 INFO - '_': '/tools/buildbot/bin/python'} 07:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:58 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 07:37:58 INFO - Cleaning up... 07:37:59 INFO - Return code: 0 07:37:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', '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 07:37:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:37:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:37:59 INFO - Using env: {'DISPLAY': ':0', 07:37:59 INFO - 'HOME': '/home/cltbld', 07:37:59 INFO - 'LANG': 'en_US.UTF-8', 07:37:59 INFO - 'LANGUAGE': 'en_US:en', 07:37:59 INFO - 'LOGNAME': 'cltbld', 07:37:59 INFO - 'MAIL': '/var/mail/cltbld', 07:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:59 INFO - 'MOZ_NO_REMOTE': '1', 07:37:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:59 INFO - 'NO_EM_RESTART': '1', 07:37:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:59 INFO - 'PWD': '/builds/slave/test', 07:37:59 INFO - 'SHELL': '/bin/bash', 07:37:59 INFO - 'SHLVL': '1', 07:37:59 INFO - 'TERM': 'linux', 07:37:59 INFO - 'TMOUT': '86400', 07:37:59 INFO - 'USER': 'cltbld', 07:37:59 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', 07:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:59 INFO - '_': '/tools/buildbot/bin/python'} 07:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:59 INFO - Downloading/unpacking psutil>=3.1.1 07:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:00 INFO - Installing collected packages: psutil 07:38:00 INFO - Running setup.py install for psutil 07:38:00 INFO - building 'psutil._psutil_linux' extension 07:38:00 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 07:38: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 07:38:00 INFO - building 'psutil._psutil_posix' extension 07:38: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 07:38: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 07:38:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:00 INFO - Successfully installed psutil 07:38:00 INFO - Cleaning up... 07:38:00 INFO - Return code: 0 07:38:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', '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 07:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:38:00 INFO - Using env: {'DISPLAY': ':0', 07:38:00 INFO - 'HOME': '/home/cltbld', 07:38:00 INFO - 'LANG': 'en_US.UTF-8', 07:38:00 INFO - 'LANGUAGE': 'en_US:en', 07:38:00 INFO - 'LOGNAME': 'cltbld', 07:38:00 INFO - 'MAIL': '/var/mail/cltbld', 07:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:00 INFO - 'MOZ_NO_REMOTE': '1', 07:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:00 INFO - 'NO_EM_RESTART': '1', 07:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:00 INFO - 'PWD': '/builds/slave/test', 07:38:00 INFO - 'SHELL': '/bin/bash', 07:38:00 INFO - 'SHLVL': '1', 07:38:00 INFO - 'TERM': 'linux', 07:38:00 INFO - 'TMOUT': '86400', 07:38:00 INFO - 'USER': 'cltbld', 07:38:00 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', 07:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:00 INFO - '_': '/tools/buildbot/bin/python'} 07:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:38: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 07:38: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 07:38: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 07:38: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 07:38:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:38:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:38:02 INFO - Installing collected packages: mozsystemmonitor 07:38:02 INFO - Running setup.py install for mozsystemmonitor 07:38:02 INFO - Successfully installed mozsystemmonitor 07:38:02 INFO - Cleaning up... 07:38:02 INFO - Return code: 0 07:38:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38: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')]} 07:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38: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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', '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 07:38: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 07:38: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 07:38:02 INFO - Using env: {'DISPLAY': ':0', 07:38:02 INFO - 'HOME': '/home/cltbld', 07:38:02 INFO - 'LANG': 'en_US.UTF-8', 07:38:02 INFO - 'LANGUAGE': 'en_US:en', 07:38:02 INFO - 'LOGNAME': 'cltbld', 07:38:02 INFO - 'MAIL': '/var/mail/cltbld', 07:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:02 INFO - 'MOZ_NO_REMOTE': '1', 07:38:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:02 INFO - 'NO_EM_RESTART': '1', 07:38:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:02 INFO - 'PWD': '/builds/slave/test', 07:38:02 INFO - 'SHELL': '/bin/bash', 07:38:02 INFO - 'SHLVL': '1', 07:38:02 INFO - 'TERM': 'linux', 07:38:02 INFO - 'TMOUT': '86400', 07:38:02 INFO - 'USER': 'cltbld', 07:38:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', 07:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:02 INFO - '_': '/tools/buildbot/bin/python'} 07:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:02 INFO - Downloading/unpacking jsonschema==2.5.1 07:38: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 07:38: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 07:38: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 07:38: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 07:38:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:38: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 07:38: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 07:38: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 07:38: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 07:38:03 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:03 INFO - warning: no files found matching '*.txt' 07:38:03 INFO - no previously-included directories found matching 'build' 07:38:03 INFO - no previously-included directories found matching 'dist' 07:38:03 INFO - no previously-included directories found matching '.git*' 07:38:03 INFO - Installing collected packages: jsonschema, functools32 07:38:03 INFO - Running setup.py install for functools32 07:38:04 INFO - warning: no files found matching '*.txt' 07:38:04 INFO - no previously-included directories found matching 'build' 07:38:04 INFO - no previously-included directories found matching 'dist' 07:38:04 INFO - no previously-included directories found matching '.git*' 07:38:04 INFO - Successfully installed jsonschema functools32 07:38:04 INFO - Cleaning up... 07:38:04 INFO - Return code: 0 07:38:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38: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')]} 07:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38: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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', '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 07:38: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 07:38: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 07:38:04 INFO - Using env: {'DISPLAY': ':0', 07:38:04 INFO - 'HOME': '/home/cltbld', 07:38:04 INFO - 'LANG': 'en_US.UTF-8', 07:38:04 INFO - 'LANGUAGE': 'en_US:en', 07:38:04 INFO - 'LOGNAME': 'cltbld', 07:38:04 INFO - 'MAIL': '/var/mail/cltbld', 07:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:04 INFO - 'MOZ_NO_REMOTE': '1', 07:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:04 INFO - 'NO_EM_RESTART': '1', 07:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:04 INFO - 'PWD': '/builds/slave/test', 07:38:04 INFO - 'SHELL': '/bin/bash', 07:38:04 INFO - 'SHLVL': '1', 07:38:04 INFO - 'TERM': 'linux', 07:38:04 INFO - 'TMOUT': '86400', 07:38:04 INFO - 'USER': 'cltbld', 07:38:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', 07:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:04 INFO - '_': '/tools/buildbot/bin/python'} 07:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:38:04 INFO - Cleaning up... 07:38:04 INFO - Return code: 0 07:38:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38: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')]} 07:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38: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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', '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 07:38: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 07:38: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 07:38:04 INFO - Using env: {'DISPLAY': ':0', 07:38:04 INFO - 'HOME': '/home/cltbld', 07:38:04 INFO - 'LANG': 'en_US.UTF-8', 07:38:04 INFO - 'LANGUAGE': 'en_US:en', 07:38:04 INFO - 'LOGNAME': 'cltbld', 07:38:04 INFO - 'MAIL': '/var/mail/cltbld', 07:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:04 INFO - 'MOZ_NO_REMOTE': '1', 07:38:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:04 INFO - 'NO_EM_RESTART': '1', 07:38:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:04 INFO - 'PWD': '/builds/slave/test', 07:38:04 INFO - 'SHELL': '/bin/bash', 07:38:04 INFO - 'SHLVL': '1', 07:38:04 INFO - 'TERM': 'linux', 07:38:04 INFO - 'TMOUT': '86400', 07:38:04 INFO - 'USER': 'cltbld', 07:38:04 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', 07:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:04 INFO - '_': '/tools/buildbot/bin/python'} 07:38:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:04 INFO - Downloading/unpacking blobuploader==1.2.4 07:38: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 07:38: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 07:38: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 07:38: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 07:38:05 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38: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 07:38: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 07:38: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 07:38: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 07:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38: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 07:38: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 07:38: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 07:38: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 07:38:06 INFO - Downloading docopt-0.6.1.tar.gz 07:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:06 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:06 INFO - Running setup.py install for blobuploader 07:38:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:06 INFO - Running setup.py install for requests 07:38:06 INFO - Running setup.py install for docopt 07:38:06 INFO - Successfully installed blobuploader requests docopt 07:38:06 INFO - Cleaning up... 07:38:06 INFO - Return code: 0 07:38:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38: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')]} 07:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38: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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', '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 07:38: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 07:38: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 07:38:06 INFO - Using env: {'DISPLAY': ':0', 07:38:06 INFO - 'HOME': '/home/cltbld', 07:38:06 INFO - 'LANG': 'en_US.UTF-8', 07:38:06 INFO - 'LANGUAGE': 'en_US:en', 07:38:06 INFO - 'LOGNAME': 'cltbld', 07:38:06 INFO - 'MAIL': '/var/mail/cltbld', 07:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:06 INFO - 'MOZ_NO_REMOTE': '1', 07:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:06 INFO - 'NO_EM_RESTART': '1', 07:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:06 INFO - 'PWD': '/builds/slave/test', 07:38:06 INFO - 'SHELL': '/bin/bash', 07:38:06 INFO - 'SHLVL': '1', 07:38:06 INFO - 'TERM': 'linux', 07:38:06 INFO - 'TMOUT': '86400', 07:38:06 INFO - 'USER': 'cltbld', 07:38:06 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', 07:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:06 INFO - '_': '/tools/buildbot/bin/python'} 07:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:07 INFO - Running setup.py (path:/tmp/pip-jeko0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:07 INFO - Running setup.py (path:/tmp/pip-1dC1h6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:07 INFO - Running setup.py (path:/tmp/pip-FiOdD8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:07 INFO - Running setup.py (path:/tmp/pip-yQDBxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:07 INFO - Running setup.py (path:/tmp/pip-u0xAV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:07 INFO - Running setup.py (path:/tmp/pip-GYbsZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:07 INFO - Running setup.py (path:/tmp/pip-Iq_YsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:07 INFO - Running setup.py (path:/tmp/pip-EI8YO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:07 INFO - Running setup.py (path:/tmp/pip-eRh0YC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:07 INFO - Running setup.py (path:/tmp/pip-a2mnVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:07 INFO - Running setup.py (path:/tmp/pip-_FKKu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:07 INFO - Running setup.py (path:/tmp/pip-OeSkEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:07 INFO - Running setup.py (path:/tmp/pip-_fB1w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:07 INFO - Running setup.py (path:/tmp/pip-eFHlZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:08 INFO - Running setup.py (path:/tmp/pip-ynGC9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:08 INFO - Running setup.py (path:/tmp/pip-MNJivv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:08 INFO - Running setup.py (path:/tmp/pip-iWFUbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:08 INFO - Running setup.py install for manifestparser 07:38:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:08 INFO - Running setup.py install for mozcrash 07:38:08 INFO - Running setup.py install for mozdebug 07:38:08 INFO - Running setup.py install for mozdevice 07:38:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:08 INFO - Running setup.py install for mozfile 07:38:08 INFO - Running setup.py install for mozhttpd 07:38:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:08 INFO - Running setup.py install for mozinfo 07:38:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:08 INFO - Running setup.py install for mozInstall 07:38:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Running setup.py install for mozleak 07:38:09 INFO - Running setup.py install for mozlog 07:38:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Running setup.py install for moznetwork 07:38:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Running setup.py install for mozprocess 07:38:09 INFO - Running setup.py install for mozprofile 07:38:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Running setup.py install for mozrunner 07:38:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:09 INFO - Running setup.py install for mozscreenshot 07:38:09 INFO - Running setup.py install for moztest 07:38:09 INFO - Running setup.py install for mozversion 07:38:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:10 INFO - Cleaning up... 07:38:10 INFO - Return code: 0 07:38:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38: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')]} 07:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38: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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', '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 07:38: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 07:38: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 07:38:10 INFO - Using env: {'DISPLAY': ':0', 07:38:10 INFO - 'HOME': '/home/cltbld', 07:38:10 INFO - 'LANG': 'en_US.UTF-8', 07:38:10 INFO - 'LANGUAGE': 'en_US:en', 07:38:10 INFO - 'LOGNAME': 'cltbld', 07:38:10 INFO - 'MAIL': '/var/mail/cltbld', 07:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:10 INFO - 'MOZ_NO_REMOTE': '1', 07:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:10 INFO - 'NO_EM_RESTART': '1', 07:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:10 INFO - 'PWD': '/builds/slave/test', 07:38:10 INFO - 'SHELL': '/bin/bash', 07:38:10 INFO - 'SHLVL': '1', 07:38:10 INFO - 'TERM': 'linux', 07:38:10 INFO - 'TMOUT': '86400', 07:38:10 INFO - 'USER': 'cltbld', 07:38:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', 07:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:10 INFO - '_': '/tools/buildbot/bin/python'} 07:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:10 INFO - Running setup.py (path:/tmp/pip-598vD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38: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)) 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:10 INFO - Running setup.py (path:/tmp/pip-cBInKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38: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)) 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:10 INFO - Running setup.py (path:/tmp/pip-yypceG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38: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)) 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:10 INFO - Running setup.py (path:/tmp/pip-Ch_L3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38: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)) 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:10 INFO - Running setup.py (path:/tmp/pip-3wTb29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38: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)) 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:10 INFO - Running setup.py (path:/tmp/pip-M3hpNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38: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)) 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:10 INFO - Running setup.py (path:/tmp/pip-tCbqp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38: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)) 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:10 INFO - Running setup.py (path:/tmp/pip-fsKfgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38: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)) 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:10 INFO - Running setup.py (path:/tmp/pip-Y1y4FP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38: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)) 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:10 INFO - Running setup.py (path:/tmp/pip-oHhtiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:10 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)) 07:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:10 INFO - Running setup.py (path:/tmp/pip-fSeFQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38: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)) 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:11 INFO - Running setup.py (path:/tmp/pip-yvDcGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38: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)) 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:11 INFO - Running setup.py (path:/tmp/pip-uYT7QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38: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)) 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:11 INFO - Running setup.py (path:/tmp/pip-JXtOUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38: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)) 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:11 INFO - Running setup.py (path:/tmp/pip-scPXO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38: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)) 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:11 INFO - Running setup.py (path:/tmp/pip-lfONnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38: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)) 07:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:11 INFO - Running setup.py (path:/tmp/pip-LJ4sF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38: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)) 07:38: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)) 07:38: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)) 07:38: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)) 07:38: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)) 07:38: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)) 07:38: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)) 07:38:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38: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 07:38: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 07:38: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 07:38: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 07:38:12 INFO - Downloading blessings-1.6.tar.gz 07:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:12 INFO - Installing collected packages: blessings 07:38:12 INFO - Running setup.py install for blessings 07:38:12 INFO - Successfully installed blessings 07:38:12 INFO - Cleaning up... 07:38:12 INFO - Return code: 0 07:38:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:13 INFO - Reading from file tmpfile_stdout 07:38:13 INFO - Current package versions: 07:38:13 INFO - argparse == 1.2.1 07:38:13 INFO - blessings == 1.6 07:38:13 INFO - blobuploader == 1.2.4 07:38:13 INFO - docopt == 0.6.1 07:38:13 INFO - functools32 == 3.2.3-2 07:38:13 INFO - jsonschema == 2.5.1 07:38:13 INFO - manifestparser == 1.1 07:38:13 INFO - mozInstall == 1.13 07:38:13 INFO - mozcrash == 1.0 07:38:13 INFO - mozdebug == 0.1 07:38:13 INFO - mozdevice == 0.51 07:38:13 INFO - mozfile == 1.2 07:38:13 INFO - mozhttpd == 0.7 07:38:13 INFO - mozinfo == 0.10 07:38:13 INFO - mozleak == 0.1 07:38:13 INFO - mozlog == 3.5 07:38:13 INFO - moznetwork == 0.27 07:38:13 INFO - mozprocess == 0.25 07:38:13 INFO - mozprofile == 0.28 07:38:13 INFO - mozrunner == 6.13 07:38:13 INFO - mozscreenshot == 0.1 07:38:13 INFO - mozsystemmonitor == 0.3 07:38:13 INFO - moztest == 0.8 07:38:13 INFO - mozversion == 1.4 07:38:13 INFO - psutil == 3.1.1 07:38:13 INFO - requests == 1.2.3 07:38:13 INFO - wsgiref == 0.1.2 07:38:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38: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')]} 07:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38: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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', '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 07:38: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 07:38: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 07:38:13 INFO - Using env: {'DISPLAY': ':0', 07:38:13 INFO - 'HOME': '/home/cltbld', 07:38:13 INFO - 'LANG': 'en_US.UTF-8', 07:38:13 INFO - 'LANGUAGE': 'en_US:en', 07:38:13 INFO - 'LOGNAME': 'cltbld', 07:38:13 INFO - 'MAIL': '/var/mail/cltbld', 07:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:13 INFO - 'MOZ_NO_REMOTE': '1', 07:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:13 INFO - 'NO_EM_RESTART': '1', 07:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:13 INFO - 'PWD': '/builds/slave/test', 07:38:13 INFO - 'SHELL': '/bin/bash', 07:38:13 INFO - 'SHLVL': '1', 07:38:13 INFO - 'TERM': 'linux', 07:38:13 INFO - 'TMOUT': '86400', 07:38:13 INFO - 'USER': 'cltbld', 07:38:13 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', 07:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:13 INFO - '_': '/tools/buildbot/bin/python'} 07:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38: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)) 07:38: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)) 07:38: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)) 07:38: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)) 07:38: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)) 07:38: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)) 07:38: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)) 07:38: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)) 07:38: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)) 07:38:13 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:38: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 07:38: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 07:38: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 07:38: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 07:38:14 INFO - Downloading marionette_driver-1.4.0.tar.gz 07:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 07:38:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 07:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:38: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)) 07:38: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)) 07:38: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)) 07:38: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)) 07:38:14 INFO - Installing collected packages: marionette-driver, simplejson 07:38:14 INFO - Running setup.py install for marionette-driver 07:38:14 INFO - Running setup.py install for simplejson 07:38:14 INFO - building 'simplejson._speedups' extension 07:38: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 07:38: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 07:38:15 INFO - Successfully installed marionette-driver simplejson 07:38:15 INFO - Cleaning up... 07:38:15 INFO - Return code: 0 07:38:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38: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')]} 07:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38: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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', '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 07:38: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 07:38: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 07:38:15 INFO - Using env: {'DISPLAY': ':0', 07:38:15 INFO - 'HOME': '/home/cltbld', 07:38:15 INFO - 'LANG': 'en_US.UTF-8', 07:38:15 INFO - 'LANGUAGE': 'en_US:en', 07:38:15 INFO - 'LOGNAME': 'cltbld', 07:38:15 INFO - 'MAIL': '/var/mail/cltbld', 07:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:15 INFO - 'MOZ_NO_REMOTE': '1', 07:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:15 INFO - 'NO_EM_RESTART': '1', 07:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:15 INFO - 'PWD': '/builds/slave/test', 07:38:15 INFO - 'SHELL': '/bin/bash', 07:38:15 INFO - 'SHLVL': '1', 07:38:15 INFO - 'TERM': 'linux', 07:38:15 INFO - 'TMOUT': '86400', 07:38:15 INFO - 'USER': 'cltbld', 07:38:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', 07:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:15 INFO - '_': '/tools/buildbot/bin/python'} 07:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:38:16 INFO - Cleaning up... 07:38:16 INFO - Return code: 0 07:38:16 INFO - Running post-action listener: _resource_record_post_action 07:38:16 INFO - Running post-action listener: _start_resource_monitoring 07:38:16 INFO - Starting resource monitoring. 07:38:16 INFO - [mozharness: 2017-07-28 14:38:16.064152Z] Finished create-virtualenv step (success) 07:38:16 INFO - [mozharness: 2017-07-28 14:38:16.064631Z] Running install step. 07:38:16 INFO - Running pre-action listener: _resource_record_pre_action 07:38:16 INFO - Running main action method: install 07:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:16 INFO - Reading from file tmpfile_stdout 07:38:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:16 INFO - Reading from file tmpfile_stdout 07:38:16 INFO - Output received: 07:38:16 INFO - Usage: mozinstall [options] installer 07:38:16 INFO - Options: 07:38:16 INFO - -h, --help show this help message and exit 07:38:16 INFO - -d DEST, --destination=DEST 07:38:16 INFO - Directory to install application into. [default: 07:38:16 INFO - "/builds/slave/test"] 07:38:16 INFO - --app=APP Application being installed. [default: firefox] 07:38:16 INFO - mkdir: /builds/slave/test/build/application 07:38: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'] 07:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:38:34 INFO - Reading from file tmpfile_stdout 07:38:34 INFO - Output received: 07:38:34 INFO - /builds/slave/test/build/application/firefox/firefox 07:38:34 INFO - Running post-action listener: _resource_record_post_action 07:38:34 INFO - [mozharness: 2017-07-28 14:38:34.289395Z] Finished install step (success) 07:38:34 INFO - [mozharness: 2017-07-28 14:38:34.289659Z] Running setup-mitmproxy step. 07:38:34 INFO - Running pre-action listener: _resource_record_pre_action 07:38:34 INFO - Running main action method: setup_mitmproxy 07:38:34 INFO - Skipping: mitmproxy is not required 07:38:34 INFO - Running post-action listener: _resource_record_post_action 07:38:34 INFO - [mozharness: 2017-07-28 14:38:34.290809Z] Finished setup-mitmproxy step (success) 07:38:34 INFO - [mozharness: 2017-07-28 14:38:34.291032Z] Running run-tests step. 07:38:34 INFO - Running pre-action listener: _resource_record_pre_action 07:38:34 INFO - Running pre-action listener: _set_gcov_prefix 07:38:34 INFO - Running main action method: run_tests 07:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:38:34 INFO - Python 2.7.3 07:38:34 INFO - Return code: 0 07:38:34 INFO - grabbing minidump binary from tooltool 07:38: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')]} 07:38: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 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:38: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 07:38: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 07:38: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 07:38:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:38:34 INFO - Return code: 0 07:38:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:38:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:38:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:38:34 INFO - ENV: RUST_BACKTRACE is now 1 07:38:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:38:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:38: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/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 07:38: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/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 07:38:34 INFO - Using env: {'DISPLAY': ':0', 07:38:34 INFO - 'HOME': '/home/cltbld', 07:38:34 INFO - 'LANG': 'en_US.UTF-8', 07:38:34 INFO - 'LANGUAGE': 'en_US:en', 07:38:34 INFO - 'LOGNAME': 'cltbld', 07:38:34 INFO - 'MAIL': '/var/mail/cltbld', 07:38:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:38:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:34 INFO - 'MOZ_NO_REMOTE': '1', 07:38:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:38:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:34 INFO - 'NO_EM_RESTART': '1', 07:38:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:34 INFO - 'PWD': '/builds/slave/test', 07:38:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:38:34 INFO - 'RUST_BACKTRACE': '1', 07:38:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:38:34 INFO - 'SHELL': '/bin/bash', 07:38:34 INFO - 'SHLVL': '1', 07:38:34 INFO - 'TERM': 'linux', 07:38:34 INFO - 'TMOUT': '86400', 07:38:34 INFO - 'USER': 'cltbld', 07:38:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1501252572.607632-732779493', 07:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:34 INFO - '_': '/tools/buildbot/bin/python'} 07:38: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/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 07:38:34 INFO - mozversion application_buildid: 20170728132457 07:38:34 INFO - mozversion application_changeset: 16ffc1d05422a81099ce8b9b59de66dde4c8b2f0 07:38:34 INFO - mozversion application_display_name: Nightly 07:38:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:38:34 INFO - mozversion application_name: Firefox 07:38:34 INFO - mozversion application_remotingname: firefox 07:38:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:38:34 INFO - mozversion application_vendor: Mozilla 07:38:34 INFO - mozversion application_version: 56.0a1 07:38:34 INFO - mozversion platform_buildid: 20170728132457 07:38:34 INFO - mozversion platform_changeset: 16ffc1d05422a81099ce8b9b59de66dde4c8b2f0 07:38:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:38:34 INFO - mozversion platform_version: 56.0a1 07:38:34 INFO - using testdate: 1501252714 07:38:34 INFO - actual date: 1501252714 07:38:34 INFO - starting webserver on 'localhost:59575' 07:38:34 INFO - SUITE-START | Running 2 tests 07:38:34 INFO - TEST-START | dromaeo_css 07:38:34 INFO - Initialising browser for dromaeo_css test... 07:38:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59575/getInfo.html -profile /tmp/tmpr4daoE/profile 07:38:34 INFO - TEST-INFO | started process 11075 (/builds/slave/test/build/application/firefox/firefox http://localhost:59575/getInfo.html) 07:38:40 INFO - TEST-INFO | 11075: exit 0 07:38:40 INFO - Browser initialized. 07:38:40 INFO - Running cycle 1/1 for dromaeo_css test... 07:38:40 INFO - TEST-INFO | started process 11288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpr4daoE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:38:41 INFO - PID 11288 | 07:38:41 INFO - PID 11288 | (/builds/slave/test/build/application/firefox/firefox:11336): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:38:41 INFO - PID 11288 | 07:38:52 INFO - PID 11288 | RSS: Main: 164052992 07:38:52 INFO - PID 11288 | 07:41:50 INFO - PID 11288 | Cycle 1(1): loaded http://localhost:59575/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59575/tests/dromaeo/cssquery-ext.html) 07:41:51 INFO - PID 11288 | RSS: Main: 166703104 07:41:51 INFO - PID 11288 | 07:44:53 INFO - PID 11288 | Cycle 1(1): loaded http://localhost:59575/tests/dromaeo/cssquery-ext.html (next: http://localhost:59575/tests/dromaeo/cssquery-jquery.html) 07:44:54 INFO - PID 11288 | RSS: Main: 163848192 07:44:54 INFO - PID 11288 | 07:47:55 INFO - PID 11288 | Cycle 1(1): loaded http://localhost:59575/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59575/tests/dromaeo/cssquery-mootools.html) 07:47:56 INFO - PID 11288 | RSS: Main: 165724160 07:47:56 INFO - PID 11288 | 07:50:58 INFO - PID 11288 | Cycle 1(1): loaded http://localhost:59575/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59575/tests/dromaeo/cssquery-prototype.html) 07:50:58 INFO - PID 11288 | RSS: Main: 164233216 07:50:58 INFO - PID 11288 | 07:54:02 INFO - PID 11288 | Cycle 1(1): loaded http://localhost:59575/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59575/tests/dromaeo/cssquery-yui.html) 07:54:02 INFO - PID 11288 | RSS: Main: 165523456 07:54:02 INFO - PID 11288 | 07:57:04 INFO - PID 11288 | Cycle 1(1): loaded http://localhost:59575/tests/dromaeo/cssquery-yui.html (next: http://localhost:59575/tests/dromaeo/cssquery-dojo.html) 07:57:04 INFO - PID 11288 | RSS: Main: 167944192 07:57:04 INFO - PID 11288 | 07:57:04 INFO - PID 11288 | __start_tp_report 07:57:04 INFO - PID 11288 | _x_x_mozilla_page_load 07:57:04 INFO - PID 11288 | _x_x_mozilla_page_load_details 07:57:04 INFO - PID 11288 | |i|pagename|runs| 07:57:04 INFO - PID 11288 | |0;dojo.html;3377.729781617471;3413.266147778227;3418.606860211076;3420.931581368373;3462.7056700180483;6129.846753831156;6174.073888916665;6176.9382306176985;6200.968995155018;6214.906776398352;6035.486983606399;6133.969330153354;6159.291681456634;6174.9382506174925;6179.938200618004;5384.030874442598;5407.297051383324;5428.75570599324;5434;5434.646747961389;5429.158480435539;5453.945460545384;5487.6158668893195;5499.092649712813;5520.447955204468;5406.297181366436;5449.700266485342;5453.454654534535;5461.262729531522;5499.395066542697;5409.83770486886;5410.323709536308;5429.918551221735;5471.781128754845;5487.122060470326;5149;5311.681299122065;5331.786728530893;5408.810691625774;5415.891682166374;6080.0575910733905;6105.32841387447;6108.450239478424;6164.229471316085;6190.133381326618;6528.6409247491365;6561.901571476432;6630.801075967729;6651.733930642768;6700.798976030727;6705.865882682319;6710.899336509956;6765.526413151081;6780.423663988518;6785.084013658142;6137.171481849982;6231.657258850807;6266.624002559861;6277.623342599459;6283.246010478726;6720.4287635550545;6744.696488658022;6804.87245228801;6837.1111755471475;6864.450843932474;6413.647249401328;6531.967340163269;6595.637239951849;6624.238212605515;6643.10318107059;6594.736210551524;6657.53397262187;6732.057511948331;6746.561473504206;6762.898556521656;6604.636744979072;6618.040384144272;6683.933160668331;6710.060591517192;6724.260331363546;6568.967155164193;6572.835679107965;6633;6643.368879956396;6643.734250630017;4839.201531747292;4855.587275081658;4885.41375034991;4897.240927656219;4901.43633482147;4309.28896732042;4329.956700432956;4356.281213599784;4359.585839345257;4369.453818272716;6277.811665650038;6331.651759153291;6362.236531616236;6368.044793281045;6389.201349831271;6577.144971153815;6580.045893345438;6590.242122155918;6590.538662293593;6599.60402375859;6310;6317.936820631827;6330.272018717907;6337.524685648595;6345;5381.031414345455;5414.7021913795115;5461.453854614586;5471.425500322488;5526.806561770399;7043.225245223021;7084.114485689289;7109.217986021534;7133.251008644018;7137.750178743719;6594.901076483857;6601.735930562916;6610.933890661032;6626.271110177973;6697;6986.685599147949;6994.055802466602;7039.612821294878;7081.4334853210585;7128.964355178191;6581.506387021088;6587.571807832475;6590.80227593173;6591.637459939558;6639.767608133692;6742.898856517254;6772.0857684212;6800.217974932946;6800.82997925036;6810.421114205348;6419.325970773001;6434.806955791334;6437.935620643733;6507.577007494498;6511.2512061113575;6395.16862807832;6425.153793574838;6512.023196520559;6513.5114866384265;6520.478361730955;6436.356364363526;6438.4527315176865;6448.806535803933;6449.9355006451215;6480.254770701241;6431.549791514549;6467.741290348522;6491.026346048131;6535.803925882231;6544.018397240452;6280.591761535668;6299.937000629935;6327.303996560283;6352.6506042166275;6371.93628063732 07:57:04 INFO - PID 11288 | |1;ext.html;864.1560028994708;891.786644999554;916.9679061232856;941.4022095969058;943.2548286853386;41228;41714.7914260429;41801.79099104504;41873.16253674928;41974.37038444426;37794.62205377945;37804.054898627546;38136.90247036412;38157;38187.61812381876;6669.566478178915;6722.294159113296;6743.561668491557;6757.932420675779;6766.8308292292595;6636.767713130042;6724.293949135344;6726.125603671516;6729.05793188954;6740.325967403245;6698.3971442570155;6722.663866806664;7249.963750181241;7414.740484083059;7421.591812450313;7353.301436363537;7382.409407247407;7405.333519983227;7405.666744996488;7409.740659076933;7154.069970903801;7264.418846492268;7323.267673232687;7339.633018349061;7341.339279464821;39287.60712392897;39374.60625393738;39408.605913941065;39506.20987580261;39554.208915821524;3436.2096717754807;3480.112571294304;3486.808225547594;3488.1105318143964;3488.459288810213;30141;30174.245643859078;30252.243693907607;30254.394912101856;30362.54456183159;4790.065937142223;4812.807487700487;4825.131476334293;4851.660383773137;4890.193118135503;196513;202277;203353;204097;211439;48570.5142948566;48589;48621.270680939815;48668.756656216494;48676;50704.746476267384;50736;50758.238626420636;50803.49196508062;51120.744396278526;16311.265993030342;16351.83648163527;16395;16465.91767041181;16626.085565293783;13468.259245741578;13504.662383440493;13654;13664.180149191081;13683.931580342034;14647.340869660891;14650;14691.706165876623;14694.632634184018;14900.92549537267;5826.416753696531;5866.970665146647;5890.263717035371;5980.295615749491;5984.491318237911;1065.9200559958035;1078.094400703413;1084.8860869608736;1086.0768346905068;1102.9779404412027;23737.16919907795;24195.395115122265;24275.63586546203;24520;24699.753002469744;1150.097173718627;1151.9251248668809;1176.5705517486056;1205.1262834445133;1205.9155859089956;12614.55849045279;13012.21926684402;13106.541271055466;13164.539241126515;13206.207627542379;280476;284988;285774;285875;286169;53476.73261633667;53513;53701.462985370425;54107;54133.188002179995;1477.9039362441406;1530.9540713778604;1535.8310585835773;1538.4077130304913;1549.635835578638;23394.883025584764;23646.645300320164;23704.881475592512;23741.287761367188;24325.878370608032;38127.23745525129;38390.42414363731;38411.231775363776;38490.80754596209;38558.80720596379;228367;231727;233202;233455;234291;34872.30255394929;36378.27243455169;38389.232215356096;38490.80754596209;38611;47279.29081063718;47808.5219147818;48162.5183748158;48407.5159248403;48462.5153748458;32019.199520012186;32334.35331293408;32480.512792308607;33671.15822104467;33784.49323260104;30026.549601755552;31846.68153318437;32828.17929551685;33035.339293214485;33286.500702489;39394.2121157581;39951.600483994785;40905.18189636131;41002.79498602488;41003.38494922638;33018;34022.31955360928;34088.65911340855;34139.82930085334;34621.48067779036;24388.63417048781;26061.688650939916;26107.347316317246;26425.207243782716;26433.095566344706 07:57:04 INFO - PID 11288 | |2;jquery.html;561.1610642090076;562.2550121089557;562.4965655738117;564.762799624158;570.4609144358581;22001.889990550044;22836.314910552668;22865.085396584116;22865.4283642909;22973.19593814217;24781.62827557588;26573.335666608345;26595;26599.734002659967;26738.5989210162;6109.663968481743;6276.529260305472;6287.025511045796;6287.08837218603;6288.748450061992;5847.239858818348;6196.039613859859;6248.4064013918605;6252.999520076789;6254.843628909291;6043.244594425697;6063.605865618721;6079.574429789916;6082.178905847698;6082.391760823926;5995.16067750511;6012.6392416455155;6057.727402266886;6074.392560743934;6075.544334174932;5596.3284405871145;5598.496135347838;5630.324361076656;5638.041532939369;5665.631733937281;29046.12861614155;30176;30554.388912221853;30686.386272274653;30707.232319191975;2083.7395325584303;2155.687425323335;2157.3635777445693;2157.9352619421443;2158.0396723458066;18957.81042189574;19552.120154593078;19565;19629.509262268413;19687.704684429744;2196.7144271244797;2257.322803159062;2263.569921714869;2268.88655567221;2292.9541409171725;130325;135277.3236133823;136324.31837840847;136392;137064;15279.312430940634;15670.373185072469;15750.212489375486;15906.9204653976;16047.759283610756;23158.95784689693;24151.51696966086;24238.394040148785;24306.635400469007;24471.632925506132;10577.682669519927;10663.573457061631;10700.571977120984;10808.405537695346;10816.513256903458;9895.950520247497;9958.80082398348;9988.250881183794;9994.950025249827;10005.269070555883;9734.902650973541;9761;9818.410895346302;9932.751681207883;10160.796784064278;2679.289988153141;2746.8901243950418;2754.0754424944375;2770.1966429735153;2810.789190810697;1007.1791489935679;1010.9646162384281;1039.7556574205055;1045.2839804733783;1055.4458909072798;20687.27594534184;20846.895765521076;21088.261910833047;21430.78569214288;21778.89110554437;1099.6096385783092;1103.674416047268;1111.2110401614943;1112.8720197177267;1127.9661610151545;11453.59912403062;11623.941880290713;11690.357030363242;11752.412379380996;11782.764344713058;544047;556790;559126;559186;559257;133271;134390;134488;135085;142049;1305.673581604599;1330.6207730796677;1359.9932000339934;1366.043769361451;1367.5213675213795;21582.244621438174;22333.77666223317;22468;22592.548149037255;22756.20353287627;50874;53057.20414193713;61341.69329153326;62753.372466274755;66014.66992665007;74152.62923685346;83545.58227209069;86876;87376.563117184;88178;14559.708805824037;15027.173505457306;15069.397224110913;15085.849141508445;15129.546113616609;21904.561908761418;22103.226387076375;22337.771422571914;22356.664650029936;22519.099236030375;16909.66180676404;17138;17166.39917602878;17586.120693965506;17669.823301767334;14134.575962721136;14358.353874075483;15426.30581623852;15454.922725386301;15700;18402.539936501693;18523.44429667112;18530;18594.349197778014;18602.44192674222;14305.499307524187;15027.474038408604;15290.159041252839;15328.540143795259;15339.156346401054;17486.47540573785;17544.473665790047;17587.29650813953;18033.639327213645;18538.16578253955 07:57:04 INFO - PID 11288 | |3;mootools.html;1415.2450960808596;1495.200067963639;1501.5945694662448;1504.7592385218363;1519.0809560216076;14887.106773593592;15166.317515711791;15489.070655760663;15554;15571;15344.539663810076;15668.529944101696;15671;15672.451464198755;15691;2685.4092099738077;2739.5342791725357;2740.849253291078;2742.3555464465835;2742.4515096980685;2526.1411120219122;2585.961210581843;2613.085420102968;2616.5551856184493;2618.2668852721267;2638.762511373976;2654.0578094776365;2655.1238091429877;2677.1834590450003;2692.17888543994;2616.882240299191;2629.6581444412295;2648.510025645262;2649.072824511415;2650.6421633079576;2528.3931856354343;2567.2169988153605;2579.9097031603806;2583.3929026678716;2584.6639936808283;14949.551513454613;15113.3199006045;15209.239538023165;15210.543683689508;15215.847841521554;7853.410994175402;8167.142450042778;8183.427160098796;8199.385046121564;8203.179682031809;4760.833370832004;4963.553280204799;5037.949620503821;5045.243213517965;5050.419201791804;1816.0556510614538;1837.0998210876708;1852.249838815282;1910.2072639854443;1926.4991102313359;26192.476150476883;26423.603645945324;26461.73538264612;26471;26567.335816604547;6551.8362040948405;6594.901076483857;6595.373439523238;6710.396064354231;6750.493712971449;17849.910750446164;18069.27722891096;18137.455876323733;18144.909275453803;18175.091245437674;8015.519068855887;8165.2243036911395;8179.468334558234;8196.795080123045;8214.096449390563;6706.228783689938;7486;7500.324970752549;7505.4746167767735;7542.2834830691;5071.54356107952;5195.610329225323;5451.264079349237;5455.945440545624;5474.698891561003;1493.133982290269;1552.2781906413572;1555.2223888055971;1560.7502799552244;1579.336678594993;877.4559772940818;915.455304094063;930.4045410937006;932.6269492203037;943.8206740719241;7776.300132988058;7937.166597507294;8177.713780017671;8195.508269503849;8274;979.177490907641;991.251605038206;1013.159077965287;1033.7105610429091;1062.3678911047914;4468.955310446854;5023.246513023076;5069.797208111634;5072.695638261716;5148.3564554430695;21666;22300;22396.216132435286;22516.662250066263;22557.43606409853;21144.577108457746;21744.34766956994;21903.890480547496;21912.671309930363;21931.12275508962;11382.317060976367;11475.598354057567;11831.349275789742;12125.454354554066;12187.878121218851;8199.918000820155;8359.122292159236;8518.48889066658;8554.57227138653;8809.119088091396;18440.170192341644;18522.259109635463;18766.71849922225;18971;19275.903620481808;18548.25806967706;19249.32627358036;19443.902780486573;19586.90206549015;19689.606207876048;12500.124991250888;12597.370131493206;12652.493900243888;12767.170133941265;12814.423350949417;12795.552155674506;13051.086423950232;13995.720085598028;14205.218712970885;14216.147031178163;11444.198906076495;11499.885001149882;12044.277343359427;12225.938870305947;12724;11408.486618102372;11932.164748467523;12112.818307725214;12112.939435302767;12239.20445171061;8594.312455003459;8774.429662071945;8795.384323097578;8931.73204803857;9081.909180908371;6658.400743933069;6872.244053154049;7211.206767255493;7344.265573442613;7377.963110184414;7006.684699188447;7145.4998150128995;7149.177844547736;7213.531120477152;7273.3817625500305 07:57:04 INFO - PID 11288 | |4;prototype.html;500.22465178972584;513.4275283059387;527.9287296215011;540.4757385336225;543.6031696861294;6025.668588227646;6042.2145121134245;6095.299040610331;6103.664298463588;6138.232720909887;5839.416058394158;5962.6124301920345;5975.223220981277;6014.5489088318445;6020.729067191976;4720.693154944917;4733.479317275097;4736.458343737835;4754.738489383082;4775.880602984918;4600.7239565626005;4709.740964246965;4750.667453278272;4752.643551733617;4757.333973243732;4639.466461356953;4668.8599342019625;4682.227432473638;4691.530846915315;4707.623390128799;4643.582077613014;4665.976670116662;4668.2997550367545;4685.20351540239;4686.7656617169005;4205.87382378526;4216.093539888939;4220.113776107021;4246.554111818276;4249.766262855542;5927.851803704899;5961.463468287875;5979.431953964367;5987.940120598825;5988.251468566429;5635.6055076144685;5663.5186009189265;5667.886642267173;5670.00774864397;5708.658465260661;6467.579607325509;6469;6475.255345635265;6493.123428337161;6521;4792.376990991183;4814.566688998007;4821.903561928777;4822.807087716487;4826.517348265181;6662.267150613428;6776.864462710718;6787.864242715118;6806.829829254259;6817.659117044128;4947.109520286383;4992.475790042066;5000.524950129732;5008.323876276656;5014.0974624567925;5105.974470127626;5107.131787596118;5115.846524604268;5145;5171;5606.803761868397;5654.943450565524;5725.2843394575675;5744.684042377626;5756.827295181151;6363.809085727343;6393.602399100338;6407.647579383179;6424.935750642434;6460.806175814733;1697.1514242878561;1706.9317227311017;1717.3770786606788;1721.9139043047799;1769.9115044247735;1212.921160124589;1237.6534570320325;1246.8192112143688;1249.5813902342636;1250.5998080614297;6182.69086545671;6205.689715514206;6217.476853007821;6244.843878902973;6253.280872699606;6468.15913931186;6522.608643481406;6522.836929076716;6564.343565643493;6596.835079122964;6238.376162383725;6244.033129564173;6260.186175797208;6264.718087686065;6311.558190926591;3452.361313157074;3466.7173145936167;3474.3051389722154;3479.739019573542;3490.2495963367996;7008;7010.92989070113;7054.6472676365975;7071.646417679095;7091.290870912868;6661.933380666228;6690.933090669128;6815.318468153145;6847.1783385993;6903.827404314932;6961.2342642308295;7009.7897063088185;7014.508984371045;7062.799324115015;7116.146062472537;6606.141201643755;6630.138082049302;6638.070670106093;6661.733530658719;6674.332566743286;6466.644334561644;6552.115464412243;6555.868882622225;6565.507586930904;6593.472522198309;7031.929680703128;7037;7059.505834591735;7070.080889484334;7071.893921591283;4925.581325587365;4943.8516844494725;4977.303177555073;4979.062353211478;5017.774200160929;6470.48236141117;6645.674014095028;6655.866882662416;6669.199696036507;6727.727892788017;6304.936950630435;6398.1362516059735;6425.8714825704155;6435.806925792233;6449.129367535323;6374.713137908712;6421.357864213542;6424.2933277338525;6428.260750013621;6432.807015789534;6314.179156709598;6345.8730825384155;6384.3934826191435;6411.647359395278;6434.8391290218115;6222.875542489215;6364.140840986593;6414.935850641434;6426.814882939636;6488.935110648833;6205.28639206479;6319.24169099711;6352.555321127476;6360.4911607072245;6386.648734319657 07:57:04 INFO - PID 11288 | |5;yui.html;936.4007035497278;947.8246524392987;950.9809803803925;958.6165533786489;974.8586454964028;15922.68154636908;16260.34958601656;16343.91828040861;16472.09403482808;19077.809221907777;19088.80911190888;19178.904105479454;19191.32830350938;19192.9040354798;19207.23171073159;969.8011907558969;998.2712619787577;1011.2870426349406;1059.2691043180218;1063.2557209953025;1044.2533588484232;1044.295100806956;1044.373375974413;1044.6239353832614;1046.5918291866178;1106.4633652678444;1108.562117963404;1110.2561283939779;1112.232559533923;1112.50493530379;1101;1102.399192440122;1102.8511150994634;1104.0339702760084;1105.2318638546215;809.7732634862248;809.9190080991913;811.2374368093973;811.2658044469764;811.3184924663252;16633;17057.914710426492;17220.225089870986;17222.397216097503;17320.566985825328;18170.091495425175;18305.908470457696;18578.07109644526;18603.534911627183;18779.62440751191;13416.597502074954;13540.05219634626;13697.452101915911;13705.657358566015;13710.108842925278;3293.5059741039036;3375.9493607595905;3380.4084285249983;3525.823708814549;3563.875264365761;123970;126147;128793;128926.35536822349;132256.33871830677;14215.50245741394;14372.209528476034;14387.568372948828;14444.494442694455;14465.78301325481;25607.871960640077;27280.727192728216;27288.863555682095;27579.586306205423;27672.03147889814;7613.9238607614325;7694.538327700356;7751.7674469766;7877.212278772192;8031.638576264082;3649.708023358125;3765.077555998798;3962.128331767007;3986.700997425147;4069.206504731549;4679.064187162513;4732.195526760459;4755.619550435957;4757.714537127714;4760.857174284777;1017.9694609161737;1042.67677020124;1054.825953717628;1057.2387880725864;1057.5029736024057;684.8424862281604;696.9303069692991;700.8808502554577;720.726124072849;722.0216606498225;11464.369459679798;11781.469833857496;11856.110791690659;11964;12090.637280881587;618.2364779497317;628.9811305660837;632.105570617571;640.1134428816123;648.8540078482398;5412.675239485643;5446.319210098738;5636.718164091779;5775.797847075332;6574.671266436659;115459;121228;121902;125406;125431.3728431352;103344;104402.95597044085;106077;106650.46674766576;109460;91725.54327616624;93858;93954.5302273498;94450;97482;12222.755544888874;13081.542146024844;13128.671783205496;13185.73628527405;13325.13386629866;42695.3595696071;46286.53713462822;46742.53257467518;47126;48450.03099938052;54688.726556366964;58271.70864145652;58390.7080464595;59539;60163.69918150381;15698.450554230547;16075.919620401823;17367.826321736622;17388.391406301223;17425.47723568295;16230.837691622932;19842.801571984674;19983;20001.399958001282;20173.193072276943;18131.184096715944;18665.253389864796;19220.807791921903;19263.903680481508;19383;15727.68544629124;16302.61427778652;16656.25046872918;16697.582560436087;16882.409115680894;17753.378631747826;18546.721799173294;18566.164522596246;18665.44003679892;18770.343037993604;12760.808587871375;12893.871061289643;13144.868551314365;13236.338183091;13617.046806723434;13165;13412.329383530589;13580.79628805549;13666.658333541742;13805.24071176095 07:57:04 INFO - PID 11288 | __end_tp_report 07:57:04 INFO - PID 11288 | __start_cc_report 07:57:04 INFO - PID 11288 | _x_x_mozilla_cycle_collect,324 07:57:04 INFO - PID 11288 | __end_cc_report 07:57:04 INFO - PID 11288 | __startTimestamp1501253824587__endTimestamp 07:57:04 INFO - PID 11288 | 07:57:04 INFO - PID 11288 | ------- Summary: start ------- 07:57:04 INFO - PID 11288 | Number of tests: 6 07:57:04 INFO - PID 11288 | 07:57:04 INFO - PID 11288 | [#0] dojo.html Cycles:165 Average:6127.75 Median:6419.33 stddev:795.00 (12.4%) stddev-sans-first:767.61 07:57:04 INFO - PID 11288 | Values: 3377.7 3413.3 3418.6 3420.9 3462.7 6129.8 6174.1 6176.9 6201.0 6214.9 6035.5 6134.0 6159.3 6174.9 6179.9 5384.0 5407.3 5428.8 5434.0 5434.6 5429.2 5453.9 5487.6 5499.1 5520.4 5406.3 5449.7 5453.5 5461.3 5499.4 5409.8 5410.3 5429.9 5471.8 5487.1 5149.0 5311.7 5331.8 5408.8 5415.9 6080.1 6105.3 6108.5 6164.2 6190.1 6528.6 6561.9 6630.8 6651.7 6700.8 6705.9 6710.9 6765.5 6780.4 6785.1 6137.2 6231.7 6266.6 6277.6 6283.2 6720.4 6744.7 6804.9 6837.1 6864.5 6413.6 6532.0 6595.6 6624.2 6643.1 6594.7 6657.5 6732.1 6746.6 6762.9 6604.6 6618.0 6683.9 6710.1 6724.3 6569.0 6572.8 6633.0 6643.4 6643.7 4839.2 4855.6 4885.4 4897.2 4901.4 4309.3 4330.0 4356.3 4359.6 4369.5 6277.8 6331.7 6362.2 6368.0 6389.2 6577.1 6580.0 6590.2 6590.5 6599.6 6310.0 6317.9 6330.3 6337.5 6345.0 5381.0 5414.7 5461.5 5471.4 5526.8 7043.2 7084.1 7109.2 7133.3 7137.8 6594.9 6601.7 6610.9 6626.3 6697.0 6986.7 6994.1 7039.6 7081.4 7129.0 6581.5 6587.6 6590.8 6591.6 6639.8 6742.9 6772.1 6800.2 6800.8 6810.4 6419.3 6434.8 6437.9 6507.6 6511.3 6395.2 6425.2 6512.0 6513.5 6520.5 6436.4 6438.5 6448.8 6449.9 6480.3 6431.5 6467.7 6491.0 6535.8 6544.0 6280.6 6299.9 6327.3 6352.7 6371.9 07:57:04 INFO - PID 11288 | 07:57:04 INFO - PID 11288 | [#1] ext.html Cycles:180 Average:40892.46 Median:19933.37 stddev:63153.53 (316.8%) stddev-sans-first:63259.17 07:57:04 INFO - PID 11288 | Values: 864.2 891.8 917.0 941.4 943.3 41228.0 41714.8 41801.8 41873.2 41974.4 37794.6 37804.1 38136.9 38157.0 38187.6 6669.6 6722.3 6743.6 6757.9 6766.8 6636.8 6724.3 6726.1 6729.1 6740.3 6698.4 6722.7 7250.0 7414.7 7421.6 7353.3 7382.4 7405.3 7405.7 7409.7 7154.1 7264.4 7323.3 7339.6 7341.3 39287.6 39374.6 39408.6 39506.2 39554.2 3436.2 3480.1 3486.8 3488.1 3488.5 30141.0 30174.2 30252.2 30254.4 30362.5 4790.1 4812.8 4825.1 4851.7 4890.2 196513.0 202277.0 203353.0 204097.0 211439.0 48570.5 48589.0 48621.3 48668.8 48676.0 50704.7 50736.0 50758.2 50803.5 51120.7 16311.3 16351.8 16395.0 16465.9 16626.1 13468.3 13504.7 13654.0 13664.2 13683.9 14647.3 14650.0 14691.7 14694.6 14900.9 5826.4 5867.0 5890.3 5980.3 5984.5 1065.9 1078.1 1084.9 1086.1 1103.0 23737.2 24195.4 24275.6 24520.0 24699.8 1150.1 1151.9 1176.6 1205.1 1205.9 12614.6 13012.2 13106.5 13164.5 13206.2 280476.0 284988.0 285774.0 285875.0 286169.0 53476.7 53513.0 53701.5 54107.0 54133.2 1477.9 1531.0 1535.8 1538.4 1549.6 23394.9 23646.6 23704.9 23741.3 24325.9 38127.2 38390.4 38411.2 38490.8 38558.8 228367.0 231727.0 233202.0 233455.0 234291.0 34872.3 36378.3 38389.2 38490.8 38611.0 47279.3 47808.5 48162.5 48407.5 48462.5 32019.2 32334.4 32480.5 33671.2 33784.5 30026.5 31846.7 32828.2 33035.3 33286.5 39394.2 39951.6 40905.2 41002.8 41003.4 33018.0 34022.3 34088.7 34139.8 34621.5 24388.6 26061.7 26107.3 26425.2 26433.1 07:57:04 INFO - PID 11288 | 07:57:04 INFO - PID 11288 | [#2] jquery.html Cycles:180 Average:37665.75 Median:22052.56 stddev:93369.52 (423.4%) stddev-sans-first:93589.89 07:57:04 INFO - PID 11288 | Values: 561.2 562.3 562.5 564.8 570.5 22001.9 22836.3 22865.1 22865.4 22973.2 24781.6 26573.3 26595.0 26599.7 26738.6 6109.7 6276.5 6287.0 6287.1 6288.7 5847.2 6196.0 6248.4 6253.0 6254.8 6043.2 6063.6 6079.6 6082.2 6082.4 5995.2 6012.6 6057.7 6074.4 6075.5 5596.3 5598.5 5630.3 5638.0 5665.6 29046.1 30176.0 30554.4 30686.4 30707.2 2083.7 2155.7 2157.4 2157.9 2158.0 18957.8 19552.1 19565.0 19629.5 19687.7 2196.7 2257.3 2263.6 2268.9 2293.0 130325.0 135277.3 136324.3 136392.0 137064.0 15279.3 15670.4 15750.2 15906.9 16047.8 23159.0 24151.5 24238.4 24306.6 24471.6 10577.7 10663.6 10700.6 10808.4 10816.5 9896.0 9958.8 9988.3 9995.0 10005.3 9734.9 9761.0 9818.4 9932.8 10160.8 2679.3 2746.9 2754.1 2770.2 2810.8 1007.2 1011.0 1039.8 1045.3 1055.4 20687.3 20846.9 21088.3 21430.8 21778.9 1099.6 1103.7 1111.2 1112.9 1128.0 11453.6 11623.9 11690.4 11752.4 11782.8 544047.0 556790.0 559126.0 559186.0 559257.0 133271.0 134390.0 134488.0 135085.0 142049.0 1305.7 1330.6 1360.0 1366.0 1367.5 21582.2 22333.8 22468.0 22592.5 22756.2 50874.0 53057.2 61341.7 62753.4 66014.7 74152.6 83545.6 86876.0 87376.6 88178.0 14559.7 15027.2 15069.4 15085.8 15129.5 21904.6 22103.2 22337.8 22356.7 22519.1 16909.7 17138.0 17166.4 17586.1 17669.8 14134.6 14358.4 15426.3 15454.9 15700.0 18402.5 18523.4 18530.0 18594.3 18602.4 14305.5 15027.5 15290.2 15328.5 15339.2 17486.5 17544.5 17587.3 18033.6 18538.2 07:57:04 INFO - PID 11288 | 07:57:04 INFO - PID 11288 | [#3] mootools.html Cycles:180 Average:9443.46 Median:2614.82 stddev:6812.86 (260.5%) stddev-sans-first:6805.27 07:57:04 INFO - PID 11288 | Values: 1415.2 1495.2 1501.6 1504.8 1519.1 14887.1 15166.3 15489.1 15554.0 15571.0 15344.5 15668.5 15671.0 15672.5 15691.0 2685.4 2739.5 2740.8 2742.4 2742.5 2526.1 2586.0 2613.1 2616.6 2618.3 2638.8 2654.1 2655.1 2677.2 2692.2 2616.9 2629.7 2648.5 2649.1 2650.6 2528.4 2567.2 2579.9 2583.4 2584.7 14949.6 15113.3 15209.2 15210.5 15215.8 7853.4 8167.1 8183.4 8199.4 8203.2 4760.8 4963.6 5037.9 5045.2 5050.4 1816.1 1837.1 1852.2 1910.2 1926.5 26192.5 26423.6 26461.7 26471.0 26567.3 6551.8 6594.9 6595.4 6710.4 6750.5 17849.9 18069.3 18137.5 18144.9 18175.1 8015.5 8165.2 8179.5 8196.8 8214.1 6706.2 7486.0 7500.3 7505.5 7542.3 5071.5 5195.6 5451.3 5455.9 5474.7 1493.1 1552.3 1555.2 1560.8 1579.3 877.5 915.5 930.4 932.6 943.8 7776.3 7937.2 8177.7 8195.5 8274.0 979.2 991.3 1013.2 1033.7 1062.4 4469.0 5023.2 5069.8 5072.7 5148.4 21666.0 22300.0 22396.2 22516.7 22557.4 21144.6 21744.3 21903.9 21912.7 21931.1 11382.3 11475.6 11831.3 12125.5 12187.9 8199.9 8359.1 8518.5 8554.6 8809.1 18440.2 18522.3 18766.7 18971.0 19275.9 18548.3 19249.3 19443.9 19586.9 19689.6 12500.1 12597.4 12652.5 12767.2 12814.4 12795.6 13051.1 13995.7 14205.2 14216.1 11444.2 11499.9 12044.3 12225.9 12724.0 11408.5 11932.2 12112.8 12112.9 12239.2 8594.3 8774.4 8795.4 8931.7 9081.9 6658.4 6872.2 7211.2 7344.3 7378.0 7006.7 7145.5 7149.2 7213.5 7273.4 07:57:04 INFO - PID 11288 | 07:57:04 INFO - PID 11288 | [#4] prototype.html Cycles:180 Average:5489.19 Median:6193.99 stddev:1580.83 (25.5%) stddev-sans-first:1540.28 07:57:04 INFO - PID 11288 | Values: 500.2 513.4 527.9 540.5 543.6 6025.7 6042.2 6095.3 6103.7 6138.2 5839.4 5962.6 5975.2 6014.5 6020.7 4720.7 4733.5 4736.5 4754.7 4775.9 4600.7 4709.7 4750.7 4752.6 4757.3 4639.5 4668.9 4682.2 4691.5 4707.6 4643.6 4666.0 4668.3 4685.2 4686.8 4205.9 4216.1 4220.1 4246.6 4249.8 5927.9 5961.5 5979.4 5987.9 5988.3 5635.6 5663.5 5667.9 5670.0 5708.7 6467.6 6469.0 6475.3 6493.1 6521.0 4792.4 4814.6 4821.9 4822.8 4826.5 6662.3 6776.9 6787.9 6806.8 6817.7 4947.1 4992.5 5000.5 5008.3 5014.1 5106.0 5107.1 5115.8 5145.0 5171.0 5606.8 5654.9 5725.3 5744.7 5756.8 6363.8 6393.6 6407.6 6424.9 6460.8 1697.2 1706.9 1717.4 1721.9 1769.9 1212.9 1237.7 1246.8 1249.6 1250.6 6182.7 6205.7 6217.5 6244.8 6253.3 6468.2 6522.6 6522.8 6564.3 6596.8 6238.4 6244.0 6260.2 6264.7 6311.6 3452.4 3466.7 3474.3 3479.7 3490.2 7008.0 7010.9 7054.6 7071.6 7091.3 6661.9 6690.9 6815.3 6847.2 6903.8 6961.2 7009.8 7014.5 7062.8 7116.1 6606.1 6630.1 6638.1 6661.7 6674.3 6466.6 6552.1 6555.9 6565.5 6593.5 7031.9 7037.0 7059.5 7070.1 7071.9 4925.6 4943.9 4977.3 4979.1 5017.8 6470.5 6645.7 6655.9 6669.2 6727.7 6304.9 6398.1 6425.9 6435.8 6449.1 6374.7 6421.4 6424.3 6428.3 6432.8 6314.2 6345.9 6384.4 6411.6 6434.8 6222.9 6364.1 6414.9 6426.8 6488.9 6205.3 6319.2 6352.6 6360.5 6386.6 07:57:04 INFO - PID 11288 | 07:57:04 INFO - PID 11288 | [#5] yui.html Cycles:180 Average:23797.24 Median:18238.00 stddev:34006.53 (186.5%) stddev-sans-first:34058.60 07:57:04 INFO - PID 11288 | Values: 936.4 947.8 951.0 958.6 974.9 15922.7 16260.3 16343.9 16472.1 19077.8 19088.8 19178.9 19191.3 19192.9 19207.2 969.8 998.3 1011.3 1059.3 1063.3 1044.3 1044.3 1044.4 1044.6 1046.6 1106.5 1108.6 1110.3 1112.2 1112.5 1101.0 1102.4 1102.9 1104.0 1105.2 809.8 809.9 811.2 811.3 811.3 16633.0 17057.9 17220.2 17222.4 17320.6 18170.1 18305.9 18578.1 18603.5 18779.6 13416.6 13540.1 13697.5 13705.7 13710.1 3293.5 3375.9 3380.4 3525.8 3563.9 123970.0 126147.0 128793.0 128926.4 132256.3 14215.5 14372.2 14387.6 14444.5 14465.8 25607.9 27280.7 27288.9 27579.6 27672.0 7613.9 7694.5 7751.8 7877.2 8031.6 3649.7 3765.1 3962.1 3986.7 4069.2 4679.1 4732.2 4755.6 4757.7 4760.9 1018.0 1042.7 1054.8 1057.2 1057.5 684.8 696.9 700.9 720.7 722.0 11464.4 11781.5 11856.1 11964.0 12090.6 618.2 629.0 632.1 640.1 648.9 5412.7 5446.3 5636.7 5775.8 6574.7 115459.0 121228.0 121902.0 125406.0 125431.4 103344.0 104403.0 106077.0 106650.5 109460.0 91725.5 93858.0 93954.5 94450.0 97482.0 12222.8 13081.5 13128.7 13185.7 13325.1 42695.4 46286.5 46742.5 47126.0 48450.0 54688.7 58271.7 58390.7 59539.0 60163.7 15698.5 16075.9 17367.8 17388.4 17425.5 16230.8 19842.8 19983.0 20001.4 20173.2 18131.2 18665.3 19220.8 19263.9 19383.0 15727.7 16302.6 16656.3 16697.6 16882.4 17753.4 18546.7 18566.2 18665.4 18770.3 12760.8 12893.9 13144.9 13236.3 13617.0 13165.0 13412.3 13580.8 13666.7 13805.2 07:57:04 INFO - PID 11288 | -------- Summary: end -------- 07:57:04 INFO - PID 11288 | 07:57:05 INFO - TEST-INFO | 11288: exit 0 07:57:05 INFO - TEST-OK | dromaeo_css | took 1110654ms 07:57:05 INFO - TEST-START | kraken 07:57:05 INFO - Initialising browser for kraken test... 07:57:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59575/getInfo.html -profile /tmp/tmp1ZxfSF/profile 07:57:05 INFO - TEST-INFO | started process 11651 (/builds/slave/test/build/application/firefox/firefox http://localhost:59575/getInfo.html) 07:57:11 INFO - TEST-INFO | 11651: exit 0 07:57:11 INFO - Browser initialized. 07:57:11 INFO - Running cycle 1/1 for kraken test... 07:57:11 INFO - TEST-INFO | started process 11861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1ZxfSF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:57:11 INFO - PID 11861 | 07:57:11 INFO - PID 11861 | (/builds/slave/test/build/application/firefox/firefox:11910): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:57:11 INFO - PID 11861 | 07:57:22 INFO - PID 11861 | RSS: Main: 164110336 07:57:22 INFO - PID 11861 | 07:57:24 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59575/tests/kraken/driver.html?testName=audio-beat-detection) 07:57:25 INFO - PID 11861 | RSS: Main: 168853504 07:57:25 INFO - PID 11861 | 07:57:28 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59575/tests/kraken/driver.html?testName=audio-dft) 07:57:29 INFO - PID 11861 | RSS: Main: 169472000 07:57:29 INFO - PID 11861 | 07:57:31 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59575/tests/kraken/driver.html?testName=audio-fft) 07:57:32 INFO - PID 11861 | RSS: Main: 163926016 07:57:32 INFO - PID 11861 | 07:57:34 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59575/tests/kraken/driver.html?testName=audio-oscillator) 07:57:35 INFO - PID 11861 | RSS: Main: 165015552 07:57:35 INFO - PID 11861 | 07:57:37 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59575/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:57:37 INFO - PID 11861 | RSS: Main: 165031936 07:57:37 INFO - PID 11861 | 07:57:40 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59575/tests/kraken/driver.html?testName=imaging-darkroom) 07:57:41 INFO - PID 11861 | RSS: Main: 167870464 07:57:41 INFO - PID 11861 | 07:57:45 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59575/tests/kraken/driver.html?testName=imaging-desaturate) 07:57:45 INFO - PID 11861 | RSS: Main: 169889792 07:57:45 INFO - PID 11861 | 07:57:48 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59575/tests/kraken/driver.html?testName=json-parse-financial) 07:57:49 INFO - PID 11861 | RSS: Main: 168349696 07:57:49 INFO - PID 11861 | 07:57:50 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59575/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:51 INFO - PID 11861 | RSS: Main: 168161280 07:57:51 INFO - PID 11861 | 07:57:53 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59575/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:57:53 INFO - PID 11861 | RSS: Main: 168357888 07:57:53 INFO - PID 11861 | 07:57:55 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59575/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:56 INFO - PID 11861 | RSS: Main: 165306368 07:57:56 INFO - PID 11861 | 07:57:58 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:59 INFO - PID 11861 | RSS: Main: 165703680 07:57:59 INFO - PID 11861 | 07:58:02 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:03 INFO - PID 11861 | RSS: Main: 166141952 07:58:03 INFO - PID 11861 | 07:58:04 INFO - PID 11861 | Cycle 1(1): loaded http://localhost:59575/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59575/tests/kraken/driver.html?testName=ai-astar) 07:58:05 INFO - PID 11861 | RSS: Main: 167575552 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | __start_tp_report 07:58:05 INFO - PID 11861 | _x_x_mozilla_page_load 07:58:05 INFO - PID 11861 | _x_x_mozilla_page_load_details 07:58:05 INFO - PID 11861 | |i|pagename|runs| 07:58:05 INFO - PID 11861 | |0;ai-astar;99;109;100;106;106;105;108;106;108;109 07:58:05 INFO - PID 11861 | |1;audio-beat-detection;137;127;140;170;116;145;148;114;167;114 07:58:05 INFO - PID 11861 | |2;audio-dft;163;163;162;161;168;162;164;164;165;167 07:58:05 INFO - PID 11861 | |3;audio-fft;76;76;75;171;74;74;73;83;97;74 07:58:05 INFO - PID 11861 | |4;audio-oscillator;79;78;129;79;79;79;135;78;79;126 07:58:05 INFO - PID 11861 | |5;imaging-gaussian-blur;114;115;115;115;114;115;114;114;113;115 07:58:05 INFO - PID 11861 | |6;imaging-darkroom;148;148;148;148;148;147;149;148;150;148 07:58:05 INFO - PID 11861 | |7;imaging-desaturate;94;99;94;94;102;94;95;94;94;93 07:58:05 INFO - PID 11861 | |8;json-parse-financial;51;49;49;50;50;50;50;50;49;52 07:58:05 INFO - PID 11861 | |9;json-stringify-tinderbox;53;55;54;53;54;53;53;54;54;54 07:58:05 INFO - PID 11861 | |10;stanford-crypto-aes;78;79;76;77;78;77;76;79;79;80 07:58:05 INFO - PID 11861 | |11;stanford-crypto-ccm;138;120;122;132;120;123;129;120;121;156 07:58:05 INFO - PID 11861 | |12;stanford-crypto-pbkdf2;171;169;168;169;174;176;171;180;172;172 07:58:05 INFO - PID 11861 | |13;stanford-crypto-sha256-iterative;65;63;62;65;66;63;64;61;64;63 07:58:05 INFO - PID 11861 | __end_tp_report 07:58:05 INFO - PID 11861 | __start_cc_report 07:58:05 INFO - PID 11861 | _x_x_mozilla_cycle_collect,873 07:58:05 INFO - PID 11861 | __end_cc_report 07:58:05 INFO - PID 11861 | __startTimestamp1501253885214__endTimestamp 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | ------- Summary: start ------- 07:58:05 INFO - PID 11861 | Number of tests: 14 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#0] ai-astar Cycles:10 Average:105.60 Median:108.00 stddev:3.50 (3.2%) stddev-sans-first:2.78 07:58:05 INFO - PID 11861 | Values: 99.0 109.0 100.0 106.0 106.0 105.0 108.0 106.0 108.0 109.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:142.50 stddev:20.48 (14.4%) stddev-sans-first:21.72 07:58:05 INFO - PID 11861 | Values: 137.0 127.0 140.0 170.0 116.0 145.0 148.0 114.0 167.0 114.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.23 (1.4%) stddev-sans-first:2.35 07:58:05 INFO - PID 11861 | Values: 163.0 163.0 162.0 161.0 168.0 162.0 164.0 164.0 165.0 167.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#3] audio-fft Cycles:10 Average:87.30 Median:75.50 stddev:30.30 (40.1%) stddev-sans-first:31.86 07:58:05 INFO - PID 11861 | Values: 76.0 76.0 75.0 171.0 74.0 74.0 73.0 83.0 97.0 74.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.00 stddev:24.87 (31.5%) stddev-sans-first:25.77 07:58:05 INFO - PID 11861 | Values: 79.0 78.0 129.0 79.0 79.0 79.0 135.0 78.0 79.0 126.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:115.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 07:58:05 INFO - PID 11861 | Values: 114.0 115.0 115.0 115.0 114.0 115.0 114.0 114.0 113.0 115.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 07:58:05 INFO - PID 11861 | Values: 148.0 148.0 148.0 148.0 148.0 147.0 149.0 148.0 150.0 148.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.00 stddev:2.87 (3.1%) stddev-sans-first:3.00 07:58:05 INFO - PID 11861 | Values: 94.0 99.0 94.0 94.0 102.0 94.0 95.0 94.0 94.0 93.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#8] json-parse-financial Cycles:10 Average:50.00 Median:50.00 stddev:0.94 (1.9%) stddev-sans-first:0.93 07:58:05 INFO - PID 11861 | Values: 51.0 49.0 49.0 50.0 50.0 50.0 50.0 50.0 49.0 52.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#9] json-stringify-tinderbox Cycles:10 Average:53.70 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.67 07:58:05 INFO - PID 11861 | Values: 53.0 55.0 54.0 53.0 54.0 53.0 53.0 54.0 54.0 54.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#10] stanford-crypto-aes Cycles:10 Average:77.90 Median:78.50 stddev:1.37 (1.7%) stddev-sans-first:1.45 07:58:05 INFO - PID 11861 | Values: 78.0 79.0 76.0 77.0 78.0 77.0 76.0 79.0 79.0 80.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:126.00 stddev:11.56 (9.2%) stddev-sans-first:11.69 07:58:05 INFO - PID 11861 | Values: 138.0 120.0 122.0 132.0 120.0 123.0 129.0 120.0 121.0 156.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:172.00 stddev:3.65 (2.1%) stddev-sans-first:3.84 07:58:05 INFO - PID 11861 | Values: 171.0 169.0 168.0 169.0 174.0 176.0 171.0 180.0 172.0 172.0 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.60 Median:64.00 stddev:1.51 (2.4%) stddev-sans-first:1.51 07:58:05 INFO - PID 11861 | Values: 65.0 63.0 62.0 65.0 66.0 63.0 64.0 61.0 64.0 63.0 07:58:05 INFO - PID 11861 | -------- Summary: end -------- 07:58:05 INFO - PID 11861 | 07:58:05 INFO - PID 11861 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:58:05 INFO - TEST-INFO | 11861: exit 0 07:58:05 INFO - TEST-OK | kraken | took 60516ms 07:58:05 INFO - SUITE-END | took 1171s 07:58:05 INFO - Completed test suite (00:19:31) 07:58:05 INFO - javascript benchmark 07:58:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8560.443815665703, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3377.729781617471, 3413.266147778227, 3418.606860211076, 3420.931581368373, 3462.7056700180483, 6129.846753831156, 6174.073888916665, 6176.9382306176985, 6200.968995155018, 6214.906776398352, 6035.486983606399, 6133.969330153354, 6159.291681456634, 6174.9382506174925, 6179.938200618004, 5384.030874442598, 5407.297051383324, 5428.75570599324, 5434.0, 5434.646747961389, 5429.158480435539, 5453.945460545384, 5487.6158668893195, 5499.092649712813, 5520.447955204468, 5406.297181366436, 5449.700266485342, 5453.454654534535, 5461.262729531522, 5499.395066542697, 5409.83770486886, 5410.323709536308, 5429.918551221735, 5471.781128754845, 5487.122060470326, 5149.0, 5311.681299122065, 5331.786728530893, 5408.810691625774, 5415.891682166374, 6080.0575910733905, 6105.32841387447, 6108.450239478424, 6164.229471316085, 6190.133381326618, 6528.6409247491365, 6561.901571476432, 6630.801075967729, 6651.733930642768, 6700.798976030727, 6705.865882682319, 6710.899336509956, 6765.526413151081, 6780.423663988518, 6785.084013658142, 6137.171481849982, 6231.657258850807, 6266.624002559861, 6277.623342599459, 6283.246010478726, 6720.4287635550545, 6744.696488658022, 6804.87245228801, 6837.1111755471475, 6864.450843932474, 6413.647249401328, 6531.967340163269, 6595.637239951849, 6624.238212605515, 6643.10318107059, 6594.736210551524, 6657.53397262187, 6732.057511948331, 6746.561473504206, 6762.898556521656, 6604.636744979072, 6618.040384144272, 6683.933160668331, 6710.060591517192, 6724.260331363546, 6568.967155164193, 6572.835679107965, 6633.0, 6643.368879956396, 6643.734250630017, 4839.201531747292, 4855.587275081658, 4885.41375034991, 4897.240927656219, 4901.43633482147, 4309.28896732042, 4329.956700432956, 4356.281213599784, 4359.585839345257, 4369.453818272716, 6277.811665650038, 6331.651759153291, 6362.236531616236, 6368.044793281045, 6389.201349831271, 6577.144971153815, 6580.045893345438, 6590.242122155918, 6590.538662293593, 6599.60402375859, 6310.0, 6317.936820631827, 6330.272018717907, 6337.524685648595, 6345.0, 5381.031414345455, 5414.7021913795115, 5461.453854614586, 5471.425500322488, 5526.806561770399, 7043.225245223021, 7084.114485689289, 7109.217986021534, 7133.251008644018, 7137.750178743719, 6594.901076483857, 6601.735930562916, 6610.933890661032, 6626.271110177973, 6697.0, 6986.685599147949, 6994.055802466602, 7039.612821294878, 7081.4334853210585, 7128.964355178191, 6581.506387021088, 6587.571807832475, 6590.80227593173, 6591.637459939558, 6639.767608133692, 6742.898856517254, 6772.0857684212, 6800.217974932946, 6800.82997925036, 6810.421114205348, 6419.325970773001, 6434.806955791334, 6437.935620643733, 6507.577007494498, 6511.2512061113575, 6395.16862807832, 6425.153793574838, 6512.023196520559, 6513.5114866384265, 6520.478361730955, 6436.356364363526, 6438.4527315176865, 6448.806535803933, 6449.9355006451215, 6480.254770701241, 6431.549791514549, 6467.741290348522, 6491.026346048131, 6535.803925882231, 6544.018397240452, 6280.591761535668, 6299.937000629935, 6327.303996560283, 6352.6506042166275, 6371.93628063732], "value": 6066.552688784383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [864.1560028994708, 891.786644999554, 916.9679061232856, 941.4022095969058, 943.2548286853386, 41228.0, 41714.7914260429, 41801.79099104504, 41873.16253674928, 41974.37038444426, 37794.62205377945, 37804.054898627546, 38136.90247036412, 38157.0, 38187.61812381876, 6669.566478178915, 6722.294159113296, 6743.561668491557, 6757.932420675779, 6766.8308292292595, 6636.767713130042, 6724.293949135344, 6726.125603671516, 6729.05793188954, 6740.325967403245, 6698.3971442570155, 6722.663866806664, 7249.963750181241, 7414.740484083059, 7421.591812450313, 7353.301436363537, 7382.409407247407, 7405.333519983227, 7405.666744996488, 7409.740659076933, 7154.069970903801, 7264.418846492268, 7323.267673232687, 7339.633018349061, 7341.339279464821, 39287.60712392897, 39374.60625393738, 39408.605913941065, 39506.20987580261, 39554.208915821524, 3436.2096717754807, 3480.112571294304, 3486.808225547594, 3488.1105318143964, 3488.459288810213, 30141.0, 30174.245643859078, 30252.243693907607, 30254.394912101856, 30362.54456183159, 4790.065937142223, 4812.807487700487, 4825.131476334293, 4851.660383773137, 4890.193118135503, 196513.0, 202277.0, 203353.0, 204097.0, 211439.0, 48570.5142948566, 48589.0, 48621.270680939815, 48668.756656216494, 48676.0, 50704.746476267384, 50736.0, 50758.238626420636, 50803.49196508062, 51120.744396278526, 16311.265993030342, 16351.83648163527, 16395.0, 16465.91767041181, 16626.085565293783, 13468.259245741578, 13504.662383440493, 13654.0, 13664.180149191081, 13683.931580342034, 14647.340869660891, 14650.0, 14691.706165876623, 14694.632634184018, 14900.92549537267, 5826.416753696531, 5866.970665146647, 5890.263717035371, 5980.295615749491, 5984.491318237911, 1065.9200559958035, 1078.094400703413, 1084.8860869608736, 1086.0768346905068, 1102.9779404412027, 23737.16919907795, 24195.395115122265, 24275.63586546203, 24520.0, 24699.753002469744, 1150.097173718627, 1151.9251248668809, 1176.5705517486056, 1205.1262834445133, 1205.9155859089956, 12614.55849045279, 13012.21926684402, 13106.541271055466, 13164.539241126515, 13206.207627542379, 280476.0, 284988.0, 285774.0, 285875.0, 286169.0, 53476.73261633667, 53513.0, 53701.462985370425, 54107.0, 54133.188002179995, 1477.9039362441406, 1530.9540713778604, 1535.8310585835773, 1538.4077130304913, 1549.635835578638, 23394.883025584764, 23646.645300320164, 23704.881475592512, 23741.287761367188, 24325.878370608032, 38127.23745525129, 38390.42414363731, 38411.231775363776, 38490.80754596209, 38558.80720596379, 228367.0, 231727.0, 233202.0, 233455.0, 234291.0, 34872.30255394929, 36378.27243455169, 38389.232215356096, 38490.80754596209, 38611.0, 47279.29081063718, 47808.5219147818, 48162.5183748158, 48407.5159248403, 48462.5153748458, 32019.199520012186, 32334.35331293408, 32480.512792308607, 33671.15822104467, 33784.49323260104, 30026.549601755552, 31846.68153318437, 32828.17929551685, 33035.339293214485, 33286.500702489, 39394.2121157581, 39951.600483994785, 40905.18189636131, 41002.79498602488, 41003.38494922638, 33018.0, 34022.31955360928, 34088.65911340855, 34139.82930085334, 34621.48067779036, 24388.63417048781, 26061.688650939916, 26107.347316317246, 26425.207243782716, 26433.095566344706], "value": 17580.245630342295, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1610642090076, 562.2550121089557, 562.4965655738117, 564.762799624158, 570.4609144358581, 22001.889990550044, 22836.314910552668, 22865.085396584116, 22865.4283642909, 22973.19593814217, 24781.62827557588, 26573.335666608345, 26595.0, 26599.734002659967, 26738.5989210162, 6109.663968481743, 6276.529260305472, 6287.025511045796, 6287.08837218603, 6288.748450061992, 5847.239858818348, 6196.039613859859, 6248.4064013918605, 6252.999520076789, 6254.843628909291, 6043.244594425697, 6063.605865618721, 6079.574429789916, 6082.178905847698, 6082.391760823926, 5995.16067750511, 6012.6392416455155, 6057.727402266886, 6074.392560743934, 6075.544334174932, 5596.3284405871145, 5598.496135347838, 5630.324361076656, 5638.041532939369, 5665.631733937281, 29046.12861614155, 30176.0, 30554.388912221853, 30686.386272274653, 30707.232319191975, 2083.7395325584303, 2155.687425323335, 2157.3635777445693, 2157.9352619421443, 2158.0396723458066, 18957.81042189574, 19552.120154593078, 19565.0, 19629.509262268413, 19687.704684429744, 2196.7144271244797, 2257.322803159062, 2263.569921714869, 2268.88655567221, 2292.9541409171725, 130325.0, 135277.3236133823, 136324.31837840847, 136392.0, 137064.0, 15279.312430940634, 15670.373185072469, 15750.212489375486, 15906.9204653976, 16047.759283610756, 23158.95784689693, 24151.51696966086, 24238.394040148785, 24306.635400469007, 24471.632925506132, 10577.682669519927, 10663.573457061631, 10700.571977120984, 10808.405537695346, 10816.513256903458, 9895.950520247497, 9958.80082398348, 9988.250881183794, 9994.950025249827, 10005.269070555883, 9734.902650973541, 9761.0, 9818.410895346302, 9932.751681207883, 10160.796784064278, 2679.289988153141, 2746.8901243950418, 2754.0754424944375, 2770.1966429735153, 2810.789190810697, 1007.1791489935679, 1010.9646162384281, 1039.7556574205055, 1045.2839804733783, 1055.4458909072798, 20687.27594534184, 20846.895765521076, 21088.261910833047, 21430.78569214288, 21778.89110554437, 1099.6096385783092, 1103.674416047268, 1111.2110401614943, 1112.8720197177267, 1127.9661610151545, 11453.59912403062, 11623.941880290713, 11690.357030363242, 11752.412379380996, 11782.764344713058, 544047.0, 556790.0, 559126.0, 559186.0, 559257.0, 133271.0, 134390.0, 134488.0, 135085.0, 142049.0, 1305.673581604599, 1330.6207730796677, 1359.9932000339934, 1366.043769361451, 1367.5213675213795, 21582.244621438174, 22333.77666223317, 22468.0, 22592.548149037255, 22756.20353287627, 50874.0, 53057.20414193713, 61341.69329153326, 62753.372466274755, 66014.66992665007, 74152.62923685346, 83545.58227209069, 86876.0, 87376.563117184, 88178.0, 14559.708805824037, 15027.173505457306, 15069.397224110913, 15085.849141508445, 15129.546113616609, 21904.561908761418, 22103.226387076375, 22337.771422571914, 22356.664650029936, 22519.099236030375, 16909.66180676404, 17138.0, 17166.39917602878, 17586.120693965506, 17669.823301767334, 14134.575962721136, 14358.353874075483, 15426.30581623852, 15454.922725386301, 15700.0, 18402.539936501693, 18523.44429667112, 18530.0, 18594.349197778014, 18602.44192674222, 14305.499307524187, 15027.474038408604, 15290.159041252839, 15328.540143795259, 15339.156346401054, 17486.47540573785, 17544.473665790047, 17587.29650813953, 18033.639327213645, 18538.16578253955], "value": 12264.04250412367, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1415.2450960808596, 1495.200067963639, 1501.5945694662448, 1504.7592385218363, 1519.0809560216076, 14887.106773593592, 15166.317515711791, 15489.070655760663, 15554.0, 15571.0, 15344.539663810076, 15668.529944101696, 15671.0, 15672.451464198755, 15691.0, 2685.4092099738077, 2739.5342791725357, 2740.849253291078, 2742.3555464465835, 2742.4515096980685, 2526.1411120219122, 2585.961210581843, 2613.085420102968, 2616.5551856184493, 2618.2668852721267, 2638.762511373976, 2654.0578094776365, 2655.1238091429877, 2677.1834590450003, 2692.17888543994, 2616.882240299191, 2629.6581444412295, 2648.510025645262, 2649.072824511415, 2650.6421633079576, 2528.3931856354343, 2567.2169988153605, 2579.9097031603806, 2583.3929026678716, 2584.6639936808283, 14949.551513454613, 15113.3199006045, 15209.239538023165, 15210.543683689508, 15215.847841521554, 7853.410994175402, 8167.142450042778, 8183.427160098796, 8199.385046121564, 8203.179682031809, 4760.833370832004, 4963.553280204799, 5037.949620503821, 5045.243213517965, 5050.419201791804, 1816.0556510614538, 1837.0998210876708, 1852.249838815282, 1910.2072639854443, 1926.4991102313359, 26192.476150476883, 26423.603645945324, 26461.73538264612, 26471.0, 26567.335816604547, 6551.8362040948405, 6594.901076483857, 6595.373439523238, 6710.396064354231, 6750.493712971449, 17849.910750446164, 18069.27722891096, 18137.455876323733, 18144.909275453803, 18175.091245437674, 8015.519068855887, 8165.2243036911395, 8179.468334558234, 8196.795080123045, 8214.096449390563, 6706.228783689938, 7486.0, 7500.324970752549, 7505.4746167767735, 7542.2834830691, 5071.54356107952, 5195.610329225323, 5451.264079349237, 5455.945440545624, 5474.698891561003, 1493.133982290269, 1552.2781906413572, 1555.2223888055971, 1560.7502799552244, 1579.336678594993, 877.4559772940818, 915.455304094063, 930.4045410937006, 932.6269492203037, 943.8206740719241, 7776.300132988058, 7937.166597507294, 8177.713780017671, 8195.508269503849, 8274.0, 979.177490907641, 991.251605038206, 1013.159077965287, 1033.7105610429091, 1062.3678911047914, 4468.955310446854, 5023.246513023076, 5069.797208111634, 5072.695638261716, 5148.3564554430695, 21666.0, 22300.0, 22396.216132435286, 22516.662250066263, 22557.43606409853, 21144.577108457746, 21744.34766956994, 21903.890480547496, 21912.671309930363, 21931.12275508962, 11382.317060976367, 11475.598354057567, 11831.349275789742, 12125.454354554066, 12187.878121218851, 8199.918000820155, 8359.122292159236, 8518.48889066658, 8554.57227138653, 8809.119088091396, 18440.170192341644, 18522.259109635463, 18766.71849922225, 18971.0, 19275.903620481808, 18548.25806967706, 19249.32627358036, 19443.902780486573, 19586.90206549015, 19689.606207876048, 12500.124991250888, 12597.370131493206, 12652.493900243888, 12767.170133941265, 12814.423350949417, 12795.552155674506, 13051.086423950232, 13995.720085598028, 14205.218712970885, 14216.147031178163, 11444.198906076495, 11499.885001149882, 12044.277343359427, 12225.938870305947, 12724.0, 11408.486618102372, 11932.164748467523, 12112.818307725214, 12112.939435302767, 12239.20445171061, 8594.312455003459, 8774.429662071945, 8795.384323097578, 8931.73204803857, 9081.909180908371, 6658.400743933069, 6872.244053154049, 7211.206767255493, 7344.265573442613, 7377.963110184414, 7006.684699188447, 7145.4998150128995, 7149.177844547736, 7213.531120477152, 7273.3817625500305], "value": 6716.305784571981, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.22465178972584, 513.4275283059387, 527.9287296215011, 540.4757385336225, 543.6031696861294, 6025.668588227646, 6042.2145121134245, 6095.299040610331, 6103.664298463588, 6138.232720909887, 5839.416058394158, 5962.6124301920345, 5975.223220981277, 6014.5489088318445, 6020.729067191976, 4720.693154944917, 4733.479317275097, 4736.458343737835, 4754.738489383082, 4775.880602984918, 4600.7239565626005, 4709.740964246965, 4750.667453278272, 4752.643551733617, 4757.333973243732, 4639.466461356953, 4668.8599342019625, 4682.227432473638, 4691.530846915315, 4707.623390128799, 4643.582077613014, 4665.976670116662, 4668.2997550367545, 4685.20351540239, 4686.7656617169005, 4205.87382378526, 4216.093539888939, 4220.113776107021, 4246.554111818276, 4249.766262855542, 5927.851803704899, 5961.463468287875, 5979.431953964367, 5987.940120598825, 5988.251468566429, 5635.6055076144685, 5663.5186009189265, 5667.886642267173, 5670.00774864397, 5708.658465260661, 6467.579607325509, 6469.0, 6475.255345635265, 6493.123428337161, 6521.0, 4792.376990991183, 4814.566688998007, 4821.903561928777, 4822.807087716487, 4826.517348265181, 6662.267150613428, 6776.864462710718, 6787.864242715118, 6806.829829254259, 6817.659117044128, 4947.109520286383, 4992.475790042066, 5000.524950129732, 5008.323876276656, 5014.0974624567925, 5105.974470127626, 5107.131787596118, 5115.846524604268, 5145.0, 5171.0, 5606.803761868397, 5654.943450565524, 5725.2843394575675, 5744.684042377626, 5756.827295181151, 6363.809085727343, 6393.602399100338, 6407.647579383179, 6424.935750642434, 6460.806175814733, 1697.1514242878561, 1706.9317227311017, 1717.3770786606788, 1721.9139043047799, 1769.9115044247735, 1212.921160124589, 1237.6534570320325, 1246.8192112143688, 1249.5813902342636, 1250.5998080614297, 6182.69086545671, 6205.689715514206, 6217.476853007821, 6244.843878902973, 6253.280872699606, 6468.15913931186, 6522.608643481406, 6522.836929076716, 6564.343565643493, 6596.835079122964, 6238.376162383725, 6244.033129564173, 6260.186175797208, 6264.718087686065, 6311.558190926591, 3452.361313157074, 3466.7173145936167, 3474.3051389722154, 3479.739019573542, 3490.2495963367996, 7008.0, 7010.92989070113, 7054.6472676365975, 7071.646417679095, 7091.290870912868, 6661.933380666228, 6690.933090669128, 6815.318468153145, 6847.1783385993, 6903.827404314932, 6961.2342642308295, 7009.7897063088185, 7014.508984371045, 7062.799324115015, 7116.146062472537, 6606.141201643755, 6630.138082049302, 6638.070670106093, 6661.733530658719, 6674.332566743286, 6466.644334561644, 6552.115464412243, 6555.868882622225, 6565.507586930904, 6593.472522198309, 7031.929680703128, 7037.0, 7059.505834591735, 7070.080889484334, 7071.893921591283, 4925.581325587365, 4943.8516844494725, 4977.303177555073, 4979.062353211478, 5017.774200160929, 6470.48236141117, 6645.674014095028, 6655.866882662416, 6669.199696036507, 6727.727892788017, 6304.936950630435, 6398.1362516059735, 6425.8714825704155, 6435.806925792233, 6449.129367535323, 6374.713137908712, 6421.357864213542, 6424.2933277338525, 6428.260750013621, 6432.807015789534, 6314.179156709598, 6345.8730825384155, 6384.3934826191435, 6411.647359395278, 6434.8391290218115, 6222.875542489215, 6364.140840986593, 6414.935850641434, 6426.814882939636, 6488.935110648833, 6205.28639206479, 6319.24169099711, 6352.555321127476, 6360.4911607072245, 6386.648734319657], "value": 5028.88362549833, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [936.4007035497278, 947.8246524392987, 950.9809803803925, 958.6165533786489, 974.8586454964028, 15922.68154636908, 16260.34958601656, 16343.91828040861, 16472.09403482808, 19077.809221907777, 19088.80911190888, 19178.904105479454, 19191.32830350938, 19192.9040354798, 19207.23171073159, 969.8011907558969, 998.2712619787577, 1011.2870426349406, 1059.2691043180218, 1063.2557209953025, 1044.2533588484232, 1044.295100806956, 1044.373375974413, 1044.6239353832614, 1046.5918291866178, 1106.4633652678444, 1108.562117963404, 1110.2561283939779, 1112.232559533923, 1112.50493530379, 1101.0, 1102.399192440122, 1102.8511150994634, 1104.0339702760084, 1105.2318638546215, 809.7732634862248, 809.9190080991913, 811.2374368093973, 811.2658044469764, 811.3184924663252, 16633.0, 17057.914710426492, 17220.225089870986, 17222.397216097503, 17320.566985825328, 18170.091495425175, 18305.908470457696, 18578.07109644526, 18603.534911627183, 18779.62440751191, 13416.597502074954, 13540.05219634626, 13697.452101915911, 13705.657358566015, 13710.108842925278, 3293.5059741039036, 3375.9493607595905, 3380.4084285249983, 3525.823708814549, 3563.875264365761, 123970.0, 126147.0, 128793.0, 128926.35536822349, 132256.33871830677, 14215.50245741394, 14372.209528476034, 14387.568372948828, 14444.494442694455, 14465.78301325481, 25607.871960640077, 27280.727192728216, 27288.863555682095, 27579.586306205423, 27672.03147889814, 7613.9238607614325, 7694.538327700356, 7751.7674469766, 7877.212278772192, 8031.638576264082, 3649.708023358125, 3765.077555998798, 3962.128331767007, 3986.700997425147, 4069.206504731549, 4679.064187162513, 4732.195526760459, 4755.619550435957, 4757.714537127714, 4760.857174284777, 1017.9694609161737, 1042.67677020124, 1054.825953717628, 1057.2387880725864, 1057.5029736024057, 684.8424862281604, 696.9303069692991, 700.8808502554577, 720.726124072849, 722.0216606498225, 11464.369459679798, 11781.469833857496, 11856.110791690659, 11964.0, 12090.637280881587, 618.2364779497317, 628.9811305660837, 632.105570617571, 640.1134428816123, 648.8540078482398, 5412.675239485643, 5446.319210098738, 5636.718164091779, 5775.797847075332, 6574.671266436659, 115459.0, 121228.0, 121902.0, 125406.0, 125431.3728431352, 103344.0, 104402.95597044085, 106077.0, 106650.46674766576, 109460.0, 91725.54327616624, 93858.0, 93954.5302273498, 94450.0, 97482.0, 12222.755544888874, 13081.542146024844, 13128.671783205496, 13185.73628527405, 13325.13386629866, 42695.3595696071, 46286.53713462822, 46742.53257467518, 47126.0, 48450.03099938052, 54688.726556366964, 58271.70864145652, 58390.7080464595, 59539.0, 60163.69918150381, 15698.450554230547, 16075.919620401823, 17367.826321736622, 17388.391406301223, 17425.47723568295, 16230.837691622932, 19842.801571984674, 19983.0, 20001.399958001282, 20173.193072276943, 18131.184096715944, 18665.253389864796, 19220.807791921903, 19263.903680481508, 19383.0, 15727.68544629124, 16302.61427778652, 16656.25046872918, 16697.582560436087, 16882.409115680894, 17753.378631747826, 18546.721799173294, 18566.164522596246, 18665.44003679892, 18770.343037993604, 12760.808587871375, 12893.871061289643, 13144.868551314365, 13236.338183091, 13617.046806723434, 13165.0, 13412.329383530589, 13580.79628805549, 13666.658333541742, 13805.24071176095], "value": 8907.339394784169, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1492.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 100.0, 106.0, 106.0, 105.0, 108.0, 106.0, 108.0, 109.0], "value": 105.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 127.0, 140.0, 170.0, 116.0, 145.0, 148.0, 114.0, 167.0, 114.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 161.0, 168.0, 162.0, 164.0, 164.0, 165.0, 167.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 171.0, 74.0, 74.0, 73.0, 83.0, 97.0, 74.0], "value": 87.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 129.0, 79.0, 79.0, 79.0, 135.0, 78.0, 79.0, 126.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 115.0, 114.0, 115.0, 114.0, 114.0, 113.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 149.0, 148.0, 150.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 94.0, 94.0, 102.0, 94.0, 95.0, 94.0, 94.0, 93.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 49.0, 50.0, 50.0, 50.0, 50.0, 50.0, 49.0, 52.0], "value": 50.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 53.0, 54.0, 53.0, 53.0, 54.0, 54.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 76.0, 77.0, 78.0, 77.0, 76.0, 79.0, 79.0, 80.0], "value": 77.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 120.0, 122.0, 132.0, 120.0, 123.0, 129.0, 120.0, 121.0, 156.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 169.0, 168.0, 169.0, 174.0, 176.0, 171.0, 180.0, 172.0, 172.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 62.0, 65.0, 66.0, 63.0, 64.0, 61.0, 64.0, 63.0], "value": 63.6, "unit": "score"}]}]} 07:58:05 INFO - Return code: 0 07:58:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:58:06 INFO - # TBPL SUCCESS # 07:58:06 INFO - Running post-action listener: _package_coverage_data 07:58:06 INFO - Running post-action listener: _resource_record_post_action 07:58:06 INFO - [mozharness: 2017-07-28 14:58:06.033479Z] Finished run-tests step (success) 07:58:06 INFO - Running post-run listener: _resource_record_post_run 07:58:06 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 245760; Write bytes: 440033280; Read time: 348; Write time: 253868 07:58:06 INFO - TinderboxPrint: CPU usage
13.0% 07:58:06 INFO - TinderboxPrint: I/O read bytes / time
245,760 / 348 07:58:06 INFO - TinderboxPrint: I/O write bytes / time
440,033,280 / 253,868 07:58:06 INFO - TinderboxPrint: CPU idle
8,242.4 (86.9%) 07:58:06 INFO - TinderboxPrint: CPU user
1,190.1 (12.6%) 07:58:06 INFO - TinderboxPrint: Swap in / out
0 / 0 07:58:06 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 121380864; Read time: 160; Write time: 80356 07:58:06 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:58:06 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 241664; Write bytes: 318652416; Read time: 188; Write time: 173512 07:58:06 INFO - Running post-run listener: _upload_blobber_files 07:58:06 INFO - Blob upload gear active. 07:58:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:58:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:58:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:58:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:58:07 INFO - (blobuploader) - INFO - Open directory for files ... 07:58:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:58:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:58:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:07 INFO - (blobuploader) - INFO - Done attempting. 07:58:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:58:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:58:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:08 INFO - (blobuploader) - INFO - Done attempting. 07:58:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:58:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:58:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:14 INFO - (blobuploader) - INFO - Done attempting. 07:58:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:58:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:58:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:58:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:58:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:58:15 INFO - (blobuploader) - INFO - Done attempting. 07:58:15 INFO - (blobuploader) - INFO - Iteration through files over. 07:58:15 INFO - Return code: 0 07:58:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:58:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:58:15 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50d4ecef412a2da813d218a8c3401facd91941aba5cd1ea1ae8329efffe46f065bc0dbb3be781656fb15f7bfa43f410a60cb5264dd27c7f2435ae703fb46321c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86434158604acf8b5cdee3d68518a236d98b31db6d57dd67837b716e812b278f1eda7e26b3be0df93261abf538c8139fde03bb448f67be9868c4699abf5b456c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/405e86f0fd4029f514e16ad87ecf6e27d4c4def60aa57bc043b807bede084a229325286b3d18a70b0f965b3f1648bdf82edef4e5056d2057fe603e3faa3333a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8994c9cc50d3d141a072b6a34b54c433d303be038b59420579202a4285f44c9dfc2829b4115a5bd1460670c48c981e2ded5713f97587c7d64fe3ebceab4f0f0d"} 07:58:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:58:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:58:15 INFO - Contents: 07:58:15 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50d4ecef412a2da813d218a8c3401facd91941aba5cd1ea1ae8329efffe46f065bc0dbb3be781656fb15f7bfa43f410a60cb5264dd27c7f2435ae703fb46321c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86434158604acf8b5cdee3d68518a236d98b31db6d57dd67837b716e812b278f1eda7e26b3be0df93261abf538c8139fde03bb448f67be9868c4699abf5b456c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/405e86f0fd4029f514e16ad87ecf6e27d4c4def60aa57bc043b807bede084a229325286b3d18a70b0f965b3f1648bdf82edef4e5056d2057fe603e3faa3333a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8994c9cc50d3d141a072b6a34b54c433d303be038b59420579202a4285f44c9dfc2829b4115a5bd1460670c48c981e2ded5713f97587c7d64fe3ebceab4f0f0d"} 07:58:15 INFO - Running post-run listener: copy_logs_to_upload_dir 07:58:15 INFO - Copying logs to upload dir... 07:58:15 INFO - mkdir: /builds/slave/test/build/upload/logs 07:58:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.924698 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-28 07:58:15.565562) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 07:58:15.573267) ========= 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=d2a8c569965ab8367867b893000001a1-1501252572.607632-732779493 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/50d4ecef412a2da813d218a8c3401facd91941aba5cd1ea1ae8329efffe46f065bc0dbb3be781656fb15f7bfa43f410a60cb5264dd27c7f2435ae703fb46321c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86434158604acf8b5cdee3d68518a236d98b31db6d57dd67837b716e812b278f1eda7e26b3be0df93261abf538c8139fde03bb448f67be9868c4699abf5b456c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/405e86f0fd4029f514e16ad87ecf6e27d4c4def60aa57bc043b807bede084a229325286b3d18a70b0f965b3f1648bdf82edef4e5056d2057fe603e3faa3333a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8994c9cc50d3d141a072b6a34b54c433d303be038b59420579202a4285f44c9dfc2829b4115a5bd1460670c48c981e2ded5713f97587c7d64fe3ebceab4f0f0d"} build_url:https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011395 build_url: 'https://queue.taskcluster.net/v1/task/bCmq_jAhSaqKzrkMD7BI5A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50d4ecef412a2da813d218a8c3401facd91941aba5cd1ea1ae8329efffe46f065bc0dbb3be781656fb15f7bfa43f410a60cb5264dd27c7f2435ae703fb46321c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86434158604acf8b5cdee3d68518a236d98b31db6d57dd67837b716e812b278f1eda7e26b3be0df93261abf538c8139fde03bb448f67be9868c4699abf5b456c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/405e86f0fd4029f514e16ad87ecf6e27d4c4def60aa57bc043b807bede084a229325286b3d18a70b0f965b3f1648bdf82edef4e5056d2057fe603e3faa3333a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8994c9cc50d3d141a072b6a34b54c433d303be038b59420579202a4285f44c9dfc2829b4115a5bd1460670c48c981e2ded5713f97587c7d64fe3ebceab4f0f0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-28 07:58:15.606639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 07:58:15.607018) ========= 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=d2a8c569965ab8367867b893000001a1-1501252572.607632-732779493 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-28 07:58:15.693007) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 07:58:15.693746) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-28 07:58:15.694465) ========= ========= Total master_lag: 0.19 =========