builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1502013080.36 results: success (0) revision: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:20.364320) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:20.364731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:20.365090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:20.411510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:20.411795) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-06 02:51:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 45.2M=0s 2017-08-06 02:51:20 (45.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.208019 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:20.660114) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:20.660429) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014565 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:20.710419) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-08-06 02:51:20.710755) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fe6609d22dfdd710b11e3ac7773aff89f7a8d12c --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 fe6609d22dfdd710b11e3ac7773aff89f7a8d12c --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=516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-06 02:51:20,783 truncating revision to first 12 chars 2017-08-06 02:51:20,783 Setting DEBUG logging. 2017-08-06 02:51:20,783 attempt 1/10 2017-08-06 02:51:20,783 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fe6609d22dfd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-06 02:51:21,387 attempt 1/10 2017-08-06 02:51:22,013 current task status: no status available at this point. state: STARTED 2017-08-06 02:51:22,013 sleeping for 11.00s (attempt 1/10) 2017-08-06 02:51:33,024 attempt 2/10 2017-08-06 02:51:33,358 current task status: Task completed! Check 's3_urls' for upload locations. state: SUCCESS 2017-08-06 02:51:33,537 unpacking tar archive at: mozilla-central-fe6609d22dfd/testing/mozharness/ program finished with exit code 0 elapsedTime=13.283244 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 13 secs) (at 2017-08-06 02:51:34.005571) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:34.005881) ========= script_repo_revision: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:34.006236) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:34.006562) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-06 02:51:34.013610) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-06 02:51:34.013875) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:51:34 INFO - MultiFileLogger online at 20170806 02:51:34 in /builds/slave/test 02:51:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 02:51:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:51:34 INFO - {'append_to_log': False, 02:51:34 INFO - 'base_work_dir': '/builds/slave/test', 02:51:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:51:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:51:34 INFO - 'branch': 'Firefox-Non-PGO', 02:51:34 INFO - 'buildbot_json_path': 'buildprops.json', 02:51:34 INFO - 'code_coverage': False, 02:51:34 INFO - 'config_files': ('talos/linux_config.py',), 02:51:34 INFO - 'default_actions': ('clobber', 02:51:34 INFO - 'read-buildbot-config', 02:51:34 INFO - 'download-and-extract', 02:51:34 INFO - 'populate-webroot', 02:51:34 INFO - 'create-virtualenv', 02:51:34 INFO - 'install', 02:51:34 INFO - 'setup-mitmproxy', 02:51:34 INFO - 'run-tests'), 02:51:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:51:34 INFO - 'disable_ccov_upload': False, 02:51:34 INFO - 'download_minidump_stackwalk': True, 02:51:34 INFO - 'download_symbols': 'ondemand', 02:51:34 INFO - 'enable_stylo': False, 02:51:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:51:34 INFO - 'tooltool.py': '/tools/tooltool.py', 02:51:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:51:34 INFO - '/tools/misc-python/virtualenv.py')}, 02:51:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:51:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:51:34 INFO - 'gecko_profile': False, 02:51:34 INFO - 'gecko_profile_interval': 0, 02:51:34 INFO - 'installer_path': 'installer.exe', 02:51:34 INFO - 'log_level': 'info', 02:51:34 INFO - 'log_name': 'talos', 02:51:34 INFO - 'log_to_console': True, 02:51:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:51:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:51:34 INFO - 'opt_config_files': (), 02:51:34 INFO - 'pip_index': False, 02:51:34 INFO - 'suite': 'dromaeojs-e10s', 02:51:34 INFO - 'system_bits': '32', 02:51:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:51:34 INFO - 'title': 'talos-linux64-ix-061', 02:51:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:51:34 INFO - 'use_talos_json': True, 02:51:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:51:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:51:34 INFO - 'work_dir': 'build'} 02:51:34 INFO - [mozharness: 2017-08-06 09:51:34.281340Z] Running clobber step. 02:51:34 INFO - Running pre-action listener: _resource_record_pre_action 02:51:34 INFO - Running main action method: clobber 02:51:34 INFO - rmtree: /builds/slave/test/build 02:51:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:51:35 INFO - Running post-action listener: _resource_record_post_action 02:51:35 INFO - [mozharness: 2017-08-06 09:51:35.284847Z] Finished clobber step (success) 02:51:35 INFO - [mozharness: 2017-08-06 09:51:35.284949Z] Running read-buildbot-config step. 02:51:35 INFO - Running pre-action listener: _resource_record_pre_action 02:51:35 INFO - Running main action method: read_buildbot_config 02:51:35 INFO - Using buildbot properties: 02:51:35 INFO - { 02:51:35 INFO - "project": "", 02:51:35 INFO - "product": "firefox", 02:51:35 INFO - "who": "archaeopteryx@coole-files.de", 02:51:35 INFO - "installer_path": "public/build/target.tar.bz2", 02:51:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:51:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:51:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:51:35 INFO - "stage_platform": "linux64", 02:51:35 INFO - "basedir": "/builds/slave/test", 02:51:35 INFO - "buildnumber": 1061, 02:51:35 INFO - "platform": "ubuntu64_hw", 02:51:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:51:35 INFO - "slavebuilddir": "test", 02:51:35 INFO - "taskId": "DpgidOYARVOZFGyK2-5FwA", 02:51:35 INFO - "branch": "mozilla-central", 02:51:35 INFO - "script_repo_revision": "production", 02:51:35 INFO - "revision": "fe6609d22dfdd710b11e3ac7773aff89f7a8d12c", 02:51:35 INFO - "slavename": "talos-linux64-ix-061", 02:51:35 INFO - "repo_path": "mozilla-central" 02:51:35 INFO - } 02:51:35 INFO - Finding installer, test and symbols from parent task. 02:51:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpgidOYARVOZFGyK2-5FwA'}, attempt #1 02:51:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DpgidOYARVOZFGyK2-5FwA'}, attempt #1 02:51:36 INFO - Task dependencies: Ph1H-2ZlRnGCNKdcz7C8dw 02:51:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw'}, attempt #1 02:51:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 02:51:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json 02:51:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip 02:51:36 INFO - Running post-action listener: _resource_record_post_action 02:51:36 INFO - [mozharness: 2017-08-06 09:51:36.639347Z] Finished read-buildbot-config step (success) 02:51:36 INFO - [mozharness: 2017-08-06 09:51:36.639569Z] Running download-and-extract step. 02:51:36 INFO - Running pre-action listener: _resource_record_pre_action 02:51:36 INFO - Running main action method: download_and_extract 02:51:36 INFO - mkdir: /builds/slave/test/build/tests 02:51:36 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')]} 02:51:36 INFO - trying https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json 02:51:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:51:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:51:37 INFO - Downloaded 989 bytes. 02:51:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:51:37 INFO - Using the following test package requirements: 02:51:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:51:37 INFO - u'common': [u'target.common.tests.zip'], 02:51:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:51:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:51:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:51:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:51:37 INFO - u'mozbase': [u'target.common.tests.zip'], 02:51:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:51:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:51:37 INFO - u'web-platform': [u'target.common.tests.zip', 02:51:37 INFO - u'target.web-platform.tests.tar.gz'], 02:51:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:51:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:51:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip 02:51:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:51:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip into memory 02:51:38 INFO - Content-Length response header: 54284831 02:51:38 INFO - Bytes received: 54284831 02:51:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:51:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip 02:51:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:51:49 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.common.tests.zip into memory 02:51:50 INFO - Content-Length response header: 54284831 02:51:50 INFO - Bytes received: 54284831 02:52:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip 02:52:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:52:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.talos.tests.zip into memory 02:52:04 INFO - Content-Length response header: 14496008 02:52:04 INFO - Bytes received: 14496008 02:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:04 INFO - trying https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 02:52:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:52:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:52:05 INFO - Downloaded 61880648 bytes. 02:52:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 02:52:05 INFO - mkdir: /builds/slave/test/properties 02:52:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:52:05 INFO - Writing to file /builds/slave/test/properties/build_url 02:52:05 INFO - Contents: 02:52:05 INFO - build_url:https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 02:52:05 INFO - Running post-action listener: _resource_record_post_action 02:52:05 INFO - Running post-action listener: set_extra_try_arguments 02:52:05 INFO - [mozharness: 2017-08-06 09:52:05.541393Z] Finished download-and-extract step (success) 02:52:05 INFO - [mozharness: 2017-08-06 09:52:05.541505Z] Running populate-webroot step. 02:52:05 INFO - Running pre-action listener: _resource_record_pre_action 02:52:05 INFO - Running main action method: populate_webroot 02:52:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:52:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:52:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:52:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:52:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:52:05 INFO - 'tests': ['damp', 'tps']}, 02:52:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:52:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:52:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:52:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:52:05 INFO - 'other-e10s': {'tests': ['a11yr', 02:52:05 INFO - 'ts_paint', 02:52:05 INFO - 'tpaint', 02:52:05 INFO - 'sessionrestore', 02:52:05 INFO - 'sessionrestore_many_windows', 02:52:05 INFO - 'sessionrestore_no_auto_restore', 02:52:05 INFO - 'tabpaint']}, 02:52:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:52:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:52:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:52:05 INFO - 'tsvgr_opacity', 02:52:05 INFO - 'tart', 02:52:05 INFO - 'tscrollx', 02:52:05 INFO - 'tsvg_static']}, 02:52:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:52:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:05 INFO - 'talos_options': ['--mitmproxy', 02:52:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:05 INFO - '--firstNonBlankPaint'], 02:52:05 INFO - 'tests': ['tp6_google', 02:52:05 INFO - 'tp6_youtube', 02:52:05 INFO - 'tp6_amazon', 02:52:05 INFO - 'tp6_facebook']}, 02:52:05 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:05 INFO - 'talos_options': ['--stylo', 02:52:05 INFO - '--mitmproxy', 02:52:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:05 INFO - '--firstNonBlankPaint'], 02:52:05 INFO - 'tests': ['tp6_google', 02:52:05 INFO - 'tp6_youtube', 02:52:05 INFO - 'tp6_amazon', 02:52:05 INFO - 'tp6_facebook']}, 02:52:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:52:05 INFO - 'talos_options': ['--stylo', 02:52:05 INFO - '--stylo-threads=1', 02:52:05 INFO - '--mitmproxy', 02:52:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:52:05 INFO - '--firstNonBlankPaint'], 02:52:05 INFO - 'tests': ['tp6_google', 02:52:05 INFO - 'tp6_youtube', 02:52:05 INFO - 'tp6_amazon', 02:52:05 INFO - 'tp6_facebook']}, 02:52:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:52:05 INFO - 'talos_options': ['--xperf_path', 02:52:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:52:05 INFO - 'tests': ['tp5n']}}} 02:52:05 INFO - Running post-action listener: _resource_record_post_action 02:52:05 INFO - [mozharness: 2017-08-06 09:52:05.549926Z] Finished populate-webroot step (success) 02:52:05 INFO - [mozharness: 2017-08-06 09:52:05.550017Z] Running create-virtualenv step. 02:52:05 INFO - Running pre-action listener: _resource_record_pre_action 02:52:05 INFO - Running main action method: create_virtualenv 02:52:05 INFO - Creating virtualenv /builds/slave/test/build/venv 02:52:05 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 02:52:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:52:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:52:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:52:05 INFO - Using real prefix '/usr' 02:52:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:52:06 INFO - Installing distribute.............................................................................................................................................................................................done. 02:52:08 INFO - Installing pip.................done. 02:52:08 INFO - Return code: 0 02:52:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:52:08 INFO - Reading from file tmpfile_stdout 02:52:08 INFO - Output received: 02:52:08 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) 02:52:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbdf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4ceb0>, '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 0xf4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4e240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', '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 02:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:52:08 INFO - Using env: {'DISPLAY': ':0', 02:52:08 INFO - 'HOME': '/home/cltbld', 02:52:08 INFO - 'LANG': 'en_US.UTF-8', 02:52:08 INFO - 'LANGUAGE': 'en_US:en', 02:52:08 INFO - 'LOGNAME': 'cltbld', 02:52:08 INFO - 'MAIL': '/var/mail/cltbld', 02:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:08 INFO - 'MOZ_NO_REMOTE': '1', 02:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:08 INFO - 'NO_EM_RESTART': '1', 02:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:08 INFO - 'PWD': '/builds/slave/test', 02:52:08 INFO - 'SHELL': '/bin/bash', 02:52:08 INFO - 'SHLVL': '1', 02:52:08 INFO - 'TERM': 'linux', 02:52:08 INFO - 'TMOUT': '86400', 02:52:08 INFO - 'USER': 'cltbld', 02:52:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', 02:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:08 INFO - '_': '/tools/buildbot/bin/python'} 02:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:08 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 02:52:08 INFO - Cleaning up... 02:52:08 INFO - Return code: 0 02:52:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xbdf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4ceb0>, '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 0xf4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4e240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', '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 02:52:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:52:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:52:08 INFO - Using env: {'DISPLAY': ':0', 02:52:08 INFO - 'HOME': '/home/cltbld', 02:52:08 INFO - 'LANG': 'en_US.UTF-8', 02:52:08 INFO - 'LANGUAGE': 'en_US:en', 02:52:08 INFO - 'LOGNAME': 'cltbld', 02:52:08 INFO - 'MAIL': '/var/mail/cltbld', 02:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:08 INFO - 'MOZ_NO_REMOTE': '1', 02:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:08 INFO - 'NO_EM_RESTART': '1', 02:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:08 INFO - 'PWD': '/builds/slave/test', 02:52:08 INFO - 'SHELL': '/bin/bash', 02:52:08 INFO - 'SHLVL': '1', 02:52:08 INFO - 'TERM': 'linux', 02:52:08 INFO - 'TMOUT': '86400', 02:52:08 INFO - 'USER': 'cltbld', 02:52:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', 02:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:08 INFO - '_': '/tools/buildbot/bin/python'} 02:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:09 INFO - Downloading/unpacking psutil>=3.1.1 02:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:52:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:10 INFO - Installing collected packages: psutil 02:52:10 INFO - Running setup.py install for psutil 02:52:10 INFO - building 'psutil._psutil_linux' extension 02:52:10 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 02:52:11 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 02:52:11 INFO - building 'psutil._psutil_posix' extension 02:52:11 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 02:52:11 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 02:52:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:52:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:52:11 INFO - Successfully installed psutil 02:52:11 INFO - Cleaning up... 02:52:11 INFO - Return code: 0 02:52:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:11 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 0xbdf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4ceb0>, '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 0xf4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4e240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', '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 02:52:11 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 02:52:11 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 02:52:11 INFO - Using env: {'DISPLAY': ':0', 02:52:11 INFO - 'HOME': '/home/cltbld', 02:52:11 INFO - 'LANG': 'en_US.UTF-8', 02:52:11 INFO - 'LANGUAGE': 'en_US:en', 02:52:11 INFO - 'LOGNAME': 'cltbld', 02:52:11 INFO - 'MAIL': '/var/mail/cltbld', 02:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:11 INFO - 'MOZ_NO_REMOTE': '1', 02:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:11 INFO - 'NO_EM_RESTART': '1', 02:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:11 INFO - 'PWD': '/builds/slave/test', 02:52:11 INFO - 'SHELL': '/bin/bash', 02:52:11 INFO - 'SHLVL': '1', 02:52:11 INFO - 'TERM': 'linux', 02:52:11 INFO - 'TMOUT': '86400', 02:52:11 INFO - 'USER': 'cltbld', 02:52:11 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', 02:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:11 INFO - '_': '/tools/buildbot/bin/python'} 02:52:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:52:12 INFO - Installing collected packages: mozsystemmonitor 02:52:12 INFO - Running setup.py install for mozsystemmonitor 02:52:13 INFO - Successfully installed mozsystemmonitor 02:52:13 INFO - Cleaning up... 02:52:13 INFO - Return code: 0 02:52:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:13 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 0xbdf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4ceb0>, '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 0xf4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4e240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', '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 02:52:13 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 02:52:13 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 02:52:13 INFO - Using env: {'DISPLAY': ':0', 02:52:13 INFO - 'HOME': '/home/cltbld', 02:52:13 INFO - 'LANG': 'en_US.UTF-8', 02:52:13 INFO - 'LANGUAGE': 'en_US:en', 02:52:13 INFO - 'LOGNAME': 'cltbld', 02:52:13 INFO - 'MAIL': '/var/mail/cltbld', 02:52:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:13 INFO - 'MOZ_NO_REMOTE': '1', 02:52:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:13 INFO - 'NO_EM_RESTART': '1', 02:52:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:13 INFO - 'PWD': '/builds/slave/test', 02:52:13 INFO - 'SHELL': '/bin/bash', 02:52:13 INFO - 'SHLVL': '1', 02:52:13 INFO - 'TERM': 'linux', 02:52:13 INFO - 'TMOUT': '86400', 02:52:13 INFO - 'USER': 'cltbld', 02:52:13 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', 02:52:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:13 INFO - '_': '/tools/buildbot/bin/python'} 02:52:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:13 INFO - Downloading/unpacking jsonschema==2.5.1 02:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:52:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:52:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:52:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:52: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 02:52: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 02:52: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 02:52: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 02:52:14 INFO - Downloading functools32-3.2.3-2.tar.gz 02:52:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:52:14 INFO - warning: no files found matching '*.txt' 02:52:14 INFO - no previously-included directories found matching 'build' 02:52:14 INFO - no previously-included directories found matching 'dist' 02:52:14 INFO - no previously-included directories found matching '.git*' 02:52:14 INFO - Installing collected packages: jsonschema, functools32 02:52:14 INFO - Running setup.py install for functools32 02:52:14 INFO - warning: no files found matching '*.txt' 02:52:14 INFO - no previously-included directories found matching 'build' 02:52:14 INFO - no previously-included directories found matching 'dist' 02:52:14 INFO - no previously-included directories found matching '.git*' 02:52:14 INFO - Successfully installed jsonschema functools32 02:52:14 INFO - Cleaning up... 02:52:14 INFO - Return code: 0 02:52:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52: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')]} 02:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52: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', '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 0xbdf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4ceb0>, '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 0xf4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4e240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', '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 02:52: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:52: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 functools32==3.2.3-2 02:52:14 INFO - Using env: {'DISPLAY': ':0', 02:52:14 INFO - 'HOME': '/home/cltbld', 02:52:14 INFO - 'LANG': 'en_US.UTF-8', 02:52:14 INFO - 'LANGUAGE': 'en_US:en', 02:52:14 INFO - 'LOGNAME': 'cltbld', 02:52:14 INFO - 'MAIL': '/var/mail/cltbld', 02:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:14 INFO - 'MOZ_NO_REMOTE': '1', 02:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:14 INFO - 'NO_EM_RESTART': '1', 02:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:14 INFO - 'PWD': '/builds/slave/test', 02:52:14 INFO - 'SHELL': '/bin/bash', 02:52:14 INFO - 'SHLVL': '1', 02:52:14 INFO - 'TERM': 'linux', 02:52:14 INFO - 'TMOUT': '86400', 02:52:14 INFO - 'USER': 'cltbld', 02:52:14 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', 02:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:14 INFO - '_': '/tools/buildbot/bin/python'} 02:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:52:15 INFO - Cleaning up... 02:52:15 INFO - Return code: 0 02:52:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:52: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')]} 02:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52: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')]} 02:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52: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 0xbdf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4ceb0>, '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 0xf4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4e240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', '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 02:52: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 02:52: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 02:52:15 INFO - Using env: {'DISPLAY': ':0', 02:52:15 INFO - 'HOME': '/home/cltbld', 02:52:15 INFO - 'LANG': 'en_US.UTF-8', 02:52:15 INFO - 'LANGUAGE': 'en_US:en', 02:52:15 INFO - 'LOGNAME': 'cltbld', 02:52:15 INFO - 'MAIL': '/var/mail/cltbld', 02:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:15 INFO - 'MOZ_NO_REMOTE': '1', 02:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:15 INFO - 'NO_EM_RESTART': '1', 02:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:15 INFO - 'PWD': '/builds/slave/test', 02:52:15 INFO - 'SHELL': '/bin/bash', 02:52:15 INFO - 'SHLVL': '1', 02:52:15 INFO - 'TERM': 'linux', 02:52:15 INFO - 'TMOUT': '86400', 02:52:15 INFO - 'USER': 'cltbld', 02:52:15 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', 02:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:15 INFO - '_': '/tools/buildbot/bin/python'} 02:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:15 INFO - Downloading/unpacking blobuploader==1.2.4 02:52: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 02:52: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 02:52: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 02:52: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 02:52:16 INFO - Downloading blobuploader-1.2.4.tar.gz 02:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:52:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:52: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 02:52: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 02:52: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 02:52: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 02:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:52:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:52: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 02:52: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 02:52: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 02:52: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 02:52:16 INFO - Downloading docopt-0.6.1.tar.gz 02:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:52:16 INFO - Installing collected packages: blobuploader, requests, docopt 02:52:16 INFO - Running setup.py install for blobuploader 02:52:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:52:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:52:17 INFO - Running setup.py install for requests 02:52:17 INFO - Running setup.py install for docopt 02:52:17 INFO - Successfully installed blobuploader requests docopt 02:52:17 INFO - Cleaning up... 02:52:17 INFO - Return code: 0 02:52:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:17 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 0xbdf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4ceb0>, '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 0xf4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4e240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', '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 02:52:17 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 02:52:17 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 02:52:17 INFO - Using env: {'DISPLAY': ':0', 02:52:17 INFO - 'HOME': '/home/cltbld', 02:52:17 INFO - 'LANG': 'en_US.UTF-8', 02:52:17 INFO - 'LANGUAGE': 'en_US:en', 02:52:17 INFO - 'LOGNAME': 'cltbld', 02:52:17 INFO - 'MAIL': '/var/mail/cltbld', 02:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:17 INFO - 'MOZ_NO_REMOTE': '1', 02:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:17 INFO - 'NO_EM_RESTART': '1', 02:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:17 INFO - 'PWD': '/builds/slave/test', 02:52:17 INFO - 'SHELL': '/bin/bash', 02:52:17 INFO - 'SHLVL': '1', 02:52:17 INFO - 'TERM': 'linux', 02:52:17 INFO - 'TMOUT': '86400', 02:52:17 INFO - 'USER': 'cltbld', 02:52:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', 02:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:17 INFO - '_': '/tools/buildbot/bin/python'} 02:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:17 INFO - Running setup.py (path:/tmp/pip-Yw1c4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:17 INFO - Running setup.py (path:/tmp/pip-CiokjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:17 INFO - Running setup.py (path:/tmp/pip-NLlgPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:17 INFO - Running setup.py (path:/tmp/pip-L_5QGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:18 INFO - Running setup.py (path:/tmp/pip-XpBXI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:18 INFO - Running setup.py (path:/tmp/pip-Fr_taW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:18 INFO - Running setup.py (path:/tmp/pip-qopWHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:18 INFO - Running setup.py (path:/tmp/pip-INFofF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:18 INFO - Running setup.py (path:/tmp/pip-7Si4r_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:18 INFO - Running setup.py (path:/tmp/pip-RHWGpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:18 INFO - Running setup.py (path:/tmp/pip-5U1jP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:18 INFO - Running setup.py (path:/tmp/pip-C_IY34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:18 INFO - Running setup.py (path:/tmp/pip-pS_Ft5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:18 INFO - Running setup.py (path:/tmp/pip-Sy6Ydv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:18 INFO - Running setup.py (path:/tmp/pip-DJTvCU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:18 INFO - Running setup.py (path:/tmp/pip-NxP0db-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:18 INFO - Running setup.py (path:/tmp/pip-TSEnBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:52:18 INFO - Running setup.py install for manifestparser 02:52:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:52:19 INFO - Running setup.py install for mozcrash 02:52:19 INFO - Running setup.py install for mozdebug 02:52:19 INFO - Running setup.py install for mozdevice 02:52:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:52:19 INFO - Running setup.py install for mozfile 02:52:19 INFO - Running setup.py install for mozhttpd 02:52:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:52:19 INFO - Running setup.py install for mozinfo 02:52:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:52:19 INFO - Running setup.py install for mozInstall 02:52:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:52:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:52:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:52:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:52:19 INFO - Running setup.py install for mozleak 02:52:19 INFO - Running setup.py install for mozlog 02:52:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:52:19 INFO - Running setup.py install for moznetwork 02:52:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:52:20 INFO - Running setup.py install for mozprocess 02:52:20 INFO - Running setup.py install for mozprofile 02:52:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:52:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:52:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:52:20 INFO - Running setup.py install for mozrunner 02:52:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:52:20 INFO - Running setup.py install for mozscreenshot 02:52:20 INFO - Running setup.py install for moztest 02:52:20 INFO - Running setup.py install for mozversion 02:52:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:52:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:52:20 INFO - Cleaning up... 02:52:20 INFO - Return code: 0 02:52:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:20 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 0xbdf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4ceb0>, '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 0xf4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4e240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', '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 02:52:20 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 02:52:20 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 02:52:20 INFO - Using env: {'DISPLAY': ':0', 02:52:20 INFO - 'HOME': '/home/cltbld', 02:52:20 INFO - 'LANG': 'en_US.UTF-8', 02:52:20 INFO - 'LANGUAGE': 'en_US:en', 02:52:20 INFO - 'LOGNAME': 'cltbld', 02:52:20 INFO - 'MAIL': '/var/mail/cltbld', 02:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:20 INFO - 'MOZ_NO_REMOTE': '1', 02:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:20 INFO - 'NO_EM_RESTART': '1', 02:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:20 INFO - 'PWD': '/builds/slave/test', 02:52:20 INFO - 'SHELL': '/bin/bash', 02:52:20 INFO - 'SHLVL': '1', 02:52:20 INFO - 'TERM': 'linux', 02:52:20 INFO - 'TMOUT': '86400', 02:52:20 INFO - 'USER': 'cltbld', 02:52:20 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', 02:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:20 INFO - '_': '/tools/buildbot/bin/python'} 02:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:52:20 INFO - Running setup.py (path:/tmp/pip-ecbT4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:52: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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:52:21 INFO - Running setup.py (path:/tmp/pip-eW5q07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:52:21 INFO - Running setup.py (path:/tmp/pip-5zE0kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:52:21 INFO - Running setup.py (path:/tmp/pip-CIgFFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:52:21 INFO - Running setup.py (path:/tmp/pip-zXBEXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:52:21 INFO - Running setup.py (path:/tmp/pip-A68jjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:52:21 INFO - Running setup.py (path:/tmp/pip-Jwv177-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:52:21 INFO - Running setup.py (path:/tmp/pip-jgNx4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:52:21 INFO - Running setup.py (path:/tmp/pip-ziWX2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:52:21 INFO - Running setup.py (path:/tmp/pip-KG5xJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:52:21 INFO - Running setup.py (path:/tmp/pip-J25Q3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:52:21 INFO - Running setup.py (path:/tmp/pip-Du554U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:52:21 INFO - Running setup.py (path:/tmp/pip-G7Zu1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:52:21 INFO - Running setup.py (path:/tmp/pip-BrFW2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:52:21 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)) 02:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:52:21 INFO - Running setup.py (path:/tmp/pip-V64hLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:52: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)) 02:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:52:22 INFO - Running setup.py (path:/tmp/pip-NsoH4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:52:22 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)) 02:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:52:22 INFO - Running setup.py (path:/tmp/pip-4OOAI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:52:22 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)) 02:52:22 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)) 02:52:22 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)) 02:52:22 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)) 02:52:22 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)) 02:52:22 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)) 02:52:22 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)) 02:52:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:52:22 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 02:52:22 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 02:52:22 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 02:52:22 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 02:52:23 INFO - Downloading blessings-1.6.tar.gz 02:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:52:23 INFO - Installing collected packages: blessings 02:52:23 INFO - Running setup.py install for blessings 02:52:23 INFO - Successfully installed blessings 02:52:23 INFO - Cleaning up... 02:52:23 INFO - Return code: 0 02:52:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:52:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:23 INFO - Reading from file tmpfile_stdout 02:52:23 INFO - Current package versions: 02:52:23 INFO - argparse == 1.2.1 02:52:23 INFO - blessings == 1.6 02:52:23 INFO - blobuploader == 1.2.4 02:52:23 INFO - docopt == 0.6.1 02:52:23 INFO - functools32 == 3.2.3-2 02:52:23 INFO - jsonschema == 2.5.1 02:52:23 INFO - manifestparser == 1.1 02:52:23 INFO - mozInstall == 1.13 02:52:23 INFO - mozcrash == 1.0 02:52:23 INFO - mozdebug == 0.1 02:52:23 INFO - mozdevice == 0.51 02:52:23 INFO - mozfile == 1.2 02:52:23 INFO - mozhttpd == 0.7 02:52:23 INFO - mozinfo == 0.10 02:52:23 INFO - mozleak == 0.1 02:52:23 INFO - mozlog == 3.5 02:52:23 INFO - moznetwork == 0.27 02:52:23 INFO - mozprocess == 0.25 02:52:23 INFO - mozprofile == 0.28 02:52:23 INFO - mozrunner == 6.13 02:52:23 INFO - mozscreenshot == 0.1 02:52:23 INFO - mozsystemmonitor == 0.3 02:52:23 INFO - moztest == 0.8 02:52:23 INFO - mozversion == 1.4 02:52:23 INFO - psutil == 3.1.1 02:52:23 INFO - requests == 1.2.3 02:52:23 INFO - wsgiref == 0.1.2 02:52:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:23 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 0xbdf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4ceb0>, '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 0xf4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4e240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', '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 02:52:23 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 02:52:23 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 02:52:23 INFO - Using env: {'DISPLAY': ':0', 02:52:23 INFO - 'HOME': '/home/cltbld', 02:52:23 INFO - 'LANG': 'en_US.UTF-8', 02:52:23 INFO - 'LANGUAGE': 'en_US:en', 02:52:23 INFO - 'LOGNAME': 'cltbld', 02:52:23 INFO - 'MAIL': '/var/mail/cltbld', 02:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:23 INFO - 'MOZ_NO_REMOTE': '1', 02:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:23 INFO - 'NO_EM_RESTART': '1', 02:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:23 INFO - 'PWD': '/builds/slave/test', 02:52:23 INFO - 'SHELL': '/bin/bash', 02:52:23 INFO - 'SHLVL': '1', 02:52:23 INFO - 'TERM': 'linux', 02:52:23 INFO - 'TMOUT': '86400', 02:52:23 INFO - 'USER': 'cltbld', 02:52:23 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', 02:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:23 INFO - '_': '/tools/buildbot/bin/python'} 02:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:23 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)) 02:52:23 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)) 02:52:23 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)) 02:52:23 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)) 02:52:23 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)) 02:52:23 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)) 02:52:23 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)) 02:52:23 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)) 02:52:23 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)) 02:52:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:52: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 02:52: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 02:52: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 02:52: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 02:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:52:25 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)) 02:52:25 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)) 02:52:25 INFO - Installing collected packages: simplejson 02:52:25 INFO - Running setup.py install for simplejson 02:52:25 INFO - building 'simplejson._speedups' extension 02:52:25 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 02:52:26 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 02:52:26 INFO - Successfully installed simplejson 02:52:26 INFO - Cleaning up... 02:52:26 INFO - Return code: 0 02:52:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:52:26 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')]} 02:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:52:26 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')]} 02:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:52:26 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 0xbdf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdaca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf4fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf4ceb0>, '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 0xf4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4e240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', '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 02:52:26 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 02:52:26 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 02:52:26 INFO - Using env: {'DISPLAY': ':0', 02:52:26 INFO - 'HOME': '/home/cltbld', 02:52:26 INFO - 'LANG': 'en_US.UTF-8', 02:52:26 INFO - 'LANGUAGE': 'en_US:en', 02:52:26 INFO - 'LOGNAME': 'cltbld', 02:52:26 INFO - 'MAIL': '/var/mail/cltbld', 02:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:26 INFO - 'MOZ_NO_REMOTE': '1', 02:52:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:26 INFO - 'NO_EM_RESTART': '1', 02:52:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:26 INFO - 'PWD': '/builds/slave/test', 02:52:26 INFO - 'SHELL': '/bin/bash', 02:52:26 INFO - 'SHLVL': '1', 02:52:26 INFO - 'TERM': 'linux', 02:52:26 INFO - 'TMOUT': '86400', 02:52:26 INFO - 'USER': 'cltbld', 02:52:26 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', 02:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:26 INFO - '_': '/tools/buildbot/bin/python'} 02:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:52:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:52:26 INFO - Cleaning up... 02:52:26 INFO - Return code: 0 02:52:26 INFO - Running post-action listener: _resource_record_post_action 02:52:26 INFO - Running post-action listener: _start_resource_monitoring 02:52:26 INFO - Starting resource monitoring. 02:52:26 INFO - [mozharness: 2017-08-06 09:52:26.627886Z] Finished create-virtualenv step (success) 02:52:26 INFO - [mozharness: 2017-08-06 09:52:26.628893Z] Running install step. 02:52:26 INFO - Running pre-action listener: _resource_record_pre_action 02:52:26 INFO - Running main action method: install 02:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:52:26 INFO - Reading from file tmpfile_stdout 02:52:26 INFO - Detecting whether we're running mozinstall >=1.0... 02:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:52:26 INFO - Reading from file tmpfile_stdout 02:52:27 INFO - Output received: 02:52:27 INFO - Usage: mozinstall [options] installer 02:52:27 INFO - Options: 02:52:27 INFO - -h, --help show this help message and exit 02:52:27 INFO - -d DEST, --destination=DEST 02:52:27 INFO - Directory to install application into. [default: 02:52:27 INFO - "/builds/slave/test"] 02:52:27 INFO - --app=APP Application being installed. [default: firefox] 02:52:27 INFO - mkdir: /builds/slave/test/build/application 02:52:27 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'] 02:52:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:52:44 INFO - Reading from file tmpfile_stdout 02:52:44 INFO - Output received: 02:52:44 INFO - /builds/slave/test/build/application/firefox/firefox 02:52:44 INFO - Running post-action listener: _resource_record_post_action 02:52:44 INFO - [mozharness: 2017-08-06 09:52:44.955719Z] Finished install step (success) 02:52:44 INFO - [mozharness: 2017-08-06 09:52:44.955975Z] Running setup-mitmproxy step. 02:52:44 INFO - Running pre-action listener: _resource_record_pre_action 02:52:44 INFO - Running main action method: setup_mitmproxy 02:52:44 INFO - Skipping: mitmproxy is not required 02:52:44 INFO - Running post-action listener: _resource_record_post_action 02:52:44 INFO - [mozharness: 2017-08-06 09:52:44.957100Z] Finished setup-mitmproxy step (success) 02:52:44 INFO - [mozharness: 2017-08-06 09:52:44.957333Z] Running run-tests step. 02:52:44 INFO - Running pre-action listener: _resource_record_pre_action 02:52:44 INFO - Running pre-action listener: _set_gcov_prefix 02:52:44 INFO - Running main action method: run_tests 02:52:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:52:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:52:44 INFO - Python 2.7.3 02:52:44 INFO - Return code: 0 02:52:44 INFO - grabbing minidump binary from tooltool 02:52:44 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')]} 02:52:44 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 0xf4ceb0>, '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 0xf4ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf4e240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:52:44 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 02:52:44 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 02:52:44 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 02:52:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:52:45 INFO - Return code: 0 02:52:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:52:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:52:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:52:45 INFO - ENV: RUST_BACKTRACE is now 1 02:52:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:52:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 02:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 02:52:45 INFO - Using env: {'DISPLAY': ':0', 02:52:45 INFO - 'HOME': '/home/cltbld', 02:52:45 INFO - 'LANG': 'en_US.UTF-8', 02:52:45 INFO - 'LANGUAGE': 'en_US:en', 02:52:45 INFO - 'LOGNAME': 'cltbld', 02:52:45 INFO - 'MAIL': '/var/mail/cltbld', 02:52:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:52:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:52:45 INFO - 'MOZ_NO_REMOTE': '1', 02:52:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:52:45 INFO - 'NO_EM_RESTART': '1', 02:52:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:52:45 INFO - 'PWD': '/builds/slave/test', 02:52:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:52:45 INFO - 'RUST_BACKTRACE': '1', 02:52:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:52:45 INFO - 'SHELL': '/bin/bash', 02:52:45 INFO - 'SHLVL': '1', 02:52:45 INFO - 'TERM': 'linux', 02:52:45 INFO - 'TMOUT': '86400', 02:52:45 INFO - 'USER': 'cltbld', 02:52:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557', 02:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:52:45 INFO - '_': '/tools/buildbot/bin/python'} 02:52:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 02:52:45 INFO - mozversion application_buildid: 20170806090558 02:52:45 INFO - mozversion application_changeset: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c 02:52:45 INFO - mozversion application_display_name: Nightly 02:52:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:52:45 INFO - mozversion application_name: Firefox 02:52:45 INFO - mozversion application_remotingname: firefox 02:52:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:52:45 INFO - mozversion application_vendor: Mozilla 02:52:45 INFO - mozversion application_version: 57.0a1 02:52:45 INFO - mozversion platform_buildid: 20170806090558 02:52:45 INFO - mozversion platform_changeset: fe6609d22dfdd710b11e3ac7773aff89f7a8d12c 02:52:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:52:45 INFO - mozversion platform_version: 57.0a1 02:52:45 INFO - using testdate: 1502013165 02:52:45 INFO - actual date: 1502013165 02:52:45 INFO - starting webserver on 'localhost:47135' 02:52:45 INFO - SUITE-START | Running 2 tests 02:52:45 INFO - TEST-START | dromaeo_css 02:52:45 INFO - Initialising browser for dromaeo_css test... 02:52:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47135/getInfo.html -profile /tmp/tmpE8C3NL/profile 02:52:45 INFO - TEST-INFO | started process 3438 (/builds/slave/test/build/application/firefox/firefox http://localhost:47135/getInfo.html) 02:52:53 INFO - TEST-INFO | 3438: exit 0 02:52:54 INFO - Browser initialized. 02:52:54 INFO - Running cycle 1/1 for dromaeo_css test... 02:52:54 INFO - TEST-INFO | started process 3649 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE8C3NL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:52:55 INFO - PID 3649 | 02:52:55 INFO - PID 3649 | (/builds/slave/test/build/application/firefox/firefox:3697): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:52:55 INFO - PID 3649 | 02:53:05 INFO - PID 3649 | RSS: Main: 170885120 02:53:05 INFO - PID 3649 | 02:56:05 INFO - PID 3649 | Cycle 1(1): loaded http://localhost:47135/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47135/tests/dromaeo/cssquery-ext.html) 02:56:06 INFO - PID 3649 | RSS: Main: 172748800 02:56:06 INFO - PID 3649 | 02:59:07 INFO - PID 3649 | Cycle 1(1): loaded http://localhost:47135/tests/dromaeo/cssquery-ext.html (next: http://localhost:47135/tests/dromaeo/cssquery-jquery.html) 02:59:08 INFO - PID 3649 | RSS: Main: 170582016 02:59:08 INFO - PID 3649 | 03:02:10 INFO - PID 3649 | Cycle 1(1): loaded http://localhost:47135/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47135/tests/dromaeo/cssquery-mootools.html) 03:02:10 INFO - PID 3649 | RSS: Main: 172187648 03:02:10 INFO - PID 3649 | 03:05:12 INFO - PID 3649 | Cycle 1(1): loaded http://localhost:47135/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47135/tests/dromaeo/cssquery-prototype.html) 03:05:13 INFO - PID 3649 | RSS: Main: 171069440 03:05:13 INFO - PID 3649 | 03:08:17 INFO - PID 3649 | Cycle 1(1): loaded http://localhost:47135/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47135/tests/dromaeo/cssquery-yui.html) 03:08:17 INFO - PID 3649 | RSS: Main: 174305280 03:08:17 INFO - PID 3649 | 03:11:19 INFO - PID 3649 | Cycle 1(1): loaded http://localhost:47135/tests/dromaeo/cssquery-yui.html (next: http://localhost:47135/tests/dromaeo/cssquery-dojo.html) 03:11:19 INFO - PID 3649 | RSS: Main: 175026176 03:11:19 INFO - PID 3649 | 03:11:19 INFO - PID 3649 | __start_tp_report 03:11:19 INFO - PID 3649 | _x_x_mozilla_page_load 03:11:19 INFO - PID 3649 | _x_x_mozilla_page_load_details 03:11:19 INFO - PID 3649 | |i|pagename|runs| 03:11:19 INFO - PID 3649 | |0;dojo.html;3129.4992801151816;3158.7315078218367;3183.952240716388;3198.824064676442;3226.709596136347;6192.566520343577;6303.621782693036;6319.052142178675;6327.588706734059;6350.333215012426;6166.814995550129;6232.657203853786;6259.62442253464;6292.590981586193;6323.051542268662;5740.024195886688;5747.3677895431465;5750.3962083981205;5769.596128271022;5806.59353845231;5748;5754.309482862062;5884.176215329857;5891.911621325684;5902.911456328137;5757.510611597998;5824.271966004249;5838.182654428383;5838.4453476919625;5889.1755154278435;5578.3584887738025;5737.684427356494;5815.447532484407;5819.214406055171;5893.941060589382;5673.886522269573;5695.572832037614;5710.971445142789;5772.6536407815665;5796.362400135981;6225.377462253784;6242.750289988395;6263.467605253559;6290.025046117859;6305;6678.699458524378;6684.398404143651;6739.494537909627;6743.123393958803;6824.761133360308;6727.529072964894;6770.559913605649;6803.081583986148;6828.863422731567;6831.487638427137;6344.397282258178;6354.269259035178;6383.425491705769;6387.073874288202;6408.10286559882;6910.378065973986;6969.059177011039;6971.058907047585;7043.013978043078;7055.906334518158;6520.510961677893;6613.570117942319;6657;6672.099266599044;6747.257801641816;6711.127553418024;6758.05387245786;6787.728490860409;6790.354916282945;6800.31996800316;6686.130802995676;6708.161479815023;6772.864542709118;6775.644871025716;6781.966090169616;6736.93263067363;6753.729850806011;6832.043513908056;6833.931660683429;6833.965830170917;5347.41178470368;5430.56555475561;5432.402435732066;5444.50999410055;5507.697076660742;4629.953700462952;4636.235021221461;4641.6054635355695;4645.721256724607;4651.186042442559;5720.1991721159075;5740.770369185269;5749.913751293734;5763.3084029915835;5826.242588463472;6874.690638921261;6887.380135787803;6904.033435319059;6910.930890691129;6933.93066069343;5789.334226563999;5827.213326200908;5849.88300233993;5859.414058594107;5878.647281163144;5845.707714614252;5921.822345329647;5953.880922381615;6017.458428741435;6027.6684782336515;6558.639274839834;6563.278039415661;6565.441937435371;6578.27638959714;6581.078648989145;6774.390304872585;6860.176778786577;6861.382475577222;6862.588244705334;6863.176418829772;6546.312637173029;6548.0832683425315;6616.305287944889;6628.701708423229;6635.236947750877;6687.331266873468;6743.055972163803;6750.122484077038;6753.493487988322;6754.054432379373;6766.424853887278;6788.389044985975;6801.2178599461695;6852.897206542006;6862.828429289308;6425.228972523327;6447.709853056717;6540.705668244846;6579.539432239889;6674.83312917181;6604.669766511559;6612.437942774918;6612.669366531558;6612.834679132868;6650.135482387259;6440.581362211441;6501.1548498694865;6567.835804104936;6588.637624930675;6589.7364105435245;6566.6388348641285;6582.802515924338;6587;6675.632840193836;6686.398224159849;6299.149614801943;6364.554481186457;6371.044343348535;6372.745090196526;6426.518011149089 03:11:19 INFO - PID 3649 | |1;ext.html;816.1389733830806;834.3408707121373;878.5431575580698;880.4057261348593;1164.6564263542255;31663.208419789516;33234.33531329375;43974.12051758967;44263.336049959275;44295;45828.54171458285;46402.303965440464;46511;46571.534284657144;46614.300785488245;7912.564808935521;8001.279884810366;8043.436959412844;8069.556174410405;8077.919220807776;7551;7627.8855817162785;7634.12207596128;7650.464467487278;7725.8068548286465;7695.653695583712;7726.150123486412;7761.573113478757;7763.534187948713;7763.961180194091;7636.236376362319;7670.501417407851;7692.153863075057;7736.458447908677;7736.535807851547;7751.612419379008;7766.495177813424;7889.684412623488;7894.3289820365335;7896.605169741548;40901.795491022356;41355.58644413547;41359;41389.1722165558;41404.1719165615;3570.839312230956;3617.457381392786;3620.8008559529217;3621.5473065866768;3623.3840247158046;32191.83904080488;32784;32807;32829.671703282904;32834.50748238778;5024.497550244982;5044.092063428581;5085.516875896784;5114.820981265638;5133.435322114565;191469.9999999986;192125;192331;193025;193205;50886;50970.23544646833;51067;52054;52999.73500132475;54013;54077.72961135169;54193.45806541884;54214.186787198225;54549.72725136428;16649.583760406087;16946.745798813026;16981.066041367845;16992.91503542499;17166.65666686659;13665.453381864614;13766.518171863936;13780.65548361299;13782.724345513234;13787.310634468236;15069.698606028038;15087.4719384821;15125.924370378078;15145.242737863064;15237.542873713806;5912.23140991677;5914.467697907209;5997.13041608973;6030.788922387783;6056.424639659225;998.3710262534556;1030.6598822388594;1039.589362201926;1044.7074819050679;1049.0872940541624;23449.531009379716;23609.40976475602;23710.288691339287;23717;23882.880585596962;1132.7621199548023;1141.6917432293235;1147.3402793393832;1148.942552872353;1158.252926862186;12303.815442768366;12425.689357766129;12452.252864828139;12555.435005424777;12589.874101259053;226926;229047;229339;239538;247044;60147.39852601418;60358.39641603528;60474;60485.69757151186;60673.69663151656;1477.2023107521818;1500.0324790510278;1513.0921447131634;1513.4627207341234;1530.540837748671;27417.90328386842;28065.57901631518;28510.57234141448;28577.714222857507;28614.57078143871;37797.24405511819;38014.23971520499;38022.23955520819;38106.61893381141;38201.044973875876;193269;193365;193378;193547;194244;35399.82300088483;36504.26991460209;36548.26903461969;36555.81722091373;36632.15362386911;45584.316235255836;45793.54206458026;46019.07961840677;46091.539084608725;46115;32904.34191316208;33397;37807.43288850725;39083.80458097691;39493.80253098716;38157;38390.42414363731;38412.2317553653;38495.80752096222;38666.42000369941;42584.14831703411;42751.3587296197;43079;43119;43866.342004869315;44281;44335.33496997483;44466.77766611146;44477.4418046549;45383.319250211935;25886.48227035411;25981.74018259869;26067.608985865605;26150.34624134412;26516.33709157209 03:11:19 INFO - PID 3649 | |2;jquery.html;576.8875069361471;584.6871923520914;585.9384764599714;601.843520684622;602.5601311042938;21826.672599910995;22784.544309113808;22802.88598557007;22874.77125228745;23940.880295598497;25875.48249035023;26567.73432265677;26588.468230635375;26589.202323930265;26636.866815665944;6469.126667899832;6588;6618.139641846553;6623.304553021935;6775.62734049627;7008.264132266115;7040.683169257396;7043.823904402405;7058.85882282354;7058.894116588255;7021.473389495783;7024.508284420092;7031.789046328593;7052.977318288845;7062.364387205151;6964.721411143548;6981;7019.964900175518;7045.365917067463;7055.611941343224;6873.518853680244;6880.2431732509385;6895.413889819321;6902.413294869942;6911.827204319882;30902.22744431407;33952.151196220046;34029.14927126817;34036.31927361439;34057.14857128567;1962.077823423003;1966.5083729067733;1972.7928567500348;1977.13006277239;1990.7312512810875;20814.687779683318;20902.686459703116;21613.56772864534;21737.130514779547;21864.23475178361;2567.460833225025;2589.5338839008973;2622.9213123606323;2641.5641419165813;2652.2175958092407;140607.29696351453;146222;146329;146480;146803;21057.789422105583;21661.241856534947;21984.45038874041;22370.302236530184;22984.4253893654;45198;45282.05666631724;45436.091278174914;45444.50055246993;45577.77211113989;12023.879761202275;12185.756284874431;12362.320072396105;12379.133460657667;12386.194897331825;8604.956975215084;9064.50145242018;9467.337286389886;10064.345817521838;10529.894021195638;11890.940545297392;12059.311696362516;12199.231111488962;12443.626691199279;12563.93718031404;4026.697997650188;4329.242382583036;4588.6099681526775;4592.563706447949;4693.577578017995;963.3689933093834;984.4929861121528;986.8125056239435;992.9205663547043;995.9502024898726;19035.42893713163;19666.31167909145;19973.500662483555;20219.090140943397;20324.593508129754;1049.9842502362471;1051.8211903976342;1052.1162223732101;1059.8357254625546;1060.6075751971666;10918.563257469772;11193.552257909756;11273.98081534769;11297.774044519063;11523.790002049664;457534;472017;473328;474455;498479;116943;121036.39481802535;121264.39367803281;121696;122006.99999999822;1197.0782497476894;1206.9577564785366;1222.4560070768423;1227.9386030698608;1231.5751065882257;17684.292628294723;17751.911240443715;17989.820101798814;18019.008954507102;18204.72692909581;56790;57085;57461.712691436274;57592.4240757587;58903.705481472316;71675.64162179155;72133;76973.61513192399;80748.59625701833;80965;14926.925365373103;15467.922660386626;15530.61173470627;15531.06813591188;15558.144302063496;23994.40013999664;24507.38731531726;24702.25893223206;24744.505109898062;24885.62671559892;18526.62946741031;18646.347377842252;18991.33530326432;19172.328968486036;19250.326238581583;17240.137993100045;17605.911970440065;17619.471415857544;17940.28238870483;18278.451646450627;19624;19711.310104146287;19781.70327445118;19892.70160947616;19914.90042549778;14497.420103195755;15128.319225635092;15301.770473442684;15329.693406132037;15386.9230653846;19548.21807127699;19565.413037608894;19601.509962251057;19798;19800.405987820388 03:11:19 INFO - PID 3649 | |3;mootools.html;1369.6301998460417;1422.2533170085703;1427.9286035698212;1429.5211104280065;1433.2761955212616;13559.593212203637;14129.081609695362;14174.929125354385;14223.644408889782;14233.501827436041;13030.153040052413;13431.865681343184;13803.585892423218;13858.722825543484;13881;2517.156752487914;2570.498752743216;2570.807189460789;2571.3571607098224;2574.613807928816;2430.8176886733477;2478.4051827561348;2536.7336429674897;2553.8212325137247;2604.1406335909105;2534.3664083979006;2555.8722063896826;2560.2319304208754;2561.5517284475236;2564.871756412181;2477.318737347235;2513.899444022237;2519.067944860404;2526.418923647562;2601.310652677042;2483.5405449991626;2487.1543675150538;2501.6622755927897;2502.2368177705794;2506.5362907861922;13682.04225704201;13753.312334383241;13911.652208694763;13916.165030098227;13922.09506382082;7517.210692877224;7775.727849525239;7783.649735761847;7786.454948153631;7787.688492460295;4876.561109500162;5015.5736762375245;5043.470435604282;5126.179811230222;5187.559057480119;1791.6327152933618;1807.4577626711934;1827.570520927581;1856.7771867375866;1861.972070418945;22925.312240632808;23177.420564486023;23459.530809383887;23500.647490287658;23554.646680299807;6976.232614412411;6987.161540615057;7020.139662989312;7166.641667916583;7169.5698258104685;18328.083595820157;18377.17302721381;18401.81598184001;18412.539686507946;18416.723749143774;7587.430942679322;7822.765317040498;7824.139344672081;7851.489653172525;7856.214378562098;6771.255161932184;7086.681099350541;7088.964555177191;7091;7093.964530177316;5154.793808247703;5347.2781174541715;5363.356397232279;5368.3826359968325;5588.993981083444;1385.5496963486908;1391.2070120031688;1550.093195480634;1573.3156077106496;1589.785378973847;880.1726377205534;906.7687739626485;922.8754118194092;925.3337596930199;954.2413781044087;7998.920010799934;8046.758597242092;8091.19088091198;8152.347812175011;8504.404691671647;996.6511720897773;1009.5154325923597;1019.9031092046243;1023.7696518283327;1041.6458404142477;4941.876453088702;5090.49095090488;5123.949590333973;5234.659747116425;5270.578353731692;18254.817451825576;19390.903045484683;19448.319308824124;19662.311819086262;19747.901260493894;18599.721004184947;19160.137793799313;19260.518487037654;19336.70994935077;19598.216071356987;10281.485925703684;10706.197035222234;10771.946140269249;10822.242443028912;10953.507092180871;7882.344707611466;7927.088384835818;8085.676572937016;8118.3099436548555;8221.753347399588;16719.665606688042;16908.154592270585;17197;17612.29550817953;17656.82343176603;17292.481225563253;17294.913525432294;17395.30418783285;17427.128643568023;17474.82525174732;10423.791524169626;10581.418022008556;10639.627613033506;10642.04221620058;10649.787004259717;12642;12788.744225115632;12959.416826242654;12997.48010079624;13052.869471305545;10757.085647720032;10766.515506802056;10766.930781880637;10898;11051.83422248683;10447.843282350923;10540.578376865145;10599.682009539727;10613.681589552325;10827.350358978487;9322.766930826512;9505.382150160218;9523.952380238054;9524.904750952403;9528.714138575853;6667.866642667216;6672.532922695559;6711.362420570038;6746.5277430581355;6748.797536073926;6752.122224110834;6753;6816.454683625199;6854.565052496962;6932.341427564374 03:11:19 INFO - PID 3649 | |4;prototype.html;496.78141617688226;500.8172017213718;517.6298946253429;524.8504176309752;534.462864820855;6255.749770009205;6275.278342990552;6340.463814474213;6363.204599425072;6363.331850155736;5870.354261031283;6151.569390142692;6154.261488621371;6193.597416167946;6199.721012554434;4915.434725006634;4945.505449455044;4957.851264462054;4981.103401387749;4990.30135780991;4945.4065512138595;4952.306677065214;5001.199808030716;5005.57452616528;5018;4763.714177149365;4930.580900623451;4994.825181118662;5010.920468005773;5013.674111182761;4897.583705385046;4943.159662857305;4975.154223781966;4990.25146228065;5018.623603229772;4476.753778542179;4495.57292057254;4496;4510.323451482304;4512.661550383735;5896.97051514744;5998.130271110665;6005.909911351333;6020.5785595008365;6086.7565297388055;5713.857153571153;5727.341355744101;5754;5764.394738552433;5793.8841223175305;6447.194100737408;6458.580192287486;6519.608823470607;6527.249366322886;6586.7035983380865;4837.758112094381;4881.4630390657;4891.51084891508;4906.1168989581865;4910.238912968495;6825.931740682579;6899.896501552481;6910.481713871379;6919.135108111486;6956.443484521226;5025.773840177201;5048.848534543969;5066.138756411419;5095.80248641569;5150.8969820604125;5055.469175736568;5083.220872694601;5088.109580823341;5142.202958541432;5142.228665700175;5712.600117991784;5716;5752.3097228332035;5785.50823180026;5802.419758024248;6523.575967562093;6651.900221496681;6698.263191048981;6731.966340168267;6741.1910570731825;1656.7514872769182;1698.2338368097287;1727.3004433204571;1727.4126796889118;1787.830156135165;1199.8140288255333;1227.128738595607;1233.6669099343308;1235.3576140406938;1254.7866862633375;5648.322201335866;5667.603267771299;5697.971510142423;5708.9714551427805;5716.828495145152;6488.416042556192;6502.642354670538;6515.283318834924;6562.737490500326;6638.037484564711;5588.86027849307;5601.7759289628775;5633.802816901389;5663.150527420919;5712.171735098387;3480.773749706261;3497.755157138976;3509.9298014039578;3510.315488479722;3545.5922568904907;6449.613023218528;6453.290138084807;6453.677316134174;6453.806385808433;6538.300041989022;6754.493412994045;6758.864822703518;6835.73538895306;6868.416184624363;6897.275786042494;6442.742290308335;6444.323346048597;6466;6478.255000674889;6495.740170393131;6629.359448386245;6676.298988606321;6676.9666151668935;6683.920220632257;6704.541479915802;6557.96721016411;6566.310537393696;6581.2102547694585;6621.96060403144;6696.7656132035145;6328.114064030948;6349.936500634934;6400.39196276353;6415.294317625151;6439;5022.397312322545;5026.924596131134;5045.520675535819;5053.29253904461;5054.649587941625;6668.499862510428;6678.83302917431;6688.398044176048;6716.3955244028275;6746.730130794714;6364.109024736633;6385.616862988049;6488.156539649815;6502.187226596676;6558.967205163944;6384.968075159594;6389.48884089281;6395.5203359747275;6494.837629059122;6545.934540654533;5986.191864098291;6398.93601064002;6417.7753778617525;6439.1706220334745;6517.837054073686;6493.610383377012;6512.73949042033;6570.408663220333;6602.306757790555;6638.435732962752;6092.177556030057;6256.249250089836;6306;6327.367263273636;6454.1609590752905 03:11:19 INFO - PID 3649 | |5;yui.html;905.1672461335571;908.9045650206729;931.8835145606799;934.1685899549402;938.2634631814027;19327.903360483197;20143.093560789763;20160.09279582419;20178.39464816056;22538;22269.331920042383;22880.427989300275;23001.4249643759;23045;23167.884160579215;1027.1423361493162;1053.383770494258;1054.5518154784224;1054.8048611006989;1056.587930707025;1062.760878802271;1064.5262858028182;1064.872215334157;1065.6003998500562;1065.8294672852346;1005.1054561440324;1067.4662668665667;1072.8551645527832;1073.2219141122662;1134.6369161868206;1058.820000599896;1065.8720953485554;1067.4342598422809;1067.8451624514441;1068.5779117248721;792.9484583502054;795.3239746215728;796.5658715999793;797.4896066517433;798.0622768247287;20110.79889201104;20513.4871628209;20565.4858628534;20719.27482538119;20820.79179208219;21731;22384.21655242075;22760.886195568917;22904.427389315402;22921.312360629207;17033.7444938326;17060.82939170617;17244.56888577783;17391.65216695659;17394.47816565505;3637.618050104754;3667.8716244931566;3669.7064234861145;3670.596234414212;3674.9816250918843;128690;129160.54197290192;129581;131261;134838.999999999;17660.205290761947;17752.644947100987;18378.264869405342;18458.261669533338;18503.167357468945;32300.838495807842;33103.83448082744;33272.66727332696;33588.3282334352;33759.66240337614;8046.959765201136;8573.528455934858;8774.561271936378;9080.455172689659;9326.860097098548;4462.464504259509;4552.590266875997;4552.863414097583;4554.476235232924;4559.498455169929;5325.573954083741;5355.812546560852;5387.622866399314;5436.537894278951;5446.591505637093;1049.6483677967967;1055.7255113670346;1065.3554599467366;1071.3197119828965;1072.404815327485;556.1851886985586;573.2146958666654;579.7478097027722;588.6409290332894;593.1221791748237;11222.887771122185;11412.714682132848;11700.70748231301;11816.763664726657;12057.216280941886;569.396439773841;573.3549756523911;576.6338375131737;581.8487193329764;583.629395333966;5118.948810511922;5156.587473002151;5238.423773384925;5360.356757189084;5520.06158952979;101971;104222.47888760507;107490;109200;111138;91941;95564;97222;97626.5118674402;99146.5042674782;82404.58797705972;86283;87358.56320718356;87912;90318;11007.229493935669;11092.279001864854;11102.2783519071;11193.776124477303;11934;37304.25391492209;37708.2458350826;39534;40028.39957400583;40308.798456008706;66404;68555;68756.31243687498;71957.6402117986;72155.63922180566;17170.656586867943;17677.734833977756;17683.557911052325;17726.734098988785;18059.187336569623;18905.621887562447;19092.713609295595;19447.8055219446;20364.796352036883;20421.183152673726;17406.564835879206;17555.561110971816;17984.460466186036;18076.81923180804;18146.81853181451;18456.815431846047;18716.344927927457;19035.904820476364;19043.90478047601;19060.61878762389;16599.253033613273;17014.74477882808;17105.315787368865;17580.20889060021;17672.381466648607;12021.699457513632;12591.68520786951;12677.8098328527;12777.297248651414;13079.869201307865;11546.538138474367;11745.765084698087;12548.623541293775;13295.734085318047;13464.93267533656 03:11:19 INFO - PID 3649 | __end_tp_report 03:11:19 INFO - PID 3649 | __start_cc_report 03:11:19 INFO - PID 3649 | _x_x_mozilla_cycle_collect,386 03:11:19 INFO - PID 3649 | __end_cc_report 03:11:19 INFO - PID 3649 | __startTimestamp1502014279618__endTimestamp 03:11:19 INFO - PID 3649 | 03:11:19 INFO - PID 3649 | ------- Summary: start ------- 03:11:19 INFO - PID 3649 | Number of tests: 6 03:11:19 INFO - PID 3649 | 03:11:19 INFO - PID 3649 | [#0] dojo.html Cycles:165 Average:6228.46 Median:6447.71 stddev:748.95 (11.6%) stddev-sans-first:710.69 03:11:19 INFO - PID 3649 | Values: 3129.5 3158.7 3184.0 3198.8 3226.7 6192.6 6303.6 6319.1 6327.6 6350.3 6166.8 6232.7 6259.6 6292.6 6323.1 5740.0 5747.4 5750.4 5769.6 5806.6 5748.0 5754.3 5884.2 5891.9 5902.9 5757.5 5824.3 5838.2 5838.4 5889.2 5578.4 5737.7 5815.4 5819.2 5893.9 5673.9 5695.6 5711.0 5772.7 5796.4 6225.4 6242.8 6263.5 6290.0 6305.0 6678.7 6684.4 6739.5 6743.1 6824.8 6727.5 6770.6 6803.1 6828.9 6831.5 6344.4 6354.3 6383.4 6387.1 6408.1 6910.4 6969.1 6971.1 7043.0 7055.9 6520.5 6613.6 6657.0 6672.1 6747.3 6711.1 6758.1 6787.7 6790.4 6800.3 6686.1 6708.2 6772.9 6775.6 6782.0 6736.9 6753.7 6832.0 6833.9 6834.0 5347.4 5430.6 5432.4 5444.5 5507.7 4630.0 4636.2 4641.6 4645.7 4651.2 5720.2 5740.8 5749.9 5763.3 5826.2 6874.7 6887.4 6904.0 6910.9 6933.9 5789.3 5827.2 5849.9 5859.4 5878.6 5845.7 5921.8 5953.9 6017.5 6027.7 6558.6 6563.3 6565.4 6578.3 6581.1 6774.4 6860.2 6861.4 6862.6 6863.2 6546.3 6548.1 6616.3 6628.7 6635.2 6687.3 6743.1 6750.1 6753.5 6754.1 6766.4 6788.4 6801.2 6852.9 6862.8 6425.2 6447.7 6540.7 6579.5 6674.8 6604.7 6612.4 6612.7 6612.8 6650.1 6440.6 6501.2 6567.8 6588.6 6589.7 6566.6 6582.8 6587.0 6675.6 6686.4 6299.1 6364.6 6371.0 6372.7 6426.5 03:11:19 INFO - PID 3649 | 03:11:19 INFO - PID 3649 | [#1] ext.html Cycles:180 Average:39552.68 Median:38295.73 stddev:53836.91 (140.6%) stddev-sans-first:53909.36 03:11:19 INFO - PID 3649 | Values: 816.1 834.3 878.5 880.4 1164.7 31663.2 33234.3 43974.1 44263.3 44295.0 45828.5 46402.3 46511.0 46571.5 46614.3 7912.6 8001.3 8043.4 8069.6 8077.9 7551.0 7627.9 7634.1 7650.5 7725.8 7695.7 7726.2 7761.6 7763.5 7764.0 7636.2 7670.5 7692.2 7736.5 7736.5 7751.6 7766.5 7889.7 7894.3 7896.6 40901.8 41355.6 41359.0 41389.2 41404.2 3570.8 3617.5 3620.8 3621.5 3623.4 32191.8 32784.0 32807.0 32829.7 32834.5 5024.5 5044.1 5085.5 5114.8 5133.4 191470.0 192125.0 192331.0 193025.0 193205.0 50886.0 50970.2 51067.0 52054.0 52999.7 54013.0 54077.7 54193.5 54214.2 54549.7 16649.6 16946.7 16981.1 16992.9 17166.7 13665.5 13766.5 13780.7 13782.7 13787.3 15069.7 15087.5 15125.9 15145.2 15237.5 5912.2 5914.5 5997.1 6030.8 6056.4 998.4 1030.7 1039.6 1044.7 1049.1 23449.5 23609.4 23710.3 23717.0 23882.9 1132.8 1141.7 1147.3 1148.9 1158.3 12303.8 12425.7 12452.3 12555.4 12589.9 226926.0 229047.0 229339.0 239538.0 247044.0 60147.4 60358.4 60474.0 60485.7 60673.7 1477.2 1500.0 1513.1 1513.5 1530.5 27417.9 28065.6 28510.6 28577.7 28614.6 37797.2 38014.2 38022.2 38106.6 38201.0 193269.0 193365.0 193378.0 193547.0 194244.0 35399.8 36504.3 36548.3 36555.8 36632.2 45584.3 45793.5 46019.1 46091.5 46115.0 32904.3 33397.0 37807.4 39083.8 39493.8 38157.0 38390.4 38412.2 38495.8 38666.4 42584.1 42751.4 43079.0 43119.0 43866.3 44281.0 44335.3 44466.8 44477.4 45383.3 25886.5 25981.7 26067.6 26150.3 26516.3 03:11:19 INFO - PID 3649 | 03:11:19 INFO - PID 3649 | [#2] jquery.html Cycles:180 Average:36342.47 Median:22177.38 stddev:80608.25 (363.5%) stddev-sans-first:80789.65 03:11:19 INFO - PID 3649 | Values: 576.9 584.7 585.9 601.8 602.6 21826.7 22784.5 22802.9 22874.8 23940.9 25875.5 26567.7 26588.5 26589.2 26636.9 6469.1 6588.0 6618.1 6623.3 6775.6 7008.3 7040.7 7043.8 7058.9 7058.9 7021.5 7024.5 7031.8 7053.0 7062.4 6964.7 6981.0 7020.0 7045.4 7055.6 6873.5 6880.2 6895.4 6902.4 6911.8 30902.2 33952.2 34029.1 34036.3 34057.1 1962.1 1966.5 1972.8 1977.1 1990.7 20814.7 20902.7 21613.6 21737.1 21864.2 2567.5 2589.5 2622.9 2641.6 2652.2 140607.3 146222.0 146329.0 146480.0 146803.0 21057.8 21661.2 21984.5 22370.3 22984.4 45198.0 45282.1 45436.1 45444.5 45577.8 12023.9 12185.8 12362.3 12379.1 12386.2 8605.0 9064.5 9467.3 10064.3 10529.9 11890.9 12059.3 12199.2 12443.6 12563.9 4026.7 4329.2 4588.6 4592.6 4693.6 963.4 984.5 986.8 992.9 996.0 19035.4 19666.3 19973.5 20219.1 20324.6 1050.0 1051.8 1052.1 1059.8 1060.6 10918.6 11193.6 11274.0 11297.8 11523.8 457534.0 472017.0 473328.0 474455.0 498479.0 116943.0 121036.4 121264.4 121696.0 122007.0 1197.1 1207.0 1222.5 1227.9 1231.6 17684.3 17751.9 17989.8 18019.0 18204.7 56790.0 57085.0 57461.7 57592.4 58903.7 71675.6 72133.0 76973.6 80748.6 80965.0 14926.9 15467.9 15530.6 15531.1 15558.1 23994.4 24507.4 24702.3 24744.5 24885.6 18526.6 18646.3 18991.3 19172.3 19250.3 17240.1 17605.9 17619.5 17940.3 18278.5 19624.0 19711.3 19781.7 19892.7 19914.9 14497.4 15128.3 15301.8 15329.7 15386.9 19548.2 19565.4 19601.5 19798.0 19800.4 03:11:19 INFO - PID 3649 | 03:11:19 INFO - PID 3649 | [#3] mootools.html Cycles:180 Average:8768.09 Median:2477.86 stddev:6041.29 (243.8%) stddev-sans-first:6032.66 03:11:19 INFO - PID 3649 | Values: 1369.6 1422.3 1427.9 1429.5 1433.3 13559.6 14129.1 14174.9 14223.6 14233.5 13030.2 13431.9 13803.6 13858.7 13881.0 2517.2 2570.5 2570.8 2571.4 2574.6 2430.8 2478.4 2536.7 2553.8 2604.1 2534.4 2555.9 2560.2 2561.6 2564.9 2477.3 2513.9 2519.1 2526.4 2601.3 2483.5 2487.2 2501.7 2502.2 2506.5 13682.0 13753.3 13911.7 13916.2 13922.1 7517.2 7775.7 7783.6 7786.5 7787.7 4876.6 5015.6 5043.5 5126.2 5187.6 1791.6 1807.5 1827.6 1856.8 1862.0 22925.3 23177.4 23459.5 23500.6 23554.6 6976.2 6987.2 7020.1 7166.6 7169.6 18328.1 18377.2 18401.8 18412.5 18416.7 7587.4 7822.8 7824.1 7851.5 7856.2 6771.3 7086.7 7089.0 7091.0 7094.0 5154.8 5347.3 5363.4 5368.4 5589.0 1385.5 1391.2 1550.1 1573.3 1589.8 880.2 906.8 922.9 925.3 954.2 7998.9 8046.8 8091.2 8152.3 8504.4 996.7 1009.5 1019.9 1023.8 1041.6 4941.9 5090.5 5123.9 5234.7 5270.6 18254.8 19390.9 19448.3 19662.3 19747.9 18599.7 19160.1 19260.5 19336.7 19598.2 10281.5 10706.2 10771.9 10822.2 10953.5 7882.3 7927.1 8085.7 8118.3 8221.8 16719.7 16908.2 17197.0 17612.3 17656.8 17292.5 17294.9 17395.3 17427.1 17474.8 10423.8 10581.4 10639.6 10642.0 10649.8 12642.0 12788.7 12959.4 12997.5 13052.9 10757.1 10766.5 10766.9 10898.0 11051.8 10447.8 10540.6 10599.7 10613.7 10827.4 9322.8 9505.4 9524.0 9524.9 9528.7 6667.9 6672.5 6711.4 6746.5 6748.8 6752.1 6753.0 6816.5 6854.6 6932.3 03:11:19 INFO - PID 3649 | 03:11:19 INFO - PID 3649 | [#4] prototype.html Cycles:180 Average:5487.34 Median:6053.67 stddev:1533.60 (25.3%) stddev-sans-first:1491.46 03:11:19 INFO - PID 3649 | Values: 496.8 500.8 517.6 524.9 534.5 6255.7 6275.3 6340.5 6363.2 6363.3 5870.4 6151.6 6154.3 6193.6 6199.7 4915.4 4945.5 4957.9 4981.1 4990.3 4945.4 4952.3 5001.2 5005.6 5018.0 4763.7 4930.6 4994.8 5010.9 5013.7 4897.6 4943.2 4975.2 4990.3 5018.6 4476.8 4495.6 4496.0 4510.3 4512.7 5897.0 5998.1 6005.9 6020.6 6086.8 5713.9 5727.3 5754.0 5764.4 5793.9 6447.2 6458.6 6519.6 6527.2 6586.7 4837.8 4881.5 4891.5 4906.1 4910.2 6825.9 6899.9 6910.5 6919.1 6956.4 5025.8 5048.8 5066.1 5095.8 5150.9 5055.5 5083.2 5088.1 5142.2 5142.2 5712.6 5716.0 5752.3 5785.5 5802.4 6523.6 6651.9 6698.3 6732.0 6741.2 1656.8 1698.2 1727.3 1727.4 1787.8 1199.8 1227.1 1233.7 1235.4 1254.8 5648.3 5667.6 5698.0 5709.0 5716.8 6488.4 6502.6 6515.3 6562.7 6638.0 5588.9 5601.8 5633.8 5663.2 5712.2 3480.8 3497.8 3509.9 3510.3 3545.6 6449.6 6453.3 6453.7 6453.8 6538.3 6754.5 6758.9 6835.7 6868.4 6897.3 6442.7 6444.3 6466.0 6478.3 6495.7 6629.4 6676.3 6677.0 6683.9 6704.5 6558.0 6566.3 6581.2 6622.0 6696.8 6328.1 6349.9 6400.4 6415.3 6439.0 5022.4 5026.9 5045.5 5053.3 5054.6 6668.5 6678.8 6688.4 6716.4 6746.7 6364.1 6385.6 6488.2 6502.2 6559.0 6385.0 6389.5 6395.5 6494.8 6545.9 5986.2 6398.9 6417.8 6439.2 6517.8 6493.6 6512.7 6570.4 6602.3 6638.4 6092.2 6256.2 6306.0 6327.4 6454.2 03:11:19 INFO - PID 3649 | 03:11:19 INFO - PID 3649 | [#5] yui.html Cycles:180 Average:23869.31 Median:20151.59 stddev:32243.13 (160.0%) stddev-sans-first:32287.48 03:11:19 INFO - PID 3649 | Values: 905.2 908.9 931.9 934.2 938.3 19327.9 20143.1 20160.1 20178.4 22538.0 22269.3 22880.4 23001.4 23045.0 23167.9 1027.1 1053.4 1054.6 1054.8 1056.6 1062.8 1064.5 1064.9 1065.6 1065.8 1005.1 1067.5 1072.9 1073.2 1134.6 1058.8 1065.9 1067.4 1067.8 1068.6 792.9 795.3 796.6 797.5 798.1 20110.8 20513.5 20565.5 20719.3 20820.8 21731.0 22384.2 22760.9 22904.4 22921.3 17033.7 17060.8 17244.6 17391.7 17394.5 3637.6 3667.9 3669.7 3670.6 3675.0 128690.0 129160.5 129581.0 131261.0 134839.0 17660.2 17752.6 18378.3 18458.3 18503.2 32300.8 33103.8 33272.7 33588.3 33759.7 8047.0 8573.5 8774.6 9080.5 9326.9 4462.5 4552.6 4552.9 4554.5 4559.5 5325.6 5355.8 5387.6 5436.5 5446.6 1049.6 1055.7 1065.4 1071.3 1072.4 556.2 573.2 579.7 588.6 593.1 11222.9 11412.7 11700.7 11816.8 12057.2 569.4 573.4 576.6 581.8 583.6 5118.9 5156.6 5238.4 5360.4 5520.1 101971.0 104222.5 107490.0 109200.0 111138.0 91941.0 95564.0 97222.0 97626.5 99146.5 82404.6 86283.0 87358.6 87912.0 90318.0 11007.2 11092.3 11102.3 11193.8 11934.0 37304.3 37708.2 39534.0 40028.4 40308.8 66404.0 68555.0 68756.3 71957.6 72155.6 17170.7 17677.7 17683.6 17726.7 18059.2 18905.6 19092.7 19447.8 20364.8 20421.2 17406.6 17555.6 17984.5 18076.8 18146.8 18456.8 18716.3 19035.9 19043.9 19060.6 16599.3 17014.7 17105.3 17580.2 17672.4 12021.7 12591.7 12677.8 12777.3 13079.9 11546.5 11745.8 12548.6 13295.7 13464.9 03:11:19 INFO - PID 3649 | -------- Summary: end -------- 03:11:19 INFO - PID 3649 | 03:11:20 INFO - TEST-INFO | 3649: exit 0 03:11:20 INFO - TEST-OK | dromaeo_css | took 1114989ms 03:11:20 INFO - TEST-START | kraken 03:11:20 INFO - Initialising browser for kraken test... 03:11:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47135/getInfo.html -profile /tmp/tmpredBL7/profile 03:11:20 INFO - TEST-INFO | started process 4006 (/builds/slave/test/build/application/firefox/firefox http://localhost:47135/getInfo.html) 03:11:25 INFO - TEST-INFO | 4006: exit 0 03:11:26 INFO - Browser initialized. 03:11:26 INFO - Running cycle 1/1 for kraken test... 03:11:26 INFO - TEST-INFO | started process 4212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpredBL7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:11:27 INFO - PID 4212 | 03:11:27 INFO - PID 4212 | (/builds/slave/test/build/application/firefox/firefox:4261): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:11:27 INFO - PID 4212 | 03:11:37 INFO - PID 4212 | RSS: Main: 171048960 03:11:37 INFO - PID 4212 | 03:11:39 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47135/tests/kraken/driver.html?testName=audio-beat-detection) 03:11:40 INFO - PID 4212 | RSS: Main: 175828992 03:11:40 INFO - PID 4212 | 03:11:43 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47135/tests/kraken/driver.html?testName=audio-dft) 03:11:44 INFO - PID 4212 | RSS: Main: 176680960 03:11:44 INFO - PID 4212 | 03:11:47 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47135/tests/kraken/driver.html?testName=audio-fft) 03:11:47 INFO - PID 4212 | RSS: Main: 170876928 03:11:47 INFO - PID 4212 | 03:11:49 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47135/tests/kraken/driver.html?testName=audio-oscillator) 03:11:50 INFO - PID 4212 | RSS: Main: 171642880 03:11:50 INFO - PID 4212 | 03:11:52 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47135/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:11:53 INFO - PID 4212 | RSS: Main: 172003328 03:11:53 INFO - PID 4212 | 03:11:56 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47135/tests/kraken/driver.html?testName=imaging-darkroom) 03:11:57 INFO - PID 4212 | RSS: Main: 174903296 03:11:57 INFO - PID 4212 | 03:12:00 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47135/tests/kraken/driver.html?testName=imaging-desaturate) 03:12:01 INFO - PID 4212 | RSS: Main: 175415296 03:12:01 INFO - PID 4212 | 03:12:03 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47135/tests/kraken/driver.html?testName=json-parse-financial) 03:12:04 INFO - PID 4212 | RSS: Main: 175276032 03:12:04 INFO - PID 4212 | 03:12:06 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47135/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:12:06 INFO - PID 4212 | RSS: Main: 175263744 03:12:06 INFO - PID 4212 | 03:12:08 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47135/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:12:09 INFO - PID 4212 | RSS: Main: 175104000 03:12:09 INFO - PID 4212 | 03:12:11 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47135/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:12:12 INFO - PID 4212 | RSS: Main: 172367872 03:12:12 INFO - PID 4212 | 03:12:14 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47135/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:12:15 INFO - PID 4212 | RSS: Main: 172687360 03:12:15 INFO - PID 4212 | 03:12:18 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47135/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:12:19 INFO - PID 4212 | RSS: Main: 172957696 03:12:19 INFO - PID 4212 | 03:12:20 INFO - PID 4212 | Cycle 1(1): loaded http://localhost:47135/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47135/tests/kraken/driver.html?testName=ai-astar) 03:12:21 INFO - PID 4212 | RSS: Main: 174530560 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | __start_tp_report 03:12:21 INFO - PID 4212 | _x_x_mozilla_page_load 03:12:21 INFO - PID 4212 | _x_x_mozilla_page_load_details 03:12:21 INFO - PID 4212 | |i|pagename|runs| 03:12:21 INFO - PID 4212 | |0;ai-astar;98;107;103;108;107;113;111;99;109;108 03:12:21 INFO - PID 4212 | |1;audio-beat-detection;149;116;145;174;125;148;153;121;173;118 03:12:21 INFO - PID 4212 | |2;audio-dft;164;163;165;162;162;163;162;168;168;164 03:12:21 INFO - PID 4212 | |3;audio-fft;75;76;74;185;75;74;73;74;177;75 03:12:21 INFO - PID 4212 | |4;audio-oscillator;78;78;148;79;79;79;136;78;78;125 03:12:21 INFO - PID 4212 | |5;imaging-gaussian-blur;114;114;115;115;115;114;116;114;114;113 03:12:21 INFO - PID 4212 | |6;imaging-darkroom;151;152;152;152;152;150;152;150;152;150 03:12:21 INFO - PID 4212 | |7;imaging-desaturate;94;94;95;94;95;94;95;95;95;95 03:12:21 INFO - PID 4212 | |8;json-parse-financial;57;56;60;55;56;55;58;56;55;55 03:12:21 INFO - PID 4212 | |9;json-stringify-tinderbox;54;54;54;54;54;54;55;53;54;54 03:12:21 INFO - PID 4212 | |10;stanford-crypto-aes;81;88;80;77;80;78;79;82;79;78 03:12:21 INFO - PID 4212 | |11;stanford-crypto-ccm;135;136;123;134;147;135;124;127;125;174 03:12:21 INFO - PID 4212 | |12;stanford-crypto-pbkdf2;170;172;178;175;174;184;188;173;172;177 03:12:21 INFO - PID 4212 | |13;stanford-crypto-sha256-iterative;67;70;65;67;66;65;67;65;68;64 03:12:21 INFO - PID 4212 | __end_tp_report 03:12:21 INFO - PID 4212 | __start_cc_report 03:12:21 INFO - PID 4212 | _x_x_mozilla_cycle_collect,982 03:12:21 INFO - PID 4212 | __end_cc_report 03:12:21 INFO - PID 4212 | __startTimestamp1502014341208__endTimestamp 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | ------- Summary: start ------- 03:12:21 INFO - PID 4212 | Number of tests: 14 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#0] ai-astar Cycles:10 Average:106.30 Median:110.00 stddev:4.88 (4.4%) stddev-sans-first:4.15 03:12:21 INFO - PID 4212 | Values: 98.0 107.0 103.0 108.0 107.0 113.0 111.0 99.0 109.0 108.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:148.50 stddev:21.56 (14.5%) stddev-sans-first:22.72 03:12:21 INFO - PID 4212 | Values: 149.0 116.0 145.0 174.0 125.0 148.0 153.0 121.0 173.0 118.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.28 (1.4%) stddev-sans-first:2.42 03:12:21 INFO - PID 4212 | Values: 164.0 163.0 165.0 162.0 162.0 163.0 162.0 168.0 168.0 164.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#3] audio-fft Cycles:10 Average:95.80 Median:74.50 stddev:44.95 (60.3%) stddev-sans-first:47.04 03:12:21 INFO - PID 4212 | Values: 75.0 76.0 74.0 185.0 75.0 74.0 73.0 74.0 177.0 75.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:78.00 stddev:28.49 (36.5%) stddev-sans-first:29.49 03:12:21 INFO - PID 4212 | Values: 78.0 78.0 148.0 79.0 79.0 79.0 136.0 78.0 78.0 125.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 03:12:21 INFO - PID 4212 | Values: 114.0 114.0 115.0 115.0 115.0 114.0 116.0 114.0 114.0 113.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:152.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 03:12:21 INFO - PID 4212 | Values: 151.0 152.0 152.0 152.0 152.0 150.0 152.0 150.0 152.0 150.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 03:12:21 INFO - PID 4212 | Values: 94.0 94.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:1.64 (2.9%) stddev-sans-first:1.72 03:12:21 INFO - PID 4212 | Values: 57.0 56.0 60.0 55.0 56.0 55.0 58.0 56.0 55.0 55.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 03:12:21 INFO - PID 4212 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 55.0 53.0 54.0 54.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:3.12 (3.9%) stddev-sans-first:3.30 03:12:21 INFO - PID 4212 | Values: 81.0 88.0 80.0 77.0 80.0 78.0 79.0 82.0 79.0 78.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#11] stanford-crypto-ccm Cycles:10 Average:136.00 Median:135.00 stddev:15.22 (11.3%) stddev-sans-first:16.14 03:12:21 INFO - PID 4212 | Values: 135.0 136.0 123.0 134.0 147.0 135.0 124.0 127.0 125.0 174.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.30 Median:176.00 stddev:5.72 (3.2%) stddev-sans-first:5.59 03:12:21 INFO - PID 4212 | Values: 170.0 172.0 178.0 175.0 174.0 184.0 188.0 173.0 172.0 177.0 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.78 (2.7%) stddev-sans-first:1.87 03:12:21 INFO - PID 4212 | Values: 67.0 70.0 65.0 67.0 66.0 65.0 67.0 65.0 68.0 64.0 03:12:21 INFO - PID 4212 | -------- Summary: end -------- 03:12:21 INFO - PID 4212 | 03:12:21 INFO - PID 4212 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:12:21 INFO - TEST-INFO | 4212: exit 0 03:12:21 INFO - TEST-OK | kraken | took 61566ms 03:12:21 INFO - SUITE-END | took 1176s 03:12:22 INFO - Completed test suite (00:19:36) 03:12:22 INFO - javascript benchmark 03:12:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8704.046821253973, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3129.4992801151816, 3158.7315078218367, 3183.952240716388, 3198.824064676442, 3226.709596136347, 6192.566520343577, 6303.621782693036, 6319.052142178675, 6327.588706734059, 6350.333215012426, 6166.814995550129, 6232.657203853786, 6259.62442253464, 6292.590981586193, 6323.051542268662, 5740.024195886688, 5747.3677895431465, 5750.3962083981205, 5769.596128271022, 5806.59353845231, 5748.0, 5754.309482862062, 5884.176215329857, 5891.911621325684, 5902.911456328137, 5757.510611597998, 5824.271966004249, 5838.182654428383, 5838.4453476919625, 5889.1755154278435, 5578.3584887738025, 5737.684427356494, 5815.447532484407, 5819.214406055171, 5893.941060589382, 5673.886522269573, 5695.572832037614, 5710.971445142789, 5772.6536407815665, 5796.362400135981, 6225.377462253784, 6242.750289988395, 6263.467605253559, 6290.025046117859, 6305.0, 6678.699458524378, 6684.398404143651, 6739.494537909627, 6743.123393958803, 6824.761133360308, 6727.529072964894, 6770.559913605649, 6803.081583986148, 6828.863422731567, 6831.487638427137, 6344.397282258178, 6354.269259035178, 6383.425491705769, 6387.073874288202, 6408.10286559882, 6910.378065973986, 6969.059177011039, 6971.058907047585, 7043.013978043078, 7055.906334518158, 6520.510961677893, 6613.570117942319, 6657.0, 6672.099266599044, 6747.257801641816, 6711.127553418024, 6758.05387245786, 6787.728490860409, 6790.354916282945, 6800.31996800316, 6686.130802995676, 6708.161479815023, 6772.864542709118, 6775.644871025716, 6781.966090169616, 6736.93263067363, 6753.729850806011, 6832.043513908056, 6833.931660683429, 6833.965830170917, 5347.41178470368, 5430.56555475561, 5432.402435732066, 5444.50999410055, 5507.697076660742, 4629.953700462952, 4636.235021221461, 4641.6054635355695, 4645.721256724607, 4651.186042442559, 5720.1991721159075, 5740.770369185269, 5749.913751293734, 5763.3084029915835, 5826.242588463472, 6874.690638921261, 6887.380135787803, 6904.033435319059, 6910.930890691129, 6933.93066069343, 5789.334226563999, 5827.213326200908, 5849.88300233993, 5859.414058594107, 5878.647281163144, 5845.707714614252, 5921.822345329647, 5953.880922381615, 6017.458428741435, 6027.6684782336515, 6558.639274839834, 6563.278039415661, 6565.441937435371, 6578.27638959714, 6581.078648989145, 6774.390304872585, 6860.176778786577, 6861.382475577222, 6862.588244705334, 6863.176418829772, 6546.312637173029, 6548.0832683425315, 6616.305287944889, 6628.701708423229, 6635.236947750877, 6687.331266873468, 6743.055972163803, 6750.122484077038, 6753.493487988322, 6754.054432379373, 6766.424853887278, 6788.389044985975, 6801.2178599461695, 6852.897206542006, 6862.828429289308, 6425.228972523327, 6447.709853056717, 6540.705668244846, 6579.539432239889, 6674.83312917181, 6604.669766511559, 6612.437942774918, 6612.669366531558, 6612.834679132868, 6650.135482387259, 6440.581362211441, 6501.1548498694865, 6567.835804104936, 6588.637624930675, 6589.7364105435245, 6566.6388348641285, 6582.802515924338, 6587.0, 6675.632840193836, 6686.398224159849, 6299.149614801943, 6364.554481186457, 6371.044343348535, 6372.745090196526, 6426.518011149089], "value": 6171.24613675223, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.1389733830806, 834.3408707121373, 878.5431575580698, 880.4057261348593, 1164.6564263542255, 31663.208419789516, 33234.33531329375, 43974.12051758967, 44263.336049959275, 44295.0, 45828.54171458285, 46402.303965440464, 46511.0, 46571.534284657144, 46614.300785488245, 7912.564808935521, 8001.279884810366, 8043.436959412844, 8069.556174410405, 8077.919220807776, 7551.0, 7627.8855817162785, 7634.12207596128, 7650.464467487278, 7725.8068548286465, 7695.653695583712, 7726.150123486412, 7761.573113478757, 7763.534187948713, 7763.961180194091, 7636.236376362319, 7670.501417407851, 7692.153863075057, 7736.458447908677, 7736.535807851547, 7751.612419379008, 7766.495177813424, 7889.684412623488, 7894.3289820365335, 7896.605169741548, 40901.795491022356, 41355.58644413547, 41359.0, 41389.1722165558, 41404.1719165615, 3570.839312230956, 3617.457381392786, 3620.8008559529217, 3621.5473065866768, 3623.3840247158046, 32191.83904080488, 32784.0, 32807.0, 32829.671703282904, 32834.50748238778, 5024.497550244982, 5044.092063428581, 5085.516875896784, 5114.820981265638, 5133.435322114565, 191469.9999999986, 192125.0, 192331.0, 193025.0, 193205.0, 50886.0, 50970.23544646833, 51067.0, 52054.0, 52999.73500132475, 54013.0, 54077.72961135169, 54193.45806541884, 54214.186787198225, 54549.72725136428, 16649.583760406087, 16946.745798813026, 16981.066041367845, 16992.91503542499, 17166.65666686659, 13665.453381864614, 13766.518171863936, 13780.65548361299, 13782.724345513234, 13787.310634468236, 15069.698606028038, 15087.4719384821, 15125.924370378078, 15145.242737863064, 15237.542873713806, 5912.23140991677, 5914.467697907209, 5997.13041608973, 6030.788922387783, 6056.424639659225, 998.3710262534556, 1030.6598822388594, 1039.589362201926, 1044.7074819050679, 1049.0872940541624, 23449.531009379716, 23609.40976475602, 23710.288691339287, 23717.0, 23882.880585596962, 1132.7621199548023, 1141.6917432293235, 1147.3402793393832, 1148.942552872353, 1158.252926862186, 12303.815442768366, 12425.689357766129, 12452.252864828139, 12555.435005424777, 12589.874101259053, 226926.0, 229047.0, 229339.0, 239538.0, 247044.0, 60147.39852601418, 60358.39641603528, 60474.0, 60485.69757151186, 60673.69663151656, 1477.2023107521818, 1500.0324790510278, 1513.0921447131634, 1513.4627207341234, 1530.540837748671, 27417.90328386842, 28065.57901631518, 28510.57234141448, 28577.714222857507, 28614.57078143871, 37797.24405511819, 38014.23971520499, 38022.23955520819, 38106.61893381141, 38201.044973875876, 193269.0, 193365.0, 193378.0, 193547.0, 194244.0, 35399.82300088483, 36504.26991460209, 36548.26903461969, 36555.81722091373, 36632.15362386911, 45584.316235255836, 45793.54206458026, 46019.07961840677, 46091.539084608725, 46115.0, 32904.34191316208, 33397.0, 37807.43288850725, 39083.80458097691, 39493.80253098716, 38157.0, 38390.42414363731, 38412.2317553653, 38495.80752096222, 38666.42000369941, 42584.14831703411, 42751.3587296197, 43079.0, 43119.0, 43866.342004869315, 44281.0, 44335.33496997483, 44466.77766611146, 44477.4418046549, 45383.319250211935, 25886.48227035411, 25981.74018259869, 26067.608985865605, 26150.34624134412, 26516.33709157209], "value": 18233.52004482769, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.8875069361471, 584.6871923520914, 585.9384764599714, 601.843520684622, 602.5601311042938, 21826.672599910995, 22784.544309113808, 22802.88598557007, 22874.77125228745, 23940.880295598497, 25875.48249035023, 26567.73432265677, 26588.468230635375, 26589.202323930265, 26636.866815665944, 6469.126667899832, 6588.0, 6618.139641846553, 6623.304553021935, 6775.62734049627, 7008.264132266115, 7040.683169257396, 7043.823904402405, 7058.85882282354, 7058.894116588255, 7021.473389495783, 7024.508284420092, 7031.789046328593, 7052.977318288845, 7062.364387205151, 6964.721411143548, 6981.0, 7019.964900175518, 7045.365917067463, 7055.611941343224, 6873.518853680244, 6880.2431732509385, 6895.413889819321, 6902.413294869942, 6911.827204319882, 30902.22744431407, 33952.151196220046, 34029.14927126817, 34036.31927361439, 34057.14857128567, 1962.077823423003, 1966.5083729067733, 1972.7928567500348, 1977.13006277239, 1990.7312512810875, 20814.687779683318, 20902.686459703116, 21613.56772864534, 21737.130514779547, 21864.23475178361, 2567.460833225025, 2589.5338839008973, 2622.9213123606323, 2641.5641419165813, 2652.2175958092407, 140607.29696351453, 146222.0, 146329.0, 146480.0, 146803.0, 21057.789422105583, 21661.241856534947, 21984.45038874041, 22370.302236530184, 22984.4253893654, 45198.0, 45282.05666631724, 45436.091278174914, 45444.50055246993, 45577.77211113989, 12023.879761202275, 12185.756284874431, 12362.320072396105, 12379.133460657667, 12386.194897331825, 8604.956975215084, 9064.50145242018, 9467.337286389886, 10064.345817521838, 10529.894021195638, 11890.940545297392, 12059.311696362516, 12199.231111488962, 12443.626691199279, 12563.93718031404, 4026.697997650188, 4329.242382583036, 4588.6099681526775, 4592.563706447949, 4693.577578017995, 963.3689933093834, 984.4929861121528, 986.8125056239435, 992.9205663547043, 995.9502024898726, 19035.42893713163, 19666.31167909145, 19973.500662483555, 20219.090140943397, 20324.593508129754, 1049.9842502362471, 1051.8211903976342, 1052.1162223732101, 1059.8357254625546, 1060.6075751971666, 10918.563257469772, 11193.552257909756, 11273.98081534769, 11297.774044519063, 11523.790002049664, 457534.0, 472017.0, 473328.0, 474455.0, 498479.0, 116943.0, 121036.39481802535, 121264.39367803281, 121696.0, 122006.99999999822, 1197.0782497476894, 1206.9577564785366, 1222.4560070768423, 1227.9386030698608, 1231.5751065882257, 17684.292628294723, 17751.911240443715, 17989.820101798814, 18019.008954507102, 18204.72692909581, 56790.0, 57085.0, 57461.712691436274, 57592.4240757587, 58903.705481472316, 71675.64162179155, 72133.0, 76973.61513192399, 80748.59625701833, 80965.0, 14926.925365373103, 15467.922660386626, 15530.61173470627, 15531.06813591188, 15558.144302063496, 23994.40013999664, 24507.38731531726, 24702.25893223206, 24744.505109898062, 24885.62671559892, 18526.62946741031, 18646.347377842252, 18991.33530326432, 19172.328968486036, 19250.326238581583, 17240.137993100045, 17605.911970440065, 17619.471415857544, 17940.28238870483, 18278.451646450627, 19624.0, 19711.310104146287, 19781.70327445118, 19892.70160947616, 19914.90042549778, 14497.420103195755, 15128.319225635092, 15301.770473442684, 15329.693406132037, 15386.9230653846, 19548.21807127699, 19565.413037608894, 19601.509962251057, 19798.0, 19800.405987820388], "value": 13137.315915395533, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1369.6301998460417, 1422.2533170085703, 1427.9286035698212, 1429.5211104280065, 1433.2761955212616, 13559.593212203637, 14129.081609695362, 14174.929125354385, 14223.644408889782, 14233.501827436041, 13030.153040052413, 13431.865681343184, 13803.585892423218, 13858.722825543484, 13881.0, 2517.156752487914, 2570.498752743216, 2570.807189460789, 2571.3571607098224, 2574.613807928816, 2430.8176886733477, 2478.4051827561348, 2536.7336429674897, 2553.8212325137247, 2604.1406335909105, 2534.3664083979006, 2555.8722063896826, 2560.2319304208754, 2561.5517284475236, 2564.871756412181, 2477.318737347235, 2513.899444022237, 2519.067944860404, 2526.418923647562, 2601.310652677042, 2483.5405449991626, 2487.1543675150538, 2501.6622755927897, 2502.2368177705794, 2506.5362907861922, 13682.04225704201, 13753.312334383241, 13911.652208694763, 13916.165030098227, 13922.09506382082, 7517.210692877224, 7775.727849525239, 7783.649735761847, 7786.454948153631, 7787.688492460295, 4876.561109500162, 5015.5736762375245, 5043.470435604282, 5126.179811230222, 5187.559057480119, 1791.6327152933618, 1807.4577626711934, 1827.570520927581, 1856.7771867375866, 1861.972070418945, 22925.312240632808, 23177.420564486023, 23459.530809383887, 23500.647490287658, 23554.646680299807, 6976.232614412411, 6987.161540615057, 7020.139662989312, 7166.641667916583, 7169.5698258104685, 18328.083595820157, 18377.17302721381, 18401.81598184001, 18412.539686507946, 18416.723749143774, 7587.430942679322, 7822.765317040498, 7824.139344672081, 7851.489653172525, 7856.214378562098, 6771.255161932184, 7086.681099350541, 7088.964555177191, 7091.0, 7093.964530177316, 5154.793808247703, 5347.2781174541715, 5363.356397232279, 5368.3826359968325, 5588.993981083444, 1385.5496963486908, 1391.2070120031688, 1550.093195480634, 1573.3156077106496, 1589.785378973847, 880.1726377205534, 906.7687739626485, 922.8754118194092, 925.3337596930199, 954.2413781044087, 7998.920010799934, 8046.758597242092, 8091.19088091198, 8152.347812175011, 8504.404691671647, 996.6511720897773, 1009.5154325923597, 1019.9031092046243, 1023.7696518283327, 1041.6458404142477, 4941.876453088702, 5090.49095090488, 5123.949590333973, 5234.659747116425, 5270.578353731692, 18254.817451825576, 19390.903045484683, 19448.319308824124, 19662.311819086262, 19747.901260493894, 18599.721004184947, 19160.137793799313, 19260.518487037654, 19336.70994935077, 19598.216071356987, 10281.485925703684, 10706.197035222234, 10771.946140269249, 10822.242443028912, 10953.507092180871, 7882.344707611466, 7927.088384835818, 8085.676572937016, 8118.3099436548555, 8221.753347399588, 16719.665606688042, 16908.154592270585, 17197.0, 17612.29550817953, 17656.82343176603, 17292.481225563253, 17294.913525432294, 17395.30418783285, 17427.128643568023, 17474.82525174732, 10423.791524169626, 10581.418022008556, 10639.627613033506, 10642.04221620058, 10649.787004259717, 12642.0, 12788.744225115632, 12959.416826242654, 12997.48010079624, 13052.869471305545, 10757.085647720032, 10766.515506802056, 10766.930781880637, 10898.0, 11051.83422248683, 10447.843282350923, 10540.578376865145, 10599.682009539727, 10613.681589552325, 10827.350358978487, 9322.766930826512, 9505.382150160218, 9523.952380238054, 9524.904750952403, 9528.714138575853, 6667.866642667216, 6672.532922695559, 6711.362420570038, 6746.5277430581355, 6748.797536073926, 6752.122224110834, 6753.0, 6816.454683625199, 6854.565052496962, 6932.341427564374], "value": 6381.332741946045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.78141617688226, 500.8172017213718, 517.6298946253429, 524.8504176309752, 534.462864820855, 6255.749770009205, 6275.278342990552, 6340.463814474213, 6363.204599425072, 6363.331850155736, 5870.354261031283, 6151.569390142692, 6154.261488621371, 6193.597416167946, 6199.721012554434, 4915.434725006634, 4945.505449455044, 4957.851264462054, 4981.103401387749, 4990.30135780991, 4945.4065512138595, 4952.306677065214, 5001.199808030716, 5005.57452616528, 5018.0, 4763.714177149365, 4930.580900623451, 4994.825181118662, 5010.920468005773, 5013.674111182761, 4897.583705385046, 4943.159662857305, 4975.154223781966, 4990.25146228065, 5018.623603229772, 4476.753778542179, 4495.57292057254, 4496.0, 4510.323451482304, 4512.661550383735, 5896.97051514744, 5998.130271110665, 6005.909911351333, 6020.5785595008365, 6086.7565297388055, 5713.857153571153, 5727.341355744101, 5754.0, 5764.394738552433, 5793.8841223175305, 6447.194100737408, 6458.580192287486, 6519.608823470607, 6527.249366322886, 6586.7035983380865, 4837.758112094381, 4881.4630390657, 4891.51084891508, 4906.1168989581865, 4910.238912968495, 6825.931740682579, 6899.896501552481, 6910.481713871379, 6919.135108111486, 6956.443484521226, 5025.773840177201, 5048.848534543969, 5066.138756411419, 5095.80248641569, 5150.8969820604125, 5055.469175736568, 5083.220872694601, 5088.109580823341, 5142.202958541432, 5142.228665700175, 5712.600117991784, 5716.0, 5752.3097228332035, 5785.50823180026, 5802.419758024248, 6523.575967562093, 6651.900221496681, 6698.263191048981, 6731.966340168267, 6741.1910570731825, 1656.7514872769182, 1698.2338368097287, 1727.3004433204571, 1727.4126796889118, 1787.830156135165, 1199.8140288255333, 1227.128738595607, 1233.6669099343308, 1235.3576140406938, 1254.7866862633375, 5648.322201335866, 5667.603267771299, 5697.971510142423, 5708.9714551427805, 5716.828495145152, 6488.416042556192, 6502.642354670538, 6515.283318834924, 6562.737490500326, 6638.037484564711, 5588.86027849307, 5601.7759289628775, 5633.802816901389, 5663.150527420919, 5712.171735098387, 3480.773749706261, 3497.755157138976, 3509.9298014039578, 3510.315488479722, 3545.5922568904907, 6449.613023218528, 6453.290138084807, 6453.677316134174, 6453.806385808433, 6538.300041989022, 6754.493412994045, 6758.864822703518, 6835.73538895306, 6868.416184624363, 6897.275786042494, 6442.742290308335, 6444.323346048597, 6466.0, 6478.255000674889, 6495.740170393131, 6629.359448386245, 6676.298988606321, 6676.9666151668935, 6683.920220632257, 6704.541479915802, 6557.96721016411, 6566.310537393696, 6581.2102547694585, 6621.96060403144, 6696.7656132035145, 6328.114064030948, 6349.936500634934, 6400.39196276353, 6415.294317625151, 6439.0, 5022.397312322545, 5026.924596131134, 5045.520675535819, 5053.29253904461, 5054.649587941625, 6668.499862510428, 6678.83302917431, 6688.398044176048, 6716.3955244028275, 6746.730130794714, 6364.109024736633, 6385.616862988049, 6488.156539649815, 6502.187226596676, 6558.967205163944, 6384.968075159594, 6389.48884089281, 6395.5203359747275, 6494.837629059122, 6545.934540654533, 5986.191864098291, 6398.93601064002, 6417.7753778617525, 6439.1706220334745, 6517.837054073686, 6493.610383377012, 6512.73949042033, 6570.408663220333, 6602.306757790555, 6638.435732962752, 6092.177556030057, 6256.249250089836, 6306.0, 6327.367263273636, 6454.1609590752905], "value": 5036.269312990566, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.1672461335571, 908.9045650206729, 931.8835145606799, 934.1685899549402, 938.2634631814027, 19327.903360483197, 20143.093560789763, 20160.09279582419, 20178.39464816056, 22538.0, 22269.331920042383, 22880.427989300275, 23001.4249643759, 23045.0, 23167.884160579215, 1027.1423361493162, 1053.383770494258, 1054.5518154784224, 1054.8048611006989, 1056.587930707025, 1062.760878802271, 1064.5262858028182, 1064.872215334157, 1065.6003998500562, 1065.8294672852346, 1005.1054561440324, 1067.4662668665667, 1072.8551645527832, 1073.2219141122662, 1134.6369161868206, 1058.820000599896, 1065.8720953485554, 1067.4342598422809, 1067.8451624514441, 1068.5779117248721, 792.9484583502054, 795.3239746215728, 796.5658715999793, 797.4896066517433, 798.0622768247287, 20110.79889201104, 20513.4871628209, 20565.4858628534, 20719.27482538119, 20820.79179208219, 21731.0, 22384.21655242075, 22760.886195568917, 22904.427389315402, 22921.312360629207, 17033.7444938326, 17060.82939170617, 17244.56888577783, 17391.65216695659, 17394.47816565505, 3637.618050104754, 3667.8716244931566, 3669.7064234861145, 3670.596234414212, 3674.9816250918843, 128690.0, 129160.54197290192, 129581.0, 131261.0, 134838.999999999, 17660.205290761947, 17752.644947100987, 18378.264869405342, 18458.261669533338, 18503.167357468945, 32300.838495807842, 33103.83448082744, 33272.66727332696, 33588.3282334352, 33759.66240337614, 8046.959765201136, 8573.528455934858, 8774.561271936378, 9080.455172689659, 9326.860097098548, 4462.464504259509, 4552.590266875997, 4552.863414097583, 4554.476235232924, 4559.498455169929, 5325.573954083741, 5355.812546560852, 5387.622866399314, 5436.537894278951, 5446.591505637093, 1049.6483677967967, 1055.7255113670346, 1065.3554599467366, 1071.3197119828965, 1072.404815327485, 556.1851886985586, 573.2146958666654, 579.7478097027722, 588.6409290332894, 593.1221791748237, 11222.887771122185, 11412.714682132848, 11700.70748231301, 11816.763664726657, 12057.216280941886, 569.396439773841, 573.3549756523911, 576.6338375131737, 581.8487193329764, 583.629395333966, 5118.948810511922, 5156.587473002151, 5238.423773384925, 5360.356757189084, 5520.06158952979, 101971.0, 104222.47888760507, 107490.0, 109200.0, 111138.0, 91941.0, 95564.0, 97222.0, 97626.5118674402, 99146.5042674782, 82404.58797705972, 86283.0, 87358.56320718356, 87912.0, 90318.0, 11007.229493935669, 11092.279001864854, 11102.2783519071, 11193.776124477303, 11934.0, 37304.25391492209, 37708.2458350826, 39534.0, 40028.39957400583, 40308.798456008706, 66404.0, 68555.0, 68756.31243687498, 71957.6402117986, 72155.63922180566, 17170.656586867943, 17677.734833977756, 17683.557911052325, 17726.734098988785, 18059.187336569623, 18905.621887562447, 19092.713609295595, 19447.8055219446, 20364.796352036883, 20421.183152673726, 17406.564835879206, 17555.561110971816, 17984.460466186036, 18076.81923180804, 18146.81853181451, 18456.815431846047, 18716.344927927457, 19035.904820476364, 19043.90478047601, 19060.61878762389, 16599.253033613273, 17014.74477882808, 17105.315787368865, 17580.20889060021, 17672.381466648607, 12021.699457513632, 12591.68520786951, 12677.8098328527, 12777.297248651414, 13079.869201307865, 11546.538138474367, 11745.765084698087, 12548.623541293775, 13295.734085318047, 13464.93267533656], "value": 9152.23856420269, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 103.0, 108.0, 107.0, 113.0, 111.0, 99.0, 109.0, 108.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 145.0, 174.0, 125.0, 148.0, 153.0, 121.0, 173.0, 118.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 165.0, 162.0, 162.0, 163.0, 162.0, 168.0, 168.0, 164.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 185.0, 75.0, 74.0, 73.0, 74.0, 177.0, 75.0], "value": 95.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 148.0, 79.0, 79.0, 79.0, 136.0, 78.0, 78.0, 125.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 115.0, 115.0, 114.0, 116.0, 114.0, 114.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 152.0, 152.0, 152.0, 150.0, 152.0, 150.0, 152.0, 150.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 60.0, 55.0, 56.0, 55.0, 58.0, 56.0, 55.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 53.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 88.0, 80.0, 77.0, 80.0, 78.0, 79.0, 82.0, 79.0, 78.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 136.0, 123.0, 134.0, 147.0, 135.0, 124.0, 127.0, 125.0, 174.0], "value": 136.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 178.0, 175.0, 174.0, 184.0, 188.0, 173.0, 172.0, 177.0], "value": 176.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 65.0, 67.0, 66.0, 65.0, 67.0, 65.0, 68.0, 64.0], "value": 66.4, "unit": "score"}]}]} 03:12:22 INFO - Return code: 0 03:12:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:12:22 INFO - # TBPL SUCCESS # 03:12:22 INFO - Running post-action listener: _package_coverage_data 03:12:22 INFO - Running post-action listener: _resource_record_post_action 03:12:22 INFO - [mozharness: 2017-08-06 10:12:22.502301Z] Finished run-tests step (success) 03:12:22 INFO - Running post-run listener: _resource_record_post_run 03:12:22 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 5402624; Write bytes: 444334080; Read time: 1844; Write time: 298400 03:12:22 INFO - TinderboxPrint: CPU usage
13.1% 03:12:22 INFO - TinderboxPrint: I/O read bytes / time
5,402,624 / 1,844 03:12:22 INFO - TinderboxPrint: I/O write bytes / time
444,334,080 / 298,400 03:12:22 INFO - TinderboxPrint: CPU idle
8,274.6 (86.8%) 03:12:22 INFO - TinderboxPrint: CPU user
1,201.8 (12.6%) 03:12:22 INFO - TinderboxPrint: Swap in / out
0 / 0 03:12:22 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 117686272; Read time: 140; Write time: 84912 03:12:22 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:12:22 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3026944; Write bytes: 326647808; Read time: 1160; Write time: 213488 03:12:23 INFO - Running post-run listener: _upload_blobber_files 03:12:23 INFO - Blob upload gear active. 03:12:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:12:23 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 03:12:23 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:12:23 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:12:23 INFO - (blobuploader) - INFO - Open directory for files ... 03:12:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:12:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:12:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:24 INFO - (blobuploader) - INFO - Done attempting. 03:12:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:12:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:12:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:25 INFO - (blobuploader) - INFO - Done attempting. 03:12:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:12:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:12:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:31 INFO - (blobuploader) - INFO - Done attempting. 03:12:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:12:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:12:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:12:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:12:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:12:32 INFO - (blobuploader) - INFO - Done attempting. 03:12:32 INFO - (blobuploader) - INFO - Iteration through files over. 03:12:32 INFO - Return code: 0 03:12:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:12:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:12:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43c32470dc093ccb0137d3e641a34db83cd6e1e2c10bac48f1028b23f0291d0751bcf91a56a49987f1e2c361fdead63fbee3782628bbd71382779508a4087124", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ebf2a56738d7455f48a610be6c28bc0977c6408eef401a0c73024278d5a2ac91cbf5d61c66f907ecd7a3bc202b6b6aca36534d55c38a0452b3eb1a7b6aafe24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b1deba66548a07a94e3e5c57f3d6e69e526a1b93de82a2500ad91b472ce615bf67a2b757536f989de327ce6390180a8d09fda9e44d3b7ca3caa2bc07b48ce37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa0085326d6f09c312c0cecd0dbd0daceb9980c85d27e6932b12c96f6f55090de2326238f71f5d1fd44e44ad6c7a9ee4da09730466d748da0bcbe3657f37dde4"} 03:12:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:12:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:12:32 INFO - Contents: 03:12:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43c32470dc093ccb0137d3e641a34db83cd6e1e2c10bac48f1028b23f0291d0751bcf91a56a49987f1e2c361fdead63fbee3782628bbd71382779508a4087124", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ebf2a56738d7455f48a610be6c28bc0977c6408eef401a0c73024278d5a2ac91cbf5d61c66f907ecd7a3bc202b6b6aca36534d55c38a0452b3eb1a7b6aafe24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b1deba66548a07a94e3e5c57f3d6e69e526a1b93de82a2500ad91b472ce615bf67a2b757536f989de327ce6390180a8d09fda9e44d3b7ca3caa2bc07b48ce37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa0085326d6f09c312c0cecd0dbd0daceb9980c85d27e6932b12c96f6f55090de2326238f71f5d1fd44e44ad6c7a9ee4da09730466d748da0bcbe3657f37dde4"} 03:12:32 INFO - Running post-run listener: copy_logs_to_upload_dir 03:12:32 INFO - Copying logs to upload dir... 03:12:32 INFO - mkdir: /builds/slave/test/build/upload/logs 03:12:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.626952 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-06 03:12:32.668212) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:32.677034) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557 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-Non-PGO/sha512/43c32470dc093ccb0137d3e641a34db83cd6e1e2c10bac48f1028b23f0291d0751bcf91a56a49987f1e2c361fdead63fbee3782628bbd71382779508a4087124", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ebf2a56738d7455f48a610be6c28bc0977c6408eef401a0c73024278d5a2ac91cbf5d61c66f907ecd7a3bc202b6b6aca36534d55c38a0452b3eb1a7b6aafe24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b1deba66548a07a94e3e5c57f3d6e69e526a1b93de82a2500ad91b472ce615bf67a2b757536f989de327ce6390180a8d09fda9e44d3b7ca3caa2bc07b48ce37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa0085326d6f09c312c0cecd0dbd0daceb9980c85d27e6932b12c96f6f55090de2326238f71f5d1fd44e44ad6c7a9ee4da09730466d748da0bcbe3657f37dde4"} build_url:https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011095 build_url: 'https://queue.taskcluster.net/v1/task/Ph1H-2ZlRnGCNKdcz7C8dw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43c32470dc093ccb0137d3e641a34db83cd6e1e2c10bac48f1028b23f0291d0751bcf91a56a49987f1e2c361fdead63fbee3782628bbd71382779508a4087124", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2ebf2a56738d7455f48a610be6c28bc0977c6408eef401a0c73024278d5a2ac91cbf5d61c66f907ecd7a3bc202b6b6aca36534d55c38a0452b3eb1a7b6aafe24", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7b1deba66548a07a94e3e5c57f3d6e69e526a1b93de82a2500ad91b472ce615bf67a2b757536f989de327ce6390180a8d09fda9e44d3b7ca3caa2bc07b48ce37", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa0085326d6f09c312c0cecd0dbd0daceb9980c85d27e6932b12c96f6f55090de2326238f71f5d1fd44e44ad6c7a9ee4da09730466d748da0bcbe3657f37dde4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:32.701601) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:32.701904) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1502012588.701222-839914557 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-06 03:12:32.785359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 03:12:32.785682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-06 03:12:32.785963) ========= ========= Total master_lag: 0.21 =========