builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-087 starttime: 1495777476.93 results: success (0) revision: 5d6fe59a9a5dfd2d381d2cdfdc968d3305b417cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 22:44:36.928467) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 22:44:36.929326) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 22:44:36.929641) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 22:44:36.953533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 22:44:36.953818) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 22:44:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.7M=0s 2017-05-25 22:44:37 (34.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122425 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 22:44:37.089583) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 22:44:37.089981) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017984 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 22:44:37.140261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 22:44:37.140752) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5d6fe59a9a5dfd2d381d2cdfdc968d3305b417cf --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 5d6fe59a9a5dfd2d381d2cdfdc968d3305b417cf --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=ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 22:44:37,347 truncating revision to first 12 chars 2017-05-25 22:44:37,347 Setting DEBUG logging. 2017-05-25 22:44:37,347 attempt 1/10 2017-05-25 22:44:37,347 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5d6fe59a9a5d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 22:44:38,178 unpacking tar archive at: mozilla-central-5d6fe59a9a5d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.142885 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-25 22:44:38.297858) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 22:44:38.298235) ========= script_repo_revision: 5d6fe59a9a5dfd2d381d2cdfdc968d3305b417cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 22:44:38.298736) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 22:44:38.299060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 22:44:38.307021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-05-25 22:44:38.307345) ========= /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=ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:44:38 INFO - MultiFileLogger online at 20170525 22:44:38 in /builds/slave/test 22:44:38 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 22:44:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:44:38 INFO - {'append_to_log': False, 22:44:38 INFO - 'base_work_dir': '/builds/slave/test', 22:44:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 22:44:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:44:38 INFO - 'branch': 'Firefox-Non-PGO', 22:44:38 INFO - 'buildbot_json_path': 'buildprops.json', 22:44:38 INFO - 'config_files': ('talos/linux_config.py',), 22:44:38 INFO - 'default_actions': ('clobber', 22:44:38 INFO - 'read-buildbot-config', 22:44:38 INFO - 'download-and-extract', 22:44:38 INFO - 'populate-webroot', 22:44:38 INFO - 'create-virtualenv', 22:44:38 INFO - 'install', 22:44:38 INFO - 'run-tests'), 22:44:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:44:38 INFO - 'download_minidump_stackwalk': True, 22:44:38 INFO - 'download_symbols': 'ondemand', 22:44:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:44:38 INFO - 'tooltool.py': '/tools/tooltool.py', 22:44:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:44:38 INFO - '/tools/misc-python/virtualenv.py')}, 22:44:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:44:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:44:38 INFO - 'gecko_profile': False, 22:44:38 INFO - 'gecko_profile_interval': 0, 22:44:38 INFO - 'installer_path': 'installer.exe', 22:44:38 INFO - 'log_level': 'info', 22:44:38 INFO - 'log_name': 'talos', 22:44:38 INFO - 'log_to_console': True, 22:44:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:44:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:44:38 INFO - 'opt_config_files': (), 22:44:38 INFO - 'pip_index': False, 22:44:38 INFO - 'suite': 'dromaeojs-e10s', 22:44:38 INFO - 'system_bits': '32', 22:44:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:44:38 INFO - 'title': 'talos-linux64-ix-087', 22:44:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:44:38 INFO - 'use_talos_json': True, 22:44:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:44:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:44:38 INFO - 'work_dir': 'build'} 22:44:38 INFO - [mozharness: 2017-05-26 05:44:38.613263Z] Running clobber step. 22:44:38 INFO - Running pre-action listener: _resource_record_pre_action 22:44:38 INFO - Running main action method: clobber 22:44:38 INFO - rmtree: /builds/slave/test/build 22:44:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:44:40 INFO - Running post-action listener: _resource_record_post_action 22:44:40 INFO - [mozharness: 2017-05-26 05:44:40.149114Z] Finished clobber step (success) 22:44:40 INFO - [mozharness: 2017-05-26 05:44:40.149212Z] Running read-buildbot-config step. 22:44:40 INFO - Running pre-action listener: _resource_record_pre_action 22:44:40 INFO - Running main action method: read_buildbot_config 22:44:40 INFO - Using buildbot properties: 22:44:40 INFO - { 22:44:40 INFO - "project": "", 22:44:40 INFO - "product": "firefox", 22:44:40 INFO - "who": "eakhgari@mozilla.com", 22:44:40 INFO - "installer_path": "public/build/target.tar.bz2", 22:44:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:44:40 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 22:44:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 22:44:40 INFO - "stage_platform": "linux64", 22:44:40 INFO - "basedir": "/builds/slave/test", 22:44:40 INFO - "buildnumber": 905, 22:44:40 INFO - "platform": "ubuntu64_hw", 22:44:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:44:40 INFO - "slavebuilddir": "test", 22:44:40 INFO - "taskId": "JyQTVBopTsGg1xZOi6WBkw", 22:44:40 INFO - "branch": "mozilla-central", 22:44:40 INFO - "script_repo_revision": "production", 22:44:40 INFO - "revision": "5d6fe59a9a5dfd2d381d2cdfdc968d3305b417cf", 22:44:40 INFO - "slavename": "talos-linux64-ix-087", 22:44:40 INFO - "repo_path": "mozilla-central" 22:44:40 INFO - } 22:44:40 INFO - Finding installer, test and symbols from parent task. 22:44:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JyQTVBopTsGg1xZOi6WBkw'}, attempt #1 22:44:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JyQTVBopTsGg1xZOi6WBkw'}, attempt #1 22:44:41 INFO - Task dependencies: MX4XMzTvTf29IClyFGHrBQ 22:44:41 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ'}, attempt #1 22:44:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.tar.bz2 22:44:41 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/test_packages.json 22:44:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.crashreporter-symbols.zip 22:44:41 INFO - Running post-action listener: _resource_record_post_action 22:44:41 INFO - [mozharness: 2017-05-26 05:44:41.524178Z] Finished read-buildbot-config step (success) 22:44:41 INFO - [mozharness: 2017-05-26 05:44:41.524398Z] Running download-and-extract step. 22:44:41 INFO - Running pre-action listener: _resource_record_pre_action 22:44:41 INFO - Running main action method: download_and_extract 22:44:41 INFO - mkdir: /builds/slave/test/build/tests 22:44:41 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')]} 22:44:41 INFO - trying https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.test_packages.json 22:44:41 INFO - Downloading https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:44:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:44:42 INFO - Downloaded 986 bytes. 22:44:42 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:44:42 INFO - Using the following test package requirements: 22:44:42 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:44:42 INFO - u'common': [u'target.common.tests.zip'], 22:44:42 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:44:42 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:44:42 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:44:42 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:44:42 INFO - u'mozbase': [u'target.common.tests.zip'], 22:44:42 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:44:42 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:44:42 INFO - u'web-platform': [u'target.common.tests.zip', 22:44:42 INFO - u'target.web-platform.tests.zip'], 22:44:42 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:44:42 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:44:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.common.tests.zip 22:44:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:44:42 INFO - Fetch https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.common.tests.zip into memory 22:44:43 INFO - Content-Length response header: 63532327 22:44:43 INFO - Bytes received: 63532327 22:44:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:44:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.common.tests.zip 22:44:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:44:54 INFO - Fetch https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.common.tests.zip into memory 22:44:55 INFO - Content-Length response header: 63532327 22:44:55 INFO - Bytes received: 63532327 22:45:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.talos.tests.zip 22:45:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:45:06 INFO - Fetch https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.talos.tests.zip into memory 22:45:07 INFO - Content-Length response header: 14411888 22:45:07 INFO - Bytes received: 14411888 22:45:07 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')]} 22:45:07 INFO - trying https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.tar.bz2 22:45:07 INFO - Downloading https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:45:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:45:09 INFO - Downloaded 54097388 bytes. 22:45:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.tar.bz2 22:45:09 INFO - mkdir: /builds/slave/test/properties 22:45:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:45:09 INFO - Writing to file /builds/slave/test/properties/build_url 22:45:09 INFO - Contents: 22:45:09 INFO - build_url:https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.tar.bz2 22:45:09 INFO - Running post-action listener: _resource_record_post_action 22:45:09 INFO - Running post-action listener: set_extra_try_arguments 22:45:09 INFO - [mozharness: 2017-05-26 05:45:09.632770Z] Finished download-and-extract step (success) 22:45:09 INFO - [mozharness: 2017-05-26 05:45:09.632933Z] Running populate-webroot step. 22:45:09 INFO - Running pre-action listener: _resource_record_pre_action 22:45:09 INFO - Running main action method: populate_webroot 22:45:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:45:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:45:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:45:09 INFO - '--tppagecycles', 22:45:09 INFO - '7'], 22:45:09 INFO - 'tests': ['tsvgm']}}, 22:45:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:45:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:45:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:45:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:45:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:45:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:45:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:45:09 INFO - 'talos_options': ['--disable-e10s'], 22:45:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:45:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:45:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:45:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:45:09 INFO - 'talos_options': ['--disable-e10s'], 22:45:09 INFO - 'tests': ['damp', 'tps']}, 22:45:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:45:09 INFO - 'tests': ['damp', 'tps']}, 22:45:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:45:09 INFO - 'tests': ['dromaeo_dom']}, 22:45:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:45:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:45:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 22:45:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 22:45:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 22:45:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 22:45:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:45:09 INFO - 'tests': ['a11yr', 22:45:09 INFO - 'ts_paint', 22:45:09 INFO - 'tpaint', 22:45:09 INFO - 'sessionrestore', 22:45:09 INFO - 'sessionrestore_no_auto_restore', 22:45:09 INFO - 'tabpaint']}, 22:45:09 INFO - 'other-e10s': {'tests': ['a11yr', 22:45:09 INFO - 'ts_paint', 22:45:09 INFO - 'tpaint', 22:45:09 INFO - 'sessionrestore', 22:45:09 INFO - 'sessionrestore_no_auto_restore', 22:45:09 INFO - 'tabpaint']}, 22:45:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:45:09 INFO - 'ts_paint', 22:45:09 INFO - 'tpaint', 22:45:09 INFO - 'sessionrestore', 22:45:09 INFO - 'sessionrestore_no_auto_restore', 22:45:09 INFO - 'tabpaint']}, 22:45:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:45:09 INFO - 'ts_paint', 22:45:09 INFO - 'tpaint', 22:45:09 INFO - 'sessionrestore', 22:45:09 INFO - 'sessionrestore_no_auto_restore', 22:45:09 INFO - 'tabpaint']}, 22:45:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:45:09 INFO - 'tests': ['a11yr', 22:45:09 INFO - 'ts_paint', 22:45:09 INFO - 'tpaint', 22:45:09 INFO - 'sessionrestore', 22:45:09 INFO - 'sessionrestore_no_auto_restore', 22:45:09 INFO - 'tabpaint']}, 22:45:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:45:09 INFO - 'tests': ['a11yr', 22:45:09 INFO - 'ts_paint', 22:45:09 INFO - 'tpaint', 22:45:09 INFO - 'sessionrestore', 22:45:09 INFO - 'sessionrestore_no_auto_restore', 22:45:09 INFO - 'tabpaint']}, 22:45:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 22:45:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 22:45:09 INFO - 'bloom_basic_ref']}, 22:45:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:45:09 INFO - 'tests': ['tsvgx', 22:45:09 INFO - 'tsvgr_opacity', 22:45:09 INFO - 'tart', 22:45:09 INFO - 'tscrollx', 22:45:09 INFO - 'cart', 22:45:09 INFO - 'tsvg_static']}, 22:45:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:45:09 INFO - 'tsvgr_opacity', 22:45:09 INFO - 'tart', 22:45:09 INFO - 'tscrollx', 22:45:09 INFO - 'cart', 22:45:09 INFO - 'tsvg_static']}, 22:45:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:45:09 INFO - 'talos_options': ['--disable-e10s'], 22:45:09 INFO - 'tests': ['tp5o']}, 22:45:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:45:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:45:09 INFO - 'talos_options': ['--disable-e10s', 22:45:09 INFO - '--xperf_path', 22:45:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:45:09 INFO - 'tests': ['tp5n']}, 22:45:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:45:09 INFO - 'talos_options': ['--xperf_path', 22:45:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:45:09 INFO - 'tests': ['tp5n']}}, 22:45:09 INFO - 'talos.zip': {'path': '', 22:45:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:45:09 INFO - Running post-action listener: _resource_record_post_action 22:45:09 INFO - [mozharness: 2017-05-26 05:45:09.654340Z] Finished populate-webroot step (success) 22:45:09 INFO - [mozharness: 2017-05-26 05:45:09.654429Z] Running create-virtualenv step. 22:45:09 INFO - Running pre-action listener: _resource_record_pre_action 22:45:09 INFO - Running main action method: create_virtualenv 22:45:09 INFO - Creating virtualenv /builds/slave/test/build/venv 22:45:09 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 22:45:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:45:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:45:09 INFO - Using real prefix '/usr' 22:45:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:45:10 INFO - Installing distribute.............................................................................................................................................................................................done. 22:45:12 INFO - Installing pip.................done. 22:45:12 INFO - Return code: 0 22:45:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:45:12 INFO - Reading from file tmpfile_stdout 22:45:12 INFO - Output received: 22:45:12 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) 22:45:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:45: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')]} 22:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:45: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')]} 22:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:45:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb77a0>, '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 0x1bb86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', '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 22:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:45:12 INFO - Using env: {'DISPLAY': ':0', 22:45:12 INFO - 'HOME': '/home/cltbld', 22:45:12 INFO - 'LANG': 'en_US.UTF-8', 22:45:12 INFO - 'LANGUAGE': 'en_US:en', 22:45:12 INFO - 'LOGNAME': 'cltbld', 22:45:12 INFO - 'MAIL': '/var/mail/cltbld', 22:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:45:12 INFO - 'MOZ_NO_REMOTE': '1', 22:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:45:12 INFO - 'NO_EM_RESTART': '1', 22:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:45:12 INFO - 'PWD': '/builds/slave/test', 22:45:12 INFO - 'SHELL': '/bin/bash', 22:45:12 INFO - 'SHLVL': '1', 22:45:12 INFO - 'TERM': 'linux', 22:45:12 INFO - 'TMOUT': '86400', 22:45:12 INFO - 'USER': 'cltbld', 22:45:12 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', 22:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:45:12 INFO - '_': '/tools/buildbot/bin/python'} 22:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:45:12 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 22:45:12 INFO - Cleaning up... 22:45:12 INFO - Return code: 0 22:45:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:45: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')]} 22:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:45: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')]} 22:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:45:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb77a0>, '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 0x1bb86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', '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 22:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:45:12 INFO - Using env: {'DISPLAY': ':0', 22:45:12 INFO - 'HOME': '/home/cltbld', 22:45:12 INFO - 'LANG': 'en_US.UTF-8', 22:45:12 INFO - 'LANGUAGE': 'en_US:en', 22:45:12 INFO - 'LOGNAME': 'cltbld', 22:45:12 INFO - 'MAIL': '/var/mail/cltbld', 22:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:45:12 INFO - 'MOZ_NO_REMOTE': '1', 22:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:45:12 INFO - 'NO_EM_RESTART': '1', 22:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:45:12 INFO - 'PWD': '/builds/slave/test', 22:45:12 INFO - 'SHELL': '/bin/bash', 22:45:12 INFO - 'SHLVL': '1', 22:45:12 INFO - 'TERM': 'linux', 22:45:12 INFO - 'TMOUT': '86400', 22:45:12 INFO - 'USER': 'cltbld', 22:45:12 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', 22:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:45:12 INFO - '_': '/tools/buildbot/bin/python'} 22:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:45:12 INFO - Downloading/unpacking psutil>=3.1.1 22:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:45:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:45:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:45:14 INFO - Installing collected packages: psutil 22:45:14 INFO - Running setup.py install for psutil 22:45:14 INFO - building 'psutil._psutil_linux' extension 22:45:14 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 22:45:14 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 22:45:14 INFO - building 'psutil._psutil_posix' extension 22:45:14 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 22:45:14 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 22:45:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:45:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:45:14 INFO - Successfully installed psutil 22:45:14 INFO - Cleaning up... 22:45:14 INFO - Return code: 0 22:45:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:45:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:45:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb77a0>, '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 0x1bb86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', '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 22:45:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:45:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:45:14 INFO - Using env: {'DISPLAY': ':0', 22:45:14 INFO - 'HOME': '/home/cltbld', 22:45:14 INFO - 'LANG': 'en_US.UTF-8', 22:45:14 INFO - 'LANGUAGE': 'en_US:en', 22:45:14 INFO - 'LOGNAME': 'cltbld', 22:45:14 INFO - 'MAIL': '/var/mail/cltbld', 22:45:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:45:14 INFO - 'MOZ_NO_REMOTE': '1', 22:45:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:45:14 INFO - 'NO_EM_RESTART': '1', 22:45:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:45:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:45:14 INFO - 'PWD': '/builds/slave/test', 22:45:14 INFO - 'SHELL': '/bin/bash', 22:45:14 INFO - 'SHLVL': '1', 22:45:14 INFO - 'TERM': 'linux', 22:45:14 INFO - 'TMOUT': '86400', 22:45:14 INFO - 'USER': 'cltbld', 22:45:14 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', 22:45:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:45:14 INFO - '_': '/tools/buildbot/bin/python'} 22:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:45:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:45:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:45:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:45:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:45:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:45:15 INFO - Installing collected packages: mozsystemmonitor 22:45:15 INFO - Running setup.py install for mozsystemmonitor 22:45:16 INFO - Successfully installed mozsystemmonitor 22:45:16 INFO - Cleaning up... 22:45:16 INFO - Return code: 0 22:45:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:45:16 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')]} 22:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:45:16 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')]} 22:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:45:16 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 0x18471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb77a0>, '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 0x1bb86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', '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 22:45:16 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 22:45:16 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 22:45:16 INFO - Using env: {'DISPLAY': ':0', 22:45:16 INFO - 'HOME': '/home/cltbld', 22:45:16 INFO - 'LANG': 'en_US.UTF-8', 22:45:16 INFO - 'LANGUAGE': 'en_US:en', 22:45:16 INFO - 'LOGNAME': 'cltbld', 22:45:16 INFO - 'MAIL': '/var/mail/cltbld', 22:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:45:16 INFO - 'MOZ_NO_REMOTE': '1', 22:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:45:16 INFO - 'NO_EM_RESTART': '1', 22:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:45:16 INFO - 'PWD': '/builds/slave/test', 22:45:16 INFO - 'SHELL': '/bin/bash', 22:45:16 INFO - 'SHLVL': '1', 22:45:16 INFO - 'TERM': 'linux', 22:45:16 INFO - 'TMOUT': '86400', 22:45:16 INFO - 'USER': 'cltbld', 22:45:16 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', 22:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:45:16 INFO - '_': '/tools/buildbot/bin/python'} 22:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:45:16 INFO - Downloading/unpacking jsonschema==2.5.1 22:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:45:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:45:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:45:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:45:17 INFO - Downloading functools32-3.2.3-2.tar.gz 22:45:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:45:17 INFO - warning: no files found matching '*.txt' 22:45:17 INFO - no previously-included directories found matching 'build' 22:45:17 INFO - no previously-included directories found matching 'dist' 22:45:17 INFO - no previously-included directories found matching '.git*' 22:45:17 INFO - Installing collected packages: jsonschema, functools32 22:45:17 INFO - Running setup.py install for functools32 22:45:17 INFO - warning: no files found matching '*.txt' 22:45:17 INFO - no previously-included directories found matching 'build' 22:45:17 INFO - no previously-included directories found matching 'dist' 22:45:17 INFO - no previously-included directories found matching '.git*' 22:45:17 INFO - Successfully installed jsonschema functools32 22:45:17 INFO - Cleaning up... 22:45:17 INFO - Return code: 0 22:45:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:45:17 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 0x18471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb77a0>, '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 0x1bb86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', '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 22:45:17 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 22:45:17 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 22:45:17 INFO - Using env: {'DISPLAY': ':0', 22:45:17 INFO - 'HOME': '/home/cltbld', 22:45:17 INFO - 'LANG': 'en_US.UTF-8', 22:45:17 INFO - 'LANGUAGE': 'en_US:en', 22:45:17 INFO - 'LOGNAME': 'cltbld', 22:45:17 INFO - 'MAIL': '/var/mail/cltbld', 22:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:45:17 INFO - 'MOZ_NO_REMOTE': '1', 22:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:45:17 INFO - 'NO_EM_RESTART': '1', 22:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:45:17 INFO - 'PWD': '/builds/slave/test', 22:45:17 INFO - 'SHELL': '/bin/bash', 22:45:17 INFO - 'SHLVL': '1', 22:45:17 INFO - 'TERM': 'linux', 22:45:17 INFO - 'TMOUT': '86400', 22:45:17 INFO - 'USER': 'cltbld', 22:45:17 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', 22:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:45:17 INFO - '_': '/tools/buildbot/bin/python'} 22:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:45:17 INFO - Cleaning up... 22:45:17 INFO - Return code: 0 22:45:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:45:17 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 0x18471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb77a0>, '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 0x1bb86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', '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 22:45:17 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 22:45:17 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 22:45:17 INFO - Using env: {'DISPLAY': ':0', 22:45:17 INFO - 'HOME': '/home/cltbld', 22:45:17 INFO - 'LANG': 'en_US.UTF-8', 22:45:17 INFO - 'LANGUAGE': 'en_US:en', 22:45:17 INFO - 'LOGNAME': 'cltbld', 22:45:17 INFO - 'MAIL': '/var/mail/cltbld', 22:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:45:17 INFO - 'MOZ_NO_REMOTE': '1', 22:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:45:17 INFO - 'NO_EM_RESTART': '1', 22:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:45:17 INFO - 'PWD': '/builds/slave/test', 22:45:17 INFO - 'SHELL': '/bin/bash', 22:45:17 INFO - 'SHLVL': '1', 22:45:17 INFO - 'TERM': 'linux', 22:45:17 INFO - 'TMOUT': '86400', 22:45:17 INFO - 'USER': 'cltbld', 22:45:17 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', 22:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:45:17 INFO - '_': '/tools/buildbot/bin/python'} 22:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:45:18 INFO - Downloading/unpacking blobuploader==1.2.4 22:45:18 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 22:45:18 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 22:45:18 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 22:45:18 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 22:45:19 INFO - Downloading blobuploader-1.2.4.tar.gz 22:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:45:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:45:19 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 22:45:19 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 22:45:19 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 22:45:19 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 22:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:45:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:45:19 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 22:45:19 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 22:45:19 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 22:45:19 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 22:45:19 INFO - Downloading docopt-0.6.1.tar.gz 22:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:45:19 INFO - Installing collected packages: blobuploader, requests, docopt 22:45:19 INFO - Running setup.py install for blobuploader 22:45:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:45:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:45:19 INFO - Running setup.py install for requests 22:45:20 INFO - Running setup.py install for docopt 22:45:20 INFO - Successfully installed blobuploader requests docopt 22:45:20 INFO - Cleaning up... 22:45:20 INFO - Return code: 0 22:45:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:45:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:45:20 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 0x18471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb77a0>, '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 0x1bb86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', '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 22:45:20 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 22:45:20 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 22:45:20 INFO - Using env: {'DISPLAY': ':0', 22:45:20 INFO - 'HOME': '/home/cltbld', 22:45:20 INFO - 'LANG': 'en_US.UTF-8', 22:45:20 INFO - 'LANGUAGE': 'en_US:en', 22:45:20 INFO - 'LOGNAME': 'cltbld', 22:45:20 INFO - 'MAIL': '/var/mail/cltbld', 22:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:45:20 INFO - 'MOZ_NO_REMOTE': '1', 22:45:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:45:20 INFO - 'NO_EM_RESTART': '1', 22:45:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:45:20 INFO - 'PWD': '/builds/slave/test', 22:45:20 INFO - 'SHELL': '/bin/bash', 22:45:20 INFO - 'SHLVL': '1', 22:45:20 INFO - 'TERM': 'linux', 22:45:20 INFO - 'TMOUT': '86400', 22:45:20 INFO - 'USER': 'cltbld', 22:45:20 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', 22:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:45:20 INFO - '_': '/tools/buildbot/bin/python'} 22:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:45:20 INFO - Running setup.py (path:/tmp/pip-LxvUlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:45:20 INFO - Running setup.py (path:/tmp/pip-tGxVFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:45:20 INFO - Running setup.py (path:/tmp/pip-DohRhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:45:20 INFO - Running setup.py (path:/tmp/pip-hjhNiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:45:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:45:20 INFO - Running setup.py (path:/tmp/pip-o3A23p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:45:21 INFO - Running setup.py (path:/tmp/pip-X3Qh7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:45:21 INFO - Running setup.py (path:/tmp/pip-fWsPLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:45:21 INFO - Running setup.py (path:/tmp/pip-rvy1GZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:45:21 INFO - Running setup.py (path:/tmp/pip-hrP_1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:45:21 INFO - Running setup.py (path:/tmp/pip-7jmxQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:45:21 INFO - Running setup.py (path:/tmp/pip-8U7ulS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:45:21 INFO - Running setup.py (path:/tmp/pip-tJyqdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:45:21 INFO - Running setup.py (path:/tmp/pip-HDiU2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:45:21 INFO - Running setup.py (path:/tmp/pip-xWNxwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:45:21 INFO - Running setup.py (path:/tmp/pip-gV5DDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:45:21 INFO - Running setup.py (path:/tmp/pip-XJgQL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:45:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:45:21 INFO - Running setup.py (path:/tmp/pip-TnsnhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:45:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:45:21 INFO - Running setup.py install for manifestparser 22:45:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:45:22 INFO - Running setup.py install for mozcrash 22:45:22 INFO - Running setup.py install for mozdebug 22:45:22 INFO - Running setup.py install for mozdevice 22:45:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:45:22 INFO - Running setup.py install for mozfile 22:45:22 INFO - Running setup.py install for mozhttpd 22:45:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:45:22 INFO - Running setup.py install for mozinfo 22:45:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:45:22 INFO - Running setup.py install for mozInstall 22:45:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:45:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:45:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:45:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:45:22 INFO - Running setup.py install for mozleak 22:45:22 INFO - Running setup.py install for mozlog 22:45:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:45:22 INFO - Running setup.py install for moznetwork 22:45:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:45:23 INFO - Running setup.py install for mozprocess 22:45:23 INFO - Running setup.py install for mozprofile 22:45:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:45:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:45:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:45:23 INFO - Running setup.py install for mozrunner 22:45:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:45:23 INFO - Running setup.py install for mozscreenshot 22:45:23 INFO - Running setup.py install for moztest 22:45:23 INFO - Running setup.py install for mozversion 22:45:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:45:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:45:23 INFO - Cleaning up... 22:45:23 INFO - Return code: 0 22:45:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:45:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:45:23 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 0x18471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb77a0>, '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 0x1bb86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', '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 22:45:23 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 22:45:23 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 22:45:23 INFO - Using env: {'DISPLAY': ':0', 22:45:23 INFO - 'HOME': '/home/cltbld', 22:45:23 INFO - 'LANG': 'en_US.UTF-8', 22:45:23 INFO - 'LANGUAGE': 'en_US:en', 22:45:23 INFO - 'LOGNAME': 'cltbld', 22:45:23 INFO - 'MAIL': '/var/mail/cltbld', 22:45:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:45:23 INFO - 'MOZ_NO_REMOTE': '1', 22:45:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:45:23 INFO - 'NO_EM_RESTART': '1', 22:45:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:45:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:45:23 INFO - 'PWD': '/builds/slave/test', 22:45:23 INFO - 'SHELL': '/bin/bash', 22:45:23 INFO - 'SHLVL': '1', 22:45:23 INFO - 'TERM': 'linux', 22:45:23 INFO - 'TMOUT': '86400', 22:45:23 INFO - 'USER': 'cltbld', 22:45:23 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', 22:45:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:45:23 INFO - '_': '/tools/buildbot/bin/python'} 22:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:45:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:45:23 INFO - Running setup.py (path:/tmp/pip-ALgSmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:45:24 INFO - Running setup.py (path:/tmp/pip-LUBCkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:45:24 INFO - Running setup.py (path:/tmp/pip-4Tqvfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:45:24 INFO - Running setup.py (path:/tmp/pip-NZNp2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:45:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:45:24 INFO - Running setup.py (path:/tmp/pip-2yXzMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:45:24 INFO - Running setup.py (path:/tmp/pip-ui7l1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:45:24 INFO - Running setup.py (path:/tmp/pip-X_ypxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:45:24 INFO - Running setup.py (path:/tmp/pip-k2Q4VZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:45:24 INFO - Running setup.py (path:/tmp/pip-O0eLPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:45:24 INFO - Running setup.py (path:/tmp/pip-8PKDGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:45:24 INFO - Running setup.py (path:/tmp/pip-TjiQD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:45:24 INFO - Running setup.py (path:/tmp/pip-XLjVPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:45:24 INFO - Running setup.py (path:/tmp/pip-8N8_dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:45:24 INFO - Running setup.py (path:/tmp/pip-Cw0zq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:45:24 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)) 22:45:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:45:24 INFO - Running setup.py (path:/tmp/pip-2IUFHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:45:25 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)) 22:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:45:25 INFO - Running setup.py (path:/tmp/pip-ReS4ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:45:25 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)) 22:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:45:25 INFO - Running setup.py (path:/tmp/pip-9upKK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:45:25 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)) 22:45:25 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)) 22:45:25 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)) 22:45:25 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)) 22:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:45:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:45:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:45:26 INFO - Downloading blessings-1.6.tar.gz 22:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:45:26 INFO - Installing collected packages: blessings 22:45:26 INFO - Running setup.py install for blessings 22:45:26 INFO - Successfully installed blessings 22:45:26 INFO - Cleaning up... 22:45:26 INFO - Return code: 0 22:45:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:45:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:45:26 INFO - Reading from file tmpfile_stdout 22:45:26 INFO - Current package versions: 22:45:26 INFO - argparse == 1.2.1 22:45:26 INFO - blessings == 1.6 22:45:26 INFO - blobuploader == 1.2.4 22:45:26 INFO - docopt == 0.6.1 22:45:26 INFO - functools32 == 3.2.3-2 22:45:26 INFO - jsonschema == 2.5.1 22:45:26 INFO - manifestparser == 1.1 22:45:26 INFO - mozInstall == 1.12 22:45:26 INFO - mozcrash == 1.0 22:45:26 INFO - mozdebug == 0.1 22:45:26 INFO - mozdevice == 0.51 22:45:26 INFO - mozfile == 1.2 22:45:26 INFO - mozhttpd == 0.7 22:45:26 INFO - mozinfo == 0.9 22:45:26 INFO - mozleak == 0.1 22:45:26 INFO - mozlog == 3.4 22:45:26 INFO - moznetwork == 0.27 22:45:26 INFO - mozprocess == 0.25 22:45:26 INFO - mozprofile == 0.28 22:45:26 INFO - mozrunner == 6.13 22:45:26 INFO - mozscreenshot == 0.1 22:45:26 INFO - mozsystemmonitor == 0.3 22:45:26 INFO - moztest == 0.8 22:45:26 INFO - mozversion == 1.4 22:45:26 INFO - psutil == 3.1.1 22:45:26 INFO - requests == 1.2.3 22:45:26 INFO - wsgiref == 0.1.2 22:45:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:45:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:45:26 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 0x18471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb77a0>, '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 0x1bb86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', '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 22:45:26 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 22:45:26 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 22:45:26 INFO - Using env: {'DISPLAY': ':0', 22:45:26 INFO - 'HOME': '/home/cltbld', 22:45:26 INFO - 'LANG': 'en_US.UTF-8', 22:45:26 INFO - 'LANGUAGE': 'en_US:en', 22:45:26 INFO - 'LOGNAME': 'cltbld', 22:45:26 INFO - 'MAIL': '/var/mail/cltbld', 22:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:45:26 INFO - 'MOZ_NO_REMOTE': '1', 22:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:45:26 INFO - 'NO_EM_RESTART': '1', 22:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:45:26 INFO - 'PWD': '/builds/slave/test', 22:45:26 INFO - 'SHELL': '/bin/bash', 22:45:26 INFO - 'SHLVL': '1', 22:45:26 INFO - 'TERM': 'linux', 22:45:26 INFO - 'TMOUT': '86400', 22:45:26 INFO - 'USER': 'cltbld', 22:45:26 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', 22:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:45:26 INFO - '_': '/tools/buildbot/bin/python'} 22:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:45:26 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)) 22:45:26 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)) 22:45:26 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)) 22:45:26 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)) 22:45:26 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)) 22:45:26 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)) 22:45:26 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)) 22:45:26 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)) 22:45:26 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)) 22:45:26 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 22:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:45:28 INFO - Downloading marionette_driver-1.4.0.tar.gz 22:45:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 22:45:28 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)) 22:45:28 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)) 22:45:28 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)) 22:45:28 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)) 22:45:28 INFO - Installing collected packages: marionette-driver 22:45:28 INFO - Running setup.py install for marionette-driver 22:45:28 INFO - Successfully installed marionette-driver 22:45:28 INFO - Cleaning up... 22:45:28 INFO - Return code: 0 22:45:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:45:28 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')]} 22:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:45:28 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')]} 22:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:45:28 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 0x18471f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a14a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bba5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb77a0>, '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 0x1bb86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8b30>, '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': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', '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 22:45:28 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 22:45:28 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 22:45:28 INFO - Using env: {'DISPLAY': ':0', 22:45:28 INFO - 'HOME': '/home/cltbld', 22:45:28 INFO - 'LANG': 'en_US.UTF-8', 22:45:28 INFO - 'LANGUAGE': 'en_US:en', 22:45:28 INFO - 'LOGNAME': 'cltbld', 22:45:28 INFO - 'MAIL': '/var/mail/cltbld', 22:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:45:28 INFO - 'MOZ_NO_REMOTE': '1', 22:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:45:28 INFO - 'NO_EM_RESTART': '1', 22:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:45:28 INFO - 'PWD': '/builds/slave/test', 22:45:28 INFO - 'SHELL': '/bin/bash', 22:45:28 INFO - 'SHLVL': '1', 22:45:28 INFO - 'TERM': 'linux', 22:45:28 INFO - 'TMOUT': '86400', 22:45:28 INFO - 'USER': 'cltbld', 22:45:28 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', 22:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:45:28 INFO - '_': '/tools/buildbot/bin/python'} 22:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:45:28 INFO - Cleaning up... 22:45:28 INFO - Return code: 0 22:45:28 INFO - Running post-action listener: _resource_record_post_action 22:45:28 INFO - Running post-action listener: _start_resource_monitoring 22:45:28 INFO - Starting resource monitoring. 22:45:28 INFO - [mozharness: 2017-05-26 05:45:28.540258Z] Finished create-virtualenv step (success) 22:45:28 INFO - [mozharness: 2017-05-26 05:45:28.540765Z] Running install step. 22:45:28 INFO - Running pre-action listener: _resource_record_pre_action 22:45:28 INFO - Running main action method: install 22:45:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:45:28 INFO - Reading from file tmpfile_stdout 22:45:28 INFO - Detecting whether we're running mozinstall >=1.0... 22:45:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:45:28 INFO - Reading from file tmpfile_stdout 22:45:28 INFO - Output received: 22:45:28 INFO - Usage: mozinstall [options] installer 22:45:28 INFO - Options: 22:45:28 INFO - -h, --help show this help message and exit 22:45:28 INFO - -d DEST, --destination=DEST 22:45:28 INFO - Directory to install application into. [default: 22:45:28 INFO - "/builds/slave/test"] 22:45:28 INFO - --app=APP Application being installed. [default: firefox] 22:45:28 INFO - mkdir: /builds/slave/test/build/application 22:45:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:45:44 INFO - Reading from file tmpfile_stdout 22:45:44 INFO - Output received: 22:45:44 INFO - /builds/slave/test/build/application/firefox/firefox 22:45:44 INFO - Running post-action listener: _resource_record_post_action 22:45:44 INFO - [mozharness: 2017-05-26 05:45:44.358120Z] Finished install step (success) 22:45:44 INFO - [mozharness: 2017-05-26 05:45:44.358396Z] Running run-tests step. 22:45:44 INFO - Running pre-action listener: _resource_record_pre_action 22:45:44 INFO - Running main action method: run_tests 22:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:45:44 INFO - Python 2.7.3 22:45:44 INFO - Return code: 0 22:45:44 INFO - grabbing minidump binary from tooltool 22:45:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:45:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bb77a0>, '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 0x1bb86a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bb8b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:45:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:45:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:45:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:45:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:45:44 INFO - Return code: 0 22:45:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:45:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:45:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:45:44 INFO - ENV: RUST_BACKTRACE is now 1 22:45:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:45:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:45:44 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/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 22:45:44 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/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-087 --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 22:45:44 INFO - Using env: {'DISPLAY': ':0', 22:45:44 INFO - 'HOME': '/home/cltbld', 22:45:44 INFO - 'LANG': 'en_US.UTF-8', 22:45:44 INFO - 'LANGUAGE': 'en_US:en', 22:45:44 INFO - 'LOGNAME': 'cltbld', 22:45:44 INFO - 'MAIL': '/var/mail/cltbld', 22:45:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:45:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:45:44 INFO - 'MOZ_NO_REMOTE': '1', 22:45:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:45:44 INFO - 'NO_EM_RESTART': '1', 22:45:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:45:44 INFO - 'PWD': '/builds/slave/test', 22:45:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:45:44 INFO - 'RUST_BACKTRACE': '1', 22:45:44 INFO - 'SHELL': '/bin/bash', 22:45:44 INFO - 'SHLVL': '1', 22:45:44 INFO - 'TERM': 'linux', 22:45:44 INFO - 'TMOUT': '86400', 22:45:44 INFO - 'USER': 'cltbld', 22:45:44 INFO - 'XDG_SESSION_COOKIE': 'ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756', 22:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:45:44 INFO - '_': '/tools/buildbot/bin/python'} 22:45:44 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/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-087', '--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 22:45:44 INFO - mozversion application_buildid: 20170526051207 22:45:44 INFO - mozversion application_changeset: 5d6fe59a9a5dfd2d381d2cdfdc968d3305b417cf 22:45:44 INFO - mozversion application_display_name: Nightly 22:45:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:45:44 INFO - mozversion application_name: Firefox 22:45:44 INFO - mozversion application_remotingname: firefox 22:45:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:45:44 INFO - mozversion application_vendor: Mozilla 22:45:44 INFO - mozversion application_version: 55.0a1 22:45:44 INFO - mozversion platform_buildid: 20170526051207 22:45:44 INFO - mozversion platform_changeset: 5d6fe59a9a5dfd2d381d2cdfdc968d3305b417cf 22:45:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:45:44 INFO - mozversion platform_version: 55.0a1 22:45:44 INFO - using testdate: 1495777544 22:45:44 INFO - actual date: 1495777544 22:45:44 INFO - starting webserver on 'localhost:60239' 22:45:44 INFO - SUITE-START | Running 2 tests 22:45:44 INFO - TEST-START | dromaeo_css 22:45:44 INFO - operating with platform_type : linux_ 22:45:44 INFO - Initialising browser for dromaeo_css test... 22:45:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60239/getInfo.html -profile /tmp/tmpgoYzUT/profile 22:45:44 INFO - TEST-INFO | started process 6697 (/builds/slave/test/build/application/firefox/firefox http://localhost:60239/getInfo.html) 22:46:19 INFO - TEST-INFO | 6697: killed by SIGTERM 22:46:19 INFO - Browser initialized. 22:46:19 INFO - Running cycle 1/1 for dromaeo_css test... 22:46:19 INFO - TEST-INFO | started process 6894 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgoYzUT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:46:31 INFO - PID 6894 | RSS: Main: 168996864 22:46:31 INFO - PID 6894 | 22:49:35 INFO - PID 6894 | Cycle 1(1): loaded http://localhost:60239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60239/tests/dromaeo/cssquery-ext.html) 22:49:37 INFO - PID 6894 | RSS: Main: 168472576 22:49:37 INFO - PID 6894 | 22:52:39 INFO - PID 6894 | Cycle 1(1): loaded http://localhost:60239/tests/dromaeo/cssquery-ext.html (next: http://localhost:60239/tests/dromaeo/cssquery-jquery.html) 22:52:40 INFO - PID 6894 | RSS: Main: 172318720 22:52:40 INFO - PID 6894 | 22:55:41 INFO - PID 6894 | Cycle 1(1): loaded http://localhost:60239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60239/tests/dromaeo/cssquery-mootools.html) 22:55:42 INFO - PID 6894 | RSS: Main: 170991616 22:55:42 INFO - PID 6894 | 22:58:44 INFO - PID 6894 | Cycle 1(1): loaded http://localhost:60239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60239/tests/dromaeo/cssquery-prototype.html) 22:58:44 INFO - PID 6894 | RSS: Main: 176664576 22:58:44 INFO - PID 6894 | 23:01:47 INFO - PID 6894 | Cycle 1(1): loaded http://localhost:60239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60239/tests/dromaeo/cssquery-yui.html) 23:01:48 INFO - PID 6894 | RSS: Main: 173948928 23:01:48 INFO - PID 6894 | 23:04:50 INFO - PID 6894 | Cycle 1(1): loaded http://localhost:60239/tests/dromaeo/cssquery-yui.html (next: http://localhost:60239/tests/dromaeo/cssquery-dojo.html) 23:04:50 INFO - PID 6894 | RSS: Main: 170860544 23:04:50 INFO - PID 6894 | 23:04:50 INFO - PID 6894 | __start_tp_report 23:04:50 INFO - PID 6894 | _x_x_mozilla_page_load 23:04:50 INFO - PID 6894 | _x_x_mozilla_page_load_details 23:04:50 INFO - PID 6894 | |i|pagename|runs| 23:04:50 INFO - PID 6894 | |0;dojo.html;2730.781537477002;2750.573661082533;2769.473799978004;2788.735070168333;2790.3861150546886;5248.21276808478;5298.4701529847;5315.202719592063;5370.650907690997;5372.2210279509445;5323.893522129555;5331.866703332409;5336.8132115375965;5411.675299482034;5415.214793854889;4446.955530444687;4671.322658214557;4724.126036683216;4758.072175925696;4765.42814862217;4787.13831510328;4806.495317991596;4841.782119804618;4849.151398505265;4872.366592343008;4641.930371044403;4702.670813043088;4709.505501922317;4759.000609871931;4765.857024289242;4763.809447622091;4771.045790841846;4793.400824896888;4803.759812009385;4822.517748225149;4698.1778188816825;4702.788374523155;4710.1286262041285;4722.126406614753;4722.456917454502;5190.948090519084;5366.91949620756;5378.435264297271;5398.703071331075;5417.51242388187;5706.543476521868;5721.399253078408;5758.971205143989;5768.10594357871;5785.190073389729;5825.7378417971295;5825.79609713658;5828.125781132821;5850.76596936122;5883.411658834125;5399.299220745453;5408.378036525771;5409.377921538995;5415.675059496442;5425.755840987165;5800.100984347433;5863.296404431496;5878.647281163144;5900.1149827526215;5965.522758179335;5702.401247868997;5710.057840456361;5713.885722285531;5742.425757424307;5765.990951583456;5637.915431268534;5729.1119876419225;5732.684702341411;5750.942490575041;5753.712314384347;5658.886822263532;5734.77060917567;5770.16332631766;5771.8557036074435;5775.797847075332;5730.19777231188;5736.311642602915;5770.740316685759;5793.8841223175305;5807.041838096667;4717.551832575899;4723.291506274018;4743.478217396084;4744.7627618618935;4786.042791441726;4010.8195131219163;4110.0752330725345;4111.075008123208;4120.381942708617;4138.79306034697;4806.831760888352;4812.51874812516;4829.372181616367;4895.216765317532;4907.852764417074;5808.506276966421;5809.622374545641;5811.651300921958;5814.3604203538425;5840.269966254218;4855.393075865517;4857.392825896763;4860;4866.926996095061;4908.754562271872;5024.949750502521;5080.695158290514;5082;5137.6660517066275;5145.408278047998;5317.20241963693;5317.734113294242;5318.468153184651;5322.441143680013;5361.785528578813;5705.286839144941;5772.509336706427;5789;5791.189233507228;5794.855128621818;5297.549708274686;5298.867528311823;5331.893362132658;5358.33020872391;5373.838784836461;5634.042212823748;5657.4059723728415;5673.8865222694485;5675.716214189191;5676.716164191691;5688.317401911797;5759.596828221985;5795.420457954171;5810.186573879745;5824.854378640568;5549.7780088796;5592.245046918777;5611.242482264842;5676.68778217202;5694.487496125369;5603.831885043455;5618.831435056954;5629.408912064338;5638.407967163553;5672.602917795714;5525.336959564717;5529.4470552945995;5557.638753481011;5558.138488534284;5562.388137304974;5500.064988951808;5621.128725047624;5654.349749778664;5719.370869204467;5744.138379243147;5482.23248745168;5492.450754924475;5493.642913210629;5528.419515950928;5550.222968784293 23:04:50 INFO - PID 6894 | |1;ext.html;650.6519012328405;705.8623568404162;719.2843121094512;1165.5687395663606;1198.6224339333114;33394.33211335775;35551.2889742205;35658.2868342633;35690.821545892235;35735.642643573556;33833.830830845814;34028;34109.65890341096;34111.14722131948;34133;6333.778317758879;6451.935480645204;6560.507961902853;6727.932720672804;6733.02371156182;6707.899381509281;6785;6789.049533065375;6789.728410863584;6791.864162716743;6718.529702920798;6739.326067393271;6748.527603067787;6793.015012823138;6810.455163586901;6753.561018533805;6760.357766012221;6769.05233267343;6770.255271920085;6788.185417749853;6601.537892347537;6671.166104236971;6674.766383176614;6700.430463410616;6719.428848547879;32629.83685081583;32657.6734232657;32666.6733332666;32669.836650816833;32896.17759556006;2983.5524671299477;2984.0451055662197;3010;3026.0770465008163;3028.757699384044;24577.754222457726;24631.753682463124;24655.506889862103;24686.753132468624;24932.750672493225;2841.7300356466103;2854.943670841802;2871.784616153797;2892.956605650917;2898.840563768992;148963.25518372338;149394;149795;156172;160411;38511.422328665096;39122;39146.804265978484;39161.608383915795;39192.804035979636;40673;40704;40745.38881916774;44249;44988.55011449909;11670.358130302915;11697;11756.1182911282;11812.055035597132;11817.586384476503;9257.953710231406;9267.860982085274;9291.070892910655;9322.161005509537;9330.58012389444;12498.750024999448;12570.308633025088;12649.30428826405;12656.557020504239;12733.490660373667;5323.254744335796;5350.38470575881;5368.355797304349;5486.698231597221;5512.80705175317;845.7843249971218;881.8060026794095;882.223643193998;896.8430524658158;911.4349103555705;21044.530070708042;21874.89062554677;21914.23300184486;21917.342479725634;21947.67078493792;965.8840939087354;967.1392460709974;978.6574698855486;993.2054356514759;1000.7548150703125;11296.265742726697;11348.489317980711;11387.430628468543;11420.486078126503;11659.358735269472;174703;175811;175832;175913;176198.11900940412;41442;41772.79113604473;42031.57968420338;42045.36931945962;42140;1220.1824777399163;1244.147758785235;1247.0335489995325;1247.3950134184913;1259.4080782032431;19932.402027939184;20326.59346813085;20740.688889666366;20836.68744968857;21142.894285528473;29334.97327593524;29550.852245738635;29592.556111657912;29653.258668532595;29862.25344366408;150765;151010;151288;151589;152200;28647.14058578246;28789.42421151607;29040.564391534568;29141.317443098393;29230;35313.82343088268;35370.646293537764;35373.469397958535;35491.64508354987;35667.46498802572;25283.11509097173;26342.34144146335;26577.867110664323;26690.866545667148;26979.86510067437;26706.46587068209;26914.865425672746;27328.72671273262;27403;27476.862615686794;29870.701292987662;29912.85043574768;29969.850150749106;30237.09288721254;30339;25235.369115772253;25718.61422078633;25896.92824573992;26930.46139077168;27185.04852330159;18903.621927561097;21632.89183554135;21795;21921.232756853435;22095.33713988583 23:04:50 INFO - PID 6894 | |2;jquery.html;409.61291579457423;415.7006954992408;420.20161692783705;427.7946585638893;445.54331809894876;14635.487757928448;15211.239438028082;17239.913800430997;17594.560135996606;17609.911950440244;18689;18827;18864.151113199903;19034.524136896584;19050;5313.601479889005;5336.706481143545;5505.394406615269;5521.089020311644;5532.3914369419335;5282.102042652758;5420.159875219328;5431.34823821142;5446.482584154499;5459.235707001023;4810.20631595788;5254.763535640886;5265.131253343213;5280.287161233223;5408.91886621701;5181.844544663666;5186.92219616706;5190.896182076375;5227.5295223429885;5237.711925844077;4738.407699037621;4745.8576242712425;4787.2101103318255;4827.203511420611;4849.369581954358;21745.456363590878;21813.23653672114;22145.89270536483;22171.66742498864;22205;1585.651156745514;1636.4845073801832;1637.4023481429313;1639.7868277124016;1643.4248013195406;14370.640733981629;14551.708965820624;14682.853171468363;14824.777628335583;14908.552743417715;1991;2031.1672214392177;2077.387170784622;2082.3440616206;2094.7381577302835;89928.55035724779;90024.54987725084;93188.06811931862;93595.53202233945;94393.52803236009;10933.726656833484;10989.285696429706;11015.724606884733;11065.723356916142;11404.94297528507;15521.922390387976;15661.451849185223;15676.137812420198;15708.842911570966;15746.527604171893;7391.889121663179;7523.962380188064;7649.426293028045;7661.157272699998;7683.884741728879;6808.761693340709;6863.794086177422;7013.789586312419;7022.789316320519;7029.22678505364;6962.860742785218;6980.232174460907;7073.115860517435;7116.288371162842;7164.391026762679;2052.702358158059;2057.8765274083603;2077.8961051947645;2078.490769761418;2172.239716099353;817.3175398542284;831.4138532334689;843.1357858195277;869.5956380283072;883.6597909804772;16936.745948810778;17039.744403833953;17378.47864564065;17541.386051488138;17597;853.8847255620536;860.8278344331034;871.4205053639259;880.7665968518347;882.5454890731279;8935.865962010575;9157.130072643089;9461.785689409933;9479.90520094804;9491.66779162726;379279;381241;382160;389396;394019;75870.62064689641;77063;77312.61343693246;77694.22305776984;81077.18922810814;1048.4286064095086;1050.1965996013057;1094.0973696700255;1100.1528822806395;1100.9064229540418;17260.223289952235;17605.471835844946;18273.908630457296;18274.45176644703;18278;39469.40795888122;39638.801805990784;40156.99215039295;40597.39103913503;41031.79484102561;49740.50259497359;49919.251211232586;50244;51072.23391649054;51943.74028129986;8221.83556328882;8251.546164960984;8429.536375499407;8463.830723385621;8668;11647.708807279885;12031.879681203076;12284.201526900722;12372.07209459312;12707.301098439304;10397.636082737068;10408.739781505523;10678.519466624177;10732.624358147428;11083;9458.763530911783;9480.431174129575;9558.139767420966;9585.952070239884;9837.68814328618;10406.271560990657;10633.787324253317;10833;10846;11125.332480051224;8225.79435514117;8398.83202335962;8484.830303394021;8596.312295016509;8644.438111522983;10526;10701.839472407764;10792.352458852494;10912.399818009768;11167.1066314693 23:04:50 INFO - PID 6894 | |3;mootools.html;1282.621626620147;1330.580867026886;1334.319497056501;1335.3189873164683;1351.837779466464;10438.164946804256;10819.080378167855;10821.13430925526;11004.39475828829;11296.491657875395;11106.6112686056;11251.493682784274;11304.37825919574;11313.377764222965;11341.943290283538;2262.9321120366376;2292.2091878302044;2293.5298263855952;2305.481266714984;2313.8264630152808;2172.543765809174;2208.116753298685;2226.599212141814;2236.3067449090836;2238;2037.1342179573621;2067.8138967492923;2072.492239401349;2074.52285974226;2090.4982804126976;2127.4043267885017;2141.4646338415396;2145.7854214578574;2149.355193441961;2158.4603849037585;2086.113401804227;2101.884396358215;2245.315178870444;2250.8762018089;2258.1306197114063;10781.946090269577;10885.074768644674;10905.291156074829;10924.726881827939;10943.124550035978;5710.14347847822;5916.674582897939;5931.64410135389;5947.464728174442;5951.345352011275;3391.6608339166132;3436.914077148066;3491.738119641037;3499.772514786531;3534.3991521441417;1072.495926914349;1074.3607553505651;1080.4543705428787;1083.1226706367868;1103.779244151165;15531.145786981711;15563.377464901503;15596.22018899062;15632.983856049434;15725;4768.9523104769205;4846.127697014571;4946.332245146859;4990.126727822617;5119.846404607868;11171.83242251367;11236;11243.381614011145;11261.887381126084;11285.435728213557;5672.801451949162;5782.826515204551;5800.39095894925;5810.389909059572;5811.4479124483105;5191.32512773337;5342.145256758978;5356.116240820221;5356.116240820299;5371.650842695212;3726.571444283888;3770.679492243135;3775.1505911169766;3861.961380386216;3895.7662540247675;1106.878243393226;1109.367660433545;1110.2339385823757;1112.9387883666477;1113.6881673131536;711.2958171410266;729.1614643160408;733.3436574266109;734.302412707919;739.8372358081214;5791.276090488689;5882.382349853289;5890.617109887844;5928.584999050111;5988.101784732238;519.8856251624636;547.9424660410599;563.7716724726492;564.4863174511175;575.8617931696363;3630.909227269339;4222.683298752606;4258.978705106455;4303.978480107579;4330.307150855848;13331.133476324008;14355.712885742227;14362.353694083791;14369.425222991173;14389.208593527248;13846;13973.930130349283;14069;14108.788368174486;14126;7255.383292420098;7655.540667559964;7658.693652253959;7785.221477852169;7968;6266.404691554295;6358.745650173942;6565;6567.507436942153;6878.7248510059035;12163.81754273669;12216.26702397859;13090.607281781562;13497.852682521703;13511.189328639919;12307.076969227164;12334.321612311409;12335.50657973707;12482;12563.246205227715;8083.070446898682;8282.296004839656;8298.336133109458;8311.875321870297;8332.625031873458;9341.626334946526;9538.23694104456;9743.951280243553;9805.166560842123;9998.850017249602;8336.916630833857;8458.788530286793;8471.618777155167;8479.19447652472;8512.489250644981;7542.321191092828;7608.353289970414;7637.427192960439;7873.645685944261;7896.32881205104;7479.139898911477;7541.057367829021;7551.320381165721;7563.168051514219;7587.810304742426;5629.605927585029;5678.74445649955;5682.289713785777;5785.884282314414;5921.437463440966;5301.469853014668;5305.761240744098;5333.599980001593;5403.675779453245;5462.91805622908 23:04:50 INFO - PID 6894 | |4;prototype.html;352.82711471379014;352.9047157267538;359.3998023301087;366.27477594363165;379.92211596622695;5371.543418809396;5558.583106267031;5575.414581468943;5584.162375643656;5662.886742265157;5349.8127565535215;5422;5424.755885985131;5429.619926605139;5439.3200849893765;4063.08580569371;4067.8983025424304;4067.9626695192683;4069.0844559973916;4069.4302797608357;3984.940225896614;4096.242195193884;4098.323776576861;4104.220198162355;4109.301418758818;4101.241270364977;4104.117614712836;4105.322621767405;4109.363048727452;4110.91778164438;4081.163476435616;4085.632293093606;4092.283850326196;4100.323446631302;4105.5894410559;3555.8044307563073;3558.9110272243142;3561.5726112866364;3576.3920133577094;3587.7488575799703;5261.7369131543655;5368.677879327252;5374.522006448219;5376.758045887906;5383.4616538346245;4718.646101542364;4821.373221481185;4858.772867605171;4862.954464790052;4870.902581948377;5612.326520817487;5719.19931209631;5730.398308177665;5777.740001699934;5788.768449262025;4337.501187363462;4392.099619578011;4392.363107349416;4400.823967041314;4430.202563538562;5951.49412299955;6118.938810611926;6172.598781079216;6174.660393678346;6187.679620142447;4248.426462427533;4268.637165840938;4274.294741367639;4280.186764514732;4285.742855428684;4297.183535128315;4306.729514793081;4307.978460107742;4319.762413067311;4339.674524410681;4901.754912254373;4923.729194894315;4929.7535123244415;5079.97460012705;5101.846944591668;5849.093390524476;5883.470487656132;5897.64614123154;5899.882002359929;5903.468687818031;1562.874970002397;1586.444744339472;1597.225345707331;1599.6083407435374;1606.4939544043589;1138.2544433396138;1145.135422755814;1152.9335364787537;1162.5872815150499;1163.988360116405;5003.974980125076;5011.223260394645;5019.598432125421;5040.092783299041;5041.571466425395;5981.760729570856;6018.428249316308;6023.6385816851125;6025.397460253939;6028.216331876915;4890.388701412324;4896.11869863428;4916.631252655993;4931.18635425158;4946.777395017233;3114.256016630694;3144.795588286754;3148.779585428998;3158.9684103159134;3161.1148878314107;5302.549283310962;5424.430434804368;5445.945540544623;5455.5908306876345;5481.780728770885;6144.723487443076;6146.446819786241;6157.476614487729;6164.137020817089;6166.784162554289;5483.945160548423;5502.284702988666;5507.504324610804;5511.972440137773;5520.7703493456775;5877.794277200449;5928.140419639214;5963.880722385615;5979.252593425822;5982.205338398376;5741.971290143522;5894.347543605309;5940.702964851826;5952.613080149777;5966.194563734014;5461;5547.33431988164;5548.805791797267;5582.469665381782;5586.944130558642;3999.340108882002;4003.939940900947;4007.1384652299894;4059.837606495707;4066.7966601669204;6048.546359023003;6051.273847138372;6062.787802426894;6068.544859135671;6089.147519347383;5757.971210143923;5835.620684655484;5840.729191652688;5858.384869588632;5891.440313170242;5783.624064435799;5841.912371314349;5858.121281807763;5862.472377486047;5878.735456904364;5690.317161940594;5734.455226753452;5759.94240057594;5784.248047753765;5790.710464476843;5637.295338082739;5829.854253643523;5860.531157507475;5873.765049397976;5909.581700391961;5702.971485142548;5730.5129064030025;5732.34078081026;5743.885122297447;5757.453041961007 23:04:50 INFO - PID 6894 | |5;yui.html;743.9218882017385;752.7478294771252;767.7121079595148;772.6021099133947;785.4972817396865;13752.518661846838;14360;14478.855211447883;15695.84304156958;16971.236294366754;16062.116583587898;16121.919390403062;16165;16295.02229866206;16321.10233937136;616.7687117331001;868.8827008353886;899.2356496977582;899.7885496908222;900.2168113741054;658.2627457247866;856.4304737349655;873.7116751472031;899.8200359928007;899.941503802254;942.8821397325335;943.170010390855;944.3767113704956;950.8478643417054;951.3816019587255;933.9906600934039;935.4901578639658;937.8968313485511;940.0975063938627;941.5292353823088;689.7275576147443;689.7930620813786;690.4234963805178;691.7129391302603;691.830501527124;14494.202818844959;14577.562673119823;14669;14771;14774.48289309869;16194.676106477804;16572.66854662912;16594.08732519711;16621.50135495937;16623.168841557872;12846.67883302925;13374.063815532916;13515;13539;13539.932300338534;2882.495563276439;2882.769378449719;2899.913002609925;2903.129061281607;2909.418116376733;88760.11239887647;88812.5559372199;88925;91734.99999999933;92825.53587232088;12563.246205227715;13023.348832558335;13116.540921067908;13160.210387376788;13199.802002969964;23937.162199322942;24012.759872401402;24123.276301710976;24236;24290.635640465407;6266.968665156645;6374.617522948638;6380.904286435707;6390.424861762371;6395.072714456378;2725.7001729809704;2805;2847.7721782257368;2876.0652787843615;2882.30824602094;3919.941200881989;4035.2534781065597;4035.616616421435;4040.777757223381;4045.7977101144825;757.6552668535803;792.2671528835804;795.7055889320989;798.4570492065451;799.3445374792731;575.0999685492192;595.1905408644241;597.5100417657479;601.1823919469518;622.9937700623026;9570.47362395075;10246;10724.946375268073;10811.459427028618;11148.888511114947;566.9886602268014;582.0948425198771;582.14715441877;585.6603170161296;599.2928344553469;4605.838795642204;4735.266033764703;4743.0988112258565;4766.404199475066;4919.1883339248625;80436.59781701054;81800;81829;84535.577322113;85463.14536854676;76528;77143;77752;78071.60964195142;78152.21847781564;60313;60380;61283.08075378873;63953.36046639567;66463.66768166129;9720.75698107553;10179.38923664553;10238.283320167517;10279.17766578657;10566.788664226826;28129.296767580974;28391.858040709663;28478;28738.425231494835;29176.27059323534;34958.82520587381;35047.47428788519;35271.47092793559;35592.82203588966;36087.09782255465;13532.729345413234;13536.187828730308;13720.65698357549;13874.445022199;13876.236806975714;16147.75778363349;16215.270312836186;16297.103659298853;16453.91773041127;16649.3340266388;14990.100593964396;15029.624259393602;15076;15201.467948621745;15378.84621153774;14862.851371486147;14946.925265374039;15061.322240498985;15093.094414335175;15308.081515109128;12911.289879056741;12961.675958101123;12963.22220666763;13266.469341226242;13292.933535332262;9195.172434480928;9220;9319.767005824908;9433;9441.905580944378;10293.279470436997;10325.277230593787;10632.202584806017;10655.147588193082;10792.56829726802 23:04:50 INFO - PID 6894 | __end_tp_report 23:04:50 INFO - PID 6894 | __start_cc_report 23:04:50 INFO - PID 6894 | _x_x_mozilla_cycle_collect,331 23:04:50 INFO - PID 6894 | __end_cc_report 23:04:50 INFO - PID 6894 | __startTimestamp1495778690416__endTimestamp 23:04:50 INFO - PID 6894 | 23:04:50 INFO - PID 6894 | ------- Summary: start ------- 23:04:50 INFO - PID 6894 | Number of tests: 6 23:04:50 INFO - PID 6894 | 23:04:50 INFO - PID 6894 | [#0] dojo.html Cycles:165 Average:5262.68 Median:5415.68 stddev:631.93 (11.7%) stddev-sans-first:601.85 23:04:50 INFO - PID 6894 | Values: 2730.8 2750.6 2769.5 2788.7 2790.4 5248.2 5298.5 5315.2 5370.7 5372.2 5323.9 5331.9 5336.8 5411.7 5415.2 4447.0 4671.3 4724.1 4758.1 4765.4 4787.1 4806.5 4841.8 4849.2 4872.4 4641.9 4702.7 4709.5 4759.0 4765.9 4763.8 4771.0 4793.4 4803.8 4822.5 4698.2 4702.8 4710.1 4722.1 4722.5 5190.9 5366.9 5378.4 5398.7 5417.5 5706.5 5721.4 5759.0 5768.1 5785.2 5825.7 5825.8 5828.1 5850.8 5883.4 5399.3 5408.4 5409.4 5415.7 5425.8 5800.1 5863.3 5878.6 5900.1 5965.5 5702.4 5710.1 5713.9 5742.4 5766.0 5637.9 5729.1 5732.7 5750.9 5753.7 5658.9 5734.8 5770.2 5771.9 5775.8 5730.2 5736.3 5770.7 5793.9 5807.0 4717.6 4723.3 4743.5 4744.8 4786.0 4010.8 4110.1 4111.1 4120.4 4138.8 4806.8 4812.5 4829.4 4895.2 4907.9 5808.5 5809.6 5811.7 5814.4 5840.3 4855.4 4857.4 4860.0 4866.9 4908.8 5024.9 5080.7 5082.0 5137.7 5145.4 5317.2 5317.7 5318.5 5322.4 5361.8 5705.3 5772.5 5789.0 5791.2 5794.9 5297.5 5298.9 5331.9 5358.3 5373.8 5634.0 5657.4 5673.9 5675.7 5676.7 5688.3 5759.6 5795.4 5810.2 5824.9 5549.8 5592.2 5611.2 5676.7 5694.5 5603.8 5618.8 5629.4 5638.4 5672.6 5525.3 5529.4 5557.6 5558.1 5562.4 5500.1 5621.1 5654.3 5719.4 5744.1 5482.2 5492.5 5493.6 5528.4 5550.2 23:04:50 INFO - PID 6894 | 23:04:50 INFO - PID 6894 | [#1] ext.html Cycles:180 Average:30310.31 Median:29891.78 stddev:41415.35 (138.6%) stddev-sans-first:41471.65 23:04:50 INFO - PID 6894 | Values: 650.7 705.9 719.3 1165.6 1198.6 33394.3 35551.3 35658.3 35690.8 35735.6 33833.8 34028.0 34109.7 34111.1 34133.0 6333.8 6451.9 6560.5 6727.9 6733.0 6707.9 6785.0 6789.0 6789.7 6791.9 6718.5 6739.3 6748.5 6793.0 6810.5 6753.6 6760.4 6769.1 6770.3 6788.2 6601.5 6671.2 6674.8 6700.4 6719.4 32629.8 32657.7 32666.7 32669.8 32896.2 2983.6 2984.0 3010.0 3026.1 3028.8 24577.8 24631.8 24655.5 24686.8 24932.8 2841.7 2854.9 2871.8 2893.0 2898.8 148963.3 149394.0 149795.0 156172.0 160411.0 38511.4 39122.0 39146.8 39161.6 39192.8 40673.0 40704.0 40745.4 44249.0 44988.6 11670.4 11697.0 11756.1 11812.1 11817.6 9258.0 9267.9 9291.1 9322.2 9330.6 12498.8 12570.3 12649.3 12656.6 12733.5 5323.3 5350.4 5368.4 5486.7 5512.8 845.8 881.8 882.2 896.8 911.4 21044.5 21874.9 21914.2 21917.3 21947.7 965.9 967.1 978.7 993.2 1000.8 11296.3 11348.5 11387.4 11420.5 11659.4 174703.0 175811.0 175832.0 175913.0 176198.1 41442.0 41772.8 42031.6 42045.4 42140.0 1220.2 1244.1 1247.0 1247.4 1259.4 19932.4 20326.6 20740.7 20836.7 21142.9 29335.0 29550.9 29592.6 29653.3 29862.3 150765.0 151010.0 151288.0 151589.0 152200.0 28647.1 28789.4 29040.6 29141.3 29230.0 35313.8 35370.6 35373.5 35491.6 35667.5 25283.1 26342.3 26577.9 26690.9 26979.9 26706.5 26914.9 27328.7 27403.0 27476.9 29870.7 29912.9 29969.9 30237.1 30339.0 25235.4 25718.6 25896.9 26930.5 27185.0 18903.6 21632.9 21795.0 21921.2 22095.3 23:04:50 INFO - PID 6894 | 23:04:50 INFO - PID 6894 | [#2] jquery.html Cycles:180 Average:25468.97 Median:20723.75 stddev:64134.53 (309.5%) stddev-sans-first:64286.85 23:04:50 INFO - PID 6894 | Values: 409.6 415.7 420.2 427.8 445.5 14635.5 15211.2 17239.9 17594.6 17609.9 18689.0 18827.0 18864.2 19034.5 19050.0 5313.6 5336.7 5505.4 5521.1 5532.4 5282.1 5420.2 5431.3 5446.5 5459.2 4810.2 5254.8 5265.1 5280.3 5408.9 5181.8 5186.9 5190.9 5227.5 5237.7 4738.4 4745.9 4787.2 4827.2 4849.4 21745.5 21813.2 22145.9 22171.7 22205.0 1585.7 1636.5 1637.4 1639.8 1643.4 14370.6 14551.7 14682.9 14824.8 14908.6 1991.0 2031.2 2077.4 2082.3 2094.7 89928.6 90024.5 93188.1 93595.5 94393.5 10933.7 10989.3 11015.7 11065.7 11404.9 15521.9 15661.5 15676.1 15708.8 15746.5 7391.9 7524.0 7649.4 7661.2 7683.9 6808.8 6863.8 7013.8 7022.8 7029.2 6962.9 6980.2 7073.1 7116.3 7164.4 2052.7 2057.9 2077.9 2078.5 2172.2 817.3 831.4 843.1 869.6 883.7 16936.7 17039.7 17378.5 17541.4 17597.0 853.9 860.8 871.4 880.8 882.5 8935.9 9157.1 9461.8 9479.9 9491.7 379279.0 381241.0 382160.0 389396.0 394019.0 75870.6 77063.0 77312.6 77694.2 81077.2 1048.4 1050.2 1094.1 1100.2 1100.9 17260.2 17605.5 18273.9 18274.5 18278.0 39469.4 39638.8 40157.0 40597.4 41031.8 49740.5 49919.3 50244.0 51072.2 51943.7 8221.8 8251.5 8429.5 8463.8 8668.0 11647.7 12031.9 12284.2 12372.1 12707.3 10397.6 10408.7 10678.5 10732.6 11083.0 9458.8 9480.4 9558.1 9586.0 9837.7 10406.3 10633.8 10833.0 10846.0 11125.3 8225.8 8398.8 8484.8 8596.3 8644.4 10526.0 10701.8 10792.4 10912.4 11167.1 23:04:50 INFO - PID 6894 | 23:04:50 INFO - PID 6894 | [#3] mootools.html Cycles:180 Average:6535.41 Median:3678.74 stddev:4279.03 (116.3%) stddev-sans-first:4272.83 23:04:50 INFO - PID 6894 | Values: 1282.6 1330.6 1334.3 1335.3 1351.8 10438.2 10819.1 10821.1 11004.4 11296.5 11106.6 11251.5 11304.4 11313.4 11341.9 2262.9 2292.2 2293.5 2305.5 2313.8 2172.5 2208.1 2226.6 2236.3 2238.0 2037.1 2067.8 2072.5 2074.5 2090.5 2127.4 2141.5 2145.8 2149.4 2158.5 2086.1 2101.9 2245.3 2250.9 2258.1 10781.9 10885.1 10905.3 10924.7 10943.1 5710.1 5916.7 5931.6 5947.5 5951.3 3391.7 3436.9 3491.7 3499.8 3534.4 1072.5 1074.4 1080.5 1083.1 1103.8 15531.1 15563.4 15596.2 15633.0 15725.0 4769.0 4846.1 4946.3 4990.1 5119.8 11171.8 11236.0 11243.4 11261.9 11285.4 5672.8 5782.8 5800.4 5810.4 5811.4 5191.3 5342.1 5356.1 5356.1 5371.7 3726.6 3770.7 3775.2 3862.0 3895.8 1106.9 1109.4 1110.2 1112.9 1113.7 711.3 729.2 733.3 734.3 739.8 5791.3 5882.4 5890.6 5928.6 5988.1 519.9 547.9 563.8 564.5 575.9 3630.9 4222.7 4259.0 4304.0 4330.3 13331.1 14355.7 14362.4 14369.4 14389.2 13846.0 13973.9 14069.0 14108.8 14126.0 7255.4 7655.5 7658.7 7785.2 7968.0 6266.4 6358.7 6565.0 6567.5 6878.7 12163.8 12216.3 13090.6 13497.9 13511.2 12307.1 12334.3 12335.5 12482.0 12563.2 8083.1 8282.3 8298.3 8311.9 8332.6 9341.6 9538.2 9744.0 9805.2 9998.9 8336.9 8458.8 8471.6 8479.2 8512.5 7542.3 7608.4 7637.4 7873.6 7896.3 7479.1 7541.1 7551.3 7563.2 7587.8 5629.6 5678.7 5682.3 5785.9 5921.4 5301.5 5305.8 5333.6 5403.7 5462.9 23:04:50 INFO - PID 6894 | 23:04:50 INFO - PID 6894 | [#4] prototype.html Cycles:180 Average:4792.07 Median:5375.64 stddev:1397.63 (26.0%) stddev-sans-first:1361.25 23:04:50 INFO - PID 6894 | Values: 352.8 352.9 359.4 366.3 379.9 5371.5 5558.6 5575.4 5584.2 5662.9 5349.8 5422.0 5424.8 5429.6 5439.3 4063.1 4067.9 4068.0 4069.1 4069.4 3984.9 4096.2 4098.3 4104.2 4109.3 4101.2 4104.1 4105.3 4109.4 4110.9 4081.2 4085.6 4092.3 4100.3 4105.6 3555.8 3558.9 3561.6 3576.4 3587.7 5261.7 5368.7 5374.5 5376.8 5383.5 4718.6 4821.4 4858.8 4863.0 4870.9 5612.3 5719.2 5730.4 5777.7 5788.8 4337.5 4392.1 4392.4 4400.8 4430.2 5951.5 6118.9 6172.6 6174.7 6187.7 4248.4 4268.6 4274.3 4280.2 4285.7 4297.2 4306.7 4308.0 4319.8 4339.7 4901.8 4923.7 4929.8 5080.0 5101.8 5849.1 5883.5 5897.6 5899.9 5903.5 1562.9 1586.4 1597.2 1599.6 1606.5 1138.3 1145.1 1152.9 1162.6 1164.0 5004.0 5011.2 5019.6 5040.1 5041.6 5981.8 6018.4 6023.6 6025.4 6028.2 4890.4 4896.1 4916.6 4931.2 4946.8 3114.3 3144.8 3148.8 3159.0 3161.1 5302.5 5424.4 5445.9 5455.6 5481.8 6144.7 6146.4 6157.5 6164.1 6166.8 5483.9 5502.3 5507.5 5512.0 5520.8 5877.8 5928.1 5963.9 5979.3 5982.2 5742.0 5894.3 5940.7 5952.6 5966.2 5461.0 5547.3 5548.8 5582.5 5586.9 3999.3 4003.9 4007.1 4059.8 4066.8 6048.5 6051.3 6062.8 6068.5 6089.1 5758.0 5835.6 5840.7 5858.4 5891.4 5783.6 5841.9 5858.1 5862.5 5878.7 5690.3 5734.5 5759.9 5784.2 5790.7 5637.3 5829.9 5860.5 5873.8 5909.6 5703.0 5730.5 5732.3 5743.9 5757.5 23:04:50 INFO - PID 6894 | 23:04:50 INFO - PID 6894 | [#5] yui.html Cycles:180 Average:17545.90 Median:35432.15 stddev:23287.00 (65.7%) stddev-sans-first:23318.14 23:04:50 INFO - PID 6894 | Values: 743.9 752.7 767.7 772.6 785.5 13752.5 14360.0 14478.9 15695.8 16971.2 16062.1 16121.9 16165.0 16295.0 16321.1 616.8 868.9 899.2 899.8 900.2 658.3 856.4 873.7 899.8 899.9 942.9 943.2 944.4 950.8 951.4 934.0 935.5 937.9 940.1 941.5 689.7 689.8 690.4 691.7 691.8 14494.2 14577.6 14669.0 14771.0 14774.5 16194.7 16572.7 16594.1 16621.5 16623.2 12846.7 13374.1 13515.0 13539.0 13539.9 2882.5 2882.8 2899.9 2903.1 2909.4 88760.1 88812.6 88925.0 91735.0 92825.5 12563.2 13023.3 13116.5 13160.2 13199.8 23937.2 24012.8 24123.3 24236.0 24290.6 6267.0 6374.6 6380.9 6390.4 6395.1 2725.7 2805.0 2847.8 2876.1 2882.3 3919.9 4035.3 4035.6 4040.8 4045.8 757.7 792.3 795.7 798.5 799.3 575.1 595.2 597.5 601.2 623.0 9570.5 10246.0 10724.9 10811.5 11148.9 567.0 582.1 582.1 585.7 599.3 4605.8 4735.3 4743.1 4766.4 4919.2 80436.6 81800.0 81829.0 84535.6 85463.1 76528.0 77143.0 77752.0 78071.6 78152.2 60313.0 60380.0 61283.1 63953.4 66463.7 9720.8 10179.4 10238.3 10279.2 10566.8 28129.3 28391.9 28478.0 28738.4 29176.3 34958.8 35047.5 35271.5 35592.8 36087.1 13532.7 13536.2 13720.7 13874.4 13876.2 16147.8 16215.3 16297.1 16453.9 16649.3 14990.1 15029.6 15076.0 15201.5 15378.8 14862.9 14946.9 15061.3 15093.1 15308.1 12911.3 12961.7 12963.2 13266.5 13292.9 9195.2 9220.0 9319.8 9433.0 9441.9 10293.3 10325.3 10632.2 10655.1 10792.6 23:04:50 INFO - PID 6894 | -------- Summary: end -------- 23:04:50 INFO - PID 6894 | 23:04:51 INFO - TEST-INFO | 6894: exit 0 23:04:51 INFO - TEST-OK | dromaeo_css | took 1146549ms 23:04:51 INFO - TEST-START | kraken 23:04:51 INFO - operating with platform_type : linux_ 23:04:51 INFO - Initialising browser for kraken test... 23:04:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60239/getInfo.html -profile /tmp/tmps4b_XA/profile 23:04:51 INFO - TEST-INFO | started process 7290 (/builds/slave/test/build/application/firefox/firefox http://localhost:60239/getInfo.html) 23:05:26 INFO - TEST-INFO | 7290: killed by SIGTERM 23:05:26 INFO - Browser initialized. 23:05:26 INFO - Running cycle 1/1 for kraken test... 23:05:26 INFO - TEST-INFO | started process 7490 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps4b_XA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:05:38 INFO - PID 7490 | RSS: Main: 169353216 23:05:38 INFO - PID 7490 | 23:05:40 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60239/tests/kraken/driver.html?testName=audio-beat-detection) 23:05:41 INFO - PID 7490 | RSS: Main: 174477312 23:05:41 INFO - PID 7490 | 23:05:44 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60239/tests/kraken/driver.html?testName=audio-dft) 23:05:45 INFO - PID 7490 | RSS: Main: 173920256 23:05:45 INFO - PID 7490 | 23:05:48 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60239/tests/kraken/driver.html?testName=audio-fft) 23:05:48 INFO - PID 7490 | RSS: Main: 171438080 23:05:48 INFO - PID 7490 | 23:05:50 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60239/tests/kraken/driver.html?testName=audio-oscillator) 23:05:51 INFO - PID 7490 | RSS: Main: 171929600 23:05:51 INFO - PID 7490 | 23:05:53 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:05:54 INFO - PID 7490 | RSS: Main: 172523520 23:05:54 INFO - PID 7490 | 23:05:57 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60239/tests/kraken/driver.html?testName=imaging-darkroom) 23:05:57 INFO - PID 7490 | RSS: Main: 173477888 23:05:57 INFO - PID 7490 | 23:06:01 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60239/tests/kraken/driver.html?testName=imaging-desaturate) 23:06:01 INFO - PID 7490 | RSS: Main: 172216320 23:06:01 INFO - PID 7490 | 23:06:04 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60239/tests/kraken/driver.html?testName=json-parse-financial) 23:06:05 INFO - PID 7490 | RSS: Main: 173039616 23:06:05 INFO - PID 7490 | 23:06:07 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:06:07 INFO - PID 7490 | RSS: Main: 172789760 23:06:07 INFO - PID 7490 | 23:06:09 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60239/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:06:10 INFO - PID 7490 | RSS: Main: 172773376 23:06:10 INFO - PID 7490 | 23:06:12 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:06:13 INFO - PID 7490 | RSS: Main: 172818432 23:06:13 INFO - PID 7490 | 23:06:15 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:06:16 INFO - PID 7490 | RSS: Main: 173203456 23:06:16 INFO - PID 7490 | 23:06:19 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:06:20 INFO - PID 7490 | RSS: Main: 172822528 23:06:20 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | Cycle 1(1): loaded http://localhost:60239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60239/tests/kraken/driver.html?testName=ai-astar) 23:06:22 INFO - PID 7490 | RSS: Main: 174522368 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | __start_tp_report 23:06:22 INFO - PID 7490 | _x_x_mozilla_page_load 23:06:22 INFO - PID 7490 | _x_x_mozilla_page_load_details 23:06:22 INFO - PID 7490 | |i|pagename|runs| 23:06:22 INFO - PID 7490 | |0;ai-astar;107;111;112;111;111;110;111;111;112;112 23:06:22 INFO - PID 7490 | |1;audio-beat-detection;149;121;123;170;125;125;124;124;145;123 23:06:22 INFO - PID 7490 | |2;audio-dft;163;165;163;163;167;167;170;165;164;163 23:06:22 INFO - PID 7490 | |3;audio-fft;73;75;80;122;75;75;75;74;94;74 23:06:22 INFO - PID 7490 | |4;audio-oscillator;83;83;104;85;83;83;95;84;84;105 23:06:22 INFO - PID 7490 | |5;imaging-gaussian-blur;114;116;114;114;114;115;114;114;115;114 23:06:22 INFO - PID 7490 | |6;imaging-darkroom;151;150;150;153;150;152;151;152;150;152 23:06:22 INFO - PID 7490 | |7;imaging-desaturate;96;95;95;95;95;95;100;95;94;95 23:06:22 INFO - PID 7490 | |8;json-parse-financial;56;54;56;55;58;59;58;55;55;55 23:06:22 INFO - PID 7490 | |9;json-stringify-tinderbox;59;56;56;57;56;56;56;56;56;56 23:06:22 INFO - PID 7490 | |10;stanford-crypto-aes;95;88;88;88;87;88;95;88;143;85 23:06:22 INFO - PID 7490 | |11;stanford-crypto-ccm;135;135;136;135;136;132;141;134;132;143 23:06:22 INFO - PID 7490 | |12;stanford-crypto-pbkdf2;190;194;187;198;198;195;197;193;191;196 23:06:22 INFO - PID 7490 | |13;stanford-crypto-sha256-iterative;77;77;77;74;78;72;78;75;72;82 23:06:22 INFO - PID 7490 | __end_tp_report 23:06:22 INFO - PID 7490 | __start_cc_report 23:06:22 INFO - PID 7490 | _x_x_mozilla_cycle_collect,883 23:06:22 INFO - PID 7490 | __end_cc_report 23:06:22 INFO - PID 7490 | __startTimestamp1495778782359__endTimestamp 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | ------- Summary: start ------- 23:06:22 INFO - PID 7490 | Number of tests: 14 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:1.48 (1.3%) stddev-sans-first:0.67 23:06:22 INFO - PID 7490 | Values: 107.0 111.0 112.0 111.0 111.0 110.0 111.0 111.0 112.0 112.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:125.00 stddev:16.34 (13.1%) stddev-sans-first:16.26 23:06:22 INFO - PID 7490 | Values: 149.0 121.0 123.0 170.0 125.0 125.0 124.0 124.0 145.0 123.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:2.36 (1.4%) stddev-sans-first:2.39 23:06:22 INFO - PID 7490 | Values: 163.0 165.0 163.0 163.0 167.0 167.0 170.0 165.0 164.0 163.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:15.46 (20.6%) stddev-sans-first:16.08 23:06:22 INFO - PID 7490 | Values: 73.0 75.0 80.0 122.0 75.0 75.0 75.0 74.0 94.0 74.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:83.50 stddev:8.99 (10.8%) stddev-sans-first:9.28 23:06:22 INFO - PID 7490 | Values: 83.0 83.0 104.0 85.0 83.0 83.0 95.0 84.0 84.0 105.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 23:06:22 INFO - PID 7490 | Values: 114.0 116.0 114.0 114.0 114.0 115.0 114.0 114.0 115.0 114.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.50 stddev:1.10 (0.7%) stddev-sans-first:1.17 23:06:22 INFO - PID 7490 | Values: 151.0 150.0 150.0 153.0 150.0 152.0 151.0 152.0 150.0 152.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.65 (1.7%) stddev-sans-first:1.74 23:06:22 INFO - PID 7490 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 100.0 95.0 94.0 95.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.66 (3.0%) stddev-sans-first:1.76 23:06:22 INFO - PID 7490 | Values: 56.0 54.0 56.0 55.0 58.0 59.0 58.0 55.0 55.0 55.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.00 stddev:0.97 (1.7%) stddev-sans-first:0.33 23:06:22 INFO - PID 7490 | Values: 59.0 56.0 56.0 57.0 56.0 56.0 56.0 56.0 56.0 56.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#10] stanford-crypto-aes Cycles:10 Average:94.50 Median:88.00 stddev:17.35 (19.7%) stddev-sans-first:18.41 23:06:22 INFO - PID 7490 | Values: 95.0 88.0 88.0 88.0 87.0 88.0 95.0 88.0 143.0 85.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:135.50 stddev:3.54 (2.6%) stddev-sans-first:3.74 23:06:22 INFO - PID 7490 | Values: 135.0 135.0 136.0 135.0 136.0 132.0 141.0 134.0 132.0 143.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.90 Median:195.50 stddev:3.67 (1.9%) stddev-sans-first:3.61 23:06:22 INFO - PID 7490 | Values: 190.0 194.0 187.0 198.0 198.0 195.0 197.0 193.0 191.0 196.0 23:06:22 INFO - PID 7490 | 23:06:22 INFO - PID 7490 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:77.00 stddev:3.05 (4.0%) stddev-sans-first:3.22 23:06:22 INFO - PID 7490 | Values: 77.0 77.0 77.0 74.0 78.0 72.0 78.0 75.0 72.0 82.0 23:06:22 INFO - PID 7490 | -------- Summary: end -------- 23:06:22 INFO - PID 7490 | 23:06:23 INFO - TEST-INFO | 7490: exit 0 23:06:23 INFO - TEST-OK | kraken | took 92230ms 23:06:23 INFO - SUITE-END | took 1238s 23:06:23 INFO - Completed test suite (00:20:38) 23:06:23 INFO - javascript benchmark 23:06:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6804.805240354877, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2730.781537477002, 2750.573661082533, 2769.473799978004, 2788.735070168333, 2790.3861150546886, 5248.21276808478, 5298.4701529847, 5315.202719592063, 5370.650907690997, 5372.2210279509445, 5323.893522129555, 5331.866703332409, 5336.8132115375965, 5411.675299482034, 5415.214793854889, 4446.955530444687, 4671.322658214557, 4724.126036683216, 4758.072175925696, 4765.42814862217, 4787.13831510328, 4806.495317991596, 4841.782119804618, 4849.151398505265, 4872.366592343008, 4641.930371044403, 4702.670813043088, 4709.505501922317, 4759.000609871931, 4765.857024289242, 4763.809447622091, 4771.045790841846, 4793.400824896888, 4803.759812009385, 4822.517748225149, 4698.1778188816825, 4702.788374523155, 4710.1286262041285, 4722.126406614753, 4722.456917454502, 5190.948090519084, 5366.91949620756, 5378.435264297271, 5398.703071331075, 5417.51242388187, 5706.543476521868, 5721.399253078408, 5758.971205143989, 5768.10594357871, 5785.190073389729, 5825.7378417971295, 5825.79609713658, 5828.125781132821, 5850.76596936122, 5883.411658834125, 5399.299220745453, 5408.378036525771, 5409.377921538995, 5415.675059496442, 5425.755840987165, 5800.100984347433, 5863.296404431496, 5878.647281163144, 5900.1149827526215, 5965.522758179335, 5702.401247868997, 5710.057840456361, 5713.885722285531, 5742.425757424307, 5765.990951583456, 5637.915431268534, 5729.1119876419225, 5732.684702341411, 5750.942490575041, 5753.712314384347, 5658.886822263532, 5734.77060917567, 5770.16332631766, 5771.8557036074435, 5775.797847075332, 5730.19777231188, 5736.311642602915, 5770.740316685759, 5793.8841223175305, 5807.041838096667, 4717.551832575899, 4723.291506274018, 4743.478217396084, 4744.7627618618935, 4786.042791441726, 4010.8195131219163, 4110.0752330725345, 4111.075008123208, 4120.381942708617, 4138.79306034697, 4806.831760888352, 4812.51874812516, 4829.372181616367, 4895.216765317532, 4907.852764417074, 5808.506276966421, 5809.622374545641, 5811.651300921958, 5814.3604203538425, 5840.269966254218, 4855.393075865517, 4857.392825896763, 4860.0, 4866.926996095061, 4908.754562271872, 5024.949750502521, 5080.695158290514, 5082.0, 5137.6660517066275, 5145.408278047998, 5317.20241963693, 5317.734113294242, 5318.468153184651, 5322.441143680013, 5361.785528578813, 5705.286839144941, 5772.509336706427, 5789.0, 5791.189233507228, 5794.855128621818, 5297.549708274686, 5298.867528311823, 5331.893362132658, 5358.33020872391, 5373.838784836461, 5634.042212823748, 5657.4059723728415, 5673.8865222694485, 5675.716214189191, 5676.716164191691, 5688.317401911797, 5759.596828221985, 5795.420457954171, 5810.186573879745, 5824.854378640568, 5549.7780088796, 5592.245046918777, 5611.242482264842, 5676.68778217202, 5694.487496125369, 5603.831885043455, 5618.831435056954, 5629.408912064338, 5638.407967163553, 5672.602917795714, 5525.336959564717, 5529.4470552945995, 5557.638753481011, 5558.138488534284, 5562.388137304974, 5500.064988951808, 5621.128725047624, 5654.349749778664, 5719.370869204467, 5744.138379243147, 5482.23248745168, 5492.450754924475, 5493.642913210629, 5528.419515950928, 5550.222968784293], "value": 5215.882618367438, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.6519012328405, 705.8623568404162, 719.2843121094512, 1165.5687395663606, 1198.6224339333114, 33394.33211335775, 35551.2889742205, 35658.2868342633, 35690.821545892235, 35735.642643573556, 33833.830830845814, 34028.0, 34109.65890341096, 34111.14722131948, 34133.0, 6333.778317758879, 6451.935480645204, 6560.507961902853, 6727.932720672804, 6733.02371156182, 6707.899381509281, 6785.0, 6789.049533065375, 6789.728410863584, 6791.864162716743, 6718.529702920798, 6739.326067393271, 6748.527603067787, 6793.015012823138, 6810.455163586901, 6753.561018533805, 6760.357766012221, 6769.05233267343, 6770.255271920085, 6788.185417749853, 6601.537892347537, 6671.166104236971, 6674.766383176614, 6700.430463410616, 6719.428848547879, 32629.83685081583, 32657.6734232657, 32666.6733332666, 32669.836650816833, 32896.17759556006, 2983.5524671299477, 2984.0451055662197, 3010.0, 3026.0770465008163, 3028.757699384044, 24577.754222457726, 24631.753682463124, 24655.506889862103, 24686.753132468624, 24932.750672493225, 2841.7300356466103, 2854.943670841802, 2871.784616153797, 2892.956605650917, 2898.840563768992, 148963.25518372338, 149394.0, 149795.0, 156172.0, 160411.0, 38511.422328665096, 39122.0, 39146.804265978484, 39161.608383915795, 39192.804035979636, 40673.0, 40704.0, 40745.38881916774, 44249.0, 44988.55011449909, 11670.358130302915, 11697.0, 11756.1182911282, 11812.055035597132, 11817.586384476503, 9257.953710231406, 9267.860982085274, 9291.070892910655, 9322.161005509537, 9330.58012389444, 12498.750024999448, 12570.308633025088, 12649.30428826405, 12656.557020504239, 12733.490660373667, 5323.254744335796, 5350.38470575881, 5368.355797304349, 5486.698231597221, 5512.80705175317, 845.7843249971218, 881.8060026794095, 882.223643193998, 896.8430524658158, 911.4349103555705, 21044.530070708042, 21874.89062554677, 21914.23300184486, 21917.342479725634, 21947.67078493792, 965.8840939087354, 967.1392460709974, 978.6574698855486, 993.2054356514759, 1000.7548150703125, 11296.265742726697, 11348.489317980711, 11387.430628468543, 11420.486078126503, 11659.358735269472, 174703.0, 175811.0, 175832.0, 175913.0, 176198.11900940412, 41442.0, 41772.79113604473, 42031.57968420338, 42045.36931945962, 42140.0, 1220.1824777399163, 1244.147758785235, 1247.0335489995325, 1247.3950134184913, 1259.4080782032431, 19932.402027939184, 20326.59346813085, 20740.688889666366, 20836.68744968857, 21142.894285528473, 29334.97327593524, 29550.852245738635, 29592.556111657912, 29653.258668532595, 29862.25344366408, 150765.0, 151010.0, 151288.0, 151589.0, 152200.0, 28647.14058578246, 28789.42421151607, 29040.564391534568, 29141.317443098393, 29230.0, 35313.82343088268, 35370.646293537764, 35373.469397958535, 35491.64508354987, 35667.46498802572, 25283.11509097173, 26342.34144146335, 26577.867110664323, 26690.866545667148, 26979.86510067437, 26706.46587068209, 26914.865425672746, 27328.72671273262, 27403.0, 27476.862615686794, 29870.701292987662, 29912.85043574768, 29969.850150749106, 30237.09288721254, 30339.0, 25235.369115772253, 25718.61422078633, 25896.92824573992, 26930.46139077168, 27185.04852330159, 18903.621927561097, 21632.89183554135, 21795.0, 21921.232756853435, 22095.33713988583], "value": 14334.475175299765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.61291579457423, 415.7006954992408, 420.20161692783705, 427.7946585638893, 445.54331809894876, 14635.487757928448, 15211.239438028082, 17239.913800430997, 17594.560135996606, 17609.911950440244, 18689.0, 18827.0, 18864.151113199903, 19034.524136896584, 19050.0, 5313.601479889005, 5336.706481143545, 5505.394406615269, 5521.089020311644, 5532.3914369419335, 5282.102042652758, 5420.159875219328, 5431.34823821142, 5446.482584154499, 5459.235707001023, 4810.20631595788, 5254.763535640886, 5265.131253343213, 5280.287161233223, 5408.91886621701, 5181.844544663666, 5186.92219616706, 5190.896182076375, 5227.5295223429885, 5237.711925844077, 4738.407699037621, 4745.8576242712425, 4787.2101103318255, 4827.203511420611, 4849.369581954358, 21745.456363590878, 21813.23653672114, 22145.89270536483, 22171.66742498864, 22205.0, 1585.651156745514, 1636.4845073801832, 1637.4023481429313, 1639.7868277124016, 1643.4248013195406, 14370.640733981629, 14551.708965820624, 14682.853171468363, 14824.777628335583, 14908.552743417715, 1991.0, 2031.1672214392177, 2077.387170784622, 2082.3440616206, 2094.7381577302835, 89928.55035724779, 90024.54987725084, 93188.06811931862, 93595.53202233945, 94393.52803236009, 10933.726656833484, 10989.285696429706, 11015.724606884733, 11065.723356916142, 11404.94297528507, 15521.922390387976, 15661.451849185223, 15676.137812420198, 15708.842911570966, 15746.527604171893, 7391.889121663179, 7523.962380188064, 7649.426293028045, 7661.157272699998, 7683.884741728879, 6808.761693340709, 6863.794086177422, 7013.789586312419, 7022.789316320519, 7029.22678505364, 6962.860742785218, 6980.232174460907, 7073.115860517435, 7116.288371162842, 7164.391026762679, 2052.702358158059, 2057.8765274083603, 2077.8961051947645, 2078.490769761418, 2172.239716099353, 817.3175398542284, 831.4138532334689, 843.1357858195277, 869.5956380283072, 883.6597909804772, 16936.745948810778, 17039.744403833953, 17378.47864564065, 17541.386051488138, 17597.0, 853.8847255620536, 860.8278344331034, 871.4205053639259, 880.7665968518347, 882.5454890731279, 8935.865962010575, 9157.130072643089, 9461.785689409933, 9479.90520094804, 9491.66779162726, 379279.0, 381241.0, 382160.0, 389396.0, 394019.0, 75870.62064689641, 77063.0, 77312.61343693246, 77694.22305776984, 81077.18922810814, 1048.4286064095086, 1050.1965996013057, 1094.0973696700255, 1100.1528822806395, 1100.9064229540418, 17260.223289952235, 17605.471835844946, 18273.908630457296, 18274.45176644703, 18278.0, 39469.40795888122, 39638.801805990784, 40156.99215039295, 40597.39103913503, 41031.79484102561, 49740.50259497359, 49919.251211232586, 50244.0, 51072.23391649054, 51943.74028129986, 8221.83556328882, 8251.546164960984, 8429.536375499407, 8463.830723385621, 8668.0, 11647.708807279885, 12031.879681203076, 12284.201526900722, 12372.07209459312, 12707.301098439304, 10397.636082737068, 10408.739781505523, 10678.519466624177, 10732.624358147428, 11083.0, 9458.763530911783, 9480.431174129575, 9558.139767420966, 9585.952070239884, 9837.68814328618, 10406.271560990657, 10633.787324253317, 10833.0, 10846.0, 11125.332480051224, 8225.79435514117, 8398.83202335962, 8484.830303394021, 8596.312295016509, 8644.438111522983, 10526.0, 10701.839472407764, 10792.352458852494, 10912.399818009768, 11167.1066314693], "value": 8795.761664070777, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1282.621626620147, 1330.580867026886, 1334.319497056501, 1335.3189873164683, 1351.837779466464, 10438.164946804256, 10819.080378167855, 10821.13430925526, 11004.39475828829, 11296.491657875395, 11106.6112686056, 11251.493682784274, 11304.37825919574, 11313.377764222965, 11341.943290283538, 2262.9321120366376, 2292.2091878302044, 2293.5298263855952, 2305.481266714984, 2313.8264630152808, 2172.543765809174, 2208.116753298685, 2226.599212141814, 2236.3067449090836, 2238.0, 2037.1342179573621, 2067.8138967492923, 2072.492239401349, 2074.52285974226, 2090.4982804126976, 2127.4043267885017, 2141.4646338415396, 2145.7854214578574, 2149.355193441961, 2158.4603849037585, 2086.113401804227, 2101.884396358215, 2245.315178870444, 2250.8762018089, 2258.1306197114063, 10781.946090269577, 10885.074768644674, 10905.291156074829, 10924.726881827939, 10943.124550035978, 5710.14347847822, 5916.674582897939, 5931.64410135389, 5947.464728174442, 5951.345352011275, 3391.6608339166132, 3436.914077148066, 3491.738119641037, 3499.772514786531, 3534.3991521441417, 1072.495926914349, 1074.3607553505651, 1080.4543705428787, 1083.1226706367868, 1103.779244151165, 15531.145786981711, 15563.377464901503, 15596.22018899062, 15632.983856049434, 15725.0, 4768.9523104769205, 4846.127697014571, 4946.332245146859, 4990.126727822617, 5119.846404607868, 11171.83242251367, 11236.0, 11243.381614011145, 11261.887381126084, 11285.435728213557, 5672.801451949162, 5782.826515204551, 5800.39095894925, 5810.389909059572, 5811.4479124483105, 5191.32512773337, 5342.145256758978, 5356.116240820221, 5356.116240820299, 5371.650842695212, 3726.571444283888, 3770.679492243135, 3775.1505911169766, 3861.961380386216, 3895.7662540247675, 1106.878243393226, 1109.367660433545, 1110.2339385823757, 1112.9387883666477, 1113.6881673131536, 711.2958171410266, 729.1614643160408, 733.3436574266109, 734.302412707919, 739.8372358081214, 5791.276090488689, 5882.382349853289, 5890.617109887844, 5928.584999050111, 5988.101784732238, 519.8856251624636, 547.9424660410599, 563.7716724726492, 564.4863174511175, 575.8617931696363, 3630.909227269339, 4222.683298752606, 4258.978705106455, 4303.978480107579, 4330.307150855848, 13331.133476324008, 14355.712885742227, 14362.353694083791, 14369.425222991173, 14389.208593527248, 13846.0, 13973.930130349283, 14069.0, 14108.788368174486, 14126.0, 7255.383292420098, 7655.540667559964, 7658.693652253959, 7785.221477852169, 7968.0, 6266.404691554295, 6358.745650173942, 6565.0, 6567.507436942153, 6878.7248510059035, 12163.81754273669, 12216.26702397859, 13090.607281781562, 13497.852682521703, 13511.189328639919, 12307.076969227164, 12334.321612311409, 12335.50657973707, 12482.0, 12563.246205227715, 8083.070446898682, 8282.296004839656, 8298.336133109458, 8311.875321870297, 8332.625031873458, 9341.626334946526, 9538.23694104456, 9743.951280243553, 9805.166560842123, 9998.850017249602, 8336.916630833857, 8458.788530286793, 8471.618777155167, 8479.19447652472, 8512.489250644981, 7542.321191092828, 7608.353289970414, 7637.427192960439, 7873.645685944261, 7896.32881205104, 7479.139898911477, 7541.057367829021, 7551.320381165721, 7563.168051514219, 7587.810304742426, 5629.605927585029, 5678.74445649955, 5682.289713785777, 5785.884282314414, 5921.437463440966, 5301.469853014668, 5305.761240744098, 5333.599980001593, 5403.675779453245, 5462.91805622908], "value": 4829.126863723067, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.82711471379014, 352.9047157267538, 359.3998023301087, 366.27477594363165, 379.92211596622695, 5371.543418809396, 5558.583106267031, 5575.414581468943, 5584.162375643656, 5662.886742265157, 5349.8127565535215, 5422.0, 5424.755885985131, 5429.619926605139, 5439.3200849893765, 4063.08580569371, 4067.8983025424304, 4067.9626695192683, 4069.0844559973916, 4069.4302797608357, 3984.940225896614, 4096.242195193884, 4098.323776576861, 4104.220198162355, 4109.301418758818, 4101.241270364977, 4104.117614712836, 4105.322621767405, 4109.363048727452, 4110.91778164438, 4081.163476435616, 4085.632293093606, 4092.283850326196, 4100.323446631302, 4105.5894410559, 3555.8044307563073, 3558.9110272243142, 3561.5726112866364, 3576.3920133577094, 3587.7488575799703, 5261.7369131543655, 5368.677879327252, 5374.522006448219, 5376.758045887906, 5383.4616538346245, 4718.646101542364, 4821.373221481185, 4858.772867605171, 4862.954464790052, 4870.902581948377, 5612.326520817487, 5719.19931209631, 5730.398308177665, 5777.740001699934, 5788.768449262025, 4337.501187363462, 4392.099619578011, 4392.363107349416, 4400.823967041314, 4430.202563538562, 5951.49412299955, 6118.938810611926, 6172.598781079216, 6174.660393678346, 6187.679620142447, 4248.426462427533, 4268.637165840938, 4274.294741367639, 4280.186764514732, 4285.742855428684, 4297.183535128315, 4306.729514793081, 4307.978460107742, 4319.762413067311, 4339.674524410681, 4901.754912254373, 4923.729194894315, 4929.7535123244415, 5079.97460012705, 5101.846944591668, 5849.093390524476, 5883.470487656132, 5897.64614123154, 5899.882002359929, 5903.468687818031, 1562.874970002397, 1586.444744339472, 1597.225345707331, 1599.6083407435374, 1606.4939544043589, 1138.2544433396138, 1145.135422755814, 1152.9335364787537, 1162.5872815150499, 1163.988360116405, 5003.974980125076, 5011.223260394645, 5019.598432125421, 5040.092783299041, 5041.571466425395, 5981.760729570856, 6018.428249316308, 6023.6385816851125, 6025.397460253939, 6028.216331876915, 4890.388701412324, 4896.11869863428, 4916.631252655993, 4931.18635425158, 4946.777395017233, 3114.256016630694, 3144.795588286754, 3148.779585428998, 3158.9684103159134, 3161.1148878314107, 5302.549283310962, 5424.430434804368, 5445.945540544623, 5455.5908306876345, 5481.780728770885, 6144.723487443076, 6146.446819786241, 6157.476614487729, 6164.137020817089, 6166.784162554289, 5483.945160548423, 5502.284702988666, 5507.504324610804, 5511.972440137773, 5520.7703493456775, 5877.794277200449, 5928.140419639214, 5963.880722385615, 5979.252593425822, 5982.205338398376, 5741.971290143522, 5894.347543605309, 5940.702964851826, 5952.613080149777, 5966.194563734014, 5461.0, 5547.33431988164, 5548.805791797267, 5582.469665381782, 5586.944130558642, 3999.340108882002, 4003.939940900947, 4007.1384652299894, 4059.837606495707, 4066.7966601669204, 6048.546359023003, 6051.273847138372, 6062.787802426894, 6068.544859135671, 6089.147519347383, 5757.971210143923, 5835.620684655484, 5840.729191652688, 5858.384869588632, 5891.440313170242, 5783.624064435799, 5841.912371314349, 5858.121281807763, 5862.472377486047, 5878.735456904364, 5690.317161940594, 5734.455226753452, 5759.94240057594, 5784.248047753765, 5790.710464476843, 5637.295338082739, 5829.854253643523, 5860.531157507475, 5873.765049397976, 5909.581700391961, 5702.971485142548, 5730.5129064030025, 5732.34078081026, 5743.885122297447, 5757.453041961007], "value": 4370.304648472904, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.9218882017385, 752.7478294771252, 767.7121079595148, 772.6021099133947, 785.4972817396865, 13752.518661846838, 14360.0, 14478.855211447883, 15695.84304156958, 16971.236294366754, 16062.116583587898, 16121.919390403062, 16165.0, 16295.02229866206, 16321.10233937136, 616.7687117331001, 868.8827008353886, 899.2356496977582, 899.7885496908222, 900.2168113741054, 658.2627457247866, 856.4304737349655, 873.7116751472031, 899.8200359928007, 899.941503802254, 942.8821397325335, 943.170010390855, 944.3767113704956, 950.8478643417054, 951.3816019587255, 933.9906600934039, 935.4901578639658, 937.8968313485511, 940.0975063938627, 941.5292353823088, 689.7275576147443, 689.7930620813786, 690.4234963805178, 691.7129391302603, 691.830501527124, 14494.202818844959, 14577.562673119823, 14669.0, 14771.0, 14774.48289309869, 16194.676106477804, 16572.66854662912, 16594.08732519711, 16621.50135495937, 16623.168841557872, 12846.67883302925, 13374.063815532916, 13515.0, 13539.0, 13539.932300338534, 2882.495563276439, 2882.769378449719, 2899.913002609925, 2903.129061281607, 2909.418116376733, 88760.11239887647, 88812.5559372199, 88925.0, 91734.99999999933, 92825.53587232088, 12563.246205227715, 13023.348832558335, 13116.540921067908, 13160.210387376788, 13199.802002969964, 23937.162199322942, 24012.759872401402, 24123.276301710976, 24236.0, 24290.635640465407, 6266.968665156645, 6374.617522948638, 6380.904286435707, 6390.424861762371, 6395.072714456378, 2725.7001729809704, 2805.0, 2847.7721782257368, 2876.0652787843615, 2882.30824602094, 3919.941200881989, 4035.2534781065597, 4035.616616421435, 4040.777757223381, 4045.7977101144825, 757.6552668535803, 792.2671528835804, 795.7055889320989, 798.4570492065451, 799.3445374792731, 575.0999685492192, 595.1905408644241, 597.5100417657479, 601.1823919469518, 622.9937700623026, 9570.47362395075, 10246.0, 10724.946375268073, 10811.459427028618, 11148.888511114947, 566.9886602268014, 582.0948425198771, 582.14715441877, 585.6603170161296, 599.2928344553469, 4605.838795642204, 4735.266033764703, 4743.0988112258565, 4766.404199475066, 4919.1883339248625, 80436.59781701054, 81800.0, 81829.0, 84535.577322113, 85463.14536854676, 76528.0, 77143.0, 77752.0, 78071.60964195142, 78152.21847781564, 60313.0, 60380.0, 61283.08075378873, 63953.36046639567, 66463.66768166129, 9720.75698107553, 10179.38923664553, 10238.283320167517, 10279.17766578657, 10566.788664226826, 28129.296767580974, 28391.858040709663, 28478.0, 28738.425231494835, 29176.27059323534, 34958.82520587381, 35047.47428788519, 35271.47092793559, 35592.82203588966, 36087.09782255465, 13532.729345413234, 13536.187828730308, 13720.65698357549, 13874.445022199, 13876.236806975714, 16147.75778363349, 16215.270312836186, 16297.103659298853, 16453.91773041127, 16649.3340266388, 14990.100593964396, 15029.624259393602, 15076.0, 15201.467948621745, 15378.84621153774, 14862.851371486147, 14946.925265374039, 15061.322240498985, 15093.094414335175, 15308.081515109128, 12911.289879056741, 12961.675958101123, 12963.22220666763, 13266.469341226242, 13292.933535332262, 9195.172434480928, 9220.0, 9319.767005824908, 9433.0, 9441.905580944378, 10293.279470436997, 10325.277230593787, 10632.202584806017, 10655.147588193082, 10792.56829726802], "value": 7153.207054253928, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 111.0, 112.0, 111.0, 111.0, 110.0, 111.0, 111.0, 112.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 123.0, 170.0, 125.0, 125.0, 124.0, 124.0, 145.0, 123.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 163.0, 163.0, 167.0, 167.0, 170.0, 165.0, 164.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 80.0, 122.0, 75.0, 75.0, 75.0, 74.0, 94.0, 74.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 104.0, 85.0, 83.0, 83.0, 95.0, 84.0, 84.0, 105.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 153.0, 150.0, 152.0, 151.0, 152.0, 150.0, 152.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 100.0, 95.0, 94.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 55.0, 58.0, 59.0, 58.0, 55.0, 55.0, 55.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 88.0, 88.0, 88.0, 87.0, 88.0, 95.0, 88.0, 143.0, 85.0], "value": 94.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 136.0, 135.0, 136.0, 132.0, 141.0, 134.0, 132.0, 143.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 194.0, 187.0, 198.0, 198.0, 195.0, 197.0, 193.0, 191.0, 196.0], "value": 193.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 74.0, 78.0, 72.0, 78.0, 75.0, 72.0, 82.0], "value": 76.2, "unit": "score"}]}]} 23:06:23 INFO - Return code: 0 23:06:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:06:23 INFO - # TBPL SUCCESS # 23:06:23 INFO - Running post-action listener: _resource_record_post_action 23:06:23 INFO - [mozharness: 2017-05-26 06:06:23.670423Z] Finished run-tests step (success) 23:06:23 INFO - Running post-run listener: _resource_record_post_run 23:06:23 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401977344; Read time: 16; Write time: 235476 23:06:23 INFO - TinderboxPrint: CPU usage
12.6% 23:06:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 23:06:23 INFO - TinderboxPrint: I/O write bytes / time
401,977,344 / 235,476 23:06:23 INFO - TinderboxPrint: CPU idle
8,750.2 (87.3%) 23:06:23 INFO - TinderboxPrint: CPU user
1,213.9 (12.1%) 23:06:23 INFO - TinderboxPrint: Swap in / out
0 / 0 23:06:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 97558528; Read time: 0; Write time: 80056 23:06:23 INFO - run-tests - Wall time: 1239s; CPU: 13.0%; Read bytes: 4096; Write bytes: 304418816; Read time: 16; Write time: 155420 23:06:24 INFO - Running post-run listener: _upload_blobber_files 23:06:24 INFO - Blob upload gear active. 23:06:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:06:24 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 23:06:24 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'] 23:06:24 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 23:06:24 INFO - (blobuploader) - INFO - Open directory for files ... 23:06:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:06:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:06:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:06:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:06:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:06:25 INFO - (blobuploader) - INFO - Done attempting. 23:06:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:06:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:06:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:06:26 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:06:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:06:26 INFO - (blobuploader) - INFO - Done attempting. 23:06:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:06:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:06:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:06:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:06:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:06:30 INFO - (blobuploader) - INFO - Done attempting. 23:06:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:06:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:06:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:06:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:06:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:06:31 INFO - (blobuploader) - INFO - Done attempting. 23:06:31 INFO - (blobuploader) - INFO - Iteration through files over. 23:06:31 INFO - Return code: 0 23:06:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:06:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:06:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35b0e76aca6e144ea10dab26faae6328da7626a582bfab260882818b00fa5c2679fbac2ef3dd6efc77e6269c3c91df425464c8c45c0c93ebc922621c216e5013", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a38c812b526a1a0c7ab7951202c5ab8fa6f9eb7abc59fd51cd56caff189b7fe7f4c07d2d3138d8c8bb69ad4f62ef0ff66faa4699cccfcc1a5e995b698934bb8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5d424bda1d0ea323f94dff2b4e1bf8d13c17373be7eabd45da37ce01f132b8f6ebeeb8f1d2da5d40d1b37acb5637d36389c5a816f4f372c05bd5489ab75cbb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2388986871d430342932837165bf9277a79a4f5f633ab870f598afffe438b02a867e9f2c968d34ce2012baf7939eea7263562f41e685088324889b38c9b3caa9"} 23:06:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:06:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:06:31 INFO - Contents: 23:06:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35b0e76aca6e144ea10dab26faae6328da7626a582bfab260882818b00fa5c2679fbac2ef3dd6efc77e6269c3c91df425464c8c45c0c93ebc922621c216e5013", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a38c812b526a1a0c7ab7951202c5ab8fa6f9eb7abc59fd51cd56caff189b7fe7f4c07d2d3138d8c8bb69ad4f62ef0ff66faa4699cccfcc1a5e995b698934bb8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5d424bda1d0ea323f94dff2b4e1bf8d13c17373be7eabd45da37ce01f132b8f6ebeeb8f1d2da5d40d1b37acb5637d36389c5a816f4f372c05bd5489ab75cbb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2388986871d430342932837165bf9277a79a4f5f633ab870f598afffe438b02a867e9f2c968d34ce2012baf7939eea7263562f41e685088324889b38c9b3caa9"} 23:06:31 INFO - Running post-run listener: copy_logs_to_upload_dir 23:06:31 INFO - Copying logs to upload dir... 23:06:31 INFO - mkdir: /builds/slave/test/build/upload/logs 23:06:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.368094 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2017-05-25 23:06:31.676540) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 23:06:31.680460) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756 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/35b0e76aca6e144ea10dab26faae6328da7626a582bfab260882818b00fa5c2679fbac2ef3dd6efc77e6269c3c91df425464c8c45c0c93ebc922621c216e5013", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a38c812b526a1a0c7ab7951202c5ab8fa6f9eb7abc59fd51cd56caff189b7fe7f4c07d2d3138d8c8bb69ad4f62ef0ff66faa4699cccfcc1a5e995b698934bb8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5d424bda1d0ea323f94dff2b4e1bf8d13c17373be7eabd45da37ce01f132b8f6ebeeb8f1d2da5d40d1b37acb5637d36389c5a816f4f372c05bd5489ab75cbb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2388986871d430342932837165bf9277a79a4f5f633ab870f598afffe438b02a867e9f2c968d34ce2012baf7939eea7263562f41e685088324889b38c9b3caa9"} build_url:https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/MX4XMzTvTf29IClyFGHrBQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35b0e76aca6e144ea10dab26faae6328da7626a582bfab260882818b00fa5c2679fbac2ef3dd6efc77e6269c3c91df425464c8c45c0c93ebc922621c216e5013", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a38c812b526a1a0c7ab7951202c5ab8fa6f9eb7abc59fd51cd56caff189b7fe7f4c07d2d3138d8c8bb69ad4f62ef0ff66faa4699cccfcc1a5e995b698934bb8f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5d424bda1d0ea323f94dff2b4e1bf8d13c17373be7eabd45da37ce01f132b8f6ebeeb8f1d2da5d40d1b37acb5637d36389c5a816f4f372c05bd5489ab75cbb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2388986871d430342932837165bf9277a79a4f5f633ab870f598afffe438b02a867e9f2c968d34ce2012baf7939eea7263562f41e685088324889b38c9b3caa9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 23:06:31.704475) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 23:06:31.704775) ========= 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=ca619d3d7d62c99d832f7b8a000001c4-1495770815.296378-1927970756 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 23:06:31.788958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 23:06:31.789307) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 23:06:31.789597) ========= ========= Total master_lag: 0.15 =========