builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1501526970.7 results: success (0) revision: 87824406b9feb420a3150720707b424d7cee5915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 11:49:30.703671) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-31 11:49:30.704183) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 11:49:30.704503) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-31 11:49:30.773847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 11:49:30.776868) ========= 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=8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-31 11:49:31-- 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% 37.9M=0s 2017-07-31 11:49:31 (37.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.080526 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 11:49:30.891127) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 11:49:30.891427) ========= 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=8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017905 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 11:49:30.960917) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-31 11:49:30.961238) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 87824406b9feb420a3150720707b424d7cee5915 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 87824406b9feb420a3150720707b424d7cee5915 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-31 11:49:31,398 truncating revision to first 12 chars 2017-07-31 11:49:31,398 Setting DEBUG logging. 2017-07-31 11:49:31,398 attempt 1/10 2017-07-31 11:49:31,398 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/87824406b9fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-31 11:49:32,747 unpacking tar archive at: mozilla-central-87824406b9fe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.688724 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-31 11:49:32.663564) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 11:49:32.666899) ========= script_repo_revision: 87824406b9feb420a3150720707b424d7cee5915 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-31 11:49:32.667273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 11:49:32.667563) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-31 11:49:32.677323) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-31 11:49:32.677603) ========= /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=8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:49:33 INFO - MultiFileLogger online at 20170731 11:49:33 in /builds/slave/test 11:49:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 11:49:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:49:33 INFO - {'append_to_log': False, 11:49:33 INFO - 'base_work_dir': '/builds/slave/test', 11:49:33 INFO - 'blob_upload_branch': 'Firefox', 11:49:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:49:33 INFO - 'branch': 'Firefox', 11:49:33 INFO - 'buildbot_json_path': 'buildprops.json', 11:49:33 INFO - 'code_coverage': False, 11:49:33 INFO - 'config_files': ('talos/linux_config.py',), 11:49:33 INFO - 'default_actions': ('clobber', 11:49:33 INFO - 'read-buildbot-config', 11:49:33 INFO - 'download-and-extract', 11:49:33 INFO - 'populate-webroot', 11:49:33 INFO - 'create-virtualenv', 11:49:33 INFO - 'install', 11:49:33 INFO - 'setup-mitmproxy', 11:49:33 INFO - 'run-tests'), 11:49:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:49:33 INFO - 'disable_ccov_upload': False, 11:49:33 INFO - 'download_minidump_stackwalk': True, 11:49:33 INFO - 'download_symbols': 'ondemand', 11:49:33 INFO - 'enable_stylo': False, 11:49:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:49:33 INFO - 'tooltool.py': '/tools/tooltool.py', 11:49:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:49:33 INFO - '/tools/misc-python/virtualenv.py')}, 11:49:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:49:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:49:33 INFO - 'gecko_profile': False, 11:49:33 INFO - 'gecko_profile_interval': 0, 11:49:33 INFO - 'installer_path': 'installer.exe', 11:49:33 INFO - 'log_level': 'info', 11:49:33 INFO - 'log_name': 'talos', 11:49:33 INFO - 'log_to_console': True, 11:49:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:49:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:49:33 INFO - 'opt_config_files': (), 11:49:33 INFO - 'pip_index': False, 11:49:33 INFO - 'suite': 'dromaeojs-e10s', 11:49:33 INFO - 'system_bits': '32', 11:49:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:49:33 INFO - 'title': 'talos-linux64-ix-038', 11:49:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:49:33 INFO - 'use_talos_json': True, 11:49:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:49:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:49:33 INFO - 'work_dir': 'build'} 11:49:33 INFO - [mozharness: 2017-07-31 18:49:33.217871Z] Running clobber step. 11:49:33 INFO - Running pre-action listener: _resource_record_pre_action 11:49:33 INFO - Running main action method: clobber 11:49:33 INFO - rmtree: /builds/slave/test/build 11:49:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:49:34 INFO - Running post-action listener: _resource_record_post_action 11:49:34 INFO - [mozharness: 2017-07-31 18:49:34.253896Z] Finished clobber step (success) 11:49:34 INFO - [mozharness: 2017-07-31 18:49:34.254000Z] Running read-buildbot-config step. 11:49:34 INFO - Running pre-action listener: _resource_record_pre_action 11:49:34 INFO - Running main action method: read_buildbot_config 11:49:34 INFO - Using buildbot properties: 11:49:34 INFO - { 11:49:34 INFO - "project": "", 11:49:34 INFO - "product": "firefox", 11:49:34 INFO - "who": "rstrong@mozilla.com", 11:49:34 INFO - "installer_path": "public/build/target.tar.bz2", 11:49:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:49:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:49:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 11:49:34 INFO - "stage_platform": "linux64-pgo", 11:49:34 INFO - "basedir": "/builds/slave/test", 11:49:34 INFO - "buildnumber": 93, 11:49:34 INFO - "platform": "ubuntu64_hw", 11:49:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:49:34 INFO - "slavebuilddir": "test", 11:49:34 INFO - "taskId": "IL8TQ9l0QemguJkswCxXzw", 11:49:34 INFO - "branch": "mozilla-central", 11:49:34 INFO - "script_repo_revision": "production", 11:49:34 INFO - "revision": "87824406b9feb420a3150720707b424d7cee5915", 11:49:34 INFO - "slavename": "talos-linux64-ix-038", 11:49:34 INFO - "repo_path": "mozilla-central" 11:49:34 INFO - } 11:49:34 INFO - Finding installer, test and symbols from parent task. 11:49:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IL8TQ9l0QemguJkswCxXzw'}, attempt #1 11:49:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IL8TQ9l0QemguJkswCxXzw'}, attempt #1 11:49:35 INFO - Task dependencies: f2TFbEELQBuS5vxeIOzlIg 11:49:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg'}, attempt #1 11:49:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.tar.bz2 11:49:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.test_packages.json 11:49:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.crashreporter-symbols.zip 11:49:35 INFO - Running post-action listener: _resource_record_post_action 11:49:35 INFO - [mozharness: 2017-07-31 18:49:35.701159Z] Finished read-buildbot-config step (success) 11:49:35 INFO - [mozharness: 2017-07-31 18:49:35.701386Z] Running download-and-extract step. 11:49:35 INFO - Running pre-action listener: _resource_record_pre_action 11:49:35 INFO - Running main action method: download_and_extract 11:49:35 INFO - mkdir: /builds/slave/test/build/tests 11:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:49:35 INFO - trying https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.test_packages.json 11:49:35 INFO - Downloading https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:49:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:49:36 INFO - Downloaded 989 bytes. 11:49:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:49:36 INFO - Using the following test package requirements: 11:49:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:49:36 INFO - u'common': [u'target.common.tests.zip'], 11:49:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:49:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:49:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:49:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:49:36 INFO - u'mozbase': [u'target.common.tests.zip'], 11:49:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:49:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:49:36 INFO - u'web-platform': [u'target.common.tests.zip', 11:49:36 INFO - u'target.web-platform.tests.tar.gz'], 11:49:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:49:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:49:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.common.tests.zip 11:49:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:49:36 INFO - Fetch https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.common.tests.zip into memory 11:49:37 INFO - Content-Length response header: 73017613 11:49:37 INFO - Bytes received: 73017613 11:49:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:49:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.common.tests.zip 11:49:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:49:48 INFO - Fetch https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.common.tests.zip into memory 11:49:50 INFO - Content-Length response header: 73017613 11:49:50 INFO - Bytes received: 73017613 11:50:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.talos.tests.zip 11:50:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:50:02 INFO - Fetch https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.talos.tests.zip into memory 11:50:03 INFO - Content-Length response header: 14496686 11:50:03 INFO - Bytes received: 14496686 11:50:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:03 INFO - trying https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.tar.bz2 11:50:03 INFO - Downloading https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:50:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:50:07 INFO - Downloaded 63246329 bytes. 11:50:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.tar.bz2 11:50:07 INFO - mkdir: /builds/slave/test/properties 11:50:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:50:07 INFO - Writing to file /builds/slave/test/properties/build_url 11:50:07 INFO - Contents: 11:50:07 INFO - build_url:https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.tar.bz2 11:50:07 INFO - Running post-action listener: _resource_record_post_action 11:50:07 INFO - Running post-action listener: set_extra_try_arguments 11:50:07 INFO - [mozharness: 2017-07-31 18:50:07.549393Z] Finished download-and-extract step (success) 11:50:07 INFO - [mozharness: 2017-07-31 18:50:07.549506Z] Running populate-webroot step. 11:50:07 INFO - Running pre-action listener: _resource_record_pre_action 11:50:07 INFO - Running main action method: populate_webroot 11:50:07 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:50:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:50:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:50:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:50:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:50:07 INFO - 'tests': ['damp', 'tps']}, 11:50:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:50:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:50:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:50:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:50:07 INFO - 'other-e10s': {'tests': ['a11yr', 11:50:07 INFO - 'ts_paint', 11:50:07 INFO - 'tpaint', 11:50:07 INFO - 'sessionrestore', 11:50:07 INFO - 'sessionrestore_many_windows', 11:50:07 INFO - 'sessionrestore_no_auto_restore', 11:50:07 INFO - 'tabpaint']}, 11:50:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:50:07 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:50:07 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:50:07 INFO - 'talos_options': ['--mitmproxy', 11:50:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:50:07 INFO - '--firstNonBlankPaint'], 11:50:07 INFO - 'tests': ['quantum_pageload_google', 11:50:07 INFO - 'quantum_pageload_youtube', 11:50:07 INFO - 'quantum_pageload_amazon', 11:50:07 INFO - 'quantum_pageload_facebook']}, 11:50:07 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:50:07 INFO - 'talos_options': ['--stylo', 11:50:07 INFO - '--mitmproxy', 11:50:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:50:07 INFO - '--firstNonBlankPaint'], 11:50:07 INFO - 'tests': ['quantum_pageload_google', 11:50:07 INFO - 'quantum_pageload_youtube', 11:50:07 INFO - 'quantum_pageload_amazon', 11:50:07 INFO - 'quantum_pageload_facebook']}, 11:50:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:50:07 INFO - 'tsvgr_opacity', 11:50:07 INFO - 'tart', 11:50:07 INFO - 'tscrollx', 11:50:07 INFO - 'cart', 11:50:07 INFO - 'tsvg_static']}, 11:50:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:50:07 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:50:07 INFO - 'talos_options': ['--stylo', 11:50:07 INFO - '--stylo-threads=1', 11:50:07 INFO - '--mitmproxy', 11:50:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:50:07 INFO - '--firstNonBlankPaint'], 11:50:07 INFO - 'tests': ['tp6_google', 11:50:07 INFO - 'tp6_youtube', 11:50:07 INFO - 'tp6_amazon', 11:50:07 INFO - 'tp6_facebook']}, 11:50:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:50:07 INFO - 'talos_options': ['--xperf_path', 11:50:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:50:07 INFO - 'tests': ['tp5n']}}} 11:50:07 INFO - Running post-action listener: _resource_record_post_action 11:50:07 INFO - [mozharness: 2017-07-31 18:50:07.558249Z] Finished populate-webroot step (success) 11:50:07 INFO - [mozharness: 2017-07-31 18:50:07.558340Z] Running create-virtualenv step. 11:50:07 INFO - Running pre-action listener: _resource_record_pre_action 11:50:07 INFO - Running main action method: create_virtualenv 11:50:07 INFO - Creating virtualenv /builds/slave/test/build/venv 11:50:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:50:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:50:07 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:50:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:50:07 INFO - Using real prefix '/usr' 11:50:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:50:08 INFO - Installing distribute.............................................................................................................................................................................................done. 11:50:10 INFO - Installing pip.................done. 11:50:10 INFO - Return code: 0 11:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:50:10 INFO - Reading from file tmpfile_stdout 11:50:10 INFO - Output received: 11:50:10 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 11:50:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:10 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 0x21e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2550d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254deb0>, '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 0x254edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254f240>, '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': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:50:10 INFO - Using env: {'DISPLAY': ':0', 11:50:10 INFO - 'HOME': '/home/cltbld', 11:50:10 INFO - 'LANG': 'en_US.UTF-8', 11:50:10 INFO - 'LANGUAGE': 'en_US:en', 11:50:10 INFO - 'LOGNAME': 'cltbld', 11:50:10 INFO - 'MAIL': '/var/mail/cltbld', 11:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:10 INFO - 'MOZ_NO_REMOTE': '1', 11:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:10 INFO - 'NO_EM_RESTART': '1', 11:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:10 INFO - 'PWD': '/builds/slave/test', 11:50:10 INFO - 'SHELL': '/bin/bash', 11:50:10 INFO - 'SHLVL': '1', 11:50:10 INFO - 'TERM': 'linux', 11:50:10 INFO - 'TMOUT': '86400', 11:50:10 INFO - 'USER': 'cltbld', 11:50:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 11:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:10 INFO - '_': '/tools/buildbot/bin/python'} 11:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 11:50:10 INFO - Cleaning up... 11:50:10 INFO - Return code: 0 11:50:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:10 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 0x21e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2550d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254deb0>, '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 0x254edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254f240>, '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': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:50:10 INFO - Using env: {'DISPLAY': ':0', 11:50:10 INFO - 'HOME': '/home/cltbld', 11:50:10 INFO - 'LANG': 'en_US.UTF-8', 11:50:10 INFO - 'LANGUAGE': 'en_US:en', 11:50:10 INFO - 'LOGNAME': 'cltbld', 11:50:10 INFO - 'MAIL': '/var/mail/cltbld', 11:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:10 INFO - 'MOZ_NO_REMOTE': '1', 11:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:10 INFO - 'NO_EM_RESTART': '1', 11:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:10 INFO - 'PWD': '/builds/slave/test', 11:50:10 INFO - 'SHELL': '/bin/bash', 11:50:10 INFO - 'SHLVL': '1', 11:50:10 INFO - 'TERM': 'linux', 11:50:10 INFO - 'TMOUT': '86400', 11:50:10 INFO - 'USER': 'cltbld', 11:50:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 11:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:10 INFO - '_': '/tools/buildbot/bin/python'} 11:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:10 INFO - Downloading/unpacking psutil>=3.1.1 11:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:50:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:50:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:50:12 INFO - Installing collected packages: psutil 11:50:12 INFO - Running setup.py install for psutil 11:50:12 INFO - building 'psutil._psutil_linux' extension 11:50:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:50:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:50:12 INFO - building 'psutil._psutil_posix' extension 11:50:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:50:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:50:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:50:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:50:12 INFO - Successfully installed psutil 11:50:12 INFO - Cleaning up... 11:50:12 INFO - Return code: 0 11:50:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2550d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254deb0>, '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 0x254edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254f240>, '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': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:50:12 INFO - Using env: {'DISPLAY': ':0', 11:50:12 INFO - 'HOME': '/home/cltbld', 11:50:12 INFO - 'LANG': 'en_US.UTF-8', 11:50:12 INFO - 'LANGUAGE': 'en_US:en', 11:50:12 INFO - 'LOGNAME': 'cltbld', 11:50:12 INFO - 'MAIL': '/var/mail/cltbld', 11:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:12 INFO - 'MOZ_NO_REMOTE': '1', 11:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:12 INFO - 'NO_EM_RESTART': '1', 11:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:12 INFO - 'PWD': '/builds/slave/test', 11:50:12 INFO - 'SHELL': '/bin/bash', 11:50:12 INFO - 'SHLVL': '1', 11:50:12 INFO - 'TERM': 'linux', 11:50:12 INFO - 'TMOUT': '86400', 11:50:12 INFO - 'USER': 'cltbld', 11:50:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 11:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:12 INFO - '_': '/tools/buildbot/bin/python'} 11:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:50:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:50:13 INFO - Installing collected packages: mozsystemmonitor 11:50:13 INFO - Running setup.py install for mozsystemmonitor 11:50:14 INFO - Successfully installed mozsystemmonitor 11:50:14 INFO - Cleaning up... 11:50:14 INFO - Return code: 0 11:50:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:14 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 0x21e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2550d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254deb0>, '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 0x254edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254f240>, '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': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:50:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:50:14 INFO - Using env: {'DISPLAY': ':0', 11:50:14 INFO - 'HOME': '/home/cltbld', 11:50:14 INFO - 'LANG': 'en_US.UTF-8', 11:50:14 INFO - 'LANGUAGE': 'en_US:en', 11:50:14 INFO - 'LOGNAME': 'cltbld', 11:50:14 INFO - 'MAIL': '/var/mail/cltbld', 11:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:14 INFO - 'MOZ_NO_REMOTE': '1', 11:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:14 INFO - 'NO_EM_RESTART': '1', 11:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:14 INFO - 'PWD': '/builds/slave/test', 11:50:14 INFO - 'SHELL': '/bin/bash', 11:50:14 INFO - 'SHLVL': '1', 11:50:14 INFO - 'TERM': 'linux', 11:50:14 INFO - 'TMOUT': '86400', 11:50:14 INFO - 'USER': 'cltbld', 11:50:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 11:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:14 INFO - '_': '/tools/buildbot/bin/python'} 11:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:14 INFO - Downloading/unpacking jsonschema==2.5.1 11:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:50:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:15 INFO - Downloading functools32-3.2.3-2.tar.gz 11:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:50:15 INFO - warning: no files found matching '*.txt' 11:50:15 INFO - no previously-included directories found matching 'build' 11:50:15 INFO - no previously-included directories found matching 'dist' 11:50:15 INFO - no previously-included directories found matching '.git*' 11:50:15 INFO - Installing collected packages: jsonschema, functools32 11:50:15 INFO - Running setup.py install for functools32 11:50:15 INFO - warning: no files found matching '*.txt' 11:50:15 INFO - no previously-included directories found matching 'build' 11:50:15 INFO - no previously-included directories found matching 'dist' 11:50:15 INFO - no previously-included directories found matching '.git*' 11:50:15 INFO - Successfully installed jsonschema functools32 11:50:15 INFO - Cleaning up... 11:50:15 INFO - Return code: 0 11:50:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50: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', '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 0x21e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2550d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254deb0>, '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 0x254edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254f240>, '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': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:50: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 functools32==3.2.3-2 11:50:15 INFO - Using env: {'DISPLAY': ':0', 11:50:15 INFO - 'HOME': '/home/cltbld', 11:50:15 INFO - 'LANG': 'en_US.UTF-8', 11:50:15 INFO - 'LANGUAGE': 'en_US:en', 11:50:15 INFO - 'LOGNAME': 'cltbld', 11:50:15 INFO - 'MAIL': '/var/mail/cltbld', 11:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:15 INFO - 'MOZ_NO_REMOTE': '1', 11:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:15 INFO - 'NO_EM_RESTART': '1', 11:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:15 INFO - 'PWD': '/builds/slave/test', 11:50:15 INFO - 'SHELL': '/bin/bash', 11:50:15 INFO - 'SHLVL': '1', 11:50:15 INFO - 'TERM': 'linux', 11:50:15 INFO - 'TMOUT': '86400', 11:50:15 INFO - 'USER': 'cltbld', 11:50:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 11:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:15 INFO - '_': '/tools/buildbot/bin/python'} 11:50:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:50:15 INFO - Cleaning up... 11:50:15 INFO - Return code: 0 11:50:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50: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', '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 0x21e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2550d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254deb0>, '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 0x254edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254f240>, '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': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:50: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 blobuploader==1.2.4 11:50:15 INFO - Using env: {'DISPLAY': ':0', 11:50:15 INFO - 'HOME': '/home/cltbld', 11:50:15 INFO - 'LANG': 'en_US.UTF-8', 11:50:15 INFO - 'LANGUAGE': 'en_US:en', 11:50:15 INFO - 'LOGNAME': 'cltbld', 11:50:15 INFO - 'MAIL': '/var/mail/cltbld', 11:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:15 INFO - 'MOZ_NO_REMOTE': '1', 11:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:15 INFO - 'NO_EM_RESTART': '1', 11:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:15 INFO - 'PWD': '/builds/slave/test', 11:50:15 INFO - 'SHELL': '/bin/bash', 11:50:15 INFO - 'SHLVL': '1', 11:50:15 INFO - 'TERM': 'linux', 11:50:15 INFO - 'TMOUT': '86400', 11:50:15 INFO - 'USER': 'cltbld', 11:50:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 11:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:15 INFO - '_': '/tools/buildbot/bin/python'} 11:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:16 INFO - Downloading/unpacking blobuploader==1.2.4 11:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:17 INFO - Downloading blobuploader-1.2.4.tar.gz 11:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:50:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:50:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:17 INFO - Downloading docopt-0.6.1.tar.gz 11:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:50:17 INFO - Installing collected packages: blobuploader, requests, docopt 11:50:17 INFO - Running setup.py install for blobuploader 11:50:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:50:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:50:17 INFO - Running setup.py install for requests 11:50:18 INFO - Running setup.py install for docopt 11:50:18 INFO - Successfully installed blobuploader requests docopt 11:50:18 INFO - Cleaning up... 11:50:18 INFO - Return code: 0 11:50:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:18 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 0x21e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2550d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254deb0>, '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 0x254edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254f240>, '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': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:50:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:50:18 INFO - Using env: {'DISPLAY': ':0', 11:50:18 INFO - 'HOME': '/home/cltbld', 11:50:18 INFO - 'LANG': 'en_US.UTF-8', 11:50:18 INFO - 'LANGUAGE': 'en_US:en', 11:50:18 INFO - 'LOGNAME': 'cltbld', 11:50:18 INFO - 'MAIL': '/var/mail/cltbld', 11:50:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:18 INFO - 'MOZ_NO_REMOTE': '1', 11:50:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:18 INFO - 'NO_EM_RESTART': '1', 11:50:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:18 INFO - 'PWD': '/builds/slave/test', 11:50:18 INFO - 'SHELL': '/bin/bash', 11:50:18 INFO - 'SHLVL': '1', 11:50:18 INFO - 'TERM': 'linux', 11:50:18 INFO - 'TMOUT': '86400', 11:50:18 INFO - 'USER': 'cltbld', 11:50:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 11:50:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:18 INFO - '_': '/tools/buildbot/bin/python'} 11:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:50:18 INFO - Running setup.py (path:/tmp/pip-GpDwOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:50:18 INFO - Running setup.py (path:/tmp/pip-Wwf8FY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:50:18 INFO - Running setup.py (path:/tmp/pip-D35jj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:50:18 INFO - Running setup.py (path:/tmp/pip-38Lums-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:50:18 INFO - Running setup.py (path:/tmp/pip-ZSquGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:50:19 INFO - Running setup.py (path:/tmp/pip-6TnGe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:50:19 INFO - Running setup.py (path:/tmp/pip-9WaOfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:50:19 INFO - Running setup.py (path:/tmp/pip-7SSGTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:50:19 INFO - Running setup.py (path:/tmp/pip-RK_XOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:50:19 INFO - Running setup.py (path:/tmp/pip-Ar9_cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:50:19 INFO - Running setup.py (path:/tmp/pip-sseVSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:50:19 INFO - Running setup.py (path:/tmp/pip-eRk7wB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:50:19 INFO - Running setup.py (path:/tmp/pip-2PpmdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:50:19 INFO - Running setup.py (path:/tmp/pip-uK5VzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:19 INFO - Running setup.py (path:/tmp/pip-PRYAwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:50:19 INFO - Running setup.py (path:/tmp/pip-S6xqpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:50:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:50:19 INFO - Running setup.py (path:/tmp/pip-mJ2Hsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:50:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:50:19 INFO - Running setup.py install for manifestparser 11:50:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:50:19 INFO - Running setup.py install for mozcrash 11:50:20 INFO - Running setup.py install for mozdebug 11:50:20 INFO - Running setup.py install for mozdevice 11:50:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:50:20 INFO - Running setup.py install for mozfile 11:50:20 INFO - Running setup.py install for mozhttpd 11:50:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:50:20 INFO - Running setup.py install for mozinfo 11:50:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:50:20 INFO - Running setup.py install for mozInstall 11:50:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:50:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:50:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:50:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:50:20 INFO - Running setup.py install for mozleak 11:50:20 INFO - Running setup.py install for mozlog 11:50:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:50:20 INFO - Running setup.py install for moznetwork 11:50:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:50:20 INFO - Running setup.py install for mozprocess 11:50:21 INFO - Running setup.py install for mozprofile 11:50:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:50:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:50:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:50:21 INFO - Running setup.py install for mozrunner 11:50:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:50:21 INFO - Running setup.py install for mozscreenshot 11:50:21 INFO - Running setup.py install for moztest 11:50:21 INFO - Running setup.py install for mozversion 11:50:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:50:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:50:21 INFO - Cleaning up... 11:50:21 INFO - Return code: 0 11:50:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:21 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 0x21e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2550d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254deb0>, '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 0x254edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254f240>, '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': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:50:21 INFO - Using env: {'DISPLAY': ':0', 11:50:21 INFO - 'HOME': '/home/cltbld', 11:50:21 INFO - 'LANG': 'en_US.UTF-8', 11:50:21 INFO - 'LANGUAGE': 'en_US:en', 11:50:21 INFO - 'LOGNAME': 'cltbld', 11:50:21 INFO - 'MAIL': '/var/mail/cltbld', 11:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:21 INFO - 'MOZ_NO_REMOTE': '1', 11:50:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:21 INFO - 'NO_EM_RESTART': '1', 11:50:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:21 INFO - 'PWD': '/builds/slave/test', 11:50:21 INFO - 'SHELL': '/bin/bash', 11:50:21 INFO - 'SHLVL': '1', 11:50:21 INFO - 'TERM': 'linux', 11:50:21 INFO - 'TMOUT': '86400', 11:50:21 INFO - 'USER': 'cltbld', 11:50:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 11:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:21 INFO - '_': '/tools/buildbot/bin/python'} 11:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:50:21 INFO - Running setup.py (path:/tmp/pip-yQQPvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:50:21 INFO - Running setup.py (path:/tmp/pip-5UQXqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:50:22 INFO - Running setup.py (path:/tmp/pip-6JT_iP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:50:22 INFO - Running setup.py (path:/tmp/pip-hw6itV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:50:22 INFO - Running setup.py (path:/tmp/pip-jDqJCW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:50:22 INFO - Running setup.py (path:/tmp/pip-7nUJHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:50:22 INFO - Running setup.py (path:/tmp/pip-AhulIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:50:22 INFO - Running setup.py (path:/tmp/pip-9_aDjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:50:22 INFO - Running setup.py (path:/tmp/pip-ckPYkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:50:22 INFO - Running setup.py (path:/tmp/pip-3bz0gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:50:22 INFO - Running setup.py (path:/tmp/pip-YAP2PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:50:22 INFO - Running setup.py (path:/tmp/pip-OqexjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:50:22 INFO - Running setup.py (path:/tmp/pip-PBW_kT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:50:22 INFO - Running setup.py (path:/tmp/pip-XwP7_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:22 INFO - Running setup.py (path:/tmp/pip-BOeisq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:50:22 INFO - Running setup.py (path:/tmp/pip-zi8cs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:50:23 INFO - Running setup.py (path:/tmp/pip-t8l9R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:50:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:24 INFO - Downloading blessings-1.6.tar.gz 11:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:50:24 INFO - Installing collected packages: blessings 11:50:24 INFO - Running setup.py install for blessings 11:50:24 INFO - Successfully installed blessings 11:50:24 INFO - Cleaning up... 11:50:24 INFO - Return code: 0 11:50:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:50:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:24 INFO - Reading from file tmpfile_stdout 11:50:24 INFO - Current package versions: 11:50:24 INFO - argparse == 1.2.1 11:50:24 INFO - blessings == 1.6 11:50:24 INFO - blobuploader == 1.2.4 11:50:24 INFO - docopt == 0.6.1 11:50:24 INFO - functools32 == 3.2.3-2 11:50:24 INFO - jsonschema == 2.5.1 11:50:24 INFO - manifestparser == 1.1 11:50:24 INFO - mozInstall == 1.13 11:50:24 INFO - mozcrash == 1.0 11:50:24 INFO - mozdebug == 0.1 11:50:24 INFO - mozdevice == 0.51 11:50:24 INFO - mozfile == 1.2 11:50:24 INFO - mozhttpd == 0.7 11:50:24 INFO - mozinfo == 0.10 11:50:24 INFO - mozleak == 0.1 11:50:24 INFO - mozlog == 3.5 11:50:24 INFO - moznetwork == 0.27 11:50:24 INFO - mozprocess == 0.25 11:50:24 INFO - mozprofile == 0.28 11:50:24 INFO - mozrunner == 6.13 11:50:24 INFO - mozscreenshot == 0.1 11:50:24 INFO - mozsystemmonitor == 0.3 11:50:24 INFO - moztest == 0.8 11:50:24 INFO - mozversion == 1.4 11:50:24 INFO - psutil == 3.1.1 11:50:24 INFO - requests == 1.2.3 11:50:24 INFO - wsgiref == 0.1.2 11:50:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:24 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 0x21e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2550d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254deb0>, '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 0x254edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254f240>, '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': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:50:24 INFO - Using env: {'DISPLAY': ':0', 11:50:24 INFO - 'HOME': '/home/cltbld', 11:50:24 INFO - 'LANG': 'en_US.UTF-8', 11:50:24 INFO - 'LANGUAGE': 'en_US:en', 11:50:24 INFO - 'LOGNAME': 'cltbld', 11:50:24 INFO - 'MAIL': '/var/mail/cltbld', 11:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:24 INFO - 'MOZ_NO_REMOTE': '1', 11:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:24 INFO - 'NO_EM_RESTART': '1', 11:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:24 INFO - 'PWD': '/builds/slave/test', 11:50:24 INFO - 'SHELL': '/bin/bash', 11:50:24 INFO - 'SHLVL': '1', 11:50:24 INFO - 'TERM': 'linux', 11:50:24 INFO - 'TMOUT': '86400', 11:50:24 INFO - 'USER': 'cltbld', 11:50:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 11:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:24 INFO - '_': '/tools/buildbot/bin/python'} 11:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:50:25 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:26 INFO - Downloading marionette_driver-1.4.0.tar.gz 11:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 11:50:26 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 11:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:50:26 INFO - Installing collected packages: marionette-driver, simplejson 11:50:26 INFO - Running setup.py install for marionette-driver 11:50:26 INFO - Running setup.py install for simplejson 11:50:26 INFO - building 'simplejson._speedups' extension 11:50:26 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:50:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:50:27 INFO - Successfully installed marionette-driver simplejson 11:50:27 INFO - Cleaning up... 11:50:27 INFO - Return code: 0 11:50:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:50:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:50:27 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 0x21e11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2550d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254deb0>, '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 0x254edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254f240>, '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': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:50:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:50:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:50:27 INFO - Using env: {'DISPLAY': ':0', 11:50:27 INFO - 'HOME': '/home/cltbld', 11:50:27 INFO - 'LANG': 'en_US.UTF-8', 11:50:27 INFO - 'LANGUAGE': 'en_US:en', 11:50:27 INFO - 'LOGNAME': 'cltbld', 11:50:27 INFO - 'MAIL': '/var/mail/cltbld', 11:50:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:27 INFO - 'MOZ_NO_REMOTE': '1', 11:50:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:27 INFO - 'NO_EM_RESTART': '1', 11:50:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:27 INFO - 'PWD': '/builds/slave/test', 11:50:27 INFO - 'SHELL': '/bin/bash', 11:50:27 INFO - 'SHLVL': '1', 11:50:27 INFO - 'TERM': 'linux', 11:50:27 INFO - 'TMOUT': '86400', 11:50:27 INFO - 'USER': 'cltbld', 11:50:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 11:50:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:27 INFO - '_': '/tools/buildbot/bin/python'} 11:50:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:50:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:50:27 INFO - Cleaning up... 11:50:27 INFO - Return code: 0 11:50:27 INFO - Running post-action listener: _resource_record_post_action 11:50:27 INFO - Running post-action listener: _start_resource_monitoring 11:50:27 INFO - Starting resource monitoring. 11:50:27 INFO - [mozharness: 2017-07-31 18:50:27.845330Z] Finished create-virtualenv step (success) 11:50:27 INFO - [mozharness: 2017-07-31 18:50:27.845793Z] Running install step. 11:50:27 INFO - Running pre-action listener: _resource_record_pre_action 11:50:27 INFO - Running main action method: install 11:50:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:50:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:50:28 INFO - Reading from file tmpfile_stdout 11:50:28 INFO - Detecting whether we're running mozinstall >=1.0... 11:50:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:50:28 INFO - Reading from file tmpfile_stdout 11:50:28 INFO - Output received: 11:50:28 INFO - Usage: mozinstall [options] installer 11:50:28 INFO - Options: 11:50:28 INFO - -h, --help show this help message and exit 11:50:28 INFO - -d DEST, --destination=DEST 11:50:28 INFO - Directory to install application into. [default: 11:50:28 INFO - "/builds/slave/test"] 11:50:28 INFO - --app=APP Application being installed. [default: firefox] 11:50:28 INFO - mkdir: /builds/slave/test/build/application 11:50:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:50:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:50:46 INFO - Reading from file tmpfile_stdout 11:50:46 INFO - Output received: 11:50:46 INFO - /builds/slave/test/build/application/firefox/firefox 11:50:46 INFO - Running post-action listener: _resource_record_post_action 11:50:46 INFO - [mozharness: 2017-07-31 18:50:46.061869Z] Finished install step (success) 11:50:46 INFO - [mozharness: 2017-07-31 18:50:46.062125Z] Running setup-mitmproxy step. 11:50:46 INFO - Running pre-action listener: _resource_record_pre_action 11:50:46 INFO - Running main action method: setup_mitmproxy 11:50:46 INFO - Skipping: mitmproxy is not required 11:50:46 INFO - Running post-action listener: _resource_record_post_action 11:50:46 INFO - [mozharness: 2017-07-31 18:50:46.063258Z] Finished setup-mitmproxy step (success) 11:50:46 INFO - [mozharness: 2017-07-31 18:50:46.063480Z] Running run-tests step. 11:50:46 INFO - Running pre-action listener: _resource_record_pre_action 11:50:46 INFO - Running pre-action listener: _set_gcov_prefix 11:50:46 INFO - Running main action method: run_tests 11:50:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:50:46 INFO - Python 2.7.3 11:50:46 INFO - Return code: 0 11:50:46 INFO - grabbing minidump binary from tooltool 11:50:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:50:46 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 0x254deb0>, '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 0x254edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x254f240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:50:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:50:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:50:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:50:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:50:46 INFO - Return code: 0 11:50:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:50:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:50:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:50:46 INFO - ENV: RUST_BACKTRACE is now 1 11:50:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:50:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:50:46 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/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:50:46 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/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:50:46 INFO - Using env: {'DISPLAY': ':0', 11:50:46 INFO - 'HOME': '/home/cltbld', 11:50:46 INFO - 'LANG': 'en_US.UTF-8', 11:50:46 INFO - 'LANGUAGE': 'en_US:en', 11:50:46 INFO - 'LOGNAME': 'cltbld', 11:50:46 INFO - 'MAIL': '/var/mail/cltbld', 11:50:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:46 INFO - 'MOZ_NO_REMOTE': '1', 11:50:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:46 INFO - 'NO_EM_RESTART': '1', 11:50:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:46 INFO - 'PWD': '/builds/slave/test', 11:50:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:46 INFO - 'RUST_BACKTRACE': '1', 11:50:46 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:50:46 INFO - 'SHELL': '/bin/bash', 11:50:46 INFO - 'SHLVL': '1', 11:50:46 INFO - 'TERM': 'linux', 11:50:46 INFO - 'TMOUT': '86400', 11:50:46 INFO - 'USER': 'cltbld', 11:50:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514', 11:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:46 INFO - '_': '/tools/buildbot/bin/python'} 11:50:46 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/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:50:46 INFO - mozversion application_buildid: 20170731173448 11:50:46 INFO - mozversion application_changeset: 87824406b9feb420a3150720707b424d7cee5915 11:50:46 INFO - mozversion application_display_name: Nightly 11:50:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:50:46 INFO - mozversion application_name: Firefox 11:50:46 INFO - mozversion application_remotingname: firefox 11:50:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:50:46 INFO - mozversion application_vendor: Mozilla 11:50:46 INFO - mozversion application_version: 56.0a1 11:50:46 INFO - mozversion platform_buildid: 20170731173448 11:50:46 INFO - mozversion platform_changeset: 87824406b9feb420a3150720707b424d7cee5915 11:50:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:50:46 INFO - mozversion platform_version: 56.0a1 11:50:46 INFO - using testdate: 1501527046 11:50:46 INFO - actual date: 1501527046 11:50:46 INFO - starting webserver on 'localhost:47843' 11:50:46 INFO - SUITE-START | Running 2 tests 11:50:46 INFO - TEST-START | dromaeo_css 11:50:46 INFO - Initialising browser for dromaeo_css test... 11:50:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47843/getInfo.html -profile /tmp/tmpp9JD4j/profile 11:50:46 INFO - TEST-INFO | started process 22922 (/builds/slave/test/build/application/firefox/firefox http://localhost:47843/getInfo.html) 11:50:53 INFO - TEST-INFO | 22922: exit 0 11:50:53 INFO - Browser initialized. 11:50:53 INFO - Running cycle 1/1 for dromaeo_css test... 11:50:53 INFO - TEST-INFO | started process 23132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp9JD4j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:54 INFO - PID 23132 | 11:50:54 INFO - PID 23132 | (/builds/slave/test/build/application/firefox/firefox:23181): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:50:54 INFO - PID 23132 | 11:51:04 INFO - PID 23132 | RSS: Main: 164450304 11:51:04 INFO - PID 23132 | 11:54:02 INFO - PID 23132 | Cycle 1(1): loaded http://localhost:47843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47843/tests/dromaeo/cssquery-ext.html) 11:54:03 INFO - PID 23132 | RSS: Main: 167219200 11:54:03 INFO - PID 23132 | 11:57:05 INFO - PID 23132 | Cycle 1(1): loaded http://localhost:47843/tests/dromaeo/cssquery-ext.html (next: http://localhost:47843/tests/dromaeo/cssquery-jquery.html) 11:57:06 INFO - PID 23132 | RSS: Main: 164909056 11:57:06 INFO - PID 23132 | 12:00:07 INFO - PID 23132 | Cycle 1(1): loaded http://localhost:47843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47843/tests/dromaeo/cssquery-mootools.html) 12:00:08 INFO - PID 23132 | RSS: Main: 166109184 12:00:08 INFO - PID 23132 | 12:03:09 INFO - PID 23132 | Cycle 1(1): loaded http://localhost:47843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47843/tests/dromaeo/cssquery-prototype.html) 12:03:10 INFO - PID 23132 | RSS: Main: 164683776 12:03:10 INFO - PID 23132 | 12:06:14 INFO - PID 23132 | Cycle 1(1): loaded http://localhost:47843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47843/tests/dromaeo/cssquery-yui.html) 12:06:14 INFO - PID 23132 | RSS: Main: 165879808 12:06:14 INFO - PID 23132 | 12:09:16 INFO - PID 23132 | Cycle 1(1): loaded http://localhost:47843/tests/dromaeo/cssquery-yui.html (next: http://localhost:47843/tests/dromaeo/cssquery-dojo.html) 12:09:16 INFO - PID 23132 | RSS: Main: 169209856 12:09:16 INFO - PID 23132 | 12:09:16 INFO - PID 23132 | __start_tp_report 12:09:16 INFO - PID 23132 | _x_x_mozilla_page_load 12:09:16 INFO - PID 23132 | _x_x_mozilla_page_load_details 12:09:16 INFO - PID 23132 | |i|pagename|runs| 12:09:16 INFO - PID 23132 | |0;dojo.html;3344.6655334466554;3379.239671074007;3385.9153521161975;3394.779339342943;3409.4374428219344;5896.056630939051;5922.763089476416;5931.466168044875;5937.524998000155;5945.435183657556;5967.1049342598635;5977.222961015062;5985.970070149643;5988.580799344048;6014.398560143984;5176.249443830652;5210.739463026853;5268.973655131738;5272.393674727398;5295.0733621616255;5139.408967968676;5172.922406163911;5228;5244.632875698702;5249.1601343785005;5223.033738758323;5271.2356708277275;5280.841574752763;5286.524212820846;5299.894002119955;5192.584593232532;5196.922046169273;5273.789048438058;5280.709560974145;5280.894382112375;5067.771950262247;5123.692578445268;5140.383154021504;5185.585153187736;5211.661242019294;5824.155497452845;5901.262342207224;5909.497692696126;5921.526277897758;5958.612690175125;6342.175517182736;6346.87306253877;6419.101325814389;6426.132472116298;6440.613563186177;6431.807045788634;6457.12828768115;6529.771457998995;6530.477561795045;6531.575447595891;5941.049432090845;6013.428724271187;6048.243969503812;6060.515158787286;6066.605670631439;6572.34276572339;6669.866602667919;6674.299198584175;6675.499337549703;6679.599224046573;6252.3122456529745;6285.748570057238;6295.811125666238;6309.621422714652;6390.4248617624635;6402.8719425611225;6402.903956440658;6410.038494225903;6427.485801135991;6429.03564465334;6379.681015949184;6403.295637479873;6437.517186211053;6464.191976003;6494.545381823322;6477.481801455872;6492.026196070533;6493.51298652603;6496.415322620986;6505.024246362988;4731.29030645406;4734.171519983989;4734.976325118421;4804.015176888729;4807.375041244686;4162;4213.389058586487;4259.297215959332;4272.359146128106;4275.914481710349;6245.6252624842655;6255.906161407583;6294.590851594632;6312.589681670676;6313.779017734358;6503.382178693017;6513.934860651428;6514.05546195799;6521.771737989147;6523.608583485006;6240.219972503437;6245.375462453809;6246.094316324198;6257;6315.147455093504;5374.946250537445;5443.727813609304;5445.37378201504;5452.972735136378;5456.290682211287;6936;6949.548279361826;7009.878419452863;7020;7028.964855175692;6374.4900407966325;6400.1679781629955;6400.871982560229;6408.455281301049;6449.129367535323;6860.416864566568;6873.140857392826;6886.311368863074;6894.310568943066;6898.965505172442;6298.244210694746;6313.05304204373;6327.651979141191;6339.334369891095;6404.583702059351;6474.0612611172055;6482.546221764431;6548.508861835477;6570.145881035435;6574.3754343337305;6195;6232.065190221503;6259.655718935503;6346.270178929298;6352.682365881595;6262.68686565679;6276.246850377984;6278.529110316653;6279.96860015697;6284.4344009039405;6208.689565521616;6263.937360626518;6337;6341.8731625368155;6346.619202847844;6253.593516421418;6315.873682526416;6331.461825744863;6336.524760643062;6392.169018027626;6128.295246046761;6131.816045518642;6196.380361963767;6211.9689401554515;6214.782482613087 12:09:16 INFO - PID 23132 | |1;ext.html;859.7786848500576;897.7890195803989;917.4862077236747;943.4197968249529;945.8912225094113;39970;40425.595744042585;40672.79663601678;40722.79638601803;40808.795956020214;37877.43183852245;37902.43146352807;38179.618203817954;38248.80875595618;38399.616003839954;6680.66596670167;6799.252082270947;6804.523683342168;6806.251312355637;6806.591604503721;6670.833229169261;6735.5285130040675;6749.325067493236;6751.223609284946;6757.1891373035305;7296.2338954409815;7469.514481558681;7474.962625186867;7478;7479.5512269263745;7323.450741194405;7415.5179913306;7426.814329641748;7448.627568621548;7449.813754656123;7163.140423149255;7349.632518374114;7398.334149926479;7404.814879627998;7418.666160022758;38366;38438.80780596107;38534.03664908372;38582.22835543301;38603.61396386028;3431.022158684763;3457.9654203457894;3459.2562599041325;3483.756137070406;3491.30173965208;30722.846385768153;30789;30830.229244269074;30940.226494337596;30953.690463095532;4891.413030436335;4906.901861962777;4951.133551628451;4956.925646115275;5001.724905130216;189566;194187;194288;194840;200485;50193;50204.24693629598;50287.74856125769;50318.24522632163;50360.748196258784;51779;51978.74010629923;52138.478615214124;52203.21695174575;52228.47771522312;15156.924215378853;15254.923725381524;15256.923715381574;15274.694506109816;15335.079895206323;12415.317157556421;12487.500499979898;12490.75018499643;12491.87508124907;12498.375081245902;14389.28053597316;14569.490067847786;14588.124712517283;14650.19423931694;14699.632509187355;5847.795327163529;5861.589688721834;5885.205497257901;5910.320313164041;6005.39946005396;1072.3190773858655;1081.799867024603;1089.5750657243523;1092.5902786455079;1098.8406681031206;28211.15366539007;29405.558916616268;29941.40117197644;30229.244268893453;30356.696433035828;1142.440204299887;1166.632510759108;1177.4289469607234;1184.680136363177;1190.1906703441744;13002.219866808022;16995.49013529596;17213.311467541407;17337.873038252474;17462.126893655266;258302;258390;259149;259214;259765;58103;58399.70800145972;58490;58698;58765;1494.9925250373678;1495.4616338118485;1512.3723654683183;1527.6562773376124;1531.2190782700902;28422.85788571044;29169.270768230963;29230;30141.246468838453;31334.68665313409;53181;53705.46294537161;53775.73112134414;53832.46167538274;53881;214118;223852;228279;228521;228623;36260.46176767601;39221.60778392294;39845;39906.201875961735;39963;47336.526634733214;48595.5140448591;49274;49390.25914611355;49425.75287123541;33371.66628333783;33426.83286583552;33998.32003359968;34371.14072148217;34573.82713086519;32862.507062393604;33789.66210337963;34076.488852667724;34737.82631086828;35352;40932.386014209216;42032.1593568133;42054;42382.78808605937;42615.57384426116;33996.3200735979;34346;35807.104822379646;36240.818795906904;36312.636873631986;26155;27223.86388068047;27573.764592995074;27621.723782762718;28069.43861122807 12:09:16 INFO - PID 23132 | |2;jquery.html;564.2946317103621;568.5593664909694;580.0718849840254;580.4630716587159;585.2947198625657;22623.095076196954;23399.298021059374;23436.17973370928;23441.882790586067;23489.882550587245;26058;28248.576271355894;28284.434311313762;28288.292792680193;28315.575266370968;6132.264128304599;6251.4061164189325;6255.093011513328;6262.154609127778;6271.122042913996;5970.223870896799;6218.782342618009;6227.1282020517165;6235.719392627343;6284.968575157118;6167.4757645600175;6168.75324987;6172;6173.351798061206;6185.35053819347;6176.876462470748;6191.4118158774845;6199.907001394983;6209.751609935643;6215.56491045627;5738.42615738427;5753.971230143822;5756.453136951983;5795.710214489259;5802.7098645068;30559.694403056128;30867.536986945215;30878.22804429885;31243.218919526968;31875.52186717201;2250.1336985260627;2280.0879648140713;2280.9657855132186;2281.4182383492102;2283.4405570635136;19431.80568194314;19914.80085199144;19942;19968.400947971582;19982.900085499627;2307.4462129089065;2389.104085967762;2429.2226487524;2444.523317952982;2449.1060762821444;134094;136859.31570342183;137070;137419;137701;14360.712785744226;15294.388224470897;15348.386064557293;15692.450764223197;16003;23612;23645.054197831894;23657.881710591682;23667;23718.762812371657;10047.24645651579;10151.238657100746;10277.229207809443;10279.074883260542;10282.126019288444;7578.810529736801;9140.405873618194;9239.584218710039;9353.345265831327;9373;8545.393654935304;9455.29085318604;9590.184834289164;9716;9975.508571999742;2837.730415610514;2838.5458326667635;2840.5881147233536;2848.302165969351;2853.657561092682;1018.4856647393019;1032.4631191780231;1039.4958445154093;1058.1799105693149;1069.8930106989394;20466.692999605017;21600.459988500097;21761.12955481763;25866.224013279632;27778.444431111264;1093.8577984861918;1104.4753741972659;1133.3426612564692;1136.9431528423545;1137.1300954769608;11924.76150477003;14220.502282420066;14835.703285934222;15521.922390388201;15661.843381566267;556217;580694;590576;597813;600617;130210.34894825466;135187;135841;136137;139436;1290.3290289049642;1296.824928634641;1313.40240190713;1331.3542931678128;1340.5710172744823;21831.235906743186;22785.316440506813;23078.769212307663;23431.531369372857;23650.172243971378;62766.37233627605;64528;64573;64767.67616161889;65077.349226507125;78562.21437785549;81641;82357.58821206096;82456.58771706103;83583.16416835997;12932.094753367173;13289.601311960656;14317.57047288583;14920.62698432548;15324.540263792103;24210;24597.508049838547;24715;24818.379540511633;24848;19829.107690154266;19835.107420166416;19848.50378740543;20121.094550744958;20145.899270503553;16495.17524123813;16726;17229.39697110595;17260.13699315004;17371.392001279895;18579.349722759638;19691.507712306735;19803.504912377306;19823.00884955775;19865.900670496554;15105.018173818667;15149.772753408488;15161.772573411628;15300.15849128264;15347.309371078105;19890.90054549718;20523.17907283692;20602.484937876674;20811.8959405202;20813.1674733009 12:09:16 INFO - PID 23132 | |3;mootools.html;1418.2979425184533;1455.4105587237166;1469.0137688917664;1472.2932992163767;1489.4340150742719;15061.62345941352;15634.452794152206;15660.608484787872;15670.843291567095;15679.45121920733;15635.530934071967;15891.761623575627;15892.84107158928;15901.12543810093;15901.363945442168;2721.482918245527;2786.233785708926;2786.342126434768;2786.763125134366;2788.84661343626;2585.9482810343875;2654.3894904172053;2670.7329267073233;2686.7984901132495;2690.811643184978;2590.0287392227915;2592.909248176314;2595.519828831663;2617.0447786557866;2620.567606344951;2572.884220210095;2593.6887573491113;2598;2598.376389666476;2599.1422830465995;2566.358410397401;2631.5526360518757;2649.417128231786;2676.384431580728;2688.5698288273784;14927.776083358758;15041.247937603077;15207.543773686808;15210.16344101074;15216;8182.386321025887;8468.195521425516;8471.788205294855;8472.830543389098;8480.78798030048;4977.900441991176;5159.561437277798;5192.1432963560965;5284.920726189111;5290.497402746733;1838.2646941223618;1845.6585531676549;1852.2035524724363;1865.8787178833468;1891.5933074388936;25645.230643080737;26172.214833555023;26179.345516362053;26183.214503564923;26190.86904565484;6789.981502774624;6938.722451101899;6971.163460384786;7072.717091316393;7103.218645948941;17544.912275438543;17575.824241757673;17593.384231551834;17597.912010439864;17614.559636009202;7851.646675899598;7964.2433968772875;7992.880106798402;8010.359171266285;8011.7997050073045;7296.635168241567;7400.185979542246;7419.332260096618;7440.813979650552;7446.59043752588;5263.894722105537;5421.728913554307;5424;5474.753636086306;5508.586855985817;1497.1541079290166;1527.9923600381926;1579.5024567261275;1590.427446119396;1600.0719582642039;890.123228619809;890.5725251879135;901.6258252825136;919.3380765848578;938.779386844091;7851.254130857559;8137.715179968791;8194.75415737517;8247.505149691038;8313.584320783937;974.8196583632051;996.531630133836;1006.2000709436016;1009.914157296638;1027.8817935937313;4606.608438282717;4816.446108697474;4966.577840883493;4989.101961646866;4993.076280888047;20816.895915520327;21611.243606473698;21867.453313666967;21965.890170549046;22068.22761203382;21416.143354265656;21878.781212187674;22098;22116.66824997594;22238.332850014525;11953.70115747096;12109.69725756863;12141.089418293663;12149.08881833866;12222.572209972608;7538.886916696144;7880.408969327438;8001.039875215011;8072.515649061075;8121.593920303843;18952.71570926465;19007.23971041198;19161.61676766429;19597.804021960168;19800.504987375432;19031.809681903003;19271.13279902436;19558.511037224183;20208.19167233294;20233.19067237294;12654.936725316315;12884.098113132366;12884.291363975071;12885.677858053623;12887.420066097236;14466.493672721404;14497.492587759378;14556.63608409756;14564.781528276872;14570.344334505186;10138.847917281395;10300.587976480856;10325.483725813829;10426.478676066317;10706.143508519144;10877.564897404016;10928.836067458835;10983.61557345489;11060.723481913017;11307.886921130683;9620.75948101303;9640.807183856425;9644.083812037845;9702.175315098295;9753.414795112316;7099.574025558483;7427.442941779496;7485.588292643957;7518.173000969999;7529.472936894584;7032.718691252293;7387.8153046174275;7440.181580026085;7457.552546847207;7528.774136775686 12:09:16 INFO - PID 23132 | |4;prototype.html;510.6706174517436;511.77993462810986;515.9174532074869;529.3330403691348;535.5447869311087;5959.821205363835;5991.370906054862;6000.789972350969;6008.309044459877;6113.1747214126135;5771.307443106823;5891.793787217448;5929.19955805966;5929.911051334234;5987.40125987401;4649.325847752082;4654.418197725285;4660.37084993525;4665.76671166442;4729.810807567693;4684.32077348786;4695.178343789823;4733.337332773397;4739.90520189596;4741.525847415248;4598.448186217659;4656.324832899228;4700.29495575663;4700.976495117519;4705.294205869112;4637.513061128583;4669.743164125972;4687;4693.694909830884;4716.52834716529;4190.55999120091;4225.450691410128;4257.659387249044;4261.21167583998;4274.487061552602;5851.385604511507;5894.115882617599;5924.170616113747;5959.553033522503;5960.463558279732;5540.584456165804;5586.826766379066;5591.496765291144;5625.999999999959;5656.85857853557;6377.23473183221;6392.169018027626;6414.005829096497;6429.260635026985;6451.451626611743;4755.262934245197;4782.473927867966;4786.234202527614;4805.231163013936;4821.493743156953;6714.630695311707;6717.6977036033495;6731.461483081342;6764.695588698521;6764.966175169142;4883.706977581356;4923;4938.333325001079;4955.4796746341835;4970.229614409773;5007.799688012512;5032.496750324938;5050.116229659795;5050.444451110448;5051.368578927634;5450.100733379028;5541.199110289092;5616.1856530803625;5628.831135065954;5633.267675202197;6187.257529096537;6305.148804911279;6430.356964303533;6446.258680251737;6457.806265812033;1658.8838781285194;1684.797824261072;1691.4502786594405;1707.709689352813;1754.9561260968323;1193.3198077096145;1217.391304347826;1222.3155033181447;1228.680543058811;1230.680023193958;6171.228596425447;6178.69106544671;6192;6203.332566996235;6255.40573645503;6441.903371449432;6499.967500162469;6569.408753212234;6578.243501997236;6632.237292711304;6221.813345599639;6284.402981716729;6293.716782744787;6303.432691057827;6326.304106548276;3394.762366634312;3459;3464.9826750866587;3483.4426491761196;3508.2281897982402;7024.789256322319;7058.400035996895;7063.223045464994;7141.357277845019;7145.714171433188;6772.390484856386;6781.525293229525;6783.152105986752;6797;6808.114945057111;7139.32176443237;7159.319864612853;7160.677769500385;7180.246074162243;7180.856382872418;6605.57063790852;6605.966970165118;6620.536562440776;6631.436327912182;6635.568688035455;6564.409203171737;6567.671616419256;6573.375529324707;6578;6589.27517973013;7042.22535521082;7133;7164.498485105993;7175.138983322035;7187.173475050227;4958.157113290677;4984.526469985346;4989.226669866177;4991.425986011655;4992.550670439533;6619.933800662125;6646.867062658816;6651.301613330531;6652.833679157866;6668.133142691613;6340.968295158495;6364.586301890362;6371.458426033653;6371.776987805404;6409.775657851953;6342.778002769881;6347.587406818542;6363.172787537591;6370.649614271259;6379.330170332234;6146.631202127886;6251.6561589113035;6288.937110628835;6390.233172019387;6412.198475190601;6237.12680224778;6367.61794292344;6387.968060159669;6438.130852334875;6456.063870738622;6155.2613686356135;6289.119523266655;6295.937040629535;6302.707944871198;6312.210973628296 12:09:16 INFO - PID 23132 | |5;yui.html;944.636315018718;945.0313428735546;977.0766625538864;981.0140808487469;985.99507002465;18677.533061673465;19073.332433364834;19322.90338548309;19345.129469173884;19398;17617.55956101098;18602.441926742187;21108.894455527738;21120.683189752126;21159;1037.4397825174415;1063.7021633942509;1064.8509208710786;1068.930519516229;1071.614218881202;1089.515165751241;1089.6186334782801;1089.7384627689337;1095.5782023920808;1099.4997276239292;1071.517816982357;1107.0479387726548;1113.4711012269188;1114.2423152256463;1117.3184357541934;1094.9069329107035;1098.9175811814107;1098.9395583242917;1099.5217080569978;1100.2133474565644;801.0267524957147;805.295366554265;807.0597753617029;809.7611204694629;811.6388207247777;16950.83049169517;17309.567260818454;17366.305347786074;17499.21253543581;20749.170033198654;20856.5828683427;21423.14307427701;21463.356099317047;21703.13187472515;21752.782472175233;15965.92017039919;16090.678186436206;16105.91947040269;16117.677646447122;17179.312827486887;3708.072981754561;3745.1198968242443;3757.079515518688;3757.887263382103;3758.1732018955786;132269;134889;138450;139708;144174;16008.759868601981;16135.112568808829;16274.593135171479;16495.670086598202;16612.169391530377;30890.382192356028;31287.217819554236;31320;32090.679093209237;32254.19364515859;8605.913940860512;8791.208791208694;8831.779205519784;8850.64597416109;8872.73381798547;4500.347449619787;4539.387182730289;4553.658475614342;4568.954310456919;4574.565416285448;5471.343438787291;5497.752601132958;5519.668819870821;5550.833474995757;5557.694326812064;1075.93544387337;1088.434014312553;1096.0957210301533;1099.2689861242345;1101.058594901364;698.1761521404791;711.0933559711409;723.1502983993786;734.4528326396869;752.6913965274211;12301;12641.747165056648;12895.806562901564;13027.413766380536;13115.147515411658;729.5877829026583;738.9889151662729;741.2143128284036;753.8127449267425;755.6750597243238;5922.2597175353085;6219.129321894939;6320.62076275425;6474.158359413246;6828.897566536506;119538.69062490575;119544;120088.3995580034;121474.3926280363;123291;102220.48889755653;106900;108118.45940770245;109223;109995;92214;92264.53867730619;92962.53518732499;95252;96131.51934240284;12846.614601561969;12902.870971290542;13229.933850331072;13269.203847769164;13705.246211458465;44436.77781611071;44439;44774.3283850736;45973.77013114913;47047.29429058635;72270.63864680853;75678.24321756711;77527.22472775426;79345;79657.60171199107;20382.898085509478;20589.485262868548;20803.68794468054;20837.68743468819;20899.68650470214;19870.10584523671;21233.89383053075;21356.57286854285;21409.892950535148;22934.54130917339;19684.311049113785;19914.800851991873;20055.598888021865;21040.473988150417;21052.368428947157;19557.11992960292;19647.11587978573;21229.78770212278;21319.467013324793;21474.14103435845;17843.37548185807;18257.54356141054;20013.299534516224;20169.294074707315;20846.687299690213;12969.416376262901;13593.45626174942;13819.378127984466;13929.860701392856;13953.511627093003;14592.708145836812;15076.246187690353;15153.621159471102;15613.219339032776;15747.291371888063 12:09:16 INFO - PID 23132 | __end_tp_report 12:09:16 INFO - PID 23132 | __start_cc_report 12:09:16 INFO - PID 23132 | _x_x_mozilla_cycle_collect,312 12:09:16 INFO - PID 23132 | __end_cc_report 12:09:16 INFO - PID 23132 | __startTimestamp1501528156592__endTimestamp 12:09:16 INFO - PID 23132 | 12:09:16 INFO - PID 23132 | ------- Summary: start ------- 12:09:16 INFO - PID 23132 | Number of tests: 6 12:09:16 INFO - PID 23132 | 12:09:16 INFO - PID 23132 | [#0] dojo.html Cycles:165 Average:5955.45 Median:6262.69 stddev:770.55 (12.3%) stddev-sans-first:745.19 12:09:16 INFO - PID 23132 | Values: 3344.7 3379.2 3385.9 3394.8 3409.4 5896.1 5922.8 5931.5 5937.5 5945.4 5967.1 5977.2 5986.0 5988.6 6014.4 5176.2 5210.7 5269.0 5272.4 5295.1 5139.4 5172.9 5228.0 5244.6 5249.2 5223.0 5271.2 5280.8 5286.5 5299.9 5192.6 5196.9 5273.8 5280.7 5280.9 5067.8 5123.7 5140.4 5185.6 5211.7 5824.2 5901.3 5909.5 5921.5 5958.6 6342.2 6346.9 6419.1 6426.1 6440.6 6431.8 6457.1 6529.8 6530.5 6531.6 5941.0 6013.4 6048.2 6060.5 6066.6 6572.3 6669.9 6674.3 6675.5 6679.6 6252.3 6285.7 6295.8 6309.6 6390.4 6402.9 6402.9 6410.0 6427.5 6429.0 6379.7 6403.3 6437.5 6464.2 6494.5 6477.5 6492.0 6493.5 6496.4 6505.0 4731.3 4734.2 4735.0 4804.0 4807.4 4162.0 4213.4 4259.3 4272.4 4275.9 6245.6 6255.9 6294.6 6312.6 6313.8 6503.4 6513.9 6514.1 6521.8 6523.6 6240.2 6245.4 6246.1 6257.0 6315.1 5374.9 5443.7 5445.4 5453.0 5456.3 6936.0 6949.5 7009.9 7020.0 7029.0 6374.5 6400.2 6400.9 6408.5 6449.1 6860.4 6873.1 6886.3 6894.3 6899.0 6298.2 6313.1 6327.7 6339.3 6404.6 6474.1 6482.5 6548.5 6570.1 6574.4 6195.0 6232.1 6259.7 6346.3 6352.7 6262.7 6276.2 6278.5 6280.0 6284.4 6208.7 6263.9 6337.0 6341.9 6346.6 6253.6 6315.9 6331.5 6336.5 6392.2 6128.3 6131.8 6196.4 6212.0 6214.8 12:09:16 INFO - PID 23132 | 12:09:16 INFO - PID 23132 | [#1] ext.html Cycles:180 Average:40948.60 Median:37095.03 stddev:59124.24 (159.4%) stddev-sans-first:59213.47 12:09:16 INFO - PID 23132 | Values: 859.8 897.8 917.5 943.4 945.9 39970.0 40425.6 40672.8 40722.8 40808.8 37877.4 37902.4 38179.6 38248.8 38399.6 6680.7 6799.3 6804.5 6806.3 6806.6 6670.8 6735.5 6749.3 6751.2 6757.2 7296.2 7469.5 7475.0 7478.0 7479.6 7323.5 7415.5 7426.8 7448.6 7449.8 7163.1 7349.6 7398.3 7404.8 7418.7 38366.0 38438.8 38534.0 38582.2 38603.6 3431.0 3458.0 3459.3 3483.8 3491.3 30722.8 30789.0 30830.2 30940.2 30953.7 4891.4 4906.9 4951.1 4956.9 5001.7 189566.0 194187.0 194288.0 194840.0 200485.0 50193.0 50204.2 50287.7 50318.2 50360.7 51779.0 51978.7 52138.5 52203.2 52228.5 15156.9 15254.9 15256.9 15274.7 15335.1 12415.3 12487.5 12490.8 12491.9 12498.4 14389.3 14569.5 14588.1 14650.2 14699.6 5847.8 5861.6 5885.2 5910.3 6005.4 1072.3 1081.8 1089.6 1092.6 1098.8 28211.2 29405.6 29941.4 30229.2 30356.7 1142.4 1166.6 1177.4 1184.7 1190.2 13002.2 16995.5 17213.3 17337.9 17462.1 258302.0 258390.0 259149.0 259214.0 259765.0 58103.0 58399.7 58490.0 58698.0 58765.0 1495.0 1495.5 1512.4 1527.7 1531.2 28422.9 29169.3 29230.0 30141.2 31334.7 53181.0 53705.5 53775.7 53832.5 53881.0 214118.0 223852.0 228279.0 228521.0 228623.0 36260.5 39221.6 39845.0 39906.2 39963.0 47336.5 48595.5 49274.0 49390.3 49425.8 33371.7 33426.8 33998.3 34371.1 34573.8 32862.5 33789.7 34076.5 34737.8 35352.0 40932.4 42032.2 42054.0 42382.8 42615.6 33996.3 34346.0 35807.1 36240.8 36312.6 26155.0 27223.9 27573.8 27621.7 28069.4 12:09:16 INFO - PID 23132 | 12:09:16 INFO - PID 23132 | [#2] jquery.html Cycles:180 Average:39082.57 Median:23439.03 stddev:97928.08 (417.8%) stddev-sans-first:98160.09 12:09:16 INFO - PID 23132 | Values: 564.3 568.6 580.1 580.5 585.3 22623.1 23399.3 23436.2 23441.9 23489.9 26058.0 28248.6 28284.4 28288.3 28315.6 6132.3 6251.4 6255.1 6262.2 6271.1 5970.2 6218.8 6227.1 6235.7 6285.0 6167.5 6168.8 6172.0 6173.4 6185.4 6176.9 6191.4 6199.9 6209.8 6215.6 5738.4 5754.0 5756.5 5795.7 5802.7 30559.7 30867.5 30878.2 31243.2 31875.5 2250.1 2280.1 2281.0 2281.4 2283.4 19431.8 19914.8 19942.0 19968.4 19982.9 2307.4 2389.1 2429.2 2444.5 2449.1 134094.0 136859.3 137070.0 137419.0 137701.0 14360.7 15294.4 15348.4 15692.5 16003.0 23612.0 23645.1 23657.9 23667.0 23718.8 10047.2 10151.2 10277.2 10279.1 10282.1 7578.8 9140.4 9239.6 9353.3 9373.0 8545.4 9455.3 9590.2 9716.0 9975.5 2837.7 2838.5 2840.6 2848.3 2853.7 1018.5 1032.5 1039.5 1058.2 1069.9 20466.7 21600.5 21761.1 25866.2 27778.4 1093.9 1104.5 1133.3 1136.9 1137.1 11924.8 14220.5 14835.7 15521.9 15661.8 556217.0 580694.0 590576.0 597813.0 600617.0 130210.3 135187.0 135841.0 136137.0 139436.0 1290.3 1296.8 1313.4 1331.4 1340.6 21831.2 22785.3 23078.8 23431.5 23650.2 62766.4 64528.0 64573.0 64767.7 65077.3 78562.2 81641.0 82357.6 82456.6 83583.2 12932.1 13289.6 14317.6 14920.6 15324.5 24210.0 24597.5 24715.0 24818.4 24848.0 19829.1 19835.1 19848.5 20121.1 20145.9 16495.2 16726.0 17229.4 17260.1 17371.4 18579.3 19691.5 19803.5 19823.0 19865.9 15105.0 15149.8 15161.8 15300.2 15347.3 19890.9 20523.2 20602.5 20811.9 20813.2 12:09:16 INFO - PID 23132 | 12:09:16 INFO - PID 23132 | [#3] mootools.html Cycles:180 Average:9457.20 Median:2596.76 stddev:6786.66 (261.4%) stddev-sans-first:6778.82 12:09:16 INFO - PID 23132 | Values: 1418.3 1455.4 1469.0 1472.3 1489.4 15061.6 15634.5 15660.6 15670.8 15679.5 15635.5 15891.8 15892.8 15901.1 15901.4 2721.5 2786.2 2786.3 2786.8 2788.8 2585.9 2654.4 2670.7 2686.8 2690.8 2590.0 2592.9 2595.5 2617.0 2620.6 2572.9 2593.7 2598.0 2598.4 2599.1 2566.4 2631.6 2649.4 2676.4 2688.6 14927.8 15041.2 15207.5 15210.2 15216.0 8182.4 8468.2 8471.8 8472.8 8480.8 4977.9 5159.6 5192.1 5284.9 5290.5 1838.3 1845.7 1852.2 1865.9 1891.6 25645.2 26172.2 26179.3 26183.2 26190.9 6790.0 6938.7 6971.2 7072.7 7103.2 17544.9 17575.8 17593.4 17597.9 17614.6 7851.6 7964.2 7992.9 8010.4 8011.8 7296.6 7400.2 7419.3 7440.8 7446.6 5263.9 5421.7 5424.0 5474.8 5508.6 1497.2 1528.0 1579.5 1590.4 1600.1 890.1 890.6 901.6 919.3 938.8 7851.3 8137.7 8194.8 8247.5 8313.6 974.8 996.5 1006.2 1009.9 1027.9 4606.6 4816.4 4966.6 4989.1 4993.1 20816.9 21611.2 21867.5 21965.9 22068.2 21416.1 21878.8 22098.0 22116.7 22238.3 11953.7 12109.7 12141.1 12149.1 12222.6 7538.9 7880.4 8001.0 8072.5 8121.6 18952.7 19007.2 19161.6 19597.8 19800.5 19031.8 19271.1 19558.5 20208.2 20233.2 12654.9 12884.1 12884.3 12885.7 12887.4 14466.5 14497.5 14556.6 14564.8 14570.3 10138.8 10300.6 10325.5 10426.5 10706.1 10877.6 10928.8 10983.6 11060.7 11307.9 9620.8 9640.8 9644.1 9702.2 9753.4 7099.6 7427.4 7485.6 7518.2 7529.5 7032.7 7387.8 7440.2 7457.6 7528.8 12:09:16 INFO - PID 23132 | 12:09:16 INFO - PID 23132 | [#4] prototype.html Cycles:180 Average:5469.14 Median:6150.95 stddev:1586.37 (25.8%) stddev-sans-first:1546.55 12:09:16 INFO - PID 23132 | Values: 510.7 511.8 515.9 529.3 535.5 5959.8 5991.4 6000.8 6008.3 6113.2 5771.3 5891.8 5929.2 5929.9 5987.4 4649.3 4654.4 4660.4 4665.8 4729.8 4684.3 4695.2 4733.3 4739.9 4741.5 4598.4 4656.3 4700.3 4701.0 4705.3 4637.5 4669.7 4687.0 4693.7 4716.5 4190.6 4225.5 4257.7 4261.2 4274.5 5851.4 5894.1 5924.2 5959.6 5960.5 5540.6 5586.8 5591.5 5626.0 5656.9 6377.2 6392.2 6414.0 6429.3 6451.5 4755.3 4782.5 4786.2 4805.2 4821.5 6714.6 6717.7 6731.5 6764.7 6765.0 4883.7 4923.0 4938.3 4955.5 4970.2 5007.8 5032.5 5050.1 5050.4 5051.4 5450.1 5541.2 5616.2 5628.8 5633.3 6187.3 6305.1 6430.4 6446.3 6457.8 1658.9 1684.8 1691.5 1707.7 1755.0 1193.3 1217.4 1222.3 1228.7 1230.7 6171.2 6178.7 6192.0 6203.3 6255.4 6441.9 6500.0 6569.4 6578.2 6632.2 6221.8 6284.4 6293.7 6303.4 6326.3 3394.8 3459.0 3465.0 3483.4 3508.2 7024.8 7058.4 7063.2 7141.4 7145.7 6772.4 6781.5 6783.2 6797.0 6808.1 7139.3 7159.3 7160.7 7180.2 7180.9 6605.6 6606.0 6620.5 6631.4 6635.6 6564.4 6567.7 6573.4 6578.0 6589.3 7042.2 7133.0 7164.5 7175.1 7187.2 4958.2 4984.5 4989.2 4991.4 4992.6 6619.9 6646.9 6651.3 6652.8 6668.1 6341.0 6364.6 6371.5 6371.8 6409.8 6342.8 6347.6 6363.2 6370.6 6379.3 6146.6 6251.7 6288.9 6390.2 6412.2 6237.1 6367.6 6388.0 6438.1 6456.1 6155.3 6289.1 6295.9 6302.7 6312.2 12:09:16 INFO - PID 23132 | 12:09:16 INFO - PID 23132 | [#5] yui.html Cycles:180 Average:25545.70 Median:20276.10 stddev:35278.33 (174.0%) stddev-sans-first:35328.93 12:09:16 INFO - PID 23132 | Values: 944.6 945.0 977.1 981.0 986.0 18677.5 19073.3 19322.9 19345.1 19398.0 17617.6 18602.4 21108.9 21120.7 21159.0 1037.4 1063.7 1064.9 1068.9 1071.6 1089.5 1089.6 1089.7 1095.6 1099.5 1071.5 1107.0 1113.5 1114.2 1117.3 1094.9 1098.9 1098.9 1099.5 1100.2 801.0 805.3 807.1 809.8 811.6 16950.8 17309.6 17366.3 17499.2 20749.2 20856.6 21423.1 21463.4 21703.1 21752.8 15965.9 16090.7 16105.9 16117.7 17179.3 3708.1 3745.1 3757.1 3757.9 3758.2 132269.0 134889.0 138450.0 139708.0 144174.0 16008.8 16135.1 16274.6 16495.7 16612.2 30890.4 31287.2 31320.0 32090.7 32254.2 8605.9 8791.2 8831.8 8850.6 8872.7 4500.3 4539.4 4553.7 4569.0 4574.6 5471.3 5497.8 5519.7 5550.8 5557.7 1075.9 1088.4 1096.1 1099.3 1101.1 698.2 711.1 723.2 734.5 752.7 12301.0 12641.7 12895.8 13027.4 13115.1 729.6 739.0 741.2 753.8 755.7 5922.3 6219.1 6320.6 6474.2 6828.9 119538.7 119544.0 120088.4 121474.4 123291.0 102220.5 106900.0 108118.5 109223.0 109995.0 92214.0 92264.5 92962.5 95252.0 96131.5 12846.6 12902.9 13229.9 13269.2 13705.2 44436.8 44439.0 44774.3 45973.8 47047.3 72270.6 75678.2 77527.2 79345.0 79657.6 20382.9 20589.5 20803.7 20837.7 20899.7 19870.1 21233.9 21356.6 21409.9 22934.5 19684.3 19914.8 20055.6 21040.5 21052.4 19557.1 19647.1 21229.8 21319.5 21474.1 17843.4 18257.5 20013.3 20169.3 20846.7 12969.4 13593.5 13819.4 13929.9 13953.5 14592.7 15076.2 15153.6 15613.2 15747.3 12:09:16 INFO - PID 23132 | -------- Summary: end -------- 12:09:16 INFO - PID 23132 | 12:09:17 INFO - TEST-INFO | 23132: exit 0 12:09:17 INFO - TEST-OK | dromaeo_css | took 1110966ms 12:09:17 INFO - TEST-START | kraken 12:09:17 INFO - Initialising browser for kraken test... 12:09:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47843/getInfo.html -profile /tmp/tmpqXiSzj/profile 12:09:17 INFO - TEST-INFO | started process 23496 (/builds/slave/test/build/application/firefox/firefox http://localhost:47843/getInfo.html) 12:09:23 INFO - TEST-INFO | 23496: exit 0 12:09:23 INFO - Browser initialized. 12:09:23 INFO - Running cycle 1/1 for kraken test... 12:09:23 INFO - TEST-INFO | started process 23704 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqXiSzj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:09:24 INFO - PID 23704 | 12:09:24 INFO - PID 23704 | (/builds/slave/test/build/application/firefox/firefox:23752): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:09:24 INFO - PID 23704 | 12:09:35 INFO - PID 23704 | RSS: Main: 164298752 12:09:35 INFO - PID 23704 | 12:09:37 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47843/tests/kraken/driver.html?testName=audio-beat-detection) 12:09:38 INFO - PID 23704 | RSS: Main: 169185280 12:09:38 INFO - PID 23704 | 12:09:41 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47843/tests/kraken/driver.html?testName=audio-dft) 12:09:41 INFO - PID 23704 | RSS: Main: 169644032 12:09:41 INFO - PID 23704 | 12:09:44 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47843/tests/kraken/driver.html?testName=audio-fft) 12:09:45 INFO - PID 23704 | RSS: Main: 163717120 12:09:45 INFO - PID 23704 | 12:09:47 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47843/tests/kraken/driver.html?testName=audio-oscillator) 12:09:47 INFO - PID 23704 | RSS: Main: 164130816 12:09:47 INFO - PID 23704 | 12:09:49 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:09:50 INFO - PID 23704 | RSS: Main: 164536320 12:09:50 INFO - PID 23704 | 12:09:53 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47843/tests/kraken/driver.html?testName=imaging-darkroom) 12:09:54 INFO - PID 23704 | RSS: Main: 167727104 12:09:54 INFO - PID 23704 | 12:09:57 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47843/tests/kraken/driver.html?testName=imaging-desaturate) 12:09:58 INFO - PID 23704 | RSS: Main: 169668608 12:09:58 INFO - PID 23704 | 12:10:01 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47843/tests/kraken/driver.html?testName=json-parse-financial) 12:10:01 INFO - PID 23704 | RSS: Main: 168108032 12:10:01 INFO - PID 23704 | 12:10:03 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:10:03 INFO - PID 23704 | RSS: Main: 168058880 12:10:03 INFO - PID 23704 | 12:10:05 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47843/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:10:06 INFO - PID 23704 | RSS: Main: 168009728 12:10:06 INFO - PID 23704 | 12:10:08 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:10:08 INFO - PID 23704 | RSS: Main: 165449728 12:10:08 INFO - PID 23704 | 12:10:11 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:10:12 INFO - PID 23704 | RSS: Main: 165289984 12:10:12 INFO - PID 23704 | 12:10:15 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:10:15 INFO - PID 23704 | RSS: Main: 166469632 12:10:15 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | Cycle 1(1): loaded http://localhost:47843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47843/tests/kraken/driver.html?testName=ai-astar) 12:10:17 INFO - PID 23704 | RSS: Main: 167219200 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | __start_tp_report 12:10:17 INFO - PID 23704 | _x_x_mozilla_page_load 12:10:17 INFO - PID 23704 | _x_x_mozilla_page_load_details 12:10:17 INFO - PID 23704 | |i|pagename|runs| 12:10:17 INFO - PID 23704 | |0;ai-astar;98;108;101;108;109;106;109;100;106;109 12:10:17 INFO - PID 23704 | |1;audio-beat-detection;132;117;140;184;117;141;139;115;164;115 12:10:17 INFO - PID 23704 | |2;audio-dft;163;163;162;162;168;162;161;161;164;163 12:10:17 INFO - PID 23704 | |3;audio-fft;74;73;76;165;74;73;73;91;104;76 12:10:17 INFO - PID 23704 | |4;audio-oscillator;77;78;131;78;78;77;126;78;77;134 12:10:17 INFO - PID 23704 | |5;imaging-gaussian-blur;113;115;114;114;113;114;115;114;114;114 12:10:17 INFO - PID 23704 | |6;imaging-darkroom;148;150;149;147;147;148;148;148;148;148 12:10:17 INFO - PID 23704 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;94 12:10:17 INFO - PID 23704 | |8;json-parse-financial;50;50;48;55;49;49;48;49;48;52 12:10:17 INFO - PID 23704 | |9;json-stringify-tinderbox;54;54;53;54;53;53;53;53;54;54 12:10:17 INFO - PID 23704 | |10;stanford-crypto-aes;76;77;78;77;77;79;83;77;85;77 12:10:17 INFO - PID 23704 | |11;stanford-crypto-ccm;127;129;124;123;118;125;128;123;129;163 12:10:17 INFO - PID 23704 | |12;stanford-crypto-pbkdf2;168;166;166;165;171;181;167;167;167;164 12:10:17 INFO - PID 23704 | |13;stanford-crypto-sha256-iterative;63;64;61;62;67;62;61;66;67;61 12:10:17 INFO - PID 23704 | __end_tp_report 12:10:17 INFO - PID 23704 | __start_cc_report 12:10:17 INFO - PID 23704 | _x_x_mozilla_cycle_collect,844 12:10:17 INFO - PID 23704 | __end_cc_report 12:10:17 INFO - PID 23704 | __startTimestamp1501528217796__endTimestamp 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | ------- Summary: start ------- 12:10:17 INFO - PID 23704 | Number of tests: 14 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#0] ai-astar Cycles:10 Average:105.40 Median:108.50 stddev:4.17 (3.8%) stddev-sans-first:3.46 12:10:17 INFO - PID 23704 | Values: 98.0 108.0 101.0 108.0 109.0 106.0 109.0 100.0 106.0 109.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:139.50 stddev:22.99 (16.5%) stddev-sans-first:24.33 12:10:17 INFO - PID 23704 | Values: 132.0 117.0 140.0 184.0 117.0 141.0 139.0 115.0 164.0 115.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:2.02 (1.2%) stddev-sans-first:2.15 12:10:17 INFO - PID 23704 | Values: 163.0 163.0 162.0 162.0 168.0 162.0 161.0 161.0 164.0 163.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#3] audio-fft Cycles:10 Average:87.90 Median:74.00 stddev:28.96 (39.1%) stddev-sans-first:30.28 12:10:17 INFO - PID 23704 | Values: 74.0 73.0 76.0 165.0 74.0 73.0 73.0 91.0 104.0 76.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:77.50 stddev:25.56 (33.0%) stddev-sans-first:26.41 12:10:17 INFO - PID 23704 | Values: 77.0 78.0 131.0 78.0 78.0 77.0 126.0 78.0 77.0 134.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 12:10:17 INFO - PID 23704 | Values: 113.0 115.0 114.0 114.0 113.0 114.0 115.0 114.0 114.0 114.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 12:10:17 INFO - PID 23704 | Values: 148.0 150.0 149.0 147.0 147.0 148.0 148.0 148.0 148.0 148.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 12:10:17 INFO - PID 23704 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:49.50 stddev:2.20 (4.4%) stddev-sans-first:2.33 12:10:17 INFO - PID 23704 | Values: 50.0 50.0 48.0 55.0 49.0 49.0 48.0 49.0 48.0 52.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#9] json-stringify-tinderbox Cycles:10 Average:53.50 Median:54.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 12:10:17 INFO - PID 23704 | Values: 54.0 54.0 53.0 54.0 53.0 53.0 53.0 53.0 54.0 54.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:77.50 stddev:2.99 (3.9%) stddev-sans-first:3.02 12:10:17 INFO - PID 23704 | Values: 76.0 77.0 78.0 77.0 77.0 79.0 83.0 77.0 85.0 77.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#11] stanford-crypto-ccm Cycles:10 Average:128.90 Median:127.50 stddev:12.45 (9.8%) stddev-sans-first:13.19 12:10:17 INFO - PID 23704 | Values: 127.0 129.0 124.0 123.0 118.0 125.0 128.0 123.0 129.0 163.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:167.00 stddev:4.87 (2.9%) stddev-sans-first:5.17 12:10:17 INFO - PID 23704 | Values: 168.0 166.0 166.0 165.0 171.0 181.0 167.0 167.0 167.0 164.0 12:10:17 INFO - PID 23704 | 12:10:17 INFO - PID 23704 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:2.46 (3.9%) stddev-sans-first:2.60 12:10:17 INFO - PID 23704 | Values: 63.0 64.0 61.0 62.0 67.0 62.0 61.0 66.0 67.0 61.0 12:10:17 INFO - PID 23704 | -------- Summary: end -------- 12:10:17 INFO - PID 23704 | 12:10:18 INFO - PID 23704 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:10:18 INFO - TEST-INFO | 23704: exit 0 12:10:18 INFO - TEST-OK | kraken | took 61462ms 12:10:18 INFO - SUITE-END | took 1172s 12:10:18 INFO - Completed test suite (00:19:32) 12:10:18 INFO - javascript benchmark 12:10:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8725.925377326537, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3344.6655334466554, 3379.239671074007, 3385.9153521161975, 3394.779339342943, 3409.4374428219344, 5896.056630939051, 5922.763089476416, 5931.466168044875, 5937.524998000155, 5945.435183657556, 5967.1049342598635, 5977.222961015062, 5985.970070149643, 5988.580799344048, 6014.398560143984, 5176.249443830652, 5210.739463026853, 5268.973655131738, 5272.393674727398, 5295.0733621616255, 5139.408967968676, 5172.922406163911, 5228.0, 5244.632875698702, 5249.1601343785005, 5223.033738758323, 5271.2356708277275, 5280.841574752763, 5286.524212820846, 5299.894002119955, 5192.584593232532, 5196.922046169273, 5273.789048438058, 5280.709560974145, 5280.894382112375, 5067.771950262247, 5123.692578445268, 5140.383154021504, 5185.585153187736, 5211.661242019294, 5824.155497452845, 5901.262342207224, 5909.497692696126, 5921.526277897758, 5958.612690175125, 6342.175517182736, 6346.87306253877, 6419.101325814389, 6426.132472116298, 6440.613563186177, 6431.807045788634, 6457.12828768115, 6529.771457998995, 6530.477561795045, 6531.575447595891, 5941.049432090845, 6013.428724271187, 6048.243969503812, 6060.515158787286, 6066.605670631439, 6572.34276572339, 6669.866602667919, 6674.299198584175, 6675.499337549703, 6679.599224046573, 6252.3122456529745, 6285.748570057238, 6295.811125666238, 6309.621422714652, 6390.4248617624635, 6402.8719425611225, 6402.903956440658, 6410.038494225903, 6427.485801135991, 6429.03564465334, 6379.681015949184, 6403.295637479873, 6437.517186211053, 6464.191976003, 6494.545381823322, 6477.481801455872, 6492.026196070533, 6493.51298652603, 6496.415322620986, 6505.024246362988, 4731.29030645406, 4734.171519983989, 4734.976325118421, 4804.015176888729, 4807.375041244686, 4162.0, 4213.389058586487, 4259.297215959332, 4272.359146128106, 4275.914481710349, 6245.6252624842655, 6255.906161407583, 6294.590851594632, 6312.589681670676, 6313.779017734358, 6503.382178693017, 6513.934860651428, 6514.05546195799, 6521.771737989147, 6523.608583485006, 6240.219972503437, 6245.375462453809, 6246.094316324198, 6257.0, 6315.147455093504, 5374.946250537445, 5443.727813609304, 5445.37378201504, 5452.972735136378, 5456.290682211287, 6936.0, 6949.548279361826, 7009.878419452863, 7020.0, 7028.964855175692, 6374.4900407966325, 6400.1679781629955, 6400.871982560229, 6408.455281301049, 6449.129367535323, 6860.416864566568, 6873.140857392826, 6886.311368863074, 6894.310568943066, 6898.965505172442, 6298.244210694746, 6313.05304204373, 6327.651979141191, 6339.334369891095, 6404.583702059351, 6474.0612611172055, 6482.546221764431, 6548.508861835477, 6570.145881035435, 6574.3754343337305, 6195.0, 6232.065190221503, 6259.655718935503, 6346.270178929298, 6352.682365881595, 6262.68686565679, 6276.246850377984, 6278.529110316653, 6279.96860015697, 6284.4344009039405, 6208.689565521616, 6263.937360626518, 6337.0, 6341.8731625368155, 6346.619202847844, 6253.593516421418, 6315.873682526416, 6331.461825744863, 6336.524760643062, 6392.169018027626, 6128.295246046761, 6131.816045518642, 6196.380361963767, 6211.9689401554515, 6214.782482613087], "value": 5896.892859554893, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [859.7786848500576, 897.7890195803989, 917.4862077236747, 943.4197968249529, 945.8912225094113, 39970.0, 40425.595744042585, 40672.79663601678, 40722.79638601803, 40808.795956020214, 37877.43183852245, 37902.43146352807, 38179.618203817954, 38248.80875595618, 38399.616003839954, 6680.66596670167, 6799.252082270947, 6804.523683342168, 6806.251312355637, 6806.591604503721, 6670.833229169261, 6735.5285130040675, 6749.325067493236, 6751.223609284946, 6757.1891373035305, 7296.2338954409815, 7469.514481558681, 7474.962625186867, 7478.0, 7479.5512269263745, 7323.450741194405, 7415.5179913306, 7426.814329641748, 7448.627568621548, 7449.813754656123, 7163.140423149255, 7349.632518374114, 7398.334149926479, 7404.814879627998, 7418.666160022758, 38366.0, 38438.80780596107, 38534.03664908372, 38582.22835543301, 38603.61396386028, 3431.022158684763, 3457.9654203457894, 3459.2562599041325, 3483.756137070406, 3491.30173965208, 30722.846385768153, 30789.0, 30830.229244269074, 30940.226494337596, 30953.690463095532, 4891.413030436335, 4906.901861962777, 4951.133551628451, 4956.925646115275, 5001.724905130216, 189566.0, 194187.0, 194288.0, 194840.0, 200485.0, 50193.0, 50204.24693629598, 50287.74856125769, 50318.24522632163, 50360.748196258784, 51779.0, 51978.74010629923, 52138.478615214124, 52203.21695174575, 52228.47771522312, 15156.924215378853, 15254.923725381524, 15256.923715381574, 15274.694506109816, 15335.079895206323, 12415.317157556421, 12487.500499979898, 12490.75018499643, 12491.87508124907, 12498.375081245902, 14389.28053597316, 14569.490067847786, 14588.124712517283, 14650.19423931694, 14699.632509187355, 5847.795327163529, 5861.589688721834, 5885.205497257901, 5910.320313164041, 6005.39946005396, 1072.3190773858655, 1081.799867024603, 1089.5750657243523, 1092.5902786455079, 1098.8406681031206, 28211.15366539007, 29405.558916616268, 29941.40117197644, 30229.244268893453, 30356.696433035828, 1142.440204299887, 1166.632510759108, 1177.4289469607234, 1184.680136363177, 1190.1906703441744, 13002.219866808022, 16995.49013529596, 17213.311467541407, 17337.873038252474, 17462.126893655266, 258302.0, 258390.0, 259149.0, 259214.0, 259765.0, 58103.0, 58399.70800145972, 58490.0, 58698.0, 58765.0, 1494.9925250373678, 1495.4616338118485, 1512.3723654683183, 1527.6562773376124, 1531.2190782700902, 28422.85788571044, 29169.270768230963, 29230.0, 30141.246468838453, 31334.68665313409, 53181.0, 53705.46294537161, 53775.73112134414, 53832.46167538274, 53881.0, 214118.0, 223852.0, 228279.0, 228521.0, 228623.0, 36260.46176767601, 39221.60778392294, 39845.0, 39906.201875961735, 39963.0, 47336.526634733214, 48595.5140448591, 49274.0, 49390.25914611355, 49425.75287123541, 33371.66628333783, 33426.83286583552, 33998.32003359968, 34371.14072148217, 34573.82713086519, 32862.507062393604, 33789.66210337963, 34076.488852667724, 34737.82631086828, 35352.0, 40932.386014209216, 42032.1593568133, 42054.0, 42382.78808605937, 42615.57384426116, 33996.3200735979, 34346.0, 35807.104822379646, 36240.818795906904, 36312.636873631986, 26155.0, 27223.86388068047, 27573.764592995074, 27621.723782762718, 28069.43861122807], "value": 18133.663933596723, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.2946317103621, 568.5593664909694, 580.0718849840254, 580.4630716587159, 585.2947198625657, 22623.095076196954, 23399.298021059374, 23436.17973370928, 23441.882790586067, 23489.882550587245, 26058.0, 28248.576271355894, 28284.434311313762, 28288.292792680193, 28315.575266370968, 6132.264128304599, 6251.4061164189325, 6255.093011513328, 6262.154609127778, 6271.122042913996, 5970.223870896799, 6218.782342618009, 6227.1282020517165, 6235.719392627343, 6284.968575157118, 6167.4757645600175, 6168.75324987, 6172.0, 6173.351798061206, 6185.35053819347, 6176.876462470748, 6191.4118158774845, 6199.907001394983, 6209.751609935643, 6215.56491045627, 5738.42615738427, 5753.971230143822, 5756.453136951983, 5795.710214489259, 5802.7098645068, 30559.694403056128, 30867.536986945215, 30878.22804429885, 31243.218919526968, 31875.52186717201, 2250.1336985260627, 2280.0879648140713, 2280.9657855132186, 2281.4182383492102, 2283.4405570635136, 19431.80568194314, 19914.80085199144, 19942.0, 19968.400947971582, 19982.900085499627, 2307.4462129089065, 2389.104085967762, 2429.2226487524, 2444.523317952982, 2449.1060762821444, 134094.0, 136859.31570342183, 137070.0, 137419.0, 137701.0, 14360.712785744226, 15294.388224470897, 15348.386064557293, 15692.450764223197, 16003.0, 23612.0, 23645.054197831894, 23657.881710591682, 23667.0, 23718.762812371657, 10047.24645651579, 10151.238657100746, 10277.229207809443, 10279.074883260542, 10282.126019288444, 7578.810529736801, 9140.405873618194, 9239.584218710039, 9353.345265831327, 9373.0, 8545.393654935304, 9455.29085318604, 9590.184834289164, 9716.0, 9975.508571999742, 2837.730415610514, 2838.5458326667635, 2840.5881147233536, 2848.302165969351, 2853.657561092682, 1018.4856647393019, 1032.4631191780231, 1039.4958445154093, 1058.1799105693149, 1069.8930106989394, 20466.692999605017, 21600.459988500097, 21761.12955481763, 25866.224013279632, 27778.444431111264, 1093.8577984861918, 1104.4753741972659, 1133.3426612564692, 1136.9431528423545, 1137.1300954769608, 11924.76150477003, 14220.502282420066, 14835.703285934222, 15521.922390388201, 15661.843381566267, 556217.0, 580694.0, 590576.0, 597813.0, 600617.0, 130210.34894825466, 135187.0, 135841.0, 136137.0, 139436.0, 1290.3290289049642, 1296.824928634641, 1313.40240190713, 1331.3542931678128, 1340.5710172744823, 21831.235906743186, 22785.316440506813, 23078.769212307663, 23431.531369372857, 23650.172243971378, 62766.37233627605, 64528.0, 64573.0, 64767.67616161889, 65077.349226507125, 78562.21437785549, 81641.0, 82357.58821206096, 82456.58771706103, 83583.16416835997, 12932.094753367173, 13289.601311960656, 14317.57047288583, 14920.62698432548, 15324.540263792103, 24210.0, 24597.508049838547, 24715.0, 24818.379540511633, 24848.0, 19829.107690154266, 19835.107420166416, 19848.50378740543, 20121.094550744958, 20145.899270503553, 16495.17524123813, 16726.0, 17229.39697110595, 17260.13699315004, 17371.392001279895, 18579.349722759638, 19691.507712306735, 19803.504912377306, 19823.00884955775, 19865.900670496554, 15105.018173818667, 15149.772753408488, 15161.772573411628, 15300.15849128264, 15347.309371078105, 19890.90054549718, 20523.17907283692, 20602.484937876674, 20811.8959405202, 20813.1674733009], "value": 12649.413246878486, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.2979425184533, 1455.4105587237166, 1469.0137688917664, 1472.2932992163767, 1489.4340150742719, 15061.62345941352, 15634.452794152206, 15660.608484787872, 15670.843291567095, 15679.45121920733, 15635.530934071967, 15891.761623575627, 15892.84107158928, 15901.12543810093, 15901.363945442168, 2721.482918245527, 2786.233785708926, 2786.342126434768, 2786.763125134366, 2788.84661343626, 2585.9482810343875, 2654.3894904172053, 2670.7329267073233, 2686.7984901132495, 2690.811643184978, 2590.0287392227915, 2592.909248176314, 2595.519828831663, 2617.0447786557866, 2620.567606344951, 2572.884220210095, 2593.6887573491113, 2598.0, 2598.376389666476, 2599.1422830465995, 2566.358410397401, 2631.5526360518757, 2649.417128231786, 2676.384431580728, 2688.5698288273784, 14927.776083358758, 15041.247937603077, 15207.543773686808, 15210.16344101074, 15216.0, 8182.386321025887, 8468.195521425516, 8471.788205294855, 8472.830543389098, 8480.78798030048, 4977.900441991176, 5159.561437277798, 5192.1432963560965, 5284.920726189111, 5290.497402746733, 1838.2646941223618, 1845.6585531676549, 1852.2035524724363, 1865.8787178833468, 1891.5933074388936, 25645.230643080737, 26172.214833555023, 26179.345516362053, 26183.214503564923, 26190.86904565484, 6789.981502774624, 6938.722451101899, 6971.163460384786, 7072.717091316393, 7103.218645948941, 17544.912275438543, 17575.824241757673, 17593.384231551834, 17597.912010439864, 17614.559636009202, 7851.646675899598, 7964.2433968772875, 7992.880106798402, 8010.359171266285, 8011.7997050073045, 7296.635168241567, 7400.185979542246, 7419.332260096618, 7440.813979650552, 7446.59043752588, 5263.894722105537, 5421.728913554307, 5424.0, 5474.753636086306, 5508.586855985817, 1497.1541079290166, 1527.9923600381926, 1579.5024567261275, 1590.427446119396, 1600.0719582642039, 890.123228619809, 890.5725251879135, 901.6258252825136, 919.3380765848578, 938.779386844091, 7851.254130857559, 8137.715179968791, 8194.75415737517, 8247.505149691038, 8313.584320783937, 974.8196583632051, 996.531630133836, 1006.2000709436016, 1009.914157296638, 1027.8817935937313, 4606.608438282717, 4816.446108697474, 4966.577840883493, 4989.101961646866, 4993.076280888047, 20816.895915520327, 21611.243606473698, 21867.453313666967, 21965.890170549046, 22068.22761203382, 21416.143354265656, 21878.781212187674, 22098.0, 22116.66824997594, 22238.332850014525, 11953.70115747096, 12109.69725756863, 12141.089418293663, 12149.08881833866, 12222.572209972608, 7538.886916696144, 7880.408969327438, 8001.039875215011, 8072.515649061075, 8121.593920303843, 18952.71570926465, 19007.23971041198, 19161.61676766429, 19597.804021960168, 19800.504987375432, 19031.809681903003, 19271.13279902436, 19558.511037224183, 20208.19167233294, 20233.19067237294, 12654.936725316315, 12884.098113132366, 12884.291363975071, 12885.677858053623, 12887.420066097236, 14466.493672721404, 14497.492587759378, 14556.63608409756, 14564.781528276872, 14570.344334505186, 10138.847917281395, 10300.587976480856, 10325.483725813829, 10426.478676066317, 10706.143508519144, 10877.564897404016, 10928.836067458835, 10983.61557345489, 11060.723481913017, 11307.886921130683, 9620.75948101303, 9640.807183856425, 9644.083812037845, 9702.175315098295, 9753.414795112316, 7099.574025558483, 7427.442941779496, 7485.588292643957, 7518.173000969999, 7529.472936894584, 7032.718691252293, 7387.8153046174275, 7440.181580026085, 7457.552546847207, 7528.774136775686], "value": 6733.346762040275, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.6706174517436, 511.77993462810986, 515.9174532074869, 529.3330403691348, 535.5447869311087, 5959.821205363835, 5991.370906054862, 6000.789972350969, 6008.309044459877, 6113.1747214126135, 5771.307443106823, 5891.793787217448, 5929.19955805966, 5929.911051334234, 5987.40125987401, 4649.325847752082, 4654.418197725285, 4660.37084993525, 4665.76671166442, 4729.810807567693, 4684.32077348786, 4695.178343789823, 4733.337332773397, 4739.90520189596, 4741.525847415248, 4598.448186217659, 4656.324832899228, 4700.29495575663, 4700.976495117519, 4705.294205869112, 4637.513061128583, 4669.743164125972, 4687.0, 4693.694909830884, 4716.52834716529, 4190.55999120091, 4225.450691410128, 4257.659387249044, 4261.21167583998, 4274.487061552602, 5851.385604511507, 5894.115882617599, 5924.170616113747, 5959.553033522503, 5960.463558279732, 5540.584456165804, 5586.826766379066, 5591.496765291144, 5625.999999999959, 5656.85857853557, 6377.23473183221, 6392.169018027626, 6414.005829096497, 6429.260635026985, 6451.451626611743, 4755.262934245197, 4782.473927867966, 4786.234202527614, 4805.231163013936, 4821.493743156953, 6714.630695311707, 6717.6977036033495, 6731.461483081342, 6764.695588698521, 6764.966175169142, 4883.706977581356, 4923.0, 4938.333325001079, 4955.4796746341835, 4970.229614409773, 5007.799688012512, 5032.496750324938, 5050.116229659795, 5050.444451110448, 5051.368578927634, 5450.100733379028, 5541.199110289092, 5616.1856530803625, 5628.831135065954, 5633.267675202197, 6187.257529096537, 6305.148804911279, 6430.356964303533, 6446.258680251737, 6457.806265812033, 1658.8838781285194, 1684.797824261072, 1691.4502786594405, 1707.709689352813, 1754.9561260968323, 1193.3198077096145, 1217.391304347826, 1222.3155033181447, 1228.680543058811, 1230.680023193958, 6171.228596425447, 6178.69106544671, 6192.0, 6203.332566996235, 6255.40573645503, 6441.903371449432, 6499.967500162469, 6569.408753212234, 6578.243501997236, 6632.237292711304, 6221.813345599639, 6284.402981716729, 6293.716782744787, 6303.432691057827, 6326.304106548276, 3394.762366634312, 3459.0, 3464.9826750866587, 3483.4426491761196, 3508.2281897982402, 7024.789256322319, 7058.400035996895, 7063.223045464994, 7141.357277845019, 7145.714171433188, 6772.390484856386, 6781.525293229525, 6783.152105986752, 6797.0, 6808.114945057111, 7139.32176443237, 7159.319864612853, 7160.677769500385, 7180.246074162243, 7180.856382872418, 6605.57063790852, 6605.966970165118, 6620.536562440776, 6631.436327912182, 6635.568688035455, 6564.409203171737, 6567.671616419256, 6573.375529324707, 6578.0, 6589.27517973013, 7042.22535521082, 7133.0, 7164.498485105993, 7175.138983322035, 7187.173475050227, 4958.157113290677, 4984.526469985346, 4989.226669866177, 4991.425986011655, 4992.550670439533, 6619.933800662125, 6646.867062658816, 6651.301613330531, 6652.833679157866, 6668.133142691613, 6340.968295158495, 6364.586301890362, 6371.458426033653, 6371.776987805404, 6409.775657851953, 6342.778002769881, 6347.587406818542, 6363.172787537591, 6370.649614271259, 6379.330170332234, 6146.631202127886, 6251.6561589113035, 6288.937110628835, 6390.233172019387, 6412.198475190601, 6237.12680224778, 6367.61794292344, 6387.968060159669, 6438.130852334875, 6456.063870738622, 6155.2613686356135, 6289.119523266655, 6295.937040629535, 6302.707944871198, 6312.210973628296], "value": 5005.867274885999, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [944.636315018718, 945.0313428735546, 977.0766625538864, 981.0140808487469, 985.99507002465, 18677.533061673465, 19073.332433364834, 19322.90338548309, 19345.129469173884, 19398.0, 17617.55956101098, 18602.441926742187, 21108.894455527738, 21120.683189752126, 21159.0, 1037.4397825174415, 1063.7021633942509, 1064.8509208710786, 1068.930519516229, 1071.614218881202, 1089.515165751241, 1089.6186334782801, 1089.7384627689337, 1095.5782023920808, 1099.4997276239292, 1071.517816982357, 1107.0479387726548, 1113.4711012269188, 1114.2423152256463, 1117.3184357541934, 1094.9069329107035, 1098.9175811814107, 1098.9395583242917, 1099.5217080569978, 1100.2133474565644, 801.0267524957147, 805.295366554265, 807.0597753617029, 809.7611204694629, 811.6388207247777, 16950.83049169517, 17309.567260818454, 17366.305347786074, 17499.21253543581, 20749.170033198654, 20856.5828683427, 21423.14307427701, 21463.356099317047, 21703.13187472515, 21752.782472175233, 15965.92017039919, 16090.678186436206, 16105.91947040269, 16117.677646447122, 17179.312827486887, 3708.072981754561, 3745.1198968242443, 3757.079515518688, 3757.887263382103, 3758.1732018955786, 132269.0, 134889.0, 138450.0, 139708.0, 144174.0, 16008.759868601981, 16135.112568808829, 16274.593135171479, 16495.670086598202, 16612.169391530377, 30890.382192356028, 31287.217819554236, 31320.0, 32090.679093209237, 32254.19364515859, 8605.913940860512, 8791.208791208694, 8831.779205519784, 8850.64597416109, 8872.73381798547, 4500.347449619787, 4539.387182730289, 4553.658475614342, 4568.954310456919, 4574.565416285448, 5471.343438787291, 5497.752601132958, 5519.668819870821, 5550.833474995757, 5557.694326812064, 1075.93544387337, 1088.434014312553, 1096.0957210301533, 1099.2689861242345, 1101.058594901364, 698.1761521404791, 711.0933559711409, 723.1502983993786, 734.4528326396869, 752.6913965274211, 12301.0, 12641.747165056648, 12895.806562901564, 13027.413766380536, 13115.147515411658, 729.5877829026583, 738.9889151662729, 741.2143128284036, 753.8127449267425, 755.6750597243238, 5922.2597175353085, 6219.129321894939, 6320.62076275425, 6474.158359413246, 6828.897566536506, 119538.69062490575, 119544.0, 120088.3995580034, 121474.3926280363, 123291.0, 102220.48889755653, 106900.0, 108118.45940770245, 109223.0, 109995.0, 92214.0, 92264.53867730619, 92962.53518732499, 95252.0, 96131.51934240284, 12846.614601561969, 12902.870971290542, 13229.933850331072, 13269.203847769164, 13705.246211458465, 44436.77781611071, 44439.0, 44774.3283850736, 45973.77013114913, 47047.29429058635, 72270.63864680853, 75678.24321756711, 77527.22472775426, 79345.0, 79657.60171199107, 20382.898085509478, 20589.485262868548, 20803.68794468054, 20837.68743468819, 20899.68650470214, 19870.10584523671, 21233.89383053075, 21356.57286854285, 21409.892950535148, 22934.54130917339, 19684.311049113785, 19914.800851991873, 20055.598888021865, 21040.473988150417, 21052.368428947157, 19557.11992960292, 19647.11587978573, 21229.78770212278, 21319.467013324793, 21474.14103435845, 17843.37548185807, 18257.54356141054, 20013.299534516224, 20169.294074707315, 20846.687299690213, 12969.416376262901, 13593.45626174942, 13819.378127984466, 13929.860701392856, 13953.511627093003, 14592.708145836812, 15076.246187690353, 15153.621159471102, 15613.219339032776, 15747.291371888063], "value": 9681.665231475781, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 101.0, 108.0, 109.0, 106.0, 109.0, 100.0, 106.0, 109.0], "value": 105.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 117.0, 140.0, 184.0, 117.0, 141.0, 139.0, 115.0, 164.0, 115.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 168.0, 162.0, 161.0, 161.0, 164.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 165.0, 74.0, 73.0, 73.0, 91.0, 104.0, 76.0], "value": 87.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 131.0, 78.0, 78.0, 77.0, 126.0, 78.0, 77.0, 134.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 48.0, 55.0, 49.0, 49.0, 48.0, 49.0, 48.0, 52.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 54.0, 53.0, 53.0, 53.0, 53.0, 54.0, 54.0], "value": 53.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 78.0, 77.0, 77.0, 79.0, 83.0, 77.0, 85.0, 77.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 129.0, 124.0, 123.0, 118.0, 125.0, 128.0, 123.0, 129.0, 163.0], "value": 128.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 166.0, 166.0, 165.0, 171.0, 181.0, 167.0, 167.0, 167.0, 164.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 61.0, 62.0, 67.0, 62.0, 61.0, 66.0, 67.0, 61.0], "value": 63.4, "unit": "score"}]}]} 12:10:19 INFO - Return code: 0 12:10:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:10:19 INFO - # TBPL SUCCESS # 12:10:19 INFO - Running post-action listener: _package_coverage_data 12:10:19 INFO - Running post-action listener: _resource_record_post_action 12:10:19 INFO - [mozharness: 2017-07-31 19:10:19.086554Z] Finished run-tests step (success) 12:10:19 INFO - Running post-run listener: _resource_record_post_run 12:10:19 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 424488960; Read time: 536; Write time: 927972 12:10:19 INFO - TinderboxPrint: CPU usage
13.1% 12:10:19 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 536 12:10:19 INFO - TinderboxPrint: I/O write bytes / time
424,488,960 / 927,972 12:10:19 INFO - TinderboxPrint: CPU idle
8,251.5 (86.9%) 12:10:19 INFO - TinderboxPrint: CPU user
1,191.2 (12.5%) 12:10:19 INFO - TinderboxPrint: Swap in / out
0 / 0 12:10:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107991040; Read time: 0; Write time: 174448 12:10:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:10:19 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 313483264; Read time: 536; Write time: 753052 12:10:19 INFO - Running post-run listener: _upload_blobber_files 12:10:19 INFO - Blob upload gear active. 12:10:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:10:19 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 12:10:19 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'] 12:10:19 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 12:10:20 INFO - (blobuploader) - INFO - Open directory for files ... 12:10:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:10:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:10:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:21 INFO - (blobuploader) - INFO - Done attempting. 12:10:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:10:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:10:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:28 INFO - (blobuploader) - INFO - Done attempting. 12:10:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:10:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:10:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:28 INFO - (blobuploader) - INFO - Done attempting. 12:10:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:10:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:10:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:10:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:10:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:10:29 INFO - (blobuploader) - INFO - Done attempting. 12:10:29 INFO - (blobuploader) - INFO - Iteration through files over. 12:10:29 INFO - Return code: 0 12:10:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:10:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:10:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d0ca0b2b7a173a7632aecf955f84de704f608d03beeae9338f7d50616460ac275d6a17e3bef3695477d584f2273bd018943efa3d3fb9746f98dd19f7824db3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6a5276214e04378e4e12ee664b9eee25fd4ed3c70162114a644d7fed1b88921933d7dc183608dd7a3bcc36db9eb76a7ccd8563af66b0f883b2aaff03c2f995d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19cb7dbbf19bf8fa53b114a03fc42af393cc73f82eedc559d18eb5424562fe4c0ef875a25a6159559b89714a58c5e0bacbafa2fc5de598393e5280a9c9aa9e2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab9fbfe2e46fa17632dc80d4422e7a7f85147d63be27fe20a1c68ec383e567b823fc67b1fc84ffd766bb318bda24a597025ed064ab352356ef756c046a130a56"} 12:10:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:10:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:10:29 INFO - Contents: 12:10:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d0ca0b2b7a173a7632aecf955f84de704f608d03beeae9338f7d50616460ac275d6a17e3bef3695477d584f2273bd018943efa3d3fb9746f98dd19f7824db3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6a5276214e04378e4e12ee664b9eee25fd4ed3c70162114a644d7fed1b88921933d7dc183608dd7a3bcc36db9eb76a7ccd8563af66b0f883b2aaff03c2f995d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19cb7dbbf19bf8fa53b114a03fc42af393cc73f82eedc559d18eb5424562fe4c0ef875a25a6159559b89714a58c5e0bacbafa2fc5de598393e5280a9c9aa9e2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab9fbfe2e46fa17632dc80d4422e7a7f85147d63be27fe20a1c68ec383e567b823fc67b1fc84ffd766bb318bda24a597025ed064ab352356ef756c046a130a56"} 12:10:29 INFO - Running post-run listener: copy_logs_to_upload_dir 12:10:29 INFO - Copying logs to upload dir... 12:10:29 INFO - mkdir: /builds/slave/test/build/upload/logs 12:10:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.852802 ========= master_lag: -0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-07-31 12:10:29.278601) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 12:10:29.283198) ========= 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=8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d0ca0b2b7a173a7632aecf955f84de704f608d03beeae9338f7d50616460ac275d6a17e3bef3695477d584f2273bd018943efa3d3fb9746f98dd19f7824db3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6a5276214e04378e4e12ee664b9eee25fd4ed3c70162114a644d7fed1b88921933d7dc183608dd7a3bcc36db9eb76a7ccd8563af66b0f883b2aaff03c2f995d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19cb7dbbf19bf8fa53b114a03fc42af393cc73f82eedc559d18eb5424562fe4c0ef875a25a6159559b89714a58c5e0bacbafa2fc5de598393e5280a9c9aa9e2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab9fbfe2e46fa17632dc80d4422e7a7f85147d63be27fe20a1c68ec383e567b823fc67b1fc84ffd766bb318bda24a597025ed064ab352356ef756c046a130a56"} build_url:https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011210 build_url: 'https://queue.taskcluster.net/v1/task/f2TFbEELQBuS5vxeIOzlIg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5d0ca0b2b7a173a7632aecf955f84de704f608d03beeae9338f7d50616460ac275d6a17e3bef3695477d584f2273bd018943efa3d3fb9746f98dd19f7824db3c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e6a5276214e04378e4e12ee664b9eee25fd4ed3c70162114a644d7fed1b88921933d7dc183608dd7a3bcc36db9eb76a7ccd8563af66b0f883b2aaff03c2f995d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19cb7dbbf19bf8fa53b114a03fc42af393cc73f82eedc559d18eb5424562fe4c0ef875a25a6159559b89714a58c5e0bacbafa2fc5de598393e5280a9c9aa9e2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab9fbfe2e46fa17632dc80d4422e7a7f85147d63be27fe20a1c68ec383e567b823fc67b1fc84ffd766bb318bda24a597025ed064ab352356ef756c046a130a56"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-31 12:10:29.310640) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 12:10:29.310995) ========= 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=8783db0840cc980e80bb0bd400000236-1501526132.604629-942651514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-31 12:10:29.397033) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 12:10:29.397400) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-31 12:10:29.397716) ========= ========= Total master_lag: -0.06 =========