builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1496139746.89 results: success (0) revision: 286f71223256cbb3a769432fd860f563c4886e81 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:26.894273) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:26.894750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:26.895084) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:26.945178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:26.945494) ========= 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=8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 03:22:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 195M=0s 2017-05-30 03:22:27 (195 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.368270 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:27.336655) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:27.337011) ========= 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=8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017282 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:27.387751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:27.388709) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 286f71223256cbb3a769432fd860f563c4886e81 --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 286f71223256cbb3a769432fd860f563c4886e81 --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=8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 03:22:27,414 truncating revision to first 12 chars 2017-05-30 03:22:27,414 Setting DEBUG logging. 2017-05-30 03:22:27,414 attempt 1/10 2017-05-30 03:22:27,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/286f71223256?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 03:22:28,004 unpacking tar archive at: mozilla-central-286f71223256/testing/mozharness/ program finished with exit code 0 elapsedTime=0.928226 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:28.334704) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:28.335511) ========= script_repo_revision: 286f71223256cbb3a769432fd860f563c4886e81 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:28.336565) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:28.337302) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 03:22:28.347554) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-05-30 03:22:28.348235) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:22:28 INFO - MultiFileLogger online at 20170530 03:22:28 in /builds/slave/test 03:22:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:22:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:22:28 INFO - {'append_to_log': False, 03:22:28 INFO - 'base_work_dir': '/builds/slave/test', 03:22:28 INFO - 'blob_upload_branch': 'Firefox', 03:22:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:22:28 INFO - 'branch': 'Firefox', 03:22:28 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:28 INFO - 'config_files': ('talos/linux_config.py',), 03:22:28 INFO - 'default_actions': ('clobber', 03:22:28 INFO - 'read-buildbot-config', 03:22:28 INFO - 'download-and-extract', 03:22:28 INFO - 'populate-webroot', 03:22:28 INFO - 'create-virtualenv', 03:22:28 INFO - 'install', 03:22:28 INFO - 'setup-mitmproxy', 03:22:28 INFO - 'run-tests'), 03:22:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:28 INFO - 'download_minidump_stackwalk': True, 03:22:28 INFO - 'download_symbols': 'ondemand', 03:22:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:22:28 INFO - 'tooltool.py': '/tools/tooltool.py', 03:22:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:22:28 INFO - '/tools/misc-python/virtualenv.py')}, 03:22:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:28 INFO - 'gecko_profile': False, 03:22:28 INFO - 'gecko_profile_interval': 0, 03:22:28 INFO - 'installer_path': 'installer.exe', 03:22:28 INFO - 'log_level': 'info', 03:22:28 INFO - 'log_name': 'talos', 03:22:28 INFO - 'log_to_console': True, 03:22:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:22:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:22:28 INFO - 'opt_config_files': (), 03:22:28 INFO - 'pip_index': False, 03:22:28 INFO - 'suite': 'dromaeojs-e10s', 03:22:28 INFO - 'system_bits': '32', 03:22:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:28 INFO - 'title': 'talos-linux64-ix-001', 03:22:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:28 INFO - 'use_talos_json': True, 03:22:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:22:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:28 INFO - 'work_dir': 'build'} 03:22:28 INFO - [mozharness: 2017-05-30 10:22:28.593935Z] Running clobber step. 03:22:28 INFO - Running pre-action listener: _resource_record_pre_action 03:22:28 INFO - Running main action method: clobber 03:22:28 INFO - rmtree: /builds/slave/test/build 03:22:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:22:29 INFO - Running post-action listener: _resource_record_post_action 03:22:29 INFO - [mozharness: 2017-05-30 10:22:29.579465Z] Finished clobber step (success) 03:22:29 INFO - [mozharness: 2017-05-30 10:22:29.579565Z] Running read-buildbot-config step. 03:22:29 INFO - Running pre-action listener: _resource_record_pre_action 03:22:29 INFO - Running main action method: read_buildbot_config 03:22:29 INFO - Using buildbot properties: 03:22:29 INFO - { 03:22:29 INFO - "project": "", 03:22:29 INFO - "product": "firefox", 03:22:29 INFO - "who": "cbook@mozilla.com", 03:22:29 INFO - "installer_path": "public/build/target.tar.bz2", 03:22:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:22:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:22:29 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:22:29 INFO - "stage_platform": "linux64-stylosequential", 03:22:29 INFO - "basedir": "/builds/slave/test", 03:22:29 INFO - "buildnumber": 30, 03:22:29 INFO - "platform": "ubuntu64_hw_styloseq", 03:22:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:22:29 INFO - "slavebuilddir": "test", 03:22:29 INFO - "taskId": "IdTH7Yw4TKCrnIHpytU8vg", 03:22:29 INFO - "branch": "mozilla-central", 03:22:29 INFO - "script_repo_revision": "production", 03:22:29 INFO - "revision": "286f71223256cbb3a769432fd860f563c4886e81", 03:22:29 INFO - "slavename": "talos-linux64-ix-001", 03:22:29 INFO - "repo_path": "mozilla-central" 03:22:29 INFO - } 03:22:29 INFO - Finding installer, test and symbols from parent task. 03:22:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IdTH7Yw4TKCrnIHpytU8vg'}, attempt #1 03:22:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IdTH7Yw4TKCrnIHpytU8vg'}, attempt #1 03:22:30 INFO - Task dependencies: KzVL2TxBScyPCA7uP4xUzA 03:22:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA'}, attempt #1 03:22:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.tar.bz2 03:22:30 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/test_packages.json 03:22:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.crashreporter-symbols.zip 03:22:30 INFO - Running post-action listener: _resource_record_post_action 03:22:30 INFO - [mozharness: 2017-05-30 10:22:30.951023Z] Finished read-buildbot-config step (success) 03:22:30 INFO - [mozharness: 2017-05-30 10:22:30.951245Z] Running download-and-extract step. 03:22:30 INFO - Running pre-action listener: _resource_record_pre_action 03:22:30 INFO - Running main action method: download_and_extract 03:22:30 INFO - mkdir: /builds/slave/test/build/tests 03:22:30 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')]} 03:22:30 INFO - trying https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.test_packages.json 03:22:30 INFO - Downloading https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:22:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:22:31 INFO - Downloaded 986 bytes. 03:22:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:22:31 INFO - Using the following test package requirements: 03:22:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:22:31 INFO - u'common': [u'target.common.tests.zip'], 03:22:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:22:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:22:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:22:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:22:31 INFO - u'mozbase': [u'target.common.tests.zip'], 03:22:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:22:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:22:31 INFO - u'web-platform': [u'target.common.tests.zip', 03:22:31 INFO - u'target.web-platform.tests.zip'], 03:22:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:22:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:22:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.common.tests.zip 03:22:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:22:31 INFO - Fetch https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.common.tests.zip into memory 03:22:32 INFO - Content-Length response header: 63528757 03:22:32 INFO - Bytes received: 63528757 03:22:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:22:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.common.tests.zip 03:22:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:22:44 INFO - Fetch https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.common.tests.zip into memory 03:22:45 INFO - Content-Length response header: 63528757 03:22:45 INFO - Bytes received: 63528757 03:22:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.talos.tests.zip 03:22:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:22:57 INFO - Fetch https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.talos.tests.zip into memory 03:22:58 INFO - Content-Length response header: 14447425 03:22:58 INFO - Bytes received: 14447425 03:22:58 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')]} 03:22:58 INFO - trying https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.tar.bz2 03:22:58 INFO - Downloading https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:22:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:22:59 INFO - Downloaded 56012935 bytes. 03:22:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.tar.bz2 03:22:59 INFO - mkdir: /builds/slave/test/properties 03:22:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:22:59 INFO - Writing to file /builds/slave/test/properties/build_url 03:22:59 INFO - Contents: 03:22:59 INFO - build_url:https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.tar.bz2 03:22:59 INFO - Running post-action listener: _resource_record_post_action 03:22:59 INFO - Running post-action listener: set_extra_try_arguments 03:22:59 INFO - [mozharness: 2017-05-30 10:22:59.433530Z] Finished download-and-extract step (success) 03:22:59 INFO - [mozharness: 2017-05-30 10:22:59.433646Z] Running populate-webroot step. 03:22:59 INFO - Running pre-action listener: _resource_record_pre_action 03:22:59 INFO - Running main action method: populate_webroot 03:22:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:22:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:22:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:22:59 INFO - '--tppagecycles', 03:22:59 INFO - '7'], 03:22:59 INFO - 'tests': ['tsvgm']}}, 03:22:59 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:22:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:22:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:22:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:22:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:22:59 INFO - 'talos_options': ['--disable-e10s'], 03:22:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:22:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:22:59 INFO - 'talos_options': ['--disable-e10s'], 03:22:59 INFO - 'tests': ['damp', 'tps']}, 03:22:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:22:59 INFO - 'tests': ['damp', 'tps']}, 03:22:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:22:59 INFO - 'tests': ['dromaeo_dom']}, 03:22:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:22:59 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:22:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:22:59 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:22:59 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:22:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:22:59 INFO - 'tests': ['a11yr', 03:22:59 INFO - 'ts_paint', 03:22:59 INFO - 'tpaint', 03:22:59 INFO - 'sessionrestore', 03:22:59 INFO - 'sessionrestore_no_auto_restore', 03:22:59 INFO - 'tabpaint']}, 03:22:59 INFO - 'other-e10s': {'tests': ['a11yr', 03:22:59 INFO - 'ts_paint', 03:22:59 INFO - 'tpaint', 03:22:59 INFO - 'sessionrestore', 03:22:59 INFO - 'sessionrestore_no_auto_restore', 03:22:59 INFO - 'tabpaint']}, 03:22:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:22:59 INFO - 'ts_paint', 03:22:59 INFO - 'tpaint', 03:22:59 INFO - 'sessionrestore', 03:22:59 INFO - 'sessionrestore_no_auto_restore', 03:22:59 INFO - 'tabpaint']}, 03:22:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:22:59 INFO - 'ts_paint', 03:22:59 INFO - 'tpaint', 03:22:59 INFO - 'sessionrestore', 03:22:59 INFO - 'sessionrestore_no_auto_restore', 03:22:59 INFO - 'tabpaint']}, 03:22:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:22:59 INFO - 'tests': ['a11yr', 03:22:59 INFO - 'ts_paint', 03:22:59 INFO - 'tpaint', 03:22:59 INFO - 'sessionrestore', 03:22:59 INFO - 'sessionrestore_no_auto_restore', 03:22:59 INFO - 'tabpaint']}, 03:22:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:22:59 INFO - 'tests': ['a11yr', 03:22:59 INFO - 'ts_paint', 03:22:59 INFO - 'tpaint', 03:22:59 INFO - 'sessionrestore', 03:22:59 INFO - 'sessionrestore_no_auto_restore', 03:22:59 INFO - 'tabpaint']}, 03:22:59 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:22:59 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:22:59 INFO - 'bloom_basic_ref']}, 03:22:59 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 03:22:59 INFO - 'talos_options': ['--mitmproxy', 03:22:59 INFO - 'mitmproxy-recording-1.mp', 03:22:59 INFO - '--firstNonBlankPaint'], 03:22:59 INFO - 'tests': ['Quantum_1']}, 03:22:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:22:59 INFO - 'tests': ['tsvgx', 03:22:59 INFO - 'tsvgr_opacity', 03:22:59 INFO - 'tart', 03:22:59 INFO - 'tscrollx', 03:22:59 INFO - 'cart', 03:22:59 INFO - 'tsvg_static']}, 03:22:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:22:59 INFO - 'tsvgr_opacity', 03:22:59 INFO - 'tart', 03:22:59 INFO - 'tscrollx', 03:22:59 INFO - 'cart', 03:22:59 INFO - 'tsvg_static']}, 03:22:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:22:59 INFO - 'talos_options': ['--disable-e10s'], 03:22:59 INFO - 'tests': ['tp5o']}, 03:22:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:22:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:22:59 INFO - 'talos_options': ['--disable-e10s', 03:22:59 INFO - '--xperf_path', 03:22:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:59 INFO - 'tests': ['tp5n']}, 03:22:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:22:59 INFO - 'talos_options': ['--xperf_path', 03:22:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:59 INFO - 'tests': ['tp5n']}}, 03:22:59 INFO - 'talos.zip': {'path': '', 03:22:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:22:59 INFO - Running post-action listener: _resource_record_post_action 03:22:59 INFO - [mozharness: 2017-05-30 10:22:59.450267Z] Finished populate-webroot step (success) 03:22:59 INFO - [mozharness: 2017-05-30 10:22:59.450357Z] Running create-virtualenv step. 03:22:59 INFO - Running pre-action listener: _resource_record_pre_action 03:22:59 INFO - Running main action method: create_virtualenv 03:22:59 INFO - Creating virtualenv /builds/slave/test/build/venv 03:22:59 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 03:22:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:22:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:59 INFO - Using real prefix '/usr' 03:22:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:23:00 INFO - Installing distribute.............................................................................................................................................................................................done. 03:23:02 INFO - Installing pip.................done. 03:23:02 INFO - Return code: 0 03:23:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:23:02 INFO - Reading from file tmpfile_stdout 03:23:02 INFO - Output received: 03:23:02 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) 03:23:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:23:02 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')]} 03:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:02 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')]} 03:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:02 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 0x21dc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556e40>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', '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 03:23:02 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 03:23:02 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 03:23:02 INFO - Using env: {'DISPLAY': ':0', 03:23:02 INFO - 'HOME': '/home/cltbld', 03:23:02 INFO - 'LANG': 'en_US.UTF-8', 03:23:02 INFO - 'LANGUAGE': 'en_US:en', 03:23:02 INFO - 'LOGNAME': 'cltbld', 03:23:02 INFO - 'MAIL': '/var/mail/cltbld', 03:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:02 INFO - 'MOZ_NO_REMOTE': '1', 03:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:02 INFO - 'NO_EM_RESTART': '1', 03:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:02 INFO - 'PWD': '/builds/slave/test', 03:23:02 INFO - 'SHELL': '/bin/bash', 03:23:02 INFO - 'SHLVL': '1', 03:23:02 INFO - 'TERM': 'linux', 03:23:02 INFO - 'TMOUT': '86400', 03:23:02 INFO - 'USER': 'cltbld', 03:23:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', 03:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:02 INFO - '_': '/tools/buildbot/bin/python'} 03:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:02 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 03:23:02 INFO - Cleaning up... 03:23:02 INFO - Return code: 0 03:23:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:23:02 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')]} 03:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:02 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')]} 03:23:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:02 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 0x21dc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556e40>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', '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 03:23:02 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 03:23:02 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 03:23:02 INFO - Using env: {'DISPLAY': ':0', 03:23:02 INFO - 'HOME': '/home/cltbld', 03:23:02 INFO - 'LANG': 'en_US.UTF-8', 03:23:02 INFO - 'LANGUAGE': 'en_US:en', 03:23:02 INFO - 'LOGNAME': 'cltbld', 03:23:02 INFO - 'MAIL': '/var/mail/cltbld', 03:23:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:02 INFO - 'MOZ_NO_REMOTE': '1', 03:23:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:02 INFO - 'NO_EM_RESTART': '1', 03:23:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:02 INFO - 'PWD': '/builds/slave/test', 03:23:02 INFO - 'SHELL': '/bin/bash', 03:23:02 INFO - 'SHLVL': '1', 03:23:02 INFO - 'TERM': 'linux', 03:23:02 INFO - 'TMOUT': '86400', 03:23:02 INFO - 'USER': 'cltbld', 03:23:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', 03:23:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:02 INFO - '_': '/tools/buildbot/bin/python'} 03:23:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:02 INFO - Downloading/unpacking psutil>=3.1.1 03:23:02 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 03:23:02 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 03:23:02 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 03:23:02 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 03:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:23:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:04 INFO - Installing collected packages: psutil 03:23:04 INFO - Running setup.py install for psutil 03:23:04 INFO - building 'psutil._psutil_linux' extension 03:23:04 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 03:23:05 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 03:23:05 INFO - building 'psutil._psutil_posix' extension 03:23:05 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 03:23:05 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 03:23:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:23:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:23:05 INFO - Successfully installed psutil 03:23:05 INFO - Cleaning up... 03:23:05 INFO - Return code: 0 03:23:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:23:05 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')]} 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:05 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')]} 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:05 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 0x21dc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556e40>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', '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 03:23:05 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 03:23:05 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 03:23:05 INFO - Using env: {'DISPLAY': ':0', 03:23:05 INFO - 'HOME': '/home/cltbld', 03:23:05 INFO - 'LANG': 'en_US.UTF-8', 03:23:05 INFO - 'LANGUAGE': 'en_US:en', 03:23:05 INFO - 'LOGNAME': 'cltbld', 03:23:05 INFO - 'MAIL': '/var/mail/cltbld', 03:23:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:05 INFO - 'MOZ_NO_REMOTE': '1', 03:23:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:05 INFO - 'NO_EM_RESTART': '1', 03:23:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:05 INFO - 'PWD': '/builds/slave/test', 03:23:05 INFO - 'SHELL': '/bin/bash', 03:23:05 INFO - 'SHLVL': '1', 03:23:05 INFO - 'TERM': 'linux', 03:23:05 INFO - 'TMOUT': '86400', 03:23:05 INFO - 'USER': 'cltbld', 03:23:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', 03:23:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:05 INFO - '_': '/tools/buildbot/bin/python'} 03:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:23:05 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 03:23:05 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 03:23:05 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 03:23:05 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 03:23:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:23:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:23:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:23:06 INFO - Installing collected packages: mozsystemmonitor 03:23:06 INFO - Running setup.py install for mozsystemmonitor 03:23:06 INFO - Successfully installed mozsystemmonitor 03:23:06 INFO - Cleaning up... 03:23:06 INFO - Return code: 0 03:23:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:06 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 0x21dc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556e40>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', '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 03:23:06 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 03:23:06 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 03:23:06 INFO - Using env: {'DISPLAY': ':0', 03:23:06 INFO - 'HOME': '/home/cltbld', 03:23:06 INFO - 'LANG': 'en_US.UTF-8', 03:23:06 INFO - 'LANGUAGE': 'en_US:en', 03:23:06 INFO - 'LOGNAME': 'cltbld', 03:23:06 INFO - 'MAIL': '/var/mail/cltbld', 03:23:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:06 INFO - 'MOZ_NO_REMOTE': '1', 03:23:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:06 INFO - 'NO_EM_RESTART': '1', 03:23:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:06 INFO - 'PWD': '/builds/slave/test', 03:23:06 INFO - 'SHELL': '/bin/bash', 03:23:06 INFO - 'SHLVL': '1', 03:23:06 INFO - 'TERM': 'linux', 03:23:06 INFO - 'TMOUT': '86400', 03:23:06 INFO - 'USER': 'cltbld', 03:23:06 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', 03:23:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:06 INFO - '_': '/tools/buildbot/bin/python'} 03:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:07 INFO - Downloading/unpacking jsonschema==2.5.1 03:23:07 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 03:23:07 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 03:23:07 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 03:23:07 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 03:23:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:23:08 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 03:23:08 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 03:23:08 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 03:23:08 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 03:23:08 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:08 INFO - warning: no files found matching '*.txt' 03:23:08 INFO - no previously-included directories found matching 'build' 03:23:08 INFO - no previously-included directories found matching 'dist' 03:23:08 INFO - no previously-included directories found matching '.git*' 03:23:08 INFO - Installing collected packages: jsonschema, functools32 03:23:08 INFO - Running setup.py install for functools32 03:23:08 INFO - warning: no files found matching '*.txt' 03:23:08 INFO - no previously-included directories found matching 'build' 03:23:08 INFO - no previously-included directories found matching 'dist' 03:23:08 INFO - no previously-included directories found matching '.git*' 03:23:08 INFO - Successfully installed jsonschema functools32 03:23:08 INFO - Cleaning up... 03:23:08 INFO - Return code: 0 03:23:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21dc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556e40>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', '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 03:23:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:23:08 INFO - Using env: {'DISPLAY': ':0', 03:23:08 INFO - 'HOME': '/home/cltbld', 03:23:08 INFO - 'LANG': 'en_US.UTF-8', 03:23:08 INFO - 'LANGUAGE': 'en_US:en', 03:23:08 INFO - 'LOGNAME': 'cltbld', 03:23:08 INFO - 'MAIL': '/var/mail/cltbld', 03:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:08 INFO - 'MOZ_NO_REMOTE': '1', 03:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:08 INFO - 'NO_EM_RESTART': '1', 03:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:08 INFO - 'PWD': '/builds/slave/test', 03:23:08 INFO - 'SHELL': '/bin/bash', 03:23:08 INFO - 'SHLVL': '1', 03:23:08 INFO - 'TERM': 'linux', 03:23:08 INFO - 'TMOUT': '86400', 03:23:08 INFO - 'USER': 'cltbld', 03:23:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', 03:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:08 INFO - '_': '/tools/buildbot/bin/python'} 03:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:23:08 INFO - Cleaning up... 03:23:08 INFO - Return code: 0 03:23:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x21dc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556e40>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', '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 03:23:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:23:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:23:08 INFO - Using env: {'DISPLAY': ':0', 03:23:08 INFO - 'HOME': '/home/cltbld', 03:23:08 INFO - 'LANG': 'en_US.UTF-8', 03:23:08 INFO - 'LANGUAGE': 'en_US:en', 03:23:08 INFO - 'LOGNAME': 'cltbld', 03:23:08 INFO - 'MAIL': '/var/mail/cltbld', 03:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:08 INFO - 'MOZ_NO_REMOTE': '1', 03:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:08 INFO - 'NO_EM_RESTART': '1', 03:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:08 INFO - 'PWD': '/builds/slave/test', 03:23:08 INFO - 'SHELL': '/bin/bash', 03:23:08 INFO - 'SHLVL': '1', 03:23:08 INFO - 'TERM': 'linux', 03:23:08 INFO - 'TMOUT': '86400', 03:23:08 INFO - 'USER': 'cltbld', 03:23:08 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', 03:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:08 INFO - '_': '/tools/buildbot/bin/python'} 03:23:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:09 INFO - Downloading/unpacking blobuploader==1.2.4 03:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:10 INFO - Downloading blobuploader-1.2.4.tar.gz 03:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:23:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:23:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:10 INFO - Downloading docopt-0.6.1.tar.gz 03:23:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:23:10 INFO - Installing collected packages: blobuploader, requests, docopt 03:23:10 INFO - Running setup.py install for blobuploader 03:23:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:23:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:23:10 INFO - Running setup.py install for requests 03:23:11 INFO - Running setup.py install for docopt 03:23:11 INFO - Successfully installed blobuploader requests docopt 03:23:11 INFO - Cleaning up... 03:23:11 INFO - Return code: 0 03:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:11 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 0x21dc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556e40>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', '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 03:23:11 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 03:23:11 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 03:23:11 INFO - Using env: {'DISPLAY': ':0', 03:23:11 INFO - 'HOME': '/home/cltbld', 03:23:11 INFO - 'LANG': 'en_US.UTF-8', 03:23:11 INFO - 'LANGUAGE': 'en_US:en', 03:23:11 INFO - 'LOGNAME': 'cltbld', 03:23:11 INFO - 'MAIL': '/var/mail/cltbld', 03:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:11 INFO - 'MOZ_NO_REMOTE': '1', 03:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:11 INFO - 'NO_EM_RESTART': '1', 03:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:11 INFO - 'PWD': '/builds/slave/test', 03:23:11 INFO - 'SHELL': '/bin/bash', 03:23:11 INFO - 'SHLVL': '1', 03:23:11 INFO - 'TERM': 'linux', 03:23:11 INFO - 'TMOUT': '86400', 03:23:11 INFO - 'USER': 'cltbld', 03:23:11 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', 03:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:11 INFO - '_': '/tools/buildbot/bin/python'} 03:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:11 INFO - Running setup.py (path:/tmp/pip-13efJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:11 INFO - Running setup.py (path:/tmp/pip-JHbi3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:11 INFO - Running setup.py (path:/tmp/pip-dYBVHI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:11 INFO - Running setup.py (path:/tmp/pip-pgASSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:11 INFO - Running setup.py (path:/tmp/pip-FMc0Xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:11 INFO - Running setup.py (path:/tmp/pip-rh9LfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:11 INFO - Running setup.py (path:/tmp/pip-qEtb7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:12 INFO - Running setup.py (path:/tmp/pip-kRDvQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:12 INFO - Running setup.py (path:/tmp/pip-Cu4Sse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:12 INFO - Running setup.py (path:/tmp/pip-vBDKUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:12 INFO - Running setup.py (path:/tmp/pip-d5Ffsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:12 INFO - Running setup.py (path:/tmp/pip-Zj7jJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:12 INFO - Running setup.py (path:/tmp/pip-oF6Nok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:12 INFO - Running setup.py (path:/tmp/pip-PjKTMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:12 INFO - Running setup.py (path:/tmp/pip-WaeSwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:12 INFO - Running setup.py (path:/tmp/pip-QjsOPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:12 INFO - Running setup.py (path:/tmp/pip-eq0QAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:23:12 INFO - Running setup.py install for manifestparser 03:23:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:23:12 INFO - Running setup.py install for mozcrash 03:23:12 INFO - Running setup.py install for mozdebug 03:23:13 INFO - Running setup.py install for mozdevice 03:23:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:23:13 INFO - Running setup.py install for mozfile 03:23:13 INFO - Running setup.py install for mozhttpd 03:23:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:23:13 INFO - Running setup.py install for mozinfo 03:23:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:23:13 INFO - Running setup.py install for mozInstall 03:23:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:23:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:23:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:23:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:23:13 INFO - Running setup.py install for mozleak 03:23:13 INFO - Running setup.py install for mozlog 03:23:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:23:13 INFO - Running setup.py install for moznetwork 03:23:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:23:13 INFO - Running setup.py install for mozprocess 03:23:13 INFO - Running setup.py install for mozprofile 03:23:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:23:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:23:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:23:14 INFO - Running setup.py install for mozrunner 03:23:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:23:14 INFO - Running setup.py install for mozscreenshot 03:23:14 INFO - Running setup.py install for moztest 03:23:14 INFO - Running setup.py install for mozversion 03:23:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:23:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:14 INFO - Cleaning up... 03:23:14 INFO - Return code: 0 03:23:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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')]} 03:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:14 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 0x21dc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556e40>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', '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 03:23:14 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 03:23:14 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 03:23:14 INFO - Using env: {'DISPLAY': ':0', 03:23:14 INFO - 'HOME': '/home/cltbld', 03:23:14 INFO - 'LANG': 'en_US.UTF-8', 03:23:14 INFO - 'LANGUAGE': 'en_US:en', 03:23:14 INFO - 'LOGNAME': 'cltbld', 03:23:14 INFO - 'MAIL': '/var/mail/cltbld', 03:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:14 INFO - 'MOZ_NO_REMOTE': '1', 03:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:14 INFO - 'NO_EM_RESTART': '1', 03:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:14 INFO - 'PWD': '/builds/slave/test', 03:23:14 INFO - 'SHELL': '/bin/bash', 03:23:14 INFO - 'SHLVL': '1', 03:23:14 INFO - 'TERM': 'linux', 03:23:14 INFO - 'TMOUT': '86400', 03:23:14 INFO - 'USER': 'cltbld', 03:23:14 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', 03:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:14 INFO - '_': '/tools/buildbot/bin/python'} 03:23:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:23:14 INFO - Running setup.py (path:/tmp/pip-zKRqwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:23:14 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)) 03:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:23:14 INFO - Running setup.py (path:/tmp/pip-tmP1Oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:23:14 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)) 03:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:23:14 INFO - Running setup.py (path:/tmp/pip-_qCxK_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:23:14 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)) 03:23:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:23:14 INFO - Running setup.py (path:/tmp/pip-JBwsRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:23:15 INFO - Running setup.py (path:/tmp/pip-F2xWY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:23:15 INFO - Running setup.py (path:/tmp/pip-9wU9KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:23:15 INFO - Running setup.py (path:/tmp/pip-01OXUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:23:15 INFO - Running setup.py (path:/tmp/pip-mybZSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:23:15 INFO - Running setup.py (path:/tmp/pip-5vKGhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:23:15 INFO - Running setup.py (path:/tmp/pip-PZ0i56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:23:15 INFO - Running setup.py (path:/tmp/pip-KOY_aW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:23:15 INFO - Running setup.py (path:/tmp/pip-vG1iO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:23:15 INFO - Running setup.py (path:/tmp/pip-pfM_Qj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:23:15 INFO - Running setup.py (path:/tmp/pip-USjOff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:15 INFO - Running setup.py (path:/tmp/pip-AlE5rO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:23:15 INFO - Running setup.py (path:/tmp/pip-8vKa5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:23:15 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)) 03:23:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:23:15 INFO - Running setup.py (path:/tmp/pip-nFqXKb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:23:15 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)) 03:23:15 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)) 03:23:15 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)) 03:23:15 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)) 03:23:15 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)) 03:23:15 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)) 03:23:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:17 INFO - Downloading blessings-1.6.tar.gz 03:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:17 INFO - Installing collected packages: blessings 03:23:17 INFO - Running setup.py install for blessings 03:23:17 INFO - Successfully installed blessings 03:23:17 INFO - Cleaning up... 03:23:17 INFO - Return code: 0 03:23:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:23:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:17 INFO - Reading from file tmpfile_stdout 03:23:17 INFO - Current package versions: 03:23:17 INFO - argparse == 1.2.1 03:23:17 INFO - blessings == 1.6 03:23:17 INFO - blobuploader == 1.2.4 03:23:17 INFO - docopt == 0.6.1 03:23:17 INFO - functools32 == 3.2.3-2 03:23:17 INFO - jsonschema == 2.5.1 03:23:17 INFO - manifestparser == 1.1 03:23:17 INFO - mozInstall == 1.12 03:23:17 INFO - mozcrash == 1.0 03:23:17 INFO - mozdebug == 0.1 03:23:17 INFO - mozdevice == 0.51 03:23:17 INFO - mozfile == 1.2 03:23:17 INFO - mozhttpd == 0.7 03:23:17 INFO - mozinfo == 0.9 03:23:17 INFO - mozleak == 0.1 03:23:17 INFO - mozlog == 3.4 03:23:17 INFO - moznetwork == 0.27 03:23:17 INFO - mozprocess == 0.25 03:23:17 INFO - mozprofile == 0.28 03:23:17 INFO - mozrunner == 6.13 03:23:17 INFO - mozscreenshot == 0.1 03:23:17 INFO - mozsystemmonitor == 0.3 03:23:17 INFO - moztest == 0.8 03:23:17 INFO - mozversion == 1.4 03:23:17 INFO - psutil == 3.1.1 03:23:17 INFO - requests == 1.2.3 03:23:17 INFO - wsgiref == 0.1.2 03:23:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:23: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')]} 03:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23: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')]} 03:23:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:17 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 0x21dc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556e40>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', '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 03:23:17 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 03:23:17 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 03:23:17 INFO - Using env: {'DISPLAY': ':0', 03:23:17 INFO - 'HOME': '/home/cltbld', 03:23:17 INFO - 'LANG': 'en_US.UTF-8', 03:23:17 INFO - 'LANGUAGE': 'en_US:en', 03:23:17 INFO - 'LOGNAME': 'cltbld', 03:23:17 INFO - 'MAIL': '/var/mail/cltbld', 03:23:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:17 INFO - 'MOZ_NO_REMOTE': '1', 03:23:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:17 INFO - 'NO_EM_RESTART': '1', 03:23:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:17 INFO - 'PWD': '/builds/slave/test', 03:23:17 INFO - 'SHELL': '/bin/bash', 03:23:17 INFO - 'SHLVL': '1', 03:23:17 INFO - 'TERM': 'linux', 03:23:17 INFO - 'TMOUT': '86400', 03:23:17 INFO - 'USER': 'cltbld', 03:23:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', 03:23:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:17 INFO - '_': '/tools/buildbot/bin/python'} 03:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:17 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)) 03:23:17 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)) 03:23:17 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)) 03:23:17 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)) 03:23:17 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)) 03:23:17 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)) 03:23:17 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)) 03:23:17 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)) 03:23:17 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)) 03:23:17 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:23: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 03:23: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 03:23: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 03:23: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 03:23:18 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:23:19 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)) 03:23:19 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)) 03:23:19 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)) 03:23:19 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)) 03:23:19 INFO - Installing collected packages: marionette-driver 03:23:19 INFO - Running setup.py install for marionette-driver 03:23:19 INFO - Successfully installed marionette-driver 03:23:19 INFO - Cleaning up... 03:23:19 INFO - Return code: 0 03:23:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:23:19 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')]} 03:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:19 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')]} 03:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:19 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 0x21dc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2559ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2556e40>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, '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': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', '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 03:23:19 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 03:23:19 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 03:23:19 INFO - Using env: {'DISPLAY': ':0', 03:23:19 INFO - 'HOME': '/home/cltbld', 03:23:19 INFO - 'LANG': 'en_US.UTF-8', 03:23:19 INFO - 'LANGUAGE': 'en_US:en', 03:23:19 INFO - 'LOGNAME': 'cltbld', 03:23:19 INFO - 'MAIL': '/var/mail/cltbld', 03:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:19 INFO - 'MOZ_NO_REMOTE': '1', 03:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:19 INFO - 'NO_EM_RESTART': '1', 03:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:19 INFO - 'PWD': '/builds/slave/test', 03:23:19 INFO - 'SHELL': '/bin/bash', 03:23:19 INFO - 'SHLVL': '1', 03:23:19 INFO - 'TERM': 'linux', 03:23:19 INFO - 'TMOUT': '86400', 03:23:19 INFO - 'USER': 'cltbld', 03:23:19 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', 03:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:19 INFO - '_': '/tools/buildbot/bin/python'} 03:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:23:19 INFO - Cleaning up... 03:23:19 INFO - Return code: 0 03:23:19 INFO - Running post-action listener: _resource_record_post_action 03:23:19 INFO - Running post-action listener: _start_resource_monitoring 03:23:19 INFO - Starting resource monitoring. 03:23:19 INFO - [mozharness: 2017-05-30 10:23:19.461130Z] Finished create-virtualenv step (success) 03:23:19 INFO - [mozharness: 2017-05-30 10:23:19.461655Z] Running install step. 03:23:19 INFO - Running pre-action listener: _resource_record_pre_action 03:23:19 INFO - Running main action method: install 03:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:23:19 INFO - Reading from file tmpfile_stdout 03:23:19 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:23:19 INFO - Reading from file tmpfile_stdout 03:23:19 INFO - Output received: 03:23:19 INFO - Usage: mozinstall [options] installer 03:23:19 INFO - Options: 03:23:19 INFO - -h, --help show this help message and exit 03:23:19 INFO - -d DEST, --destination=DEST 03:23:19 INFO - Directory to install application into. [default: 03:23:19 INFO - "/builds/slave/test"] 03:23:19 INFO - --app=APP Application being installed. [default: firefox] 03:23:19 INFO - mkdir: /builds/slave/test/build/application 03:23:19 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'] 03:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:23:36 INFO - Reading from file tmpfile_stdout 03:23:36 INFO - Output received: 03:23:36 INFO - /builds/slave/test/build/application/firefox/firefox 03:23:36 INFO - Running post-action listener: _resource_record_post_action 03:23:36 INFO - [mozharness: 2017-05-30 10:23:36.520351Z] Finished install step (success) 03:23:36 INFO - [mozharness: 2017-05-30 10:23:36.520627Z] Running setup-mitmproxy step. 03:23:36 INFO - Running pre-action listener: _resource_record_pre_action 03:23:36 INFO - Running main action method: setup_mitmproxy 03:23:36 INFO - Skipping: mitmproxy is not required 03:23:36 INFO - Running post-action listener: _resource_record_post_action 03:23:36 INFO - [mozharness: 2017-05-30 10:23:36.521814Z] Finished setup-mitmproxy step (success) 03:23:36 INFO - [mozharness: 2017-05-30 10:23:36.522034Z] Running run-tests step. 03:23:36 INFO - Running pre-action listener: _resource_record_pre_action 03:23:36 INFO - Running main action method: run_tests 03:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:23:36 INFO - Python 2.7.3 03:23:36 INFO - Return code: 0 03:23:36 INFO - grabbing minidump binary from tooltool 03:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:23:36 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 0x2556e40>, '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 0x2557fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2558440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:23:36 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 03:23:36 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 03:23:36 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 03:23:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:36 INFO - Return code: 0 03:23:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:23:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:23:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:23:36 INFO - ENV: RUST_BACKTRACE is now 1 03:23:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:23:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:23:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 03:23:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 03:23:36 INFO - Using env: {'DISPLAY': ':0', 03:23:36 INFO - 'HOME': '/home/cltbld', 03:23:36 INFO - 'LANG': 'en_US.UTF-8', 03:23:36 INFO - 'LANGUAGE': 'en_US:en', 03:23:36 INFO - 'LOGNAME': 'cltbld', 03:23:36 INFO - 'MAIL': '/var/mail/cltbld', 03:23:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:23:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:23:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:36 INFO - 'MOZ_NO_REMOTE': '1', 03:23:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:23:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:36 INFO - 'NO_EM_RESTART': '1', 03:23:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:23:36 INFO - 'PWD': '/builds/slave/test', 03:23:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:23:36 INFO - 'RUST_BACKTRACE': '1', 03:23:36 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:23:36 INFO - 'SHELL': '/bin/bash', 03:23:36 INFO - 'SHLVL': '1', 03:23:36 INFO - 'TERM': 'linux', 03:23:36 INFO - 'TMOUT': '86400', 03:23:36 INFO - 'USER': 'cltbld', 03:23:36 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074', 03:23:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:36 INFO - '_': '/tools/buildbot/bin/python'} 03:23:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 03:23:36 INFO - mozversion application_buildid: 20170530093911 03:23:36 INFO - mozversion application_changeset: 286f71223256cbb3a769432fd860f563c4886e81 03:23:36 INFO - mozversion application_display_name: Nightly 03:23:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:36 INFO - mozversion application_name: Firefox 03:23:36 INFO - mozversion application_remotingname: firefox 03:23:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:23:36 INFO - mozversion application_vendor: Mozilla 03:23:36 INFO - mozversion application_version: 55.0a1 03:23:36 INFO - mozversion platform_buildid: 20170530093911 03:23:36 INFO - mozversion platform_changeset: 286f71223256cbb3a769432fd860f563c4886e81 03:23:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:23:36 INFO - mozversion platform_version: 55.0a1 03:23:36 INFO - using testdate: 1496139816 03:23:36 INFO - actual date: 1496139816 03:23:36 INFO - starting webserver on 'localhost:51643' 03:23:36 INFO - SUITE-START | Running 2 tests 03:23:36 INFO - TEST-START | dromaeo_css 03:23:36 INFO - operating with platform_type : linux_ 03:23:36 INFO - Initialising browser for dromaeo_css test... 03:23:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51643/getInfo.html -profile /tmp/tmphPQSMD/profile 03:23:36 INFO - TEST-INFO | started process 3347 (/builds/slave/test/build/application/firefox/firefox http://localhost:51643/getInfo.html) 03:24:13 INFO - TEST-INFO | 3347: killed by SIGTERM 03:24:13 INFO - Browser initialized. 03:24:13 INFO - Running cycle 1/1 for dromaeo_css test... 03:24:13 INFO - TEST-INFO | started process 3571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphPQSMD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:25 INFO - PID 3571 | RSS: Main: 186486784 03:24:25 INFO - PID 3571 | 03:27:30 INFO - PID 3571 | Cycle 1(1): loaded http://localhost:51643/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51643/tests/dromaeo/cssquery-ext.html) 03:27:32 INFO - PID 3571 | RSS: Main: 183300096 03:27:32 INFO - PID 3571 | 03:30:34 INFO - PID 3571 | Cycle 1(1): loaded http://localhost:51643/tests/dromaeo/cssquery-ext.html (next: http://localhost:51643/tests/dromaeo/cssquery-jquery.html) 03:30:34 INFO - PID 3571 | RSS: Main: 187244544 03:30:34 INFO - PID 3571 | 03:33:36 INFO - PID 3571 | Cycle 1(1): loaded http://localhost:51643/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51643/tests/dromaeo/cssquery-mootools.html) 03:33:37 INFO - PID 3571 | RSS: Main: 184201216 03:33:37 INFO - PID 3571 | 03:36:39 INFO - PID 3571 | Cycle 1(1): loaded http://localhost:51643/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51643/tests/dromaeo/cssquery-prototype.html) 03:36:39 INFO - PID 3571 | RSS: Main: 188145664 03:36:39 INFO - PID 3571 | 03:39:42 INFO - PID 3571 | Cycle 1(1): loaded http://localhost:51643/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51643/tests/dromaeo/cssquery-yui.html) 03:39:43 INFO - PID 3571 | RSS: Main: 187326464 03:39:43 INFO - PID 3571 | 03:42:45 INFO - PID 3571 | Cycle 1(1): loaded http://localhost:51643/tests/dromaeo/cssquery-yui.html (next: http://localhost:51643/tests/dromaeo/cssquery-dojo.html) 03:42:45 INFO - PID 3571 | RSS: Main: 185278464 03:42:45 INFO - PID 3571 | 03:42:45 INFO - PID 3571 | __start_tp_report 03:42:45 INFO - PID 3571 | _x_x_mozilla_page_load 03:42:45 INFO - PID 3571 | _x_x_mozilla_page_load_details 03:42:45 INFO - PID 3571 | |i|pagename|runs| 03:42:45 INFO - PID 3571 | |0;dojo.html;2738.0280000599773;2743.6570428696414;2762.585612158176;2773.889044438222;2779.1106845809336;5080.288759573663;5227.8693032674155;5230.738463076846;5261.079311120558;5295.496927791858;5200.245964335169;5216.426193118763;5255.159174532066;5317.388500322464;5343;4667.2065748822615;4686.718796872198;4707.599854012413;4731.8817029574275;4755.90488190236;4667.813287468497;4726.8581942541605;4782.04359128174;4790.329353890458;4809.807607695688;4592.816287348502;4633.142868569325;4680.508546602592;4715.056988602293;4783.28250762385;4610.423697037871;4657.39453870998;4670.696404733681;4673.158831410345;4691.7184968901975;4642.9071418571775;4679.438467383936;4699.7415142167165;4701.952980470186;4733.857984260443;5171.637985341028;5233.842984710464;5235;5242.737863106868;5263.499967503081;5492.176173573956;5555.2778138842095;5625.38120806711;5724.341700704431;5728.598998070137;5602.187682786014;5612.045952188138;5614.522765564891;5675.6878371689545;5686.260786097822;5220.686758794484;5225.764840582183;5257.395399529027;5258.447862974409;5269.104252277122;5693.3168019837885;5738.225339579103;5754.769809207669;5790.739416726173;5792.565557583198;5456.672599644034;5511.779528818803;5526.50261476461;5555.194496798023;5577.721113944368;5646.2942132233475;5685.0619647758485;5691.516221121168;5697.971510142505;5698.800541981011;5496.203050557727;5513.862153446115;5617.775288988395;5632.746526406321;5637.605367624227;5509.504144626922;5515.200295957064;5585.3297604287745;5608.663480191201;5639.013172694762;4674.135284972291;4691.225947718656;4695.43654761424;4701;4740.3837501124635;4020.19596080785;4030.6775457963295;4045.615666511677;4048.109415928491;4086.346184610448;4729.243321068681;4795.184818580849;4797.832075877397;4853.635977301717;4860.441049279308;5747.683877386784;5754.1944127822135;5761.510271626875;5762.538996880324;5787.913181302284;4842.927356089662;4855.757212139379;4865.1242776300605;4866.099771542276;4898.363212782316;4892.412910450697;4926.581240594518;4966.1309270877455;4999.950000499948;5007.4491805901325;5398.865028374322;5423.213634022965;5426.647267927572;5440.183972404171;5452.509274165344;5532.280803495681;5629.746661400165;5715.31416230055;5721.141828725725;5729.627574207663;5281.762320695655;5287.180487024518;5292.02097611943;5297.947020529746;5300.70846103468;5534.584906131976;5580.609357345109;5655.095184770417;5685.516731077904;5699.458551437607;5752.050911599539;5772.797952071657;5778.8266352009505;5787.131930210502;5790.623609465371;5421.7560209791445;5501.367342755634;5517.255170552085;5550.916736249041;5597.580181486323;5460.180972853945;5475.09660905962;5482.2873026506295;5515.917261241165;5516;5364.222187782671;5396.406395296436;5407.837314977299;5407.83776486706;5442.945570544244;5406.864828379322;5525.834224973257;5537;5554.861128471821;5566.721663916869;5373.865653358697;5446.673199608036;5455.263539422127;5464.2076898848645;5473.124300111963 03:42:45 INFO - PID 3571 | |1;ext.html;686.6566716641679;748.8464864702737;763.5266134996301;1100.7688385439058;1107.0258172807928;32549.186270343253;33334.833325833366;33445.665543344556;33452.31310677185;33688.15779605511;34466.827665861696;34729.82635086827;34807;34857.65142348576;35023.82488087556;6626.436752876011;6777.966110169442;6906.965465172667;6999.440044796404;7022.683979220948;6580.276169621337;6614.503912206604;6638.17022872141;6638.269790323061;6646.734130634769;6613.239477460105;6634.402903738663;6639.767608133716;6640.966795166018;6641.302663220365;6627.105340778981;6628.801135965929;6639.402453779183;6639.966800166017;6646.601203927731;6752.898706519406;6797.456203503708;6801.319868013208;6816.318368163194;6816.863662726767;30946;31029.844850775826;31179.37641247162;31250.218744531343;31264.531032034538;3005.879764809405;3019.6829332919947;3024.5311976643434;3026.636803583562;3035.074302337786;24498.387540311458;24591.524508529368;24614.138505152412;24614.384640384134;24642.753572464404;2991.1026691992315;3018.3963207358615;3021.244688827793;3057.1287183152917;3064.1420402287395;119971;121515.3924230382;137443;140931;141851;38496.422553661716;38613.42079868804;38626;38649.61350386516;38811.805940970116;41075;41149.58850411518;41150.176996460505;41180.1763964719;41277.380839287434;10553.314034587727;10556.788864222672;10615.52230149645;10622.150227981743;10626.574937002588;8094;8119;8135.3491720662205;8159.184081591793;8221.095679475253;12822.743545129231;12834.80747788784;12873.613791586267;12935.935320323339;13015.349232538336;5295.364556253275;5311.867203319948;5387.380451248078;5403.378611459732;5418.133098704188;860.7503823891127;891.2379915172435;897.1342654338595;898.510311880027;926.2682480840061;20288.898555507127;25243.368915777253;26507.602385964226;26804.59793103105;26856.462870742474;942.9245660347156;946.2477330522252;962.956666949989;968.2544440780559;969.7575606098476;11095.55617775296;11118.833217501744;11444.713882153013;11537;11648.767024659628;169984;170266;170285;170360;170674;39711.60288397137;39843.60156398457;40142.39786403148;40180.196396071915;40230.59769402327;1178.9214980367422;1212.5816593275483;1217.2513903949007;1220.4020030185322;1229.827824104626;19257.22971081197;19954.002299885236;20145.798542014392;21316.467088322916;23946.92238849291;36783.81608091942;37567.248655027295;37621.81189094037;37627.2474550502;38856.6114338853;165702;165756;166489;167065;167396;29651.81392744266;30144.397112058075;30190.849045754632;30421;30476.84761576178;35684.46473302851;35722.642773572974;36771.44842827306;36944.63055369412;37164.6283537172;27596;27847.16458506248;27859.16422507328;28669.569956451087;28700.13899583016;27200.591991119752;27752.44495110046;28004.859975700805;28076;28967.420651587272;30466.69533304727;30816.229594260323;31199.220019499695;31292.68707312898;31559;26850.462990739685;26892.327691807863;27134.72865271401;27612;28613.856930715214;20518.38444846657;22554.323370298916;22651.20720774831;22713.16085489314;22801.31596052121 03:42:45 INFO - PID 3571 | |2;jquery.html;403.7093292829162;405.62479706271694;421.31956889623257;433.24831417490657;443.06071129206066;12930.48278068876;17542.77200595957;18074.277028918845;18092.819071809296;18138.093095345244;17718.29126834925;18002.279908803666;18175.272989080422;18649.627007459876;18810.15354309056;5258.342707161605;5351.277577527023;5552.333719953591;5561.749721262533;5564.137558678412;5369.865753356178;5400.432954539776;5416.864578385533;5424.755885985141;5453.890922181554;5237.947620523803;5366.570674346062;5375.220593014011;5403.864903377408;5403.918941215885;5353;5417.26866872971;5437.293151890269;5447.645903016311;5470.343558772973;4901.387326584177;4924.704517728947;4941.085899108641;4942.703437793708;4964.776585053682;20357;20833.89583052075;20952;21123;21146.682799758015;1620.7730917671536;1625.7561365795107;1640.9097499637514;1642.2938136601256;1642.89321194122;14262.3581938813;14418;14630.926845365704;15044.623884402868;15121.319540620698;1993.4916596268004;2012.5409078418177;2055.126571207246;2096.287262330815;2097.559512502361;88846.55576722075;90595;91117;91883.0811691888;94577.52711236468;10721.47525908986;10814.35113893169;10929.125669946385;11324.094072474183;11565.942170289094;14568.708625827425;14574.271286435636;14575.708485830437;14648.707025859636;14912.328945197492;7359.411247100219;7397;7508.0990281166605;7517.135529414188;7539.623018849035;6639.86720265592;6672.065910772496;6826.931730682729;6851.9657401712675;6863.862722745617;6921.446284297244;6994;7034;7050.92949070513;7215.278472152742;2020.666590012661;2091.0799248330686;2103.5372218111993;2123.692064650617;2289.3589794857135;840.562907288219;862.0861886400436;865.1175800683268;870.1689886158704;884.4295429448099;16857.662846743242;17100.230489627997;17195.742063869053;17248.310067597155;17814.821851781577;867.7396780965811;884.3455842676373;889.7019498468086;891.7636826241052;910.4309806371018;9220.44677319363;9378;9564;9592.280578956606;9767.365121267096;343613;345590;348281.4648168979;348554;349194;75707;76747;77644;78343.60828195822;82021;1074.248026381536;1108.257467496779;1111.6387174168428;1120.361394005409;1128.0862501373913;17339.56651083733;17791.822081779017;18301.816981830012;18400.619953503807;18478.83452993817;38270;38638.80680596579;38879;39117.2176556473;39947.40078898761;47026.29460558026;47688;48295;48897;49455.75272123616;8336.499810011419;8460.703875364332;8483.660653573788;8536.829263414822;8548.572571371282;12738.745225095632;12852.164609300366;12920.289384083966;13305;13450.192988420726;10727.40999245049;10999.560017599206;11108;11306.4912078955;11592.362420066976;9127.406718563272;9457.19613832832;9674.129328360481;9921.503924803586;9959.601615935571;10522.842157367799;11046.061084807881;11380.634323881188;11527.135464840003;11562.132840037199;8336.499810011419;8433.620487077973;8435.24082832548;8500.787480313042;8716.78208044804;11158.218924675195;11190.160737944849;11207.43962801873;11266.605668801552;11495.655130346104 03:42:45 INFO - PID 3571 | |3;mootools.html;1211.2792888231502;1241.8447694038239;1244.9502019919203;1248.0826592454544;1249.5439164704883;10053.296269261155;10467;10542.367457952529;10613.78772424552;10786.406747628876;10476.423796691179;10630.521626526806;10654.4140072296;10669.146468282539;10690.198235132357;2094.4554415851912;2105.5788842231536;2129.137699231806;2140.3899888531773;2144.7211862457857;2090.3310940499046;2118.3009606829787;2124.734408198975;2127.7659457459667;2130.38218916514;2077;2092.801183887528;2092.8639638423456;2105.9894700526474;2114.1120729293657;2052.2201563405883;2058.650029494982;2063.8142567168875;2065.6901464780253;2074.429531878738;1752.1852338662584;1817.1186974317445;1905.9047047647562;1915.3775023117403;1922.1830721943118;10181.694549163536;10505.107065899409;10511.106555942753;10513.158947284199;10539.78920421595;5420.295361603005;5627.2684551008515;5628.943710562883;5633.943660563383;5641.351244606882;3401.693847553707;3430.451127819562;3505.544279243682;3528.4530897710897;3541.451075083366;1101.3997371432508;1116.8883111688847;1118.1613789657756;1121.0527104596683;1145.6906635208447;14464.783028254584;14634.853651463456;14637.41450341985;14642.560723178321;14653.926730366387;4502.549745025472;4631.861044168681;4698.647601429906;4717.787699553528;4743.952560474351;10433.686989390331;10449.68650940473;10465;10482.528286227138;10490.685279441628;5358.812441564526;5477.178423236546;5482.506574408243;5484.780608775684;5492.423295553909;5017.698938063728;5050.84847454577;5051.62112841531;5058.468860769566;5087.211482220262;3850.9229815404096;3919.451276821247;3950.328444164499;3988.920221595552;4000.4597080853287;1147.1511081799574;1165.5745652836654;1170.6019953215948;1180.8287798269203;1183.6981569699672;650.3561474140566;672.062472850371;690.7133539581017;691.5470366909682;694.7741983855267;5203.219517072469;5259.868503287372;5261.973690131525;5479;5489.451054894558;498.06364035612813;508.21227097998695;511.49106638893795;511.98464046078675;512.8358925143992;3371.662833716609;3713.591504934455;3776.8300426480873;3800.4299355096955;3895.863644772476;12677.556285529961;13225.603231903058;13325.800112998313;13482;13731.107478013897;13237.470501179845;13723.382447789874;13734.65663358404;13771.380287887068;13777.931110344585;7586.165521792598;7677.232276772278;7697.884531732028;7702.152763196044;7728.459007869507;5554.416786237549;5627.746751396279;5681.744321505459;5706.771729130788;5876.735546900485;11953.880461195624;11976.880231197576;11995.700107497383;12009.879901200877;12039;12256.264624122581;12367.876321236672;12553.184043037174;12610.684732881751;12732.172408793398;7596.392288616787;7710.151883292945;7719.4210434218785;7733.110692270236;7770.57261850581;9619.807603847745;9666.516674166123;9682.273829462678;9761.267904907303;9766.902330976884;7778;7940.0471943367165;7963.323117534843;8006.599670016592;8053.275205231557;8059.1134975153855;8142.918570814453;8145.144759800136;8210.261076503144;8252.05101413321;6887.6556172192195;7027.543209691354;7046.2249152594195;7049.048378468841;7056.964715176391;4646.535346465462;5031.6729412588065;5116.641835071509;5191.402988656353;5426.70153141581;5283.841484755463;5374.274472946102;5408.8377348679605;5439.5920305976415;5478.424765399575 03:42:45 INFO - PID 3571 | |4;prototype.html;356.678988909981;359.6475454055026;363.6327309417488;370.14865808640104;373.6861036729148;5399.7030163341;5436.565074794017;5456.508914197721;5460.180972854069;5568.49883510484;5299.5230429261355;5441.29263195785;5441.537469315113;5443.782248710047;5455.236266922634;4209.368594710787;4260.637845783112;4265.800649512866;4279.22973864705;4282.464691913511;4276.273033584298;4306.483222013363;4316.395704601343;4316.892077698067;4325.394444777734;4212.705110642256;4252.63915547025;4273.952881544026;4283.3146696528565;4303.634191093761;4087.713860029799;4214.831406743757;4260.893477663052;4288;4292.141571685675;3818.7517811342173;3831.5593706723525;3833.4249862520564;3834.4631751554803;3852.4221366795205;5308.309919710413;5329.920051199235;5334.27987221724;5345.690305875086;5349.384820745625;4906.411230652309;4993.775280112403;5010.348654674905;5038.848834534933;5049.596032317406;5754.223179870748;5759.452851979056;5782.277215348082;5789.421057894219;5837.6497410155525;4296.5059018213;4305.870823875289;4310.547392523771;4315.331123675835;4317.179735850178;5988.31134419543;6062.211912451397;6075.967085595459;6109.480694141003;6146.416090471398;4476.2837945928495;4478.328250762346;4481.282994720829;4488.281874900065;4489.371487991683;4540.20661838572;4543.568361005699;4553.248713962225;4559.703619264737;4566.858285428643;4864.902701945941;4999.825041115335;5046.1169295373165;5062.924056139161;5093.490650934877;5809.68046757424;5839.532837373;5840.1239814027385;5867.6772777497645;5868.67722275279;1534.7467667834906;1558.586974451771;1563.2730780187267;1563.7802514039067;1567.6002619331998;1096.1723898456773;1103.431732657682;1111.5276007696696;1113.3542545323692;1123.6685177872548;4998.925016124761;5010.924836127461;5020.924686129711;5023.648344615842;5036.697798132123;5883.294004719461;5988.9101663475085;6009.789657361971;6009.969950150221;6034.521542222184;4986.202207646832;5005.849824505271;5008.29883816266;5018.598512119095;5020.071286811878;3152.9820914614206;3168.8890888818783;3184.2994541200896;3191.6170059592996;3192.9361412772078;5484.149956756709;5600.663960162322;5600.663960162403;5608.691521966331;5632.549396048306;5903.586748927534;6123.785667501616;6155.045967874987;6165.722542485599;6169.981952977709;5591.7483713233005;5602.887942241132;5613.887722245614;5617.550595952396;5637.182608521742;5792.160136780059;5970.253718285215;5977.3126090500145;5986.850328741816;5999.430054144849;5854.531637468907;5857.941420585739;5861.794837180678;5886;5891.852703682443;5392.649477783932;5592.664440133605;5593;5609;5618.775248989995;4026.718129731008;4050.270951228807;4052.63526282636;4057.188562287495;4076.4089207064217;5979.222701048836;6015.428534289235;6025.457708806229;6035.577509574287;6042.758289668364;5676.460736230051;5756.68338241384;5808.186853840551;5820.970895145497;5821.544613846539;5779.133130030529;5784.797532086357;5786.710664466844;5794.275715535558;5807.89649966505;5696.715164241688;5704.828855134353;5705.4009329019855;5730.598858079894;5760.654360738369;5578;5752.913706294493;5781.4218578141845;5812.622179558315;5818.4763371296785;5633.464820842013;5640.971795140998;5648.181013753065;5656.208130861601;5656.43435656431 03:42:45 INFO - PID 3571 | |5;yui.html;714.6712512244368;742.9219931907149;745.11703631197;750.4784174998375;762.8931949527065;12644.431000604973;13080.869191308107;13244;14333.283335833192;14347.139171649695;15109.773353399707;15396.69206615867;15461.613459663515;15528.689426211497;15605.84394156058;877.3463769491738;887.024273299372;894.2398960883262;895.6730793260446;897.5557099235888;825.6944930375739;880.2341962492609;881.2553392383426;882.32942963348;894.8165626046645;944.225734897381;949.1931857920747;949.6343907595591;950.2493030505892;951.1914872358509;943.8678584998106;944.1125342178365;944.6221511395428;946.9337146399755;952.6665667016558;691.930806919309;693.1543516909413;695.2178798851293;695.8921367188094;697.3131465506472;13532.661683457894;13641;13695.31523423825;13728.45086196561;13770;14314.856851431456;14439.278036098152;14503.782443263359;14617.70764584713;14706.11763294195;12127.636170914886;12204.694882627917;12726.772814757473;13086.47654093835;13196.934015329958;3054.5570892220503;3056.0526236866644;3057.419090372822;3058.4341896749174;3063.9540406893916;70894.64552677203;73724.63137684278;74560.25439745588;74794.62602687006;75744.62127689326;12036.45835937385;12393;12532.937335313265;12688.936555317165;12728.98168146546;22591.661125083137;23252.34953009405;23289;23299.417514562272;23452.64821027686;6310.274318453345;6333.1450254216015;6351.68241587928;6358.283263518824;6384.84037899047;2995.311078451968;3066.064850220704;3069.3247485553143;3071.43178511976;3076.338587203717;3466.757326987087;3667.559892812826;4032.9395059074136;4048.4534587830267;4066.6136717011836;675.1931441926948;682.8190529509684;683.5761827666878;684.295175968753;687.5221720903924;574.3337728235227;580.67772386326;589.1751547833068;589.9262592175978;593.795140676466;9979.401235925867;10456.63401780934;10602.257841951143;10608.946955265328;10715.303505272132;583.7769872117906;590.7282649981057;592.703648175912;601.5157797972587;603.0983679399326;4768.690035147704;4871.853844384674;4918.8770280743265;4947.134251506044;5081.923771143436;81956;82138.58930705428;82698.58650706828;86160.56919715361;87500;69973.65013174902;70766;70881.93677094745;70892.64553677199;72302.63848680723;61548.692256539325;62782.372176278564;64453.355466445675;64553.67723161354;65596.34403655998;9751.317407781387;9820.312578119749;9888.901110989085;10140.695779126638;10202.948985255027;27173.86413067922;27362.863185683946;27908.30229244285;28686.139415817557;28720;35220.823895880356;35259.823700882356;35341.469877951335;35360.46959295561;36119.27761444809;12305.323207223688;12388.070894682754;12514.561990330294;12576.874231257936;12603.93698031504;14093.436262549383;14212.147271163763;14408.783868242195;14543.49097781615;14605.269736513344;13030.934845325713;13241;13382.866171338163;13556.186628802303;13563.38964746569;13422.463101475832;13509.392077356739;13576.117552359065;13625.591232263048;13768.86231137716;13223.206607603575;13292.20246785196;13492.460301587827;13549.86450135486;13692.452301907811;9447.858282125912;9675.806483870143;9698.175655069115;9752.317337786288;9990.200783937122;9661.46861922601;9833.5083245836;9856.901430985597;9965.601375944882;10209.234307426825 03:42:45 INFO - PID 3571 | __end_tp_report 03:42:45 INFO - PID 3571 | __start_cc_report 03:42:45 INFO - PID 3571 | _x_x_mozilla_cycle_collect,376 03:42:45 INFO - PID 3571 | __end_cc_report 03:42:45 INFO - PID 3571 | __startTimestamp1496140965547__endTimestamp 03:42:45 INFO - PID 3571 | 03:42:45 INFO - PID 3571 | ------- Summary: start ------- 03:42:45 INFO - PID 3571 | Number of tests: 6 03:42:45 INFO - PID 3571 | 03:42:45 INFO - PID 3571 | [#0] dojo.html Cycles:165 Average:5178.89 Median:5396.41 stddev:604.26 (11.2%) stddev-sans-first:574.98 03:42:45 INFO - PID 3571 | Values: 2738.0 2743.7 2762.6 2773.9 2779.1 5080.3 5227.9 5230.7 5261.1 5295.5 5200.2 5216.4 5255.2 5317.4 5343.0 4667.2 4686.7 4707.6 4731.9 4755.9 4667.8 4726.9 4782.0 4790.3 4809.8 4592.8 4633.1 4680.5 4715.1 4783.3 4610.4 4657.4 4670.7 4673.2 4691.7 4642.9 4679.4 4699.7 4702.0 4733.9 5171.6 5233.8 5235.0 5242.7 5263.5 5492.2 5555.3 5625.4 5724.3 5728.6 5602.2 5612.0 5614.5 5675.7 5686.3 5220.7 5225.8 5257.4 5258.4 5269.1 5693.3 5738.2 5754.8 5790.7 5792.6 5456.7 5511.8 5526.5 5555.2 5577.7 5646.3 5685.1 5691.5 5698.0 5698.8 5496.2 5513.9 5617.8 5632.7 5637.6 5509.5 5515.2 5585.3 5608.7 5639.0 4674.1 4691.2 4695.4 4701.0 4740.4 4020.2 4030.7 4045.6 4048.1 4086.3 4729.2 4795.2 4797.8 4853.6 4860.4 5747.7 5754.2 5761.5 5762.5 5787.9 4842.9 4855.8 4865.1 4866.1 4898.4 4892.4 4926.6 4966.1 5000.0 5007.4 5398.9 5423.2 5426.6 5440.2 5452.5 5532.3 5629.7 5715.3 5721.1 5729.6 5281.8 5287.2 5292.0 5297.9 5300.7 5534.6 5580.6 5655.1 5685.5 5699.5 5752.1 5772.8 5778.8 5787.1 5790.6 5421.8 5501.4 5517.3 5550.9 5597.6 5460.2 5475.1 5482.3 5515.9 5516.0 5364.2 5396.4 5407.8 5407.8 5442.9 5406.9 5525.8 5537.0 5554.9 5566.7 5373.9 5446.7 5455.3 5464.2 5473.1 03:42:45 INFO - PID 3571 | 03:42:45 INFO - PID 3571 | [#1] ext.html Cycles:180 Average:30331.89 Median:31104.61 stddev:40654.93 (130.7%) stddev-sans-first:40708.03 03:42:45 INFO - PID 3571 | Values: 686.7 748.8 763.5 1100.8 1107.0 32549.2 33334.8 33445.7 33452.3 33688.2 34466.8 34729.8 34807.0 34857.7 35023.8 6626.4 6778.0 6907.0 6999.4 7022.7 6580.3 6614.5 6638.2 6638.3 6646.7 6613.2 6634.4 6639.8 6641.0 6641.3 6627.1 6628.8 6639.4 6640.0 6646.6 6752.9 6797.5 6801.3 6816.3 6816.9 30946.0 31029.8 31179.4 31250.2 31264.5 3005.9 3019.7 3024.5 3026.6 3035.1 24498.4 24591.5 24614.1 24614.4 24642.8 2991.1 3018.4 3021.2 3057.1 3064.1 119971.0 121515.4 137443.0 140931.0 141851.0 38496.4 38613.4 38626.0 38649.6 38811.8 41075.0 41149.6 41150.2 41180.2 41277.4 10553.3 10556.8 10615.5 10622.2 10626.6 8094.0 8119.0 8135.3 8159.2 8221.1 12822.7 12834.8 12873.6 12935.9 13015.3 5295.4 5311.9 5387.4 5403.4 5418.1 860.8 891.2 897.1 898.5 926.3 20288.9 25243.4 26507.6 26804.6 26856.5 942.9 946.2 963.0 968.3 969.8 11095.6 11118.8 11444.7 11537.0 11648.8 169984.0 170266.0 170285.0 170360.0 170674.0 39711.6 39843.6 40142.4 40180.2 40230.6 1178.9 1212.6 1217.3 1220.4 1229.8 19257.2 19954.0 20145.8 21316.5 23946.9 36783.8 37567.2 37621.8 37627.2 38856.6 165702.0 165756.0 166489.0 167065.0 167396.0 29651.8 30144.4 30190.8 30421.0 30476.8 35684.5 35722.6 36771.4 36944.6 37164.6 27596.0 27847.2 27859.2 28669.6 28700.1 27200.6 27752.4 28004.9 28076.0 28967.4 30466.7 30816.2 31199.2 31292.7 31559.0 26850.5 26892.3 27134.7 27612.0 28613.9 20518.4 22554.3 22651.2 22713.2 22801.3 03:42:45 INFO - PID 3571 | 03:42:45 INFO - PID 3571 | [#2] jquery.html Cycles:180 Average:24315.17 Median:404.67 stddev:58111.22 (14360.3%) stddev-sans-first:58246.51 03:42:45 INFO - PID 3571 | Values: 403.7 405.6 421.3 433.2 443.1 12930.5 17542.8 18074.3 18092.8 18138.1 17718.3 18002.3 18175.3 18649.6 18810.2 5258.3 5351.3 5552.3 5561.7 5564.1 5369.9 5400.4 5416.9 5424.8 5453.9 5237.9 5366.6 5375.2 5403.9 5403.9 5353.0 5417.3 5437.3 5447.6 5470.3 4901.4 4924.7 4941.1 4942.7 4964.8 20357.0 20833.9 20952.0 21123.0 21146.7 1620.8 1625.8 1640.9 1642.3 1642.9 14262.4 14418.0 14630.9 15044.6 15121.3 1993.5 2012.5 2055.1 2096.3 2097.6 88846.6 90595.0 91117.0 91883.1 94577.5 10721.5 10814.4 10929.1 11324.1 11565.9 14568.7 14574.3 14575.7 14648.7 14912.3 7359.4 7397.0 7508.1 7517.1 7539.6 6639.9 6672.1 6826.9 6852.0 6863.9 6921.4 6994.0 7034.0 7050.9 7215.3 2020.7 2091.1 2103.5 2123.7 2289.4 840.6 862.1 865.1 870.2 884.4 16857.7 17100.2 17195.7 17248.3 17814.8 867.7 884.3 889.7 891.8 910.4 9220.4 9378.0 9564.0 9592.3 9767.4 343613.0 345590.0 348281.5 348554.0 349194.0 75707.0 76747.0 77644.0 78343.6 82021.0 1074.2 1108.3 1111.6 1120.4 1128.1 17339.6 17791.8 18301.8 18400.6 18478.8 38270.0 38638.8 38879.0 39117.2 39947.4 47026.3 47688.0 48295.0 48897.0 49455.8 8336.5 8460.7 8483.7 8536.8 8548.6 12738.7 12852.2 12920.3 13305.0 13450.2 10727.4 10999.6 11108.0 11306.5 11592.4 9127.4 9457.2 9674.1 9921.5 9959.6 10522.8 11046.1 11380.6 11527.1 11562.1 8336.5 8433.6 8435.2 8500.8 8716.8 11158.2 11190.2 11207.4 11266.6 11495.7 03:42:45 INFO - PID 3571 | 03:42:45 INFO - PID 3571 | [#3] mootools.html Cycles:180 Average:6240.76 Median:3627.52 stddev:4092.05 (112.8%) stddev-sans-first:4086.08 03:42:45 INFO - PID 3571 | Values: 1211.3 1241.8 1245.0 1248.1 1249.5 10053.3 10467.0 10542.4 10613.8 10786.4 10476.4 10630.5 10654.4 10669.1 10690.2 2094.5 2105.6 2129.1 2140.4 2144.7 2090.3 2118.3 2124.7 2127.8 2130.4 2077.0 2092.8 2092.9 2106.0 2114.1 2052.2 2058.7 2063.8 2065.7 2074.4 1752.2 1817.1 1905.9 1915.4 1922.2 10181.7 10505.1 10511.1 10513.2 10539.8 5420.3 5627.3 5628.9 5633.9 5641.4 3401.7 3430.5 3505.5 3528.5 3541.5 1101.4 1116.9 1118.2 1121.1 1145.7 14464.8 14634.9 14637.4 14642.6 14653.9 4502.5 4631.9 4698.6 4717.8 4744.0 10433.7 10449.7 10465.0 10482.5 10490.7 5358.8 5477.2 5482.5 5484.8 5492.4 5017.7 5050.8 5051.6 5058.5 5087.2 3850.9 3919.5 3950.3 3988.9 4000.5 1147.2 1165.6 1170.6 1180.8 1183.7 650.4 672.1 690.7 691.5 694.8 5203.2 5259.9 5262.0 5479.0 5489.5 498.1 508.2 511.5 512.0 512.8 3371.7 3713.6 3776.8 3800.4 3895.9 12677.6 13225.6 13325.8 13482.0 13731.1 13237.5 13723.4 13734.7 13771.4 13777.9 7586.2 7677.2 7697.9 7702.2 7728.5 5554.4 5627.7 5681.7 5706.8 5876.7 11953.9 11976.9 11995.7 12009.9 12039.0 12256.3 12367.9 12553.2 12610.7 12732.2 7596.4 7710.2 7719.4 7733.1 7770.6 9619.8 9666.5 9682.3 9761.3 9766.9 7778.0 7940.0 7963.3 8006.6 8053.3 8059.1 8142.9 8145.1 8210.3 8252.1 6887.7 7027.5 7046.2 7049.0 7057.0 4646.5 5031.7 5116.6 5191.4 5426.7 5283.8 5374.3 5408.8 5439.6 5478.4 03:42:45 INFO - PID 3571 | 03:42:45 INFO - PID 3571 | [#4] prototype.html Cycles:180 Average:4828.58 Median:5371.02 stddev:1376.10 (25.6%) stddev-sans-first:1338.40 03:42:45 INFO - PID 3571 | Values: 356.7 359.6 363.6 370.1 373.7 5399.7 5436.6 5456.5 5460.2 5568.5 5299.5 5441.3 5441.5 5443.8 5455.2 4209.4 4260.6 4265.8 4279.2 4282.5 4276.3 4306.5 4316.4 4316.9 4325.4 4212.7 4252.6 4274.0 4283.3 4303.6 4087.7 4214.8 4260.9 4288.0 4292.1 3818.8 3831.6 3833.4 3834.5 3852.4 5308.3 5329.9 5334.3 5345.7 5349.4 4906.4 4993.8 5010.3 5038.8 5049.6 5754.2 5759.5 5782.3 5789.4 5837.6 4296.5 4305.9 4310.5 4315.3 4317.2 5988.3 6062.2 6076.0 6109.5 6146.4 4476.3 4478.3 4481.3 4488.3 4489.4 4540.2 4543.6 4553.2 4559.7 4566.9 4864.9 4999.8 5046.1 5062.9 5093.5 5809.7 5839.5 5840.1 5867.7 5868.7 1534.7 1558.6 1563.3 1563.8 1567.6 1096.2 1103.4 1111.5 1113.4 1123.7 4998.9 5010.9 5020.9 5023.6 5036.7 5883.3 5988.9 6009.8 6010.0 6034.5 4986.2 5005.8 5008.3 5018.6 5020.1 3153.0 3168.9 3184.3 3191.6 3192.9 5484.1 5600.7 5600.7 5608.7 5632.5 5903.6 6123.8 6155.0 6165.7 6170.0 5591.7 5602.9 5613.9 5617.6 5637.2 5792.2 5970.3 5977.3 5986.9 5999.4 5854.5 5857.9 5861.8 5886.0 5891.9 5392.6 5592.7 5593.0 5609.0 5618.8 4026.7 4050.3 4052.6 4057.2 4076.4 5979.2 6015.4 6025.5 6035.6 6042.8 5676.5 5756.7 5808.2 5821.0 5821.5 5779.1 5784.8 5786.7 5794.3 5807.9 5696.7 5704.8 5705.4 5730.6 5760.7 5578.0 5752.9 5781.4 5812.6 5818.5 5633.5 5641.0 5648.2 5656.2 5656.4 03:42:45 INFO - PID 3571 | 03:42:45 INFO - PID 3571 | [#5] yui.html Cycles:180 Average:16587.76 Median:4057.53 stddev:21709.65 (535.0%) stddev-sans-first:21737.84 03:42:45 INFO - PID 3571 | Values: 714.7 742.9 745.1 750.5 762.9 12644.4 13080.9 13244.0 14333.3 14347.1 15109.8 15396.7 15461.6 15528.7 15605.8 877.3 887.0 894.2 895.7 897.6 825.7 880.2 881.3 882.3 894.8 944.2 949.2 949.6 950.2 951.2 943.9 944.1 944.6 946.9 952.7 691.9 693.2 695.2 695.9 697.3 13532.7 13641.0 13695.3 13728.5 13770.0 14314.9 14439.3 14503.8 14617.7 14706.1 12127.6 12204.7 12726.8 13086.5 13196.9 3054.6 3056.1 3057.4 3058.4 3064.0 70894.6 73724.6 74560.3 74794.6 75744.6 12036.5 12393.0 12532.9 12688.9 12729.0 22591.7 23252.3 23289.0 23299.4 23452.6 6310.3 6333.1 6351.7 6358.3 6384.8 2995.3 3066.1 3069.3 3071.4 3076.3 3466.8 3667.6 4032.9 4048.5 4066.6 675.2 682.8 683.6 684.3 687.5 574.3 580.7 589.2 589.9 593.8 9979.4 10456.6 10602.3 10608.9 10715.3 583.8 590.7 592.7 601.5 603.1 4768.7 4871.9 4918.9 4947.1 5081.9 81956.0 82138.6 82698.6 86160.6 87500.0 69973.7 70766.0 70881.9 70892.6 72302.6 61548.7 62782.4 64453.4 64553.7 65596.3 9751.3 9820.3 9888.9 10140.7 10202.9 27173.9 27362.9 27908.3 28686.1 28720.0 35220.8 35259.8 35341.5 35360.5 36119.3 12305.3 12388.1 12514.6 12576.9 12603.9 14093.4 14212.1 14408.8 14543.5 14605.3 13030.9 13241.0 13382.9 13556.2 13563.4 13422.5 13509.4 13576.1 13625.6 13768.9 13223.2 13292.2 13492.5 13549.9 13692.5 9447.9 9675.8 9698.2 9752.3 9990.2 9661.5 9833.5 9856.9 9965.6 10209.2 03:42:45 INFO - PID 3571 | -------- Summary: end -------- 03:42:45 INFO - PID 3571 | 03:42:46 INFO - TEST-INFO | 3571: exit 0 03:42:46 INFO - TEST-OK | dromaeo_css | took 1149564ms 03:42:46 INFO - TEST-START | kraken 03:42:46 INFO - operating with platform_type : linux_ 03:42:46 INFO - Initialising browser for kraken test... 03:42:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51643/getInfo.html -profile /tmp/tmpwPBe6i/profile 03:42:46 INFO - TEST-INFO | started process 3992 (/builds/slave/test/build/application/firefox/firefox http://localhost:51643/getInfo.html) 03:43:21 INFO - TEST-INFO | 3992: killed by SIGTERM 03:43:21 INFO - Browser initialized. 03:43:21 INFO - Running cycle 1/1 for kraken test... 03:43:21 INFO - TEST-INFO | started process 4216 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwPBe6i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:43:33 INFO - PID 4216 | RSS: Main: 186445824 03:43:33 INFO - PID 4216 | 03:43:36 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51643/tests/kraken/driver.html?testName=audio-beat-detection) 03:43:37 INFO - PID 4216 | RSS: Main: 189616128 03:43:37 INFO - PID 4216 | 03:43:39 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51643/tests/kraken/driver.html?testName=audio-dft) 03:43:40 INFO - PID 4216 | RSS: Main: 189132800 03:43:40 INFO - PID 4216 | 03:43:43 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51643/tests/kraken/driver.html?testName=audio-fft) 03:43:44 INFO - PID 4216 | RSS: Main: 185352192 03:43:44 INFO - PID 4216 | 03:43:46 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51643/tests/kraken/driver.html?testName=audio-oscillator) 03:43:46 INFO - PID 4216 | RSS: Main: 185729024 03:43:46 INFO - PID 4216 | 03:43:48 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51643/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:43:49 INFO - PID 4216 | RSS: Main: 186118144 03:43:49 INFO - PID 4216 | 03:43:52 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51643/tests/kraken/driver.html?testName=imaging-darkroom) 03:43:53 INFO - PID 4216 | RSS: Main: 189632512 03:43:53 INFO - PID 4216 | 03:43:56 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51643/tests/kraken/driver.html?testName=imaging-desaturate) 03:43:57 INFO - PID 4216 | RSS: Main: 186265600 03:43:57 INFO - PID 4216 | 03:44:00 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51643/tests/kraken/driver.html?testName=json-parse-financial) 03:44:01 INFO - PID 4216 | RSS: Main: 186871808 03:44:01 INFO - PID 4216 | 03:44:02 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51643/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:44:03 INFO - PID 4216 | RSS: Main: 186916864 03:44:03 INFO - PID 4216 | 03:44:05 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51643/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:44:05 INFO - PID 4216 | RSS: Main: 186798080 03:44:05 INFO - PID 4216 | 03:44:08 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51643/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:44:08 INFO - PID 4216 | RSS: Main: 186576896 03:44:08 INFO - PID 4216 | 03:44:11 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51643/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:44:12 INFO - PID 4216 | RSS: Main: 186736640 03:44:12 INFO - PID 4216 | 03:44:15 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51643/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:44:16 INFO - PID 4216 | RSS: Main: 186511360 03:44:16 INFO - PID 4216 | 03:44:17 INFO - PID 4216 | Cycle 1(1): loaded http://localhost:51643/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51643/tests/kraken/driver.html?testName=ai-astar) 03:44:18 INFO - PID 4216 | RSS: Main: 188317696 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | __start_tp_report 03:44:18 INFO - PID 4216 | _x_x_mozilla_page_load 03:44:18 INFO - PID 4216 | _x_x_mozilla_page_load_details 03:44:18 INFO - PID 4216 | |i|pagename|runs| 03:44:18 INFO - PID 4216 | |0;ai-astar;103;113;114;113;109;110;111;111;111;111 03:44:18 INFO - PID 4216 | |1;audio-beat-detection;148;126;127;185;123;129;124;128;148;123 03:44:18 INFO - PID 4216 | |2;audio-dft;166;163;165;174;170;168;163;163;163;164 03:44:18 INFO - PID 4216 | |3;audio-fft;73;74;73;110;74;75;74;75;94;73 03:44:18 INFO - PID 4216 | |4;audio-oscillator;83;83;108;83;84;84;97;85;83;103 03:44:18 INFO - PID 4216 | |5;imaging-gaussian-blur;114;115;115;114;117;114;116;114;114;114 03:44:18 INFO - PID 4216 | |6;imaging-darkroom;150;151;150;151;151;150;150;150;150;151 03:44:18 INFO - PID 4216 | |7;imaging-desaturate;95;95;95;95;95;95;96;94;95;95 03:44:18 INFO - PID 4216 | |8;json-parse-financial;55;55;56;58;56;61;65;60;57;57 03:44:18 INFO - PID 4216 | |9;json-stringify-tinderbox;57;57;59;56;57;58;57;56;57;57 03:44:18 INFO - PID 4216 | |10;stanford-crypto-aes;88;86;86;90;87;88;88;88;121;87 03:44:18 INFO - PID 4216 | |11;stanford-crypto-ccm;139;137;136;133;135;140;134;147;146;132 03:44:18 INFO - PID 4216 | |12;stanford-crypto-pbkdf2;192;192;193;202;191;189;195;189;189;193 03:44:18 INFO - PID 4216 | |13;stanford-crypto-sha256-iterative;73;73;74;75;72;73;73;72;72;73 03:44:18 INFO - PID 4216 | __end_tp_report 03:44:18 INFO - PID 4216 | __start_cc_report 03:44:18 INFO - PID 4216 | _x_x_mozilla_cycle_collect,1014 03:44:18 INFO - PID 4216 | __end_cc_report 03:44:18 INFO - PID 4216 | __startTimestamp1496141058155__endTimestamp 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | ------- Summary: start ------- 03:44:18 INFO - PID 4216 | Number of tests: 14 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.00 stddev:3.06 (2.8%) stddev-sans-first:1.59 03:44:18 INFO - PID 4216 | Values: 103.0 113.0 114.0 113.0 109.0 110.0 111.0 111.0 111.0 111.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:128.50 stddev:19.62 (15.3%) stddev-sans-first:20.33 03:44:18 INFO - PID 4216 | Values: 148.0 126.0 127.0 185.0 123.0 129.0 124.0 128.0 148.0 123.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#2] audio-dft Cycles:10 Average:165.90 Median:165.50 stddev:3.73 (2.3%) stddev-sans-first:3.95 03:44:18 INFO - PID 4216 | Values: 166.0 163.0 165.0 174.0 170.0 168.0 163.0 163.0 163.0 164.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#3] audio-fft Cycles:10 Average:79.50 Median:74.00 stddev:12.47 (16.8%) stddev-sans-first:13.00 03:44:18 INFO - PID 4216 | Values: 73.0 74.0 73.0 110.0 74.0 75.0 74.0 75.0 94.0 73.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#4] audio-oscillator Cycles:10 Average:89.30 Median:83.50 stddev:9.60 (11.5%) stddev-sans-first:9.91 03:44:18 INFO - PID 4216 | Values: 83.0 83.0 108.0 83.0 84.0 84.0 97.0 85.0 83.0 103.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:114.50 stddev:1.06 (0.9%) stddev-sans-first:1.09 03:44:18 INFO - PID 4216 | Values: 114.0 115.0 115.0 114.0 117.0 114.0 116.0 114.0 114.0 114.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:0.52 (0.3%) stddev-sans-first:0.53 03:44:18 INFO - PID 4216 | Values: 150.0 151.0 150.0 151.0 151.0 150.0 150.0 150.0 150.0 151.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 03:44:18 INFO - PID 4216 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 94.0 95.0 95.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.50 stddev:3.16 (5.5%) stddev-sans-first:3.16 03:44:18 INFO - PID 4216 | Values: 55.0 55.0 56.0 58.0 56.0 61.0 65.0 60.0 57.0 57.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.00 stddev:0.88 (1.5%) stddev-sans-first:0.93 03:44:18 INFO - PID 4216 | Values: 57.0 57.0 59.0 56.0 57.0 58.0 57.0 56.0 57.0 57.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:88.00 stddev:10.64 (12.1%) stddev-sans-first:11.23 03:44:18 INFO - PID 4216 | Values: 88.0 86.0 86.0 90.0 87.0 88.0 88.0 88.0 121.0 87.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:138.00 stddev:5.17 (3.7%) stddev-sans-first:5.47 03:44:18 INFO - PID 4216 | Values: 139.0 137.0 136.0 133.0 135.0 140.0 134.0 147.0 146.0 132.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.50 Median:192.50 stddev:3.89 (2.0%) stddev-sans-first:4.13 03:44:18 INFO - PID 4216 | Values: 192.0 192.0 193.0 202.0 191.0 189.0 195.0 189.0 189.0 193.0 03:44:18 INFO - PID 4216 | 03:44:18 INFO - PID 4216 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:73.00 stddev:0.94 (1.3%) stddev-sans-first:1.00 03:44:18 INFO - PID 4216 | Values: 73.0 73.0 74.0 75.0 72.0 73.0 73.0 72.0 72.0 73.0 03:44:18 INFO - PID 4216 | -------- Summary: end -------- 03:44:18 INFO - PID 4216 | 03:44:19 INFO - TEST-INFO | 4216: exit 0 03:44:19 INFO - TEST-OK | kraken | took 92888ms 03:44:19 INFO - SUITE-END | took 1242s 03:44:19 INFO - Completed test suite (00:20:42) 03:44:19 INFO - javascript benchmark 03:44:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6717.330765359422, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2738.0280000599773, 2743.6570428696414, 2762.585612158176, 2773.889044438222, 2779.1106845809336, 5080.288759573663, 5227.8693032674155, 5230.738463076846, 5261.079311120558, 5295.496927791858, 5200.245964335169, 5216.426193118763, 5255.159174532066, 5317.388500322464, 5343.0, 4667.2065748822615, 4686.718796872198, 4707.599854012413, 4731.8817029574275, 4755.90488190236, 4667.813287468497, 4726.8581942541605, 4782.04359128174, 4790.329353890458, 4809.807607695688, 4592.816287348502, 4633.142868569325, 4680.508546602592, 4715.056988602293, 4783.28250762385, 4610.423697037871, 4657.39453870998, 4670.696404733681, 4673.158831410345, 4691.7184968901975, 4642.9071418571775, 4679.438467383936, 4699.7415142167165, 4701.952980470186, 4733.857984260443, 5171.637985341028, 5233.842984710464, 5235.0, 5242.737863106868, 5263.499967503081, 5492.176173573956, 5555.2778138842095, 5625.38120806711, 5724.341700704431, 5728.598998070137, 5602.187682786014, 5612.045952188138, 5614.522765564891, 5675.6878371689545, 5686.260786097822, 5220.686758794484, 5225.764840582183, 5257.395399529027, 5258.447862974409, 5269.104252277122, 5693.3168019837885, 5738.225339579103, 5754.769809207669, 5790.739416726173, 5792.565557583198, 5456.672599644034, 5511.779528818803, 5526.50261476461, 5555.194496798023, 5577.721113944368, 5646.2942132233475, 5685.0619647758485, 5691.516221121168, 5697.971510142505, 5698.800541981011, 5496.203050557727, 5513.862153446115, 5617.775288988395, 5632.746526406321, 5637.605367624227, 5509.504144626922, 5515.200295957064, 5585.3297604287745, 5608.663480191201, 5639.013172694762, 4674.135284972291, 4691.225947718656, 4695.43654761424, 4701.0, 4740.3837501124635, 4020.19596080785, 4030.6775457963295, 4045.615666511677, 4048.109415928491, 4086.346184610448, 4729.243321068681, 4795.184818580849, 4797.832075877397, 4853.635977301717, 4860.441049279308, 5747.683877386784, 5754.1944127822135, 5761.510271626875, 5762.538996880324, 5787.913181302284, 4842.927356089662, 4855.757212139379, 4865.1242776300605, 4866.099771542276, 4898.363212782316, 4892.412910450697, 4926.581240594518, 4966.1309270877455, 4999.950000499948, 5007.4491805901325, 5398.865028374322, 5423.213634022965, 5426.647267927572, 5440.183972404171, 5452.509274165344, 5532.280803495681, 5629.746661400165, 5715.31416230055, 5721.141828725725, 5729.627574207663, 5281.762320695655, 5287.180487024518, 5292.02097611943, 5297.947020529746, 5300.70846103468, 5534.584906131976, 5580.609357345109, 5655.095184770417, 5685.516731077904, 5699.458551437607, 5752.050911599539, 5772.797952071657, 5778.8266352009505, 5787.131930210502, 5790.623609465371, 5421.7560209791445, 5501.367342755634, 5517.255170552085, 5550.916736249041, 5597.580181486323, 5460.180972853945, 5475.09660905962, 5482.2873026506295, 5515.917261241165, 5516.0, 5364.222187782671, 5396.406395296436, 5407.837314977299, 5407.83776486706, 5442.945570544244, 5406.864828379322, 5525.834224973257, 5537.0, 5554.861128471821, 5566.721663916869, 5373.865653358697, 5446.673199608036, 5455.263539422127, 5464.2076898848645, 5473.124300111963], "value": 5135.422061095567, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [686.6566716641679, 748.8464864702737, 763.5266134996301, 1100.7688385439058, 1107.0258172807928, 32549.186270343253, 33334.833325833366, 33445.665543344556, 33452.31310677185, 33688.15779605511, 34466.827665861696, 34729.82635086827, 34807.0, 34857.65142348576, 35023.82488087556, 6626.436752876011, 6777.966110169442, 6906.965465172667, 6999.440044796404, 7022.683979220948, 6580.276169621337, 6614.503912206604, 6638.17022872141, 6638.269790323061, 6646.734130634769, 6613.239477460105, 6634.402903738663, 6639.767608133716, 6640.966795166018, 6641.302663220365, 6627.105340778981, 6628.801135965929, 6639.402453779183, 6639.966800166017, 6646.601203927731, 6752.898706519406, 6797.456203503708, 6801.319868013208, 6816.318368163194, 6816.863662726767, 30946.0, 31029.844850775826, 31179.37641247162, 31250.218744531343, 31264.531032034538, 3005.879764809405, 3019.6829332919947, 3024.5311976643434, 3026.636803583562, 3035.074302337786, 24498.387540311458, 24591.524508529368, 24614.138505152412, 24614.384640384134, 24642.753572464404, 2991.1026691992315, 3018.3963207358615, 3021.244688827793, 3057.1287183152917, 3064.1420402287395, 119971.0, 121515.3924230382, 137443.0, 140931.0, 141851.0, 38496.422553661716, 38613.42079868804, 38626.0, 38649.61350386516, 38811.805940970116, 41075.0, 41149.58850411518, 41150.176996460505, 41180.1763964719, 41277.380839287434, 10553.314034587727, 10556.788864222672, 10615.52230149645, 10622.150227981743, 10626.574937002588, 8094.0, 8119.0, 8135.3491720662205, 8159.184081591793, 8221.095679475253, 12822.743545129231, 12834.80747788784, 12873.613791586267, 12935.935320323339, 13015.349232538336, 5295.364556253275, 5311.867203319948, 5387.380451248078, 5403.378611459732, 5418.133098704188, 860.7503823891127, 891.2379915172435, 897.1342654338595, 898.510311880027, 926.2682480840061, 20288.898555507127, 25243.368915777253, 26507.602385964226, 26804.59793103105, 26856.462870742474, 942.9245660347156, 946.2477330522252, 962.956666949989, 968.2544440780559, 969.7575606098476, 11095.55617775296, 11118.833217501744, 11444.713882153013, 11537.0, 11648.767024659628, 169984.0, 170266.0, 170285.0, 170360.0, 170674.0, 39711.60288397137, 39843.60156398457, 40142.39786403148, 40180.196396071915, 40230.59769402327, 1178.9214980367422, 1212.5816593275483, 1217.2513903949007, 1220.4020030185322, 1229.827824104626, 19257.22971081197, 19954.002299885236, 20145.798542014392, 21316.467088322916, 23946.92238849291, 36783.81608091942, 37567.248655027295, 37621.81189094037, 37627.2474550502, 38856.6114338853, 165702.0, 165756.0, 166489.0, 167065.0, 167396.0, 29651.81392744266, 30144.397112058075, 30190.849045754632, 30421.0, 30476.84761576178, 35684.46473302851, 35722.642773572974, 36771.44842827306, 36944.63055369412, 37164.6283537172, 27596.0, 27847.16458506248, 27859.16422507328, 28669.569956451087, 28700.13899583016, 27200.591991119752, 27752.44495110046, 28004.859975700805, 28076.0, 28967.420651587272, 30466.69533304727, 30816.229594260323, 31199.220019499695, 31292.68707312898, 31559.0, 26850.462990739685, 26892.327691807863, 27134.72865271401, 27612.0, 28613.856930715214, 20518.38444846657, 22554.323370298916, 22651.20720774831, 22713.16085489314, 22801.31596052121], "value": 14426.229924375499, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.7093292829162, 405.62479706271694, 421.31956889623257, 433.24831417490657, 443.06071129206066, 12930.48278068876, 17542.77200595957, 18074.277028918845, 18092.819071809296, 18138.093095345244, 17718.29126834925, 18002.279908803666, 18175.272989080422, 18649.627007459876, 18810.15354309056, 5258.342707161605, 5351.277577527023, 5552.333719953591, 5561.749721262533, 5564.137558678412, 5369.865753356178, 5400.432954539776, 5416.864578385533, 5424.755885985141, 5453.890922181554, 5237.947620523803, 5366.570674346062, 5375.220593014011, 5403.864903377408, 5403.918941215885, 5353.0, 5417.26866872971, 5437.293151890269, 5447.645903016311, 5470.343558772973, 4901.387326584177, 4924.704517728947, 4941.085899108641, 4942.703437793708, 4964.776585053682, 20357.0, 20833.89583052075, 20952.0, 21123.0, 21146.682799758015, 1620.7730917671536, 1625.7561365795107, 1640.9097499637514, 1642.2938136601256, 1642.89321194122, 14262.3581938813, 14418.0, 14630.926845365704, 15044.623884402868, 15121.319540620698, 1993.4916596268004, 2012.5409078418177, 2055.126571207246, 2096.287262330815, 2097.559512502361, 88846.55576722075, 90595.0, 91117.0, 91883.0811691888, 94577.52711236468, 10721.47525908986, 10814.35113893169, 10929.125669946385, 11324.094072474183, 11565.942170289094, 14568.708625827425, 14574.271286435636, 14575.708485830437, 14648.707025859636, 14912.328945197492, 7359.411247100219, 7397.0, 7508.0990281166605, 7517.135529414188, 7539.623018849035, 6639.86720265592, 6672.065910772496, 6826.931730682729, 6851.9657401712675, 6863.862722745617, 6921.446284297244, 6994.0, 7034.0, 7050.92949070513, 7215.278472152742, 2020.666590012661, 2091.0799248330686, 2103.5372218111993, 2123.692064650617, 2289.3589794857135, 840.562907288219, 862.0861886400436, 865.1175800683268, 870.1689886158704, 884.4295429448099, 16857.662846743242, 17100.230489627997, 17195.742063869053, 17248.310067597155, 17814.821851781577, 867.7396780965811, 884.3455842676373, 889.7019498468086, 891.7636826241052, 910.4309806371018, 9220.44677319363, 9378.0, 9564.0, 9592.280578956606, 9767.365121267096, 343613.0, 345590.0, 348281.4648168979, 348554.0, 349194.0, 75707.0, 76747.0, 77644.0, 78343.60828195822, 82021.0, 1074.248026381536, 1108.257467496779, 1111.6387174168428, 1120.361394005409, 1128.0862501373913, 17339.56651083733, 17791.822081779017, 18301.816981830012, 18400.619953503807, 18478.83452993817, 38270.0, 38638.80680596579, 38879.0, 39117.2176556473, 39947.40078898761, 47026.29460558026, 47688.0, 48295.0, 48897.0, 49455.75272123616, 8336.499810011419, 8460.703875364332, 8483.660653573788, 8536.829263414822, 8548.572571371282, 12738.745225095632, 12852.164609300366, 12920.289384083966, 13305.0, 13450.192988420726, 10727.40999245049, 10999.560017599206, 11108.0, 11306.4912078955, 11592.362420066976, 9127.406718563272, 9457.19613832832, 9674.129328360481, 9921.503924803586, 9959.601615935571, 10522.842157367799, 11046.061084807881, 11380.634323881188, 11527.135464840003, 11562.132840037199, 8336.499810011419, 8433.620487077973, 8435.24082832548, 8500.787480313042, 8716.78208044804, 11158.218924675195, 11190.160737944849, 11207.43962801873, 11266.605668801552, 11495.655130346104], "value": 8811.104834981956, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1211.2792888231502, 1241.8447694038239, 1244.9502019919203, 1248.0826592454544, 1249.5439164704883, 10053.296269261155, 10467.0, 10542.367457952529, 10613.78772424552, 10786.406747628876, 10476.423796691179, 10630.521626526806, 10654.4140072296, 10669.146468282539, 10690.198235132357, 2094.4554415851912, 2105.5788842231536, 2129.137699231806, 2140.3899888531773, 2144.7211862457857, 2090.3310940499046, 2118.3009606829787, 2124.734408198975, 2127.7659457459667, 2130.38218916514, 2077.0, 2092.801183887528, 2092.8639638423456, 2105.9894700526474, 2114.1120729293657, 2052.2201563405883, 2058.650029494982, 2063.8142567168875, 2065.6901464780253, 2074.429531878738, 1752.1852338662584, 1817.1186974317445, 1905.9047047647562, 1915.3775023117403, 1922.1830721943118, 10181.694549163536, 10505.107065899409, 10511.106555942753, 10513.158947284199, 10539.78920421595, 5420.295361603005, 5627.2684551008515, 5628.943710562883, 5633.943660563383, 5641.351244606882, 3401.693847553707, 3430.451127819562, 3505.544279243682, 3528.4530897710897, 3541.451075083366, 1101.3997371432508, 1116.8883111688847, 1118.1613789657756, 1121.0527104596683, 1145.6906635208447, 14464.783028254584, 14634.853651463456, 14637.41450341985, 14642.560723178321, 14653.926730366387, 4502.549745025472, 4631.861044168681, 4698.647601429906, 4717.787699553528, 4743.952560474351, 10433.686989390331, 10449.68650940473, 10465.0, 10482.528286227138, 10490.685279441628, 5358.812441564526, 5477.178423236546, 5482.506574408243, 5484.780608775684, 5492.423295553909, 5017.698938063728, 5050.84847454577, 5051.62112841531, 5058.468860769566, 5087.211482220262, 3850.9229815404096, 3919.451276821247, 3950.328444164499, 3988.920221595552, 4000.4597080853287, 1147.1511081799574, 1165.5745652836654, 1170.6019953215948, 1180.8287798269203, 1183.6981569699672, 650.3561474140566, 672.062472850371, 690.7133539581017, 691.5470366909682, 694.7741983855267, 5203.219517072469, 5259.868503287372, 5261.973690131525, 5479.0, 5489.451054894558, 498.06364035612813, 508.21227097998695, 511.49106638893795, 511.98464046078675, 512.8358925143992, 3371.662833716609, 3713.591504934455, 3776.8300426480873, 3800.4299355096955, 3895.863644772476, 12677.556285529961, 13225.603231903058, 13325.800112998313, 13482.0, 13731.107478013897, 13237.470501179845, 13723.382447789874, 13734.65663358404, 13771.380287887068, 13777.931110344585, 7586.165521792598, 7677.232276772278, 7697.884531732028, 7702.152763196044, 7728.459007869507, 5554.416786237549, 5627.746751396279, 5681.744321505459, 5706.771729130788, 5876.735546900485, 11953.880461195624, 11976.880231197576, 11995.700107497383, 12009.879901200877, 12039.0, 12256.264624122581, 12367.876321236672, 12553.184043037174, 12610.684732881751, 12732.172408793398, 7596.392288616787, 7710.151883292945, 7719.4210434218785, 7733.110692270236, 7770.57261850581, 9619.807603847745, 9666.516674166123, 9682.273829462678, 9761.267904907303, 9766.902330976884, 7778.0, 7940.0471943367165, 7963.323117534843, 8006.599670016592, 8053.275205231557, 8059.1134975153855, 8142.918570814453, 8145.144759800136, 8210.261076503144, 8252.05101413321, 6887.6556172192195, 7027.543209691354, 7046.2249152594195, 7049.048378468841, 7056.964715176391, 4646.535346465462, 5031.6729412588065, 5116.641835071509, 5191.402988656353, 5426.70153141581, 5283.841484755463, 5374.274472946102, 5408.8377348679605, 5439.5920305976415, 5478.424765399575], "value": 4610.979195285575, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.678988909981, 359.6475454055026, 363.6327309417488, 370.14865808640104, 373.6861036729148, 5399.7030163341, 5436.565074794017, 5456.508914197721, 5460.180972854069, 5568.49883510484, 5299.5230429261355, 5441.29263195785, 5441.537469315113, 5443.782248710047, 5455.236266922634, 4209.368594710787, 4260.637845783112, 4265.800649512866, 4279.22973864705, 4282.464691913511, 4276.273033584298, 4306.483222013363, 4316.395704601343, 4316.892077698067, 4325.394444777734, 4212.705110642256, 4252.63915547025, 4273.952881544026, 4283.3146696528565, 4303.634191093761, 4087.713860029799, 4214.831406743757, 4260.893477663052, 4288.0, 4292.141571685675, 3818.7517811342173, 3831.5593706723525, 3833.4249862520564, 3834.4631751554803, 3852.4221366795205, 5308.309919710413, 5329.920051199235, 5334.27987221724, 5345.690305875086, 5349.384820745625, 4906.411230652309, 4993.775280112403, 5010.348654674905, 5038.848834534933, 5049.596032317406, 5754.223179870748, 5759.452851979056, 5782.277215348082, 5789.421057894219, 5837.6497410155525, 4296.5059018213, 4305.870823875289, 4310.547392523771, 4315.331123675835, 4317.179735850178, 5988.31134419543, 6062.211912451397, 6075.967085595459, 6109.480694141003, 6146.416090471398, 4476.2837945928495, 4478.328250762346, 4481.282994720829, 4488.281874900065, 4489.371487991683, 4540.20661838572, 4543.568361005699, 4553.248713962225, 4559.703619264737, 4566.858285428643, 4864.902701945941, 4999.825041115335, 5046.1169295373165, 5062.924056139161, 5093.490650934877, 5809.68046757424, 5839.532837373, 5840.1239814027385, 5867.6772777497645, 5868.67722275279, 1534.7467667834906, 1558.586974451771, 1563.2730780187267, 1563.7802514039067, 1567.6002619331998, 1096.1723898456773, 1103.431732657682, 1111.5276007696696, 1113.3542545323692, 1123.6685177872548, 4998.925016124761, 5010.924836127461, 5020.924686129711, 5023.648344615842, 5036.697798132123, 5883.294004719461, 5988.9101663475085, 6009.789657361971, 6009.969950150221, 6034.521542222184, 4986.202207646832, 5005.849824505271, 5008.29883816266, 5018.598512119095, 5020.071286811878, 3152.9820914614206, 3168.8890888818783, 3184.2994541200896, 3191.6170059592996, 3192.9361412772078, 5484.149956756709, 5600.663960162322, 5600.663960162403, 5608.691521966331, 5632.549396048306, 5903.586748927534, 6123.785667501616, 6155.045967874987, 6165.722542485599, 6169.981952977709, 5591.7483713233005, 5602.887942241132, 5613.887722245614, 5617.550595952396, 5637.182608521742, 5792.160136780059, 5970.253718285215, 5977.3126090500145, 5986.850328741816, 5999.430054144849, 5854.531637468907, 5857.941420585739, 5861.794837180678, 5886.0, 5891.852703682443, 5392.649477783932, 5592.664440133605, 5593.0, 5609.0, 5618.775248989995, 4026.718129731008, 4050.270951228807, 4052.63526282636, 4057.188562287495, 4076.4089207064217, 5979.222701048836, 6015.428534289235, 6025.457708806229, 6035.577509574287, 6042.758289668364, 5676.460736230051, 5756.68338241384, 5808.186853840551, 5820.970895145497, 5821.544613846539, 5779.133130030529, 5784.797532086357, 5786.710664466844, 5794.275715535558, 5807.89649966505, 5696.715164241688, 5704.828855134353, 5705.4009329019855, 5730.598858079894, 5760.654360738369, 5578.0, 5752.913706294493, 5781.4218578141845, 5812.622179558315, 5818.4763371296785, 5633.464820842013, 5640.971795140998, 5648.181013753065, 5656.208130861601, 5656.43435656431], "value": 4406.753200970361, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.6712512244368, 742.9219931907149, 745.11703631197, 750.4784174998375, 762.8931949527065, 12644.431000604973, 13080.869191308107, 13244.0, 14333.283335833192, 14347.139171649695, 15109.773353399707, 15396.69206615867, 15461.613459663515, 15528.689426211497, 15605.84394156058, 877.3463769491738, 887.024273299372, 894.2398960883262, 895.6730793260446, 897.5557099235888, 825.6944930375739, 880.2341962492609, 881.2553392383426, 882.32942963348, 894.8165626046645, 944.225734897381, 949.1931857920747, 949.6343907595591, 950.2493030505892, 951.1914872358509, 943.8678584998106, 944.1125342178365, 944.6221511395428, 946.9337146399755, 952.6665667016558, 691.930806919309, 693.1543516909413, 695.2178798851293, 695.8921367188094, 697.3131465506472, 13532.661683457894, 13641.0, 13695.31523423825, 13728.45086196561, 13770.0, 14314.856851431456, 14439.278036098152, 14503.782443263359, 14617.70764584713, 14706.11763294195, 12127.636170914886, 12204.694882627917, 12726.772814757473, 13086.47654093835, 13196.934015329958, 3054.5570892220503, 3056.0526236866644, 3057.419090372822, 3058.4341896749174, 3063.9540406893916, 70894.64552677203, 73724.63137684278, 74560.25439745588, 74794.62602687006, 75744.62127689326, 12036.45835937385, 12393.0, 12532.937335313265, 12688.936555317165, 12728.98168146546, 22591.661125083137, 23252.34953009405, 23289.0, 23299.417514562272, 23452.64821027686, 6310.274318453345, 6333.1450254216015, 6351.68241587928, 6358.283263518824, 6384.84037899047, 2995.311078451968, 3066.064850220704, 3069.3247485553143, 3071.43178511976, 3076.338587203717, 3466.757326987087, 3667.559892812826, 4032.9395059074136, 4048.4534587830267, 4066.6136717011836, 675.1931441926948, 682.8190529509684, 683.5761827666878, 684.295175968753, 687.5221720903924, 574.3337728235227, 580.67772386326, 589.1751547833068, 589.9262592175978, 593.795140676466, 9979.401235925867, 10456.63401780934, 10602.257841951143, 10608.946955265328, 10715.303505272132, 583.7769872117906, 590.7282649981057, 592.703648175912, 601.5157797972587, 603.0983679399326, 4768.690035147704, 4871.853844384674, 4918.8770280743265, 4947.134251506044, 5081.923771143436, 81956.0, 82138.58930705428, 82698.58650706828, 86160.56919715361, 87500.0, 69973.65013174902, 70766.0, 70881.93677094745, 70892.64553677199, 72302.63848680723, 61548.692256539325, 62782.372176278564, 64453.355466445675, 64553.67723161354, 65596.34403655998, 9751.317407781387, 9820.312578119749, 9888.901110989085, 10140.695779126638, 10202.948985255027, 27173.86413067922, 27362.863185683946, 27908.30229244285, 28686.139415817557, 28720.0, 35220.823895880356, 35259.823700882356, 35341.469877951335, 35360.46959295561, 36119.27761444809, 12305.323207223688, 12388.070894682754, 12514.561990330294, 12576.874231257936, 12603.93698031504, 14093.436262549383, 14212.147271163763, 14408.783868242195, 14543.49097781615, 14605.269736513344, 13030.934845325713, 13241.0, 13382.866171338163, 13556.186628802303, 13563.38964746569, 13422.463101475832, 13509.392077356739, 13576.117552359065, 13625.591232263048, 13768.86231137716, 13223.206607603575, 13292.20246785196, 13492.460301587827, 13549.86450135486, 13692.452301907811, 9447.858282125912, 9675.806483870143, 9698.175655069115, 9752.317337786288, 9990.200783937122, 9661.46861922601, 9833.5083245836, 9856.901430985597, 9965.601375944882, 10209.234307426825], "value": 6925.923169716359, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 114.0, 113.0, 109.0, 110.0, 111.0, 111.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 126.0, 127.0, 185.0, 123.0, 129.0, 124.0, 128.0, 148.0, 123.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 163.0, 165.0, 174.0, 170.0, 168.0, 163.0, 163.0, 163.0, 164.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 110.0, 74.0, 75.0, 74.0, 75.0, 94.0, 73.0], "value": 79.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 83.0, 84.0, 84.0, 97.0, 85.0, 83.0, 103.0], "value": 89.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 117.0, 114.0, 116.0, 114.0, 114.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 150.0, 151.0, 151.0, 150.0, 150.0, 150.0, 150.0, 151.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 94.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 58.0, 56.0, 61.0, 65.0, 60.0, 57.0, 57.0], "value": 58.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 59.0, 56.0, 57.0, 58.0, 57.0, 56.0, 57.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 90.0, 87.0, 88.0, 88.0, 88.0, 121.0, 87.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 136.0, 133.0, 135.0, 140.0, 134.0, 147.0, 146.0, 132.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 192.0, 193.0, 202.0, 191.0, 189.0, 195.0, 189.0, 189.0, 193.0], "value": 192.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 74.0, 75.0, 72.0, 73.0, 73.0, 72.0, 72.0, 73.0], "value": 73.0, "unit": "score"}]}]} 03:44:19 INFO - Return code: 0 03:44:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:44:19 INFO - # TBPL SUCCESS # 03:44:19 INFO - Running post-action listener: _resource_record_post_action 03:44:19 INFO - [mozharness: 2017-05-30 10:44:19.947608Z] Finished run-tests step (success) 03:44:19 INFO - Running post-run listener: _resource_record_post_run 03:44:20 INFO - Total resource usage - Wall time: 1260s; CPU: 13.0%; Read bytes: 8720384; Write bytes: 411172864; Read time: 1900; Write time: 351840 03:44:20 INFO - TinderboxPrint: CPU usage
12.7% 03:44:20 INFO - TinderboxPrint: I/O read bytes / time
8,720,384 / 1,900 03:44:20 INFO - TinderboxPrint: I/O write bytes / time
411,172,864 / 351,840 03:44:20 INFO - TinderboxPrint: CPU idle
8,778.9 (87.3%) 03:44:20 INFO - TinderboxPrint: CPU user
1,220.6 (12.1%) 03:44:20 INFO - TinderboxPrint: Swap in / out
0 / 0 03:44:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 99287040; Read time: 108; Write time: 103984 03:44:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:44:20 INFO - run-tests - Wall time: 1243s; CPU: 13.0%; Read bytes: 6348800; Write bytes: 311885824; Read time: 1220; Write time: 247856 03:44:20 INFO - Running post-run listener: _upload_blobber_files 03:44:20 INFO - Blob upload gear active. 03:44:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:44:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:44:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:44:21 INFO - (blobuploader) - INFO - Open directory for files ... 03:44:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:44:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:44:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:28 INFO - (blobuploader) - INFO - Done attempting. 03:44:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:44:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:44:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:29 INFO - (blobuploader) - INFO - Done attempting. 03:44:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:44:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:44:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:30 INFO - (blobuploader) - INFO - Done attempting. 03:44:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:44:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:44:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:44:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:44:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:44:30 INFO - (blobuploader) - INFO - Done attempting. 03:44:30 INFO - (blobuploader) - INFO - Iteration through files over. 03:44:30 INFO - Return code: 0 03:44:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:44:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:44:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26d4c79caaa8776e5a571b06b80e6b701401e65479d71e44ba90e2b4cf68be8d9b07654b531ffb86fa0e33a8ede3c29c2aaba48c716a08eeb433f271f38885bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0edae5537fb9373176e53088b1dc2e638ea50b62c94b29454bdaf8e493314e4638008e07c385805024c7e86cfc8db86970f9422a26495c0c5f1d4c72879d783f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91f9d36dd8270ac97c68c7e5c7ff36503dacc114d7737770a620e8b62850258f2950e9dbbb7d6deee9bc04ee87028c68739257bc460c1c35b8e058c42c0a1a8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/964a0203fd5a22809f21b2cb7ea00c8dba7c757bd326863dc0bec9074c761e2b13f0976a36da924bcd26f959abfa0c48ec21cb902513a4f22b29e6494aa04f9b"} 03:44:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:44:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:44:30 INFO - Contents: 03:44:30 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26d4c79caaa8776e5a571b06b80e6b701401e65479d71e44ba90e2b4cf68be8d9b07654b531ffb86fa0e33a8ede3c29c2aaba48c716a08eeb433f271f38885bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0edae5537fb9373176e53088b1dc2e638ea50b62c94b29454bdaf8e493314e4638008e07c385805024c7e86cfc8db86970f9422a26495c0c5f1d4c72879d783f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91f9d36dd8270ac97c68c7e5c7ff36503dacc114d7737770a620e8b62850258f2950e9dbbb7d6deee9bc04ee87028c68739257bc460c1c35b8e058c42c0a1a8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/964a0203fd5a22809f21b2cb7ea00c8dba7c757bd326863dc0bec9074c761e2b13f0976a36da924bcd26f959abfa0c48ec21cb902513a4f22b29e6494aa04f9b"} 03:44:30 INFO - Running post-run listener: copy_logs_to_upload_dir 03:44:30 INFO - Copying logs to upload dir... 03:44:30 INFO - mkdir: /builds/slave/test/build/upload/logs 03:44:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1322.631852 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-05-30 03:44:30.998803) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 03:44:31.002558) ========= 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=8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26d4c79caaa8776e5a571b06b80e6b701401e65479d71e44ba90e2b4cf68be8d9b07654b531ffb86fa0e33a8ede3c29c2aaba48c716a08eeb433f271f38885bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0edae5537fb9373176e53088b1dc2e638ea50b62c94b29454bdaf8e493314e4638008e07c385805024c7e86cfc8db86970f9422a26495c0c5f1d4c72879d783f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91f9d36dd8270ac97c68c7e5c7ff36503dacc114d7737770a620e8b62850258f2950e9dbbb7d6deee9bc04ee87028c68739257bc460c1c35b8e058c42c0a1a8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/964a0203fd5a22809f21b2cb7ea00c8dba7c757bd326863dc0bec9074c761e2b13f0976a36da924bcd26f959abfa0c48ec21cb902513a4f22b29e6494aa04f9b"} build_url:https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011243 build_url: 'https://queue.taskcluster.net/v1/task/KzVL2TxBScyPCA7uP4xUzA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26d4c79caaa8776e5a571b06b80e6b701401e65479d71e44ba90e2b4cf68be8d9b07654b531ffb86fa0e33a8ede3c29c2aaba48c716a08eeb433f271f38885bc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0edae5537fb9373176e53088b1dc2e638ea50b62c94b29454bdaf8e493314e4638008e07c385805024c7e86cfc8db86970f9422a26495c0c5f1d4c72879d783f", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/91f9d36dd8270ac97c68c7e5c7ff36503dacc114d7737770a620e8b62850258f2950e9dbbb7d6deee9bc04ee87028c68739257bc460c1c35b8e058c42c0a1a8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/964a0203fd5a22809f21b2cb7ea00c8dba7c757bd326863dc0bec9074c761e2b13f0976a36da924bcd26f959abfa0c48ec21cb902513a4f22b29e6494aa04f9b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 03:44:31.030514) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:44:31.030878) ========= 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=8887e36bb8e381bfd44124ac000001a8-1496134888.497955-543259074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 03:44:31.116776) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 03:44:31.117142) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 03:44:31.117529) ========= ========= Total master_lag: 0.19 =========