builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1495633323.21 results: success (0) revision: d93182f36b3c134a3b1c6718f09eb87c2913e364 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:03.212511) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:03.212960) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:03.213238) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:03.240889) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:03.241210) ========= 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=32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-24 06:42:03-- 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% 22.4M=0.001s 2017-05-24 06:42:03 (22.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.192287 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:03.447113) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:03.447422) ========= 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=32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018846 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:03.499488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:03.502853) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d93182f36b3c134a3b1c6718f09eb87c2913e364 --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 d93182f36b3c134a3b1c6718f09eb87c2913e364 --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=32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-24 06:42:03,288 truncating revision to first 12 chars 2017-05-24 06:42:03,289 Setting DEBUG logging. 2017-05-24 06:42:03,289 attempt 1/10 2017-05-24 06:42:03,289 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d93182f36b3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-24 06:42:03,792 unpacking tar archive at: mozilla-central-d93182f36b3c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.855720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:04.370342) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:04.370652) ========= script_repo_revision: d93182f36b3c134a3b1c6718f09eb87c2913e364 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:04.374032) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:04.374289) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 06:42:04.382387) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-24 06:42:04.382708) ========= /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=32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:42:04 INFO - MultiFileLogger online at 20170524 06:42:04 in /builds/slave/test 06:42:04 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 06:42:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:42:04 INFO - {'append_to_log': False, 06:42:04 INFO - 'base_work_dir': '/builds/slave/test', 06:42:04 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:42:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:42:04 INFO - 'branch': 'Firefox-Non-PGO', 06:42:04 INFO - 'buildbot_json_path': 'buildprops.json', 06:42:04 INFO - 'config_files': ('talos/linux_config.py',), 06:42:04 INFO - 'default_actions': ('clobber', 06:42:04 INFO - 'read-buildbot-config', 06:42:04 INFO - 'download-and-extract', 06:42:04 INFO - 'populate-webroot', 06:42:04 INFO - 'create-virtualenv', 06:42:04 INFO - 'install', 06:42:04 INFO - 'run-tests'), 06:42:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:42:04 INFO - 'download_minidump_stackwalk': True, 06:42:04 INFO - 'download_symbols': 'ondemand', 06:42:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:42:04 INFO - 'tooltool.py': '/tools/tooltool.py', 06:42:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:42:04 INFO - '/tools/misc-python/virtualenv.py')}, 06:42:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:42:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:42:04 INFO - 'gecko_profile': False, 06:42:04 INFO - 'gecko_profile_interval': 0, 06:42:04 INFO - 'installer_path': 'installer.exe', 06:42:04 INFO - 'log_level': 'info', 06:42:04 INFO - 'log_name': 'talos', 06:42:04 INFO - 'log_to_console': True, 06:42:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:42:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:42:04 INFO - 'opt_config_files': (), 06:42:04 INFO - 'pip_index': False, 06:42:04 INFO - 'suite': 'dromaeojs-e10s', 06:42:04 INFO - 'system_bits': '32', 06:42:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:42:04 INFO - 'title': 'talos-linux64-ix-008', 06:42:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:42:04 INFO - 'use_talos_json': True, 06:42:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:42:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:42:04 INFO - 'work_dir': 'build'} 06:42:04 INFO - [mozharness: 2017-05-24 13:42:04.349754Z] Running clobber step. 06:42:04 INFO - Running pre-action listener: _resource_record_pre_action 06:42:04 INFO - Running main action method: clobber 06:42:04 INFO - rmtree: /builds/slave/test/build 06:42:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:42:05 INFO - Running post-action listener: _resource_record_post_action 06:42:05 INFO - [mozharness: 2017-05-24 13:42:05.328626Z] Finished clobber step (success) 06:42:05 INFO - [mozharness: 2017-05-24 13:42:05.328726Z] Running read-buildbot-config step. 06:42:05 INFO - Running pre-action listener: _resource_record_pre_action 06:42:05 INFO - Running main action method: read_buildbot_config 06:42:05 INFO - Using buildbot properties: 06:42:05 INFO - { 06:42:05 INFO - "project": "", 06:42:05 INFO - "product": "firefox", 06:42:05 INFO - "who": "ryanvm@gmail.com", 06:42:05 INFO - "installer_path": "public/build/target.tar.bz2", 06:42:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:42:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:42:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:42:05 INFO - "stage_platform": "linux64", 06:42:05 INFO - "basedir": "/builds/slave/test", 06:42:05 INFO - "buildnumber": 628, 06:42:05 INFO - "platform": "ubuntu64_hw", 06:42:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:42:05 INFO - "slavebuilddir": "test", 06:42:05 INFO - "taskId": "OySPjVnxQLKi2mQfLlf72A", 06:42:05 INFO - "branch": "mozilla-central", 06:42:05 INFO - "script_repo_revision": "production", 06:42:05 INFO - "revision": "d93182f36b3c134a3b1c6718f09eb87c2913e364", 06:42:05 INFO - "slavename": "talos-linux64-ix-008", 06:42:05 INFO - "repo_path": "mozilla-central" 06:42:05 INFO - } 06:42:05 INFO - Finding installer, test and symbols from parent task. 06:42:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OySPjVnxQLKi2mQfLlf72A'}, attempt #1 06:42:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OySPjVnxQLKi2mQfLlf72A'}, attempt #1 06:42:06 INFO - Task dependencies: XXkWE3mxR8qFdcF_LoYLxQ 06:42:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ'}, attempt #1 06:42:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.tar.bz2 06:42:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/test_packages.json 06:42:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.crashreporter-symbols.zip 06:42:06 INFO - Running post-action listener: _resource_record_post_action 06:42:06 INFO - [mozharness: 2017-05-24 13:42:06.717207Z] Finished read-buildbot-config step (success) 06:42:06 INFO - [mozharness: 2017-05-24 13:42:06.717466Z] Running download-and-extract step. 06:42:06 INFO - Running pre-action listener: _resource_record_pre_action 06:42:06 INFO - Running main action method: download_and_extract 06:42:06 INFO - mkdir: /builds/slave/test/build/tests 06:42:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:06 INFO - trying https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.test_packages.json 06:42:06 INFO - Downloading https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:42:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:42:07 INFO - Downloaded 986 bytes. 06:42:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:42:07 INFO - Using the following test package requirements: 06:42:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:42:07 INFO - u'common': [u'target.common.tests.zip'], 06:42:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:42:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:42:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:42:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:42:07 INFO - u'mozbase': [u'target.common.tests.zip'], 06:42:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:42:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:42:07 INFO - u'web-platform': [u'target.common.tests.zip', 06:42:07 INFO - u'target.web-platform.tests.zip'], 06:42:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:42:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:42:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.common.tests.zip 06:42:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:42:07 INFO - Fetch https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.common.tests.zip into memory 06:42:08 INFO - Content-Length response header: 63523791 06:42:08 INFO - Bytes received: 63523791 06:42:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:42:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.common.tests.zip 06:42:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:42:19 INFO - Fetch https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.common.tests.zip into memory 06:42:20 INFO - Content-Length response header: 63523791 06:42:20 INFO - Bytes received: 63523791 06:42:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.talos.tests.zip 06:42:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:42:33 INFO - Fetch https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.talos.tests.zip into memory 06:42:33 INFO - Content-Length response header: 14411859 06:42:33 INFO - Bytes received: 14411859 06:42:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:42:34 INFO - trying https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.tar.bz2 06:42:34 INFO - Downloading https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:42:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:42:35 INFO - Downloaded 54888463 bytes. 06:42:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.tar.bz2 06:42:35 INFO - mkdir: /builds/slave/test/properties 06:42:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:42:35 INFO - Writing to file /builds/slave/test/properties/build_url 06:42:35 INFO - Contents: 06:42:35 INFO - build_url:https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.tar.bz2 06:42:35 INFO - Running post-action listener: _resource_record_post_action 06:42:35 INFO - Running post-action listener: set_extra_try_arguments 06:42:35 INFO - [mozharness: 2017-05-24 13:42:35.206446Z] Finished download-and-extract step (success) 06:42:35 INFO - [mozharness: 2017-05-24 13:42:35.206543Z] Running populate-webroot step. 06:42:35 INFO - Running pre-action listener: _resource_record_pre_action 06:42:35 INFO - Running main action method: populate_webroot 06:42:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:42:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:42:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:42:35 INFO - '--tppagecycles', 06:42:35 INFO - '7'], 06:42:35 INFO - 'tests': ['tsvgm']}}, 06:42:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:42:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:42:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:42:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:42:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:42:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:42:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:42:35 INFO - 'talos_options': ['--disable-e10s'], 06:42:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:42:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:42:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:42:35 INFO - 'talos_options': ['--disable-e10s'], 06:42:35 INFO - 'tests': ['damp', 'tps']}, 06:42:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:42:35 INFO - 'tests': ['damp', 'tps']}, 06:42:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:42:35 INFO - 'tests': ['dromaeo_dom']}, 06:42:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:42:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:42:35 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:42:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:42:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:42:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:42:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:42:35 INFO - 'tests': ['a11yr', 06:42:35 INFO - 'ts_paint', 06:42:35 INFO - 'tpaint', 06:42:35 INFO - 'sessionrestore', 06:42:35 INFO - 'sessionrestore_no_auto_restore', 06:42:35 INFO - 'tabpaint']}, 06:42:35 INFO - 'other-e10s': {'tests': ['a11yr', 06:42:35 INFO - 'ts_paint', 06:42:35 INFO - 'tpaint', 06:42:35 INFO - 'sessionrestore', 06:42:35 INFO - 'sessionrestore_no_auto_restore', 06:42:35 INFO - 'tabpaint']}, 06:42:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:42:35 INFO - 'ts_paint', 06:42:35 INFO - 'tpaint', 06:42:35 INFO - 'sessionrestore', 06:42:35 INFO - 'sessionrestore_no_auto_restore', 06:42:35 INFO - 'tabpaint']}, 06:42:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:42:35 INFO - 'ts_paint', 06:42:35 INFO - 'tpaint', 06:42:35 INFO - 'sessionrestore', 06:42:35 INFO - 'sessionrestore_no_auto_restore', 06:42:35 INFO - 'tabpaint']}, 06:42:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:42:35 INFO - 'tests': ['a11yr', 06:42:35 INFO - 'ts_paint', 06:42:35 INFO - 'tpaint', 06:42:35 INFO - 'sessionrestore', 06:42:35 INFO - 'sessionrestore_no_auto_restore', 06:42:35 INFO - 'tabpaint']}, 06:42:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:42:35 INFO - 'tests': ['a11yr', 06:42:35 INFO - 'ts_paint', 06:42:35 INFO - 'tpaint', 06:42:35 INFO - 'sessionrestore', 06:42:35 INFO - 'sessionrestore_no_auto_restore', 06:42:35 INFO - 'tabpaint']}, 06:42:35 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:42:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:42:35 INFO - 'bloom_basic_ref']}, 06:42:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:42:35 INFO - 'tests': ['tsvgx', 06:42:35 INFO - 'tsvgr_opacity', 06:42:35 INFO - 'tart', 06:42:35 INFO - 'tscrollx', 06:42:35 INFO - 'cart', 06:42:35 INFO - 'tsvg_static']}, 06:42:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:42:35 INFO - 'tsvgr_opacity', 06:42:35 INFO - 'tart', 06:42:35 INFO - 'tscrollx', 06:42:35 INFO - 'cart', 06:42:35 INFO - 'tsvg_static']}, 06:42:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:42:35 INFO - 'talos_options': ['--disable-e10s'], 06:42:35 INFO - 'tests': ['tp5o']}, 06:42:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:42:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:42:35 INFO - 'talos_options': ['--disable-e10s', 06:42:35 INFO - '--xperf_path', 06:42:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:35 INFO - 'tests': ['tp5n']}, 06:42:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:42:35 INFO - 'talos_options': ['--xperf_path', 06:42:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:42:35 INFO - 'tests': ['tp5n']}}, 06:42:35 INFO - 'talos.zip': {'path': '', 06:42:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:42:35 INFO - Running post-action listener: _resource_record_post_action 06:42:35 INFO - [mozharness: 2017-05-24 13:42:35.221283Z] Finished populate-webroot step (success) 06:42:35 INFO - [mozharness: 2017-05-24 13:42:35.221401Z] Running create-virtualenv step. 06:42:35 INFO - Running pre-action listener: _resource_record_pre_action 06:42:35 INFO - Running main action method: create_virtualenv 06:42:35 INFO - Creating virtualenv /builds/slave/test/build/venv 06:42:35 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 06:42:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:42:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:42:35 INFO - Using real prefix '/usr' 06:42:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:42:36 INFO - Installing distribute.............................................................................................................................................................................................done. 06:42:38 INFO - Installing pip.................done. 06:42:38 INFO - Return code: 0 06:42:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:42:38 INFO - Reading from file tmpfile_stdout 06:42:38 INFO - Output received: 06:42:38 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) 06:42:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:42:38 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')]} 06:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:38 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')]} 06:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:38 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 0x269d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a105c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d7a0>, '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 0x2a0e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0eb30>, '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': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', '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 06:42:38 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 06:42:38 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 06:42:38 INFO - Using env: {'DISPLAY': ':0', 06:42:38 INFO - 'HOME': '/home/cltbld', 06:42:38 INFO - 'LANG': 'en_US.UTF-8', 06:42:38 INFO - 'LANGUAGE': 'en_US:en', 06:42:38 INFO - 'LOGNAME': 'cltbld', 06:42:38 INFO - 'MAIL': '/var/mail/cltbld', 06:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:38 INFO - 'MOZ_NO_REMOTE': '1', 06:42:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:38 INFO - 'NO_EM_RESTART': '1', 06:42:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:38 INFO - 'PWD': '/builds/slave/test', 06:42:38 INFO - 'SHELL': '/bin/bash', 06:42:38 INFO - 'SHLVL': '1', 06:42:38 INFO - 'TERM': 'linux', 06:42:38 INFO - 'TMOUT': '86400', 06:42:38 INFO - 'USER': 'cltbld', 06:42:38 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', 06:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:38 INFO - '_': '/tools/buildbot/bin/python'} 06:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42: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 06:42:39 INFO - Cleaning up... 06:42:39 INFO - Return code: 0 06:42:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42: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')]} 06:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42: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 0x269d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a105c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d7a0>, '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 0x2a0e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0eb30>, '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': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', '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 06:42: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 06:42: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 06:42:39 INFO - Using env: {'DISPLAY': ':0', 06:42:39 INFO - 'HOME': '/home/cltbld', 06:42:39 INFO - 'LANG': 'en_US.UTF-8', 06:42:39 INFO - 'LANGUAGE': 'en_US:en', 06:42:39 INFO - 'LOGNAME': 'cltbld', 06:42:39 INFO - 'MAIL': '/var/mail/cltbld', 06:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:39 INFO - 'MOZ_NO_REMOTE': '1', 06:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:39 INFO - 'NO_EM_RESTART': '1', 06:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:39 INFO - 'PWD': '/builds/slave/test', 06:42:39 INFO - 'SHELL': '/bin/bash', 06:42:39 INFO - 'SHLVL': '1', 06:42:39 INFO - 'TERM': 'linux', 06:42:39 INFO - 'TMOUT': '86400', 06:42:39 INFO - 'USER': 'cltbld', 06:42:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', 06:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:39 INFO - '_': '/tools/buildbot/bin/python'} 06:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:39 INFO - Downloading/unpacking psutil>=3.1.1 06:42: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 06:42: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 06:42: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 06:42: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 06:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:42:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:42:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:42:40 INFO - Installing collected packages: psutil 06:42:40 INFO - Running setup.py install for psutil 06:42:40 INFO - building 'psutil._psutil_linux' extension 06:42: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 06:42: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 06:42:41 INFO - building 'psutil._psutil_posix' extension 06:42: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 06:42: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_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:42:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:42:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:42:42 INFO - Successfully installed psutil 06:42:42 INFO - Cleaning up... 06:42:42 INFO - Return code: 0 06:42:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42: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')]} 06:42:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42: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 0x269d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a105c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d7a0>, '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 0x2a0e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0eb30>, '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': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', '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 06:42: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 06:42: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 06:42:42 INFO - Using env: {'DISPLAY': ':0', 06:42:42 INFO - 'HOME': '/home/cltbld', 06:42:42 INFO - 'LANG': 'en_US.UTF-8', 06:42:42 INFO - 'LANGUAGE': 'en_US:en', 06:42:42 INFO - 'LOGNAME': 'cltbld', 06:42:42 INFO - 'MAIL': '/var/mail/cltbld', 06:42:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:42 INFO - 'MOZ_NO_REMOTE': '1', 06:42:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:42 INFO - 'NO_EM_RESTART': '1', 06:42:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:42 INFO - 'PWD': '/builds/slave/test', 06:42:42 INFO - 'SHELL': '/bin/bash', 06:42:42 INFO - 'SHLVL': '1', 06:42:42 INFO - 'TERM': 'linux', 06:42:42 INFO - 'TMOUT': '86400', 06:42:42 INFO - 'USER': 'cltbld', 06:42:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', 06:42:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:42 INFO - '_': '/tools/buildbot/bin/python'} 06:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:42: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 06:42: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 06:42: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 06:42: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 06:42:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:42:43 INFO - Installing collected packages: mozsystemmonitor 06:42:43 INFO - Running setup.py install for mozsystemmonitor 06:42:43 INFO - Successfully installed mozsystemmonitor 06:42:43 INFO - Cleaning up... 06:42:43 INFO - Return code: 0 06:42:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42: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')]} 06:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42: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 0x269d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a105c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d7a0>, '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 0x2a0e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0eb30>, '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': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', '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 06:42: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 06:42: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 06:42:43 INFO - Using env: {'DISPLAY': ':0', 06:42:43 INFO - 'HOME': '/home/cltbld', 06:42:43 INFO - 'LANG': 'en_US.UTF-8', 06:42:43 INFO - 'LANGUAGE': 'en_US:en', 06:42:43 INFO - 'LOGNAME': 'cltbld', 06:42:43 INFO - 'MAIL': '/var/mail/cltbld', 06:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:43 INFO - 'MOZ_NO_REMOTE': '1', 06:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:43 INFO - 'NO_EM_RESTART': '1', 06:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:43 INFO - 'PWD': '/builds/slave/test', 06:42:43 INFO - 'SHELL': '/bin/bash', 06:42:43 INFO - 'SHLVL': '1', 06:42:43 INFO - 'TERM': 'linux', 06:42:43 INFO - 'TMOUT': '86400', 06:42:43 INFO - 'USER': 'cltbld', 06:42:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', 06:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:43 INFO - '_': '/tools/buildbot/bin/python'} 06:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:43 INFO - Downloading/unpacking jsonschema==2.5.1 06:42: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 06:42: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 06:42: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 06:42: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 06:42:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:42:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:42: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 06:42: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 06:42: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 06:42: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 06:42:44 INFO - Downloading functools32-3.2.3-2.tar.gz 06:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:42:45 INFO - warning: no files found matching '*.txt' 06:42:45 INFO - no previously-included directories found matching 'build' 06:42:45 INFO - no previously-included directories found matching 'dist' 06:42:45 INFO - no previously-included directories found matching '.git*' 06:42:45 INFO - Installing collected packages: jsonschema, functools32 06:42:45 INFO - Running setup.py install for functools32 06:42:45 INFO - warning: no files found matching '*.txt' 06:42:45 INFO - no previously-included directories found matching 'build' 06:42:45 INFO - no previously-included directories found matching 'dist' 06:42:45 INFO - no previously-included directories found matching '.git*' 06:42:45 INFO - Successfully installed jsonschema functools32 06:42:45 INFO - Cleaning up... 06:42:45 INFO - Return code: 0 06:42:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42: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')]} 06:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42: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 0x269d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a105c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d7a0>, '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 0x2a0e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0eb30>, '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': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', '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 06:42: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 06:42: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 06:42:45 INFO - Using env: {'DISPLAY': ':0', 06:42:45 INFO - 'HOME': '/home/cltbld', 06:42:45 INFO - 'LANG': 'en_US.UTF-8', 06:42:45 INFO - 'LANGUAGE': 'en_US:en', 06:42:45 INFO - 'LOGNAME': 'cltbld', 06:42:45 INFO - 'MAIL': '/var/mail/cltbld', 06:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:45 INFO - 'MOZ_NO_REMOTE': '1', 06:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:45 INFO - 'NO_EM_RESTART': '1', 06:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:45 INFO - 'PWD': '/builds/slave/test', 06:42:45 INFO - 'SHELL': '/bin/bash', 06:42:45 INFO - 'SHLVL': '1', 06:42:45 INFO - 'TERM': 'linux', 06:42:45 INFO - 'TMOUT': '86400', 06:42:45 INFO - 'USER': 'cltbld', 06:42:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', 06:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:45 INFO - '_': '/tools/buildbot/bin/python'} 06:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:42:45 INFO - Cleaning up... 06:42:45 INFO - Return code: 0 06:42:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42: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')]} 06:42:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42: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 0x269d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a105c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d7a0>, '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 0x2a0e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0eb30>, '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': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', '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 06:42: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 06:42: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 06:42:45 INFO - Using env: {'DISPLAY': ':0', 06:42:45 INFO - 'HOME': '/home/cltbld', 06:42:45 INFO - 'LANG': 'en_US.UTF-8', 06:42:45 INFO - 'LANGUAGE': 'en_US:en', 06:42:45 INFO - 'LOGNAME': 'cltbld', 06:42:45 INFO - 'MAIL': '/var/mail/cltbld', 06:42:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:45 INFO - 'MOZ_NO_REMOTE': '1', 06:42:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:45 INFO - 'NO_EM_RESTART': '1', 06:42:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:45 INFO - 'PWD': '/builds/slave/test', 06:42:45 INFO - 'SHELL': '/bin/bash', 06:42:45 INFO - 'SHLVL': '1', 06:42:45 INFO - 'TERM': 'linux', 06:42:45 INFO - 'TMOUT': '86400', 06:42:45 INFO - 'USER': 'cltbld', 06:42:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', 06:42:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:45 INFO - '_': '/tools/buildbot/bin/python'} 06:42:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:45 INFO - Downloading/unpacking blobuploader==1.2.4 06:42: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 06:42: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 06:42: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 06:42: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 06:42:46 INFO - Downloading blobuploader-1.2.4.tar.gz 06:42:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:42:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:42: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 06:42: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 06:42: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 06:42: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 06:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:42:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:42: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 06:42: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 06:42: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 06:42: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 06:42:47 INFO - Downloading docopt-0.6.1.tar.gz 06:42:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:42:47 INFO - Installing collected packages: blobuploader, requests, docopt 06:42:47 INFO - Running setup.py install for blobuploader 06:42:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:42:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:42:47 INFO - Running setup.py install for requests 06:42:47 INFO - Running setup.py install for docopt 06:42:47 INFO - Successfully installed blobuploader requests docopt 06:42:47 INFO - Cleaning up... 06:42:47 INFO - Return code: 0 06:42:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42:47 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')]} 06:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42:47 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')]} 06:42:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42:47 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 0x269d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a105c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d7a0>, '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 0x2a0e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0eb30>, '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': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', '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 06:42:47 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 06:42:47 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 06:42:47 INFO - Using env: {'DISPLAY': ':0', 06:42:47 INFO - 'HOME': '/home/cltbld', 06:42:47 INFO - 'LANG': 'en_US.UTF-8', 06:42:47 INFO - 'LANGUAGE': 'en_US:en', 06:42:47 INFO - 'LOGNAME': 'cltbld', 06:42:47 INFO - 'MAIL': '/var/mail/cltbld', 06:42:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:47 INFO - 'MOZ_NO_REMOTE': '1', 06:42:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:47 INFO - 'NO_EM_RESTART': '1', 06:42:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:47 INFO - 'PWD': '/builds/slave/test', 06:42:47 INFO - 'SHELL': '/bin/bash', 06:42:47 INFO - 'SHLVL': '1', 06:42:47 INFO - 'TERM': 'linux', 06:42:47 INFO - 'TMOUT': '86400', 06:42:47 INFO - 'USER': 'cltbld', 06:42:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', 06:42:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:47 INFO - '_': '/tools/buildbot/bin/python'} 06:42:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:42:48 INFO - Running setup.py (path:/tmp/pip-8ibh6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:42:48 INFO - Running setup.py (path:/tmp/pip-DafUAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:42:48 INFO - Running setup.py (path:/tmp/pip-_hmh8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:42:48 INFO - Running setup.py (path:/tmp/pip-QK2EQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:42:48 INFO - Running setup.py (path:/tmp/pip-o2US4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:42:48 INFO - Running setup.py (path:/tmp/pip-qlsV5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:42:48 INFO - Running setup.py (path:/tmp/pip-rW3yiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:42:48 INFO - Running setup.py (path:/tmp/pip-YGavQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:42:48 INFO - Running setup.py (path:/tmp/pip-c4KvuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:42:48 INFO - Running setup.py (path:/tmp/pip-jJbjlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:42:48 INFO - Running setup.py (path:/tmp/pip-rMjxdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:42:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:42:48 INFO - Running setup.py (path:/tmp/pip-euKX5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:42:49 INFO - Running setup.py (path:/tmp/pip-qa3miI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:42:49 INFO - Running setup.py (path:/tmp/pip-X1SUGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:49 INFO - Running setup.py (path:/tmp/pip-tqX7Hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:42:49 INFO - Running setup.py (path:/tmp/pip-qH9rdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:42:49 INFO - Running setup.py (path:/tmp/pip-QxDpF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:42:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:42:49 INFO - Running setup.py install for manifestparser 06:42:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:42:49 INFO - Running setup.py install for mozcrash 06:42:49 INFO - Running setup.py install for mozdebug 06:42:49 INFO - Running setup.py install for mozdevice 06:42:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:42:49 INFO - Running setup.py install for mozfile 06:42:49 INFO - Running setup.py install for mozhttpd 06:42:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:42:49 INFO - Running setup.py install for mozinfo 06:42:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:42:50 INFO - Running setup.py install for mozInstall 06:42:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:42:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:42:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:42:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:42:50 INFO - Running setup.py install for mozleak 06:42:50 INFO - Running setup.py install for mozlog 06:42:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:42:50 INFO - Running setup.py install for moznetwork 06:42:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:42:50 INFO - Running setup.py install for mozprocess 06:42:50 INFO - Running setup.py install for mozprofile 06:42:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:42:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:42:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:42:50 INFO - Running setup.py install for mozrunner 06:42:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:42:50 INFO - Running setup.py install for mozscreenshot 06:42:50 INFO - Running setup.py install for moztest 06:42:51 INFO - Running setup.py install for mozversion 06:42:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:42:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:42:51 INFO - Cleaning up... 06:42:51 INFO - Return code: 0 06:42:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42: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')]} 06:42:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42: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 0x269d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a105c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d7a0>, '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 0x2a0e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0eb30>, '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': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', '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 06:42: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 06:42: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 06:42:51 INFO - Using env: {'DISPLAY': ':0', 06:42:51 INFO - 'HOME': '/home/cltbld', 06:42:51 INFO - 'LANG': 'en_US.UTF-8', 06:42:51 INFO - 'LANGUAGE': 'en_US:en', 06:42:51 INFO - 'LOGNAME': 'cltbld', 06:42:51 INFO - 'MAIL': '/var/mail/cltbld', 06:42:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:51 INFO - 'MOZ_NO_REMOTE': '1', 06:42:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:51 INFO - 'NO_EM_RESTART': '1', 06:42:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:51 INFO - 'PWD': '/builds/slave/test', 06:42:51 INFO - 'SHELL': '/bin/bash', 06:42:51 INFO - 'SHLVL': '1', 06:42:51 INFO - 'TERM': 'linux', 06:42:51 INFO - 'TMOUT': '86400', 06:42:51 INFO - 'USER': 'cltbld', 06:42:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', 06:42:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:51 INFO - '_': '/tools/buildbot/bin/python'} 06:42:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:42:51 INFO - Running setup.py (path:/tmp/pip-fOMN8g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:42: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)) 06:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:42:51 INFO - Running setup.py (path:/tmp/pip-Ym2JB0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:42: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)) 06:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:42:51 INFO - Running setup.py (path:/tmp/pip-VgaJ5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:42: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)) 06:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:42:51 INFO - Running setup.py (path:/tmp/pip-r_9nRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 06:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:42:51 INFO - Running setup.py (path:/tmp/pip-RTwX2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:42: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)) 06:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:42:51 INFO - Running setup.py (path:/tmp/pip-pKqQ58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:42: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)) 06:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:42:51 INFO - Running setup.py (path:/tmp/pip-wSkvID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:42:51 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)) 06:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:42:51 INFO - Running setup.py (path:/tmp/pip-krQimn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:42:51 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)) 06:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:42:51 INFO - Running setup.py (path:/tmp/pip-wMtqSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:42: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)) 06:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:42:52 INFO - Running setup.py (path:/tmp/pip-Bb4Cvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:42: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)) 06:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:42:52 INFO - Running setup.py (path:/tmp/pip-uiywEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:42: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)) 06:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:42:52 INFO - Running setup.py (path:/tmp/pip-gqjqD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:42: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)) 06:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:42:52 INFO - Running setup.py (path:/tmp/pip-JNn6up-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:42: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)) 06:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:42:52 INFO - Running setup.py (path:/tmp/pip-WeSMGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:42: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)) 06:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:42:52 INFO - Running setup.py (path:/tmp/pip-hSipPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:42: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)) 06:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:42:52 INFO - Running setup.py (path:/tmp/pip-R0pWtA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:42: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)) 06:42:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:42:52 INFO - Running setup.py (path:/tmp/pip-rmGhM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:42: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)) 06:42: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)) 06:42: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)) 06:42: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)) 06:42: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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:42: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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:42:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:42: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 06:42: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 06:42: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 06:42: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 06:42:53 INFO - Downloading blessings-1.6.tar.gz 06:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:42:53 INFO - Installing collected packages: blessings 06:42:53 INFO - Running setup.py install for blessings 06:42:53 INFO - Successfully installed blessings 06:42:53 INFO - Cleaning up... 06:42:54 INFO - Return code: 0 06:42:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:42:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:54 INFO - Reading from file tmpfile_stdout 06:42:54 INFO - Current package versions: 06:42:54 INFO - argparse == 1.2.1 06:42:54 INFO - blessings == 1.6 06:42:54 INFO - blobuploader == 1.2.4 06:42:54 INFO - docopt == 0.6.1 06:42:54 INFO - functools32 == 3.2.3-2 06:42:54 INFO - jsonschema == 2.5.1 06:42:54 INFO - manifestparser == 1.1 06:42:54 INFO - mozInstall == 1.12 06:42:54 INFO - mozcrash == 1.0 06:42:54 INFO - mozdebug == 0.1 06:42:54 INFO - mozdevice == 0.50 06:42:54 INFO - mozfile == 1.2 06:42:54 INFO - mozhttpd == 0.7 06:42:54 INFO - mozinfo == 0.9 06:42:54 INFO - mozleak == 0.1 06:42:54 INFO - mozlog == 3.4 06:42:54 INFO - moznetwork == 0.27 06:42:54 INFO - mozprocess == 0.25 06:42:54 INFO - mozprofile == 0.28 06:42:54 INFO - mozrunner == 6.13 06:42:54 INFO - mozscreenshot == 0.1 06:42:54 INFO - mozsystemmonitor == 0.3 06:42:54 INFO - moztest == 0.8 06:42:54 INFO - mozversion == 1.4 06:42:54 INFO - psutil == 3.1.1 06:42:54 INFO - requests == 1.2.3 06:42:54 INFO - wsgiref == 0.1.2 06:42:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42: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')]} 06:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42: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 0x269d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a105c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d7a0>, '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 0x2a0e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0eb30>, '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': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', '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 06:42: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 06:42: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 06:42:54 INFO - Using env: {'DISPLAY': ':0', 06:42:54 INFO - 'HOME': '/home/cltbld', 06:42:54 INFO - 'LANG': 'en_US.UTF-8', 06:42:54 INFO - 'LANGUAGE': 'en_US:en', 06:42:54 INFO - 'LOGNAME': 'cltbld', 06:42:54 INFO - 'MAIL': '/var/mail/cltbld', 06:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:54 INFO - 'MOZ_NO_REMOTE': '1', 06:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:54 INFO - 'NO_EM_RESTART': '1', 06:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:54 INFO - 'PWD': '/builds/slave/test', 06:42:54 INFO - 'SHELL': '/bin/bash', 06:42:54 INFO - 'SHLVL': '1', 06:42:54 INFO - 'TERM': 'linux', 06:42:54 INFO - 'TMOUT': '86400', 06:42:54 INFO - 'USER': 'cltbld', 06:42:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', 06:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:54 INFO - '_': '/tools/buildbot/bin/python'} 06:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42: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)) 06:42: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)) 06:42: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)) 06:42: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)) 06:42: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)) 06:42: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)) 06:42: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)) 06:42: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)) 06:42: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)) 06:42:54 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:42: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 06:42: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 06:42: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 06:42: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 06:42:55 INFO - Downloading marionette_driver-1.4.0.tar.gz 06:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 06:42: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)) 06:42: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)) 06:42: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)) 06:42: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)) 06:42:55 INFO - Installing collected packages: marionette-driver 06:42:55 INFO - Running setup.py install for marionette-driver 06:42:55 INFO - Successfully installed marionette-driver 06:42:55 INFO - Cleaning up... 06:42:55 INFO - Return code: 0 06:42:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:42: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')]} 06:42:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:42: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')]} 06:42:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:42: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 0x269d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x286aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a105c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a0d7a0>, '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 0x2a0e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0eb30>, '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': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', '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 06:42: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 06:42: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 06:42:55 INFO - Using env: {'DISPLAY': ':0', 06:42:55 INFO - 'HOME': '/home/cltbld', 06:42:55 INFO - 'LANG': 'en_US.UTF-8', 06:42:55 INFO - 'LANGUAGE': 'en_US:en', 06:42:55 INFO - 'LOGNAME': 'cltbld', 06:42:55 INFO - 'MAIL': '/var/mail/cltbld', 06:42:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:42:55 INFO - 'MOZ_NO_REMOTE': '1', 06:42:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:42:55 INFO - 'NO_EM_RESTART': '1', 06:42:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:42:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:42:55 INFO - 'PWD': '/builds/slave/test', 06:42:55 INFO - 'SHELL': '/bin/bash', 06:42:55 INFO - 'SHLVL': '1', 06:42:55 INFO - 'TERM': 'linux', 06:42:55 INFO - 'TMOUT': '86400', 06:42:55 INFO - 'USER': 'cltbld', 06:42:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', 06:42:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:42:55 INFO - '_': '/tools/buildbot/bin/python'} 06:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:42:55 INFO - Cleaning up... 06:42:55 INFO - Return code: 0 06:42:55 INFO - Running post-action listener: _resource_record_post_action 06:42:55 INFO - Running post-action listener: _start_resource_monitoring 06:42:56 INFO - Starting resource monitoring. 06:42:56 INFO - [mozharness: 2017-05-24 13:42:56.060504Z] Finished create-virtualenv step (success) 06:42:56 INFO - [mozharness: 2017-05-24 13:42:56.061471Z] Running install step. 06:42:56 INFO - Running pre-action listener: _resource_record_pre_action 06:42:56 INFO - Running main action method: install 06:42:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:42:56 INFO - Reading from file tmpfile_stdout 06:42:56 INFO - Detecting whether we're running mozinstall >=1.0... 06:42:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:42:56 INFO - Reading from file tmpfile_stdout 06:42:56 INFO - Output received: 06:42:56 INFO - Usage: mozinstall [options] installer 06:42:56 INFO - Options: 06:42:56 INFO - -h, --help show this help message and exit 06:42:56 INFO - -d DEST, --destination=DEST 06:42:56 INFO - Directory to install application into. [default: 06:42:56 INFO - "/builds/slave/test"] 06:42:56 INFO - --app=APP Application being installed. [default: firefox] 06:42:56 INFO - mkdir: /builds/slave/test/build/application 06:42: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'] 06:42:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:43:12 INFO - Reading from file tmpfile_stdout 06:43:12 INFO - Output received: 06:43:12 INFO - /builds/slave/test/build/application/firefox/firefox 06:43:12 INFO - Running post-action listener: _resource_record_post_action 06:43:12 INFO - [mozharness: 2017-05-24 13:43:12.042720Z] Finished install step (success) 06:43:12 INFO - [mozharness: 2017-05-24 13:43:12.042845Z] Running run-tests step. 06:43:12 INFO - Running pre-action listener: _resource_record_pre_action 06:43:12 INFO - Running main action method: run_tests 06:43:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:43:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:43:12 INFO - Python 2.7.3 06:43:12 INFO - Return code: 0 06:43:12 INFO - grabbing minidump binary from tooltool 06:43:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:43:12 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 0x2a0d7a0>, '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 0x2a0e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a0eb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:43:12 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 06:43:12 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 06:43:12 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 06:43:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:43:12 INFO - Return code: 0 06:43:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:43:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:43:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:43:12 INFO - ENV: RUST_BACKTRACE is now 1 06:43:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:43:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:43: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/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 06:43: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/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 06:43:12 INFO - Using env: {'DISPLAY': ':0', 06:43:12 INFO - 'HOME': '/home/cltbld', 06:43:12 INFO - 'LANG': 'en_US.UTF-8', 06:43:12 INFO - 'LANGUAGE': 'en_US:en', 06:43:12 INFO - 'LOGNAME': 'cltbld', 06:43:12 INFO - 'MAIL': '/var/mail/cltbld', 06:43:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:43:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:43:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:43:12 INFO - 'MOZ_NO_REMOTE': '1', 06:43:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:43:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:43:12 INFO - 'NO_EM_RESTART': '1', 06:43:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:43:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:43:12 INFO - 'PWD': '/builds/slave/test', 06:43:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:43:12 INFO - 'RUST_BACKTRACE': '1', 06:43:12 INFO - 'SHELL': '/bin/bash', 06:43:12 INFO - 'SHLVL': '1', 06:43:12 INFO - 'TERM': 'linux', 06:43:12 INFO - 'TMOUT': '86400', 06:43:12 INFO - 'USER': 'cltbld', 06:43:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818', 06:43:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:43:12 INFO - '_': '/tools/buildbot/bin/python'} 06:43: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/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 06:43:12 INFO - mozversion application_buildid: 20170524131111 06:43:12 INFO - mozversion application_changeset: d93182f36b3c134a3b1c6718f09eb87c2913e364 06:43:12 INFO - mozversion application_display_name: Nightly 06:43:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:43:12 INFO - mozversion application_name: Firefox 06:43:12 INFO - mozversion application_remotingname: firefox 06:43:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:43:12 INFO - mozversion application_vendor: Mozilla 06:43:12 INFO - mozversion application_version: 55.0a1 06:43:12 INFO - mozversion platform_buildid: 20170524131111 06:43:12 INFO - mozversion platform_changeset: d93182f36b3c134a3b1c6718f09eb87c2913e364 06:43:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:43:12 INFO - mozversion platform_version: 55.0a1 06:43:12 INFO - using testdate: 1495633392 06:43:12 INFO - actual date: 1495633392 06:43:12 INFO - starting webserver on 'localhost:47171' 06:43:12 INFO - SUITE-START | Running 2 tests 06:43:12 INFO - TEST-START | dromaeo_css 06:43:12 INFO - operating with platform_type : linux_ 06:43:12 INFO - Initialising browser for dromaeo_css test... 06:43:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47171/getInfo.html -profile /tmp/tmpeK_3Ue/profile 06:43:12 INFO - TEST-INFO | started process 3299 (/builds/slave/test/build/application/firefox/firefox http://localhost:47171/getInfo.html) 06:43:49 INFO - TEST-INFO | 3299: killed by SIGTERM 06:43:49 INFO - Browser initialized. 06:43:49 INFO - Running cycle 1/1 for dromaeo_css test... 06:43:49 INFO - TEST-INFO | started process 3493 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeK_3Ue/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:44:01 INFO - PID 3493 | RSS: Main: 172945408 06:44:01 INFO - PID 3493 | 06:47:06 INFO - PID 3493 | Cycle 1(1): loaded http://localhost:47171/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47171/tests/dromaeo/cssquery-ext.html) 06:47:07 INFO - PID 3493 | RSS: Main: 170086400 06:47:07 INFO - PID 3493 | 06:50:09 INFO - PID 3493 | Cycle 1(1): loaded http://localhost:47171/tests/dromaeo/cssquery-ext.html (next: http://localhost:47171/tests/dromaeo/cssquery-jquery.html) 06:50:09 INFO - PID 3493 | RSS: Main: 176336896 06:50:09 INFO - PID 3493 | 06:53:11 INFO - PID 3493 | Cycle 1(1): loaded http://localhost:47171/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47171/tests/dromaeo/cssquery-mootools.html) 06:53:12 INFO - PID 3493 | RSS: Main: 173780992 06:53:12 INFO - PID 3493 | 06:56:13 INFO - PID 3493 | Cycle 1(1): loaded http://localhost:47171/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47171/tests/dromaeo/cssquery-prototype.html) 06:56:14 INFO - PID 3493 | RSS: Main: 178380800 06:56:14 INFO - PID 3493 | 06:59:17 INFO - PID 3493 | Cycle 1(1): loaded http://localhost:47171/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47171/tests/dromaeo/cssquery-yui.html) 06:59:17 INFO - PID 3493 | RSS: Main: 177029120 06:59:17 INFO - PID 3493 | 07:02:19 INFO - PID 3493 | Cycle 1(1): loaded http://localhost:47171/tests/dromaeo/cssquery-yui.html (next: http://localhost:47171/tests/dromaeo/cssquery-dojo.html) 07:02:19 INFO - PID 3493 | RSS: Main: 176201728 07:02:19 INFO - PID 3493 | 07:02:19 INFO - PID 3493 | __start_tp_report 07:02:19 INFO - PID 3493 | _x_x_mozilla_page_load 07:02:19 INFO - PID 3493 | _x_x_mozilla_page_load_details 07:02:19 INFO - PID 3493 | |i|pagename|runs| 07:02:19 INFO - PID 3493 | |0;dojo.html;2687.6102965070068;2694.178275625933;2711.850848203348;2730.0171938102267;2740.3012231880866;5007.173816320303;5140.640155189139;5203.449097989349;5233.816816411427;5267.078261304271;5157.948420515794;5172.818951336704;5225.529702326789;5239.921401178975;5319;4371.759553224571;4584.385610287687;4652.790624421909;4672.275797251415;4693.202155633533;4740.668153229275;4748.3827102476625;4766.547178018082;4772.284157376386;4826;4578.610818080467;4639.652026098022;4665.906681866344;4701.294805779126;4712.811487540494;4639.721616702975;4652.395188625457;4659.976700116512;4679.859604211879;4681.016986432854;4598.126355992351;4603.723776573383;4634.281686338623;4637.1421287062;4645.396098507206;5016.297718319438;5086.109930762139;5162.328897243335;5196.714180720059;5237.921431178535;5540.390557038722;5597.356304025007;5683.886322273573;5693.060644993571;5697.259356283698;5641.915371269393;5672.971635141798;5688;5689.516391106761;5716.1711551825165;5237.292965449692;5274.235235890775;5282.445343238905;5288.338957630296;5333.359996800409;5680.176374425685;5705.71471426427;5758.510526605285;5770.769169233184;5772.018756811352;5579.6652200868075;5588.91616625751;5594.992901277809;5601.663900166003;5641.887162256732;5641.802536911188;5655.915161272585;5656.43435656431;5666.631668941505;5669.546436285087;5489.451054894558;5553.583481238923;5555;5646.3788983212635;5646.85882852932;5557.972210138923;5625.987322281947;5661.320641523043;5667.064934285797;5684.37471878093;4716.29255611661;4754.31062495943;4760.976195119002;4761.119192949315;4800.687955282895;4051.1897620475434;4061.817218225128;4075.898102547401;4077.734947228421;4108.609682080198;4559.931601025987;4607;4608.170529304757;4688.320193571913;4694.389729335165;5639.379668236491;5687.862427514431;5701.289613116049;5701.515371193412;5704.743286552115;4716.1510928033285;4718.386609740781;4720.763961801897;4727.314539391769;4758;4839.346688197119;4927.1131196384995;4927.531884470969;5040.495950405004;5047.318611987408;5211.062008838446;5216.087184742579;5222.817201397933;5235.136202526541;5252.264682944315;5560.054790685674;5651.915221271602;5656.632318899258;5659.575531835211;5711.543076553949;5188.558972487381;5192.766325515286;5227.89544209106;5236.6072544560075;5237.3453318335205;5474.233607295061;5554.305711786027;5556.388797232382;5594.608377413542;5595.244641973281;5645.266115404971;5655;5699.5155411790465;5741.91387129185;5746.655200687972;5481.314835645544;5493.23094766741;5513.393526711979;5514.117741161395;5516.200150978006;5341.092014357646;5496.972515137399;5501.5323697486165;5504.559635229252;5511.936234073464;5345.1447768356875;5354.812581559627;5399.514043736082;5464.699441530754;5488.835334939959;5553.916986187816;5565.30433695788;5570.2201691762375;5576.553875690016;5605.747741351731;5303.628745987744;5363.061464243664;5391.218273350264;5393.6763794172475;5430.294061771944 07:02:19 INFO - PID 3493 | |1;ext.html;604.0576700347458;639.0669622351368;655.5280198257254;1197.2816310213868;1201.2192075151145;33171;33503.66496335036;33507;33593.328133437346;33620.83189584055;32580.837095814546;32969.83515082427;32981.17547061325;32986;33116.503252451235;6588.50586206034;6789.5926244425245;6793.0829338039475;6794.660266986655;6821.420179284767;6722.596644201363;6820.795376138723;6830.795076147699;6854.588724676535;6872.862542749142;6807.455403567703;6831.1119554457855;6852.383285504304;6864.4165245954155;6895.310468953115;6796.796096117099;6804.897926531106;6849.931500684979;6856.348646878514;6858.965705171492;6668.299828517985;6743.696533655997;6750.223724271674;6751.324867513209;6763.323667633246;30940.535891961637;31195.68804311973;31394.37211255762;31404.685953140404;31436.21409464759;2972.1677930179585;3005.879764809427;3023.9244018899485;3028.772842036856;3030.9090727278;24814.5037099257;24859;24862.50274994508;24886.004559817586;24978;2901.317236003113;2916.2126225918882;2918.3871387008753;2931.4137172565574;2943.67619561848;145342;146050;146161.26919365334;151354;157019;38959.805200974384;39082.609173908466;39131.80434097811;39398.606013940065;39409.211815764094;40740.592594074275;40799.79600101981;40821.591784082375;46401.535984640395;47234.76382618133;12991.610251692464;13027.218366898016;13149.34253287351;13201.471941122247;13216.074874758868;10348.482575871176;10440.060394564525;10459;10531.84202236967;10534;13014.349282535835;13073.169756234134;13141.342932853318;13151.684831516772;13297.268650224138;5481.671099734029;5553.333599968029;5577.191307260425;5602.4957753802355;5623.100303951348;880.5377176982007;902.7697937026016;915.8900931888217;926.2682480840061;939.478589382899;20363.185472581226;21244.78755212459;21265.89367053155;21317.147314107573;21815.454613634785;975.1029053271008;991.9008099190023;1004.6232662751469;1008.7931973945471;1011.9898801012043;11209.55161793519;11228.326300422;11308.264962777394;11453.71365715847;11478.19652624325;172844;173544;173823;174290;174627;40210.5821005212;40415.39376909348;40462.797686011385;40511.797441012604;40535.594644053774;1187.9507848960648;1240.4789988204975;1240.9689757756128;1241.050596293818;1250.5935570939298;19706.50733731668;20115.39653810388;20590.691139632618;20784.298041255144;20925.16299348009;29089.563656544746;29127.12618621445;29204.415911682074;29206.26984325409;29277.121686349445;146021;146982;147087;147164;147249;29170.56244156382;29514.262143446587;30105.7314969875;30641;31007.68992310048;37022.8148859254;37151.256974860895;37205.0698732523;37242.06894827651;37470.501179952495;25984.610230846174;27517.31206719848;27942.02202922888;28032.579511307755;28240;27805.443891122468;27907.441851162457;28522;28858;29113.417731644826;30949.381012380076;30952.84523577368;31011.224719382197;31045.379092418476;31097;26576.335591610365;26949.59575606328;27120.1863944082;27413.588796167674;28136.43727125487;20677.483062923548;21111.57776844485;21926.342209733735;22008.779912200673;22069 07:02:19 INFO - PID 3493 | |2;jquery.html;408.51182836510384;414.16338995229654;426.3136350475734;431.30129190711045;445.5811537155074;11755.294682319045;13366.264855432948;17393.56516087097;18161.909190454047;18172.09139543024;17055.82944170558;17104.914475427606;17169.7424538632;17199.226034828433;17309.221085051173;5407.945920540803;5617.578681598876;5641.943580564182;5642.661440313574;5647.7458514366745;5306.70813105279;5375.16684913839;5375.19372094187;5417.550991938939;5466.098093814516;5331.626786124973;5335.866603334909;5339.172428273624;5363.383210930754;5383.973080134594;5129.102407078765;5302.814401495968;5325.227841962894;5341.786328546854;5348.197770334462;4807.61539076873;4811.422629284508;4828.903421931577;4846.854594362175;4848.7090774553635;20579.279725209544;20725.792742072535;21643.45891352713;21643.67534486984;21657.45856353588;1622.9675406491804;1636.5090472858094;1641.9753703694455;1644.6052947292683;1651.6366399392114;13976.440942362293;14276.714465710627;14413.78379324311;14526.491572795007;14750.40998360075;2042.2954080842085;2043.3971978266447;2093.4033800366974;2098.1083039708064;2117.2272120676;86345.56827215887;90777;91254.99999999933;92482.53758731231;93733;10720.142388608892;10753.354798712102;10787.298825576312;11103.888961110448;11115.666530004113;14976.176310303037;14986;15048.398064077533;15111.697766044617;15164.24178791056;7547.8113047173165;7747.30274275318;7749.961250193713;7870.881936770953;7943.046834379911;7152.606606636685;7180.533265337736;7183.317584829433;7374.852502949911;7450.2549745026145;6725.814110414135;6914.4468442525485;6994.125734283215;7020.403265722471;7116.110486189226;2007.688808234726;2020.272701827341;2034.949126271855;2056.208359781495;2193.5283913958574;829.7925518620345;867.1155421470065;871.7689812199773;874.3660845886682;897.9236764875059;15972.520824375288;15982.840171598367;16317;16333.10167940751;16418.589535261475;888;898.4609234459402;903.9186473217311;918.1828172926101;918.6784625381063;8671.132886711404;8771.684247362818;8988.775280617907;9211.447313161098;9270.814583708288;323693;327522;329133;330078;331227;73217.97301148488;74167.62916185385;74393.6280318595;75192;75987;1076.332673742285;1090.2150451674781;1095.8411030400548;1097.8517900083386;1104.116706634689;14233.50182743599;16196;18150;18409.90795046016;18468.81531184671;39357.60642393654;40849.591504085765;40907.79546102369;40912.38631420471;41611.58388416077;47199.29201062056;47765.761171193924;48202.758986206245;48801.511984881115;49139.75430122826;7823.295903368724;8028.397870159878;8152.877706834521;8368.41421100517;8919.687810926587;12359.50561977511;12500.874991249972;13060.21638701681;13084.738305233652;13443.126196797177;10571.36571805694;10792.730181745519;11302.378369189773;11310.208285419942;11335.546578136782;10319.587216511256;10365.792684146125;10450.42522661261;10458.790824183627;10462.947685261524;10762.46187690628;11036.5033573491;11232.606858759904;11598;11615.548056492938;8425.199606037417;8523.48859068433;8528.957355213184;8571.699990500303;8730.083341249332;11118.110551156049;11152.776944461228;11254.21220514556;11309.830352544554;11603.941980290045 07:02:19 INFO - PID 3493 | |3;mootools.html;1246.2460211572;1305.9151155174918;1307.2287350463237;1309.2668105860719;1311.2591385866986;10337.844932326012;10512.68461946141;10821.567137314518;10852.728681782959;11069.944650276757;10768.35389876608;10920.399378034204;11001.449927503612;11005.119590432767;11016.339019658826;2272.136588096525;2316.1661801751357;2324.233003108978;2324.779145981129;2331.4987277735286;2110.9366718998454;2132.605467988427;2162.945926351846;2175.5866385386803;2191.397365724423;2181.869087854726;2213.513027134028;2214.734231892167;2214.9224777132804;2215.4129155773735;2156.02978659603;2173.228503881115;2175.1190767739013;2175.760666326703;2180.29140529327;2088.1751708075376;2097.737782777153;2098.4229336932312;2099.6220680277543;2110.0715685098507;10350;10625.681229563126;10659.147268218523;10674.519646615843;10705.197110216764;5608.298962629671;5762.308522977228;5804.187413762077;5824.155497452888;5833.125031245305;3301.7688761786685;3440.17435815405;3491.598466176397;3509.6490350964955;3518.48981897626;1170.0990237517149;1173.2960223865698;1184.09416796151;1199.5141967503175;1200.225854323965;15615.141167235797;15689.529314120595;15772.369105235892;15789.763153552705;15793.92103039489;4686.929696054562;4700.95299047012;4797.040591881638;4830.082284365959;4840.515948405131;10933.234673572773;10964.56141754321;11010.064144547643;11042;11050.33697978124;5233.39815921174;5377.7311134443125;5554.972225138929;5560.2493663355735;5602.579806514446;5112.258722485219;5177.275181474596;5187.533122019036;5199.844004679866;5222.764975576109;3867.439221312894;3959.6832253419657;3963.3460479021214;3971.4638523798917;3996.360582306817;1090.8309212072143;1130.2427373659668;1177;1178.192937837584;1180.5218886351042;647.355880898509;671.9294474080249;699.9055127557816;700.1353328639127;703.409136325489;6295.213098362705;6483.4164925156965;6485;6573.112629794917;6596;854.7606670132373;856.1566856646199;867.4968518259394;880.8062226310202;887.4276091920675;3545.2273863068467;4147.108371700099;4200.4959404871615;4205.852795152155;4244.196216607991;13274.871635911055;13602.727945441233;14053.578392648236;14120.43518259258;14195.716085678228;13534.526291579945;13913.930430347784;13998.790018149735;14012.789808152886;14027.579172624837;7479.252074792586;7534.510256833398;7583.05211848519;7587.279208475186;7627.12288086866;6160.845978850564;6161.691915404302;6170.167027451236;6172.22847144107;6271.529635277281;12471.5011399543;12620.873791261969;12627.11610187278;12694.936525317315;12768.74462510763;12835.358232088545;12872.806907896202;12897.613071607866;12979.286139262054;13143.211407315592;7679.462437629312;7704.576248306397;7737.226277372218;7741;7767.417443691633;9643.08390702882;9896.10935015852;9933.255005874733;10019.398836069568;10023.749406264902;8425.536595487061;8434.114417986024;8478;8481.067082620782;8490.06609272967;8082.797930051795;8108.554029528433;8149.225823546753;8214.958925205336;8314.708985185489;7544;7714.922850771421;7741.612919354123;7773.533587984739;7794.6882124714375;5307.814226502054;5339.439358867418;5354.196870469461;5451.781928722807;5457.808976685797;5660.943390566206;5708;5759.280089988752;5793.826185214451;6001.819945401645 07:02:19 INFO - PID 3493 | |4;prototype.html;379.45548138421367;390.38709226514374;395.8574913031309;401.5723254733708;403.0849970566812;5308.522232999039;5448.291722076135;5482.616216864816;5517.227588137659;5518.889622207554;5274.894502109955;5303.814366497173;5313.203019547061;5320.574354051676;5321.973390133054;4027.114034912322;4037.6877514807657;4051.7366371185926;4070.3283958147017;4074.30736774749;3916.2167566486673;4059.7158198926086;4066.166435880652;4077.7961101944934;4079.73481723687;4055.574164712707;4062.4109504121884;4077.22532718784;4083.3874918762276;4083.4283200351974;3991.102002049545;4034.5158580970324;4035.636792688643;4037.576054514263;4055.878323650295;3550.9822450887837;3554.9512893696165;3561.6972557332656;3564.8574057037686;3570.625084366156;5124.436312005676;5198.792048318062;5240.3187585614005;5259.237410575483;5271.420143784219;4724.220503616899;4725.952740472586;4734.644901632391;4748;4795.11595607559;5547.25112109864;5694.234787215976;5697.943020569783;5698.116791897262;5698.544116470673;3965.543962444327;4002.1195337025806;4002.557800291747;4008.318585840414;4018.9196216075516;5850.151727999459;5993.190919225893;6009.699515024275;6019.90970135444;6076.513878889678;4049.716519843583;4094.5086589609436;4105.507339119265;4116.135611521554;4116.279651061052;4172.7079104463;4173.791310434466;4179.164167166578;4183.916321673611;4186.372044193396;4718.9292160617615;4757.048590281888;4798.160321943646;4802.567768900815;4802.831900883452;5727;5733.426657334233;5738.110592858114;5740.770369185269;5752.827415177551;1409.4221369238562;1424.9073810202303;1425.308725268244;1426.7003929174782;1426.871581557644;926.3885835348638;944.1361154543653;975.7851474913635;978.9559469823876;979.5787811241235;4893.828715994923;4901.9019619608125;4917.614956745975;4947.529984651453;4951.777170027357;5882.588218824641;5896.852578685482;5951.333626584563;5964.7315870785915;5979.342272350038;4754.690945088558;4839.7096174229655;4840.080384726891;4849.684770489977;4861.51384861511;3083.98458007713;3094.628644562667;3114.8442577871015;3116.4390409726466;3117.6414712308374;5344.118220493653;5387.865303367447;5391.110466773017;5391.460853914656;5405.675659460367;5812.651240925558;6050.6369617823075;6079.604825686316;6095.146679464879;6104.542159338067;5373.919391209135;5396.109641909119;5403.648762830403;5404.513593776579;5410.161424979135;5714.771409143587;5849.064149736022;5936.1986131871645;5988.37122102173;6013.128096426081;5812.709364531841;5825.94174058271;5843.824685259449;5848.327442344014;5872.442117998783;5198.6880787152895;5293.232481290114;5302.310699609026;5358.062339090721;5362.839114826562;3990.960090399059;4015.5582885881945;4023.2355852387955;4028.677705783589;4028.8589899353383;5685.545156387397;5874.911876321773;5887.646741195542;5899.793507227227;5933.910991335047;5742.655440673573;5768.625039372428;5781.95924733552;5810.937117323459;5812.866491034208;5704.144378343116;5747.109198074305;5765.798197063083;5780.017397042597;5797.797077102281;5560.36055853582;5614.354349249888;5628.60599758013;5653.879795076846;5694.800681976111;5748.626339287933;5761.625494342854;5770.3652598215;5772.9711351442975;5781.392953739965;5365.570754339566;5574.136008918624;5580.023495888122;5594.776208951596;5618.943810561842 07:02:19 INFO - PID 3493 | |5;yui.html;594.6372712645285;608.9665068421236;612.8835521250962;698.8567343694543;726.9672864721088;14071.788923166161;14551.927240363784;14561.563153105411;16986.83013169868;17871.64256714865;16520.0913949733;16782.916085419587;16833.32666693334;16939.322427102932;16980.745288820646;871.3203701113126;894.9463032218088;895.7044175422095;896.8340856941454;898.9190972812446;913.4838816068933;915.3043686798048;915.9587818548181;918.7243826851951;919.1406035356963;931.659944120398;936.0966667166183;938.052566907425;938.0947385772728;941.9434833909987;930.2139691960283;931.3247895275905;937.8171256604999;939.7556635274809;941.8963913969458;654.6988385342701;678.4131726056975;679.4021261290034;684.9006894000391;684.9383555480031;14287.78568321476;14484.565463036126;14505.27473626325;14510.564683059525;14569.635759106;15035.473758418511;15407.845921540753;15429.691406171814;15555.922220388939;16149.515514534583;11738.765224695544;11967.880321196852;11999.700007499883;12131.150819442642;12180.939095304555;2948.20398492408;2972.1677930179585;2977.1663934098488;2980.8970680848006;2994.3562134141266;85283.57358213169;86738.99999999937;86868.5656571713;87074.5646271771;87450.56274718649;11608.6517404478;12303.876961230451;12379.93810030962;12422.068344874171;12463.937680311541;22893;23138;23154.884225578764;23178.884105579702;23309.76690233076;5881.764729410861;6056.939430605726;6121.081837724288;6239.656818874914;6354.555181137276;2689.1798001609695;2767.225176950417;2769.030839206302;2769.0862015534826;2772.50094982905;3306.834658267077;3380.0704806178496;3392.5759280089987;3398.8130652814334;3401.1667141549983;712.2450202785064;742.8514297140593;750.3097150621442;751.2037240525061;755.8903958925926;544.0123891872564;567.103975718364;568.2442351672266;573.3320681406199;574.9712514374264;9819.607215711434;10309.587616495257;10521.316114452537;10711.143108551298;10801.351918884735;579.9072148456227;580.1732531143105;582.6038293960063;591.7278052096084;596.6092209602717;4745.098431298043;4845.297431872359;4858.4898585648;4875.366202393737;4974.104661161025;83746.74379884306;83789;85956.57021714852;87239;88395;74118;74943.62528187434;75063.62468187624;75550;75928.62035689897;66197;66495;67213.32786672168;68135;68917;9323.20752736025;9613.567389467351;9696.660616878375;9917.851232231378;9983.700488985342;28676.569851451826;28774.280642983256;29380.265493362836;30035.849820750755;30137.397252055274;36232.63767362293;36977.815110924275;37167.25665486729;37454.438183426726;37578;11166.665000050012;11222.55109795599;11487.712807179887;11530.654080377602;11582.131340149353;13745.312734363042;13928.860711392756;13958.022938394215;14012.509562165274;14080.577582672537;12686.429110690226;12690.936545317214;12726;12946.352682366032;13086.607401777961;12413.937930310653;12531.74936501283;12566.623001309976;12637.93681031589;12716.491340346653;12461.87538124607;12635.431405586954;12676.619701408972;12844.293563853704;13104.510143072786;7992.680292788224;8288.129746376544;10548.156147508334;10887.278180454887;10993.945030274797;11914.463849126636;12171.39143042862;12658.240505569695;12673.302968336462;12826.55107071248 07:02:19 INFO - PID 3493 | __end_tp_report 07:02:19 INFO - PID 3493 | __start_cc_report 07:02:19 INFO - PID 3493 | _x_x_mozilla_cycle_collect,342 07:02:19 INFO - PID 3493 | __end_cc_report 07:02:19 INFO - PID 3493 | __startTimestamp1495634539473__endTimestamp 07:02:19 INFO - PID 3493 | 07:02:19 INFO - PID 3493 | ------- Summary: start ------- 07:02:19 INFO - PID 3493 | Number of tests: 6 07:02:19 INFO - PID 3493 | 07:02:19 INFO - PID 3493 | [#0] dojo.html Cycles:165 Average:5148.40 Median:5288.34 stddev:613.19 (11.6%) stddev-sans-first:583.90 07:02:19 INFO - PID 3493 | Values: 2687.6 2694.2 2711.9 2730.0 2740.3 5007.2 5140.6 5203.4 5233.8 5267.1 5157.9 5172.8 5225.5 5239.9 5319.0 4371.8 4584.4 4652.8 4672.3 4693.2 4740.7 4748.4 4766.5 4772.3 4826.0 4578.6 4639.7 4665.9 4701.3 4712.8 4639.7 4652.4 4660.0 4679.9 4681.0 4598.1 4603.7 4634.3 4637.1 4645.4 5016.3 5086.1 5162.3 5196.7 5237.9 5540.4 5597.4 5683.9 5693.1 5697.3 5641.9 5673.0 5688.0 5689.5 5716.2 5237.3 5274.2 5282.4 5288.3 5333.4 5680.2 5705.7 5758.5 5770.8 5772.0 5579.7 5588.9 5595.0 5601.7 5641.9 5641.8 5655.9 5656.4 5666.6 5669.5 5489.5 5553.6 5555.0 5646.4 5646.9 5558.0 5626.0 5661.3 5667.1 5684.4 4716.3 4754.3 4761.0 4761.1 4800.7 4051.2 4061.8 4075.9 4077.7 4108.6 4559.9 4607.0 4608.2 4688.3 4694.4 5639.4 5687.9 5701.3 5701.5 5704.7 4716.2 4718.4 4720.8 4727.3 4758.0 4839.3 4927.1 4927.5 5040.5 5047.3 5211.1 5216.1 5222.8 5235.1 5252.3 5560.1 5651.9 5656.6 5659.6 5711.5 5188.6 5192.8 5227.9 5236.6 5237.3 5474.2 5554.3 5556.4 5594.6 5595.2 5645.3 5655.0 5699.5 5741.9 5746.7 5481.3 5493.2 5513.4 5514.1 5516.2 5341.1 5497.0 5501.5 5504.6 5511.9 5345.1 5354.8 5399.5 5464.7 5488.8 5553.9 5565.3 5570.2 5576.6 5605.7 5303.6 5363.1 5391.2 5393.7 5430.3 07:02:19 INFO - PID 3493 | 07:02:19 INFO - PID 3493 | [#1] ext.html Cycles:180 Average:30187.62 Median:16228.97 stddev:40502.09 (249.6%) stddev-sans-first:40554.79 07:02:19 INFO - PID 3493 | Values: 604.1 639.1 655.5 1197.3 1201.2 33171.0 33503.7 33507.0 33593.3 33620.8 32580.8 32969.8 32981.2 32986.0 33116.5 6588.5 6789.6 6793.1 6794.7 6821.4 6722.6 6820.8 6830.8 6854.6 6872.9 6807.5 6831.1 6852.4 6864.4 6895.3 6796.8 6804.9 6849.9 6856.3 6859.0 6668.3 6743.7 6750.2 6751.3 6763.3 30940.5 31195.7 31394.4 31404.7 31436.2 2972.2 3005.9 3023.9 3028.8 3030.9 24814.5 24859.0 24862.5 24886.0 24978.0 2901.3 2916.2 2918.4 2931.4 2943.7 145342.0 146050.0 146161.3 151354.0 157019.0 38959.8 39082.6 39131.8 39398.6 39409.2 40740.6 40799.8 40821.6 46401.5 47234.8 12991.6 13027.2 13149.3 13201.5 13216.1 10348.5 10440.1 10459.0 10531.8 10534.0 13014.3 13073.2 13141.3 13151.7 13297.3 5481.7 5553.3 5577.2 5602.5 5623.1 880.5 902.8 915.9 926.3 939.5 20363.2 21244.8 21265.9 21317.1 21815.5 975.1 991.9 1004.6 1008.8 1012.0 11209.6 11228.3 11308.3 11453.7 11478.2 172844.0 173544.0 173823.0 174290.0 174627.0 40210.6 40415.4 40462.8 40511.8 40535.6 1188.0 1240.5 1241.0 1241.1 1250.6 19706.5 20115.4 20590.7 20784.3 20925.2 29089.6 29127.1 29204.4 29206.3 29277.1 146021.0 146982.0 147087.0 147164.0 147249.0 29170.6 29514.3 30105.7 30641.0 31007.7 37022.8 37151.3 37205.1 37242.1 37470.5 25984.6 27517.3 27942.0 28032.6 28240.0 27805.4 27907.4 28522.0 28858.0 29113.4 30949.4 30952.8 31011.2 31045.4 31097.0 26576.3 26949.6 27120.2 27413.6 28136.4 20677.5 21111.6 21926.3 22008.8 22069.0 07:02:19 INFO - PID 3493 | 07:02:19 INFO - PID 3493 | [#2] jquery.html Cycles:180 Average:23634.16 Median:19883.06 stddev:55134.12 (277.3%) stddev-sans-first:55261.20 07:02:19 INFO - PID 3493 | Values: 408.5 414.2 426.3 431.3 445.6 11755.3 13366.3 17393.6 18161.9 18172.1 17055.8 17104.9 17169.7 17199.2 17309.2 5407.9 5617.6 5641.9 5642.7 5647.7 5306.7 5375.2 5375.2 5417.6 5466.1 5331.6 5335.9 5339.2 5363.4 5384.0 5129.1 5302.8 5325.2 5341.8 5348.2 4807.6 4811.4 4828.9 4846.9 4848.7 20579.3 20725.8 21643.5 21643.7 21657.5 1623.0 1636.5 1642.0 1644.6 1651.6 13976.4 14276.7 14413.8 14526.5 14750.4 2042.3 2043.4 2093.4 2098.1 2117.2 86345.6 90777.0 91255.0 92482.5 93733.0 10720.1 10753.4 10787.3 11103.9 11115.7 14976.2 14986.0 15048.4 15111.7 15164.2 7547.8 7747.3 7750.0 7870.9 7943.0 7152.6 7180.5 7183.3 7374.9 7450.3 6725.8 6914.4 6994.1 7020.4 7116.1 2007.7 2020.3 2034.9 2056.2 2193.5 829.8 867.1 871.8 874.4 897.9 15972.5 15982.8 16317.0 16333.1 16418.6 888.0 898.5 903.9 918.2 918.7 8671.1 8771.7 8988.8 9211.4 9270.8 323693.0 327522.0 329133.0 330078.0 331227.0 73218.0 74167.6 74393.6 75192.0 75987.0 1076.3 1090.2 1095.8 1097.9 1104.1 14233.5 16196.0 18150.0 18409.9 18468.8 39357.6 40849.6 40907.8 40912.4 41611.6 47199.3 47765.8 48202.8 48801.5 49139.8 7823.3 8028.4 8152.9 8368.4 8919.7 12359.5 12500.9 13060.2 13084.7 13443.1 10571.4 10792.7 11302.4 11310.2 11335.5 10319.6 10365.8 10450.4 10458.8 10462.9 10762.5 11036.5 11232.6 11598.0 11615.5 8425.2 8523.5 8529.0 8571.7 8730.1 11118.1 11152.8 11254.2 11309.8 11603.9 07:02:19 INFO - PID 3493 | 07:02:19 INFO - PID 3493 | [#3] mootools.html Cycles:180 Average:6513.81 Median:3514.07 stddev:4237.59 (120.6%) stddev-sans-first:4230.99 07:02:19 INFO - PID 3493 | Values: 1246.2 1305.9 1307.2 1309.3 1311.3 10337.8 10512.7 10821.6 10852.7 11069.9 10768.4 10920.4 11001.4 11005.1 11016.3 2272.1 2316.2 2324.2 2324.8 2331.5 2110.9 2132.6 2162.9 2175.6 2191.4 2181.9 2213.5 2214.7 2214.9 2215.4 2156.0 2173.2 2175.1 2175.8 2180.3 2088.2 2097.7 2098.4 2099.6 2110.1 10350.0 10625.7 10659.1 10674.5 10705.2 5608.3 5762.3 5804.2 5824.2 5833.1 3301.8 3440.2 3491.6 3509.6 3518.5 1170.1 1173.3 1184.1 1199.5 1200.2 15615.1 15689.5 15772.4 15789.8 15793.9 4686.9 4701.0 4797.0 4830.1 4840.5 10933.2 10964.6 11010.1 11042.0 11050.3 5233.4 5377.7 5555.0 5560.2 5602.6 5112.3 5177.3 5187.5 5199.8 5222.8 3867.4 3959.7 3963.3 3971.5 3996.4 1090.8 1130.2 1177.0 1178.2 1180.5 647.4 671.9 699.9 700.1 703.4 6295.2 6483.4 6485.0 6573.1 6596.0 854.8 856.2 867.5 880.8 887.4 3545.2 4147.1 4200.5 4205.9 4244.2 13274.9 13602.7 14053.6 14120.4 14195.7 13534.5 13913.9 13998.8 14012.8 14027.6 7479.3 7534.5 7583.1 7587.3 7627.1 6160.8 6161.7 6170.2 6172.2 6271.5 12471.5 12620.9 12627.1 12694.9 12768.7 12835.4 12872.8 12897.6 12979.3 13143.2 7679.5 7704.6 7737.2 7741.0 7767.4 9643.1 9896.1 9933.3 10019.4 10023.7 8425.5 8434.1 8478.0 8481.1 8490.1 8082.8 8108.6 8149.2 8215.0 8314.7 7544.0 7714.9 7741.6 7773.5 7794.7 5307.8 5339.4 5354.2 5451.8 5457.8 5660.9 5708.0 5759.3 5793.8 6001.8 07:02:19 INFO - PID 3493 | 07:02:19 INFO - PID 3493 | [#4] prototype.html Cycles:180 Average:4686.48 Median:5310.86 stddev:1389.58 (26.2%) stddev-sans-first:1355.35 07:02:19 INFO - PID 3493 | Values: 379.5 390.4 395.9 401.6 403.1 5308.5 5448.3 5482.6 5517.2 5518.9 5274.9 5303.8 5313.2 5320.6 5322.0 4027.1 4037.7 4051.7 4070.3 4074.3 3916.2 4059.7 4066.2 4077.8 4079.7 4055.6 4062.4 4077.2 4083.4 4083.4 3991.1 4034.5 4035.6 4037.6 4055.9 3551.0 3555.0 3561.7 3564.9 3570.6 5124.4 5198.8 5240.3 5259.2 5271.4 4724.2 4726.0 4734.6 4748.0 4795.1 5547.3 5694.2 5697.9 5698.1 5698.5 3965.5 4002.1 4002.6 4008.3 4018.9 5850.2 5993.2 6009.7 6019.9 6076.5 4049.7 4094.5 4105.5 4116.1 4116.3 4172.7 4173.8 4179.2 4183.9 4186.4 4718.9 4757.0 4798.2 4802.6 4802.8 5727.0 5733.4 5738.1 5740.8 5752.8 1409.4 1424.9 1425.3 1426.7 1426.9 926.4 944.1 975.8 979.0 979.6 4893.8 4901.9 4917.6 4947.5 4951.8 5882.6 5896.9 5951.3 5964.7 5979.3 4754.7 4839.7 4840.1 4849.7 4861.5 3084.0 3094.6 3114.8 3116.4 3117.6 5344.1 5387.9 5391.1 5391.5 5405.7 5812.7 6050.6 6079.6 6095.1 6104.5 5373.9 5396.1 5403.6 5404.5 5410.2 5714.8 5849.1 5936.2 5988.4 6013.1 5812.7 5825.9 5843.8 5848.3 5872.4 5198.7 5293.2 5302.3 5358.1 5362.8 3991.0 4015.6 4023.2 4028.7 4028.9 5685.5 5874.9 5887.6 5899.8 5933.9 5742.7 5768.6 5782.0 5810.9 5812.9 5704.1 5747.1 5765.8 5780.0 5797.8 5560.4 5614.4 5628.6 5653.9 5694.8 5748.6 5761.6 5770.4 5773.0 5781.4 5365.6 5574.1 5580.0 5594.8 5618.9 07:02:19 INFO - PID 3493 | 07:02:19 INFO - PID 3493 | [#5] yui.html Cycles:180 Average:17336.08 Median:3399.99 stddev:23432.95 (689.2%) stddev-sans-first:23464.96 07:02:19 INFO - PID 3493 | Values: 594.6 609.0 612.9 698.9 727.0 14071.8 14551.9 14561.6 16986.8 17871.6 16520.1 16782.9 16833.3 16939.3 16980.7 871.3 894.9 895.7 896.8 898.9 913.5 915.3 916.0 918.7 919.1 931.7 936.1 938.1 938.1 941.9 930.2 931.3 937.8 939.8 941.9 654.7 678.4 679.4 684.9 684.9 14287.8 14484.6 14505.3 14510.6 14569.6 15035.5 15407.8 15429.7 15555.9 16149.5 11738.8 11967.9 11999.7 12131.2 12180.9 2948.2 2972.2 2977.2 2980.9 2994.4 85283.6 86739.0 86868.6 87074.6 87450.6 11608.7 12303.9 12379.9 12422.1 12463.9 22893.0 23138.0 23154.9 23178.9 23309.8 5881.8 6056.9 6121.1 6239.7 6354.6 2689.2 2767.2 2769.0 2769.1 2772.5 3306.8 3380.1 3392.6 3398.8 3401.2 712.2 742.9 750.3 751.2 755.9 544.0 567.1 568.2 573.3 575.0 9819.6 10309.6 10521.3 10711.1 10801.4 579.9 580.2 582.6 591.7 596.6 4745.1 4845.3 4858.5 4875.4 4974.1 83746.7 83789.0 85956.6 87239.0 88395.0 74118.0 74943.6 75063.6 75550.0 75928.6 66197.0 66495.0 67213.3 68135.0 68917.0 9323.2 9613.6 9696.7 9917.9 9983.7 28676.6 28774.3 29380.3 30035.8 30137.4 36232.6 36977.8 37167.3 37454.4 37578.0 11166.7 11222.6 11487.7 11530.7 11582.1 13745.3 13928.9 13958.0 14012.5 14080.6 12686.4 12690.9 12726.0 12946.4 13086.6 12413.9 12531.7 12566.6 12637.9 12716.5 12461.9 12635.4 12676.6 12844.3 13104.5 7992.7 8288.1 10548.2 10887.3 10993.9 11914.5 12171.4 12658.2 12673.3 12826.6 07:02:19 INFO - PID 3493 | -------- Summary: end -------- 07:02:19 INFO - PID 3493 | 07:02:20 INFO - TEST-INFO | 3493: exit 0 07:02:20 INFO - TEST-OK | dromaeo_css | took 1147494ms 07:02:20 INFO - TEST-START | kraken 07:02:20 INFO - operating with platform_type : linux_ 07:02:20 INFO - Initialising browser for kraken test... 07:02:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47171/getInfo.html -profile /tmp/tmpewRBDW/profile 07:02:20 INFO - TEST-INFO | started process 3889 (/builds/slave/test/build/application/firefox/firefox http://localhost:47171/getInfo.html) 07:02:54 INFO - TEST-INFO | 3889: killed by SIGTERM 07:02:55 INFO - Browser initialized. 07:02:55 INFO - Running cycle 1/1 for kraken test... 07:02:55 INFO - TEST-INFO | started process 4088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpewRBDW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:03:06 INFO - PID 4088 | RSS: Main: 172818432 07:03:06 INFO - PID 4088 | 07:03:09 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47171/tests/kraken/driver.html?testName=audio-beat-detection) 07:03:10 INFO - PID 4088 | RSS: Main: 178028544 07:03:10 INFO - PID 4088 | 07:03:13 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47171/tests/kraken/driver.html?testName=audio-dft) 07:03:13 INFO - PID 4088 | RSS: Main: 177577984 07:03:13 INFO - PID 4088 | 07:03:16 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47171/tests/kraken/driver.html?testName=audio-fft) 07:03:17 INFO - PID 4088 | RSS: Main: 175329280 07:03:17 INFO - PID 4088 | 07:03:19 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47171/tests/kraken/driver.html?testName=audio-oscillator) 07:03:20 INFO - PID 4088 | RSS: Main: 175710208 07:03:20 INFO - PID 4088 | 07:03:22 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47171/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:03:22 INFO - PID 4088 | RSS: Main: 175595520 07:03:22 INFO - PID 4088 | 07:03:25 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47171/tests/kraken/driver.html?testName=imaging-darkroom) 07:03:26 INFO - PID 4088 | RSS: Main: 176975872 07:03:26 INFO - PID 4088 | 07:03:30 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47171/tests/kraken/driver.html?testName=imaging-desaturate) 07:03:30 INFO - PID 4088 | RSS: Main: 175620096 07:03:30 INFO - PID 4088 | 07:03:33 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47171/tests/kraken/driver.html?testName=json-parse-financial) 07:03:34 INFO - PID 4088 | RSS: Main: 176263168 07:03:34 INFO - PID 4088 | 07:03:35 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47171/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:03:36 INFO - PID 4088 | RSS: Main: 176427008 07:03:36 INFO - PID 4088 | 07:03:38 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47171/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:03:38 INFO - PID 4088 | RSS: Main: 176271360 07:03:38 INFO - PID 4088 | 07:03:41 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47171/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:03:41 INFO - PID 4088 | RSS: Main: 176472064 07:03:41 INFO - PID 4088 | 07:03:44 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:03:45 INFO - PID 4088 | RSS: Main: 176525312 07:03:45 INFO - PID 4088 | 07:03:48 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:03:49 INFO - PID 4088 | RSS: Main: 176304128 07:03:49 INFO - PID 4088 | 07:03:50 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:47171/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47171/tests/kraken/driver.html?testName=ai-astar) 07:03:51 INFO - PID 4088 | RSS: Main: 178065408 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | __start_tp_report 07:03:51 INFO - PID 4088 | _x_x_mozilla_page_load 07:03:51 INFO - PID 4088 | _x_x_mozilla_page_load_details 07:03:51 INFO - PID 4088 | |i|pagename|runs| 07:03:51 INFO - PID 4088 | |0;ai-astar;103;113;110;110;110;111;112;112;111;112 07:03:51 INFO - PID 4088 | |1;audio-beat-detection;153;124;125;164;127;128;134;138;147;124 07:03:51 INFO - PID 4088 | |2;audio-dft;164;164;162;165;169;170;165;163;164;165 07:03:51 INFO - PID 4088 | |3;audio-fft;74;74;74;97;74;73;74;73;96;73 07:03:51 INFO - PID 4088 | |4;audio-oscillator;86;84;112;83;84;83;97;83;84;103 07:03:51 INFO - PID 4088 | |5;imaging-gaussian-blur;114;115;113;116;113;114;113;114;115;114 07:03:51 INFO - PID 4088 | |6;imaging-darkroom;150;151;151;150;151;151;150;150;151;150 07:03:51 INFO - PID 4088 | |7;imaging-desaturate;95;96;94;95;95;95;94;94;95;95 07:03:51 INFO - PID 4088 | |8;json-parse-financial;57;58;55;55;54;56;58;56;54;55 07:03:51 INFO - PID 4088 | |9;json-stringify-tinderbox;56;56;57;57;56;56;56;57;56;56 07:03:51 INFO - PID 4088 | |10;stanford-crypto-aes;86;87;86;89;86;105;88;89;116;86 07:03:51 INFO - PID 4088 | |11;stanford-crypto-ccm;134;134;136;134;134;136;132;134;143;141 07:03:51 INFO - PID 4088 | |12;stanford-crypto-pbkdf2;189;187;194;202;197;195;187;194;193;193 07:03:51 INFO - PID 4088 | |13;stanford-crypto-sha256-iterative;77;77;76;73;75;76;72;70;71;72 07:03:51 INFO - PID 4088 | __end_tp_report 07:03:51 INFO - PID 4088 | __start_cc_report 07:03:51 INFO - PID 4088 | _x_x_mozilla_cycle_collect,930 07:03:51 INFO - PID 4088 | __end_cc_report 07:03:51 INFO - PID 4088 | __startTimestamp1495634631190__endTimestamp 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | ------- Summary: start ------- 07:03:51 INFO - PID 4088 | Number of tests: 14 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:2.80 (2.5%) stddev-sans-first:1.09 07:03:51 INFO - PID 4088 | Values: 103.0 113.0 110.0 110.0 110.0 111.0 112.0 112.0 111.0 112.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:136.00 stddev:13.96 (10.3%) stddev-sans-first:13.45 07:03:51 INFO - PID 4088 | Values: 153.0 124.0 125.0 164.0 127.0 128.0 134.0 138.0 147.0 124.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:2.51 (1.5%) stddev-sans-first:2.64 07:03:51 INFO - PID 4088 | Values: 164.0 164.0 162.0 165.0 169.0 170.0 165.0 163.0 164.0 165.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#3] audio-fft Cycles:10 Average:78.20 Median:74.00 stddev:9.66 (13.1%) stddev-sans-first:10.12 07:03:51 INFO - PID 4088 | Values: 74.0 74.0 74.0 97.0 74.0 73.0 74.0 73.0 96.0 73.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:84.00 stddev:10.40 (12.4%) stddev-sans-first:10.93 07:03:51 INFO - PID 4088 | Values: 86.0 84.0 112.0 83.0 84.0 83.0 97.0 83.0 84.0 103.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.99 (0.9%) stddev-sans-first:1.05 07:03:51 INFO - PID 4088 | Values: 114.0 115.0 113.0 116.0 113.0 114.0 113.0 114.0 115.0 114.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 07:03:51 INFO - PID 4088 | Values: 150.0 151.0 151.0 150.0 151.0 151.0 150.0 150.0 151.0 150.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:03:51 INFO - PID 4088 | Values: 95.0 96.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:1.48 (2.6%) stddev-sans-first:1.50 07:03:51 INFO - PID 4088 | Values: 57.0 58.0 55.0 55.0 54.0 56.0 58.0 56.0 54.0 55.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 07:03:51 INFO - PID 4088 | Values: 56.0 56.0 57.0 57.0 56.0 56.0 56.0 57.0 56.0 56.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#10] stanford-crypto-aes Cycles:10 Average:91.80 Median:86.50 stddev:10.26 (11.9%) stddev-sans-first:10.67 07:03:51 INFO - PID 4088 | Values: 86.0 87.0 86.0 89.0 86.0 105.0 88.0 89.0 116.0 86.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:135.00 stddev:3.49 (2.6%) stddev-sans-first:3.64 07:03:51 INFO - PID 4088 | Values: 134.0 134.0 136.0 134.0 134.0 136.0 132.0 134.0 143.0 141.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.10 Median:194.00 stddev:4.61 (2.4%) stddev-sans-first:4.64 07:03:51 INFO - PID 4088 | Values: 189.0 187.0 194.0 202.0 197.0 195.0 187.0 194.0 193.0 193.0 07:03:51 INFO - PID 4088 | 07:03:51 INFO - PID 4088 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:75.50 stddev:2.60 (3.4%) stddev-sans-first:2.51 07:03:51 INFO - PID 4088 | Values: 77.0 77.0 76.0 73.0 75.0 76.0 72.0 70.0 71.0 72.0 07:03:51 INFO - PID 4088 | -------- Summary: end -------- 07:03:51 INFO - PID 4088 | 07:03:52 INFO - TEST-INFO | 4088: exit 0 07:03:52 INFO - TEST-OK | kraken | took 91999ms 07:03:52 INFO - SUITE-END | took 1239s 07:03:52 INFO - Completed test suite (00:20:39) 07:03:52 INFO - javascript benchmark 07:03:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6739.084172211052, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2687.6102965070068, 2694.178275625933, 2711.850848203348, 2730.0171938102267, 2740.3012231880866, 5007.173816320303, 5140.640155189139, 5203.449097989349, 5233.816816411427, 5267.078261304271, 5157.948420515794, 5172.818951336704, 5225.529702326789, 5239.921401178975, 5319.0, 4371.759553224571, 4584.385610287687, 4652.790624421909, 4672.275797251415, 4693.202155633533, 4740.668153229275, 4748.3827102476625, 4766.547178018082, 4772.284157376386, 4826.0, 4578.610818080467, 4639.652026098022, 4665.906681866344, 4701.294805779126, 4712.811487540494, 4639.721616702975, 4652.395188625457, 4659.976700116512, 4679.859604211879, 4681.016986432854, 4598.126355992351, 4603.723776573383, 4634.281686338623, 4637.1421287062, 4645.396098507206, 5016.297718319438, 5086.109930762139, 5162.328897243335, 5196.714180720059, 5237.921431178535, 5540.390557038722, 5597.356304025007, 5683.886322273573, 5693.060644993571, 5697.259356283698, 5641.915371269393, 5672.971635141798, 5688.0, 5689.516391106761, 5716.1711551825165, 5237.292965449692, 5274.235235890775, 5282.445343238905, 5288.338957630296, 5333.359996800409, 5680.176374425685, 5705.71471426427, 5758.510526605285, 5770.769169233184, 5772.018756811352, 5579.6652200868075, 5588.91616625751, 5594.992901277809, 5601.663900166003, 5641.887162256732, 5641.802536911188, 5655.915161272585, 5656.43435656431, 5666.631668941505, 5669.546436285087, 5489.451054894558, 5553.583481238923, 5555.0, 5646.3788983212635, 5646.85882852932, 5557.972210138923, 5625.987322281947, 5661.320641523043, 5667.064934285797, 5684.37471878093, 4716.29255611661, 4754.31062495943, 4760.976195119002, 4761.119192949315, 4800.687955282895, 4051.1897620475434, 4061.817218225128, 4075.898102547401, 4077.734947228421, 4108.609682080198, 4559.931601025987, 4607.0, 4608.170529304757, 4688.320193571913, 4694.389729335165, 5639.379668236491, 5687.862427514431, 5701.289613116049, 5701.515371193412, 5704.743286552115, 4716.1510928033285, 4718.386609740781, 4720.763961801897, 4727.314539391769, 4758.0, 4839.346688197119, 4927.1131196384995, 4927.531884470969, 5040.495950405004, 5047.318611987408, 5211.062008838446, 5216.087184742579, 5222.817201397933, 5235.136202526541, 5252.264682944315, 5560.054790685674, 5651.915221271602, 5656.632318899258, 5659.575531835211, 5711.543076553949, 5188.558972487381, 5192.766325515286, 5227.89544209106, 5236.6072544560075, 5237.3453318335205, 5474.233607295061, 5554.305711786027, 5556.388797232382, 5594.608377413542, 5595.244641973281, 5645.266115404971, 5655.0, 5699.5155411790465, 5741.91387129185, 5746.655200687972, 5481.314835645544, 5493.23094766741, 5513.393526711979, 5514.117741161395, 5516.200150978006, 5341.092014357646, 5496.972515137399, 5501.5323697486165, 5504.559635229252, 5511.936234073464, 5345.1447768356875, 5354.812581559627, 5399.514043736082, 5464.699441530754, 5488.835334939959, 5553.916986187816, 5565.30433695788, 5570.2201691762375, 5576.553875690016, 5605.747741351731, 5303.628745987744, 5363.061464243664, 5391.218273350264, 5393.6763794172475, 5430.294061771944], "value": 5103.492995962923, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.0576700347458, 639.0669622351368, 655.5280198257254, 1197.2816310213868, 1201.2192075151145, 33171.0, 33503.66496335036, 33507.0, 33593.328133437346, 33620.83189584055, 32580.837095814546, 32969.83515082427, 32981.17547061325, 32986.0, 33116.503252451235, 6588.50586206034, 6789.5926244425245, 6793.0829338039475, 6794.660266986655, 6821.420179284767, 6722.596644201363, 6820.795376138723, 6830.795076147699, 6854.588724676535, 6872.862542749142, 6807.455403567703, 6831.1119554457855, 6852.383285504304, 6864.4165245954155, 6895.310468953115, 6796.796096117099, 6804.897926531106, 6849.931500684979, 6856.348646878514, 6858.965705171492, 6668.299828517985, 6743.696533655997, 6750.223724271674, 6751.324867513209, 6763.323667633246, 30940.535891961637, 31195.68804311973, 31394.37211255762, 31404.685953140404, 31436.21409464759, 2972.1677930179585, 3005.879764809427, 3023.9244018899485, 3028.772842036856, 3030.9090727278, 24814.5037099257, 24859.0, 24862.50274994508, 24886.004559817586, 24978.0, 2901.317236003113, 2916.2126225918882, 2918.3871387008753, 2931.4137172565574, 2943.67619561848, 145342.0, 146050.0, 146161.26919365334, 151354.0, 157019.0, 38959.805200974384, 39082.609173908466, 39131.80434097811, 39398.606013940065, 39409.211815764094, 40740.592594074275, 40799.79600101981, 40821.591784082375, 46401.535984640395, 47234.76382618133, 12991.610251692464, 13027.218366898016, 13149.34253287351, 13201.471941122247, 13216.074874758868, 10348.482575871176, 10440.060394564525, 10459.0, 10531.84202236967, 10534.0, 13014.349282535835, 13073.169756234134, 13141.342932853318, 13151.684831516772, 13297.268650224138, 5481.671099734029, 5553.333599968029, 5577.191307260425, 5602.4957753802355, 5623.100303951348, 880.5377176982007, 902.7697937026016, 915.8900931888217, 926.2682480840061, 939.478589382899, 20363.185472581226, 21244.78755212459, 21265.89367053155, 21317.147314107573, 21815.454613634785, 975.1029053271008, 991.9008099190023, 1004.6232662751469, 1008.7931973945471, 1011.9898801012043, 11209.55161793519, 11228.326300422, 11308.264962777394, 11453.71365715847, 11478.19652624325, 172844.0, 173544.0, 173823.0, 174290.0, 174627.0, 40210.5821005212, 40415.39376909348, 40462.797686011385, 40511.797441012604, 40535.594644053774, 1187.9507848960648, 1240.4789988204975, 1240.9689757756128, 1241.050596293818, 1250.5935570939298, 19706.50733731668, 20115.39653810388, 20590.691139632618, 20784.298041255144, 20925.16299348009, 29089.563656544746, 29127.12618621445, 29204.415911682074, 29206.26984325409, 29277.121686349445, 146021.0, 146982.0, 147087.0, 147164.0, 147249.0, 29170.56244156382, 29514.262143446587, 30105.7314969875, 30641.0, 31007.68992310048, 37022.8148859254, 37151.256974860895, 37205.0698732523, 37242.06894827651, 37470.501179952495, 25984.610230846174, 27517.31206719848, 27942.02202922888, 28032.579511307755, 28240.0, 27805.443891122468, 27907.441851162457, 28522.0, 28858.0, 29113.417731644826, 30949.381012380076, 30952.84523577368, 31011.224719382197, 31045.379092418476, 31097.0, 26576.335591610365, 26949.59575606328, 27120.1863944082, 27413.588796167674, 28136.43727125487, 20677.483062923548, 21111.57776844485, 21926.342209733735, 22008.779912200673, 22069.0], "value": 14495.236129767329, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.51182836510384, 414.16338995229654, 426.3136350475734, 431.30129190711045, 445.5811537155074, 11755.294682319045, 13366.264855432948, 17393.56516087097, 18161.909190454047, 18172.09139543024, 17055.82944170558, 17104.914475427606, 17169.7424538632, 17199.226034828433, 17309.221085051173, 5407.945920540803, 5617.578681598876, 5641.943580564182, 5642.661440313574, 5647.7458514366745, 5306.70813105279, 5375.16684913839, 5375.19372094187, 5417.550991938939, 5466.098093814516, 5331.626786124973, 5335.866603334909, 5339.172428273624, 5363.383210930754, 5383.973080134594, 5129.102407078765, 5302.814401495968, 5325.227841962894, 5341.786328546854, 5348.197770334462, 4807.61539076873, 4811.422629284508, 4828.903421931577, 4846.854594362175, 4848.7090774553635, 20579.279725209544, 20725.792742072535, 21643.45891352713, 21643.67534486984, 21657.45856353588, 1622.9675406491804, 1636.5090472858094, 1641.9753703694455, 1644.6052947292683, 1651.6366399392114, 13976.440942362293, 14276.714465710627, 14413.78379324311, 14526.491572795007, 14750.40998360075, 2042.2954080842085, 2043.3971978266447, 2093.4033800366974, 2098.1083039708064, 2117.2272120676, 86345.56827215887, 90777.0, 91254.99999999933, 92482.53758731231, 93733.0, 10720.142388608892, 10753.354798712102, 10787.298825576312, 11103.888961110448, 11115.666530004113, 14976.176310303037, 14986.0, 15048.398064077533, 15111.697766044617, 15164.24178791056, 7547.8113047173165, 7747.30274275318, 7749.961250193713, 7870.881936770953, 7943.046834379911, 7152.606606636685, 7180.533265337736, 7183.317584829433, 7374.852502949911, 7450.2549745026145, 6725.814110414135, 6914.4468442525485, 6994.125734283215, 7020.403265722471, 7116.110486189226, 2007.688808234726, 2020.272701827341, 2034.949126271855, 2056.208359781495, 2193.5283913958574, 829.7925518620345, 867.1155421470065, 871.7689812199773, 874.3660845886682, 897.9236764875059, 15972.520824375288, 15982.840171598367, 16317.0, 16333.10167940751, 16418.589535261475, 888.0, 898.4609234459402, 903.9186473217311, 918.1828172926101, 918.6784625381063, 8671.132886711404, 8771.684247362818, 8988.775280617907, 9211.447313161098, 9270.814583708288, 323693.0, 327522.0, 329133.0, 330078.0, 331227.0, 73217.97301148488, 74167.62916185385, 74393.6280318595, 75192.0, 75987.0, 1076.332673742285, 1090.2150451674781, 1095.8411030400548, 1097.8517900083386, 1104.116706634689, 14233.50182743599, 16196.0, 18150.0, 18409.90795046016, 18468.81531184671, 39357.60642393654, 40849.591504085765, 40907.79546102369, 40912.38631420471, 41611.58388416077, 47199.29201062056, 47765.761171193924, 48202.758986206245, 48801.511984881115, 49139.75430122826, 7823.295903368724, 8028.397870159878, 8152.877706834521, 8368.41421100517, 8919.687810926587, 12359.50561977511, 12500.874991249972, 13060.21638701681, 13084.738305233652, 13443.126196797177, 10571.36571805694, 10792.730181745519, 11302.378369189773, 11310.208285419942, 11335.546578136782, 10319.587216511256, 10365.792684146125, 10450.42522661261, 10458.790824183627, 10462.947685261524, 10762.46187690628, 11036.5033573491, 11232.606858759904, 11598.0, 11615.548056492938, 8425.199606037417, 8523.48859068433, 8528.957355213184, 8571.699990500303, 8730.083341249332, 11118.110551156049, 11152.776944461228, 11254.21220514556, 11309.830352544554, 11603.941980290045], "value": 8751.4885972567, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1246.2460211572, 1305.9151155174918, 1307.2287350463237, 1309.2668105860719, 1311.2591385866986, 10337.844932326012, 10512.68461946141, 10821.567137314518, 10852.728681782959, 11069.944650276757, 10768.35389876608, 10920.399378034204, 11001.449927503612, 11005.119590432767, 11016.339019658826, 2272.136588096525, 2316.1661801751357, 2324.233003108978, 2324.779145981129, 2331.4987277735286, 2110.9366718998454, 2132.605467988427, 2162.945926351846, 2175.5866385386803, 2191.397365724423, 2181.869087854726, 2213.513027134028, 2214.734231892167, 2214.9224777132804, 2215.4129155773735, 2156.02978659603, 2173.228503881115, 2175.1190767739013, 2175.760666326703, 2180.29140529327, 2088.1751708075376, 2097.737782777153, 2098.4229336932312, 2099.6220680277543, 2110.0715685098507, 10350.0, 10625.681229563126, 10659.147268218523, 10674.519646615843, 10705.197110216764, 5608.298962629671, 5762.308522977228, 5804.187413762077, 5824.155497452888, 5833.125031245305, 3301.7688761786685, 3440.17435815405, 3491.598466176397, 3509.6490350964955, 3518.48981897626, 1170.0990237517149, 1173.2960223865698, 1184.09416796151, 1199.5141967503175, 1200.225854323965, 15615.141167235797, 15689.529314120595, 15772.369105235892, 15789.763153552705, 15793.92103039489, 4686.929696054562, 4700.95299047012, 4797.040591881638, 4830.082284365959, 4840.515948405131, 10933.234673572773, 10964.56141754321, 11010.064144547643, 11042.0, 11050.33697978124, 5233.39815921174, 5377.7311134443125, 5554.972225138929, 5560.2493663355735, 5602.579806514446, 5112.258722485219, 5177.275181474596, 5187.533122019036, 5199.844004679866, 5222.764975576109, 3867.439221312894, 3959.6832253419657, 3963.3460479021214, 3971.4638523798917, 3996.360582306817, 1090.8309212072143, 1130.2427373659668, 1177.0, 1178.192937837584, 1180.5218886351042, 647.355880898509, 671.9294474080249, 699.9055127557816, 700.1353328639127, 703.409136325489, 6295.213098362705, 6483.4164925156965, 6485.0, 6573.112629794917, 6596.0, 854.7606670132373, 856.1566856646199, 867.4968518259394, 880.8062226310202, 887.4276091920675, 3545.2273863068467, 4147.108371700099, 4200.4959404871615, 4205.852795152155, 4244.196216607991, 13274.871635911055, 13602.727945441233, 14053.578392648236, 14120.43518259258, 14195.716085678228, 13534.526291579945, 13913.930430347784, 13998.790018149735, 14012.789808152886, 14027.579172624837, 7479.252074792586, 7534.510256833398, 7583.05211848519, 7587.279208475186, 7627.12288086866, 6160.845978850564, 6161.691915404302, 6170.167027451236, 6172.22847144107, 6271.529635277281, 12471.5011399543, 12620.873791261969, 12627.11610187278, 12694.936525317315, 12768.74462510763, 12835.358232088545, 12872.806907896202, 12897.613071607866, 12979.286139262054, 13143.211407315592, 7679.462437629312, 7704.576248306397, 7737.226277372218, 7741.0, 7767.417443691633, 9643.08390702882, 9896.10935015852, 9933.255005874733, 10019.398836069568, 10023.749406264902, 8425.536595487061, 8434.114417986024, 8478.0, 8481.067082620782, 8490.06609272967, 8082.797930051795, 8108.554029528433, 8149.225823546753, 8214.958925205336, 8314.708985185489, 7544.0, 7714.922850771421, 7741.612919354123, 7773.533587984739, 7794.6882124714375, 5307.814226502054, 5339.439358867418, 5354.196870469461, 5451.781928722807, 5457.808976685797, 5660.943390566206, 5708.0, 5759.280089988752, 5793.826185214451, 6001.819945401645], "value": 4878.273619718756, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.45548138421367, 390.38709226514374, 395.8574913031309, 401.5723254733708, 403.0849970566812, 5308.522232999039, 5448.291722076135, 5482.616216864816, 5517.227588137659, 5518.889622207554, 5274.894502109955, 5303.814366497173, 5313.203019547061, 5320.574354051676, 5321.973390133054, 4027.114034912322, 4037.6877514807657, 4051.7366371185926, 4070.3283958147017, 4074.30736774749, 3916.2167566486673, 4059.7158198926086, 4066.166435880652, 4077.7961101944934, 4079.73481723687, 4055.574164712707, 4062.4109504121884, 4077.22532718784, 4083.3874918762276, 4083.4283200351974, 3991.102002049545, 4034.5158580970324, 4035.636792688643, 4037.576054514263, 4055.878323650295, 3550.9822450887837, 3554.9512893696165, 3561.6972557332656, 3564.8574057037686, 3570.625084366156, 5124.436312005676, 5198.792048318062, 5240.3187585614005, 5259.237410575483, 5271.420143784219, 4724.220503616899, 4725.952740472586, 4734.644901632391, 4748.0, 4795.11595607559, 5547.25112109864, 5694.234787215976, 5697.943020569783, 5698.116791897262, 5698.544116470673, 3965.543962444327, 4002.1195337025806, 4002.557800291747, 4008.318585840414, 4018.9196216075516, 5850.151727999459, 5993.190919225893, 6009.699515024275, 6019.90970135444, 6076.513878889678, 4049.716519843583, 4094.5086589609436, 4105.507339119265, 4116.135611521554, 4116.279651061052, 4172.7079104463, 4173.791310434466, 4179.164167166578, 4183.916321673611, 4186.372044193396, 4718.9292160617615, 4757.048590281888, 4798.160321943646, 4802.567768900815, 4802.831900883452, 5727.0, 5733.426657334233, 5738.110592858114, 5740.770369185269, 5752.827415177551, 1409.4221369238562, 1424.9073810202303, 1425.308725268244, 1426.7003929174782, 1426.871581557644, 926.3885835348638, 944.1361154543653, 975.7851474913635, 978.9559469823876, 979.5787811241235, 4893.828715994923, 4901.9019619608125, 4917.614956745975, 4947.529984651453, 4951.777170027357, 5882.588218824641, 5896.852578685482, 5951.333626584563, 5964.7315870785915, 5979.342272350038, 4754.690945088558, 4839.7096174229655, 4840.080384726891, 4849.684770489977, 4861.51384861511, 3083.98458007713, 3094.628644562667, 3114.8442577871015, 3116.4390409726466, 3117.6414712308374, 5344.118220493653, 5387.865303367447, 5391.110466773017, 5391.460853914656, 5405.675659460367, 5812.651240925558, 6050.6369617823075, 6079.604825686316, 6095.146679464879, 6104.542159338067, 5373.919391209135, 5396.109641909119, 5403.648762830403, 5404.513593776579, 5410.161424979135, 5714.771409143587, 5849.064149736022, 5936.1986131871645, 5988.37122102173, 6013.128096426081, 5812.709364531841, 5825.94174058271, 5843.824685259449, 5848.327442344014, 5872.442117998783, 5198.6880787152895, 5293.232481290114, 5302.310699609026, 5358.062339090721, 5362.839114826562, 3990.960090399059, 4015.5582885881945, 4023.2355852387955, 4028.677705783589, 4028.8589899353383, 5685.545156387397, 5874.911876321773, 5887.646741195542, 5899.793507227227, 5933.910991335047, 5742.655440673573, 5768.625039372428, 5781.95924733552, 5810.937117323459, 5812.866491034208, 5704.144378343116, 5747.109198074305, 5765.798197063083, 5780.017397042597, 5797.797077102281, 5560.36055853582, 5614.354349249888, 5628.60599758013, 5653.879795076846, 5694.800681976111, 5748.626339287933, 5761.625494342854, 5770.3652598215, 5772.9711351442975, 5781.392953739965, 5365.570754339566, 5574.136008918624, 5580.023495888122, 5594.776208951596, 5618.943810561842], "value": 4262.967769184452, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.6372712645285, 608.9665068421236, 612.8835521250962, 698.8567343694543, 726.9672864721088, 14071.788923166161, 14551.927240363784, 14561.563153105411, 16986.83013169868, 17871.64256714865, 16520.0913949733, 16782.916085419587, 16833.32666693334, 16939.322427102932, 16980.745288820646, 871.3203701113126, 894.9463032218088, 895.7044175422095, 896.8340856941454, 898.9190972812446, 913.4838816068933, 915.3043686798048, 915.9587818548181, 918.7243826851951, 919.1406035356963, 931.659944120398, 936.0966667166183, 938.052566907425, 938.0947385772728, 941.9434833909987, 930.2139691960283, 931.3247895275905, 937.8171256604999, 939.7556635274809, 941.8963913969458, 654.6988385342701, 678.4131726056975, 679.4021261290034, 684.9006894000391, 684.9383555480031, 14287.78568321476, 14484.565463036126, 14505.27473626325, 14510.564683059525, 14569.635759106, 15035.473758418511, 15407.845921540753, 15429.691406171814, 15555.922220388939, 16149.515514534583, 11738.765224695544, 11967.880321196852, 11999.700007499883, 12131.150819442642, 12180.939095304555, 2948.20398492408, 2972.1677930179585, 2977.1663934098488, 2980.8970680848006, 2994.3562134141266, 85283.57358213169, 86738.99999999937, 86868.5656571713, 87074.5646271771, 87450.56274718649, 11608.6517404478, 12303.876961230451, 12379.93810030962, 12422.068344874171, 12463.937680311541, 22893.0, 23138.0, 23154.884225578764, 23178.884105579702, 23309.76690233076, 5881.764729410861, 6056.939430605726, 6121.081837724288, 6239.656818874914, 6354.555181137276, 2689.1798001609695, 2767.225176950417, 2769.030839206302, 2769.0862015534826, 2772.50094982905, 3306.834658267077, 3380.0704806178496, 3392.5759280089987, 3398.8130652814334, 3401.1667141549983, 712.2450202785064, 742.8514297140593, 750.3097150621442, 751.2037240525061, 755.8903958925926, 544.0123891872564, 567.103975718364, 568.2442351672266, 573.3320681406199, 574.9712514374264, 9819.607215711434, 10309.587616495257, 10521.316114452537, 10711.143108551298, 10801.351918884735, 579.9072148456227, 580.1732531143105, 582.6038293960063, 591.7278052096084, 596.6092209602717, 4745.098431298043, 4845.297431872359, 4858.4898585648, 4875.366202393737, 4974.104661161025, 83746.74379884306, 83789.0, 85956.57021714852, 87239.0, 88395.0, 74118.0, 74943.62528187434, 75063.62468187624, 75550.0, 75928.62035689897, 66197.0, 66495.0, 67213.32786672168, 68135.0, 68917.0, 9323.20752736025, 9613.567389467351, 9696.660616878375, 9917.851232231378, 9983.700488985342, 28676.569851451826, 28774.280642983256, 29380.265493362836, 30035.849820750755, 30137.397252055274, 36232.63767362293, 36977.815110924275, 37167.25665486729, 37454.438183426726, 37578.0, 11166.665000050012, 11222.55109795599, 11487.712807179887, 11530.654080377602, 11582.131340149353, 13745.312734363042, 13928.860711392756, 13958.022938394215, 14012.509562165274, 14080.577582672537, 12686.429110690226, 12690.936545317214, 12726.0, 12946.352682366032, 13086.607401777961, 12413.937930310653, 12531.74936501283, 12566.623001309976, 12637.93681031589, 12716.491340346653, 12461.87538124607, 12635.431405586954, 12676.619701408972, 12844.293563853704, 13104.510143072786, 7992.680292788224, 8288.129746376544, 10548.156147508334, 10887.278180454887, 10993.945030274797, 11914.463849126636, 12171.39143042862, 12658.240505569695, 12673.302968336462, 12826.55107071248], "value": 6956.983813635186, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 110.0, 110.0, 110.0, 111.0, 112.0, 112.0, 111.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 125.0, 164.0, 127.0, 128.0, 134.0, 138.0, 147.0, 124.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 162.0, 165.0, 169.0, 170.0, 165.0, 163.0, 164.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 97.0, 74.0, 73.0, 74.0, 73.0, 96.0, 73.0], "value": 78.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 112.0, 83.0, 84.0, 83.0, 97.0, 83.0, 84.0, 103.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 116.0, 113.0, 114.0, 113.0, 114.0, 115.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 150.0, 151.0, 151.0, 150.0, 150.0, 151.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 55.0, 55.0, 54.0, 56.0, 58.0, 56.0, 54.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 89.0, 86.0, 105.0, 88.0, 89.0, 116.0, 86.0], "value": 91.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 136.0, 134.0, 134.0, 136.0, 132.0, 134.0, 143.0, 141.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 187.0, 194.0, 202.0, 197.0, 195.0, 187.0, 194.0, 193.0, 193.0], "value": 193.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 73.0, 75.0, 76.0, 72.0, 70.0, 71.0, 72.0], "value": 73.9, "unit": "score"}]}]} 07:03:52 INFO - Return code: 0 07:03:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:03:52 INFO - # TBPL SUCCESS # 07:03:52 INFO - Running post-action listener: _resource_record_post_action 07:03:52 INFO - [mozharness: 2017-05-24 14:03:52.488663Z] Finished run-tests step (success) 07:03:52 INFO - Running post-run listener: _resource_record_post_run 07:03:52 INFO - Total resource usage - Wall time: 1256s; CPU: 13.0%; Read bytes: 8740864; Write bytes: 413011968; Read time: 2124; Write time: 344172 07:03:52 INFO - TinderboxPrint: CPU usage
12.7% 07:03:52 INFO - TinderboxPrint: I/O read bytes / time
8,740,864 / 2,124 07:03:52 INFO - TinderboxPrint: I/O write bytes / time
413,011,968 / 344,172 07:03:52 INFO - TinderboxPrint: CPU idle
8,743.7 (87.2%) 07:03:52 INFO - TinderboxPrint: CPU user
1,219.8 (12.2%) 07:03:52 INFO - TinderboxPrint: Swap in / out
0 / 0 07:03:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 53248; Write bytes: 105340928; Read time: 16; Write time: 85356 07:03:52 INFO - run-tests - Wall time: 1240s; CPU: 13.0%; Read bytes: 8687616; Write bytes: 289128448; Read time: 2108; Write time: 256260 07:03:53 INFO - Running post-run listener: _upload_blobber_files 07:03:53 INFO - Blob upload gear active. 07:03:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:03:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:03:53 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'] 07:03:53 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 07:03:53 INFO - (blobuploader) - INFO - Open directory for files ... 07:03:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:03:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:03:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:04:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:00 INFO - (blobuploader) - INFO - Done attempting. 07:04:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:04:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:04:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:00 INFO - (blobuploader) - INFO - Done attempting. 07:04:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:04:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:01 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:04:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:01 INFO - (blobuploader) - INFO - Done attempting. 07:04:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:04:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:04:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:04:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:04:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:04:02 INFO - (blobuploader) - INFO - Done attempting. 07:04:02 INFO - (blobuploader) - INFO - Iteration through files over. 07:04:02 INFO - Return code: 0 07:04:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:04:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:04:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/434891a59d73e637b7b3061ef25d7a92c7b2afe1c680332c154f7083bfe9ac06ffc3ae9caceac10c50a2f196ff6bae77bdc66325eab79563a4051bf29969b028", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fffdf2c44724a7bed4a0e9af9706c20ba50c8a8adc10f5ffe93a3db16ef0ec7bfd68e2a30b5ff8581d4361a3f08bfec066200b21991b081ba89411c4b10e286f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe5027dc3c6689bbeefebb8e2306fd55e9cbf713706b9fceb42c24a5fe5639a5c0db6b83bf58e3ffea48e4aec56d1faef92725ff98ab4bcd13abea0f627efda3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b629c90b9d633d4f3783ab27f2478c94bfadd499983189906776b9a86c99a2ec5471b11929b8fbc64447e59351b25d19b4f0fe652fe682fe8bef264bb3c19c0"} 07:04:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:04:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:04:02 INFO - Contents: 07:04:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/434891a59d73e637b7b3061ef25d7a92c7b2afe1c680332c154f7083bfe9ac06ffc3ae9caceac10c50a2f196ff6bae77bdc66325eab79563a4051bf29969b028", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fffdf2c44724a7bed4a0e9af9706c20ba50c8a8adc10f5ffe93a3db16ef0ec7bfd68e2a30b5ff8581d4361a3f08bfec066200b21991b081ba89411c4b10e286f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe5027dc3c6689bbeefebb8e2306fd55e9cbf713706b9fceb42c24a5fe5639a5c0db6b83bf58e3ffea48e4aec56d1faef92725ff98ab4bcd13abea0f627efda3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b629c90b9d633d4f3783ab27f2478c94bfadd499983189906776b9a86c99a2ec5471b11929b8fbc64447e59351b25d19b4f0fe652fe682fe8bef264bb3c19c0"} 07:04:02 INFO - Running post-run listener: copy_logs_to_upload_dir 07:04:02 INFO - Copying logs to upload dir... 07:04:02 INFO - mkdir: /builds/slave/test/build/upload/logs 07:04:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1318.708471 ========= master_lag: -0.65 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 58 secs) (at 2017-05-24 07:04:02.440746) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 07:04:02.448190) ========= 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=32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/434891a59d73e637b7b3061ef25d7a92c7b2afe1c680332c154f7083bfe9ac06ffc3ae9caceac10c50a2f196ff6bae77bdc66325eab79563a4051bf29969b028", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fffdf2c44724a7bed4a0e9af9706c20ba50c8a8adc10f5ffe93a3db16ef0ec7bfd68e2a30b5ff8581d4361a3f08bfec066200b21991b081ba89411c4b10e286f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe5027dc3c6689bbeefebb8e2306fd55e9cbf713706b9fceb42c24a5fe5639a5c0db6b83bf58e3ffea48e4aec56d1faef92725ff98ab4bcd13abea0f627efda3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b629c90b9d633d4f3783ab27f2478c94bfadd499983189906776b9a86c99a2ec5471b11929b8fbc64447e59351b25d19b4f0fe652fe682fe8bef264bb3c19c0"} build_url:https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011366 build_url: 'https://queue.taskcluster.net/v1/task/XXkWE3mxR8qFdcF_LoYLxQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/434891a59d73e637b7b3061ef25d7a92c7b2afe1c680332c154f7083bfe9ac06ffc3ae9caceac10c50a2f196ff6bae77bdc66325eab79563a4051bf29969b028", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fffdf2c44724a7bed4a0e9af9706c20ba50c8a8adc10f5ffe93a3db16ef0ec7bfd68e2a30b5ff8581d4361a3f08bfec066200b21991b081ba89411c4b10e286f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe5027dc3c6689bbeefebb8e2306fd55e9cbf713706b9fceb42c24a5fe5639a5c0db6b83bf58e3ffea48e4aec56d1faef92725ff98ab4bcd13abea0f627efda3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b629c90b9d633d4f3783ab27f2478c94bfadd499983189906776b9a86c99a2ec5471b11929b8fbc64447e59351b25d19b4f0fe652fe682fe8bef264bb3c19c0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 07:04:02.479618) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 07:04:02.479978) ========= 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=32c5991c409366f7fec8a718000001d2-1495633320.999388-399957818 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 07:04:02.562717) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 07:04:02.563062) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 07:04:02.563386) ========= ========= Total master_lag: -0.49 =========