builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-089 starttime: 1495829436.87 results: success (0) revision: bce03a8eac301bcd9408b22333b1a67c3eaed057 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:36.869404) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:36.871166) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:36.871480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:36.897873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:36.898210) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-26 13:10:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 33.7M=0s 2017-05-26 13:10:37 (33.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148787 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:37.060508) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:37.060879) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020736 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:37.111270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:37.111645) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bce03a8eac301bcd9408b22333b1a67c3eaed057 --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 bce03a8eac301bcd9408b22333b1a67c3eaed057 --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=8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-26 13:10:37,420 truncating revision to first 12 chars 2017-05-26 13:10:37,420 Setting DEBUG logging. 2017-05-26 13:10:37,420 attempt 1/10 2017-05-26 13:10:37,420 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bce03a8eac30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-26 13:10:37,757 unpacking tar archive at: mozilla-central-bce03a8eac30/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716085 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:37.842272) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:37.842634) ========= script_repo_revision: bce03a8eac301bcd9408b22333b1a67c3eaed057 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:37.843099) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:37.843429) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-26 13:10:37.853477) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2017-05-26 13:10:37.853788) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:10:38 INFO - MultiFileLogger online at 20170526 13:10:38 in /builds/slave/test 13:10:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 13:10:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:10:38 INFO - {'append_to_log': False, 13:10:38 INFO - 'base_work_dir': '/builds/slave/test', 13:10:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 13:10:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:10:38 INFO - 'branch': 'Firefox-Non-PGO', 13:10:38 INFO - 'buildbot_json_path': 'buildprops.json', 13:10:38 INFO - 'config_files': ('talos/linux_config.py',), 13:10:38 INFO - 'default_actions': ('clobber', 13:10:38 INFO - 'read-buildbot-config', 13:10:38 INFO - 'download-and-extract', 13:10:38 INFO - 'populate-webroot', 13:10:38 INFO - 'create-virtualenv', 13:10:38 INFO - 'install', 13:10:38 INFO - 'run-tests'), 13:10:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:10:38 INFO - 'download_minidump_stackwalk': True, 13:10:38 INFO - 'download_symbols': 'ondemand', 13:10:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:10:38 INFO - 'tooltool.py': '/tools/tooltool.py', 13:10:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:10:38 INFO - '/tools/misc-python/virtualenv.py')}, 13:10:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:10:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:10:38 INFO - 'gecko_profile': False, 13:10:38 INFO - 'gecko_profile_interval': 0, 13:10:38 INFO - 'installer_path': 'installer.exe', 13:10:38 INFO - 'log_level': 'info', 13:10:38 INFO - 'log_name': 'talos', 13:10:38 INFO - 'log_to_console': True, 13:10:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:10:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:10:38 INFO - 'opt_config_files': (), 13:10:38 INFO - 'pip_index': False, 13:10:38 INFO - 'suite': 'dromaeojs-e10s', 13:10:38 INFO - 'system_bits': '32', 13:10:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:10:38 INFO - 'title': 'talos-linux64-ix-089', 13:10:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:10:38 INFO - 'use_talos_json': True, 13:10:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:10:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:10:38 INFO - 'work_dir': 'build'} 13:10:38 INFO - [mozharness: 2017-05-26 20:10:38.264791Z] Running clobber step. 13:10:38 INFO - Running pre-action listener: _resource_record_pre_action 13:10:38 INFO - Running main action method: clobber 13:10:38 INFO - rmtree: /builds/slave/test/build 13:10:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:10:39 INFO - Running post-action listener: _resource_record_post_action 13:10:39 INFO - [mozharness: 2017-05-26 20:10:39.787413Z] Finished clobber step (success) 13:10:39 INFO - [mozharness: 2017-05-26 20:10:39.787512Z] Running read-buildbot-config step. 13:10:39 INFO - Running pre-action listener: _resource_record_pre_action 13:10:39 INFO - Running main action method: read_buildbot_config 13:10:39 INFO - Using buildbot properties: 13:10:39 INFO - { 13:10:39 INFO - "project": "", 13:10:39 INFO - "product": "firefox", 13:10:39 INFO - "who": "ryanvm@gmail.com", 13:10:39 INFO - "installer_path": "public/build/target.tar.bz2", 13:10:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:10:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 13:10:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 13:10:39 INFO - "stage_platform": "linux64", 13:10:39 INFO - "basedir": "/builds/slave/test", 13:10:39 INFO - "buildnumber": 906, 13:10:39 INFO - "platform": "ubuntu64_hw", 13:10:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:10:39 INFO - "slavebuilddir": "test", 13:10:39 INFO - "taskId": "b2JpKEHqSnSaGD7nENKkTQ", 13:10:39 INFO - "branch": "mozilla-central", 13:10:39 INFO - "script_repo_revision": "production", 13:10:39 INFO - "revision": "bce03a8eac301bcd9408b22333b1a67c3eaed057", 13:10:39 INFO - "slavename": "talos-linux64-ix-089", 13:10:39 INFO - "repo_path": "mozilla-central" 13:10:39 INFO - } 13:10:39 INFO - Finding installer, test and symbols from parent task. 13:10:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2JpKEHqSnSaGD7nENKkTQ'}, attempt #1 13:10:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2JpKEHqSnSaGD7nENKkTQ'}, attempt #1 13:10:40 INFO - Task dependencies: SjG-k2WvSXijs6UXTnaBXA 13:10:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA'}, attempt #1 13:10:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.tar.bz2 13:10:41 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/test_packages.json 13:10:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.crashreporter-symbols.zip 13:10:41 INFO - Running post-action listener: _resource_record_post_action 13:10:41 INFO - [mozharness: 2017-05-26 20:10:41.166982Z] Finished read-buildbot-config step (success) 13:10:41 INFO - [mozharness: 2017-05-26 20:10:41.167201Z] Running download-and-extract step. 13:10:41 INFO - Running pre-action listener: _resource_record_pre_action 13:10:41 INFO - Running main action method: download_and_extract 13:10:41 INFO - mkdir: /builds/slave/test/build/tests 13:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:10:41 INFO - trying https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.test_packages.json 13:10:41 INFO - Downloading https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:10:41 INFO - Downloaded 986 bytes. 13:10:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:10:41 INFO - Using the following test package requirements: 13:10:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:10:41 INFO - u'common': [u'target.common.tests.zip'], 13:10:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:10:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:10:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:10:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:10:41 INFO - u'mozbase': [u'target.common.tests.zip'], 13:10:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:10:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:10:41 INFO - u'web-platform': [u'target.common.tests.zip', 13:10:41 INFO - u'target.web-platform.tests.zip'], 13:10:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:10:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:10:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.common.tests.zip 13:10:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:10:41 INFO - Fetch https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.common.tests.zip into memory 13:10:43 INFO - Content-Length response header: 63525954 13:10:43 INFO - Bytes received: 63525954 13:10:54 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:10:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.common.tests.zip 13:10:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:10:54 INFO - Fetch https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.common.tests.zip into memory 13:10:55 INFO - Content-Length response header: 63525954 13:10:55 INFO - Bytes received: 63525954 13:11:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.talos.tests.zip 13:11:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:11:07 INFO - Fetch https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.talos.tests.zip into memory 13:11:15 INFO - Content-Length response header: 14411888 13:11:15 INFO - Bytes received: 14411888 13:11:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:15 INFO - trying https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.tar.bz2 13:11:15 INFO - Downloading https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:11:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:11:17 INFO - Downloaded 54194281 bytes. 13:11:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.tar.bz2 13:11:17 INFO - mkdir: /builds/slave/test/properties 13:11:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:11:17 INFO - Writing to file /builds/slave/test/properties/build_url 13:11:17 INFO - Contents: 13:11:17 INFO - build_url:https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.tar.bz2 13:11:17 INFO - Running post-action listener: _resource_record_post_action 13:11:17 INFO - Running post-action listener: set_extra_try_arguments 13:11:17 INFO - [mozharness: 2017-05-26 20:11:17.168174Z] Finished download-and-extract step (success) 13:11:17 INFO - [mozharness: 2017-05-26 20:11:17.168317Z] Running populate-webroot step. 13:11:17 INFO - Running pre-action listener: _resource_record_pre_action 13:11:17 INFO - Running main action method: populate_webroot 13:11:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:11:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:11:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:11:17 INFO - '--tppagecycles', 13:11:17 INFO - '7'], 13:11:17 INFO - 'tests': ['tsvgm']}}, 13:11:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:11:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:11:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:11:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:11:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:11:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:11:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:11:17 INFO - 'talos_options': ['--disable-e10s'], 13:11:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:11:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:11:17 INFO - 'talos_options': ['--disable-e10s'], 13:11:17 INFO - 'tests': ['damp', 'tps']}, 13:11:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:11:17 INFO - 'tests': ['damp', 'tps']}, 13:11:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:11:17 INFO - 'tests': ['dromaeo_dom']}, 13:11:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:11:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:11:17 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 13:11:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:11:17 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:11:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:11:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:11:17 INFO - 'tests': ['a11yr', 13:11:17 INFO - 'ts_paint', 13:11:17 INFO - 'tpaint', 13:11:17 INFO - 'sessionrestore', 13:11:17 INFO - 'sessionrestore_no_auto_restore', 13:11:17 INFO - 'tabpaint']}, 13:11:17 INFO - 'other-e10s': {'tests': ['a11yr', 13:11:17 INFO - 'ts_paint', 13:11:17 INFO - 'tpaint', 13:11:17 INFO - 'sessionrestore', 13:11:17 INFO - 'sessionrestore_no_auto_restore', 13:11:17 INFO - 'tabpaint']}, 13:11:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:11:17 INFO - 'ts_paint', 13:11:17 INFO - 'tpaint', 13:11:17 INFO - 'sessionrestore', 13:11:17 INFO - 'sessionrestore_no_auto_restore', 13:11:17 INFO - 'tabpaint']}, 13:11:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:11:17 INFO - 'ts_paint', 13:11:17 INFO - 'tpaint', 13:11:17 INFO - 'sessionrestore', 13:11:17 INFO - 'sessionrestore_no_auto_restore', 13:11:17 INFO - 'tabpaint']}, 13:11:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:11:17 INFO - 'tests': ['a11yr', 13:11:17 INFO - 'ts_paint', 13:11:17 INFO - 'tpaint', 13:11:17 INFO - 'sessionrestore', 13:11:17 INFO - 'sessionrestore_no_auto_restore', 13:11:17 INFO - 'tabpaint']}, 13:11:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:11:17 INFO - 'tests': ['a11yr', 13:11:17 INFO - 'ts_paint', 13:11:17 INFO - 'tpaint', 13:11:17 INFO - 'sessionrestore', 13:11:17 INFO - 'sessionrestore_no_auto_restore', 13:11:17 INFO - 'tabpaint']}, 13:11:17 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 13:11:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 13:11:17 INFO - 'bloom_basic_ref']}, 13:11:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:11:17 INFO - 'tests': ['tsvgx', 13:11:17 INFO - 'tsvgr_opacity', 13:11:17 INFO - 'tart', 13:11:17 INFO - 'tscrollx', 13:11:17 INFO - 'cart', 13:11:17 INFO - 'tsvg_static']}, 13:11:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:11:17 INFO - 'tsvgr_opacity', 13:11:17 INFO - 'tart', 13:11:17 INFO - 'tscrollx', 13:11:17 INFO - 'cart', 13:11:17 INFO - 'tsvg_static']}, 13:11:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:11:17 INFO - 'talos_options': ['--disable-e10s'], 13:11:17 INFO - 'tests': ['tp5o']}, 13:11:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:11:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:11:17 INFO - 'talos_options': ['--disable-e10s', 13:11:17 INFO - '--xperf_path', 13:11:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:17 INFO - 'tests': ['tp5n']}, 13:11:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:11:17 INFO - 'talos_options': ['--xperf_path', 13:11:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:17 INFO - 'tests': ['tp5n']}}, 13:11:17 INFO - 'talos.zip': {'path': '', 13:11:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:11:17 INFO - Running post-action listener: _resource_record_post_action 13:11:17 INFO - [mozharness: 2017-05-26 20:11:17.185596Z] Finished populate-webroot step (success) 13:11:17 INFO - [mozharness: 2017-05-26 20:11:17.185684Z] Running create-virtualenv step. 13:11:17 INFO - Running pre-action listener: _resource_record_pre_action 13:11:17 INFO - Running main action method: create_virtualenv 13:11:17 INFO - Creating virtualenv /builds/slave/test/build/venv 13:11:17 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 13:11:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:11:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:11:17 INFO - Using real prefix '/usr' 13:11:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:11:18 INFO - Installing distribute.............................................................................................................................................................................................done. 13:11:20 INFO - Installing pip.................done. 13:11:20 INFO - Return code: 0 13:11:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:11:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:11:20 INFO - Reading from file tmpfile_stdout 13:11:20 INFO - Output received: 13:11:20 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) 13:11:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:20 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 0x15b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19255c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19227a0>, '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 0x19236a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', '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 13:11:20 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 13:11:20 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 13:11:20 INFO - Using env: {'DISPLAY': ':0', 13:11:20 INFO - 'HOME': '/home/cltbld', 13:11:20 INFO - 'LANG': 'en_US.UTF-8', 13:11:20 INFO - 'LANGUAGE': 'en_US:en', 13:11:20 INFO - 'LOGNAME': 'cltbld', 13:11:20 INFO - 'MAIL': '/var/mail/cltbld', 13:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:20 INFO - 'MOZ_NO_REMOTE': '1', 13:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:20 INFO - 'NO_EM_RESTART': '1', 13:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:20 INFO - 'PWD': '/builds/slave/test', 13:11:20 INFO - 'SHELL': '/bin/bash', 13:11:20 INFO - 'SHLVL': '1', 13:11:20 INFO - 'TERM': 'linux', 13:11:20 INFO - 'TMOUT': '86400', 13:11:20 INFO - 'USER': 'cltbld', 13:11:20 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', 13:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:20 INFO - '_': '/tools/buildbot/bin/python'} 13:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:20 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 13:11:20 INFO - Cleaning up... 13:11:20 INFO - Return code: 0 13:11:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:20 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 0x15b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19255c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19227a0>, '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 0x19236a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', '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 13:11:20 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 13:11:20 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 13:11:20 INFO - Using env: {'DISPLAY': ':0', 13:11:20 INFO - 'HOME': '/home/cltbld', 13:11:20 INFO - 'LANG': 'en_US.UTF-8', 13:11:20 INFO - 'LANGUAGE': 'en_US:en', 13:11:20 INFO - 'LOGNAME': 'cltbld', 13:11:20 INFO - 'MAIL': '/var/mail/cltbld', 13:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:20 INFO - 'MOZ_NO_REMOTE': '1', 13:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:20 INFO - 'NO_EM_RESTART': '1', 13:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:20 INFO - 'PWD': '/builds/slave/test', 13:11:20 INFO - 'SHELL': '/bin/bash', 13:11:20 INFO - 'SHLVL': '1', 13:11:20 INFO - 'TERM': 'linux', 13:11:20 INFO - 'TMOUT': '86400', 13:11:20 INFO - 'USER': 'cltbld', 13:11:20 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', 13:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:20 INFO - '_': '/tools/buildbot/bin/python'} 13:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:20 INFO - Downloading/unpacking psutil>=3.1.1 13:11:20 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 13:11:20 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 13:11:20 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 13:11:20 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 13:11:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:11:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:21 INFO - Installing collected packages: psutil 13:11:21 INFO - Running setup.py install for psutil 13:11:21 INFO - building 'psutil._psutil_linux' extension 13:11:21 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 13:11:22 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 13:11:22 INFO - building 'psutil._psutil_posix' extension 13:11:22 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 13:11:22 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 13:11:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:22 INFO - Successfully installed psutil 13:11:22 INFO - Cleaning up... 13:11:22 INFO - Return code: 0 13:11:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:11:22 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')]} 13:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:22 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')]} 13:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:22 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 0x15b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19255c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19227a0>, '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 0x19236a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', '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 13:11:22 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 13:11:22 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 13:11:22 INFO - Using env: {'DISPLAY': ':0', 13:11:22 INFO - 'HOME': '/home/cltbld', 13:11:22 INFO - 'LANG': 'en_US.UTF-8', 13:11:22 INFO - 'LANGUAGE': 'en_US:en', 13:11:22 INFO - 'LOGNAME': 'cltbld', 13:11:22 INFO - 'MAIL': '/var/mail/cltbld', 13:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:22 INFO - 'MOZ_NO_REMOTE': '1', 13:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:22 INFO - 'NO_EM_RESTART': '1', 13:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:22 INFO - 'PWD': '/builds/slave/test', 13:11:22 INFO - 'SHELL': '/bin/bash', 13:11:22 INFO - 'SHLVL': '1', 13:11:22 INFO - 'TERM': 'linux', 13:11:22 INFO - 'TMOUT': '86400', 13:11:22 INFO - 'USER': 'cltbld', 13:11:22 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', 13:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:22 INFO - '_': '/tools/buildbot/bin/python'} 13:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:11:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:11:23 INFO - Installing collected packages: mozsystemmonitor 13:11:23 INFO - Running setup.py install for mozsystemmonitor 13:11:23 INFO - Successfully installed mozsystemmonitor 13:11:23 INFO - Cleaning up... 13:11:23 INFO - Return code: 0 13:11:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:23 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 0x15b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19255c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19227a0>, '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 0x19236a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', '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 13:11:23 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 13:11:23 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 13:11:23 INFO - Using env: {'DISPLAY': ':0', 13:11:23 INFO - 'HOME': '/home/cltbld', 13:11:23 INFO - 'LANG': 'en_US.UTF-8', 13:11:23 INFO - 'LANGUAGE': 'en_US:en', 13:11:23 INFO - 'LOGNAME': 'cltbld', 13:11:23 INFO - 'MAIL': '/var/mail/cltbld', 13:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:23 INFO - 'MOZ_NO_REMOTE': '1', 13:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:23 INFO - 'NO_EM_RESTART': '1', 13:11:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:23 INFO - 'PWD': '/builds/slave/test', 13:11:23 INFO - 'SHELL': '/bin/bash', 13:11:23 INFO - 'SHLVL': '1', 13:11:23 INFO - 'TERM': 'linux', 13:11:23 INFO - 'TMOUT': '86400', 13:11:23 INFO - 'USER': 'cltbld', 13:11:23 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', 13:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:23 INFO - '_': '/tools/buildbot/bin/python'} 13:11:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:24 INFO - Downloading/unpacking jsonschema==2.5.1 13:11:24 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 13:11:24 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 13:11:24 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 13:11:24 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 13:11:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:11:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:25 INFO - Downloading functools32-3.2.3-2.tar.gz 13:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:11:25 INFO - warning: no files found matching '*.txt' 13:11:25 INFO - no previously-included directories found matching 'build' 13:11:25 INFO - no previously-included directories found matching 'dist' 13:11:25 INFO - no previously-included directories found matching '.git*' 13:11:25 INFO - Installing collected packages: jsonschema, functools32 13:11:25 INFO - Running setup.py install for functools32 13:11:25 INFO - warning: no files found matching '*.txt' 13:11:25 INFO - no previously-included directories found matching 'build' 13:11:25 INFO - no previously-included directories found matching 'dist' 13:11:25 INFO - no previously-included directories found matching '.git*' 13:11:25 INFO - Successfully installed jsonschema functools32 13:11:25 INFO - Cleaning up... 13:11:25 INFO - Return code: 0 13:11:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:11:25 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')]} 13:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:25 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')]} 13:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:25 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 0x15b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19255c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19227a0>, '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 0x19236a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', '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 13:11:25 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 13:11:25 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 13:11:25 INFO - Using env: {'DISPLAY': ':0', 13:11:25 INFO - 'HOME': '/home/cltbld', 13:11:25 INFO - 'LANG': 'en_US.UTF-8', 13:11:25 INFO - 'LANGUAGE': 'en_US:en', 13:11:25 INFO - 'LOGNAME': 'cltbld', 13:11:25 INFO - 'MAIL': '/var/mail/cltbld', 13:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:25 INFO - 'MOZ_NO_REMOTE': '1', 13:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:25 INFO - 'NO_EM_RESTART': '1', 13:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:25 INFO - 'PWD': '/builds/slave/test', 13:11:25 INFO - 'SHELL': '/bin/bash', 13:11:25 INFO - 'SHLVL': '1', 13:11:25 INFO - 'TERM': 'linux', 13:11:25 INFO - 'TMOUT': '86400', 13:11:25 INFO - 'USER': 'cltbld', 13:11:25 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', 13:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:25 INFO - '_': '/tools/buildbot/bin/python'} 13:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:11:25 INFO - Cleaning up... 13:11:25 INFO - Return code: 0 13:11:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:11:25 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')]} 13:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:25 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')]} 13:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:25 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 0x15b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19255c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19227a0>, '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 0x19236a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', '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 13:11:25 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 13:11:25 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 13:11:25 INFO - Using env: {'DISPLAY': ':0', 13:11:25 INFO - 'HOME': '/home/cltbld', 13:11:25 INFO - 'LANG': 'en_US.UTF-8', 13:11:25 INFO - 'LANGUAGE': 'en_US:en', 13:11:25 INFO - 'LOGNAME': 'cltbld', 13:11:25 INFO - 'MAIL': '/var/mail/cltbld', 13:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:25 INFO - 'MOZ_NO_REMOTE': '1', 13:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:25 INFO - 'NO_EM_RESTART': '1', 13:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:25 INFO - 'PWD': '/builds/slave/test', 13:11:25 INFO - 'SHELL': '/bin/bash', 13:11:25 INFO - 'SHLVL': '1', 13:11:25 INFO - 'TERM': 'linux', 13:11:25 INFO - 'TMOUT': '86400', 13:11:25 INFO - 'USER': 'cltbld', 13:11:25 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', 13:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:25 INFO - '_': '/tools/buildbot/bin/python'} 13:11:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:26 INFO - Downloading/unpacking blobuploader==1.2.4 13:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:27 INFO - Downloading blobuploader-1.2.4.tar.gz 13:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:11:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:11:27 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 13:11:27 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 13:11:27 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 13:11:27 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 13:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:11:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:11:27 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 13:11:27 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 13:11:27 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 13:11:27 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 13:11:27 INFO - Downloading docopt-0.6.1.tar.gz 13:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:11:27 INFO - Installing collected packages: blobuploader, requests, docopt 13:11:27 INFO - Running setup.py install for blobuploader 13:11:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:11:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:11:27 INFO - Running setup.py install for requests 13:11:28 INFO - Running setup.py install for docopt 13:11:28 INFO - Successfully installed blobuploader requests docopt 13:11:28 INFO - Cleaning up... 13:11:28 INFO - Return code: 0 13:11:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:28 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 0x15b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19255c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19227a0>, '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 0x19236a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', '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 13:11:28 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 13:11:28 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 13:11:28 INFO - Using env: {'DISPLAY': ':0', 13:11:28 INFO - 'HOME': '/home/cltbld', 13:11:28 INFO - 'LANG': 'en_US.UTF-8', 13:11:28 INFO - 'LANGUAGE': 'en_US:en', 13:11:28 INFO - 'LOGNAME': 'cltbld', 13:11:28 INFO - 'MAIL': '/var/mail/cltbld', 13:11:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:28 INFO - 'MOZ_NO_REMOTE': '1', 13:11:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:28 INFO - 'NO_EM_RESTART': '1', 13:11:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:28 INFO - 'PWD': '/builds/slave/test', 13:11:28 INFO - 'SHELL': '/bin/bash', 13:11:28 INFO - 'SHLVL': '1', 13:11:28 INFO - 'TERM': 'linux', 13:11:28 INFO - 'TMOUT': '86400', 13:11:28 INFO - 'USER': 'cltbld', 13:11:28 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', 13:11:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:28 INFO - '_': '/tools/buildbot/bin/python'} 13:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:11:28 INFO - Running setup.py (path:/tmp/pip-rq95mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:11:28 INFO - Running setup.py (path:/tmp/pip-_v2y7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:11:28 INFO - Running setup.py (path:/tmp/pip-u5FQ9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:11:28 INFO - Running setup.py (path:/tmp/pip-8P29x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:11:28 INFO - Running setup.py (path:/tmp/pip-oVZ5Bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:11:28 INFO - Running setup.py (path:/tmp/pip-FgUxu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:11:28 INFO - Running setup.py (path:/tmp/pip-OS_4zg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:11:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:11:28 INFO - Running setup.py (path:/tmp/pip-XjSMZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:11:29 INFO - Running setup.py (path:/tmp/pip-EJvaF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:11:29 INFO - Running setup.py (path:/tmp/pip-T4Xlku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:11:29 INFO - Running setup.py (path:/tmp/pip-hBEcoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:11:29 INFO - Running setup.py (path:/tmp/pip-2buuhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:11:29 INFO - Running setup.py (path:/tmp/pip-s9ibaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:11:29 INFO - Running setup.py (path:/tmp/pip-wjOcje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:29 INFO - Running setup.py (path:/tmp/pip-_h6yey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:11:29 INFO - Running setup.py (path:/tmp/pip-_bRCLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:11:29 INFO - Running setup.py (path:/tmp/pip-UAAGa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:11:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:11:29 INFO - Running setup.py install for manifestparser 13:11:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:11:29 INFO - Running setup.py install for mozcrash 13:11:29 INFO - Running setup.py install for mozdebug 13:11:30 INFO - Running setup.py install for mozdevice 13:11:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:11:30 INFO - Running setup.py install for mozfile 13:11:30 INFO - Running setup.py install for mozhttpd 13:11:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:11:30 INFO - Running setup.py install for mozinfo 13:11:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:11:30 INFO - Running setup.py install for mozInstall 13:11:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:11:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:11:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:11:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:11:30 INFO - Running setup.py install for mozleak 13:11:30 INFO - Running setup.py install for mozlog 13:11:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:11:30 INFO - Running setup.py install for moznetwork 13:11:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:11:30 INFO - Running setup.py install for mozprocess 13:11:30 INFO - Running setup.py install for mozprofile 13:11:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:11:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:11:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:11:31 INFO - Running setup.py install for mozrunner 13:11:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:11:31 INFO - Running setup.py install for mozscreenshot 13:11:31 INFO - Running setup.py install for moztest 13:11:31 INFO - Running setup.py install for mozversion 13:11:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:11:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:11:31 INFO - Cleaning up... 13:11:31 INFO - Return code: 0 13:11:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11:31 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')]} 13:11:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:31 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')]} 13:11:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:31 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 0x15b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19255c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19227a0>, '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 0x19236a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', '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 13:11:31 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 13:11:31 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 13:11:31 INFO - Using env: {'DISPLAY': ':0', 13:11:31 INFO - 'HOME': '/home/cltbld', 13:11:31 INFO - 'LANG': 'en_US.UTF-8', 13:11:31 INFO - 'LANGUAGE': 'en_US:en', 13:11:31 INFO - 'LOGNAME': 'cltbld', 13:11:31 INFO - 'MAIL': '/var/mail/cltbld', 13:11:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:31 INFO - 'MOZ_NO_REMOTE': '1', 13:11:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:31 INFO - 'NO_EM_RESTART': '1', 13:11:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:31 INFO - 'PWD': '/builds/slave/test', 13:11:31 INFO - 'SHELL': '/bin/bash', 13:11:31 INFO - 'SHLVL': '1', 13:11:31 INFO - 'TERM': 'linux', 13:11:31 INFO - 'TMOUT': '86400', 13:11:31 INFO - 'USER': 'cltbld', 13:11:31 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', 13:11:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:31 INFO - '_': '/tools/buildbot/bin/python'} 13:11:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:11:31 INFO - Running setup.py (path:/tmp/pip-IFGung-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:11:31 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)) 13:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:11:31 INFO - Running setup.py (path:/tmp/pip-b4oxx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:11:31 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)) 13:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:11:31 INFO - Running setup.py (path:/tmp/pip-QyMkOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:11:31 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)) 13:11:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:11:31 INFO - Running setup.py (path:/tmp/pip-2RfVlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:11:32 INFO - Running setup.py (path:/tmp/pip-KdjeiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:11:32 INFO - Running setup.py (path:/tmp/pip-KL0HDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:11:32 INFO - Running setup.py (path:/tmp/pip-Vy30Ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:11:32 INFO - Running setup.py (path:/tmp/pip-JF1nlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:11:32 INFO - Running setup.py (path:/tmp/pip-vtbQNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:11:32 INFO - Running setup.py (path:/tmp/pip-ad0ggR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:11:32 INFO - Running setup.py (path:/tmp/pip-8XbDWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:11:32 INFO - Running setup.py (path:/tmp/pip-PeOIrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:11:32 INFO - Running setup.py (path:/tmp/pip-_B4ejY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:11:32 INFO - Running setup.py (path:/tmp/pip-nO_ZYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:32 INFO - Running setup.py (path:/tmp/pip-r5t938-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:11:32 INFO - Running setup.py (path:/tmp/pip-Lst1RR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:11:32 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)) 13:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:11:32 INFO - Running setup.py (path:/tmp/pip-brCMaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:11:32 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)) 13:11:32 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)) 13:11:32 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)) 13:11:32 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)) 13:11:32 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)) 13:11:32 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)) 13:11:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:11:32 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 13:11:32 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 13:11:32 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 13:11:32 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 13:11:34 INFO - Downloading blessings-1.6.tar.gz 13:11:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:11:34 INFO - Installing collected packages: blessings 13:11:34 INFO - Running setup.py install for blessings 13:11:34 INFO - Successfully installed blessings 13:11:34 INFO - Cleaning up... 13:11:34 INFO - Return code: 0 13:11:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:11:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:11:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:11:34 INFO - Reading from file tmpfile_stdout 13:11:34 INFO - Current package versions: 13:11:34 INFO - argparse == 1.2.1 13:11:34 INFO - blessings == 1.6 13:11:34 INFO - blobuploader == 1.2.4 13:11:34 INFO - docopt == 0.6.1 13:11:34 INFO - functools32 == 3.2.3-2 13:11:34 INFO - jsonschema == 2.5.1 13:11:34 INFO - manifestparser == 1.1 13:11:34 INFO - mozInstall == 1.12 13:11:34 INFO - mozcrash == 1.0 13:11:34 INFO - mozdebug == 0.1 13:11:34 INFO - mozdevice == 0.51 13:11:34 INFO - mozfile == 1.2 13:11:34 INFO - mozhttpd == 0.7 13:11:34 INFO - mozinfo == 0.9 13:11:34 INFO - mozleak == 0.1 13:11:34 INFO - mozlog == 3.4 13:11:34 INFO - moznetwork == 0.27 13:11:34 INFO - mozprocess == 0.25 13:11:34 INFO - mozprofile == 0.28 13:11:34 INFO - mozrunner == 6.13 13:11:34 INFO - mozscreenshot == 0.1 13:11:34 INFO - mozsystemmonitor == 0.3 13:11:34 INFO - moztest == 0.8 13:11:34 INFO - mozversion == 1.4 13:11:34 INFO - psutil == 3.1.1 13:11:34 INFO - requests == 1.2.3 13:11:34 INFO - wsgiref == 0.1.2 13:11:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:34 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 0x15b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19255c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19227a0>, '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 0x19236a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', '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 13:11:34 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 13:11:34 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 13:11:34 INFO - Using env: {'DISPLAY': ':0', 13:11:34 INFO - 'HOME': '/home/cltbld', 13:11:34 INFO - 'LANG': 'en_US.UTF-8', 13:11:34 INFO - 'LANGUAGE': 'en_US:en', 13:11:34 INFO - 'LOGNAME': 'cltbld', 13:11:34 INFO - 'MAIL': '/var/mail/cltbld', 13:11:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:34 INFO - 'MOZ_NO_REMOTE': '1', 13:11:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:34 INFO - 'NO_EM_RESTART': '1', 13:11:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:34 INFO - 'PWD': '/builds/slave/test', 13:11:34 INFO - 'SHELL': '/bin/bash', 13:11:34 INFO - 'SHLVL': '1', 13:11:34 INFO - 'TERM': 'linux', 13:11:34 INFO - 'TMOUT': '86400', 13:11:34 INFO - 'USER': 'cltbld', 13:11:34 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', 13:11:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:34 INFO - '_': '/tools/buildbot/bin/python'} 13:11:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:34 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)) 13:11:34 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)) 13:11:34 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)) 13:11:34 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)) 13:11:34 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)) 13:11:34 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)) 13:11:34 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)) 13:11:34 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)) 13:11:34 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)) 13:11:34 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:11:34 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 13:11:34 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 13:11:34 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 13:11:34 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 13:11:35 INFO - Downloading marionette_driver-1.4.0.tar.gz 13:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 13:11:35 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)) 13:11:35 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)) 13:11:35 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)) 13:11:35 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)) 13:11:35 INFO - Installing collected packages: marionette-driver 13:11:35 INFO - Running setup.py install for marionette-driver 13:11:36 INFO - Successfully installed marionette-driver 13:11:36 INFO - Cleaning up... 13:11:36 INFO - Return code: 0 13:11:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:11: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')]} 13:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11: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')]} 13:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:36 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 0x15b21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19255c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19227a0>, '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 0x19236a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923b30>, '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': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', '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 13:11:36 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 13:11:36 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 13:11:36 INFO - Using env: {'DISPLAY': ':0', 13:11:36 INFO - 'HOME': '/home/cltbld', 13:11:36 INFO - 'LANG': 'en_US.UTF-8', 13:11:36 INFO - 'LANGUAGE': 'en_US:en', 13:11:36 INFO - 'LOGNAME': 'cltbld', 13:11:36 INFO - 'MAIL': '/var/mail/cltbld', 13:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:36 INFO - 'MOZ_NO_REMOTE': '1', 13:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:36 INFO - 'NO_EM_RESTART': '1', 13:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:36 INFO - 'PWD': '/builds/slave/test', 13:11:36 INFO - 'SHELL': '/bin/bash', 13:11:36 INFO - 'SHLVL': '1', 13:11:36 INFO - 'TERM': 'linux', 13:11:36 INFO - 'TMOUT': '86400', 13:11:36 INFO - 'USER': 'cltbld', 13:11:36 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', 13:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:36 INFO - '_': '/tools/buildbot/bin/python'} 13:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:11:36 INFO - Cleaning up... 13:11:36 INFO - Return code: 0 13:11:36 INFO - Running post-action listener: _resource_record_post_action 13:11:36 INFO - Running post-action listener: _start_resource_monitoring 13:11:36 INFO - Starting resource monitoring. 13:11:36 INFO - [mozharness: 2017-05-26 20:11:36.320828Z] Finished create-virtualenv step (success) 13:11:36 INFO - [mozharness: 2017-05-26 20:11:36.321375Z] Running install step. 13:11:36 INFO - Running pre-action listener: _resource_record_pre_action 13:11:36 INFO - Running main action method: install 13:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:11:36 INFO - Reading from file tmpfile_stdout 13:11:36 INFO - Detecting whether we're running mozinstall >=1.0... 13:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:11:36 INFO - Reading from file tmpfile_stdout 13:11:36 INFO - Output received: 13:11:36 INFO - Usage: mozinstall [options] installer 13:11:36 INFO - Options: 13:11:36 INFO - -h, --help show this help message and exit 13:11:36 INFO - -d DEST, --destination=DEST 13:11:36 INFO - Directory to install application into. [default: 13:11:36 INFO - "/builds/slave/test"] 13:11:36 INFO - --app=APP Application being installed. [default: firefox] 13:11:36 INFO - mkdir: /builds/slave/test/build/application 13:11:36 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'] 13:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:11:52 INFO - Reading from file tmpfile_stdout 13:11:52 INFO - Output received: 13:11:52 INFO - /builds/slave/test/build/application/firefox/firefox 13:11:52 INFO - Running post-action listener: _resource_record_post_action 13:11:52 INFO - [mozharness: 2017-05-26 20:11:52.208126Z] Finished install step (success) 13:11:52 INFO - [mozharness: 2017-05-26 20:11:52.208239Z] Running run-tests step. 13:11:52 INFO - Running pre-action listener: _resource_record_pre_action 13:11:52 INFO - Running main action method: run_tests 13:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:11:52 INFO - Python 2.7.3 13:11:52 INFO - Return code: 0 13:11:52 INFO - grabbing minidump binary from tooltool 13:11:52 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')]} 13:11:52 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 0x19227a0>, '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 0x19236a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1923b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:11:52 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 13:11:52 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 13:11:52 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 13:11:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:11:52 INFO - Return code: 0 13:11:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:11:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:11:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:11:52 INFO - ENV: RUST_BACKTRACE is now 1 13:11:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:11:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 13:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --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 13:11:52 INFO - Using env: {'DISPLAY': ':0', 13:11:52 INFO - 'HOME': '/home/cltbld', 13:11:52 INFO - 'LANG': 'en_US.UTF-8', 13:11:52 INFO - 'LANGUAGE': 'en_US:en', 13:11:52 INFO - 'LOGNAME': 'cltbld', 13:11:52 INFO - 'MAIL': '/var/mail/cltbld', 13:11:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:11:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:52 INFO - 'MOZ_NO_REMOTE': '1', 13:11:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:52 INFO - 'NO_EM_RESTART': '1', 13:11:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:52 INFO - 'PWD': '/builds/slave/test', 13:11:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:11:52 INFO - 'RUST_BACKTRACE': '1', 13:11:52 INFO - 'SHELL': '/bin/bash', 13:11:52 INFO - 'SHLVL': '1', 13:11:52 INFO - 'TERM': 'linux', 13:11:52 INFO - 'TMOUT': '86400', 13:11:52 INFO - 'USER': 'cltbld', 13:11:52 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989', 13:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:52 INFO - '_': '/tools/buildbot/bin/python'} 13:11:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--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 13:11:52 INFO - mozversion application_buildid: 20170526194410 13:11:52 INFO - mozversion application_changeset: bce03a8eac301bcd9408b22333b1a67c3eaed057 13:11:52 INFO - mozversion application_display_name: Nightly 13:11:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:11:52 INFO - mozversion application_name: Firefox 13:11:52 INFO - mozversion application_remotingname: firefox 13:11:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:11:52 INFO - mozversion application_vendor: Mozilla 13:11:52 INFO - mozversion application_version: 55.0a1 13:11:52 INFO - mozversion platform_buildid: 20170526194410 13:11:52 INFO - mozversion platform_changeset: bce03a8eac301bcd9408b22333b1a67c3eaed057 13:11:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:11:52 INFO - mozversion platform_version: 55.0a1 13:11:52 INFO - using testdate: 1495829512 13:11:52 INFO - actual date: 1495829512 13:11:52 INFO - starting webserver on 'localhost:42119' 13:11:52 INFO - SUITE-START | Running 2 tests 13:11:52 INFO - TEST-START | dromaeo_css 13:11:52 INFO - operating with platform_type : linux_ 13:11:52 INFO - Initialising browser for dromaeo_css test... 13:11:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42119/getInfo.html -profile /tmp/tmpfmXZU7/profile 13:11:52 INFO - TEST-INFO | started process 23846 (/builds/slave/test/build/application/firefox/firefox http://localhost:42119/getInfo.html) 13:12:27 INFO - TEST-INFO | 23846: killed by SIGTERM 13:12:27 INFO - Browser initialized. 13:12:27 INFO - Running cycle 1/1 for dromaeo_css test... 13:12:27 INFO - TEST-INFO | started process 24046 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfmXZU7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:12:39 INFO - PID 24046 | RSS: Main: 168787968 13:12:39 INFO - PID 24046 | 13:15:43 INFO - PID 24046 | Cycle 1(1): loaded http://localhost:42119/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42119/tests/dromaeo/cssquery-ext.html) 13:15:44 INFO - PID 24046 | RSS: Main: 166522880 13:15:44 INFO - PID 24046 | 13:18:46 INFO - PID 24046 | Cycle 1(1): loaded http://localhost:42119/tests/dromaeo/cssquery-ext.html (next: http://localhost:42119/tests/dromaeo/cssquery-jquery.html) 13:18:47 INFO - PID 24046 | RSS: Main: 172322816 13:18:47 INFO - PID 24046 | 13:21:48 INFO - PID 24046 | Cycle 1(1): loaded http://localhost:42119/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42119/tests/dromaeo/cssquery-mootools.html) 13:21:49 INFO - PID 24046 | RSS: Main: 171278336 13:21:49 INFO - PID 24046 | 13:24:50 INFO - PID 24046 | Cycle 1(1): loaded http://localhost:42119/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42119/tests/dromaeo/cssquery-prototype.html) 13:24:51 INFO - PID 24046 | RSS: Main: 175693824 13:24:51 INFO - PID 24046 | 13:27:54 INFO - PID 24046 | Cycle 1(1): loaded http://localhost:42119/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42119/tests/dromaeo/cssquery-yui.html) 13:27:55 INFO - PID 24046 | RSS: Main: 173924352 13:27:55 INFO - PID 24046 | 13:30:56 INFO - PID 24046 | Cycle 1(1): loaded http://localhost:42119/tests/dromaeo/cssquery-yui.html (next: http://localhost:42119/tests/dromaeo/cssquery-dojo.html) 13:30:57 INFO - PID 24046 | RSS: Main: 171503616 13:30:57 INFO - PID 24046 | 13:30:57 INFO - PID 24046 | __start_tp_report 13:30:57 INFO - PID 24046 | _x_x_mozilla_page_load 13:30:57 INFO - PID 24046 | _x_x_mozilla_page_load_details 13:30:57 INFO - PID 24046 | |i|pagename|runs| 13:30:57 INFO - PID 24046 | |0;dojo.html;2699.2577041313634;2705.3912869604355;2724.7411495907895;2741.9040333588327;2744.766694830939;5202.3497062867145;5220;5233.424323324441;5269.156934890419;5283.841484755459;5229.346331708536;5243.816466423676;5251.658642188255;5328.227407025979;5346.144616861303;4392.209402307583;4622.4684161321375;4665.953340466586;4672.345871577982;4701.318308845215;4720.008798152375;4752.619790416776;4780.995990841928;4782.091402633506;4813.37426134602;4560.954390456086;4618.630509559227;4658.301254811771;4680.976595117037;4689.788959496831;4705.106029854317;4715.292706094079;4719.9292010619865;4763.190257656207;4763.261694437368;4652.534746525354;4671.579557839811;4684.133435314444;4691.882702932454;4711.481737008926;5219.347581552306;5279.260903473517;5317.255584218174;5317.787288508455;5362.43694412085;5596.104623260258;5641.774329026875;5680.744366503517;5690.687012214326;5698.51562617178;5691.146328050784;5702.714864256771;5703.144528320785;5704.515116215127;5714.1428785682065;5219.347581552306;5293.206019097128;5297.576193904479;5299.099153143975;5326.973365133227;5762.4525670061275;5770.42295770428;5788.710564471759;5854.882902341929;5876.001079816441;5634.971825140848;5638.661680299195;5639.943600563942;5640.858978525488;5694.9430505695245;5696.971515142398;5718.370979192286;5720.11338242573;5739.885202295931;5740.196372507852;5567;5571.860703482445;5653.830385088454;5674.092145256739;5678.858028549237;5696.088625819849;5705.71471426427;5723.828285151452;5740.13897915316;5752.6836024019085;4373.453318335208;4379.474463064389;4388.780560971939;4391.3193455014525;4422.137683151755;3767.7550959187565;3816.580176180618;3828.655421012122;3863.8068096595057;3868.110334622996;4738.8341408050555;4762.976185119052;4804.927926081112;4804.927926081112;4807.134715751198;5617.719114044363;5697.6296540724725;5702.8289151325525;5732.598718089694;5759.308882934075;4773.212419950669;4783.569478746929;4783.6651434399955;4791.760411979387;4816.927746083811;4925.87685307863;4934.18585933317;4978.2034874419915;4978.27814966835;5009.974950125299;5234.581233501234;5249.763760630704;5289.047971365191;5298.867528311746;5301.310829592128;5592.3009623797025;5607.523360514402;5639.8590035249445;5671.602987790815;5713.400092990342;5223.843284701313;5225.294585230945;5240.554552863049;5256.474352564713;5260.552853007384;5465.754041068082;5534.1145416733125;5572.387037425799;5577.44225577439;5586.190002449541;5629.634073785191;5632.605717599892;5694.829155125353;5722.7710891563875;5724.856878578069;5478.643888147258;5497.752601132878;5501.807436739695;5509.3664228614225;5540.168974653673;5497.945020549743;5499.862503437446;5519.3652729936575;5522.30971128609;5541.3904470507405;5323.973380133075;5394.838154855361;5395.3525576931015;5427.511523962862;5436.3476382834315;5602.2717046783655;5623.0721930880945;5639.379668236573;5658.575606829587;5666.773329066956;5413.10683737179;5417.674939503642;5427.348718153847;5436.048691478896;5436.592255580927 13:30:57 INFO - PID 24046 | |1;ext.html;711.5730561663003;726.9890951635725;1118.4351902289343;1134.3420815926763;1226.3439060102846;32692.182695432595;34111.65888341116;34119;34129;34149.31701365971;32038.199045023885;32406;32420.513692294633;32429.67570324296;32448.513272300876;6533.31400202979;6544;6652.800415987528;6654.600723956554;6735.5621884577595;6831.692573834164;6874.450043996493;6913.962905564181;6917.930820691804;6922.861542769142;6890.586564806128;6926.134233220848;6932.896006559906;6943.340382663664;6951.061606683109;6859.348361905611;6875.724971001154;6890.621015844126;6901.240863505011;6916.550424222434;6726.865462690767;6754.18949726036;6754.5947243165565;6778.457723382117;6785.898211526831;31670.524942125885;31816.204594885083;31827.522587161213;31833.363332733217;31872.840635796674;3067.49386351254;3105.4720697481257;3119.625644922624;3120.719135277813;3133.7022982816598;24474;24559.263222103367;24603.38491537708;24612;24695;3102.720755132049;3128.108489080601;3139.2936589267233;3148.574942382772;3162.920926976844;145090;145957;146092.26953865163;146448.2677586616;146503.80244296344;39151.41272880909;40752.796236019225;40804.183916321505;40954.795226024275;41317.380239296435;41681.4150443451;41685.58314416878;41785.79107104506;41979.79010104991;41998.1600367997;12897.871021289668;13058;13085.607431777062;13103.2138071716;13110.278934658494;9757.268204884662;9857.950710246403;9867.06262905023;9912.306138570375;10335.74160645975;12822;12903.096783225084;12951.093423460456;12977.35113244334;13061;5404.216388623628;5432.278888961075;5438.864028399243;5501.339839219319;5510.1459273812625;870.5038128266827;890.5057692980329;909.2226146644524;924.117467818232;947.7298969793713;21472.78527214739;21484.355469335944;21581.35255942324;21716.674249886266;21862.89068554647;979.2215188924822;1000.5497526113278;1013.6198925402974;1021.3871676993745;1026.6817286641017;11044.061254793432;11139.164562657834;11437.714057148638;11453.484593193327;11468.13988950832;188647;188809;189648;190300;190381;41594.1681166381;41675.16649667051;41934.580654193065;42017.57982420137;42060;1235.9876401235872;1248.1949142802841;1254.3407975093044;1260.1242136715077;1265.6519457149357;19739;20712.275070372463;21433.89699084444;21482.355529334145;21733.891330543247;29829.10512684623;29907.252318692208;30112;30129.397412052076;30144.54783178298;144171;148313;158697;159562.2021889883;160443;31182.37635247237;31278;31621.683783161872;31631;31687.366252674357;36835.07912302214;37339.25321493609;37360.43959340558;37496.62503374931;37830.62169378271;28609.713902860705;28690.426191476472;29057.273568160967;29096.05367087558;29494.262643434085;27627.86186069057;28086.859565702856;28547.857260714394;29512.704872951854;29584.852075739484;31834.522482162323;32081.839590801897;32349.191270218435;32441.188970275933;32446.67553324531;26487.205383838515;26882.467282620655;27570.724292756815;27961.720382795913;29019;21037.474063147933;22697.93373566212;23076.769232308132;23084.192053278053;23098.53802923966 13:30:57 INFO - PID 24046 | |2;jquery.html;404.75916829486465;407.37061240383605;423.86648205815175;427.59378590339185;431.92009478246524;17429.389971351004;17883.28466861324;18039.18823652937;18069.728954065682;18714.532136696555;19379.32172373967;19575.60848783027;19610.117544710487;19678.508037299038;19855.702164467544;5339.946600534003;5414.512693857552;5536.501714845663;5624.775008999635;5629.211910332557;5381.48875856793;5469.425710300421;5479.917801232985;5482.643628164176;5486.561075113981;5194.8441546753465;5395.298611180541;5441.401445840955;5447.319085114361;5460.945390546083;5309.469053094698;5341.545968592655;5389.272448219479;5397.757100930428;5399.082156033444;4759.405074365704;4829.2997515360075;4844.128056949748;4850.514948505156;4872.537108974641;22157.335279941628;22229.888850555806;22325.665115023286;22489;22551.661725074136;1614.5156453064035;1629.136557624449;1658.4444211189266;1661.3852874436416;1662.950111496657;14529.418823247057;14674.779878301728;14708.043977141451;15013.099214047192;15046.398144074225;2018.1322031526438;2079.740032495938;2098;2127.6489379252403;2153.1710291537715;85245;85529.57235213846;87017.56491217567;87154.56422717846;87493;10987.230893837355;11078.390688512049;11092.500837462172;11245.718857028476;11277.661670149744;15401.46094886696;15478.226088695521;15499.845001550066;15512.301946412439;15518.129146108005;7749.961250193825;7871.212878712083;7932.246436588515;7992.960035199903;8014.719484818003;7263.673134708845;7294.671739771723;7300.269973002763;7433.8141546461775;7489.554804789857;7037.507374483737;7123.679434425463;7136.0723105995885;7157.642117894085;7177.712891484282;2002.9399118026483;2024.7367842180422;2039.2274292558943;2046.6623007203646;2054.3734161080715;867.4274978514151;898.2454738020094;904.8235594059096;905.7056456651615;940.4075432477632;16951.406700765416;17113.828861711474;17680.115994200238;17883.642327153644;18080.90959545194;925.1303774451993;925.2459245714721;928.6842473559022;934.6635211323918;946.2477330522252;9221.893372795173;9689.41863488193;9689.854652180224;9779.559919803625;9842.60629574809;373566;374251;376066;378269;381991;73667.63166184135;74892;75757.24242757612;77434.61282693663;77802.61098694471;1048.8321868501155;1066.6266806617778;1101.6915263726169;1108.146727020206;1116.436199719153;14289.142651440947;14553.92723036378;14608.342624581706;14723.779143313073;15294.464693735667;37723.622763773106;37921.24157516779;37951.81024094862;39194.608053919095;39280.80359598184;48464.27303590378;49720.751396242784;50082;50969.74515127401;51277.230841536664;8085.676572937016;8102.554359510284;8150.918490815253;8166.591670416574;8289.544075075928;11665.59170429065;12241.816372754238;12342.197757145757;12352.505899763908;12859.614211573667;9688.9031109688;10000.749981250527;10400.687979360631;10524.36853788775;10532.420716860646;8399.622017009127;8471;9260.259179265508;9350.176715540405;9378.109079637423;10105.191584673355;10345.068943794793;10887.618933337295;10946.233763636468;11282.43587820622;7813.687452501837;7873.330766884879;7984.84030319402;8012.799680007814;8184.713535026483;10275.948620256851;10480.68557943263;10482.266241363337;10633.946830266108;10945.781084378108 13:30:57 INFO - PID 24046 | |3;mootools.html;1234.783912815257;1289.961301160965;1299.2918859221722;1304.1457845111456;1318.4198952460918;10403.115735162512;10448.32085914415;10696.0373566379;10890.074343680786;10917.344959302438;10955.34267943924;11080.05819505343;11128.165387595942;11135.443227838596;11187.160962927772;2187.3984654220058;2212.391592312111;2217.3791338425267;2217.412385717786;2238.138316748056;2174.2281490071036;2196.967045494319;2211.7788221177834;2212.54642798226;2215.102883332253;2150.0969592771075;2173.521825198454;2182.6071307164702;2184.1154332495366;2186.081845624841;1997.690357994513;2001.4195883193856;2006;2006.1674405121857;2007.4278830533228;1894.914728837192;1971.9605607887906;2112.5669237806214;2169.80471757541;2200.504886400563;10671.466426678635;10790.73023174419;10807.297525660886;10813.67558973232;10814.72963175919;5599.552035837164;5866.501347385477;5873.823785286449;5876.236089308362;5881.85295367615;3237.967014473246;3361.159710072482;3412.692857642824;3425.383430982422;3426.5716785401823;1042.3589492462156;1047.701405099543;1066.317556763672;1084.5661735305941;1103.9448027598587;15653.765193522106;15888.28502717392;15920.920395398065;15948.122853243067;16045;4644.187267228222;4676.456769266134;4775.617950563947;4798.664093513421;4813.350197723333;11185.32888026721;11281.887181128248;11321.377324247082;11375;11381.203315767982;5474.890502189934;5574.247476590689;5582.944170558324;5585.245991791056;5605.271314729059;5080.898382032338;5166.3800343958965;5185.274061631375;5190.247414125006;5196.480351964773;3814.370628846265;3842.423636454554;3877.2245550889934;3894.6689531389584;3900.8829735107993;1069.2782371898936;1078.5793540519203;1078.5901357484106;1089.4661615808197;1093.792179485895;704.8731228378839;722.5772922840092;736.9115706115193;739.5525706947219;751.3575892611848;5565.1374037024325;5602.523785478198;5698.3162020556965;5754.251947246831;5818.0981947798155;511.82853743995435;538.6714104396315;540.3731671261318;541.7670401727295;543.4293991309189;3589.6230895756094;3712.461693054546;3846.3076646203394;3896.883093507199;4100.5899410058755;13073.803892941614;13213.603591892259;13297.800532992012;13305.600831975056;13629.863701363058;12768.297743624003;12963.546275880299;13158.539451119357;13274.336283185996;13410.463581456828;7547.207543207994;7552.763041666389;7663.118741344817;7673.079230492377;7693.8459231115785;5971.223740913653;6062.514998800174;6085.208922840003;6108.725107370268;6219.378062193744;11815.232009919328;12374.81437778416;12498.500059997497;12509.061820363328;12671.746565068832;11817.822732658846;12171.81742273849;12204.816927745913;12234.204776689487;12688.17526860751;8841.911580884109;9096.681616143404;9103.681371151977;9109.954450227971;9125.817483650422;9898.802023959624;10151.137153342048;10189.350768800314;10199.847002294822;10215.233857460571;8372.41393102477;8403.537805420761;8547.145285471403;8550.700725474579;8578.91421085781;8508.574571271289;8520.233179013918;8520.318374530147;8526.232639062515;8563.272121869712;7342.045534080536;7365.7790266292095;7395.482316237812;7481.214472480311;7489.251074892685;5886.882262354643;5951.7619295227705;6095.939040609537;6116.785912493041;6225.800687012413;5378.139497680509;5421.83734487966;5464.535514481314;5523.613347065667;5588.050031494737 13:30:57 INFO - PID 24046 | |4;prototype.html;347.64019240086515;356.91612471069294;360.9476625889245;367.5552581376534;367.8859553538403;5457.399686034533;5562.443755624436;5577.191307260445;5640.774369025234;5650.124230744236;5361.812336568221;5435.510804027636;5446.2375267462585;5452.454754524546;5455.509004189622;4122.855700050499;4126.8142933567915;4134.173165366924;4138.937915931264;4140.979295103521;3994.3209654358684;4117.094239267356;4122.835086596532;4128.153728485669;4159.292920203573;4084.387341898709;4086.284900142478;4090.6931980101613;4098.139390727951;4098.836046558149;4073.2668119738437;4075.1849630073957;4078.87763367098;4082.448869402622;4085.4893138357706;3566.6789988901123;3568.125809176768;3577.6941416382833;3709.925801483982;3818.618138186187;5420.728963551846;5436.374816896068;5458.5087342139395;5469;5482.205080263339;5053.519915608012;5055.191169412877;5060.240963855451;5071.39143302806;5082.822101226439;5669.262995810518;5840.824775256707;5887.0286402743495;5901.468867801876;5925.555583331225;4385.6710746694125;4391.4730232372;4401.933970990438;4412.823487060514;4414.889627759299;5903.5572332074835;6061.605995610271;6122.908156377658;6203.472704820096;6246.3753624637175;4188.28799104153;4218.3002878158;4221.451211342506;4222.071144348239;4238.109996900624;4265.53079161292;4282.678799090018;4284.164587905391;4286;4290.764007979591;4781.593564547053;4877.6585639004925;4902.191138462185;4923.950760492421;4942.654014218971;5811;5833.82498525045;5840.912386314209;5869.295684517885;5878.764849405976;1549.6435819761518;1558.4779099001962;1567.1537369820169;1579.1709352589983;1581.4227806850647;1095.8356246562919;1096.4188979840696;1103.4207041303218;1108.4790148630132;1128.65575999321;4954.826581069645;4989.825356112518;4992.151334273182;4997.400311962515;5012.872103776621;5913.172155898178;6007.729652165663;6009.2188015557695;6015.9171349156695;6018.759249630053;4834.734089625104;4930.852074437773;4945.851624451272;4961.404631444249;4967.90064198714;3159.7314228290393;3166.366726654632;3197.6962188592047;3207.9198020049685;3209.1816586770224;5385.623006389594;5495.780168793203;5542.334919809648;5549.36293793332;5555.777768889199;6184.752609895554;6186.133941248228;6206.224221972254;6243.906341404882;6266.592671476339;5543.833684989457;5609.859753506195;5618.943810561842;5626.099824028218;5630.74661640219;5844.444777746107;5968.16445697594;6041.305249896318;6043.761028988959;6075.453209211192;5752.654840709571;5956.583039187215;5982.4316689914385;5986.982213023884;6004.729787159676;5568.248286481273;5572.554195664256;5601;5612.214289999485;5617.943820561742;4053;4064.837406503707;4079.73481723687;4080.428739976346;4086.673066154641;5941.6037231251485;6072.453479186895;6072.635641861502;6078.878422431439;6086.330503644507;5850.64896106235;5877.94122058774;5889.882202355843;5894.469497745224;5896.557758168069;5694.743736531783;5813.76744930198;5845.3570107289015;5845.795397161079;5874.001419758737;5718.914216286676;5735.254416925773;5741.1388291756575;5759.164921086335;5777.104548794943;5859.736311865891;5867.354590994902;5906.96628090074;5921.259842519685;5923;5605.1872478491205;5636.549076073822;5650.9656523652275;5673.262475878109;5699.401562835843 13:30:57 INFO - PID 24046 | |5;yui.html;739.4306384084252;746.3618606091792;756.2248695087535;759.6695437484694;766.7891329884279;12097.213681110721;12160.27038377698;12445.439955202015;12563.93718031411;12604.432800523975;15146.16696081715;15597.454089106883;15615.84384156158;15633.374665013385;15660.451884184056;865.2645251536192;900.8918929728442;904.0868722590166;904.1952662130709;905.2938707807888;911.9544022798833;919.517253441945;919.7424721078108;920.3235621817959;920.5121285718579;951.172479942451;952.5665822050985;957.6887511558737;962.0812124421196;963.816874793787;945.3618807305076;956.8803899512561;964.7539877331236;965.8502932045474;968.5205823117567;674.8785218660639;682.607500687107;688.7189826921921;689.7723751162105;689.837888096302;15095.47165849201;15222.162781047038;15223.086614803147;15290;15326.923365383213;14624.70750584993;15040.774388384183;15067.547973560811;15167;15205.771913421308;12780.552680656132;12819.87180128196;12884.162529435556;13101.803472947913;13176.143550669272;2931.2818359501844;2933.985330073336;2944.5877577139217;2960.8075475094265;2961.2596850787304;80740.19259807386;80883.5955820223;81079.18920810775;81172.59413702953;81769.18230817675;10795.6221532246;10797.622083227207;10935.234533582732;10982.505787239594;10999.780004400027;17951;18032.188551515213;18411.079446027645;18438.26246950107;18624.534386640444;6226.6575338355915;6275.560710750204;6324.114623952651;6386.489080873519;6390.904136437957;2919.2701824543865;2977.077106097117;2995.0864986179427;3000.6849280825636;3008.7292143707173;3538.752287339913;3592.7844329340323;3618.7105031597407;3621.6378362163573;3623.2572322673786;672.5829985409077;683.3371629519457;769.3460558525321;818.145038434837;818.8976377952756;600.8708127752554;609.5732986909181;611.0711718188329;611.8378629663143;636.710296814948;9905.80188396228;10572.788544229072;10662.147028237723;10795.56817727282;11453.370064646359;598.5843480169368;606.4299558415075;610.3957082488394;618.8576627375638;626.7774939896362;4487.6634252431195;4576.725396476222;4578.2903649934315;4643.349931009661;4654.325122857167;87642.56178719066;87794.56102719446;88576;88806.55596722104;90995.5450222758;71759.2824071763;75039;75208;75468.24531754613;76519.61740191263;65987;67281;67369.59988801056;68467;70407.64796176089;9460.905390946002;9495.097965693249;9513.048695130708;9631.71104866855;9934.056264654846;28498.287542810765;29497.26256843596;29692.406151877272;29774.851125744233;30114.69885301119;36058.27883442369;37155.442668360534;37179.62820371761;37246.06884827901;37597.62402375941;12700.36498175106;12828.871711282767;13024.8046279304;13081.672958176121;13196.472141114247;14085.647858803612;14171.716565668423;14271.500497482539;14343.139411635335;14435.35040923182;13264.933675331948;13483;13504.45982160742;13585.116967397087;13618.659533511742;13533.458661653423;13613.727725445238;13619.591412257649;13715.657108572366;13731.725365492834;13420.060595758594;13423.463061477432;13535.255560944242;13723.382447789674;13736.793948090586;8864.113588641085;8868.290536756915;9082.40964337316;9198.908010919806;9368.67209647659;10630.096441802534;11070.225084244348;11189.272697274651;11257.099432045581;11331.660050198507 13:30:57 INFO - PID 24046 | __end_tp_report 13:30:57 INFO - PID 24046 | __start_cc_report 13:30:57 INFO - PID 24046 | _x_x_mozilla_cycle_collect,335 13:30:57 INFO - PID 24046 | __end_cc_report 13:30:57 INFO - PID 24046 | __startTimestamp1495830657039__endTimestamp 13:30:57 INFO - PID 24046 | 13:30:57 INFO - PID 24046 | ------- Summary: start ------- 13:30:57 INFO - PID 24046 | Number of tests: 6 13:30:57 INFO - PID 24046 | 13:30:57 INFO - PID 24046 | [#0] dojo.html Cycles:165 Average:5166.72 Median:5326.97 stddev:641.25 (12.0%) stddev-sans-first:613.31 13:30:57 INFO - PID 24046 | Values: 2699.3 2705.4 2724.7 2741.9 2744.8 5202.3 5220.0 5233.4 5269.2 5283.8 5229.3 5243.8 5251.7 5328.2 5346.1 4392.2 4622.5 4666.0 4672.3 4701.3 4720.0 4752.6 4781.0 4782.1 4813.4 4561.0 4618.6 4658.3 4681.0 4689.8 4705.1 4715.3 4719.9 4763.2 4763.3 4652.5 4671.6 4684.1 4691.9 4711.5 5219.3 5279.3 5317.3 5317.8 5362.4 5596.1 5641.8 5680.7 5690.7 5698.5 5691.1 5702.7 5703.1 5704.5 5714.1 5219.3 5293.2 5297.6 5299.1 5327.0 5762.5 5770.4 5788.7 5854.9 5876.0 5635.0 5638.7 5639.9 5640.9 5694.9 5697.0 5718.4 5720.1 5739.9 5740.2 5567.0 5571.9 5653.8 5674.1 5678.9 5696.1 5705.7 5723.8 5740.1 5752.7 4373.5 4379.5 4388.8 4391.3 4422.1 3767.8 3816.6 3828.7 3863.8 3868.1 4738.8 4763.0 4804.9 4804.9 4807.1 5617.7 5697.6 5702.8 5732.6 5759.3 4773.2 4783.6 4783.7 4791.8 4816.9 4925.9 4934.2 4978.2 4978.3 5010.0 5234.6 5249.8 5289.0 5298.9 5301.3 5592.3 5607.5 5639.9 5671.6 5713.4 5223.8 5225.3 5240.6 5256.5 5260.6 5465.8 5534.1 5572.4 5577.4 5586.2 5629.6 5632.6 5694.8 5722.8 5724.9 5478.6 5497.8 5501.8 5509.4 5540.2 5497.9 5499.9 5519.4 5522.3 5541.4 5324.0 5394.8 5395.4 5427.5 5436.3 5602.3 5623.1 5639.4 5658.6 5666.8 5413.1 5417.7 5427.3 5436.0 5436.6 13:30:57 INFO - PID 24046 | 13:30:57 INFO - PID 24046 | [#1] ext.html Cycles:180 Average:30985.21 Median:3130.91 stddev:42448.86 (1355.8%) stddev-sans-first:42507.07 13:30:57 INFO - PID 24046 | Values: 711.6 727.0 1118.4 1134.3 1226.3 32692.2 34111.7 34119.0 34129.0 34149.3 32038.2 32406.0 32420.5 32429.7 32448.5 6533.3 6544.0 6652.8 6654.6 6735.6 6831.7 6874.5 6914.0 6917.9 6922.9 6890.6 6926.1 6932.9 6943.3 6951.1 6859.3 6875.7 6890.6 6901.2 6916.6 6726.9 6754.2 6754.6 6778.5 6785.9 31670.5 31816.2 31827.5 31833.4 31872.8 3067.5 3105.5 3119.6 3120.7 3133.7 24474.0 24559.3 24603.4 24612.0 24695.0 3102.7 3128.1 3139.3 3148.6 3162.9 145090.0 145957.0 146092.3 146448.3 146503.8 39151.4 40752.8 40804.2 40954.8 41317.4 41681.4 41685.6 41785.8 41979.8 41998.2 12897.9 13058.0 13085.6 13103.2 13110.3 9757.3 9858.0 9867.1 9912.3 10335.7 12822.0 12903.1 12951.1 12977.4 13061.0 5404.2 5432.3 5438.9 5501.3 5510.1 870.5 890.5 909.2 924.1 947.7 21472.8 21484.4 21581.4 21716.7 21862.9 979.2 1000.5 1013.6 1021.4 1026.7 11044.1 11139.2 11437.7 11453.5 11468.1 188647.0 188809.0 189648.0 190300.0 190381.0 41594.2 41675.2 41934.6 42017.6 42060.0 1236.0 1248.2 1254.3 1260.1 1265.7 19739.0 20712.3 21433.9 21482.4 21733.9 29829.1 29907.3 30112.0 30129.4 30144.5 144171.0 148313.0 158697.0 159562.2 160443.0 31182.4 31278.0 31621.7 31631.0 31687.4 36835.1 37339.3 37360.4 37496.6 37830.6 28609.7 28690.4 29057.3 29096.1 29494.3 27627.9 28086.9 28547.9 29512.7 29584.9 31834.5 32081.8 32349.2 32441.2 32446.7 26487.2 26882.5 27570.7 27961.7 29019.0 21037.5 22697.9 23076.8 23084.2 23098.5 13:30:57 INFO - PID 24046 | 13:30:57 INFO - PID 24046 | [#2] jquery.html Cycles:180 Average:24944.63 Median:415.62 stddev:62594.71 (15060.6%) stddev-sans-first:62743.18 13:30:57 INFO - PID 24046 | Values: 404.8 407.4 423.9 427.6 431.9 17429.4 17883.3 18039.2 18069.7 18714.5 19379.3 19575.6 19610.1 19678.5 19855.7 5339.9 5414.5 5536.5 5624.8 5629.2 5381.5 5469.4 5479.9 5482.6 5486.6 5194.8 5395.3 5441.4 5447.3 5460.9 5309.5 5341.5 5389.3 5397.8 5399.1 4759.4 4829.3 4844.1 4850.5 4872.5 22157.3 22229.9 22325.7 22489.0 22551.7 1614.5 1629.1 1658.4 1661.4 1663.0 14529.4 14674.8 14708.0 15013.1 15046.4 2018.1 2079.7 2098.0 2127.6 2153.2 85245.0 85529.6 87017.6 87154.6 87493.0 10987.2 11078.4 11092.5 11245.7 11277.7 15401.5 15478.2 15499.8 15512.3 15518.1 7750.0 7871.2 7932.2 7993.0 8014.7 7263.7 7294.7 7300.3 7433.8 7489.6 7037.5 7123.7 7136.1 7157.6 7177.7 2002.9 2024.7 2039.2 2046.7 2054.4 867.4 898.2 904.8 905.7 940.4 16951.4 17113.8 17680.1 17883.6 18080.9 925.1 925.2 928.7 934.7 946.2 9221.9 9689.4 9689.9 9779.6 9842.6 373566.0 374251.0 376066.0 378269.0 381991.0 73667.6 74892.0 75757.2 77434.6 77802.6 1048.8 1066.6 1101.7 1108.1 1116.4 14289.1 14553.9 14608.3 14723.8 15294.5 37723.6 37921.2 37951.8 39194.6 39280.8 48464.3 49720.8 50082.0 50969.7 51277.2 8085.7 8102.6 8150.9 8166.6 8289.5 11665.6 12241.8 12342.2 12352.5 12859.6 9688.9 10000.7 10400.7 10524.4 10532.4 8399.6 8471.0 9260.3 9350.2 9378.1 10105.2 10345.1 10887.6 10946.2 11282.4 7813.7 7873.3 7984.8 8012.8 8184.7 10275.9 10480.7 10482.3 10633.9 10945.8 13:30:57 INFO - PID 24046 | 13:30:57 INFO - PID 24046 | [#3] mootools.html Cycles:180 Average:6473.53 Median:3386.93 stddev:4222.22 (124.7%) stddev-sans-first:4215.71 13:30:57 INFO - PID 24046 | Values: 1234.8 1290.0 1299.3 1304.1 1318.4 10403.1 10448.3 10696.0 10890.1 10917.3 10955.3 11080.1 11128.2 11135.4 11187.2 2187.4 2212.4 2217.4 2217.4 2238.1 2174.2 2197.0 2211.8 2212.5 2215.1 2150.1 2173.5 2182.6 2184.1 2186.1 1997.7 2001.4 2006.0 2006.2 2007.4 1894.9 1972.0 2112.6 2169.8 2200.5 10671.5 10790.7 10807.3 10813.7 10814.7 5599.6 5866.5 5873.8 5876.2 5881.9 3238.0 3361.2 3412.7 3425.4 3426.6 1042.4 1047.7 1066.3 1084.6 1103.9 15653.8 15888.3 15920.9 15948.1 16045.0 4644.2 4676.5 4775.6 4798.7 4813.4 11185.3 11281.9 11321.4 11375.0 11381.2 5474.9 5574.2 5582.9 5585.2 5605.3 5080.9 5166.4 5185.3 5190.2 5196.5 3814.4 3842.4 3877.2 3894.7 3900.9 1069.3 1078.6 1078.6 1089.5 1093.8 704.9 722.6 736.9 739.6 751.4 5565.1 5602.5 5698.3 5754.3 5818.1 511.8 538.7 540.4 541.8 543.4 3589.6 3712.5 3846.3 3896.9 4100.6 13073.8 13213.6 13297.8 13305.6 13629.9 12768.3 12963.5 13158.5 13274.3 13410.5 7547.2 7552.8 7663.1 7673.1 7693.8 5971.2 6062.5 6085.2 6108.7 6219.4 11815.2 12374.8 12498.5 12509.1 12671.7 11817.8 12171.8 12204.8 12234.2 12688.2 8841.9 9096.7 9103.7 9110.0 9125.8 9898.8 10151.1 10189.4 10199.8 10215.2 8372.4 8403.5 8547.1 8550.7 8578.9 8508.6 8520.2 8520.3 8526.2 8563.3 7342.0 7365.8 7395.5 7481.2 7489.3 5886.9 5951.8 6095.9 6116.8 6225.8 5378.1 5421.8 5464.5 5523.6 5588.1 13:30:57 INFO - PID 24046 | 13:30:57 INFO - PID 24046 | [#4] prototype.html Cycles:180 Average:4813.06 Median:5449.35 stddev:1408.54 (25.8%) stddev-sans-first:1372.03 13:30:57 INFO - PID 24046 | Values: 347.6 356.9 360.9 367.6 367.9 5457.4 5562.4 5577.2 5640.8 5650.1 5361.8 5435.5 5446.2 5452.5 5455.5 4122.9 4126.8 4134.2 4138.9 4141.0 3994.3 4117.1 4122.8 4128.2 4159.3 4084.4 4086.3 4090.7 4098.1 4098.8 4073.3 4075.2 4078.9 4082.4 4085.5 3566.7 3568.1 3577.7 3709.9 3818.6 5420.7 5436.4 5458.5 5469.0 5482.2 5053.5 5055.2 5060.2 5071.4 5082.8 5669.3 5840.8 5887.0 5901.5 5925.6 4385.7 4391.5 4401.9 4412.8 4414.9 5903.6 6061.6 6122.9 6203.5 6246.4 4188.3 4218.3 4221.5 4222.1 4238.1 4265.5 4282.7 4284.2 4286.0 4290.8 4781.6 4877.7 4902.2 4924.0 4942.7 5811.0 5833.8 5840.9 5869.3 5878.8 1549.6 1558.5 1567.2 1579.2 1581.4 1095.8 1096.4 1103.4 1108.5 1128.7 4954.8 4989.8 4992.2 4997.4 5012.9 5913.2 6007.7 6009.2 6015.9 6018.8 4834.7 4930.9 4945.9 4961.4 4967.9 3159.7 3166.4 3197.7 3207.9 3209.2 5385.6 5495.8 5542.3 5549.4 5555.8 6184.8 6186.1 6206.2 6243.9 6266.6 5543.8 5609.9 5618.9 5626.1 5630.7 5844.4 5968.2 6041.3 6043.8 6075.5 5752.7 5956.6 5982.4 5987.0 6004.7 5568.2 5572.6 5601.0 5612.2 5617.9 4053.0 4064.8 4079.7 4080.4 4086.7 5941.6 6072.5 6072.6 6078.9 6086.3 5850.6 5877.9 5889.9 5894.5 5896.6 5694.7 5813.8 5845.4 5845.8 5874.0 5718.9 5735.3 5741.1 5759.2 5777.1 5859.7 5867.4 5907.0 5921.3 5923.0 5605.2 5636.5 5651.0 5673.3 5699.4 13:30:57 INFO - PID 24046 | 13:30:57 INFO - PID 24046 | [#5] yui.html Cycles:180 Average:17095.30 Median:37167.54 stddev:23220.32 (62.5%) stddev-sans-first:23252.98 13:30:57 INFO - PID 24046 | Values: 739.4 746.4 756.2 759.7 766.8 12097.2 12160.3 12445.4 12563.9 12604.4 15146.2 15597.5 15615.8 15633.4 15660.5 865.3 900.9 904.1 904.2 905.3 912.0 919.5 919.7 920.3 920.5 951.2 952.6 957.7 962.1 963.8 945.4 956.9 964.8 965.9 968.5 674.9 682.6 688.7 689.8 689.8 15095.5 15222.2 15223.1 15290.0 15326.9 14624.7 15040.8 15067.5 15167.0 15205.8 12780.6 12819.9 12884.2 13101.8 13176.1 2931.3 2934.0 2944.6 2960.8 2961.3 80740.2 80883.6 81079.2 81172.6 81769.2 10795.6 10797.6 10935.2 10982.5 10999.8 17951.0 18032.2 18411.1 18438.3 18624.5 6226.7 6275.6 6324.1 6386.5 6390.9 2919.3 2977.1 2995.1 3000.7 3008.7 3538.8 3592.8 3618.7 3621.6 3623.3 672.6 683.3 769.3 818.1 818.9 600.9 609.6 611.1 611.8 636.7 9905.8 10572.8 10662.1 10795.6 11453.4 598.6 606.4 610.4 618.9 626.8 4487.7 4576.7 4578.3 4643.3 4654.3 87642.6 87794.6 88576.0 88806.6 90995.5 71759.3 75039.0 75208.0 75468.2 76519.6 65987.0 67281.0 67369.6 68467.0 70407.6 9460.9 9495.1 9513.0 9631.7 9934.1 28498.3 29497.3 29692.4 29774.9 30114.7 36058.3 37155.4 37179.6 37246.1 37597.6 12700.4 12828.9 13024.8 13081.7 13196.5 14085.6 14171.7 14271.5 14343.1 14435.4 13264.9 13483.0 13504.5 13585.1 13618.7 13533.5 13613.7 13619.6 13715.7 13731.7 13420.1 13423.5 13535.3 13723.4 13736.8 8864.1 8868.3 9082.4 9198.9 9368.7 10630.1 11070.2 11189.3 11257.1 11331.7 13:30:57 INFO - PID 24046 | -------- Summary: end -------- 13:30:57 INFO - PID 24046 | 13:30:57 INFO - TEST-INFO | 24046: exit 0 13:30:57 INFO - TEST-OK | dromaeo_css | took 1145339ms 13:30:57 INFO - TEST-START | kraken 13:30:57 INFO - operating with platform_type : linux_ 13:30:57 INFO - Initialising browser for kraken test... 13:30:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42119/getInfo.html -profile /tmp/tmp1nwS99/profile 13:30:57 INFO - TEST-INFO | started process 24449 (/builds/slave/test/build/application/firefox/firefox http://localhost:42119/getInfo.html) 13:31:32 INFO - TEST-INFO | 24449: killed by SIGTERM 13:31:33 INFO - Browser initialized. 13:31:33 INFO - Running cycle 1/1 for kraken test... 13:31:33 INFO - TEST-INFO | started process 24645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1nwS99/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:31:44 INFO - PID 24645 | RSS: Main: 168968192 13:31:44 INFO - PID 24645 | 13:31:47 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42119/tests/kraken/driver.html?testName=audio-beat-detection) 13:31:48 INFO - PID 24645 | RSS: Main: 174415872 13:31:48 INFO - PID 24645 | 13:31:51 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42119/tests/kraken/driver.html?testName=audio-dft) 13:31:51 INFO - PID 24645 | RSS: Main: 174059520 13:31:51 INFO - PID 24645 | 13:31:54 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42119/tests/kraken/driver.html?testName=audio-fft) 13:31:55 INFO - PID 24645 | RSS: Main: 170962944 13:31:55 INFO - PID 24645 | 13:31:57 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42119/tests/kraken/driver.html?testName=audio-oscillator) 13:31:58 INFO - PID 24645 | RSS: Main: 171204608 13:31:58 INFO - PID 24645 | 13:32:00 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42119/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:32:00 INFO - PID 24645 | RSS: Main: 171778048 13:32:00 INFO - PID 24645 | 13:32:03 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42119/tests/kraken/driver.html?testName=imaging-darkroom) 13:32:04 INFO - PID 24645 | RSS: Main: 172687360 13:32:04 INFO - PID 24645 | 13:32:08 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42119/tests/kraken/driver.html?testName=imaging-desaturate) 13:32:08 INFO - PID 24645 | RSS: Main: 171966464 13:32:08 INFO - PID 24645 | 13:32:11 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42119/tests/kraken/driver.html?testName=json-parse-financial) 13:32:12 INFO - PID 24645 | RSS: Main: 172429312 13:32:12 INFO - PID 24645 | 13:32:13 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42119/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:32:14 INFO - PID 24645 | RSS: Main: 172593152 13:32:14 INFO - PID 24645 | 13:32:16 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42119/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:32:16 INFO - PID 24645 | RSS: Main: 172425216 13:32:16 INFO - PID 24645 | 13:32:19 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42119/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:32:19 INFO - PID 24645 | RSS: Main: 172871680 13:32:19 INFO - PID 24645 | 13:32:22 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:32:23 INFO - PID 24645 | RSS: Main: 173428736 13:32:23 INFO - PID 24645 | 13:32:26 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:32:26 INFO - PID 24645 | RSS: Main: 173281280 13:32:26 INFO - PID 24645 | 13:32:28 INFO - PID 24645 | Cycle 1(1): loaded http://localhost:42119/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42119/tests/kraken/driver.html?testName=ai-astar) 13:32:29 INFO - PID 24645 | RSS: Main: 174784512 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | __start_tp_report 13:32:29 INFO - PID 24645 | _x_x_mozilla_page_load 13:32:29 INFO - PID 24645 | _x_x_mozilla_page_load_details 13:32:29 INFO - PID 24645 | |i|pagename|runs| 13:32:29 INFO - PID 24645 | |0;ai-astar;104;120;111;117;110;110;110;110;110;110 13:32:29 INFO - PID 24645 | |1;audio-beat-detection;153;126;129;165;126;124;125;126;148;125 13:32:29 INFO - PID 24645 | |2;audio-dft;165;165;163;164;169;169;171;166;164;164 13:32:29 INFO - PID 24645 | |3;audio-fft;74;75;75;110;75;77;74;76;99;76 13:32:29 INFO - PID 24645 | |4;audio-oscillator;84;82;105;84;86;83;95;83;83;102 13:32:29 INFO - PID 24645 | |5;imaging-gaussian-blur;114;114;115;115;113;114;113;114;114;114 13:32:29 INFO - PID 24645 | |6;imaging-darkroom;151;152;152;153;151;151;151;152;151;152 13:32:29 INFO - PID 24645 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;95;94 13:32:29 INFO - PID 24645 | |8;json-parse-financial;57;55;57;56;56;56;56;57;57;55 13:32:29 INFO - PID 24645 | |9;json-stringify-tinderbox;56;57;57;57;56;57;57;57;58;57 13:32:29 INFO - PID 24645 | |10;stanford-crypto-aes;86;88;85;88;95;86;87;95;130;87 13:32:29 INFO - PID 24645 | |11;stanford-crypto-ccm;143;142;135;134;137;133;131;135;142;130 13:32:29 INFO - PID 24645 | |12;stanford-crypto-pbkdf2;190;197;194;196;197;194;206;193;197;197 13:32:29 INFO - PID 24645 | |13;stanford-crypto-sha256-iterative;75;74;75;75;72;71;74;70;71;71 13:32:29 INFO - PID 24645 | __end_tp_report 13:32:29 INFO - PID 24645 | __start_cc_report 13:32:29 INFO - PID 24645 | _x_x_mozilla_cycle_collect,862 13:32:29 INFO - PID 24645 | __end_cc_report 13:32:29 INFO - PID 24645 | __startTimestamp1495830749032__endTimestamp 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | ------- Summary: start ------- 13:32:29 INFO - PID 24645 | Number of tests: 14 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#0] ai-astar Cycles:10 Average:111.20 Median:110.00 stddev:4.37 (4.0%) stddev-sans-first:3.77 13:32:29 INFO - PID 24645 | Values: 104.0 120.0 111.0 117.0 110.0 110.0 110.0 110.0 110.0 110.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:127.50 stddev:14.88 (11.7%) stddev-sans-first:14.23 13:32:29 INFO - PID 24645 | Values: 153.0 126.0 129.0 165.0 126.0 124.0 125.0 126.0 148.0 125.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.50 stddev:2.71 (1.6%) stddev-sans-first:2.85 13:32:29 INFO - PID 24645 | Values: 165.0 165.0 163.0 164.0 169.0 169.0 171.0 166.0 164.0 164.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.50 stddev:12.64 (16.7%) stddev-sans-first:13.14 13:32:29 INFO - PID 24645 | Values: 74.0 75.0 75.0 110.0 75.0 77.0 74.0 76.0 99.0 76.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#4] audio-oscillator Cycles:10 Average:88.70 Median:83.50 stddev:8.67 (10.4%) stddev-sans-first:9.02 13:32:29 INFO - PID 24645 | Values: 84.0 82.0 105.0 84.0 86.0 83.0 95.0 83.0 83.0 102.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 13:32:29 INFO - PID 24645 | Values: 114.0 114.0 115.0 115.0 113.0 114.0 113.0 114.0 114.0 114.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 13:32:29 INFO - PID 24645 | Values: 151.0 152.0 152.0 153.0 151.0 151.0 151.0 152.0 151.0 152.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:32:29 INFO - PID 24645 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:0.79 (1.4%) stddev-sans-first:0.78 13:32:29 INFO - PID 24645 | Values: 57.0 55.0 57.0 56.0 56.0 56.0 56.0 57.0 57.0 55.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 13:32:29 INFO - PID 24645 | Values: 56.0 57.0 57.0 57.0 56.0 57.0 57.0 57.0 58.0 57.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#10] stanford-crypto-aes Cycles:10 Average:92.70 Median:87.50 stddev:13.58 (15.5%) stddev-sans-first:14.19 13:32:29 INFO - PID 24645 | Values: 86.0 88.0 85.0 88.0 95.0 86.0 87.0 95.0 130.0 87.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:136.00 stddev:4.69 (3.4%) stddev-sans-first:4.28 13:32:29 INFO - PID 24645 | Values: 143.0 142.0 135.0 134.0 137.0 133.0 131.0 135.0 142.0 130.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.10 Median:197.00 stddev:4.18 (2.1%) stddev-sans-first:3.80 13:32:29 INFO - PID 24645 | Values: 190.0 197.0 194.0 196.0 197.0 194.0 206.0 193.0 197.0 197.0 13:32:29 INFO - PID 24645 | 13:32:29 INFO - PID 24645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:74.00 stddev:1.99 (2.7%) stddev-sans-first:1.94 13:32:29 INFO - PID 24645 | Values: 75.0 74.0 75.0 75.0 72.0 71.0 74.0 70.0 71.0 71.0 13:32:29 INFO - PID 24645 | -------- Summary: end -------- 13:32:29 INFO - PID 24645 | 13:32:30 INFO - TEST-INFO | 24645: exit 0 13:32:30 INFO - TEST-OK | kraken | took 92325ms 13:32:30 INFO - SUITE-END | took 1237s 13:32:30 INFO - Completed test suite (00:20:38) 13:32:30 INFO - javascript benchmark 13:32:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6772.722722877467, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2699.2577041313634, 2705.3912869604355, 2724.7411495907895, 2741.9040333588327, 2744.766694830939, 5202.3497062867145, 5220.0, 5233.424323324441, 5269.156934890419, 5283.841484755459, 5229.346331708536, 5243.816466423676, 5251.658642188255, 5328.227407025979, 5346.144616861303, 4392.209402307583, 4622.4684161321375, 4665.953340466586, 4672.345871577982, 4701.318308845215, 4720.008798152375, 4752.619790416776, 4780.995990841928, 4782.091402633506, 4813.37426134602, 4560.954390456086, 4618.630509559227, 4658.301254811771, 4680.976595117037, 4689.788959496831, 4705.106029854317, 4715.292706094079, 4719.9292010619865, 4763.190257656207, 4763.261694437368, 4652.534746525354, 4671.579557839811, 4684.133435314444, 4691.882702932454, 4711.481737008926, 5219.347581552306, 5279.260903473517, 5317.255584218174, 5317.787288508455, 5362.43694412085, 5596.104623260258, 5641.774329026875, 5680.744366503517, 5690.687012214326, 5698.51562617178, 5691.146328050784, 5702.714864256771, 5703.144528320785, 5704.515116215127, 5714.1428785682065, 5219.347581552306, 5293.206019097128, 5297.576193904479, 5299.099153143975, 5326.973365133227, 5762.4525670061275, 5770.42295770428, 5788.710564471759, 5854.882902341929, 5876.001079816441, 5634.971825140848, 5638.661680299195, 5639.943600563942, 5640.858978525488, 5694.9430505695245, 5696.971515142398, 5718.370979192286, 5720.11338242573, 5739.885202295931, 5740.196372507852, 5567.0, 5571.860703482445, 5653.830385088454, 5674.092145256739, 5678.858028549237, 5696.088625819849, 5705.71471426427, 5723.828285151452, 5740.13897915316, 5752.6836024019085, 4373.453318335208, 4379.474463064389, 4388.780560971939, 4391.3193455014525, 4422.137683151755, 3767.7550959187565, 3816.580176180618, 3828.655421012122, 3863.8068096595057, 3868.110334622996, 4738.8341408050555, 4762.976185119052, 4804.927926081112, 4804.927926081112, 4807.134715751198, 5617.719114044363, 5697.6296540724725, 5702.8289151325525, 5732.598718089694, 5759.308882934075, 4773.212419950669, 4783.569478746929, 4783.6651434399955, 4791.760411979387, 4816.927746083811, 4925.87685307863, 4934.18585933317, 4978.2034874419915, 4978.27814966835, 5009.974950125299, 5234.581233501234, 5249.763760630704, 5289.047971365191, 5298.867528311746, 5301.310829592128, 5592.3009623797025, 5607.523360514402, 5639.8590035249445, 5671.602987790815, 5713.400092990342, 5223.843284701313, 5225.294585230945, 5240.554552863049, 5256.474352564713, 5260.552853007384, 5465.754041068082, 5534.1145416733125, 5572.387037425799, 5577.44225577439, 5586.190002449541, 5629.634073785191, 5632.605717599892, 5694.829155125353, 5722.7710891563875, 5724.856878578069, 5478.643888147258, 5497.752601132878, 5501.807436739695, 5509.3664228614225, 5540.168974653673, 5497.945020549743, 5499.862503437446, 5519.3652729936575, 5522.30971128609, 5541.3904470507405, 5323.973380133075, 5394.838154855361, 5395.3525576931015, 5427.511523962862, 5436.3476382834315, 5602.2717046783655, 5623.0721930880945, 5639.379668236573, 5658.575606829587, 5666.773329066956, 5413.10683737179, 5417.674939503642, 5427.348718153847, 5436.048691478896, 5436.592255580927], "value": 5117.8548456301005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.5730561663003, 726.9890951635725, 1118.4351902289343, 1134.3420815926763, 1226.3439060102846, 32692.182695432595, 34111.65888341116, 34119.0, 34129.0, 34149.31701365971, 32038.199045023885, 32406.0, 32420.513692294633, 32429.67570324296, 32448.513272300876, 6533.31400202979, 6544.0, 6652.800415987528, 6654.600723956554, 6735.5621884577595, 6831.692573834164, 6874.450043996493, 6913.962905564181, 6917.930820691804, 6922.861542769142, 6890.586564806128, 6926.134233220848, 6932.896006559906, 6943.340382663664, 6951.061606683109, 6859.348361905611, 6875.724971001154, 6890.621015844126, 6901.240863505011, 6916.550424222434, 6726.865462690767, 6754.18949726036, 6754.5947243165565, 6778.457723382117, 6785.898211526831, 31670.524942125885, 31816.204594885083, 31827.522587161213, 31833.363332733217, 31872.840635796674, 3067.49386351254, 3105.4720697481257, 3119.625644922624, 3120.719135277813, 3133.7022982816598, 24474.0, 24559.263222103367, 24603.38491537708, 24612.0, 24695.0, 3102.720755132049, 3128.108489080601, 3139.2936589267233, 3148.574942382772, 3162.920926976844, 145090.0, 145957.0, 146092.26953865163, 146448.2677586616, 146503.80244296344, 39151.41272880909, 40752.796236019225, 40804.183916321505, 40954.795226024275, 41317.380239296435, 41681.4150443451, 41685.58314416878, 41785.79107104506, 41979.79010104991, 41998.1600367997, 12897.871021289668, 13058.0, 13085.607431777062, 13103.2138071716, 13110.278934658494, 9757.268204884662, 9857.950710246403, 9867.06262905023, 9912.306138570375, 10335.74160645975, 12822.0, 12903.096783225084, 12951.093423460456, 12977.35113244334, 13061.0, 5404.216388623628, 5432.278888961075, 5438.864028399243, 5501.339839219319, 5510.1459273812625, 870.5038128266827, 890.5057692980329, 909.2226146644524, 924.117467818232, 947.7298969793713, 21472.78527214739, 21484.355469335944, 21581.35255942324, 21716.674249886266, 21862.89068554647, 979.2215188924822, 1000.5497526113278, 1013.6198925402974, 1021.3871676993745, 1026.6817286641017, 11044.061254793432, 11139.164562657834, 11437.714057148638, 11453.484593193327, 11468.13988950832, 188647.0, 188809.0, 189648.0, 190300.0, 190381.0, 41594.1681166381, 41675.16649667051, 41934.580654193065, 42017.57982420137, 42060.0, 1235.9876401235872, 1248.1949142802841, 1254.3407975093044, 1260.1242136715077, 1265.6519457149357, 19739.0, 20712.275070372463, 21433.89699084444, 21482.355529334145, 21733.891330543247, 29829.10512684623, 29907.252318692208, 30112.0, 30129.397412052076, 30144.54783178298, 144171.0, 148313.0, 158697.0, 159562.2021889883, 160443.0, 31182.37635247237, 31278.0, 31621.683783161872, 31631.0, 31687.366252674357, 36835.07912302214, 37339.25321493609, 37360.43959340558, 37496.62503374931, 37830.62169378271, 28609.713902860705, 28690.426191476472, 29057.273568160967, 29096.05367087558, 29494.262643434085, 27627.86186069057, 28086.859565702856, 28547.857260714394, 29512.704872951854, 29584.852075739484, 31834.522482162323, 32081.839590801897, 32349.191270218435, 32441.188970275933, 32446.67553324531, 26487.205383838515, 26882.467282620655, 27570.724292756815, 27961.720382795913, 29019.0, 21037.474063147933, 22697.93373566212, 23076.769232308132, 23084.192053278053, 23098.53802923966], "value": 14744.047917088112, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.75916829486465, 407.37061240383605, 423.86648205815175, 427.59378590339185, 431.92009478246524, 17429.389971351004, 17883.28466861324, 18039.18823652937, 18069.728954065682, 18714.532136696555, 19379.32172373967, 19575.60848783027, 19610.117544710487, 19678.508037299038, 19855.702164467544, 5339.946600534003, 5414.512693857552, 5536.501714845663, 5624.775008999635, 5629.211910332557, 5381.48875856793, 5469.425710300421, 5479.917801232985, 5482.643628164176, 5486.561075113981, 5194.8441546753465, 5395.298611180541, 5441.401445840955, 5447.319085114361, 5460.945390546083, 5309.469053094698, 5341.545968592655, 5389.272448219479, 5397.757100930428, 5399.082156033444, 4759.405074365704, 4829.2997515360075, 4844.128056949748, 4850.514948505156, 4872.537108974641, 22157.335279941628, 22229.888850555806, 22325.665115023286, 22489.0, 22551.661725074136, 1614.5156453064035, 1629.136557624449, 1658.4444211189266, 1661.3852874436416, 1662.950111496657, 14529.418823247057, 14674.779878301728, 14708.043977141451, 15013.099214047192, 15046.398144074225, 2018.1322031526438, 2079.740032495938, 2098.0, 2127.6489379252403, 2153.1710291537715, 85245.0, 85529.57235213846, 87017.56491217567, 87154.56422717846, 87493.0, 10987.230893837355, 11078.390688512049, 11092.500837462172, 11245.718857028476, 11277.661670149744, 15401.46094886696, 15478.226088695521, 15499.845001550066, 15512.301946412439, 15518.129146108005, 7749.961250193825, 7871.212878712083, 7932.246436588515, 7992.960035199903, 8014.719484818003, 7263.673134708845, 7294.671739771723, 7300.269973002763, 7433.8141546461775, 7489.554804789857, 7037.507374483737, 7123.679434425463, 7136.0723105995885, 7157.642117894085, 7177.712891484282, 2002.9399118026483, 2024.7367842180422, 2039.2274292558943, 2046.6623007203646, 2054.3734161080715, 867.4274978514151, 898.2454738020094, 904.8235594059096, 905.7056456651615, 940.4075432477632, 16951.406700765416, 17113.828861711474, 17680.115994200238, 17883.642327153644, 18080.90959545194, 925.1303774451993, 925.2459245714721, 928.6842473559022, 934.6635211323918, 946.2477330522252, 9221.893372795173, 9689.41863488193, 9689.854652180224, 9779.559919803625, 9842.60629574809, 373566.0, 374251.0, 376066.0, 378269.0, 381991.0, 73667.63166184135, 74892.0, 75757.24242757612, 77434.61282693663, 77802.61098694471, 1048.8321868501155, 1066.6266806617778, 1101.6915263726169, 1108.146727020206, 1116.436199719153, 14289.142651440947, 14553.92723036378, 14608.342624581706, 14723.779143313073, 15294.464693735667, 37723.622763773106, 37921.24157516779, 37951.81024094862, 39194.608053919095, 39280.80359598184, 48464.27303590378, 49720.751396242784, 50082.0, 50969.74515127401, 51277.230841536664, 8085.676572937016, 8102.554359510284, 8150.918490815253, 8166.591670416574, 8289.544075075928, 11665.59170429065, 12241.816372754238, 12342.197757145757, 12352.505899763908, 12859.614211573667, 9688.9031109688, 10000.749981250527, 10400.687979360631, 10524.36853788775, 10532.420716860646, 8399.622017009127, 8471.0, 9260.259179265508, 9350.176715540405, 9378.109079637423, 10105.191584673355, 10345.068943794793, 10887.618933337295, 10946.233763636468, 11282.43587820622, 7813.687452501837, 7873.330766884879, 7984.84030319402, 8012.799680007814, 8184.713535026483, 10275.948620256851, 10480.68557943263, 10482.266241363337, 10633.946830266108, 10945.781084378108], "value": 8783.025711792014, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.783912815257, 1289.961301160965, 1299.2918859221722, 1304.1457845111456, 1318.4198952460918, 10403.115735162512, 10448.32085914415, 10696.0373566379, 10890.074343680786, 10917.344959302438, 10955.34267943924, 11080.05819505343, 11128.165387595942, 11135.443227838596, 11187.160962927772, 2187.3984654220058, 2212.391592312111, 2217.3791338425267, 2217.412385717786, 2238.138316748056, 2174.2281490071036, 2196.967045494319, 2211.7788221177834, 2212.54642798226, 2215.102883332253, 2150.0969592771075, 2173.521825198454, 2182.6071307164702, 2184.1154332495366, 2186.081845624841, 1997.690357994513, 2001.4195883193856, 2006.0, 2006.1674405121857, 2007.4278830533228, 1894.914728837192, 1971.9605607887906, 2112.5669237806214, 2169.80471757541, 2200.504886400563, 10671.466426678635, 10790.73023174419, 10807.297525660886, 10813.67558973232, 10814.72963175919, 5599.552035837164, 5866.501347385477, 5873.823785286449, 5876.236089308362, 5881.85295367615, 3237.967014473246, 3361.159710072482, 3412.692857642824, 3425.383430982422, 3426.5716785401823, 1042.3589492462156, 1047.701405099543, 1066.317556763672, 1084.5661735305941, 1103.9448027598587, 15653.765193522106, 15888.28502717392, 15920.920395398065, 15948.122853243067, 16045.0, 4644.187267228222, 4676.456769266134, 4775.617950563947, 4798.664093513421, 4813.350197723333, 11185.32888026721, 11281.887181128248, 11321.377324247082, 11375.0, 11381.203315767982, 5474.890502189934, 5574.247476590689, 5582.944170558324, 5585.245991791056, 5605.271314729059, 5080.898382032338, 5166.3800343958965, 5185.274061631375, 5190.247414125006, 5196.480351964773, 3814.370628846265, 3842.423636454554, 3877.2245550889934, 3894.6689531389584, 3900.8829735107993, 1069.2782371898936, 1078.5793540519203, 1078.5901357484106, 1089.4661615808197, 1093.792179485895, 704.8731228378839, 722.5772922840092, 736.9115706115193, 739.5525706947219, 751.3575892611848, 5565.1374037024325, 5602.523785478198, 5698.3162020556965, 5754.251947246831, 5818.0981947798155, 511.82853743995435, 538.6714104396315, 540.3731671261318, 541.7670401727295, 543.4293991309189, 3589.6230895756094, 3712.461693054546, 3846.3076646203394, 3896.883093507199, 4100.5899410058755, 13073.803892941614, 13213.603591892259, 13297.800532992012, 13305.600831975056, 13629.863701363058, 12768.297743624003, 12963.546275880299, 13158.539451119357, 13274.336283185996, 13410.463581456828, 7547.207543207994, 7552.763041666389, 7663.118741344817, 7673.079230492377, 7693.8459231115785, 5971.223740913653, 6062.514998800174, 6085.208922840003, 6108.725107370268, 6219.378062193744, 11815.232009919328, 12374.81437778416, 12498.500059997497, 12509.061820363328, 12671.746565068832, 11817.822732658846, 12171.81742273849, 12204.816927745913, 12234.204776689487, 12688.17526860751, 8841.911580884109, 9096.681616143404, 9103.681371151977, 9109.954450227971, 9125.817483650422, 9898.802023959624, 10151.137153342048, 10189.350768800314, 10199.847002294822, 10215.233857460571, 8372.41393102477, 8403.537805420761, 8547.145285471403, 8550.700725474579, 8578.91421085781, 8508.574571271289, 8520.233179013918, 8520.318374530147, 8526.232639062515, 8563.272121869712, 7342.045534080536, 7365.7790266292095, 7395.482316237812, 7481.214472480311, 7489.251074892685, 5886.882262354643, 5951.7619295227705, 6095.939040609537, 6116.785912493041, 6225.800687012413, 5378.139497680509, 5421.83734487966, 5464.535514481314, 5523.613347065667, 5588.050031494737], "value": 4769.72506068934, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.64019240086515, 356.91612471069294, 360.9476625889245, 367.5552581376534, 367.8859553538403, 5457.399686034533, 5562.443755624436, 5577.191307260445, 5640.774369025234, 5650.124230744236, 5361.812336568221, 5435.510804027636, 5446.2375267462585, 5452.454754524546, 5455.509004189622, 4122.855700050499, 4126.8142933567915, 4134.173165366924, 4138.937915931264, 4140.979295103521, 3994.3209654358684, 4117.094239267356, 4122.835086596532, 4128.153728485669, 4159.292920203573, 4084.387341898709, 4086.284900142478, 4090.6931980101613, 4098.139390727951, 4098.836046558149, 4073.2668119738437, 4075.1849630073957, 4078.87763367098, 4082.448869402622, 4085.4893138357706, 3566.6789988901123, 3568.125809176768, 3577.6941416382833, 3709.925801483982, 3818.618138186187, 5420.728963551846, 5436.374816896068, 5458.5087342139395, 5469.0, 5482.205080263339, 5053.519915608012, 5055.191169412877, 5060.240963855451, 5071.39143302806, 5082.822101226439, 5669.262995810518, 5840.824775256707, 5887.0286402743495, 5901.468867801876, 5925.555583331225, 4385.6710746694125, 4391.4730232372, 4401.933970990438, 4412.823487060514, 4414.889627759299, 5903.5572332074835, 6061.605995610271, 6122.908156377658, 6203.472704820096, 6246.3753624637175, 4188.28799104153, 4218.3002878158, 4221.451211342506, 4222.071144348239, 4238.109996900624, 4265.53079161292, 4282.678799090018, 4284.164587905391, 4286.0, 4290.764007979591, 4781.593564547053, 4877.6585639004925, 4902.191138462185, 4923.950760492421, 4942.654014218971, 5811.0, 5833.82498525045, 5840.912386314209, 5869.295684517885, 5878.764849405976, 1549.6435819761518, 1558.4779099001962, 1567.1537369820169, 1579.1709352589983, 1581.4227806850647, 1095.8356246562919, 1096.4188979840696, 1103.4207041303218, 1108.4790148630132, 1128.65575999321, 4954.826581069645, 4989.825356112518, 4992.151334273182, 4997.400311962515, 5012.872103776621, 5913.172155898178, 6007.729652165663, 6009.2188015557695, 6015.9171349156695, 6018.759249630053, 4834.734089625104, 4930.852074437773, 4945.851624451272, 4961.404631444249, 4967.90064198714, 3159.7314228290393, 3166.366726654632, 3197.6962188592047, 3207.9198020049685, 3209.1816586770224, 5385.623006389594, 5495.780168793203, 5542.334919809648, 5549.36293793332, 5555.777768889199, 6184.752609895554, 6186.133941248228, 6206.224221972254, 6243.906341404882, 6266.592671476339, 5543.833684989457, 5609.859753506195, 5618.943810561842, 5626.099824028218, 5630.74661640219, 5844.444777746107, 5968.16445697594, 6041.305249896318, 6043.761028988959, 6075.453209211192, 5752.654840709571, 5956.583039187215, 5982.4316689914385, 5986.982213023884, 6004.729787159676, 5568.248286481273, 5572.554195664256, 5601.0, 5612.214289999485, 5617.943820561742, 4053.0, 4064.837406503707, 4079.73481723687, 4080.428739976346, 4086.673066154641, 5941.6037231251485, 6072.453479186895, 6072.635641861502, 6078.878422431439, 6086.330503644507, 5850.64896106235, 5877.94122058774, 5889.882202355843, 5894.469497745224, 5896.557758168069, 5694.743736531783, 5813.76744930198, 5845.3570107289015, 5845.795397161079, 5874.001419758737, 5718.914216286676, 5735.254416925773, 5741.1388291756575, 5759.164921086335, 5777.104548794943, 5859.736311865891, 5867.354590994902, 5906.96628090074, 5921.259842519685, 5923.0, 5605.1872478491205, 5636.549076073822, 5650.9656523652275, 5673.262475878109, 5699.401562835843], "value": 4383.080687040962, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.4306384084252, 746.3618606091792, 756.2248695087535, 759.6695437484694, 766.7891329884279, 12097.213681110721, 12160.27038377698, 12445.439955202015, 12563.93718031411, 12604.432800523975, 15146.16696081715, 15597.454089106883, 15615.84384156158, 15633.374665013385, 15660.451884184056, 865.2645251536192, 900.8918929728442, 904.0868722590166, 904.1952662130709, 905.2938707807888, 911.9544022798833, 919.517253441945, 919.7424721078108, 920.3235621817959, 920.5121285718579, 951.172479942451, 952.5665822050985, 957.6887511558737, 962.0812124421196, 963.816874793787, 945.3618807305076, 956.8803899512561, 964.7539877331236, 965.8502932045474, 968.5205823117567, 674.8785218660639, 682.607500687107, 688.7189826921921, 689.7723751162105, 689.837888096302, 15095.47165849201, 15222.162781047038, 15223.086614803147, 15290.0, 15326.923365383213, 14624.70750584993, 15040.774388384183, 15067.547973560811, 15167.0, 15205.771913421308, 12780.552680656132, 12819.87180128196, 12884.162529435556, 13101.803472947913, 13176.143550669272, 2931.2818359501844, 2933.985330073336, 2944.5877577139217, 2960.8075475094265, 2961.2596850787304, 80740.19259807386, 80883.5955820223, 81079.18920810775, 81172.59413702953, 81769.18230817675, 10795.6221532246, 10797.622083227207, 10935.234533582732, 10982.505787239594, 10999.780004400027, 17951.0, 18032.188551515213, 18411.079446027645, 18438.26246950107, 18624.534386640444, 6226.6575338355915, 6275.560710750204, 6324.114623952651, 6386.489080873519, 6390.904136437957, 2919.2701824543865, 2977.077106097117, 2995.0864986179427, 3000.6849280825636, 3008.7292143707173, 3538.752287339913, 3592.7844329340323, 3618.7105031597407, 3621.6378362163573, 3623.2572322673786, 672.5829985409077, 683.3371629519457, 769.3460558525321, 818.145038434837, 818.8976377952756, 600.8708127752554, 609.5732986909181, 611.0711718188329, 611.8378629663143, 636.710296814948, 9905.80188396228, 10572.788544229072, 10662.147028237723, 10795.56817727282, 11453.370064646359, 598.5843480169368, 606.4299558415075, 610.3957082488394, 618.8576627375638, 626.7774939896362, 4487.6634252431195, 4576.725396476222, 4578.2903649934315, 4643.349931009661, 4654.325122857167, 87642.56178719066, 87794.56102719446, 88576.0, 88806.55596722104, 90995.5450222758, 71759.2824071763, 75039.0, 75208.0, 75468.24531754613, 76519.61740191263, 65987.0, 67281.0, 67369.59988801056, 68467.0, 70407.64796176089, 9460.905390946002, 9495.097965693249, 9513.048695130708, 9631.71104866855, 9934.056264654846, 28498.287542810765, 29497.26256843596, 29692.406151877272, 29774.851125744233, 30114.69885301119, 36058.27883442369, 37155.442668360534, 37179.62820371761, 37246.06884827901, 37597.62402375941, 12700.36498175106, 12828.871711282767, 13024.8046279304, 13081.672958176121, 13196.472141114247, 14085.647858803612, 14171.716565668423, 14271.500497482539, 14343.139411635335, 14435.35040923182, 13264.933675331948, 13483.0, 13504.45982160742, 13585.116967397087, 13618.659533511742, 13533.458661653423, 13613.727725445238, 13619.591412257649, 13715.657108572366, 13731.725365492834, 13420.060595758594, 13423.463061477432, 13535.255560944242, 13723.382447789674, 13736.793948090586, 8864.113588641085, 8868.290536756915, 9082.40964337316, 9198.908010919806, 9368.67209647659, 10630.096441802534, 11070.225084244348, 11189.272697274651, 11257.099432045581, 11331.660050198507], "value": 6965.088100206327, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 120.0, 111.0, 117.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 129.0, 165.0, 126.0, 124.0, 125.0, 126.0, 148.0, 125.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 163.0, 164.0, 169.0, 169.0, 171.0, 166.0, 164.0, 164.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 110.0, 75.0, 77.0, 74.0, 76.0, 99.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 105.0, 84.0, 86.0, 83.0, 95.0, 83.0, 83.0, 102.0], "value": 88.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 115.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 152.0, 153.0, 151.0, 151.0, 151.0, 152.0, 151.0, 152.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 57.0, 56.0, 56.0, 56.0, 56.0, 57.0, 57.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 56.0, 57.0, 57.0, 57.0, 58.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 85.0, 88.0, 95.0, 86.0, 87.0, 95.0, 130.0, 87.0], "value": 92.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 142.0, 135.0, 134.0, 137.0, 133.0, 131.0, 135.0, 142.0, 130.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 197.0, 194.0, 196.0, 197.0, 194.0, 206.0, 193.0, 197.0, 197.0], "value": 196.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 75.0, 72.0, 71.0, 74.0, 70.0, 71.0, 71.0], "value": 72.8, "unit": "score"}]}]} 13:32:30 INFO - Return code: 0 13:32:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:32:30 INFO - # TBPL SUCCESS # 13:32:30 INFO - Running post-action listener: _resource_record_post_action 13:32:30 INFO - [mozharness: 2017-05-26 20:32:30.849427Z] Finished run-tests step (success) 13:32:30 INFO - Running post-run listener: _resource_record_post_run 13:32:30 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402354176; Read time: 28; Write time: 211476 13:32:30 INFO - TinderboxPrint: CPU usage
12.6% 13:32:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 13:32:30 INFO - TinderboxPrint: I/O write bytes / time
402,354,176 / 211,476 13:32:30 INFO - TinderboxPrint: CPU idle
8,742.7 (87.3%) 13:32:30 INFO - TinderboxPrint: CPU user
1,213.1 (12.1%) 13:32:30 INFO - TinderboxPrint: Swap in / out
0 / 0 13:32:30 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 85213184; Read time: 0; Write time: 44316 13:32:30 INFO - run-tests - Wall time: 1239s; CPU: 13.0%; Read bytes: 4096; Write bytes: 302526464; Read time: 28; Write time: 164764 13:32:31 INFO - Running post-run listener: _upload_blobber_files 13:32:31 INFO - Blob upload gear active. 13:32:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:32:31 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 13:32:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:32:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:32:31 INFO - (blobuploader) - INFO - Open directory for files ... 13:32:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:32:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:32:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:33 INFO - (blobuploader) - INFO - Done attempting. 13:32:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:32:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:32:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:34 INFO - (blobuploader) - INFO - Done attempting. 13:32:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:32:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:32:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:35 INFO - (blobuploader) - INFO - Done attempting. 13:32:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:32:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:32:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:42 INFO - (blobuploader) - INFO - Done attempting. 13:32:42 INFO - (blobuploader) - INFO - Iteration through files over. 13:32:42 INFO - Return code: 0 13:32:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:32:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:32:42 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec9afd1478fe8e733201b01e57639e48274de15d2444c744d3cf5dc00aab2dd546b8faa223cb0c31bb4ffd12fad8e55ae0f588508ff53954b2fefd7bc09d20fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/512627ae3aa4230e62d74b0caa3ce23870e1f76b480135f0a3455b3179ed5bc90ada42350333c1f0a7ab51c50f23b721f2d0636454f049bd0052653f951141fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1934d4c1a95f47a9712f84f2960280d9cef8eb109d9567d77388ec3666a6e6d46ae60343d09b252ef72b431f070ecef8f43ca54b09e87dcd2f70cbc0c4f346e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b65f2a6532de8de32c4c8588ae1cd5d573f763a83f8558d5bae3bfe3e7f006c3d7d4caf163c05aa4aee57e9cebb0842e3d36d967ed6092ca8c18c42a8217b50"} 13:32:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:32:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:32:42 INFO - Contents: 13:32:42 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec9afd1478fe8e733201b01e57639e48274de15d2444c744d3cf5dc00aab2dd546b8faa223cb0c31bb4ffd12fad8e55ae0f588508ff53954b2fefd7bc09d20fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/512627ae3aa4230e62d74b0caa3ce23870e1f76b480135f0a3455b3179ed5bc90ada42350333c1f0a7ab51c50f23b721f2d0636454f049bd0052653f951141fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1934d4c1a95f47a9712f84f2960280d9cef8eb109d9567d77388ec3666a6e6d46ae60343d09b252ef72b431f070ecef8f43ca54b09e87dcd2f70cbc0c4f346e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b65f2a6532de8de32c4c8588ae1cd5d573f763a83f8558d5bae3bfe3e7f006c3d7d4caf163c05aa4aee57e9cebb0842e3d36d967ed6092ca8c18c42a8217b50"} 13:32:42 INFO - Running post-run listener: copy_logs_to_upload_dir 13:32:42 INFO - Copying logs to upload dir... 13:32:42 INFO - mkdir: /builds/slave/test/build/upload/logs 13:32:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1324.178863 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 4 secs) (at 2017-05-26 13:32:42.036515) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 13:32:42.040431) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec9afd1478fe8e733201b01e57639e48274de15d2444c744d3cf5dc00aab2dd546b8faa223cb0c31bb4ffd12fad8e55ae0f588508ff53954b2fefd7bc09d20fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/512627ae3aa4230e62d74b0caa3ce23870e1f76b480135f0a3455b3179ed5bc90ada42350333c1f0a7ab51c50f23b721f2d0636454f049bd0052653f951141fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1934d4c1a95f47a9712f84f2960280d9cef8eb109d9567d77388ec3666a6e6d46ae60343d09b252ef72b431f070ecef8f43ca54b09e87dcd2f70cbc0c4f346e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b65f2a6532de8de32c4c8588ae1cd5d573f763a83f8558d5bae3bfe3e7f006c3d7d4caf163c05aa4aee57e9cebb0842e3d36d967ed6092ca8c18c42a8217b50"} build_url:https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/SjG-k2WvSXijs6UXTnaBXA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ec9afd1478fe8e733201b01e57639e48274de15d2444c744d3cf5dc00aab2dd546b8faa223cb0c31bb4ffd12fad8e55ae0f588508ff53954b2fefd7bc09d20fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/512627ae3aa4230e62d74b0caa3ce23870e1f76b480135f0a3455b3179ed5bc90ada42350333c1f0a7ab51c50f23b721f2d0636454f049bd0052653f951141fe", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1934d4c1a95f47a9712f84f2960280d9cef8eb109d9567d77388ec3666a6e6d46ae60343d09b252ef72b431f070ecef8f43ca54b09e87dcd2f70cbc0c4f346e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5b65f2a6532de8de32c4c8588ae1cd5d573f763a83f8558d5bae3bfe3e7f006c3d7d4caf163c05aa4aee57e9cebb0842e3d36d967ed6092ca8c18c42a8217b50"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-26 13:32:42.078231) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:32:42.078519) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1495827634.982203-544578989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004454 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-26 13:32:42.161828) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 13:32:42.162147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-26 13:32:42.162432) ========= ========= Total master_lag: 0.17 =========