builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1495703505.56 results: success (0) revision: 0ed0fd886134b6698f593edbf0d362ac9e12fe07 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:45.564687) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:45.565992) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:45.566267) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:45.614072) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:45.614360) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 02:11:45-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2017-05-25 02:11:45 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.185424 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:45.831630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:45.831936) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014009 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:45.881467) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:45.881812) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0ed0fd886134b6698f593edbf0d362ac9e12fe07 --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 0ed0fd886134b6698f593edbf0d362ac9e12fe07 --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=a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 02:11:45,755 truncating revision to first 12 chars 2017-05-25 02:11:45,755 Setting DEBUG logging. 2017-05-25 02:11:45,755 attempt 1/10 2017-05-25 02:11:45,755 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0ed0fd886134?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 02:11:46,067 unpacking tar archive at: mozilla-central-0ed0fd886134/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612784 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:46.506243) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:46.506543) ========= script_repo_revision: 0ed0fd886134b6698f593edbf0d362ac9e12fe07 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:46.506925) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:46.507196) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 02:11:46.514120) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2017-05-25 02:11:46.514585) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:11:46 INFO - MultiFileLogger online at 20170525 02:11:46 in /builds/slave/test 02:11:46 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:11:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:11:46 INFO - {'append_to_log': False, 02:11:46 INFO - 'base_work_dir': '/builds/slave/test', 02:11:46 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 02:11:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:11:46 INFO - 'branch': 'Firefox-Non-PGO', 02:11:46 INFO - 'buildbot_json_path': 'buildprops.json', 02:11:46 INFO - 'config_files': ('talos/linux_config.py',), 02:11:46 INFO - 'default_actions': ('clobber', 02:11:46 INFO - 'read-buildbot-config', 02:11:46 INFO - 'download-and-extract', 02:11:46 INFO - 'populate-webroot', 02:11:46 INFO - 'create-virtualenv', 02:11:46 INFO - 'install', 02:11:46 INFO - 'run-tests'), 02:11:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:11:46 INFO - 'download_minidump_stackwalk': True, 02:11:46 INFO - 'download_symbols': 'ondemand', 02:11:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:11:46 INFO - 'tooltool.py': '/tools/tooltool.py', 02:11:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:11:46 INFO - '/tools/misc-python/virtualenv.py')}, 02:11:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:11:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:11:46 INFO - 'gecko_profile': False, 02:11:46 INFO - 'gecko_profile_interval': 0, 02:11:46 INFO - 'installer_path': 'installer.exe', 02:11:46 INFO - 'log_level': 'info', 02:11:46 INFO - 'log_name': 'talos', 02:11:46 INFO - 'log_to_console': True, 02:11:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:11:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:11:46 INFO - 'opt_config_files': (), 02:11:46 INFO - 'pip_index': False, 02:11:46 INFO - 'suite': 'dromaeojs-e10s', 02:11:46 INFO - 'system_bits': '32', 02:11:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:11:46 INFO - 'title': 'talos-linux64-ix-064', 02:11:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:11:46 INFO - 'use_talos_json': True, 02:11:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:11:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:11:46 INFO - 'work_dir': 'build'} 02:11:46 INFO - [mozharness: 2017-05-25 09:11:46.577862Z] Running clobber step. 02:11:46 INFO - Running pre-action listener: _resource_record_pre_action 02:11:46 INFO - Running main action method: clobber 02:11:46 INFO - rmtree: /builds/slave/test/build 02:11:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:11:47 INFO - Running post-action listener: _resource_record_post_action 02:11:47 INFO - [mozharness: 2017-05-25 09:11:47.626539Z] Finished clobber step (success) 02:11:47 INFO - [mozharness: 2017-05-25 09:11:47.626640Z] Running read-buildbot-config step. 02:11:47 INFO - Running pre-action listener: _resource_record_pre_action 02:11:47 INFO - Running main action method: read_buildbot_config 02:11:47 INFO - Using buildbot properties: 02:11:47 INFO - { 02:11:47 INFO - "project": "", 02:11:47 INFO - "product": "firefox", 02:11:47 INFO - "who": "archaeopteryx@coole-files.de", 02:11:47 INFO - "installer_path": "public/build/target.tar.bz2", 02:11:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 02:11:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:11:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 02:11:47 INFO - "stage_platform": "linux64", 02:11:47 INFO - "basedir": "/builds/slave/test", 02:11:47 INFO - "buildnumber": 901, 02:11:47 INFO - "platform": "ubuntu64_hw", 02:11:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:11:47 INFO - "slavebuilddir": "test", 02:11:47 INFO - "taskId": "Reu8dm6rQdWCcNl0NQbdxg", 02:11:47 INFO - "branch": "mozilla-central", 02:11:47 INFO - "script_repo_revision": "production", 02:11:47 INFO - "revision": "0ed0fd886134b6698f593edbf0d362ac9e12fe07", 02:11:47 INFO - "slavename": "talos-linux64-ix-064", 02:11:47 INFO - "repo_path": "mozilla-central" 02:11:47 INFO - } 02:11:47 INFO - Finding installer, test and symbols from parent task. 02:11:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Reu8dm6rQdWCcNl0NQbdxg'}, attempt #1 02:11:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Reu8dm6rQdWCcNl0NQbdxg'}, attempt #1 02:11:48 INFO - Task dependencies: PfMpf1BXTwSiZjrW9lNioQ 02:11:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ'}, attempt #1 02:11:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.tar.bz2 02:11:48 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/test_packages.json 02:11:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.crashreporter-symbols.zip 02:11:48 INFO - Running post-action listener: _resource_record_post_action 02:11:48 INFO - [mozharness: 2017-05-25 09:11:48.985778Z] Finished read-buildbot-config step (success) 02:11:48 INFO - [mozharness: 2017-05-25 09:11:48.985997Z] Running download-and-extract step. 02:11:48 INFO - Running pre-action listener: _resource_record_pre_action 02:11:48 INFO - Running main action method: download_and_extract 02:11:48 INFO - mkdir: /builds/slave/test/build/tests 02:11:48 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:11:48 INFO - trying https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.test_packages.json 02:11:48 INFO - Downloading https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:11:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:11:49 INFO - Downloaded 989 bytes. 02:11:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:11:49 INFO - Using the following test package requirements: 02:11:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:11:49 INFO - u'common': [u'target.common.tests.zip'], 02:11:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:11:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:11:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:11:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:11:49 INFO - u'mozbase': [u'target.common.tests.zip'], 02:11:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:11:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:11:49 INFO - u'web-platform': [u'target.common.tests.zip', 02:11:49 INFO - u'target.web-platform.tests.tar.gz'], 02:11:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:11:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:11:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.common.tests.zip 02:11:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:11:49 INFO - Fetch https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.common.tests.zip into memory 02:12:06 INFO - Content-Length response header: 63524947 02:12:06 INFO - Bytes received: 63524947 02:12:17 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:12:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.common.tests.zip 02:12:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:12:17 INFO - Fetch https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.common.tests.zip into memory 02:12:18 INFO - Content-Length response header: 63524947 02:12:18 INFO - Bytes received: 63524947 02:12:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.talos.tests.zip 02:12:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:12:30 INFO - Fetch https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.talos.tests.zip into memory 02:12:32 INFO - Content-Length response header: 14411859 02:12:32 INFO - Bytes received: 14411859 02:12:33 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:12:33 INFO - trying https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.tar.bz2 02:12:33 INFO - Downloading https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:12:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:12:36 INFO - Downloaded 53973286 bytes. 02:12:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.tar.bz2 02:12:36 INFO - mkdir: /builds/slave/test/properties 02:12:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:12:36 INFO - Writing to file /builds/slave/test/properties/build_url 02:12:36 INFO - Contents: 02:12:36 INFO - build_url:https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.tar.bz2 02:12:36 INFO - Running post-action listener: _resource_record_post_action 02:12:36 INFO - Running post-action listener: set_extra_try_arguments 02:12:36 INFO - [mozharness: 2017-05-25 09:12:36.008851Z] Finished download-and-extract step (success) 02:12:36 INFO - [mozharness: 2017-05-25 09:12:36.008948Z] Running populate-webroot step. 02:12:36 INFO - Running pre-action listener: _resource_record_pre_action 02:12:36 INFO - Running main action method: populate_webroot 02:12:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:12:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:12:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:12:36 INFO - '--tppagecycles', 02:12:36 INFO - '7'], 02:12:36 INFO - 'tests': ['tsvgm']}}, 02:12:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:12:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:12:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:12:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:12:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:12:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:12:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:12:36 INFO - 'talos_options': ['--disable-e10s'], 02:12:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:12:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:12:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:12:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:12:36 INFO - 'talos_options': ['--disable-e10s'], 02:12:36 INFO - 'tests': ['damp', 'tps']}, 02:12:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:12:36 INFO - 'tests': ['damp', 'tps']}, 02:12:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:12:36 INFO - 'tests': ['dromaeo_dom']}, 02:12:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:12:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:12:36 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:12:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:12:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:12:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:12:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:12:36 INFO - 'tests': ['a11yr', 02:12:36 INFO - 'ts_paint', 02:12:36 INFO - 'tpaint', 02:12:36 INFO - 'sessionrestore', 02:12:36 INFO - 'sessionrestore_no_auto_restore', 02:12:36 INFO - 'tabpaint']}, 02:12:36 INFO - 'other-e10s': {'tests': ['a11yr', 02:12:36 INFO - 'ts_paint', 02:12:36 INFO - 'tpaint', 02:12:36 INFO - 'sessionrestore', 02:12:36 INFO - 'sessionrestore_no_auto_restore', 02:12:36 INFO - 'tabpaint']}, 02:12:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:12:36 INFO - 'ts_paint', 02:12:36 INFO - 'tpaint', 02:12:36 INFO - 'sessionrestore', 02:12:36 INFO - 'sessionrestore_no_auto_restore', 02:12:36 INFO - 'tabpaint']}, 02:12:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:12:36 INFO - 'ts_paint', 02:12:36 INFO - 'tpaint', 02:12:36 INFO - 'sessionrestore', 02:12:36 INFO - 'sessionrestore_no_auto_restore', 02:12:36 INFO - 'tabpaint']}, 02:12:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:12:36 INFO - 'tests': ['a11yr', 02:12:36 INFO - 'ts_paint', 02:12:36 INFO - 'tpaint', 02:12:36 INFO - 'sessionrestore', 02:12:36 INFO - 'sessionrestore_no_auto_restore', 02:12:36 INFO - 'tabpaint']}, 02:12:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:12:36 INFO - 'tests': ['a11yr', 02:12:36 INFO - 'ts_paint', 02:12:36 INFO - 'tpaint', 02:12:36 INFO - 'sessionrestore', 02:12:36 INFO - 'sessionrestore_no_auto_restore', 02:12:36 INFO - 'tabpaint']}, 02:12:36 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:12:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:12:36 INFO - 'bloom_basic_ref']}, 02:12:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:12:36 INFO - 'tests': ['tsvgx', 02:12:36 INFO - 'tsvgr_opacity', 02:12:36 INFO - 'tart', 02:12:36 INFO - 'tscrollx', 02:12:36 INFO - 'cart', 02:12:36 INFO - 'tsvg_static']}, 02:12:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:12:36 INFO - 'tsvgr_opacity', 02:12:36 INFO - 'tart', 02:12:36 INFO - 'tscrollx', 02:12:36 INFO - 'cart', 02:12:36 INFO - 'tsvg_static']}, 02:12:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:12:36 INFO - 'talos_options': ['--disable-e10s'], 02:12:36 INFO - 'tests': ['tp5o']}, 02:12:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:12:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:12:36 INFO - 'talos_options': ['--disable-e10s', 02:12:36 INFO - '--xperf_path', 02:12:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:12:36 INFO - 'tests': ['tp5n']}, 02:12:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:12:36 INFO - 'talos_options': ['--xperf_path', 02:12:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:12:36 INFO - 'tests': ['tp5n']}}, 02:12:36 INFO - 'talos.zip': {'path': '', 02:12:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:12:36 INFO - Running post-action listener: _resource_record_post_action 02:12:36 INFO - [mozharness: 2017-05-25 09:12:36.025153Z] Finished populate-webroot step (success) 02:12:36 INFO - [mozharness: 2017-05-25 09:12:36.025261Z] Running create-virtualenv step. 02:12:36 INFO - Running pre-action listener: _resource_record_pre_action 02:12:36 INFO - Running main action method: create_virtualenv 02:12:36 INFO - Creating virtualenv /builds/slave/test/build/venv 02:12:36 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:12:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:12:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:12:36 INFO - Using real prefix '/usr' 02:12:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:12:36 INFO - Installing distribute.............................................................................................................................................................................................done. 02:12:38 INFO - Installing pip.................done. 02:12:38 INFO - Return code: 0 02:12:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:12:39 INFO - Reading from file tmpfile_stdout 02:12:39 INFO - Output received: 02:12:39 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:12:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:12:39 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:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:39 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:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:39 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 0x21c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25365c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25337a0>, '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 0x25346a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', '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:12:39 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:12:39 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:12:39 INFO - Using env: {'DISPLAY': ':0', 02:12:39 INFO - 'HOME': '/home/cltbld', 02:12:39 INFO - 'LANG': 'en_US.UTF-8', 02:12:39 INFO - 'LANGUAGE': 'en_US:en', 02:12:39 INFO - 'LOGNAME': 'cltbld', 02:12:39 INFO - 'MAIL': '/var/mail/cltbld', 02:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:39 INFO - 'MOZ_NO_REMOTE': '1', 02:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:39 INFO - 'NO_EM_RESTART': '1', 02:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:39 INFO - 'PWD': '/builds/slave/test', 02:12:39 INFO - 'SHELL': '/bin/bash', 02:12:39 INFO - 'SHLVL': '1', 02:12:39 INFO - 'TERM': 'linux', 02:12:39 INFO - 'TMOUT': '86400', 02:12:39 INFO - 'USER': 'cltbld', 02:12:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', 02:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:39 INFO - '_': '/tools/buildbot/bin/python'} 02:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:39 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:12:39 INFO - Cleaning up... 02:12:39 INFO - Return code: 0 02:12:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:12:39 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:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:39 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:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:39 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 0x21c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25365c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25337a0>, '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 0x25346a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', '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:12:39 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:12:39 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:12:39 INFO - Using env: {'DISPLAY': ':0', 02:12:39 INFO - 'HOME': '/home/cltbld', 02:12:39 INFO - 'LANG': 'en_US.UTF-8', 02:12:39 INFO - 'LANGUAGE': 'en_US:en', 02:12:39 INFO - 'LOGNAME': 'cltbld', 02:12:39 INFO - 'MAIL': '/var/mail/cltbld', 02:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:39 INFO - 'MOZ_NO_REMOTE': '1', 02:12:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:39 INFO - 'NO_EM_RESTART': '1', 02:12:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:39 INFO - 'PWD': '/builds/slave/test', 02:12:39 INFO - 'SHELL': '/bin/bash', 02:12:39 INFO - 'SHLVL': '1', 02:12:39 INFO - 'TERM': 'linux', 02:12:39 INFO - 'TMOUT': '86400', 02:12:39 INFO - 'USER': 'cltbld', 02:12:39 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', 02:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:39 INFO - '_': '/tools/buildbot/bin/python'} 02:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:39 INFO - Downloading/unpacking psutil>=3.1.1 02:12:39 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:12:39 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:12:39 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:12:39 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:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:12:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:12:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:12:40 INFO - Installing collected packages: psutil 02:12:40 INFO - Running setup.py install for psutil 02:12:40 INFO - building 'psutil._psutil_linux' extension 02:12:40 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:12:41 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:12:41 INFO - building 'psutil._psutil_posix' extension 02:12:41 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:12:42 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:12:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:12:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:12:42 INFO - Successfully installed psutil 02:12:42 INFO - Cleaning up... 02:12:42 INFO - Return code: 0 02:12:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:12:42 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:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:42 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:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:42 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 0x21c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25365c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25337a0>, '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 0x25346a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', '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:12:42 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:12:42 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:12:42 INFO - Using env: {'DISPLAY': ':0', 02:12:42 INFO - 'HOME': '/home/cltbld', 02:12:42 INFO - 'LANG': 'en_US.UTF-8', 02:12:42 INFO - 'LANGUAGE': 'en_US:en', 02:12:42 INFO - 'LOGNAME': 'cltbld', 02:12:42 INFO - 'MAIL': '/var/mail/cltbld', 02:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:42 INFO - 'MOZ_NO_REMOTE': '1', 02:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:42 INFO - 'NO_EM_RESTART': '1', 02:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:42 INFO - 'PWD': '/builds/slave/test', 02:12:42 INFO - 'SHELL': '/bin/bash', 02:12:42 INFO - 'SHLVL': '1', 02:12:42 INFO - 'TERM': 'linux', 02:12:42 INFO - 'TMOUT': '86400', 02:12:42 INFO - 'USER': 'cltbld', 02:12:42 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', 02:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:42 INFO - '_': '/tools/buildbot/bin/python'} 02:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:12:42 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:12:42 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:12:42 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:12:42 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:12:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:12:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:12:43 INFO - Installing collected packages: mozsystemmonitor 02:12:43 INFO - Running setup.py install for mozsystemmonitor 02:12:43 INFO - Successfully installed mozsystemmonitor 02:12:43 INFO - Cleaning up... 02:12:43 INFO - Return code: 0 02:12:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:12:43 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:12:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:43 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:12:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:43 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 0x21c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25365c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25337a0>, '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 0x25346a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', '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:12:43 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:12:43 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:12:43 INFO - Using env: {'DISPLAY': ':0', 02:12:43 INFO - 'HOME': '/home/cltbld', 02:12:43 INFO - 'LANG': 'en_US.UTF-8', 02:12:43 INFO - 'LANGUAGE': 'en_US:en', 02:12:43 INFO - 'LOGNAME': 'cltbld', 02:12:43 INFO - 'MAIL': '/var/mail/cltbld', 02:12:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:43 INFO - 'MOZ_NO_REMOTE': '1', 02:12:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:43 INFO - 'NO_EM_RESTART': '1', 02:12:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:43 INFO - 'PWD': '/builds/slave/test', 02:12:43 INFO - 'SHELL': '/bin/bash', 02:12:43 INFO - 'SHLVL': '1', 02:12:43 INFO - 'TERM': 'linux', 02:12:43 INFO - 'TMOUT': '86400', 02:12:43 INFO - 'USER': 'cltbld', 02:12:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', 02:12:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:43 INFO - '_': '/tools/buildbot/bin/python'} 02:12:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:43 INFO - Downloading/unpacking jsonschema==2.5.1 02:12:43 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:12:43 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:12:43 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:12:43 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:12:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:12:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:12:44 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:12:44 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:12:44 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:12:44 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:12:45 INFO - Downloading functools32-3.2.3-2.tar.gz 02:12:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:12:45 INFO - warning: no files found matching '*.txt' 02:12:45 INFO - no previously-included directories found matching 'build' 02:12:45 INFO - no previously-included directories found matching 'dist' 02:12:45 INFO - no previously-included directories found matching '.git*' 02:12:45 INFO - Installing collected packages: jsonschema, functools32 02:12:45 INFO - Running setup.py install for functools32 02:12:45 INFO - warning: no files found matching '*.txt' 02:12:45 INFO - no previously-included directories found matching 'build' 02:12:45 INFO - no previously-included directories found matching 'dist' 02:12:45 INFO - no previously-included directories found matching '.git*' 02:12:45 INFO - Successfully installed jsonschema functools32 02:12:45 INFO - Cleaning up... 02:12:45 INFO - Return code: 0 02:12:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:12:45 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:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:45 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:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:45 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 0x21c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25365c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25337a0>, '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 0x25346a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', '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:12:45 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:12:45 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:12:45 INFO - Using env: {'DISPLAY': ':0', 02:12:45 INFO - 'HOME': '/home/cltbld', 02:12:45 INFO - 'LANG': 'en_US.UTF-8', 02:12:45 INFO - 'LANGUAGE': 'en_US:en', 02:12:45 INFO - 'LOGNAME': 'cltbld', 02:12:45 INFO - 'MAIL': '/var/mail/cltbld', 02:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:45 INFO - 'MOZ_NO_REMOTE': '1', 02:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:45 INFO - 'NO_EM_RESTART': '1', 02:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:45 INFO - 'PWD': '/builds/slave/test', 02:12:45 INFO - 'SHELL': '/bin/bash', 02:12:45 INFO - 'SHLVL': '1', 02:12:45 INFO - 'TERM': 'linux', 02:12:45 INFO - 'TMOUT': '86400', 02:12:45 INFO - 'USER': 'cltbld', 02:12:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', 02:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:45 INFO - '_': '/tools/buildbot/bin/python'} 02:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:12:45 INFO - Cleaning up... 02:12:45 INFO - Return code: 0 02:12:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:12:45 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:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:45 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:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:45 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 0x21c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25365c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25337a0>, '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 0x25346a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', '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:12:45 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:12:45 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:12:45 INFO - Using env: {'DISPLAY': ':0', 02:12:45 INFO - 'HOME': '/home/cltbld', 02:12:45 INFO - 'LANG': 'en_US.UTF-8', 02:12:45 INFO - 'LANGUAGE': 'en_US:en', 02:12:45 INFO - 'LOGNAME': 'cltbld', 02:12:45 INFO - 'MAIL': '/var/mail/cltbld', 02:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:45 INFO - 'MOZ_NO_REMOTE': '1', 02:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:45 INFO - 'NO_EM_RESTART': '1', 02:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:45 INFO - 'PWD': '/builds/slave/test', 02:12:45 INFO - 'SHELL': '/bin/bash', 02:12:45 INFO - 'SHLVL': '1', 02:12:45 INFO - 'TERM': 'linux', 02:12:45 INFO - 'TMOUT': '86400', 02:12:45 INFO - 'USER': 'cltbld', 02:12:45 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', 02:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:45 INFO - '_': '/tools/buildbot/bin/python'} 02:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:45 INFO - Downloading/unpacking blobuploader==1.2.4 02:12:45 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:12:45 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:12:45 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:12:45 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:12:46 INFO - Downloading blobuploader-1.2.4.tar.gz 02:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:12:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:12:46 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:12:46 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:12:46 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:12:46 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:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:12:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:12:47 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:12:47 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:12:47 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:12:47 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:12:47 INFO - Downloading docopt-0.6.1.tar.gz 02:12:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:12:47 INFO - Installing collected packages: blobuploader, requests, docopt 02:12:47 INFO - Running setup.py install for blobuploader 02:12:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:12:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:12:47 INFO - Running setup.py install for requests 02:12:47 INFO - Running setup.py install for docopt 02:12:48 INFO - Successfully installed blobuploader requests docopt 02:12:48 INFO - Cleaning up... 02:12:48 INFO - Return code: 0 02:12:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:48 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:12:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:48 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:12:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:48 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 0x21c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25365c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25337a0>, '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 0x25346a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', '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:12:48 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:12:48 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:12:48 INFO - Using env: {'DISPLAY': ':0', 02:12:48 INFO - 'HOME': '/home/cltbld', 02:12:48 INFO - 'LANG': 'en_US.UTF-8', 02:12:48 INFO - 'LANGUAGE': 'en_US:en', 02:12:48 INFO - 'LOGNAME': 'cltbld', 02:12:48 INFO - 'MAIL': '/var/mail/cltbld', 02:12:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:48 INFO - 'MOZ_NO_REMOTE': '1', 02:12:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:48 INFO - 'NO_EM_RESTART': '1', 02:12:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:48 INFO - 'PWD': '/builds/slave/test', 02:12:48 INFO - 'SHELL': '/bin/bash', 02:12:48 INFO - 'SHLVL': '1', 02:12:48 INFO - 'TERM': 'linux', 02:12:48 INFO - 'TMOUT': '86400', 02:12:48 INFO - 'USER': 'cltbld', 02:12:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', 02:12:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:48 INFO - '_': '/tools/buildbot/bin/python'} 02:12:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:48 INFO - Running setup.py (path:/tmp/pip-NjQbtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:48 INFO - Running setup.py (path:/tmp/pip-yfh8sW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:48 INFO - Running setup.py (path:/tmp/pip-85_37r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:48 INFO - Running setup.py (path:/tmp/pip-AffFFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:48 INFO - Running setup.py (path:/tmp/pip-ZqQTfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:48 INFO - Running setup.py (path:/tmp/pip-YVIBA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:48 INFO - Running setup.py (path:/tmp/pip-9H_j8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:48 INFO - Running setup.py (path:/tmp/pip-nz2d4T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:48 INFO - Running setup.py (path:/tmp/pip-P0wnxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:48 INFO - Running setup.py (path:/tmp/pip-umKRMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:49 INFO - Running setup.py (path:/tmp/pip-ay1goO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:49 INFO - Running setup.py (path:/tmp/pip-NGVxQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:49 INFO - Running setup.py (path:/tmp/pip-nLN2_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:49 INFO - Running setup.py (path:/tmp/pip-EYyDhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:49 INFO - Running setup.py (path:/tmp/pip-XLienU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:49 INFO - Running setup.py (path:/tmp/pip-20sVEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:49 INFO - Running setup.py (path:/tmp/pip-8zP4qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:12:49 INFO - Running setup.py install for manifestparser 02:12:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:12:49 INFO - Running setup.py install for mozcrash 02:12:49 INFO - Running setup.py install for mozdebug 02:12:49 INFO - Running setup.py install for mozdevice 02:12:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:12:49 INFO - Running setup.py install for mozfile 02:12:50 INFO - Running setup.py install for mozhttpd 02:12:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:12:50 INFO - Running setup.py install for mozinfo 02:12:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:12:50 INFO - Running setup.py install for mozInstall 02:12:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:12:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:12:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:12:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:12:50 INFO - Running setup.py install for mozleak 02:12:50 INFO - Running setup.py install for mozlog 02:12:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:12:50 INFO - Running setup.py install for moznetwork 02:12:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:12:50 INFO - Running setup.py install for mozprocess 02:12:50 INFO - Running setup.py install for mozprofile 02:12:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:12:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:12:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:12:50 INFO - Running setup.py install for mozrunner 02:12:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:12:51 INFO - Running setup.py install for mozscreenshot 02:12:51 INFO - Running setup.py install for moztest 02:12:51 INFO - Running setup.py install for mozversion 02:12:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:12:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:12:51 INFO - Cleaning up... 02:12:51 INFO - Return code: 0 02:12:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:51 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:12:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:51 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:12:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:51 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 0x21c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25365c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25337a0>, '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 0x25346a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', '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:12:51 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:12:51 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:12:51 INFO - Using env: {'DISPLAY': ':0', 02:12:51 INFO - 'HOME': '/home/cltbld', 02:12:51 INFO - 'LANG': 'en_US.UTF-8', 02:12:51 INFO - 'LANGUAGE': 'en_US:en', 02:12:51 INFO - 'LOGNAME': 'cltbld', 02:12:51 INFO - 'MAIL': '/var/mail/cltbld', 02:12:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:51 INFO - 'MOZ_NO_REMOTE': '1', 02:12:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:51 INFO - 'NO_EM_RESTART': '1', 02:12:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:51 INFO - 'PWD': '/builds/slave/test', 02:12:51 INFO - 'SHELL': '/bin/bash', 02:12:51 INFO - 'SHLVL': '1', 02:12:51 INFO - 'TERM': 'linux', 02:12:51 INFO - 'TMOUT': '86400', 02:12:51 INFO - 'USER': 'cltbld', 02:12:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', 02:12:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:51 INFO - '_': '/tools/buildbot/bin/python'} 02:12:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:12:51 INFO - Running setup.py (path:/tmp/pip-mb0XFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:12:51 INFO - Running setup.py (path:/tmp/pip-cO_Cl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:12:51 INFO - Running setup.py (path:/tmp/pip-RYBN5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:12:51 INFO - Running setup.py (path:/tmp/pip-560ThR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:12:51 INFO - Running setup.py (path:/tmp/pip-IGBXB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:12:51 INFO - Running setup.py (path:/tmp/pip-GzYc50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:12:51 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:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:12:51 INFO - Running setup.py (path:/tmp/pip-Sjx_uN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:12:52 INFO - Running setup.py (path:/tmp/pip-YeAliV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:12:52 INFO - Running setup.py (path:/tmp/pip-OqC6VY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:12:52 INFO - Running setup.py (path:/tmp/pip-nIIqz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:12:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:12:52 INFO - Running setup.py (path:/tmp/pip-tjXSYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:12:52 INFO - Running setup.py (path:/tmp/pip-INO4Wn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:12:52 INFO - Running setup.py (path:/tmp/pip-l8Rlum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:12:52 INFO - Running setup.py (path:/tmp/pip-HNeuIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:52 INFO - Running setup.py (path:/tmp/pip-gz7yDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:12:52 INFO - Running setup.py (path:/tmp/pip-8qmX_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:12:52 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:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:12:52 INFO - Running setup.py (path:/tmp/pip-J50omA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:12:52 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:12:52 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:12:52 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:12:52 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:12:52 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:12:52 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:12:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:12:52 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:12:52 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:12:52 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:12:52 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:12:53 INFO - Downloading blessings-1.6.tar.gz 02:12:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:12:53 INFO - Installing collected packages: blessings 02:12:53 INFO - Running setup.py install for blessings 02:12:54 INFO - Successfully installed blessings 02:12:54 INFO - Cleaning up... 02:12:54 INFO - Return code: 0 02:12:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:12:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:12:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:12:54 INFO - Reading from file tmpfile_stdout 02:12:54 INFO - Current package versions: 02:12:54 INFO - argparse == 1.2.1 02:12:54 INFO - blessings == 1.6 02:12:54 INFO - blobuploader == 1.2.4 02:12:54 INFO - docopt == 0.6.1 02:12:54 INFO - functools32 == 3.2.3-2 02:12:54 INFO - jsonschema == 2.5.1 02:12:54 INFO - manifestparser == 1.1 02:12:54 INFO - mozInstall == 1.12 02:12:54 INFO - mozcrash == 1.0 02:12:54 INFO - mozdebug == 0.1 02:12:54 INFO - mozdevice == 0.51 02:12:54 INFO - mozfile == 1.2 02:12:54 INFO - mozhttpd == 0.7 02:12:54 INFO - mozinfo == 0.9 02:12:54 INFO - mozleak == 0.1 02:12:54 INFO - mozlog == 3.4 02:12:54 INFO - moznetwork == 0.27 02:12:54 INFO - mozprocess == 0.25 02:12:54 INFO - mozprofile == 0.28 02:12:54 INFO - mozrunner == 6.13 02:12:54 INFO - mozscreenshot == 0.1 02:12:54 INFO - mozsystemmonitor == 0.3 02:12:54 INFO - moztest == 0.8 02:12:54 INFO - mozversion == 1.4 02:12:54 INFO - psutil == 3.1.1 02:12:54 INFO - requests == 1.2.3 02:12:54 INFO - wsgiref == 0.1.2 02:12:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:12:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:54 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 0x21c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25365c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25337a0>, '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 0x25346a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', '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:12:54 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:12:54 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:12:54 INFO - Using env: {'DISPLAY': ':0', 02:12:54 INFO - 'HOME': '/home/cltbld', 02:12:54 INFO - 'LANG': 'en_US.UTF-8', 02:12:54 INFO - 'LANGUAGE': 'en_US:en', 02:12:54 INFO - 'LOGNAME': 'cltbld', 02:12:54 INFO - 'MAIL': '/var/mail/cltbld', 02:12:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:54 INFO - 'MOZ_NO_REMOTE': '1', 02:12:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:54 INFO - 'NO_EM_RESTART': '1', 02:12:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:54 INFO - 'PWD': '/builds/slave/test', 02:12:54 INFO - 'SHELL': '/bin/bash', 02:12:54 INFO - 'SHLVL': '1', 02:12:54 INFO - 'TERM': 'linux', 02:12:54 INFO - 'TMOUT': '86400', 02:12:54 INFO - 'USER': 'cltbld', 02:12:54 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', 02:12:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:54 INFO - '_': '/tools/buildbot/bin/python'} 02:12:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:54 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:12:54 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:12:54 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:12:54 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:12:54 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:12:54 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:12:54 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:12:54 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:12:54 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:12:54 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:12:54 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:12:54 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:12:54 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:12:54 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:12:55 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:12:55 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:12:55 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:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:12:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:12:55 INFO - Installing collected packages: marionette-driver 02:12:55 INFO - Running setup.py install for marionette-driver 02:12:55 INFO - Successfully installed marionette-driver 02:12:55 INFO - Cleaning up... 02:12:55 INFO - Return code: 0 02:12:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:12:55 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:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:12:55 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:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:12:55 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 0x21c31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25365c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25337a0>, '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 0x25346a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b30>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', '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:12:55 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:12:55 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:12:55 INFO - Using env: {'DISPLAY': ':0', 02:12:55 INFO - 'HOME': '/home/cltbld', 02:12:55 INFO - 'LANG': 'en_US.UTF-8', 02:12:55 INFO - 'LANGUAGE': 'en_US:en', 02:12:55 INFO - 'LOGNAME': 'cltbld', 02:12:55 INFO - 'MAIL': '/var/mail/cltbld', 02:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:12:55 INFO - 'MOZ_NO_REMOTE': '1', 02:12:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:12:55 INFO - 'NO_EM_RESTART': '1', 02:12:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:12:55 INFO - 'PWD': '/builds/slave/test', 02:12:55 INFO - 'SHELL': '/bin/bash', 02:12:55 INFO - 'SHLVL': '1', 02:12:55 INFO - 'TERM': 'linux', 02:12:55 INFO - 'TMOUT': '86400', 02:12:55 INFO - 'USER': 'cltbld', 02:12:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', 02:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:12:55 INFO - '_': '/tools/buildbot/bin/python'} 02:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:12:56 INFO - Cleaning up... 02:12:56 INFO - Return code: 0 02:12:56 INFO - Running post-action listener: _resource_record_post_action 02:12:56 INFO - Running post-action listener: _start_resource_monitoring 02:12:56 INFO - Starting resource monitoring. 02:12:56 INFO - [mozharness: 2017-05-25 09:12:56.154981Z] Finished create-virtualenv step (success) 02:12:56 INFO - [mozharness: 2017-05-25 09:12:56.155914Z] Running install step. 02:12:56 INFO - Running pre-action listener: _resource_record_pre_action 02:12:56 INFO - Running main action method: install 02:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:12:56 INFO - Reading from file tmpfile_stdout 02:12:56 INFO - Detecting whether we're running mozinstall >=1.0... 02:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:12:56 INFO - Reading from file tmpfile_stdout 02:12:56 INFO - Output received: 02:12:56 INFO - Usage: mozinstall [options] installer 02:12:56 INFO - Options: 02:12:56 INFO - -h, --help show this help message and exit 02:12:56 INFO - -d DEST, --destination=DEST 02:12:56 INFO - Directory to install application into. [default: 02:12:56 INFO - "/builds/slave/test"] 02:12:56 INFO - --app=APP Application being installed. [default: firefox] 02:12:56 INFO - mkdir: /builds/slave/test/build/application 02:12:56 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:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:13:11 INFO - Reading from file tmpfile_stdout 02:13:11 INFO - Output received: 02:13:11 INFO - /builds/slave/test/build/application/firefox/firefox 02:13:11 INFO - Running post-action listener: _resource_record_post_action 02:13:11 INFO - [mozharness: 2017-05-25 09:13:11.973975Z] Finished install step (success) 02:13:11 INFO - [mozharness: 2017-05-25 09:13:11.974253Z] Running run-tests step. 02:13:11 INFO - Running pre-action listener: _resource_record_pre_action 02:13:11 INFO - Running main action method: run_tests 02:13:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:13:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:13:11 INFO - Python 2.7.3 02:13:11 INFO - Return code: 0 02:13:11 INFO - grabbing minidump binary from tooltool 02:13: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:13:11 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 0x25337a0>, '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 0x25346a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2534b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:13:11 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:13:11 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:13:11 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:13:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:13:12 INFO - Return code: 0 02:13:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:13:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:13:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:13:12 INFO - ENV: RUST_BACKTRACE is now 1 02:13:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:13:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:13:12 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/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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:13:12 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/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-064 --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:13:12 INFO - Using env: {'DISPLAY': ':0', 02:13:12 INFO - 'HOME': '/home/cltbld', 02:13:12 INFO - 'LANG': 'en_US.UTF-8', 02:13:12 INFO - 'LANGUAGE': 'en_US:en', 02:13:12 INFO - 'LOGNAME': 'cltbld', 02:13:12 INFO - 'MAIL': '/var/mail/cltbld', 02:13:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:13:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:13:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:13:12 INFO - 'MOZ_NO_REMOTE': '1', 02:13:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:13:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:13:12 INFO - 'NO_EM_RESTART': '1', 02:13:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:13:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:13:12 INFO - 'PWD': '/builds/slave/test', 02:13:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:13:12 INFO - 'RUST_BACKTRACE': '1', 02:13:12 INFO - 'SHELL': '/bin/bash', 02:13:12 INFO - 'SHLVL': '1', 02:13:12 INFO - 'TERM': 'linux', 02:13:12 INFO - 'TMOUT': '86400', 02:13:12 INFO - 'USER': 'cltbld', 02:13:12 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351', 02:13:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:13:12 INFO - '_': '/tools/buildbot/bin/python'} 02:13:12 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/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--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:13:12 INFO - mozversion application_buildid: 20170525083238 02:13:12 INFO - mozversion application_changeset: 0ed0fd886134b6698f593edbf0d362ac9e12fe07 02:13:12 INFO - mozversion application_display_name: Nightly 02:13:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:13:12 INFO - mozversion application_name: Firefox 02:13:12 INFO - mozversion application_remotingname: firefox 02:13:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:13:12 INFO - mozversion application_vendor: Mozilla 02:13:12 INFO - mozversion application_version: 55.0a1 02:13:12 INFO - mozversion platform_buildid: 20170525083238 02:13:12 INFO - mozversion platform_changeset: 0ed0fd886134b6698f593edbf0d362ac9e12fe07 02:13:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:13:12 INFO - mozversion platform_version: 55.0a1 02:13:12 INFO - using testdate: 1495703592 02:13:12 INFO - actual date: 1495703592 02:13:12 INFO - starting webserver on 'localhost:33927' 02:13:12 INFO - SUITE-START | Running 2 tests 02:13:12 INFO - TEST-START | dromaeo_css 02:13:12 INFO - operating with platform_type : linux_ 02:13:12 INFO - Initialising browser for dromaeo_css test... 02:13:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33927/getInfo.html -profile /tmp/tmpyQvGPe/profile 02:13:12 INFO - TEST-INFO | started process 3320 (/builds/slave/test/build/application/firefox/firefox http://localhost:33927/getInfo.html) 02:13:50 INFO - TEST-INFO | 3320: killed by SIGTERM 02:13:50 INFO - Browser initialized. 02:13:50 INFO - Running cycle 1/1 for dromaeo_css test... 02:13:50 INFO - TEST-INFO | started process 3517 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyQvGPe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:14:02 INFO - PID 3517 | RSS: Main: 172404736 02:14:02 INFO - PID 3517 | 02:17:06 INFO - PID 3517 | Cycle 1(1): loaded http://localhost:33927/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33927/tests/dromaeo/cssquery-ext.html) 02:17:08 INFO - PID 3517 | RSS: Main: 169578496 02:17:08 INFO - PID 3517 | 02:20:09 INFO - PID 3517 | Cycle 1(1): loaded http://localhost:33927/tests/dromaeo/cssquery-ext.html (next: http://localhost:33927/tests/dromaeo/cssquery-jquery.html) 02:20:10 INFO - PID 3517 | RSS: Main: 176214016 02:20:10 INFO - PID 3517 | 02:23:12 INFO - PID 3517 | Cycle 1(1): loaded http://localhost:33927/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33927/tests/dromaeo/cssquery-mootools.html) 02:23:12 INFO - PID 3517 | RSS: Main: 173678592 02:23:12 INFO - PID 3517 | 02:26:14 INFO - PID 3517 | Cycle 1(1): loaded http://localhost:33927/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33927/tests/dromaeo/cssquery-prototype.html) 02:26:15 INFO - PID 3517 | RSS: Main: 178180096 02:26:15 INFO - PID 3517 | 02:29:17 INFO - PID 3517 | Cycle 1(1): loaded http://localhost:33927/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33927/tests/dromaeo/cssquery-yui.html) 02:29:18 INFO - PID 3517 | RSS: Main: 178094080 02:29:18 INFO - PID 3517 | 02:32:20 INFO - PID 3517 | Cycle 1(1): loaded http://localhost:33927/tests/dromaeo/cssquery-yui.html (next: http://localhost:33927/tests/dromaeo/cssquery-dojo.html) 02:32:20 INFO - PID 3517 | RSS: Main: 175706112 02:32:20 INFO - PID 3517 | 02:32:20 INFO - PID 3517 | __start_tp_report 02:32:20 INFO - PID 3517 | _x_x_mozilla_page_load 02:32:20 INFO - PID 3517 | _x_x_mozilla_page_load_details 02:32:20 INFO - PID 3517 | |i|pagename|runs| 02:32:20 INFO - PID 3517 | |0;dojo.html;2715.18544436669;2726.2366537369544;2743.0810678422727;2758.903438379657;2759.8620068996547;5188.403333616635;5261.86845328867;5264.289320941672;5272.472752724726;5325.440828712983;5187.1181899077155;5198.2722418861385;5242.344706911636;5297.549708274792;5317.388500322464;4666.253399456088;4678.836240731575;4694.90610187796;4696.600788932928;4748.905021899577;4664.836730714425;4729.6216302695875;4747.810087596509;4762.523747625244;4775.785089670973;4615.699979501355;4672.901868061003;4687;4692.6339685763605;4755.952440475586;4545.749983750892;4626.653001024903;4648.442186937589;4649.209634362167;4660.930086048712;4626.768661566908;4628.352030715702;4634.698744581625;4650.395448591696;4682.08699303636;5195.558377537914;5196;5232.215167724872;5235;5304.25740396341;5660.377358490563;5690.089585666315;5722.97138514309;5724.9427505724825;5731.914021289684;5728.856778580527;5731.598788084836;5733.827985160452;5744.396838331957;5797.043487824546;5328.17413300939;5334.813281535127;5339.86650333737;5341.946580534183;5344.038073146793;5778.56660750437;5801.82594522165;5857.238558987389;5871.266091738533;5875.211463827195;5549.972250138804;5581.860453488614;5607.775688972395;5617.38208797032;5640.097584386478;5576.97211513948;5591.720413979285;5613.494785469327;5624.29696287964;5665.5467562594895;5498.1752737089755;5559.33288005442;5619.466150715675;5622.353429355677;5630.127330263816;5565.916511252334;5608.9439105609235;5635.6618602883955;5650.7174641267775;5660.264165658438;4771.427428708508;4773.809047638125;4785.1625965455905;4811.254255590389;4812.326274321597;4082.4284600155406;4085.530164031115;4091.7954102294766;4095.037666148453;4132.421460995463;4776.761161941889;4803.1114243864295;4808.855734327975;4840.709557426566;4843.4430040545085;5692.686902220417;5693.572982026365;5696.202531645573;5718.1136923776885;5734.16854556087;4803.447603525569;4804.111239420718;4806.615470762331;4819.373481447459;4851.199552073939;4911.705297682079;4940.752962351868;4981.352424184833;5017.648764586444;5017.974910125426;5301.973490132525;5311.946880531145;5326.786928522815;5350.143976963667;5356.223347614652;5540.833774986757;5627.831165065055;5683.801066962802;5684;5685.943140568541;5173.896522069613;5256.710880901434;5258.684478931276;5274.050670879278;5275.947240527546;5563.13771365439;5641.548676105819;5650.943490565206;5663;5667.4332566743;5640.605157638925;5641.689707065987;5644.379118296902;5720.828375148586;5764;5505.587080968863;5517.393086760373;5525.309336332958;5543.223948647112;5546.556275498031;5510.834674959758;5518.613697041169;5520.171974203901;5527.917081243704;5529.115341545334;5353.437889021597;5353.839384818461;5425.810096646598;5463.48096930791;5487.368952570506;5614;5626.774929002794;5629.8592535186945;5637.182608521659;5663.773449062156;5394.352677678704;5434.75543600531;5444.455554444524;5447.291852059207;5448.264484294569 02:32:20 INFO - PID 3517 | |1;ext.html;686.8832298509253;700.9579425234487;716.6094478509214;1147.1797664669764;1206.6018213989385;32653.346933061326;33625.99999999997;33681.83159084207;33708.325833483344;33721.831390843014;32297.838510807414;32489.67510324896;32663.346733065326;32666.836665816638;32688.509672354932;6226.159468471744;6387.680615969206;6554.639494827783;6555.34446555343;6558.409743123118;6490.610563366213;6529.085927970064;6560.507961902877;6571.244306904696;6581.901271480931;6563.474922006252;6568.113304703852;6611.801645950605;6617.239017512999;6620.172478440195;6561.901571476432;6593.472522198213;6594.373534514213;6597.043428702836;6601.108850305195;6483.935160648381;6619.834504137387;6659.367360100783;6666.966665166691;6699.59802411852;31343.84328078368;31388.21529461759;31423.214419639462;31600.525992110135;31631.683683163104;3008.0524634739986;3017.215523963763;3038.756899448061;3040.452718510667;3043.3000409905844;24204.636930446057;24273.7572624275;24446.511069778506;24448;24523.934508186478;2784.3735159589132;2787.512185367573;2791.330080780598;2795.1893950754256;2835.5463125899964;140499;140706;141070;150134.24932875374;157310.99999999886;39491.80254098769;39663;39738.41046358113;39753.40369894454;39767.20465590672;41339.586604133576;41464.79267603643;41469.37795933063;43426.131477370276;44213.11573768571;13494.662633434242;13593.932030339984;13594.048416610742;13638.795418068737;13665;10906.34561926287;11047.226694131494;11060.22578419519;11064.612738554111;11081.833772493419;12875.549355772502;12923.676908077374;12925.224486530838;12928.288944107977;13133.949284057253;5280.577553795687;5404.756785944642;5559.444055594408;5584.078627026576;5591.496765291144;841.7979684875586;895.9955200223957;913.3287034029983;913.7898283394857;941.5151197133482;19509.90245048794;20355.898220509098;20697.586048279252;21211;21291.148354065663;981.7398389426808;985.2364417576292;989.1789814453986;999.165696643311;1009.3792317724547;10527.473626318806;10965.451727413598;11020.338779673246;11258.211925165324;11270.94364528172;175510.12244938948;176276;176613;176641;177166;39825.2034959305;39990;40129.19741605152;40235.59764402377;40302.59697403047;1214.5991822698488;1255.9417817613958;1258.3582372989658;1265.240855486719;1270.7458508298378;19288.8071119287;19724.30964916221;20555.38333849987;20591.279305224245;21091.367258982256;29390.412191756473;29437;29453.410931781673;29595.704042959296;29603.259918502208;149028.254858725;149583;150009;150244;150469.24765376103;28665.28336791597;28795.28011799722;28907.855460722563;28962.27594310159;29186.416271674872;34847;35640.82179589189;35828.283434331686;35850.28299434049;36191.81904090463;26706.332341691614;26824.731752682223;27014.594781078693;27212;27541.86229068922;26615.866920665274;26706.19881403561;27323.316917076438;27370.315742106606;27556.173314800588;29552.704472955855;29583.112506624835;29592.556111657912;29665.703342966295;29781.851090744407;24942.37644058913;25493;25891.22326330213;25973.22080337593;27448.862755686892;19957.301494447624;22438.77561224367;22764.20325288607;22926;22984.195553155558 02:32:20 INFO - PID 3517 | |2;jquery.html;395.229302859424;406.0157839876903;417.90179307862655;429.4267153350277;431.17645297481795;17128.657426851456;17807.109644517754;17825.82174178258;18784.342548010787;19580.70628940567;17573.7363939541;17674.38139665112;17706.114694265267;17868.28526858924;17976.4607061788;5161.380634323887;5456.945430545684;5493.313335833021;5661.8584535386535;5664.065429204176;5288.021715982536;5377.838664840061;5385.138377859544;5391.514763671269;5396.83809485716;5293.15309550472;5339.145736682131;5359.839204823861;5374.4894235047805;5379.246905433242;5205.063088644042;5241.449647787003;5264.105102132647;5268.104422248189;5275.70983595904;4772.403449568804;4775.570198682135;4775.737334446604;4796.472388037313;4800.711957282574;21786.564268714537;21881.562368752537;22016.33950981473;22075.448113797283;22099;1629.6496253305477;1652.5620710511723;1654.2225154177518;1663.6922169398579;1666.1419369024961;14207.502737404244;14240.786388204186;14318.856811431857;14657.413703451955;14752.926235368754;1990.562076343202;2013.2852837242715;2036.9898150509152;2084.8957552122333;2085.7497100347905;80899.19100808975;82160.58919705423;82777;82859.58570207171;83672.58163709204;11004.944975275072;11046.779064418666;11120.666380008613;11220.587573671699;11433.656990290305;15892.841071589137;15903.602409939844;15978.121203333696;15997.200139992954;16018.279177437043;7273.89089163663;7401.740939067215;7538.472306938462;7669.118051424046;7729.227077292226;6594.625934663517;6697.8995315070315;6873.140857392826;6887.311268873173;6918.135233095863;6770.69531871067;6913.2049814272;7019.298070193042;7048.859022819617;7092.113485814273;1990.1490615658747;2017.818396344336;2021.878687278768;2041.693745938121;2227.554489102186;834.8539005673982;871.2681347667989;872.9432586881833;885.5262434597588;912.2154946745793;16571;16625.418110366078;16899;16945.98324100558;17557.824421755875;877.1491653096487;881.5592203898051;882.1355072029447;892.5448021509077;909.0092696993695;9090.136437038604;9130.406523575946;9347.392419492711;9420.293477989178;9545.952270238744;313002;313581;318952;332305;334089;68545.65727171332;70289.64855175691;70294.29705702877;70626.64686676534;72077;1024.656739992111;1034.8292531732332;1040.7398150462384;1056.3661802918189;1060.4114716332663;14081.225532595805;14182.219977901315;14384;14514.491992780202;14790.334434950239;32226;32249.193770155933;32559.34881302408;33258.334833303685;34138.82930585331;42426;48484.757576211894;49874.501254986986;50085.24872126994;50398;7991.24083212094;8015.959920200362;8103.473274237156;8346.956630421197;8523.190296921783;11656.88343116592;11688.240264382788;11900.58347957852;12197.939010304892;12215.328156951453;9078.954605226932;10042.548085336031;10251.12865406419;10370.429626370622;10697.625583104555;9178.541072946193;9355.85966210521;9514;9688.612455501983;9871.16095131893;10327.690169294932;10734.562014091036;10800.40597767099;10874.673759786903;10885.619003334845;8125.146859579659;8128.227818357246;8247.175282471704;8252.174782521699;8258.876116858131;10120.493975301059;10417.37495750227;10453.059224669816;10707.892921071001;10920 02:32:20 INFO - PID 3517 | |3;mootools.html;1233.192259070309;1287.8132670762734;1294.9352532373384;1295.8574556798756;1312.5996571045832;10145.391276523414;10581.78836423271;10615.99148080932;10646.095081918027;10988.28576142552;10674.3595384277;10842.783144337129;10903;10905.18211134166;10946.835797463045;2190.7261592300924;2235.8434909556336;2246.5731511012937;2250.1224522436264;2252.628316327804;2109.9050542725613;2180.356794745554;2183.879886606236;2185.694002839604;2192.506685995646;2159.470929622245;2200.559888022394;2210;2218.7892150245702;2223.1885361842974;2099.9685004724943;2108.20942146695;2113.144176608476;2123.055240418015;2124.702541644171;2011.205573798356;2099.5800839832095;2192.6601376786625;2200.1639377036786;2200.9779902200935;10693;10708.892911070867;10758.569657213702;10795.2443328967;10803.297785643908;5370.9731451342495;5554.305711786027;5556.805511807108;5592.273004509388;5613.943860561424;3082.520390212688;3104.1463597510638;3192.5690031845634;3193.0740085375214;3224.790388624732;958.0611001218775;968.0948313327061;977.5454413697594;985.418603024212;988.2390559269322;15356.846431535654;15509;15549.455769048029;15610.219489025616;15641.765373519407;4391.077873646506;4604.539546045368;4674.95325046752;4704.882377940579;4707.599854012447;11092.168087393316;11144.275622084539;11165.441727913572;11189.104871610252;11201.71995700114;5397.217403476474;5518.2826232590305;5521.944780552223;5522.144067669517;5533.501984821305;5095.617828662791;5129.743512824344;5148.588112950955;5149.433562308143;5157.871053223699;3693.593704692482;3798.2783271178387;3828.157805282833;3870.9612903871166;3896.6298201670797;1087.1302957633861;1091.3888222595372;1101.542859713226;1118.6588090632272;1122.893325134111;693.6462404173908;727.9526830755984;729.7372945739529;742.6509540515949;745.4893398022372;5513.476219759116;5579.860503487445;5628.1427129047315;5752.971235143881;5759.683217423082;541.507228422134;569.9173619825102;570.0451743329905;573.131705466219;573.9913901291484;3684.412140749923;3923.136909879822;3956.802159891994;4020.798960051986;4041.2119636671155;12969.286689231994;13243.536476223479;13335.799963000563;13390;13414;12961;13175.407106680223;13392.933035334761;13417.054527093516;13461;7442.925570744332;7470.887936680954;7550.848983020309;7851.05787305527;7892.013498312596;6537.967310163419;6680.365365290289;6681.665916704243;6811.777474633765;6837.487188460786;12393.132480726263;12453.1905426147;12497.125201235825;12567.858035491126;12571.1200215984;12537.561185358469;12682.87317126817;12891.935540322238;12965.41655625518;13013.284269365276;8233.17668233172;8292.626831792462;8352.331813454788;8357.874631880648;8388.496690198608;9541.618335266512;9559.474228917197;9627.470489123165;9653.517324133905;9691.418514889128;7930;7955.880661789962;7975.5613441258965;8021.598920053857;8165.959170204111;7954.522728636301;8072.273495385443;8072.5963701815845;8112.675492980215;8206.302464290602;7040.225575186828;7124.536905101152;7127.82180445493;7164.068671072727;7200.675969581486;4771.785269662804;5185.766640501111;5323.228131920927;5361.651492652965;5661.518770904519;5168.53483186515;5181.689098654093;5299.576033917355;5332.786688532416;5370.19447082925 02:32:20 INFO - PID 3517 | |4;prototype.html;338.957630296213;341.69418370558367;350.8210812485633;354.52493658497616;366.7359501159165;5505.834824955247;5544.63959842611;5549.361823390312;5564.7217639118035;5574.665520068788;5426.403095659484;5441.061826613623;5448.828501872097;5450.754716037778;5455.972720136394;3845.288621604998;3976.7216294859372;3995.900102497432;4019.859304924328;4024.8993775155564;4013.1371755072655;4016.15660711251;4016.2770701273757;4017.5982401759884;4038.8788336349958;3948.9012774680577;3971.483707118085;3972.4041393791017;3977.9856136685103;3981.8850721797944;3861.768293902375;3965.781881996489;3967.305721498726;3994.660453861425;4022.2357752027315;3455.4644030175364;3458.170039190601;3464.3764122457947;3470.791752494833;3489.4068008438626;5264.341957255343;5268.4994925482015;5280.524752772269;5283.973580132113;5297.417284098746;4589.311603259504;4732.1482133216;4736.597389221886;4742.715437073786;4742.786574604151;5651.943480565224;5702.258706368187;5715.114157305624;5752.165935939265;5754.798582049608;3953.367461206222;3960.980195099006;3970.7419017763755;3977.363621820524;3980.0845805464614;5882.6468912719765;6049.697515124226;6089.142811442508;6112.8518812811435;6133.233345831815;3959.762414255154;3966.643002129764;3969.3053715599654;3985.3822657488136;3990.84036638537;4002.939955900664;4007.859724909614;4012.1574469361763;4027.6708686133506;4036.6367026967714;4563.406757121553;4678.087772884255;4683.1336202802595;4692.976535117371;4702.905941881211;5735.569832262514;5741.5119714824705;5777.2200752897825;5784.508316793035;5827.970860145672;1380.9033367664367;1381.8272715910512;1383.8062671226037;1384.3770303363526;1392.0673148990202;884.045231150356;934.4486752815872;949.9313272568361;951.7763325618613;954.1632357711378;5003.424606170337;5005.82479613219;5020.949790502048;5029.597632189416;5039.395272567315;5916.6924899289315;5996.880062398727;6003.549733769984;6024;6025.638461692312;4826.276058591239;4957.479464656231;4989.700617962933;4999.125153098194;5007.168082800115;3136.498160294342;3142.1987393214586;3166.920826979344;3170.619525656936;3177.126290270148;5522.972385138049;5524.375921437366;5539.944600553943;5542.224088627595;5546.362168350692;5919.55603329752;5973.551983601247;6108.297545782203;6161.199044124235;6177.752889884354;5535.003699334078;5536.861578460571;5549.6680796608525;5561.944380556223;5562.527185189304;5953.9404605955115;5970.31341395745;5977.342492325927;5982.341942386421;5983.401659833982;5697.373288938131;5812.128180772749;5862.032764593965;5878.502945246975;5926.348101708895;5519.2824932758485;5541.722913854372;5542.0855558832345;5545.4490934170735;5565.9721701392855;3976.423418604344;4038.4548086008012;4039.7778122203563;4047.9797601011805;4053.6554392875755;5950.464458198783;5966.910496342472;5971.850703732442;5997.340292567901;6005.90991135142;5721.39800855761;5743.195952566561;5761.740721667619;5765.94234057654;5795.478406943395;5649.4633009864;5696.259486266758;5727.885442291047;5728.455796699307;5775.848721112002;5668.149777533403;5690.231818704422;5696.401877802771;5698.572607054404;5717.656940583578;5659.801906933238;5801.709914504174;5804.303483581997;5807.680577568274;5812.169166712472;5609.354924183608;5619.578531610227;5635.492805647511;5645.802396916089;5666.518345940642 02:32:20 INFO - PID 3517 | |5;yui.html;713.9464540159482;739.6560599321318;744.6649007946423;753.7437271327748;760.2017881224714;12893.613191604256;13560.186388816666;13634.931825340871;14854.48009319674;15365;16643.50069497914;16696.916515417437;16782.244798984044;16797.66404671909;16875.746863797052;899.7435730816702;922.6908985489836;922.9630814767402;924.2929159193222;925.6297481007583;869.8608222684372;917.9908200917972;922.0502882031518;924.1867156901917;935.4247138010143;955.3933252384717;961.7066794627635;967.0571193086754;973.226285103341;976.1848856205078;963.9228861691048;966.6665000574791;966.8646389505475;967.2793768642406;967.8838539375249;711.8291610013612;713.9678714457862;714.1002337055296;714.8212946763309;715.0204220218283;14329.283535823168;14480.493182738659;14652.194129322883;14742;14781;15026.699466010728;15472.613184670361;15514.456994005155;15519.456819011393;15527.068375897483;11912.88087119135;11950.88049119515;12010.339431331273;12176.939115304456;12240.081993850408;2893.3779237463837;2898.9565156522667;2905.6077429546954;2914.7813913956325;2924.1519959211805;80288;80708.59645701792;81453;81981.59009204975;82828.58585707033;12784.936075319563;12930.094893357375;12936.547220847226;12937.611871643865;12963.15739476931;22836.086556537553;23831.52336953286;24042.278731638078;24048.759512405002;24315.270541883772;5939.2575928009;5964.522838172936;5994.610350327302;6007.36922623127;6058.969705151534;2970.3168271297723;3054.9847250763605;3064.4483992881496;3064.7548196144253;3067.217859445827;3450.9654903451146;3556.324298383299;3573.3032058748295;3574.660407261306;3581.3732596795458;652.0773106054879;656.7963931181349;659.9406053455212;660.5673283998989;662.9635370054693;573.3750212268648;585.4233579923772;592.3365830270125;596.9820905372845;600.8738164985315;9816.969218232125;9988.850167247498;10184.236182286359;10310;11213.775724485628;568.9317281926195;574.5662025170969;589.4812564942908;602.6715440085164;609.4880300547561;4494.955050449519;4635.629149668019;4666.65000124992;4678.391809064799;4680.648951328664;84575.15424845795;87117;87122.56438717766;88747;90727;75435;77965;78599.21400786033;80979.59510202412;81353.18646813456;60877;61716.69141654353;62512.687436562526;62627.37372626307;65531.67234163799;9816.411015339103;10110.090091891765;10518.368897866152;10668.146548276274;10813.62152324665;27664.723352766214;27919.581206282328;28420.289492762848;29275.121746347642;29392.412151756416;34800;35005.47491787574;35208;35872;36291.45562816507;13237.205767653972;13278.734425311633;13408.050228949616;13529.18824870511;13687.863121368659;14806.185659788815;15012.399504020153;15116.319765610355;15190.696186076437;15481.845181548491;13872.514461993782;14053.508127215498;14135.43458261658;14185.077969931921;14289.35697893618;14785.186814725294;14849.777253341425;14921.477748278758;15155.772663409836;15306.846931530543;13789.172649641054;13960.2321872298;14611.269436528344;14660.340284687001;14781.039232449857;10299.279050466395;10388.220883433622;10473.31923424975;10684.57261709554;11185;10585.9470702646;10647.733806654896;11310;11314;11446.37044962535 02:32:20 INFO - PID 3517 | __end_tp_report 02:32:20 INFO - PID 3517 | __start_cc_report 02:32:20 INFO - PID 3517 | _x_x_mozilla_cycle_collect,356 02:32:20 INFO - PID 3517 | __end_cc_report 02:32:20 INFO - PID 3517 | __startTimestamp1495704740489__endTimestamp 02:32:20 INFO - PID 3517 | 02:32:20 INFO - PID 3517 | ------- Summary: start ------- 02:32:20 INFO - PID 3517 | Number of tests: 6 02:32:20 INFO - PID 3517 | 02:32:20 INFO - PID 3517 | [#0] dojo.html Cycles:165 Average:5187.90 Median:5344.04 stddev:610.59 (11.4%) stddev-sans-first:580.83 02:32:20 INFO - PID 3517 | Values: 2715.2 2726.2 2743.1 2758.9 2759.9 5188.4 5261.9 5264.3 5272.5 5325.4 5187.1 5198.3 5242.3 5297.5 5317.4 4666.3 4678.8 4694.9 4696.6 4748.9 4664.8 4729.6 4747.8 4762.5 4775.8 4615.7 4672.9 4687.0 4692.6 4756.0 4545.7 4626.7 4648.4 4649.2 4660.9 4626.8 4628.4 4634.7 4650.4 4682.1 5195.6 5196.0 5232.2 5235.0 5304.3 5660.4 5690.1 5723.0 5724.9 5731.9 5728.9 5731.6 5733.8 5744.4 5797.0 5328.2 5334.8 5339.9 5341.9 5344.0 5778.6 5801.8 5857.2 5871.3 5875.2 5550.0 5581.9 5607.8 5617.4 5640.1 5577.0 5591.7 5613.5 5624.3 5665.5 5498.2 5559.3 5619.5 5622.4 5630.1 5565.9 5608.9 5635.7 5650.7 5660.3 4771.4 4773.8 4785.2 4811.3 4812.3 4082.4 4085.5 4091.8 4095.0 4132.4 4776.8 4803.1 4808.9 4840.7 4843.4 5692.7 5693.6 5696.2 5718.1 5734.2 4803.4 4804.1 4806.6 4819.4 4851.2 4911.7 4940.8 4981.4 5017.6 5018.0 5302.0 5311.9 5326.8 5350.1 5356.2 5540.8 5627.8 5683.8 5684.0 5685.9 5173.9 5256.7 5258.7 5274.1 5275.9 5563.1 5641.5 5650.9 5663.0 5667.4 5640.6 5641.7 5644.4 5720.8 5764.0 5505.6 5517.4 5525.3 5543.2 5546.6 5510.8 5518.6 5520.2 5527.9 5529.1 5353.4 5353.8 5425.8 5463.5 5487.4 5614.0 5626.8 5629.9 5637.2 5663.8 5394.4 5434.8 5444.5 5447.3 5448.3 02:32:20 INFO - PID 3517 | 02:32:20 INFO - PID 3517 | [#1] ext.html Cycles:180 Average:29999.42 Median:29503.06 stddev:40759.68 (138.2%) stddev-sans-first:40814.59 02:32:20 INFO - PID 3517 | Values: 686.9 701.0 716.6 1147.2 1206.6 32653.3 33626.0 33681.8 33708.3 33721.8 32297.8 32489.7 32663.3 32666.8 32688.5 6226.2 6387.7 6554.6 6555.3 6558.4 6490.6 6529.1 6560.5 6571.2 6581.9 6563.5 6568.1 6611.8 6617.2 6620.2 6561.9 6593.5 6594.4 6597.0 6601.1 6483.9 6619.8 6659.4 6667.0 6699.6 31343.8 31388.2 31423.2 31600.5 31631.7 3008.1 3017.2 3038.8 3040.5 3043.3 24204.6 24273.8 24446.5 24448.0 24523.9 2784.4 2787.5 2791.3 2795.2 2835.5 140499.0 140706.0 141070.0 150134.2 157311.0 39491.8 39663.0 39738.4 39753.4 39767.2 41339.6 41464.8 41469.4 43426.1 44213.1 13494.7 13593.9 13594.0 13638.8 13665.0 10906.3 11047.2 11060.2 11064.6 11081.8 12875.5 12923.7 12925.2 12928.3 13133.9 5280.6 5404.8 5559.4 5584.1 5591.5 841.8 896.0 913.3 913.8 941.5 19509.9 20355.9 20697.6 21211.0 21291.1 981.7 985.2 989.2 999.2 1009.4 10527.5 10965.5 11020.3 11258.2 11270.9 175510.1 176276.0 176613.0 176641.0 177166.0 39825.2 39990.0 40129.2 40235.6 40302.6 1214.6 1255.9 1258.4 1265.2 1270.7 19288.8 19724.3 20555.4 20591.3 21091.4 29390.4 29437.0 29453.4 29595.7 29603.3 149028.3 149583.0 150009.0 150244.0 150469.2 28665.3 28795.3 28907.9 28962.3 29186.4 34847.0 35640.8 35828.3 35850.3 36191.8 26706.3 26824.7 27014.6 27212.0 27541.9 26615.9 26706.2 27323.3 27370.3 27556.2 29552.7 29583.1 29592.6 29665.7 29781.9 24942.4 25493.0 25891.2 25973.2 27448.9 19957.3 22438.8 22764.2 22926.0 22984.2 02:32:20 INFO - PID 3517 | 02:32:20 INFO - PID 3517 | [#2] jquery.html Cycles:180 Average:22838.65 Median:411.96 stddev:53823.21 (13065.2%) stddev-sans-first:53947.82 02:32:20 INFO - PID 3517 | Values: 395.2 406.0 417.9 429.4 431.2 17128.7 17807.1 17825.8 18784.3 19580.7 17573.7 17674.4 17706.1 17868.3 17976.5 5161.4 5456.9 5493.3 5661.9 5664.1 5288.0 5377.8 5385.1 5391.5 5396.8 5293.2 5339.1 5359.8 5374.5 5379.2 5205.1 5241.4 5264.1 5268.1 5275.7 4772.4 4775.6 4775.7 4796.5 4800.7 21786.6 21881.6 22016.3 22075.4 22099.0 1629.6 1652.6 1654.2 1663.7 1666.1 14207.5 14240.8 14318.9 14657.4 14752.9 1990.6 2013.3 2037.0 2084.9 2085.7 80899.2 82160.6 82777.0 82859.6 83672.6 11004.9 11046.8 11120.7 11220.6 11433.7 15892.8 15903.6 15978.1 15997.2 16018.3 7273.9 7401.7 7538.5 7669.1 7729.2 6594.6 6697.9 6873.1 6887.3 6918.1 6770.7 6913.2 7019.3 7048.9 7092.1 1990.1 2017.8 2021.9 2041.7 2227.6 834.9 871.3 872.9 885.5 912.2 16571.0 16625.4 16899.0 16946.0 17557.8 877.1 881.6 882.1 892.5 909.0 9090.1 9130.4 9347.4 9420.3 9546.0 313002.0 313581.0 318952.0 332305.0 334089.0 68545.7 70289.6 70294.3 70626.6 72077.0 1024.7 1034.8 1040.7 1056.4 1060.4 14081.2 14182.2 14384.0 14514.5 14790.3 32226.0 32249.2 32559.3 33258.3 34138.8 42426.0 48484.8 49874.5 50085.2 50398.0 7991.2 8016.0 8103.5 8347.0 8523.2 11656.9 11688.2 11900.6 12197.9 12215.3 9079.0 10042.5 10251.1 10370.4 10697.6 9178.5 9355.9 9514.0 9688.6 9871.2 10327.7 10734.6 10800.4 10874.7 10885.6 8125.1 8128.2 8247.2 8252.2 8258.9 10120.5 10417.4 10453.1 10707.9 10920.0 02:32:20 INFO - PID 3517 | 02:32:20 INFO - PID 3517 | [#3] mootools.html Cycles:180 Average:6379.64 Median:3909.88 stddev:4192.94 (107.2%) stddev-sans-first:4186.87 02:32:20 INFO - PID 3517 | Values: 1233.2 1287.8 1294.9 1295.9 1312.6 10145.4 10581.8 10616.0 10646.1 10988.3 10674.4 10842.8 10903.0 10905.2 10946.8 2190.7 2235.8 2246.6 2250.1 2252.6 2109.9 2180.4 2183.9 2185.7 2192.5 2159.5 2200.6 2210.0 2218.8 2223.2 2100.0 2108.2 2113.1 2123.1 2124.7 2011.2 2099.6 2192.7 2200.2 2201.0 10693.0 10708.9 10758.6 10795.2 10803.3 5371.0 5554.3 5556.8 5592.3 5613.9 3082.5 3104.1 3192.6 3193.1 3224.8 958.1 968.1 977.5 985.4 988.2 15356.8 15509.0 15549.5 15610.2 15641.8 4391.1 4604.5 4675.0 4704.9 4707.6 11092.2 11144.3 11165.4 11189.1 11201.7 5397.2 5518.3 5521.9 5522.1 5533.5 5095.6 5129.7 5148.6 5149.4 5157.9 3693.6 3798.3 3828.2 3871.0 3896.6 1087.1 1091.4 1101.5 1118.7 1122.9 693.6 728.0 729.7 742.7 745.5 5513.5 5579.9 5628.1 5753.0 5759.7 541.5 569.9 570.0 573.1 574.0 3684.4 3923.1 3956.8 4020.8 4041.2 12969.3 13243.5 13335.8 13390.0 13414.0 12961.0 13175.4 13392.9 13417.1 13461.0 7442.9 7470.9 7550.8 7851.1 7892.0 6538.0 6680.4 6681.7 6811.8 6837.5 12393.1 12453.2 12497.1 12567.9 12571.1 12537.6 12682.9 12891.9 12965.4 13013.3 8233.2 8292.6 8352.3 8357.9 8388.5 9541.6 9559.5 9627.5 9653.5 9691.4 7930.0 7955.9 7975.6 8021.6 8166.0 7954.5 8072.3 8072.6 8112.7 8206.3 7040.2 7124.5 7127.8 7164.1 7200.7 4771.8 5185.8 5323.2 5361.7 5661.5 5168.5 5181.7 5299.6 5332.8 5370.2 02:32:20 INFO - PID 3517 | 02:32:20 INFO - PID 3517 | [#4] prototype.html Cycles:180 Average:4706.43 Median:5512.56 stddev:1430.54 (26.0%) stddev-sans-first:1396.49 02:32:20 INFO - PID 3517 | Values: 339.0 341.7 350.8 354.5 366.7 5505.8 5544.6 5549.4 5564.7 5574.7 5426.4 5441.1 5448.8 5450.8 5456.0 3845.3 3976.7 3995.9 4019.9 4024.9 4013.1 4016.2 4016.3 4017.6 4038.9 3948.9 3971.5 3972.4 3978.0 3981.9 3861.8 3965.8 3967.3 3994.7 4022.2 3455.5 3458.2 3464.4 3470.8 3489.4 5264.3 5268.5 5280.5 5284.0 5297.4 4589.3 4732.1 4736.6 4742.7 4742.8 5651.9 5702.3 5715.1 5752.2 5754.8 3953.4 3961.0 3970.7 3977.4 3980.1 5882.6 6049.7 6089.1 6112.9 6133.2 3959.8 3966.6 3969.3 3985.4 3990.8 4002.9 4007.9 4012.2 4027.7 4036.6 4563.4 4678.1 4683.1 4693.0 4702.9 5735.6 5741.5 5777.2 5784.5 5828.0 1380.9 1381.8 1383.8 1384.4 1392.1 884.0 934.4 949.9 951.8 954.2 5003.4 5005.8 5020.9 5029.6 5039.4 5916.7 5996.9 6003.5 6024.0 6025.6 4826.3 4957.5 4989.7 4999.1 5007.2 3136.5 3142.2 3166.9 3170.6 3177.1 5523.0 5524.4 5539.9 5542.2 5546.4 5919.6 5973.6 6108.3 6161.2 6177.8 5535.0 5536.9 5549.7 5561.9 5562.5 5953.9 5970.3 5977.3 5982.3 5983.4 5697.4 5812.1 5862.0 5878.5 5926.3 5519.3 5541.7 5542.1 5545.4 5566.0 3976.4 4038.5 4039.8 4048.0 4053.7 5950.5 5966.9 5971.9 5997.3 6005.9 5721.4 5743.2 5761.7 5765.9 5795.5 5649.5 5696.3 5727.9 5728.5 5775.8 5668.1 5690.2 5696.4 5698.6 5717.7 5659.8 5801.7 5804.3 5807.7 5812.2 5609.4 5619.6 5635.5 5645.8 5666.5 02:32:20 INFO - PID 3517 | 02:32:20 INFO - PID 3517 | [#5] yui.html Cycles:180 Average:17382.54 Median:3065.99 stddev:23074.43 (752.6%) stddev-sans-first:23105.21 02:32:20 INFO - PID 3517 | Values: 713.9 739.7 744.7 753.7 760.2 12893.6 13560.2 13634.9 14854.5 15365.0 16643.5 16696.9 16782.2 16797.7 16875.7 899.7 922.7 923.0 924.3 925.6 869.9 918.0 922.1 924.2 935.4 955.4 961.7 967.1 973.2 976.2 963.9 966.7 966.9 967.3 967.9 711.8 714.0 714.1 714.8 715.0 14329.3 14480.5 14652.2 14742.0 14781.0 15026.7 15472.6 15514.5 15519.5 15527.1 11912.9 11950.9 12010.3 12176.9 12240.1 2893.4 2899.0 2905.6 2914.8 2924.2 80288.0 80708.6 81453.0 81981.6 82828.6 12784.9 12930.1 12936.5 12937.6 12963.2 22836.1 23831.5 24042.3 24048.8 24315.3 5939.3 5964.5 5994.6 6007.4 6059.0 2970.3 3055.0 3064.4 3064.8 3067.2 3451.0 3556.3 3573.3 3574.7 3581.4 652.1 656.8 659.9 660.6 663.0 573.4 585.4 592.3 597.0 600.9 9817.0 9988.9 10184.2 10310.0 11213.8 568.9 574.6 589.5 602.7 609.5 4495.0 4635.6 4666.7 4678.4 4680.6 84575.2 87117.0 87122.6 88747.0 90727.0 75435.0 77965.0 78599.2 80979.6 81353.2 60877.0 61716.7 62512.7 62627.4 65531.7 9816.4 10110.1 10518.4 10668.1 10813.6 27664.7 27919.6 28420.3 29275.1 29392.4 34800.0 35005.5 35208.0 35872.0 36291.5 13237.2 13278.7 13408.1 13529.2 13687.9 14806.2 15012.4 15116.3 15190.7 15481.8 13872.5 14053.5 14135.4 14185.1 14289.4 14785.2 14849.8 14921.5 15155.8 15306.8 13789.2 13960.2 14611.3 14660.3 14781.0 10299.3 10388.2 10473.3 10684.6 11185.0 10585.9 10647.7 11310.0 11314.0 11446.4 02:32:20 INFO - PID 3517 | -------- Summary: end -------- 02:32:20 INFO - PID 3517 | 02:32:21 INFO - TEST-INFO | 3517: exit 0 02:32:21 INFO - TEST-OK | dromaeo_css | took 1148790ms 02:32:21 INFO - TEST-START | kraken 02:32:21 INFO - operating with platform_type : linux_ 02:32:21 INFO - Initialising browser for kraken test... 02:32:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33927/getInfo.html -profile /tmp/tmpBheYlT/profile 02:32:21 INFO - TEST-INFO | started process 3920 (/builds/slave/test/build/application/firefox/firefox http://localhost:33927/getInfo.html) 02:32:56 INFO - TEST-INFO | 3920: killed by SIGTERM 02:32:56 INFO - Browser initialized. 02:32:56 INFO - Running cycle 1/1 for kraken test... 02:32:56 INFO - TEST-INFO | started process 4117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBheYlT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:33:08 INFO - PID 4117 | RSS: Main: 173080576 02:33:08 INFO - PID 4117 | 02:33:10 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33927/tests/kraken/driver.html?testName=audio-beat-detection) 02:33:11 INFO - PID 4117 | RSS: Main: 178737152 02:33:11 INFO - PID 4117 | 02:33:14 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33927/tests/kraken/driver.html?testName=audio-dft) 02:33:15 INFO - PID 4117 | RSS: Main: 177430528 02:33:15 INFO - PID 4117 | 02:33:18 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33927/tests/kraken/driver.html?testName=audio-fft) 02:33:18 INFO - PID 4117 | RSS: Main: 174927872 02:33:18 INFO - PID 4117 | 02:33:20 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33927/tests/kraken/driver.html?testName=audio-oscillator) 02:33:21 INFO - PID 4117 | RSS: Main: 175669248 02:33:21 INFO - PID 4117 | 02:33:23 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33927/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:33:24 INFO - PID 4117 | RSS: Main: 175898624 02:33:24 INFO - PID 4117 | 02:33:27 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33927/tests/kraken/driver.html?testName=imaging-darkroom) 02:33:27 INFO - PID 4117 | RSS: Main: 177401856 02:33:27 INFO - PID 4117 | 02:33:31 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33927/tests/kraken/driver.html?testName=imaging-desaturate) 02:33:32 INFO - PID 4117 | RSS: Main: 176033792 02:33:32 INFO - PID 4117 | 02:33:34 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33927/tests/kraken/driver.html?testName=json-parse-financial) 02:33:35 INFO - PID 4117 | RSS: Main: 177127424 02:33:35 INFO - PID 4117 | 02:33:37 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33927/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:33:37 INFO - PID 4117 | RSS: Main: 177033216 02:33:37 INFO - PID 4117 | 02:33:39 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:33:40 INFO - PID 4117 | RSS: Main: 176828416 02:33:40 INFO - PID 4117 | 02:33:42 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:33:43 INFO - PID 4117 | RSS: Main: 176820224 02:33:43 INFO - PID 4117 | 02:33:45 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:33:46 INFO - PID 4117 | RSS: Main: 176996352 02:33:46 INFO - PID 4117 | 02:33:49 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:33:50 INFO - PID 4117 | RSS: Main: 176955392 02:33:50 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | Cycle 1(1): loaded http://localhost:33927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33927/tests/kraken/driver.html?testName=ai-astar) 02:33:52 INFO - PID 4117 | RSS: Main: 178257920 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | __start_tp_report 02:33:52 INFO - PID 4117 | _x_x_mozilla_page_load 02:33:52 INFO - PID 4117 | _x_x_mozilla_page_load_details 02:33:52 INFO - PID 4117 | |i|pagename|runs| 02:33:52 INFO - PID 4117 | |0;ai-astar;105;113;115;116;114;113;114;112;112;114 02:33:52 INFO - PID 4117 | |1;audio-beat-detection;155;124;123;185;127;128;125;131;154;128 02:33:52 INFO - PID 4117 | |2;audio-dft;163;164;164;165;170;169;168;163;164;162 02:33:52 INFO - PID 4117 | |3;audio-fft;75;73;74;112;76;75;74;74;89;75 02:33:52 INFO - PID 4117 | |4;audio-oscillator;83;83;103;83;84;84;96;87;84;104 02:33:52 INFO - PID 4117 | |5;imaging-gaussian-blur;115;115;114;113;114;114;113;115;116;115 02:33:52 INFO - PID 4117 | |6;imaging-darkroom;151;152;151;153;151;151;150;150;151;151 02:33:52 INFO - PID 4117 | |7;imaging-desaturate;95;96;96;95;95;95;94;95;95;94 02:33:52 INFO - PID 4117 | |8;json-parse-financial;54;54;55;56;56;55;57;54;55;55 02:33:52 INFO - PID 4117 | |9;json-stringify-tinderbox;57;56;57;57;59;56;57;57;57;57 02:33:52 INFO - PID 4117 | |10;stanford-crypto-aes;89;87;87;88;86;89;89;106;123;91 02:33:52 INFO - PID 4117 | |11;stanford-crypto-ccm;147;140;134;139;143;134;144;133;139;139 02:33:52 INFO - PID 4117 | |12;stanford-crypto-pbkdf2;190;196;196;196;201;199;203;200;198;196 02:33:52 INFO - PID 4117 | |13;stanford-crypto-sha256-iterative;77;74;74;74;79;72;75;76;71;73 02:33:52 INFO - PID 4117 | __end_tp_report 02:33:52 INFO - PID 4117 | __start_cc_report 02:33:52 INFO - PID 4117 | _x_x_mozilla_cycle_collect,910 02:33:52 INFO - PID 4117 | __end_cc_report 02:33:52 INFO - PID 4117 | __startTimestamp1495704832413__endTimestamp 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | ------- Summary: start ------- 02:33:52 INFO - PID 4117 | Number of tests: 14 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:3.01 (2.6%) stddev-sans-first:1.32 02:33:52 INFO - PID 4117 | Values: 105.0 113.0 115.0 116.0 114.0 113.0 114.0 112.0 112.0 114.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#1] audio-beat-detection Cycles:10 Average:138.00 Median:129.50 stddev:20.31 (15.7%) stddev-sans-first:20.59 02:33:52 INFO - PID 4117 | Values: 155.0 124.0 123.0 185.0 127.0 128.0 125.0 131.0 154.0 128.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:2.78 (1.7%) stddev-sans-first:2.83 02:33:52 INFO - PID 4117 | Values: 163.0 164.0 164.0 165.0 170.0 169.0 168.0 163.0 164.0 162.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#3] audio-fft Cycles:10 Average:79.70 Median:75.00 stddev:12.26 (16.3%) stddev-sans-first:12.88 02:33:52 INFO - PID 4117 | Values: 75.0 73.0 74.0 112.0 76.0 75.0 74.0 74.0 89.0 75.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#4] audio-oscillator Cycles:10 Average:89.10 Median:84.00 stddev:8.54 (10.2%) stddev-sans-first:8.77 02:33:52 INFO - PID 4117 | Values: 83.0 83.0 103.0 83.0 84.0 84.0 96.0 87.0 84.0 104.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:115.00 stddev:0.97 (0.8%) stddev-sans-first:1.00 02:33:52 INFO - PID 4117 | Values: 115.0 115.0 114.0 113.0 114.0 114.0 113.0 115.0 116.0 115.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 02:33:52 INFO - PID 4117 | Values: 151.0 152.0 151.0 153.0 151.0 151.0 150.0 150.0 151.0 151.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 02:33:52 INFO - PID 4117 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:0.99 (1.8%) stddev-sans-first:0.97 02:33:52 INFO - PID 4117 | Values: 54.0 54.0 55.0 56.0 56.0 55.0 57.0 54.0 55.0 55.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#9] json-stringify-tinderbox Cycles:10 Average:57.00 Median:57.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 02:33:52 INFO - PID 4117 | Values: 57.0 56.0 57.0 57.0 59.0 56.0 57.0 57.0 57.0 57.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#10] stanford-crypto-aes Cycles:10 Average:93.50 Median:88.50 stddev:11.85 (13.4%) stddev-sans-first:12.46 02:33:52 INFO - PID 4117 | Values: 89.0 87.0 87.0 88.0 86.0 89.0 89.0 106.0 123.0 91.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:139.50 stddev:4.61 (3.3%) stddev-sans-first:3.94 02:33:52 INFO - PID 4117 | Values: 147.0 140.0 134.0 139.0 143.0 134.0 144.0 133.0 139.0 139.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.50 Median:198.50 stddev:3.60 (1.8%) stddev-sans-first:2.60 02:33:52 INFO - PID 4117 | Values: 190.0 196.0 196.0 196.0 201.0 199.0 203.0 200.0 198.0 196.0 02:33:52 INFO - PID 4117 | 02:33:52 INFO - PID 4117 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:74.50 stddev:2.37 (3.2%) stddev-sans-first:2.33 02:33:52 INFO - PID 4117 | Values: 77.0 74.0 74.0 74.0 79.0 72.0 75.0 76.0 71.0 73.0 02:33:52 INFO - PID 4117 | -------- Summary: end -------- 02:33:52 INFO - PID 4117 | 02:33:53 INFO - TEST-INFO | 4117: exit 0 02:33:53 INFO - TEST-OK | kraken | took 92300ms 02:33:53 INFO - SUITE-END | took 1241s 02:33:53 INFO - Completed test suite (00:20:41) 02:33:53 INFO - javascript benchmark 02:33:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6691.432328875688, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2715.18544436669, 2726.2366537369544, 2743.0810678422727, 2758.903438379657, 2759.8620068996547, 5188.403333616635, 5261.86845328867, 5264.289320941672, 5272.472752724726, 5325.440828712983, 5187.1181899077155, 5198.2722418861385, 5242.344706911636, 5297.549708274792, 5317.388500322464, 4666.253399456088, 4678.836240731575, 4694.90610187796, 4696.600788932928, 4748.905021899577, 4664.836730714425, 4729.6216302695875, 4747.810087596509, 4762.523747625244, 4775.785089670973, 4615.699979501355, 4672.901868061003, 4687.0, 4692.6339685763605, 4755.952440475586, 4545.749983750892, 4626.653001024903, 4648.442186937589, 4649.209634362167, 4660.930086048712, 4626.768661566908, 4628.352030715702, 4634.698744581625, 4650.395448591696, 4682.08699303636, 5195.558377537914, 5196.0, 5232.215167724872, 5235.0, 5304.25740396341, 5660.377358490563, 5690.089585666315, 5722.97138514309, 5724.9427505724825, 5731.914021289684, 5728.856778580527, 5731.598788084836, 5733.827985160452, 5744.396838331957, 5797.043487824546, 5328.17413300939, 5334.813281535127, 5339.86650333737, 5341.946580534183, 5344.038073146793, 5778.56660750437, 5801.82594522165, 5857.238558987389, 5871.266091738533, 5875.211463827195, 5549.972250138804, 5581.860453488614, 5607.775688972395, 5617.38208797032, 5640.097584386478, 5576.97211513948, 5591.720413979285, 5613.494785469327, 5624.29696287964, 5665.5467562594895, 5498.1752737089755, 5559.33288005442, 5619.466150715675, 5622.353429355677, 5630.127330263816, 5565.916511252334, 5608.9439105609235, 5635.6618602883955, 5650.7174641267775, 5660.264165658438, 4771.427428708508, 4773.809047638125, 4785.1625965455905, 4811.254255590389, 4812.326274321597, 4082.4284600155406, 4085.530164031115, 4091.7954102294766, 4095.037666148453, 4132.421460995463, 4776.761161941889, 4803.1114243864295, 4808.855734327975, 4840.709557426566, 4843.4430040545085, 5692.686902220417, 5693.572982026365, 5696.202531645573, 5718.1136923776885, 5734.16854556087, 4803.447603525569, 4804.111239420718, 4806.615470762331, 4819.373481447459, 4851.199552073939, 4911.705297682079, 4940.752962351868, 4981.352424184833, 5017.648764586444, 5017.974910125426, 5301.973490132525, 5311.946880531145, 5326.786928522815, 5350.143976963667, 5356.223347614652, 5540.833774986757, 5627.831165065055, 5683.801066962802, 5684.0, 5685.943140568541, 5173.896522069613, 5256.710880901434, 5258.684478931276, 5274.050670879278, 5275.947240527546, 5563.13771365439, 5641.548676105819, 5650.943490565206, 5663.0, 5667.4332566743, 5640.605157638925, 5641.689707065987, 5644.379118296902, 5720.828375148586, 5764.0, 5505.587080968863, 5517.393086760373, 5525.309336332958, 5543.223948647112, 5546.556275498031, 5510.834674959758, 5518.613697041169, 5520.171974203901, 5527.917081243704, 5529.115341545334, 5353.437889021597, 5353.839384818461, 5425.810096646598, 5463.48096930791, 5487.368952570506, 5614.0, 5626.774929002794, 5629.8592535186945, 5637.182608521659, 5663.773449062156, 5394.352677678704, 5434.75543600531, 5444.455554444524, 5447.291852059207, 5448.264484294569], "value": 5143.438301007042, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.8832298509253, 700.9579425234487, 716.6094478509214, 1147.1797664669764, 1206.6018213989385, 32653.346933061326, 33625.99999999997, 33681.83159084207, 33708.325833483344, 33721.831390843014, 32297.838510807414, 32489.67510324896, 32663.346733065326, 32666.836665816638, 32688.509672354932, 6226.159468471744, 6387.680615969206, 6554.639494827783, 6555.34446555343, 6558.409743123118, 6490.610563366213, 6529.085927970064, 6560.507961902877, 6571.244306904696, 6581.901271480931, 6563.474922006252, 6568.113304703852, 6611.801645950605, 6617.239017512999, 6620.172478440195, 6561.901571476432, 6593.472522198213, 6594.373534514213, 6597.043428702836, 6601.108850305195, 6483.935160648381, 6619.834504137387, 6659.367360100783, 6666.966665166691, 6699.59802411852, 31343.84328078368, 31388.21529461759, 31423.214419639462, 31600.525992110135, 31631.683683163104, 3008.0524634739986, 3017.215523963763, 3038.756899448061, 3040.452718510667, 3043.3000409905844, 24204.636930446057, 24273.7572624275, 24446.511069778506, 24448.0, 24523.934508186478, 2784.3735159589132, 2787.512185367573, 2791.330080780598, 2795.1893950754256, 2835.5463125899964, 140499.0, 140706.0, 141070.0, 150134.24932875374, 157310.99999999886, 39491.80254098769, 39663.0, 39738.41046358113, 39753.40369894454, 39767.20465590672, 41339.586604133576, 41464.79267603643, 41469.37795933063, 43426.131477370276, 44213.11573768571, 13494.662633434242, 13593.932030339984, 13594.048416610742, 13638.795418068737, 13665.0, 10906.34561926287, 11047.226694131494, 11060.22578419519, 11064.612738554111, 11081.833772493419, 12875.549355772502, 12923.676908077374, 12925.224486530838, 12928.288944107977, 13133.949284057253, 5280.577553795687, 5404.756785944642, 5559.444055594408, 5584.078627026576, 5591.496765291144, 841.7979684875586, 895.9955200223957, 913.3287034029983, 913.7898283394857, 941.5151197133482, 19509.90245048794, 20355.898220509098, 20697.586048279252, 21211.0, 21291.148354065663, 981.7398389426808, 985.2364417576292, 989.1789814453986, 999.165696643311, 1009.3792317724547, 10527.473626318806, 10965.451727413598, 11020.338779673246, 11258.211925165324, 11270.94364528172, 175510.12244938948, 176276.0, 176613.0, 176641.0, 177166.0, 39825.2034959305, 39990.0, 40129.19741605152, 40235.59764402377, 40302.59697403047, 1214.5991822698488, 1255.9417817613958, 1258.3582372989658, 1265.240855486719, 1270.7458508298378, 19288.8071119287, 19724.30964916221, 20555.38333849987, 20591.279305224245, 21091.367258982256, 29390.412191756473, 29437.0, 29453.410931781673, 29595.704042959296, 29603.259918502208, 149028.254858725, 149583.0, 150009.0, 150244.0, 150469.24765376103, 28665.28336791597, 28795.28011799722, 28907.855460722563, 28962.27594310159, 29186.416271674872, 34847.0, 35640.82179589189, 35828.283434331686, 35850.28299434049, 36191.81904090463, 26706.332341691614, 26824.731752682223, 27014.594781078693, 27212.0, 27541.86229068922, 26615.866920665274, 26706.19881403561, 27323.316917076438, 27370.315742106606, 27556.173314800588, 29552.704472955855, 29583.112506624835, 29592.556111657912, 29665.703342966295, 29781.851090744407, 24942.37644058913, 25493.0, 25891.22326330213, 25973.22080337593, 27448.862755686892, 19957.301494447624, 22438.77561224367, 22764.20325288607, 22926.0, 22984.195553155558], "value": 14329.66099472882, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.229302859424, 406.0157839876903, 417.90179307862655, 429.4267153350277, 431.17645297481795, 17128.657426851456, 17807.109644517754, 17825.82174178258, 18784.342548010787, 19580.70628940567, 17573.7363939541, 17674.38139665112, 17706.114694265267, 17868.28526858924, 17976.4607061788, 5161.380634323887, 5456.945430545684, 5493.313335833021, 5661.8584535386535, 5664.065429204176, 5288.021715982536, 5377.838664840061, 5385.138377859544, 5391.514763671269, 5396.83809485716, 5293.15309550472, 5339.145736682131, 5359.839204823861, 5374.4894235047805, 5379.246905433242, 5205.063088644042, 5241.449647787003, 5264.105102132647, 5268.104422248189, 5275.70983595904, 4772.403449568804, 4775.570198682135, 4775.737334446604, 4796.472388037313, 4800.711957282574, 21786.564268714537, 21881.562368752537, 22016.33950981473, 22075.448113797283, 22099.0, 1629.6496253305477, 1652.5620710511723, 1654.2225154177518, 1663.6922169398579, 1666.1419369024961, 14207.502737404244, 14240.786388204186, 14318.856811431857, 14657.413703451955, 14752.926235368754, 1990.562076343202, 2013.2852837242715, 2036.9898150509152, 2084.8957552122333, 2085.7497100347905, 80899.19100808975, 82160.58919705423, 82777.0, 82859.58570207171, 83672.58163709204, 11004.944975275072, 11046.779064418666, 11120.666380008613, 11220.587573671699, 11433.656990290305, 15892.841071589137, 15903.602409939844, 15978.121203333696, 15997.200139992954, 16018.279177437043, 7273.89089163663, 7401.740939067215, 7538.472306938462, 7669.118051424046, 7729.227077292226, 6594.625934663517, 6697.8995315070315, 6873.140857392826, 6887.311268873173, 6918.135233095863, 6770.69531871067, 6913.2049814272, 7019.298070193042, 7048.859022819617, 7092.113485814273, 1990.1490615658747, 2017.818396344336, 2021.878687278768, 2041.693745938121, 2227.554489102186, 834.8539005673982, 871.2681347667989, 872.9432586881833, 885.5262434597588, 912.2154946745793, 16571.0, 16625.418110366078, 16899.0, 16945.98324100558, 17557.824421755875, 877.1491653096487, 881.5592203898051, 882.1355072029447, 892.5448021509077, 909.0092696993695, 9090.136437038604, 9130.406523575946, 9347.392419492711, 9420.293477989178, 9545.952270238744, 313002.0, 313581.0, 318952.0, 332305.0, 334089.0, 68545.65727171332, 70289.64855175691, 70294.29705702877, 70626.64686676534, 72077.0, 1024.656739992111, 1034.8292531732332, 1040.7398150462384, 1056.3661802918189, 1060.4114716332663, 14081.225532595805, 14182.219977901315, 14384.0, 14514.491992780202, 14790.334434950239, 32226.0, 32249.193770155933, 32559.34881302408, 33258.334833303685, 34138.82930585331, 42426.0, 48484.757576211894, 49874.501254986986, 50085.24872126994, 50398.0, 7991.24083212094, 8015.959920200362, 8103.473274237156, 8346.956630421197, 8523.190296921783, 11656.88343116592, 11688.240264382788, 11900.58347957852, 12197.939010304892, 12215.328156951453, 9078.954605226932, 10042.548085336031, 10251.12865406419, 10370.429626370622, 10697.625583104555, 9178.541072946193, 9355.85966210521, 9514.0, 9688.612455501983, 9871.16095131893, 10327.690169294932, 10734.562014091036, 10800.40597767099, 10874.673759786903, 10885.619003334845, 8125.146859579659, 8128.227818357246, 8247.175282471704, 8252.174782521699, 8258.876116858131, 10120.493975301059, 10417.37495750227, 10453.059224669816, 10707.892921071001, 10920.0], "value": 8550.53597964194, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1233.192259070309, 1287.8132670762734, 1294.9352532373384, 1295.8574556798756, 1312.5996571045832, 10145.391276523414, 10581.78836423271, 10615.99148080932, 10646.095081918027, 10988.28576142552, 10674.3595384277, 10842.783144337129, 10903.0, 10905.18211134166, 10946.835797463045, 2190.7261592300924, 2235.8434909556336, 2246.5731511012937, 2250.1224522436264, 2252.628316327804, 2109.9050542725613, 2180.356794745554, 2183.879886606236, 2185.694002839604, 2192.506685995646, 2159.470929622245, 2200.559888022394, 2210.0, 2218.7892150245702, 2223.1885361842974, 2099.9685004724943, 2108.20942146695, 2113.144176608476, 2123.055240418015, 2124.702541644171, 2011.205573798356, 2099.5800839832095, 2192.6601376786625, 2200.1639377036786, 2200.9779902200935, 10693.0, 10708.892911070867, 10758.569657213702, 10795.2443328967, 10803.297785643908, 5370.9731451342495, 5554.305711786027, 5556.805511807108, 5592.273004509388, 5613.943860561424, 3082.520390212688, 3104.1463597510638, 3192.5690031845634, 3193.0740085375214, 3224.790388624732, 958.0611001218775, 968.0948313327061, 977.5454413697594, 985.418603024212, 988.2390559269322, 15356.846431535654, 15509.0, 15549.455769048029, 15610.219489025616, 15641.765373519407, 4391.077873646506, 4604.539546045368, 4674.95325046752, 4704.882377940579, 4707.599854012447, 11092.168087393316, 11144.275622084539, 11165.441727913572, 11189.104871610252, 11201.71995700114, 5397.217403476474, 5518.2826232590305, 5521.944780552223, 5522.144067669517, 5533.501984821305, 5095.617828662791, 5129.743512824344, 5148.588112950955, 5149.433562308143, 5157.871053223699, 3693.593704692482, 3798.2783271178387, 3828.157805282833, 3870.9612903871166, 3896.6298201670797, 1087.1302957633861, 1091.3888222595372, 1101.542859713226, 1118.6588090632272, 1122.893325134111, 693.6462404173908, 727.9526830755984, 729.7372945739529, 742.6509540515949, 745.4893398022372, 5513.476219759116, 5579.860503487445, 5628.1427129047315, 5752.971235143881, 5759.683217423082, 541.507228422134, 569.9173619825102, 570.0451743329905, 573.131705466219, 573.9913901291484, 3684.412140749923, 3923.136909879822, 3956.802159891994, 4020.798960051986, 4041.2119636671155, 12969.286689231994, 13243.536476223479, 13335.799963000563, 13390.0, 13414.0, 12961.0, 13175.407106680223, 13392.933035334761, 13417.054527093516, 13461.0, 7442.925570744332, 7470.887936680954, 7550.848983020309, 7851.05787305527, 7892.013498312596, 6537.967310163419, 6680.365365290289, 6681.665916704243, 6811.777474633765, 6837.487188460786, 12393.132480726263, 12453.1905426147, 12497.125201235825, 12567.858035491126, 12571.1200215984, 12537.561185358469, 12682.87317126817, 12891.935540322238, 12965.41655625518, 13013.284269365276, 8233.17668233172, 8292.626831792462, 8352.331813454788, 8357.874631880648, 8388.496690198608, 9541.618335266512, 9559.474228917197, 9627.470489123165, 9653.517324133905, 9691.418514889128, 7930.0, 7955.880661789962, 7975.5613441258965, 8021.598920053857, 8165.959170204111, 7954.522728636301, 8072.273495385443, 8072.5963701815845, 8112.675492980215, 8206.302464290602, 7040.225575186828, 7124.536905101152, 7127.82180445493, 7164.068671072727, 7200.675969581486, 4771.785269662804, 5185.766640501111, 5323.228131920927, 5361.651492652965, 5661.518770904519, 5168.53483186515, 5181.689098654093, 5299.576033917355, 5332.786688532416, 5370.19447082925], "value": 4710.410715294655, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.957630296213, 341.69418370558367, 350.8210812485633, 354.52493658497616, 366.7359501159165, 5505.834824955247, 5544.63959842611, 5549.361823390312, 5564.7217639118035, 5574.665520068788, 5426.403095659484, 5441.061826613623, 5448.828501872097, 5450.754716037778, 5455.972720136394, 3845.288621604998, 3976.7216294859372, 3995.900102497432, 4019.859304924328, 4024.8993775155564, 4013.1371755072655, 4016.15660711251, 4016.2770701273757, 4017.5982401759884, 4038.8788336349958, 3948.9012774680577, 3971.483707118085, 3972.4041393791017, 3977.9856136685103, 3981.8850721797944, 3861.768293902375, 3965.781881996489, 3967.305721498726, 3994.660453861425, 4022.2357752027315, 3455.4644030175364, 3458.170039190601, 3464.3764122457947, 3470.791752494833, 3489.4068008438626, 5264.341957255343, 5268.4994925482015, 5280.524752772269, 5283.973580132113, 5297.417284098746, 4589.311603259504, 4732.1482133216, 4736.597389221886, 4742.715437073786, 4742.786574604151, 5651.943480565224, 5702.258706368187, 5715.114157305624, 5752.165935939265, 5754.798582049608, 3953.367461206222, 3960.980195099006, 3970.7419017763755, 3977.363621820524, 3980.0845805464614, 5882.6468912719765, 6049.697515124226, 6089.142811442508, 6112.8518812811435, 6133.233345831815, 3959.762414255154, 3966.643002129764, 3969.3053715599654, 3985.3822657488136, 3990.84036638537, 4002.939955900664, 4007.859724909614, 4012.1574469361763, 4027.6708686133506, 4036.6367026967714, 4563.406757121553, 4678.087772884255, 4683.1336202802595, 4692.976535117371, 4702.905941881211, 5735.569832262514, 5741.5119714824705, 5777.2200752897825, 5784.508316793035, 5827.970860145672, 1380.9033367664367, 1381.8272715910512, 1383.8062671226037, 1384.3770303363526, 1392.0673148990202, 884.045231150356, 934.4486752815872, 949.9313272568361, 951.7763325618613, 954.1632357711378, 5003.424606170337, 5005.82479613219, 5020.949790502048, 5029.597632189416, 5039.395272567315, 5916.6924899289315, 5996.880062398727, 6003.549733769984, 6024.0, 6025.638461692312, 4826.276058591239, 4957.479464656231, 4989.700617962933, 4999.125153098194, 5007.168082800115, 3136.498160294342, 3142.1987393214586, 3166.920826979344, 3170.619525656936, 3177.126290270148, 5522.972385138049, 5524.375921437366, 5539.944600553943, 5542.224088627595, 5546.362168350692, 5919.55603329752, 5973.551983601247, 6108.297545782203, 6161.199044124235, 6177.752889884354, 5535.003699334078, 5536.861578460571, 5549.6680796608525, 5561.944380556223, 5562.527185189304, 5953.9404605955115, 5970.31341395745, 5977.342492325927, 5982.341942386421, 5983.401659833982, 5697.373288938131, 5812.128180772749, 5862.032764593965, 5878.502945246975, 5926.348101708895, 5519.2824932758485, 5541.722913854372, 5542.0855558832345, 5545.4490934170735, 5565.9721701392855, 3976.423418604344, 4038.4548086008012, 4039.7778122203563, 4047.9797601011805, 4053.6554392875755, 5950.464458198783, 5966.910496342472, 5971.850703732442, 5997.340292567901, 6005.90991135142, 5721.39800855761, 5743.195952566561, 5761.740721667619, 5765.94234057654, 5795.478406943395, 5649.4633009864, 5696.259486266758, 5727.885442291047, 5728.455796699307, 5775.848721112002, 5668.149777533403, 5690.231818704422, 5696.401877802771, 5698.572607054404, 5717.656940583578, 5659.801906933238, 5801.709914504174, 5804.303483581997, 5807.680577568274, 5812.169166712472, 5609.354924183608, 5619.578531610227, 5635.492805647511, 5645.802396916089, 5666.518345940642], "value": 4255.365062756533, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.9464540159482, 739.6560599321318, 744.6649007946423, 753.7437271327748, 760.2017881224714, 12893.613191604256, 13560.186388816666, 13634.931825340871, 14854.48009319674, 15365.0, 16643.50069497914, 16696.916515417437, 16782.244798984044, 16797.66404671909, 16875.746863797052, 899.7435730816702, 922.6908985489836, 922.9630814767402, 924.2929159193222, 925.6297481007583, 869.8608222684372, 917.9908200917972, 922.0502882031518, 924.1867156901917, 935.4247138010143, 955.3933252384717, 961.7066794627635, 967.0571193086754, 973.226285103341, 976.1848856205078, 963.9228861691048, 966.6665000574791, 966.8646389505475, 967.2793768642406, 967.8838539375249, 711.8291610013612, 713.9678714457862, 714.1002337055296, 714.8212946763309, 715.0204220218283, 14329.283535823168, 14480.493182738659, 14652.194129322883, 14742.0, 14781.0, 15026.699466010728, 15472.613184670361, 15514.456994005155, 15519.456819011393, 15527.068375897483, 11912.88087119135, 11950.88049119515, 12010.339431331273, 12176.939115304456, 12240.081993850408, 2893.3779237463837, 2898.9565156522667, 2905.6077429546954, 2914.7813913956325, 2924.1519959211805, 80288.0, 80708.59645701792, 81453.0, 81981.59009204975, 82828.58585707033, 12784.936075319563, 12930.094893357375, 12936.547220847226, 12937.611871643865, 12963.15739476931, 22836.086556537553, 23831.52336953286, 24042.278731638078, 24048.759512405002, 24315.270541883772, 5939.2575928009, 5964.522838172936, 5994.610350327302, 6007.36922623127, 6058.969705151534, 2970.3168271297723, 3054.9847250763605, 3064.4483992881496, 3064.7548196144253, 3067.217859445827, 3450.9654903451146, 3556.324298383299, 3573.3032058748295, 3574.660407261306, 3581.3732596795458, 652.0773106054879, 656.7963931181349, 659.9406053455212, 660.5673283998989, 662.9635370054693, 573.3750212268648, 585.4233579923772, 592.3365830270125, 596.9820905372845, 600.8738164985315, 9816.969218232125, 9988.850167247498, 10184.236182286359, 10310.0, 11213.775724485628, 568.9317281926195, 574.5662025170969, 589.4812564942908, 602.6715440085164, 609.4880300547561, 4494.955050449519, 4635.629149668019, 4666.65000124992, 4678.391809064799, 4680.648951328664, 84575.15424845795, 87117.0, 87122.56438717766, 88747.0, 90727.0, 75435.0, 77965.0, 78599.21400786033, 80979.59510202412, 81353.18646813456, 60877.0, 61716.69141654353, 62512.687436562526, 62627.37372626307, 65531.67234163799, 9816.411015339103, 10110.090091891765, 10518.368897866152, 10668.146548276274, 10813.62152324665, 27664.723352766214, 27919.581206282328, 28420.289492762848, 29275.121746347642, 29392.412151756416, 34800.0, 35005.47491787574, 35208.0, 35872.0, 36291.45562816507, 13237.205767653972, 13278.734425311633, 13408.050228949616, 13529.18824870511, 13687.863121368659, 14806.185659788815, 15012.399504020153, 15116.319765610355, 15190.696186076437, 15481.845181548491, 13872.514461993782, 14053.508127215498, 14135.43458261658, 14185.077969931921, 14289.35697893618, 14785.186814725294, 14849.777253341425, 14921.477748278758, 15155.772663409836, 15306.846931530543, 13789.172649641054, 13960.2321872298, 14611.269436528344, 14660.340284687001, 14781.039232449857, 10299.279050466395, 10388.220883433622, 10473.31923424975, 10684.57261709554, 11185.0, 10585.9470702646, 10647.733806654896, 11310.0, 11314.0, 11446.37044962535], "value": 7105.664005855357, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1562.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 115.0, 116.0, 114.0, 113.0, 114.0, 112.0, 112.0, 114.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 124.0, 123.0, 185.0, 127.0, 128.0, 125.0, 131.0, 154.0, 128.0], "value": 138.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 165.0, 170.0, 169.0, 168.0, 163.0, 164.0, 162.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 74.0, 112.0, 76.0, 75.0, 74.0, 74.0, 89.0, 75.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 103.0, 83.0, 84.0, 84.0, 96.0, 87.0, 84.0, 104.0], "value": 89.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 113.0, 114.0, 114.0, 113.0, 115.0, 116.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 151.0, 153.0, 151.0, 151.0, 150.0, 150.0, 151.0, 151.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 56.0, 56.0, 55.0, 57.0, 54.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 59.0, 56.0, 57.0, 57.0, 57.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 87.0, 88.0, 86.0, 89.0, 89.0, 106.0, 123.0, 91.0], "value": 93.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 140.0, 134.0, 139.0, 143.0, 134.0, 144.0, 133.0, 139.0, 139.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 196.0, 196.0, 196.0, 201.0, 199.0, 203.0, 200.0, 198.0, 196.0], "value": 197.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 74.0, 74.0, 79.0, 72.0, 75.0, 76.0, 71.0, 73.0], "value": 74.5, "unit": "score"}]}]} 02:33:53 INFO - Return code: 0 02:33:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:33:53 INFO - # TBPL SUCCESS # 02:33:53 INFO - Running post-action listener: _resource_record_post_action 02:33:53 INFO - [mozharness: 2017-05-25 09:33:53.741859Z] Finished run-tests step (success) 02:33:53 INFO - Running post-run listener: _resource_record_post_run 02:33:53 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 8761344; Write bytes: 400863232; Read time: 2672; Write time: 330960 02:33:53 INFO - TinderboxPrint: CPU usage
12.7% 02:33:53 INFO - TinderboxPrint: I/O read bytes / time
8,761,344 / 2,672 02:33:53 INFO - TinderboxPrint: I/O write bytes / time
400,863,232 / 330,960 02:33:53 INFO - TinderboxPrint: CPU idle
8,749.3 (87.2%) 02:33:53 INFO - TinderboxPrint: CPU user
1,218.4 (12.1%) 02:33:53 INFO - TinderboxPrint: Swap in / out
0 / 0 02:33:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 97538048; Read time: 204; Write time: 75588 02:33:53 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 7012352; Write bytes: 303325184; Read time: 2412; Write time: 255372 02:33:54 INFO - Running post-run listener: _upload_blobber_files 02:33:54 INFO - Blob upload gear active. 02:33:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:33:54 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 02:33:54 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'] 02:33:54 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 02:33:54 INFO - (blobuploader) - INFO - Open directory for files ... 02:33:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:33:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:33:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:55 INFO - (blobuploader) - INFO - Done attempting. 02:33:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:33:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:33:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:56 INFO - (blobuploader) - INFO - Done attempting. 02:33:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:33:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:33:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:33:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:33:59 INFO - (blobuploader) - INFO - Done attempting. 02:33:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:33:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:33:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:34:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:34:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:34:00 INFO - (blobuploader) - INFO - Done attempting. 02:34:00 INFO - (blobuploader) - INFO - Iteration through files over. 02:34:00 INFO - Return code: 0 02:34:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:34:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:34:00 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc3a2271f5c0dccb4eeb0404edc277e599ec12dd8877a1eb93bd9493ba32042d7563adf1f385a6a2ab38e94dbc368ec42d7177d3f97b4abd9c411231aa0ae310", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9da3248d15bc1b18ebdd4730a309bf59c8b4b412ee729a661d83969de15094fe3d2cb0e343f5557220a9234de8e92f0495d26d8a74c503dbc881a19b170bfcc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5833a62b6b917ec8fb9a1c94f008a72959ff5d5e803a02efe032f6b2bf48bab4cfca6bfefe028a9e46875c7bf83a57f81789c40eb0880001a7ac542474102879", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db90aa634d87b45969a72f06e59db97a914822d051f18041a9855e4aa8518cdbc93f788d3787c80f658df96c9a14e6fd1b7430ef83ad9f838d6c3262142f0b0d"} 02:34:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:34:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:34:00 INFO - Contents: 02:34:00 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc3a2271f5c0dccb4eeb0404edc277e599ec12dd8877a1eb93bd9493ba32042d7563adf1f385a6a2ab38e94dbc368ec42d7177d3f97b4abd9c411231aa0ae310", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9da3248d15bc1b18ebdd4730a309bf59c8b4b412ee729a661d83969de15094fe3d2cb0e343f5557220a9234de8e92f0495d26d8a74c503dbc881a19b170bfcc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5833a62b6b917ec8fb9a1c94f008a72959ff5d5e803a02efe032f6b2bf48bab4cfca6bfefe028a9e46875c7bf83a57f81789c40eb0880001a7ac542474102879", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db90aa634d87b45969a72f06e59db97a914822d051f18041a9855e4aa8518cdbc93f788d3787c80f658df96c9a14e6fd1b7430ef83ad9f838d6c3262142f0b0d"} 02:34:00 INFO - Running post-run listener: copy_logs_to_upload_dir 02:34:00 INFO - Copying logs to upload dir... 02:34:00 INFO - mkdir: /builds/slave/test/build/upload/logs 02:34:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1334.335247 ========= master_lag: -0.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 14 secs) (at 2017-05-25 02:34:00.590084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 02:34:00.594052) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc3a2271f5c0dccb4eeb0404edc277e599ec12dd8877a1eb93bd9493ba32042d7563adf1f385a6a2ab38e94dbc368ec42d7177d3f97b4abd9c411231aa0ae310", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9da3248d15bc1b18ebdd4730a309bf59c8b4b412ee729a661d83969de15094fe3d2cb0e343f5557220a9234de8e92f0495d26d8a74c503dbc881a19b170bfcc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5833a62b6b917ec8fb9a1c94f008a72959ff5d5e803a02efe032f6b2bf48bab4cfca6bfefe028a9e46875c7bf83a57f81789c40eb0880001a7ac542474102879", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db90aa634d87b45969a72f06e59db97a914822d051f18041a9855e4aa8518cdbc93f788d3787c80f658df96c9a14e6fd1b7430ef83ad9f838d6c3262142f0b0d"} build_url:https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011245 build_url: 'https://queue.taskcluster.net/v1/task/PfMpf1BXTwSiZjrW9lNioQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cc3a2271f5c0dccb4eeb0404edc277e599ec12dd8877a1eb93bd9493ba32042d7563adf1f385a6a2ab38e94dbc368ec42d7177d3f97b4abd9c411231aa0ae310", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9da3248d15bc1b18ebdd4730a309bf59c8b4b412ee729a661d83969de15094fe3d2cb0e343f5557220a9234de8e92f0495d26d8a74c503dbc881a19b170bfcc5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5833a62b6b917ec8fb9a1c94f008a72959ff5d5e803a02efe032f6b2bf48bab4cfca6bfefe028a9e46875c7bf83a57f81789c40eb0880001a7ac542474102879", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db90aa634d87b45969a72f06e59db97a914822d051f18041a9855e4aa8518cdbc93f788d3787c80f658df96c9a14e6fd1b7430ef83ad9f838d6c3262142f0b0d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 02:34:00.618478) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:34:00.618816) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1495703321.306769-735834351 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 02:34:00.701889) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 02:34:00.702222) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 02:34:00.702533) ========= ========= Total master_lag: -0.09 =========