builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1496279306.99 results: success (0) revision: 7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:26.990109) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:26.990862) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:26.991126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:27.025560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:27.026116) ========= 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=62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-31 18:08:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 59.1K=0.2s 2017-05-31 18:08:27 (59.1 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.376510 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:27.419808) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:27.420078) ========= 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=62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023019 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:27.471573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-31 18:08:27.471858) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205 --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 7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205 --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=62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-31 18:08:27,970 truncating revision to first 12 chars 2017-05-31 18:08:27,970 Setting DEBUG logging. 2017-05-31 18:08:27,970 attempt 1/10 2017-05-31 18:08:27,971 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7fb3d9dfa8e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-31 18:08:29,107 unpacking tar archive at: mozilla-central-7fb3d9dfa8e6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.492285 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-31 18:08:28.977299) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:28.977626) ========= script_repo_revision: 7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:28.977987) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:28.978253) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-31 18:08:28.986742) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2017-05-31 18:08:28.987015) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:08:29 INFO - MultiFileLogger online at 20170531 18:08:29 in /builds/slave/test 18:08:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:08:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:08:29 INFO - {'append_to_log': False, 18:08:29 INFO - 'base_work_dir': '/builds/slave/test', 18:08:29 INFO - 'blob_upload_branch': 'Firefox', 18:08:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:08:29 INFO - 'branch': 'Firefox', 18:08:29 INFO - 'buildbot_json_path': 'buildprops.json', 18:08:29 INFO - 'config_files': ('talos/linux_config.py',), 18:08:29 INFO - 'default_actions': ('clobber', 18:08:29 INFO - 'read-buildbot-config', 18:08:29 INFO - 'download-and-extract', 18:08:29 INFO - 'populate-webroot', 18:08:29 INFO - 'create-virtualenv', 18:08:29 INFO - 'install', 18:08:29 INFO - 'setup-mitmproxy', 18:08:29 INFO - 'run-tests'), 18:08:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:08:29 INFO - 'download_minidump_stackwalk': True, 18:08:29 INFO - 'download_symbols': 'ondemand', 18:08:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:08:29 INFO - 'tooltool.py': '/tools/tooltool.py', 18:08:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:08:29 INFO - '/tools/misc-python/virtualenv.py')}, 18:08:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:08:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:08:29 INFO - 'gecko_profile': False, 18:08:29 INFO - 'gecko_profile_interval': 0, 18:08:29 INFO - 'installer_path': 'installer.exe', 18:08:29 INFO - 'log_level': 'info', 18:08:29 INFO - 'log_name': 'talos', 18:08:29 INFO - 'log_to_console': True, 18:08:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:08:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:08:29 INFO - 'opt_config_files': (), 18:08:29 INFO - 'pip_index': False, 18:08:29 INFO - 'suite': 'dromaeojs-e10s', 18:08:29 INFO - 'system_bits': '32', 18:08:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:08:29 INFO - 'title': 'talos-linux64-ix-018', 18:08:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:08:29 INFO - 'use_talos_json': True, 18:08:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:08:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:08:29 INFO - 'work_dir': 'build'} 18:08:29 INFO - [mozharness: 2017-06-01 01:08:29.583252Z] Running clobber step. 18:08:29 INFO - Running pre-action listener: _resource_record_pre_action 18:08:29 INFO - Running main action method: clobber 18:08:29 INFO - rmtree: /builds/slave/test/build 18:08:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:08:31 INFO - Running post-action listener: _resource_record_post_action 18:08:31 INFO - [mozharness: 2017-06-01 01:08:31.120160Z] Finished clobber step (success) 18:08:31 INFO - [mozharness: 2017-06-01 01:08:31.120260Z] Running read-buildbot-config step. 18:08:31 INFO - Running pre-action listener: _resource_record_pre_action 18:08:31 INFO - Running main action method: read_buildbot_config 18:08:31 INFO - Using buildbot properties: 18:08:31 INFO - { 18:08:31 INFO - "project": "", 18:08:31 INFO - "product": "firefox", 18:08:31 INFO - "who": "ryanvm@gmail.com", 18:08:31 INFO - "installer_path": "public/build/target.tar.bz2", 18:08:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:08:31 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:08:31 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:08:31 INFO - "stage_platform": "linux64-stylo", 18:08:31 INFO - "basedir": "/builds/slave/test", 18:08:31 INFO - "buildnumber": 126, 18:08:31 INFO - "platform": "ubuntu64_hw_stylo", 18:08:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:08:31 INFO - "slavebuilddir": "test", 18:08:31 INFO - "taskId": "aPDS9kXPSNKL3z83YoZ-cQ", 18:08:31 INFO - "branch": "mozilla-central", 18:08:31 INFO - "script_repo_revision": "production", 18:08:31 INFO - "revision": "7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205", 18:08:31 INFO - "slavename": "talos-linux64-ix-018", 18:08:31 INFO - "repo_path": "mozilla-central" 18:08:31 INFO - } 18:08:31 INFO - Finding installer, test and symbols from parent task. 18:08:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aPDS9kXPSNKL3z83YoZ-cQ'}, attempt #1 18:08:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aPDS9kXPSNKL3z83YoZ-cQ'}, attempt #1 18:08:32 INFO - Task dependencies: QIDwbIK6QUiOx0mk4t3s6A 18:08:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A'}, attempt #1 18:08:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2 18:08:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/test_packages.json 18:08:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.crashreporter-symbols.zip 18:08:32 INFO - Running post-action listener: _resource_record_post_action 18:08:32 INFO - [mozharness: 2017-06-01 01:08:32.485321Z] Finished read-buildbot-config step (success) 18:08:32 INFO - [mozharness: 2017-06-01 01:08:32.485646Z] Running download-and-extract step. 18:08:32 INFO - Running pre-action listener: _resource_record_pre_action 18:08:32 INFO - Running main action method: download_and_extract 18:08:32 INFO - mkdir: /builds/slave/test/build/tests 18:08:32 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')]} 18:08:32 INFO - trying https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.test_packages.json 18:08:32 INFO - Downloading https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:08:33 INFO - Downloaded 986 bytes. 18:08:33 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:08:33 INFO - Using the following test package requirements: 18:08:33 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:08:33 INFO - u'common': [u'target.common.tests.zip'], 18:08:33 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:08:33 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:08:33 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:08:33 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:08:33 INFO - u'mozbase': [u'target.common.tests.zip'], 18:08:33 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:08:33 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:08:33 INFO - u'web-platform': [u'target.common.tests.zip', 18:08:33 INFO - u'target.web-platform.tests.zip'], 18:08:33 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:08:33 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:08:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.common.tests.zip 18:08:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:08:33 INFO - Fetch https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.common.tests.zip into memory 18:08:36 INFO - Content-Length response header: 63527515 18:08:36 INFO - Bytes received: 63527515 18:08:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:08:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.common.tests.zip 18:08:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:08:47 INFO - Fetch https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.common.tests.zip into memory 18:08:50 INFO - Content-Length response header: 63527515 18:08:50 INFO - Bytes received: 63527515 18:09:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.talos.tests.zip 18:09:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:09:02 INFO - Fetch https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.talos.tests.zip into memory 18:09:03 INFO - Content-Length response header: 14447425 18:09:03 INFO - Bytes received: 14447425 18:09:04 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')]} 18:09:04 INFO - trying https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2 18:09:04 INFO - Downloading https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:09:09 INFO - Downloaded 56019989 bytes. 18:09:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2 18:09:09 INFO - mkdir: /builds/slave/test/properties 18:09:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:09:09 INFO - Writing to file /builds/slave/test/properties/build_url 18:09:09 INFO - Contents: 18:09:09 INFO - build_url:https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2 18:09:09 INFO - Running post-action listener: _resource_record_post_action 18:09:09 INFO - Running post-action listener: set_extra_try_arguments 18:09:09 INFO - [mozharness: 2017-06-01 01:09:09.115922Z] Finished download-and-extract step (success) 18:09:09 INFO - [mozharness: 2017-06-01 01:09:09.116149Z] Running populate-webroot step. 18:09:09 INFO - Running pre-action listener: _resource_record_pre_action 18:09:09 INFO - Running main action method: populate_webroot 18:09:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:09:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:09:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:09:09 INFO - '--tppagecycles', 18:09:09 INFO - '7'], 18:09:09 INFO - 'tests': ['tsvgm']}}, 18:09:09 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:09:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:09:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:09:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:09:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['damp', 'tps']}, 18:09:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'tests': ['damp', 'tps']}, 18:09:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['dromaeo_dom']}, 18:09:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:09:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:09:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:09:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:09:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['a11yr', 18:09:09 INFO - 'ts_paint', 18:09:09 INFO - 'tpaint', 18:09:09 INFO - 'sessionrestore', 18:09:09 INFO - 'sessionrestore_no_auto_restore', 18:09:09 INFO - 'tabpaint']}, 18:09:09 INFO - 'other-e10s': {'tests': ['a11yr', 18:09:09 INFO - 'ts_paint', 18:09:09 INFO - 'tpaint', 18:09:09 INFO - 'sessionrestore', 18:09:09 INFO - 'sessionrestore_no_auto_restore', 18:09:09 INFO - 'tabpaint']}, 18:09:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:09:09 INFO - 'ts_paint', 18:09:09 INFO - 'tpaint', 18:09:09 INFO - 'sessionrestore', 18:09:09 INFO - 'sessionrestore_no_auto_restore', 18:09:09 INFO - 'tabpaint']}, 18:09:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:09:09 INFO - 'ts_paint', 18:09:09 INFO - 'tpaint', 18:09:09 INFO - 'sessionrestore', 18:09:09 INFO - 'sessionrestore_no_auto_restore', 18:09:09 INFO - 'tabpaint']}, 18:09:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['a11yr', 18:09:09 INFO - 'ts_paint', 18:09:09 INFO - 'tpaint', 18:09:09 INFO - 'sessionrestore', 18:09:09 INFO - 'sessionrestore_no_auto_restore', 18:09:09 INFO - 'tabpaint']}, 18:09:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['a11yr', 18:09:09 INFO - 'ts_paint', 18:09:09 INFO - 'tpaint', 18:09:09 INFO - 'sessionrestore', 18:09:09 INFO - 'sessionrestore_no_auto_restore', 18:09:09 INFO - 'tabpaint']}, 18:09:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:09:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:09:09 INFO - 'bloom_basic_ref']}, 18:09:09 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 18:09:09 INFO - 'talos_options': ['--mitmproxy', 18:09:09 INFO - 'mitmproxy-recording-1.mp', 18:09:09 INFO - '--firstNonBlankPaint'], 18:09:09 INFO - 'tests': ['Quantum_1']}, 18:09:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['tsvgx', 18:09:09 INFO - 'tsvgr_opacity', 18:09:09 INFO - 'tart', 18:09:09 INFO - 'tscrollx', 18:09:09 INFO - 'cart', 18:09:09 INFO - 'tsvg_static']}, 18:09:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:09:09 INFO - 'tsvgr_opacity', 18:09:09 INFO - 'tart', 18:09:09 INFO - 'tscrollx', 18:09:09 INFO - 'cart', 18:09:09 INFO - 'tsvg_static']}, 18:09:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'talos_options': ['--disable-e10s'], 18:09:09 INFO - 'tests': ['tp5o']}, 18:09:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:09:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'talos_options': ['--disable-e10s', 18:09:09 INFO - '--xperf_path', 18:09:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:09 INFO - 'tests': ['tp5n']}, 18:09:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:09:09 INFO - 'talos_options': ['--xperf_path', 18:09:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:09:09 INFO - 'tests': ['tp5n']}}, 18:09:09 INFO - 'talos.zip': {'path': '', 18:09:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:09:09 INFO - Running post-action listener: _resource_record_post_action 18:09:09 INFO - [mozharness: 2017-06-01 01:09:09.133696Z] Finished populate-webroot step (success) 18:09:09 INFO - [mozharness: 2017-06-01 01:09:09.133790Z] Running create-virtualenv step. 18:09:09 INFO - Running pre-action listener: _resource_record_pre_action 18:09:09 INFO - Running main action method: create_virtualenv 18:09:09 INFO - Creating virtualenv /builds/slave/test/build/venv 18:09:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:09:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:09:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:09:09 INFO - Using real prefix '/usr' 18:09:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:09:09 INFO - Installing distribute.............................................................................................................................................................................................done. 18:09:11 INFO - Installing pip.................done. 18:09:11 INFO - Return code: 0 18:09:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:09:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:09:11 INFO - Reading from file tmpfile_stdout 18:09:11 INFO - Output received: 18:09:11 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) 18:09:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:11 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 0x15393b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b4840>, '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 0x18b5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b5bd0>, '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': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', '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 18:09:11 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 18:09:11 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 18:09:11 INFO - Using env: {'DISPLAY': ':0', 18:09:11 INFO - 'HOME': '/home/cltbld', 18:09:11 INFO - 'LANG': 'en_US.UTF-8', 18:09:11 INFO - 'LANGUAGE': 'en_US:en', 18:09:11 INFO - 'LOGNAME': 'cltbld', 18:09:11 INFO - 'MAIL': '/var/mail/cltbld', 18:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:11 INFO - 'MOZ_NO_REMOTE': '1', 18:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:11 INFO - 'NO_EM_RESTART': '1', 18:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:11 INFO - 'PWD': '/builds/slave/test', 18:09:11 INFO - 'SHELL': '/bin/bash', 18:09:11 INFO - 'SHLVL': '1', 18:09:11 INFO - 'TERM': 'linux', 18:09:11 INFO - 'TMOUT': '86400', 18:09:11 INFO - 'USER': 'cltbld', 18:09:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', 18:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:11 INFO - '_': '/tools/buildbot/bin/python'} 18:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:09:12 INFO - Cleaning up... 18:09:12 INFO - Return code: 0 18:09:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15393b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b4840>, '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 0x18b5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b5bd0>, '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': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', '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 18:09:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:09:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:09:12 INFO - Using env: {'DISPLAY': ':0', 18:09:12 INFO - 'HOME': '/home/cltbld', 18:09:12 INFO - 'LANG': 'en_US.UTF-8', 18:09:12 INFO - 'LANGUAGE': 'en_US:en', 18:09:12 INFO - 'LOGNAME': 'cltbld', 18:09:12 INFO - 'MAIL': '/var/mail/cltbld', 18:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:12 INFO - 'MOZ_NO_REMOTE': '1', 18:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:12 INFO - 'NO_EM_RESTART': '1', 18:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:12 INFO - 'PWD': '/builds/slave/test', 18:09:12 INFO - 'SHELL': '/bin/bash', 18:09:12 INFO - 'SHLVL': '1', 18:09:12 INFO - 'TERM': 'linux', 18:09:12 INFO - 'TMOUT': '86400', 18:09:12 INFO - 'USER': 'cltbld', 18:09:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', 18:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:12 INFO - '_': '/tools/buildbot/bin/python'} 18:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:12 INFO - Downloading/unpacking psutil>=3.1.1 18:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:09:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:09:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:09:13 INFO - Installing collected packages: psutil 18:09:13 INFO - Running setup.py install for psutil 18:09:13 INFO - building 'psutil._psutil_linux' extension 18:09:13 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 18:09:13 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 18:09:13 INFO - building 'psutil._psutil_posix' extension 18:09:13 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 18:09:13 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 18:09:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:09:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:09:14 INFO - Successfully installed psutil 18:09:14 INFO - Cleaning up... 18:09:14 INFO - Return code: 0 18:09:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15393b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b4840>, '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 0x18b5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b5bd0>, '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': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', '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 18:09:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:09:14 INFO - Using env: {'DISPLAY': ':0', 18:09:14 INFO - 'HOME': '/home/cltbld', 18:09:14 INFO - 'LANG': 'en_US.UTF-8', 18:09:14 INFO - 'LANGUAGE': 'en_US:en', 18:09:14 INFO - 'LOGNAME': 'cltbld', 18:09:14 INFO - 'MAIL': '/var/mail/cltbld', 18:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:14 INFO - 'MOZ_NO_REMOTE': '1', 18:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:14 INFO - 'NO_EM_RESTART': '1', 18:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:14 INFO - 'PWD': '/builds/slave/test', 18:09:14 INFO - 'SHELL': '/bin/bash', 18:09:14 INFO - 'SHLVL': '1', 18:09:14 INFO - 'TERM': 'linux', 18:09:14 INFO - 'TMOUT': '86400', 18:09:14 INFO - 'USER': 'cltbld', 18:09:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', 18:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:14 INFO - '_': '/tools/buildbot/bin/python'} 18:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:09:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:09:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:09:15 INFO - Installing collected packages: mozsystemmonitor 18:09:15 INFO - Running setup.py install for mozsystemmonitor 18:09:15 INFO - Successfully installed mozsystemmonitor 18:09:15 INFO - Cleaning up... 18:09:15 INFO - Return code: 0 18:09:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:09: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')]} 18:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09: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')]} 18:09:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:15 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 0x15393b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b4840>, '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 0x18b5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b5bd0>, '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': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', '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 18:09:15 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 18:09:15 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 18:09:15 INFO - Using env: {'DISPLAY': ':0', 18:09:15 INFO - 'HOME': '/home/cltbld', 18:09:15 INFO - 'LANG': 'en_US.UTF-8', 18:09:15 INFO - 'LANGUAGE': 'en_US:en', 18:09:15 INFO - 'LOGNAME': 'cltbld', 18:09:15 INFO - 'MAIL': '/var/mail/cltbld', 18:09:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:15 INFO - 'MOZ_NO_REMOTE': '1', 18:09:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:15 INFO - 'NO_EM_RESTART': '1', 18:09:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:15 INFO - 'PWD': '/builds/slave/test', 18:09:15 INFO - 'SHELL': '/bin/bash', 18:09:15 INFO - 'SHLVL': '1', 18:09:15 INFO - 'TERM': 'linux', 18:09:15 INFO - 'TMOUT': '86400', 18:09:15 INFO - 'USER': 'cltbld', 18:09:15 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', 18:09:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:15 INFO - '_': '/tools/buildbot/bin/python'} 18:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:15 INFO - Downloading/unpacking jsonschema==2.5.1 18:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:09:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:16 INFO - Downloading functools32-3.2.3-2.tar.gz 18:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:09:17 INFO - warning: no files found matching '*.txt' 18:09:17 INFO - no previously-included directories found matching 'build' 18:09:17 INFO - no previously-included directories found matching 'dist' 18:09:17 INFO - no previously-included directories found matching '.git*' 18:09:17 INFO - Installing collected packages: jsonschema, functools32 18:09:17 INFO - Running setup.py install for functools32 18:09:17 INFO - warning: no files found matching '*.txt' 18:09:17 INFO - no previously-included directories found matching 'build' 18:09:17 INFO - no previously-included directories found matching 'dist' 18:09:17 INFO - no previously-included directories found matching '.git*' 18:09:17 INFO - Successfully installed jsonschema functools32 18:09:17 INFO - Cleaning up... 18:09:17 INFO - Return code: 0 18:09:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15393b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b4840>, '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 0x18b5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b5bd0>, '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': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', '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 18:09:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:09:17 INFO - Using env: {'DISPLAY': ':0', 18:09:17 INFO - 'HOME': '/home/cltbld', 18:09:17 INFO - 'LANG': 'en_US.UTF-8', 18:09:17 INFO - 'LANGUAGE': 'en_US:en', 18:09:17 INFO - 'LOGNAME': 'cltbld', 18:09:17 INFO - 'MAIL': '/var/mail/cltbld', 18:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:17 INFO - 'MOZ_NO_REMOTE': '1', 18:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:17 INFO - 'NO_EM_RESTART': '1', 18:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:17 INFO - 'PWD': '/builds/slave/test', 18:09:17 INFO - 'SHELL': '/bin/bash', 18:09:17 INFO - 'SHLVL': '1', 18:09:17 INFO - 'TERM': 'linux', 18:09:17 INFO - 'TMOUT': '86400', 18:09:17 INFO - 'USER': 'cltbld', 18:09:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', 18:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:17 INFO - '_': '/tools/buildbot/bin/python'} 18:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:09:17 INFO - Cleaning up... 18:09:17 INFO - Return code: 0 18:09:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15393b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b4840>, '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 0x18b5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b5bd0>, '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': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', '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 18:09:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:09:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:09:17 INFO - Using env: {'DISPLAY': ':0', 18:09:17 INFO - 'HOME': '/home/cltbld', 18:09:17 INFO - 'LANG': 'en_US.UTF-8', 18:09:17 INFO - 'LANGUAGE': 'en_US:en', 18:09:17 INFO - 'LOGNAME': 'cltbld', 18:09:17 INFO - 'MAIL': '/var/mail/cltbld', 18:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:17 INFO - 'MOZ_NO_REMOTE': '1', 18:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:17 INFO - 'NO_EM_RESTART': '1', 18:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:17 INFO - 'PWD': '/builds/slave/test', 18:09:17 INFO - 'SHELL': '/bin/bash', 18:09:17 INFO - 'SHLVL': '1', 18:09:17 INFO - 'TERM': 'linux', 18:09:17 INFO - 'TMOUT': '86400', 18:09:17 INFO - 'USER': 'cltbld', 18:09:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', 18:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:17 INFO - '_': '/tools/buildbot/bin/python'} 18:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:17 INFO - Downloading/unpacking blobuploader==1.2.4 18:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:18 INFO - Downloading blobuploader-1.2.4.tar.gz 18:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:09:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:09:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:09:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:09:19 INFO - Downloading docopt-0.6.1.tar.gz 18:09:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:09:19 INFO - Installing collected packages: blobuploader, requests, docopt 18:09:19 INFO - Running setup.py install for blobuploader 18:09:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:09:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:09:19 INFO - Running setup.py install for requests 18:09:19 INFO - Running setup.py install for docopt 18:09:19 INFO - Successfully installed blobuploader requests docopt 18:09:19 INFO - Cleaning up... 18:09:19 INFO - Return code: 0 18:09:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:19 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 0x15393b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b4840>, '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 0x18b5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b5bd0>, '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': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', '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 18:09:19 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 18:09:19 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 18:09:19 INFO - Using env: {'DISPLAY': ':0', 18:09:19 INFO - 'HOME': '/home/cltbld', 18:09:19 INFO - 'LANG': 'en_US.UTF-8', 18:09:19 INFO - 'LANGUAGE': 'en_US:en', 18:09:19 INFO - 'LOGNAME': 'cltbld', 18:09:19 INFO - 'MAIL': '/var/mail/cltbld', 18:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:19 INFO - 'MOZ_NO_REMOTE': '1', 18:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:19 INFO - 'NO_EM_RESTART': '1', 18:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:19 INFO - 'PWD': '/builds/slave/test', 18:09:19 INFO - 'SHELL': '/bin/bash', 18:09:19 INFO - 'SHLVL': '1', 18:09:19 INFO - 'TERM': 'linux', 18:09:19 INFO - 'TMOUT': '86400', 18:09:19 INFO - 'USER': 'cltbld', 18:09:19 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', 18:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:19 INFO - '_': '/tools/buildbot/bin/python'} 18:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:09:20 INFO - Running setup.py (path:/tmp/pip-KEPkso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:09:20 INFO - Running setup.py (path:/tmp/pip-6A1AI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:09:20 INFO - Running setup.py (path:/tmp/pip-_zKx1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:09:20 INFO - Running setup.py (path:/tmp/pip-nyVDMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:09:20 INFO - Running setup.py (path:/tmp/pip-YV3X2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:09:20 INFO - Running setup.py (path:/tmp/pip-2k04j3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:09:20 INFO - Running setup.py (path:/tmp/pip-hZvTYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:09:20 INFO - Running setup.py (path:/tmp/pip-Kd2tEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:09:20 INFO - Running setup.py (path:/tmp/pip-83TNjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:09:20 INFO - Running setup.py (path:/tmp/pip-zpa5W4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:09:20 INFO - Running setup.py (path:/tmp/pip-Qt9NtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:09:20 INFO - Running setup.py (path:/tmp/pip-77D7y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:09:20 INFO - Running setup.py (path:/tmp/pip-Yon4Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:09:21 INFO - Running setup.py (path:/tmp/pip-h33R87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:21 INFO - Running setup.py (path:/tmp/pip-m4uP9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:09:21 INFO - Running setup.py (path:/tmp/pip-NNlXwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:09:21 INFO - Running setup.py (path:/tmp/pip-UZp1Km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:09:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:09:21 INFO - Running setup.py install for manifestparser 18:09:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:09:21 INFO - Running setup.py install for mozcrash 18:09:21 INFO - Running setup.py install for mozdebug 18:09:21 INFO - Running setup.py install for mozdevice 18:09:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:09:21 INFO - Running setup.py install for mozfile 18:09:21 INFO - Running setup.py install for mozhttpd 18:09:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:09:21 INFO - Running setup.py install for mozinfo 18:09:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Running setup.py install for mozInstall 18:09:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Running setup.py install for mozleak 18:09:22 INFO - Running setup.py install for mozlog 18:09:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Running setup.py install for moznetwork 18:09:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Running setup.py install for mozprocess 18:09:22 INFO - Running setup.py install for mozprofile 18:09:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Running setup.py install for mozrunner 18:09:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:09:22 INFO - Running setup.py install for mozscreenshot 18:09:22 INFO - Running setup.py install for moztest 18:09:23 INFO - Running setup.py install for mozversion 18:09:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:09:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:09:23 INFO - Cleaning up... 18:09:23 INFO - Return code: 0 18:09:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09: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')]} 18:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09: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')]} 18:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15393b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b4840>, '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 0x18b5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b5bd0>, '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': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', '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 18:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:09:23 INFO - Using env: {'DISPLAY': ':0', 18:09:23 INFO - 'HOME': '/home/cltbld', 18:09:23 INFO - 'LANG': 'en_US.UTF-8', 18:09:23 INFO - 'LANGUAGE': 'en_US:en', 18:09:23 INFO - 'LOGNAME': 'cltbld', 18:09:23 INFO - 'MAIL': '/var/mail/cltbld', 18:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:23 INFO - 'MOZ_NO_REMOTE': '1', 18:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:23 INFO - 'NO_EM_RESTART': '1', 18:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:23 INFO - 'PWD': '/builds/slave/test', 18:09:23 INFO - 'SHELL': '/bin/bash', 18:09:23 INFO - 'SHLVL': '1', 18:09:23 INFO - 'TERM': 'linux', 18:09:23 INFO - 'TMOUT': '86400', 18:09:23 INFO - 'USER': 'cltbld', 18:09:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', 18:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:23 INFO - '_': '/tools/buildbot/bin/python'} 18:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:09:23 INFO - Running setup.py (path:/tmp/pip-18wmKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:09:23 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)) 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:09:23 INFO - Running setup.py (path:/tmp/pip-HCRYED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:09:23 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)) 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:09:23 INFO - Running setup.py (path:/tmp/pip-x3UkQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:09:23 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)) 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:09:23 INFO - Running setup.py (path:/tmp/pip-q73keI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:09:23 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)) 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:09:23 INFO - Running setup.py (path:/tmp/pip-cWyStL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:09:23 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)) 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:09:23 INFO - Running setup.py (path:/tmp/pip-1WuDIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:09:23 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)) 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:09:23 INFO - Running setup.py (path:/tmp/pip-rKuFm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:09:23 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)) 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:09:23 INFO - Running setup.py (path:/tmp/pip-TdwUDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:09:23 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)) 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:09:23 INFO - Running setup.py (path:/tmp/pip-IJ7mzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:09:23 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)) 18:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:09:24 INFO - Running setup.py (path:/tmp/pip-34r8XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:09:24 INFO - Running setup.py (path:/tmp/pip-7cWV5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:09:24 INFO - Running setup.py (path:/tmp/pip-_dOZ3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:09:24 INFO - Running setup.py (path:/tmp/pip-uLdGZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:09:24 INFO - Running setup.py (path:/tmp/pip-TqiHDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:09:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:24 INFO - Running setup.py (path:/tmp/pip-gmYO6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:09:24 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)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:09:24 INFO - Running setup.py (path:/tmp/pip-MoR0sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:09:24 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)) 18:09:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:09:24 INFO - Running setup.py (path:/tmp/pip-yFuqHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:09:24 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)) 18:09:24 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)) 18:09:24 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)) 18:09:24 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)) 18:09:24 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)) 18:09:24 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)) 18:09:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:09: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 18:09: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 18:09: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 18:09: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 18:09:25 INFO - Downloading blessings-1.6.tar.gz 18:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:09:25 INFO - Installing collected packages: blessings 18:09:25 INFO - Running setup.py install for blessings 18:09:25 INFO - Successfully installed blessings 18:09:25 INFO - Cleaning up... 18:09:25 INFO - Return code: 0 18:09:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:09:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:09:26 INFO - Reading from file tmpfile_stdout 18:09:26 INFO - Current package versions: 18:09:26 INFO - argparse == 1.2.1 18:09:26 INFO - blessings == 1.6 18:09:26 INFO - blobuploader == 1.2.4 18:09:26 INFO - docopt == 0.6.1 18:09:26 INFO - functools32 == 3.2.3-2 18:09:26 INFO - jsonschema == 2.5.1 18:09:26 INFO - manifestparser == 1.1 18:09:26 INFO - mozInstall == 1.12 18:09:26 INFO - mozcrash == 1.0 18:09:26 INFO - mozdebug == 0.1 18:09:26 INFO - mozdevice == 0.51 18:09:26 INFO - mozfile == 1.2 18:09:26 INFO - mozhttpd == 0.7 18:09:26 INFO - mozinfo == 0.9 18:09:26 INFO - mozleak == 0.1 18:09:26 INFO - mozlog == 3.4 18:09:26 INFO - moznetwork == 0.27 18:09:26 INFO - mozprocess == 0.25 18:09:26 INFO - mozprofile == 0.28 18:09:26 INFO - mozrunner == 6.13 18:09:26 INFO - mozscreenshot == 0.1 18:09:26 INFO - mozsystemmonitor == 0.3 18:09:26 INFO - moztest == 0.8 18:09:26 INFO - mozversion == 1.4 18:09:26 INFO - psutil == 3.1.1 18:09:26 INFO - requests == 1.2.3 18:09:26 INFO - wsgiref == 0.1.2 18:09:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15393b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b4840>, '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 0x18b5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b5bd0>, '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': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', '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 18:09:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:09:26 INFO - Using env: {'DISPLAY': ':0', 18:09:26 INFO - 'HOME': '/home/cltbld', 18:09:26 INFO - 'LANG': 'en_US.UTF-8', 18:09:26 INFO - 'LANGUAGE': 'en_US:en', 18:09:26 INFO - 'LOGNAME': 'cltbld', 18:09:26 INFO - 'MAIL': '/var/mail/cltbld', 18:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:26 INFO - 'MOZ_NO_REMOTE': '1', 18:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:26 INFO - 'NO_EM_RESTART': '1', 18:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:26 INFO - 'PWD': '/builds/slave/test', 18:09:26 INFO - 'SHELL': '/bin/bash', 18:09:26 INFO - 'SHLVL': '1', 18:09:26 INFO - 'TERM': 'linux', 18:09:26 INFO - 'TMOUT': '86400', 18:09:26 INFO - 'USER': 'cltbld', 18:09:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', 18:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:26 INFO - '_': '/tools/buildbot/bin/python'} 18:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:09:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:09:26 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:09: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 18:09: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 18:09: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 18:09: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 18:09:27 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:09:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:09:27 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)) 18:09:27 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)) 18:09:27 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)) 18:09:27 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)) 18:09:27 INFO - Installing collected packages: marionette-driver 18:09:27 INFO - Running setup.py install for marionette-driver 18:09:27 INFO - Successfully installed marionette-driver 18:09:27 INFO - Cleaning up... 18:09:27 INFO - Return code: 0 18:09:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:09:27 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')]} 18:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:09:27 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')]} 18:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:09:27 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 0x15393b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1713a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b4840>, '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 0x18b5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b5bd0>, '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': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', '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 18:09:27 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 18:09:27 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 18:09:27 INFO - Using env: {'DISPLAY': ':0', 18:09:27 INFO - 'HOME': '/home/cltbld', 18:09:27 INFO - 'LANG': 'en_US.UTF-8', 18:09:27 INFO - 'LANGUAGE': 'en_US:en', 18:09:27 INFO - 'LOGNAME': 'cltbld', 18:09:27 INFO - 'MAIL': '/var/mail/cltbld', 18:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:27 INFO - 'MOZ_NO_REMOTE': '1', 18:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:27 INFO - 'NO_EM_RESTART': '1', 18:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:27 INFO - 'PWD': '/builds/slave/test', 18:09:27 INFO - 'SHELL': '/bin/bash', 18:09:27 INFO - 'SHLVL': '1', 18:09:27 INFO - 'TERM': 'linux', 18:09:27 INFO - 'TMOUT': '86400', 18:09:27 INFO - 'USER': 'cltbld', 18:09:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', 18:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:27 INFO - '_': '/tools/buildbot/bin/python'} 18:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:09:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:09:27 INFO - Cleaning up... 18:09:27 INFO - Return code: 0 18:09:27 INFO - Running post-action listener: _resource_record_post_action 18:09:27 INFO - Running post-action listener: _start_resource_monitoring 18:09:27 INFO - Starting resource monitoring. 18:09:27 INFO - [mozharness: 2017-06-01 01:09:27.915673Z] Finished create-virtualenv step (success) 18:09:27 INFO - [mozharness: 2017-06-01 01:09:27.916154Z] Running install step. 18:09:27 INFO - Running pre-action listener: _resource_record_pre_action 18:09:27 INFO - Running main action method: install 18:09:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:09:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:09:28 INFO - Reading from file tmpfile_stdout 18:09:28 INFO - Detecting whether we're running mozinstall >=1.0... 18:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:09:28 INFO - Reading from file tmpfile_stdout 18:09:28 INFO - Output received: 18:09:28 INFO - Usage: mozinstall [options] installer 18:09:28 INFO - Options: 18:09:28 INFO - -h, --help show this help message and exit 18:09:28 INFO - -d DEST, --destination=DEST 18:09:28 INFO - Directory to install application into. [default: 18:09:28 INFO - "/builds/slave/test"] 18:09:28 INFO - --app=APP Application being installed. [default: firefox] 18:09:28 INFO - mkdir: /builds/slave/test/build/application 18:09:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:09:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:09:44 INFO - Reading from file tmpfile_stdout 18:09:44 INFO - Output received: 18:09:44 INFO - /builds/slave/test/build/application/firefox/firefox 18:09:44 INFO - Running post-action listener: _resource_record_post_action 18:09:44 INFO - [mozharness: 2017-06-01 01:09:44.294066Z] Finished install step (success) 18:09:44 INFO - [mozharness: 2017-06-01 01:09:44.294347Z] Running setup-mitmproxy step. 18:09:44 INFO - Running pre-action listener: _resource_record_pre_action 18:09:44 INFO - Running main action method: setup_mitmproxy 18:09:44 INFO - Skipping: mitmproxy is not required 18:09:44 INFO - Running post-action listener: _resource_record_post_action 18:09:44 INFO - [mozharness: 2017-06-01 01:09:44.295486Z] Finished setup-mitmproxy step (success) 18:09:44 INFO - [mozharness: 2017-06-01 01:09:44.295707Z] Running run-tests step. 18:09:44 INFO - Running pre-action listener: _resource_record_pre_action 18:09:44 INFO - Running main action method: run_tests 18:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:09:44 INFO - Python 2.7.3 18:09:44 INFO - Return code: 0 18:09:44 INFO - grabbing minidump binary from tooltool 18:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:09:44 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b4840>, '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 0x18b5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b5bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:09:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:09:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:09:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:09:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:09:44 INFO - Return code: 0 18:09:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:09:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:09:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:09:44 INFO - ENV: RUST_BACKTRACE is now 1 18:09:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:09:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:09:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 18:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 18:09:44 INFO - Using env: {'DISPLAY': ':0', 18:09:44 INFO - 'HOME': '/home/cltbld', 18:09:44 INFO - 'LANG': 'en_US.UTF-8', 18:09:44 INFO - 'LANGUAGE': 'en_US:en', 18:09:44 INFO - 'LOGNAME': 'cltbld', 18:09:44 INFO - 'MAIL': '/var/mail/cltbld', 18:09:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:09:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:09:44 INFO - 'MOZ_NO_REMOTE': '1', 18:09:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:09:44 INFO - 'NO_EM_RESTART': '1', 18:09:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:09:44 INFO - 'PWD': '/builds/slave/test', 18:09:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:09:44 INFO - 'RUST_BACKTRACE': '1', 18:09:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:09:44 INFO - 'SHELL': '/bin/bash', 18:09:44 INFO - 'SHLVL': '1', 18:09:44 INFO - 'TERM': 'linux', 18:09:44 INFO - 'TMOUT': '86400', 18:09:44 INFO - 'USER': 'cltbld', 18:09:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389', 18:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:09:44 INFO - '_': '/tools/buildbot/bin/python'} 18:09:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 18:09:44 INFO - mozversion application_buildid: 20170601002546 18:09:44 INFO - mozversion application_changeset: 7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205 18:09:44 INFO - mozversion application_display_name: Nightly 18:09:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:09:44 INFO - mozversion application_name: Firefox 18:09:44 INFO - mozversion application_remotingname: firefox 18:09:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:09:44 INFO - mozversion application_vendor: Mozilla 18:09:44 INFO - mozversion application_version: 55.0a1 18:09:44 INFO - mozversion platform_buildid: 20170601002546 18:09:44 INFO - mozversion platform_changeset: 7fb3d9dfa8e684d5258a3d96b7176a1fa95fe205 18:09:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:09:44 INFO - mozversion platform_version: 55.0a1 18:09:44 INFO - using testdate: 1496279384 18:09:44 INFO - actual date: 1496279384 18:09:44 INFO - starting webserver on 'localhost:56159' 18:09:44 INFO - SUITE-START | Running 2 tests 18:09:44 INFO - TEST-START | dromaeo_css 18:09:44 INFO - operating with platform_type : linux_ 18:09:44 INFO - Initialising browser for dromaeo_css test... 18:09:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56159/getInfo.html -profile /tmp/tmpnSkVrF/profile 18:09:44 INFO - TEST-INFO | started process 30028 (/builds/slave/test/build/application/firefox/firefox http://localhost:56159/getInfo.html) 18:10:19 INFO - TEST-INFO | 30028: killed by SIGTERM 18:10:19 INFO - Browser initialized. 18:10:19 INFO - Running cycle 1/1 for dromaeo_css test... 18:10:19 INFO - TEST-INFO | started process 30254 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnSkVrF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:10:31 INFO - PID 30254 | RSS: Main: 188919808 18:10:31 INFO - PID 30254 | 18:13:36 INFO - PID 30254 | Cycle 1(1): loaded http://localhost:56159/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56159/tests/dromaeo/cssquery-ext.html) 18:13:37 INFO - PID 30254 | RSS: Main: 182489088 18:13:37 INFO - PID 30254 | 18:16:39 INFO - PID 30254 | Cycle 1(1): loaded http://localhost:56159/tests/dromaeo/cssquery-ext.html (next: http://localhost:56159/tests/dromaeo/cssquery-jquery.html) 18:16:40 INFO - PID 30254 | RSS: Main: 187813888 18:16:40 INFO - PID 30254 | 18:19:42 INFO - PID 30254 | Cycle 1(1): loaded http://localhost:56159/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56159/tests/dromaeo/cssquery-mootools.html) 18:19:42 INFO - PID 30254 | RSS: Main: 185237504 18:19:42 INFO - PID 30254 | 18:22:44 INFO - PID 30254 | Cycle 1(1): loaded http://localhost:56159/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56159/tests/dromaeo/cssquery-prototype.html) 18:22:45 INFO - PID 30254 | RSS: Main: 188760064 18:22:45 INFO - PID 30254 | 18:25:48 INFO - PID 30254 | Cycle 1(1): loaded http://localhost:56159/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56159/tests/dromaeo/cssquery-yui.html) 18:25:48 INFO - PID 30254 | RSS: Main: 189554688 18:25:48 INFO - PID 30254 | 18:28:50 INFO - PID 30254 | Cycle 1(1): loaded http://localhost:56159/tests/dromaeo/cssquery-yui.html (next: http://localhost:56159/tests/dromaeo/cssquery-dojo.html) 18:28:51 INFO - PID 30254 | RSS: Main: 185847808 18:28:51 INFO - PID 30254 | 18:28:51 INFO - PID 30254 | __start_tp_report 18:28:51 INFO - PID 30254 | _x_x_mozilla_page_load 18:28:51 INFO - PID 30254 | _x_x_mozilla_page_load_details 18:28:51 INFO - PID 30254 | |i|pagename|runs| 18:28:51 INFO - PID 30254 | |0;dojo.html;2722.469118521889;2729.2358139720873;2730.140005898142;2766.4605401946624;2768.5293500104995;5231.24146998685;5284.947150528498;5291.7883284668615;5316.946830531693;5344.893102137959;5218.608604354669;5239.973800131003;5304.177852432879;5366.382865970415;5396.244525766386;4693.694909830867;4696.906061878761;4719.362886010387;4728.219843725781;4761.190597598416;4674.275487299474;4765.714057156564;4767.5709186173235;4782.736949467778;4802.447718512381;4649.093426781779;4681.74250416227;4709.952900470986;4712.104700106968;4754.857354279377;4673.556012178838;4747.026859493795;4752.786124624366;4780.091782561337;4802.663813533054;4698.459677137139;4701.130290896195;4707.082118986765;4726.574608285271;4751.239801631722;5188.273641690166;5251.52736253739;5265.131253343194;5296.364436267672;5338.839834804962;5633.521150702195;5636.577256705723;5644.153376993443;5762.394948530386;5771.8557036074435;5740.339860916007;5761.222234998306;5764.452377024176;5778.711064446803;5836.6789826559525;5350.839474815762;5352.090144675414;5362.43694412085;5365.356157261075;5374.6506477078865;5714.828555143269;5768.2501274834;5793;5892.027815410409;5917.230760001258;5659.151127330933;5677.318721753416;5684.715764211773;5699.74351154199;5713.971430142823;5620.803271885547;5688.857778555486;5721.8569535761935;5729.455701708331;5743.770249189985;5615.185798059259;5687.061634830289;5724.885502290014;5725.942740572541;5726.77092916287;5631.267935168484;5654.46282603152;5690.146478028246;5702.030654788696;5710.2862142232225;4759.286107083896;4775.570198682135;4780.450248221429;4782.665213435026;4805.711657300573;4093;4095.28332541804;4096;4102.897427564335;4148.294789885666;4673.322368256651;4730.385049943486;4735.905281894343;4800.279958006327;4804.42346918372;5720.427957204246;5724.942750572524;5749.9712501437225;5754.74103665336;5780.768769249183;4778.856634300907;4781.019890922353;4784.832530861473;4788.712677239377;4828.903421931612;4943.703377797344;4998.400191976986;5034.270030845581;5071.923921141186;5078.822241221539;5256;5280.04959107349;5289.5503882168905;5349.545288650508;5362.490563396471;5619.381867994599;5733.111367738007;5740.885182296414;5772.076467765138;5814.563907707024;5246.554042906396;5267.446918073547;5318.308619879391;5327.680339179662;5336.813211537733;5540.529055030206;5638.407967163389;5664.291963504562;5696.373398926032;5713.600047996601;5778.27771528559;5781.277340332458;5782.161586570008;5787.363390027178;5787.710614469175;5449.809256675997;5459.426760190282;5517.420670829505;5533.280673512418;5570.44295570456;5545.085060965057;5573.136163894603;5584.441555844383;5587.106063029895;5595.552355811444;5369.167778994262;5389.784408623768;5417.214503896834;5420.620556561003;5422.566194704493;5512.5314348280845;5602.635828671123;5619.325680918316;5633.464820842013;5680.40355762639;5300.469953004668;5340.732963351739;5345.358556973032;5360.0887849064975;5380.085385484399 18:28:51 INFO - PID 30254 | |1;ext.html;705.8411857332101;757.2692351880435;786.7521730654842;1107.341132026444;1125.3641692443773;33090;34031.65968340319;34062.8296858516;34152.4877126843;34179.31641367171;34393;34660.30679386411;34692.82653586729;34724;34903.12742181447;6516.185476815398;6669.066330713704;6681.730471210479;6897.172339319276;7010.614416207107;6620.768273110442;6683.832904177386;6709.8322541936595;6720.227173874993;6728.697208625624;6649.900251496208;6693.4979876509215;6725.293844146343;6727.899081513781;6736.730530778763;6676.19885613727;6708.19501659804;6713.1608548931135;6714.29499902513;6724.058631791553;6667.19993600771;6678.532502724763;6681.599104053772;6692.464602831762;6702.530822842403;32278.193045173823;32483;32497;32545;32571.51142732861;3036.969630303691;3069.309405383793;3074.323648797261;3080.430120427706;3081.6147981502313;24343.634845477332;24406.511869762504;24517.264482065566;24584.385390365205;24600.876995614908;3038.8632511537035;3077.8461076946287;3094.922626934322;3121.3757248550155;3152.6059242594674;126218.36890815487;126636;135320.64679353178;145565;145941.27029364786;39403;39442;39580;39715.20569588592;39742.60257397389;41116.38325425121;41139.7943010289;41146.794266028475;41170.58829411668;44383.77808110939;12445.875541244472;12492.12555121151;12594.37028148589;12626.36868156607;12647.0514711397;10417.687469375931;10492.527836247387;10503.107235885036;10677.89322106769;10678.09236214915;12973.545925892737;13032.087753857139;13040.739185216242;13049.086563940622;13168.341582920815;5294.338207724035;5348.491893270133;5358.223057656618;5362.383325917492;5382.650127741685;852.8933883264592;908.7137551671335;909.8544232922701;920.6041402196986;932.3054324528134;20398.59202815965;20998;21264.893675531523;21383.0538130412;21628.35114946554;973.9026097390346;983.8573406855966;989.7228775942748;1000.9749756256152;1016.1413605503337;10946.343219406861;11413.60052398162;14492;14884.553463396116;14976.17631030282;170702;172779;173015;173289;173388;45390;45987;45997.7700111504;45999.540004600196;46084;1191.7259030423052;1239.2688313894846;1245.0413181850106;1245.701031752373;1254.1534464236604;24609.384765381008;24662.753372466046;25583.232503024938;25668.101616443335;25839.095631653552;30171.396572068876;36801;37907.62092379151;37954.43068353922;37962;162059;162713;163331.18334408727;163419;163862;29926.551101733927;30019.849900750356;30127.54808677828;30223.848880755457;30484.237894052825;35006.12484687801;35365.82317088501;35937.28125437529;35988.64011359853;35989;27713.86143069272;28063;28085.4552999587;28274.57588136221;29356.853215733783;27142.457150856477;27235;27383.315417114733;27427.177184684493;28543;30640.540391893694;30678.693213068476;30717.23206919845;30763.538546921365;30805.69194308028;26550.734492654825;26907.865460673354;27106;27361.452770944867;27926.3018424541;21675.241366552094;22620.886895566076;22936.655950160428;22965.425864353525;23213.41966450785 18:28:51 INFO - PID 30254 | |2;jquery.html;400.6954714417042;411.20431964149356;427.5831064711906;434.47862564922093;440.3328956630703;17881.642367152665;18417.723734143998;18664.346747863827;18665.346712865037;20487.18051277951;19710.310139145135;20229.39311820644;20264.89867550664;20276.188952441884;20305.086271117834;5571.303587051619;5706.172604972297;5709.229254050712;5717.914231286534;5718.485336319731;5167.664101833388;5468.179773034037;5677;5732.79935202268;5754.16564598133;5427.83716488506;5456.590755693319;5461.808836690697;5462.289902312714;5463.863403414906;5446.074167391553;5447.45525447456;5448.891022179574;5450.04624190767;5457.2359869618285;4949.480304568005;4956.2565615157655;4957.801687932479;4958.950410495885;4971.950280497185;23633.645495317585;23950.880245598833;23955;23958;23993;1557.3069983857188;1629.5111466559983;1636.3454618152834;1636.909969951652;1645.24318813346;15313.61715957099;15581.376744930189;15607.531774046796;15647.843521564866;15656.530304090895;2027.5032617008928;2079.189116244666;2085.3952353817376;2092.686097085434;2094.4240333908147;99922;102629.48685256526;102777;102824.48587757089;102835.99999999926;10802.00162969853;11135.276207046516;11234.887651123548;11304.434778261055;11666.241694290014;15950;15997.760033599505;16004.599885002968;16014.919925400298;16042;7853.136155022943;7928.127905930343;7978.202179782092;8030.196980301923;8233.50598964064;7288.234735352712;7336.96331518339;7345.19202887682;7415.777526674208;7467.925320746832;7079.221285658677;7426.368758655467;7516.285952834472;7549.6225188740345;7565.546067235983;2008.6642382815555;2036.6537688592975;2051.938441846747;2059.2792522617265;2182.1162429216192;836.7615229659518;862.2455351567379;889.1775108025051;899.0739538275586;906.8549032154824;18223;18626.627467450577;18692.626147476974;18848.34030808915;18938.431847044612;889.1819526036062;893.6604090445719;902.2962089570145;906.329316305942;908.6728777640044;10016.499175041365;10058.195344372432;10280.794384112276;10356.689299321033;10395.220358472994;340331;340840;362651;362859;364253;85143.57428212819;86150.56924715337;86290;86318.56840715882;86908.56545717358;1049.2550289294534;1057.9100776433936;1068.433730123036;1084.924055316136;1087.994560027195;15730.685386292438;15920.76118858195;16007.35970561211;16196.433124840574;16583.17084145812;42530;44076.77961610172;45075;45459.09081818279;45485;53901.73049134729;54048.729756350964;54183.18725219046;54292.72853635706;54466.18300725571;9658.75853103678;9915.107640312406;9942.66347408344;14691.3388897502;15479.458218962282;16967.406140785013;17220.397286094925;17258.309667613154;17316.30734770595;17365.479035628952;13057.151285166434;13987.650308741955;14144.929275353557;14292.785608215678;14305.57083287503;11891.762164756483;12133.635990920286;12457.688557786129;12935.870641293466;13088.738225235633;12859.16415432994;13014.804777928528;13124;13352.332383380597;13367.732645347232;13556;13698.65753356174;13732.65668358299;13753.931230344184;13986.790198147239;12146.420965274458;12187.207831490925;12223;12260.632181034583;12294.508219671114 18:28:51 INFO - PID 30254 | |3;mootools.html;1237.9814302785458;1288.92910889901;1292.6509842342568;1305.2038256663434;1308.5354699081827;10268.691939241817;10524.105451036661;10595.364278143317;11025.338479691214;11035.39305338206;10944;11137.665870023891;11220.495077721502;11228.101751859853;11238.100951923847;2171.8262538996883;2235.519363336882;2236.474428509299;2243.618584840573;2244.876531790751;2165.436986383536;2170.012644246872;2249.887505624712;2255.492514184312;2265.3770213191337;2189.638709612912;2202.4714068623575;2212.1483228956886;2212.977870221301;2228.3871935217862;2125.9893700531475;2134.7011418401435;2134.9786502134934;2136.7115439415793;2137.540428807806;2098.8845613491253;2110.5356821499245;2119.2476670781803;2124.6600543913055;2131.0623325736783;10900.34597924127;10958.945205273923;10966.725831854268;11014.44927753609;11032.669019929335;5339.866503337409;5568.582356323292;5602.299712535933;5602.347307544243;5606.887862242773;3176.504078607691;3302.207470207133;3381.205416727067;3387.0854869185428;3390.7287417006582;1014.8376259798397;1063.5054699564662;1072.4530489450437;1072.6942821295893;1076.8869268726828;15832.604184895354;16249.675006499921;16277.511674649779;16321.265543050591;16391.83608163927;4754.453237877619;4789.401324834395;4900.705957642553;4903.705777653352;4916;12000.759984800256;12024.699382515331;12033.458494367775;12047.819282710767;12052.819207711891;5516.062269414129;5648.830535083872;5662.745176467069;5664.376918538957;5669.971650141723;5181.896362072813;5199.74001299941;5212.869678258074;5213.3222681051975;5215.9918431404185;4154.0462924327085;4157.08544120293;4181.184668989578;4214.452121224222;4262.083652014831;1214.5081242096965;1216.793145165324;1226.8466441694789;1240.5347994502063;1241.4661695470854;696.8675951569186;711.975080872167;714.9821254468679;722.3282347416848;731.5574077683032;5396.541293990055;5417.972910135424;5506.889862202814;5587.497125258747;5589.077802162679;540.4190495217657;558.9916151257735;561.4441702714283;562.6314763829698;564.7910273198943;3791.734578579473;3865.7100717446306;3883.6310550497656;3920.745151565139;3930.5872883346838;13538.59384218475;14131.576052718436;14547.418103275962;14553.27233638314;14582.854171458363;13833.377498012613;14143.434262629586;14233.074850134708;14273.857261427253;14454;6461.450776684034;7803.453758236982;7868;7910.406719496061;7911.841763164704;5967.671778052075;6269.310375858743;6402.199725034371;6477.287498375269;6573.112629794917;11273.492692829006;11491.367974761468;11494.597689080842;11519.078473721915;11528.365939873387;11472.541098355972;11512.827307590225;11624.418779061183;11644.825327619923;11722.355270459866;8133.918660813316;8291.378146638906;8295.95852020736;8296.792580185544;8301.169883011651;9509.334346595671;9795.902040979785;9866.210703143875;9891.35706179096;9905.356151850396;8290.046644635702;8358.958205208935;8373.162683731578;8389.706360277361;8664.220220179963;8025;8166.224208700164;8188.918110819054;8194.713185038496;8230.09468958402;7356.190819010012;7473.51422157558;7499.88750168737;7523.172451030273;7547.132079810673;4913.3121363008495;4979.0788704089855;5021.623378246573;5038.370203724535;5135.10135726239;5158.509941555546;5163.122269214317;5278.5513231374225;5282.8943421132135;5324.547413469899 18:28:51 INFO - PID 30254 | |4;prototype.html;353.50332782440665;366.3808164202496;373.40441995017954;379.8803376936265;388.1828750480238;5562;5592.6085174037835;5604;5611.607187496882;5636.746346414411;5472.72636368182;5478.698671573062;5486.588505862056;5501.697406642633;5515.641483303582;4083.1425400665894;4223.303154979425;4260.31834906415;4269.316909294521;4280.6361459275995;4219.556946520602;4226.704130710851;4244.681648876332;4244.97877510612;4249.21389542934;4184.7070705050655;4184.916301673965;4194.224068547313;4195.937060944088;4201.327787553992;4170.70805043647;4200.390943313233;4205.243056249874;4213.852515161954;4227.640650544708;3722.5532936047575;3725.590185079639;3726.049857286375;3732.216234590739;3746.512953316079;5430.67415955044;5436.972815135939;5437.401885792559;5440.265564148829;5445.918311225335;4973.62697797663;4991.900161996739;4999.12515309823;5006.3241462402475;5010.774515146791;5847.152162936393;5880.441358070976;5901.616394934315;5905.468507834273;5910.202122713422;4185.434966279544;4185.539590645027;4188.225178342016;4192;4201.747895126302;5867.882642347172;6135.785247516315;6162.291336496271;6180.258368995749;6273;4262.6376757975295;4265;4266.168097221012;4268.0823622921225;4275.636570891509;4299.591538803808;4312.159128969821;4317.84887528935;4326.199653064194;4332.068605249887;4910.558049775537;4913.1893237616105;4917.9918116785975;4918.95081049185;4932.136876046749;5835.854103647443;5840.737166827503;5847.766089356463;5857.330660761748;5863.970680146572;1482.9545170654662;1483.1249562758026;1483.8441963593882;1486.4054378248786;1490.128274959161;944.3436811416137;999.9300048996646;1003.5534187286734;1021.1779517488493;1024.5338371041307;4970.3290055842;4991.126552853236;4995.850124496271;5030.37120359955;5032.924506132411;6027.336992930774;6032.668203248863;6036.939630603638;6045.244344456943;6049.667268300285;4902.92645610309;4931.9753401232765;4935.210366341368;4947.381577302837;4959.454460009396;3163.2724473371254;3203.1511649412923;3205.8742725842585;3206.4228438881223;3208.748588050662;5566.526845218121;5576.665400076008;5579.609427340048;5581.49766521015;5602.663840169603;6145.539084568675;6163.7842675506145;6203.720832562545;6208.410201030895;6221.160143380676;5538.529225015838;5549.472800083986;5557.582816381797;5613.550915926798;5619.887602247851;5983.640981541122;5989.460948514655;6040.2147720797775;6047.637141771508;6048.60684055535;5928.170056192223;5935.34711181761;5947.453662047812;5971.641701497924;5992.880142397041;5578.525825304894;5582.106862901916;5597.3412629000895;5608.8878222434505;5628.127640215773;3965.6232657897453;4219.113986062838;4258.339957306623;4275.529691733845;4284.400183974184;5904.586678932434;6039.63762174271;6067.817965461043;6075.27096748393;6085.3306136325855;5840.8247752567495;5844.912326315024;5851.970740146272;5857.1799948008165;5886.91092147954;5639.464250896158;5789.044807606866;5812.7674893003805;5848;5853.443922827325;5666.34836993751;5671.43285671446;5678.6876721779045;5679.119736440858;5698.544116470755;5905.232319798399;5914.763409463573;5916.792912248051;5927.585069045125;5942;5708.34354049273;5714;5717.656940583578;5721.456461636304;5731.484166425042 18:28:51 INFO - PID 30254 | |5;yui.html;731.7438896386262;753.8680730872097;769.307623139175;772.9381649468044;778.2334400615395;13322.40049197786;13978.580642580713;13985.370658320362;14001.649958751012;14893;16260.51218463445;16455.2595133219;16511.91744041281;16529.66940661186;16542.669146617092;895.6417433026776;913.4427998920653;914.6935776514875;915.4461550761794;915.8992510823804;870.9520976346298;896.2202883491371;896.3277541843618;898.4923518212189;916.6837441082815;937.9484128372936;938.9389689670184;939.1359948847042;940.802431489388;942.3074040580168;930.1256818590571;930.9813803723955;931.4597533430627;931.4737173496986;938.7090002099371;683.835879388948;683.8905775075964;685.715428097339;687.5702685821361;688.9414399776025;12056.156069075168;12063.276203427735;12068.336241506713;12089.093318001098;12152.696182595417;15329.923350383177;16244.02535847853;16263.756043659354;16421.507354779376;16437.671246575002;12190.329531875743;12466.127371084027;12563.371831408393;12735.23588584688;12743.235405875677;3050.9847450762604;3072.139800855764;3077.5229839374933;3081.6456107547697;3081.7534597232166;78301;78758.6062069686;81966.18033819586;82090;82111.58944205241;12408.689782755504;12417.44121514534;12547.686307842378;12614.55849045279;12675.556355527513;22068.558628827333;22111;22383.664245036336;22610.321690349316;22633.547329053326;5795.7971470999155;5885.323187833368;5889.705514724246;5902.76388944446;5916.645001299936;2754.394033312668;2841.715828417142;2881.394907069539;2885.5094633912286;2925.8390788506836;3461.6884480396884;3534.7879127252445;3545;3561.394562924309;3562.9109272267883;709.1136079900125;713.4114355656604;717.7452004538418;718.6514540447879;720.9855802883912;549.7608540284989;550.435803301611;555.2143716640988;592.5378205000106;593.9316978547522;9919.553620087114;10106;10116.74708132288;11173.776524469466;11363.431828408546;507.11761534928957;569.4476357932798;595.0924839619528;600.3336296710647;618.0266080922565;4458.175237581057;4534.77326133692;4582.88542786433;4621.884452888705;4690.085433340534;78505.21494785094;78679;79413.60293198613;79496.60251698704;79965;68239.31760682429;68825.65587172032;74808;74926;75903.62048189723;68923;71374.64312678507;72950.63524682343;73692.63153684305;75424.62287688637;10581.682549523526;10615.924883564605;10949.945250273699;11305;11483.25358851672;28793.42413151767;28845.855770721013;28972;29438.705612944454;29915.850420747756;37389.25221495609;37399;37567;37647.623523764414;38074.428883566216;13969.511067112602;14145.575632731034;14541.636459088608;14584.1978691173;14800.62998425048;17444.21501032482;17767.111644417986;18091;18176.36382726598;18272.908635456737;14162.645933851736;14353.641158970691;14417.495387661802;14423.423063077778;14558.927205364329;13506.189628621922;13538.59384218475;15724.213789310717;15808.446704365291;15887.28507217155;13948.58154255374;14309.713805724035;14458.98787084894;14570.271486425849;14884.62788430298;9825.55784989663;10818.891811081789;10884.238103333008;10894.128469722562;10915.890841091488;11453.370064646524;11722.355270460206;12040.458179381774;12052.397380131133;12099.637010889688 18:28:51 INFO - PID 30254 | __end_tp_report 18:28:51 INFO - PID 30254 | __start_cc_report 18:28:51 INFO - PID 30254 | _x_x_mozilla_cycle_collect,387 18:28:51 INFO - PID 30254 | __end_cc_report 18:28:51 INFO - PID 30254 | __startTimestamp1496280531020__endTimestamp 18:28:51 INFO - PID 30254 | 18:28:51 INFO - PID 30254 | ------- Summary: start ------- 18:28:51 INFO - PID 30254 | Number of tests: 6 18:28:51 INFO - PID 30254 | 18:28:51 INFO - PID 30254 | [#0] dojo.html Cycles:165 Average:5214.66 Median:5360.09 stddev:618.42 (11.5%) stddev-sans-first:588.60 18:28:51 INFO - PID 30254 | Values: 2722.5 2729.2 2730.1 2766.5 2768.5 5231.2 5284.9 5291.8 5316.9 5344.9 5218.6 5240.0 5304.2 5366.4 5396.2 4693.7 4696.9 4719.4 4728.2 4761.2 4674.3 4765.7 4767.6 4782.7 4802.4 4649.1 4681.7 4710.0 4712.1 4754.9 4673.6 4747.0 4752.8 4780.1 4802.7 4698.5 4701.1 4707.1 4726.6 4751.2 5188.3 5251.5 5265.1 5296.4 5338.8 5633.5 5636.6 5644.2 5762.4 5771.9 5740.3 5761.2 5764.5 5778.7 5836.7 5350.8 5352.1 5362.4 5365.4 5374.7 5714.8 5768.3 5793.0 5892.0 5917.2 5659.2 5677.3 5684.7 5699.7 5714.0 5620.8 5688.9 5721.9 5729.5 5743.8 5615.2 5687.1 5724.9 5725.9 5726.8 5631.3 5654.5 5690.1 5702.0 5710.3 4759.3 4775.6 4780.5 4782.7 4805.7 4093.0 4095.3 4096.0 4102.9 4148.3 4673.3 4730.4 4735.9 4800.3 4804.4 5720.4 5724.9 5750.0 5754.7 5780.8 4778.9 4781.0 4784.8 4788.7 4828.9 4943.7 4998.4 5034.3 5071.9 5078.8 5256.0 5280.0 5289.6 5349.5 5362.5 5619.4 5733.1 5740.9 5772.1 5814.6 5246.6 5267.4 5318.3 5327.7 5336.8 5540.5 5638.4 5664.3 5696.4 5713.6 5778.3 5781.3 5782.2 5787.4 5787.7 5449.8 5459.4 5517.4 5533.3 5570.4 5545.1 5573.1 5584.4 5587.1 5595.6 5369.2 5389.8 5417.2 5420.6 5422.6 5512.5 5602.6 5619.3 5633.5 5680.4 5300.5 5340.7 5345.4 5360.1 5380.1 18:28:51 INFO - PID 30254 | 18:28:51 INFO - PID 30254 | [#1] ext.html Cycles:180 Average:30773.62 Median:16895.78 stddev:40776.15 (241.3%) stddev-sans-first:40828.03 18:28:51 INFO - PID 30254 | Values: 705.8 757.3 786.8 1107.3 1125.4 33090.0 34031.7 34062.8 34152.5 34179.3 34393.0 34660.3 34692.8 34724.0 34903.1 6516.2 6669.1 6681.7 6897.2 7010.6 6620.8 6683.8 6709.8 6720.2 6728.7 6649.9 6693.5 6725.3 6727.9 6736.7 6676.2 6708.2 6713.2 6714.3 6724.1 6667.2 6678.5 6681.6 6692.5 6702.5 32278.2 32483.0 32497.0 32545.0 32571.5 3037.0 3069.3 3074.3 3080.4 3081.6 24343.6 24406.5 24517.3 24584.4 24600.9 3038.9 3077.8 3094.9 3121.4 3152.6 126218.4 126636.0 135320.6 145565.0 145941.3 39403.0 39442.0 39580.0 39715.2 39742.6 41116.4 41139.8 41146.8 41170.6 44383.8 12445.9 12492.1 12594.4 12626.4 12647.1 10417.7 10492.5 10503.1 10677.9 10678.1 12973.5 13032.1 13040.7 13049.1 13168.3 5294.3 5348.5 5358.2 5362.4 5382.7 852.9 908.7 909.9 920.6 932.3 20398.6 20998.0 21264.9 21383.1 21628.4 973.9 983.9 989.7 1001.0 1016.1 10946.3 11413.6 14492.0 14884.6 14976.2 170702.0 172779.0 173015.0 173289.0 173388.0 45390.0 45987.0 45997.8 45999.5 46084.0 1191.7 1239.3 1245.0 1245.7 1254.2 24609.4 24662.8 25583.2 25668.1 25839.1 30171.4 36801.0 37907.6 37954.4 37962.0 162059.0 162713.0 163331.2 163419.0 163862.0 29926.6 30019.8 30127.5 30223.8 30484.2 35006.1 35365.8 35937.3 35988.6 35989.0 27713.9 28063.0 28085.5 28274.6 29356.9 27142.5 27235.0 27383.3 27427.2 28543.0 30640.5 30678.7 30717.2 30763.5 30805.7 26550.7 26907.9 27106.0 27361.5 27926.3 21675.2 22620.9 22936.7 22965.4 23213.4 18:28:51 INFO - PID 30254 | 18:28:51 INFO - PID 30254 | [#2] jquery.html Cycles:180 Average:26266.01 Median:2069.23 stddev:59756.72 (2887.9%) stddev-sans-first:59892.80 18:28:51 INFO - PID 30254 | Values: 400.7 411.2 427.6 434.5 440.3 17881.6 18417.7 18664.3 18665.3 20487.2 19710.3 20229.4 20264.9 20276.2 20305.1 5571.3 5706.2 5709.2 5717.9 5718.5 5167.7 5468.2 5677.0 5732.8 5754.2 5427.8 5456.6 5461.8 5462.3 5463.9 5446.1 5447.5 5448.9 5450.0 5457.2 4949.5 4956.3 4957.8 4959.0 4972.0 23633.6 23950.9 23955.0 23958.0 23993.0 1557.3 1629.5 1636.3 1636.9 1645.2 15313.6 15581.4 15607.5 15647.8 15656.5 2027.5 2079.2 2085.4 2092.7 2094.4 99922.0 102629.5 102777.0 102824.5 102836.0 10802.0 11135.3 11234.9 11304.4 11666.2 15950.0 15997.8 16004.6 16014.9 16042.0 7853.1 7928.1 7978.2 8030.2 8233.5 7288.2 7337.0 7345.2 7415.8 7467.9 7079.2 7426.4 7516.3 7549.6 7565.5 2008.7 2036.7 2051.9 2059.3 2182.1 836.8 862.2 889.2 899.1 906.9 18223.0 18626.6 18692.6 18848.3 18938.4 889.2 893.7 902.3 906.3 908.7 10016.5 10058.2 10280.8 10356.7 10395.2 340331.0 340840.0 362651.0 362859.0 364253.0 85143.6 86150.6 86290.0 86318.6 86908.6 1049.3 1057.9 1068.4 1084.9 1088.0 15730.7 15920.8 16007.4 16196.4 16583.2 42530.0 44076.8 45075.0 45459.1 45485.0 53901.7 54048.7 54183.2 54292.7 54466.2 9658.8 9915.1 9942.7 14691.3 15479.5 16967.4 17220.4 17258.3 17316.3 17365.5 13057.2 13987.7 14144.9 14292.8 14305.6 11891.8 12133.6 12457.7 12935.9 13088.7 12859.2 13014.8 13124.0 13352.3 13367.7 13556.0 13698.7 13732.7 13753.9 13986.8 12146.4 12187.2 12223.0 12260.6 12294.5 18:28:51 INFO - PID 30254 | 18:28:51 INFO - PID 30254 | [#3] mootools.html Cycles:180 Average:6465.84 Median:3828.72 stddev:4284.93 (111.9%) stddev-sans-first:4278.94 18:28:51 INFO - PID 30254 | Values: 1238.0 1288.9 1292.7 1305.2 1308.5 10268.7 10524.1 10595.4 11025.3 11035.4 10944.0 11137.7 11220.5 11228.1 11238.1 2171.8 2235.5 2236.5 2243.6 2244.9 2165.4 2170.0 2249.9 2255.5 2265.4 2189.6 2202.5 2212.1 2213.0 2228.4 2126.0 2134.7 2135.0 2136.7 2137.5 2098.9 2110.5 2119.2 2124.7 2131.1 10900.3 10958.9 10966.7 11014.4 11032.7 5339.9 5568.6 5602.3 5602.3 5606.9 3176.5 3302.2 3381.2 3387.1 3390.7 1014.8 1063.5 1072.5 1072.7 1076.9 15832.6 16249.7 16277.5 16321.3 16391.8 4754.5 4789.4 4900.7 4903.7 4916.0 12000.8 12024.7 12033.5 12047.8 12052.8 5516.1 5648.8 5662.7 5664.4 5670.0 5181.9 5199.7 5212.9 5213.3 5216.0 4154.0 4157.1 4181.2 4214.5 4262.1 1214.5 1216.8 1226.8 1240.5 1241.5 696.9 712.0 715.0 722.3 731.6 5396.5 5418.0 5506.9 5587.5 5589.1 540.4 559.0 561.4 562.6 564.8 3791.7 3865.7 3883.6 3920.7 3930.6 13538.6 14131.6 14547.4 14553.3 14582.9 13833.4 14143.4 14233.1 14273.9 14454.0 6461.5 7803.5 7868.0 7910.4 7911.8 5967.7 6269.3 6402.2 6477.3 6573.1 11273.5 11491.4 11494.6 11519.1 11528.4 11472.5 11512.8 11624.4 11644.8 11722.4 8133.9 8291.4 8296.0 8296.8 8301.2 9509.3 9795.9 9866.2 9891.4 9905.4 8290.0 8359.0 8373.2 8389.7 8664.2 8025.0 8166.2 8188.9 8194.7 8230.1 7356.2 7473.5 7499.9 7523.2 7547.1 4913.3 4979.1 5021.6 5038.4 5135.1 5158.5 5163.1 5278.6 5282.9 5324.5 18:28:51 INFO - PID 30254 | 18:28:51 INFO - PID 30254 | [#4] prototype.html Cycles:180 Average:4828.39 Median:5494.14 stddev:1415.33 (25.8%) stddev-sans-first:1378.87 18:28:51 INFO - PID 30254 | Values: 353.5 366.4 373.4 379.9 388.2 5562.0 5592.6 5604.0 5611.6 5636.7 5472.7 5478.7 5486.6 5501.7 5515.6 4083.1 4223.3 4260.3 4269.3 4280.6 4219.6 4226.7 4244.7 4245.0 4249.2 4184.7 4184.9 4194.2 4195.9 4201.3 4170.7 4200.4 4205.2 4213.9 4227.6 3722.6 3725.6 3726.0 3732.2 3746.5 5430.7 5437.0 5437.4 5440.3 5445.9 4973.6 4991.9 4999.1 5006.3 5010.8 5847.2 5880.4 5901.6 5905.5 5910.2 4185.4 4185.5 4188.2 4192.0 4201.7 5867.9 6135.8 6162.3 6180.3 6273.0 4262.6 4265.0 4266.2 4268.1 4275.6 4299.6 4312.2 4317.8 4326.2 4332.1 4910.6 4913.2 4918.0 4919.0 4932.1 5835.9 5840.7 5847.8 5857.3 5864.0 1483.0 1483.1 1483.8 1486.4 1490.1 944.3 999.9 1003.6 1021.2 1024.5 4970.3 4991.1 4995.9 5030.4 5032.9 6027.3 6032.7 6036.9 6045.2 6049.7 4902.9 4932.0 4935.2 4947.4 4959.5 3163.3 3203.2 3205.9 3206.4 3208.7 5566.5 5576.7 5579.6 5581.5 5602.7 6145.5 6163.8 6203.7 6208.4 6221.2 5538.5 5549.5 5557.6 5613.6 5619.9 5983.6 5989.5 6040.2 6047.6 6048.6 5928.2 5935.3 5947.5 5971.6 5992.9 5578.5 5582.1 5597.3 5608.9 5628.1 3965.6 4219.1 4258.3 4275.5 4284.4 5904.6 6039.6 6067.8 6075.3 6085.3 5840.8 5844.9 5852.0 5857.2 5886.9 5639.5 5789.0 5812.8 5848.0 5853.4 5666.3 5671.4 5678.7 5679.1 5698.5 5905.2 5914.8 5916.8 5927.6 5942.0 5708.3 5714.0 5717.7 5721.5 5731.5 18:28:51 INFO - PID 30254 | 18:28:51 INFO - PID 30254 | [#5] yui.html Cycles:180 Average:17357.69 Median:3079.58 stddev:22528.05 (731.5%) stddev-sans-first:22556.65 18:28:51 INFO - PID 30254 | Values: 731.7 753.9 769.3 772.9 778.2 13322.4 13978.6 13985.4 14001.6 14893.0 16260.5 16455.3 16511.9 16529.7 16542.7 895.6 913.4 914.7 915.4 915.9 871.0 896.2 896.3 898.5 916.7 937.9 938.9 939.1 940.8 942.3 930.1 931.0 931.5 931.5 938.7 683.8 683.9 685.7 687.6 688.9 12056.2 12063.3 12068.3 12089.1 12152.7 15329.9 16244.0 16263.8 16421.5 16437.7 12190.3 12466.1 12563.4 12735.2 12743.2 3051.0 3072.1 3077.5 3081.6 3081.8 78301.0 78758.6 81966.2 82090.0 82111.6 12408.7 12417.4 12547.7 12614.6 12675.6 22068.6 22111.0 22383.7 22610.3 22633.5 5795.8 5885.3 5889.7 5902.8 5916.6 2754.4 2841.7 2881.4 2885.5 2925.8 3461.7 3534.8 3545.0 3561.4 3562.9 709.1 713.4 717.7 718.7 721.0 549.8 550.4 555.2 592.5 593.9 9919.6 10106.0 10116.7 11173.8 11363.4 507.1 569.4 595.1 600.3 618.0 4458.2 4534.8 4582.9 4621.9 4690.1 78505.2 78679.0 79413.6 79496.6 79965.0 68239.3 68825.7 74808.0 74926.0 75903.6 68923.0 71374.6 72950.6 73692.6 75424.6 10581.7 10615.9 10949.9 11305.0 11483.3 28793.4 28845.9 28972.0 29438.7 29915.9 37389.3 37399.0 37567.0 37647.6 38074.4 13969.5 14145.6 14541.6 14584.2 14800.6 17444.2 17767.1 18091.0 18176.4 18272.9 14162.6 14353.6 14417.5 14423.4 14558.9 13506.2 13538.6 15724.2 15808.4 15887.3 13948.6 14309.7 14459.0 14570.3 14884.6 9825.6 10818.9 10884.2 10894.1 10915.9 11453.4 11722.4 12040.5 12052.4 12099.6 18:28:51 INFO - PID 30254 | -------- Summary: end -------- 18:28:51 INFO - PID 30254 | 18:28:51 INFO - TEST-INFO | 30254: exit 0 18:28:51 INFO - TEST-OK | dromaeo_css | took 1147225ms 18:28:51 INFO - TEST-START | kraken 18:28:51 INFO - operating with platform_type : linux_ 18:28:51 INFO - Initialising browser for kraken test... 18:28:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56159/getInfo.html -profile /tmp/tmpe8OwtW/profile 18:28:51 INFO - TEST-INFO | started process 30682 (/builds/slave/test/build/application/firefox/firefox http://localhost:56159/getInfo.html) 18:29:26 INFO - TEST-INFO | 30682: killed by SIGTERM 18:29:26 INFO - Browser initialized. 18:29:26 INFO - Running cycle 1/1 for kraken test... 18:29:26 INFO - TEST-INFO | started process 30909 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe8OwtW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:29:39 INFO - PID 30909 | RSS: Main: 188469248 18:29:39 INFO - PID 30909 | 18:29:41 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56159/tests/kraken/driver.html?testName=audio-beat-detection) 18:29:42 INFO - PID 30909 | RSS: Main: 191598592 18:29:42 INFO - PID 30909 | 18:29:45 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56159/tests/kraken/driver.html?testName=audio-dft) 18:29:45 INFO - PID 30909 | RSS: Main: 190849024 18:29:45 INFO - PID 30909 | 18:29:48 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56159/tests/kraken/driver.html?testName=audio-fft) 18:29:49 INFO - PID 30909 | RSS: Main: 186073088 18:29:49 INFO - PID 30909 | 18:29:51 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56159/tests/kraken/driver.html?testName=audio-oscillator) 18:29:52 INFO - PID 30909 | RSS: Main: 186408960 18:29:52 INFO - PID 30909 | 18:29:54 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56159/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:29:55 INFO - PID 30909 | RSS: Main: 186757120 18:29:55 INFO - PID 30909 | 18:29:58 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56159/tests/kraken/driver.html?testName=imaging-darkroom) 18:29:58 INFO - PID 30909 | RSS: Main: 187928576 18:29:58 INFO - PID 30909 | 18:30:02 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56159/tests/kraken/driver.html?testName=imaging-desaturate) 18:30:03 INFO - PID 30909 | RSS: Main: 187285504 18:30:03 INFO - PID 30909 | 18:30:05 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56159/tests/kraken/driver.html?testName=json-parse-financial) 18:30:06 INFO - PID 30909 | RSS: Main: 187785216 18:30:06 INFO - PID 30909 | 18:30:08 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56159/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:30:08 INFO - PID 30909 | RSS: Main: 187809792 18:30:08 INFO - PID 30909 | 18:30:10 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56159/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:30:11 INFO - PID 30909 | RSS: Main: 187174912 18:30:11 INFO - PID 30909 | 18:30:13 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56159/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:30:14 INFO - PID 30909 | RSS: Main: 187346944 18:30:14 INFO - PID 30909 | 18:30:17 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:30:17 INFO - PID 30909 | RSS: Main: 187297792 18:30:17 INFO - PID 30909 | 18:30:21 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:30:21 INFO - PID 30909 | RSS: Main: 187183104 18:30:21 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | Cycle 1(1): loaded http://localhost:56159/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56159/tests/kraken/driver.html?testName=ai-astar) 18:30:23 INFO - PID 30909 | RSS: Main: 188461056 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | __start_tp_report 18:30:23 INFO - PID 30909 | _x_x_mozilla_page_load 18:30:23 INFO - PID 30909 | _x_x_mozilla_page_load_details 18:30:23 INFO - PID 30909 | |i|pagename|runs| 18:30:23 INFO - PID 30909 | |0;ai-astar;102;109;110;109;111;110;110;110;109;110 18:30:23 INFO - PID 30909 | |1;audio-beat-detection;150;122;124;164;127;124;123;124;147;123 18:30:23 INFO - PID 30909 | |2;audio-dft;164;165;162;166;173;172;169;165;165;166 18:30:23 INFO - PID 30909 | |3;audio-fft;75;75;79;108;78;76;75;77;97;74 18:30:23 INFO - PID 30909 | |4;audio-oscillator;82;83;104;83;83;82;104;84;83;121 18:30:23 INFO - PID 30909 | |5;imaging-gaussian-blur;114;114;114;114;114;113;116;113;114;114 18:30:23 INFO - PID 30909 | |6;imaging-darkroom;150;151;151;151;151;155;150;151;151;150 18:30:23 INFO - PID 30909 | |7;imaging-desaturate;94;96;94;94;93;97;98;100;100;94 18:30:23 INFO - PID 30909 | |8;json-parse-financial;64;55;55;56;60;56;60;57;56;56 18:30:23 INFO - PID 30909 | |9;json-stringify-tinderbox;57;56;56;56;59;56;57;57;56;56 18:30:23 INFO - PID 30909 | |10;stanford-crypto-aes;95;86;89;85;88;87;87;88;123;86 18:30:23 INFO - PID 30909 | |11;stanford-crypto-ccm;136;136;131;139;132;131;143;135;143;156 18:30:23 INFO - PID 30909 | |12;stanford-crypto-pbkdf2;197;197;189;186;196;194;200;200;189;195 18:30:23 INFO - PID 30909 | |13;stanford-crypto-sha256-iterative;79;73;76;74;75;75;71;71;69;70 18:30:23 INFO - PID 30909 | __end_tp_report 18:30:23 INFO - PID 30909 | __start_cc_report 18:30:23 INFO - PID 30909 | _x_x_mozilla_cycle_collect,1028 18:30:23 INFO - PID 30909 | __end_cc_report 18:30:23 INFO - PID 30909 | __startTimestamp1496280623718__endTimestamp 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | ------- Summary: start ------- 18:30:23 INFO - PID 30909 | Number of tests: 14 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.54 (2.3%) stddev-sans-first:0.67 18:30:23 INFO - PID 30909 | Values: 102.0 109.0 110.0 109.0 111.0 110.0 110.0 110.0 109.0 110.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:125.50 stddev:15.08 (12.0%) stddev-sans-first:14.65 18:30:23 INFO - PID 30909 | Values: 150.0 122.0 124.0 164.0 127.0 124.0 123.0 124.0 147.0 123.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#2] audio-dft Cycles:10 Average:166.70 Median:166.00 stddev:3.53 (2.1%) stddev-sans-first:3.61 18:30:23 INFO - PID 30909 | Values: 164.0 165.0 162.0 166.0 173.0 172.0 169.0 165.0 165.0 166.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.50 stddev:11.52 (15.1%) stddev-sans-first:11.98 18:30:23 INFO - PID 30909 | Values: 75.0 75.0 79.0 108.0 78.0 76.0 75.0 77.0 97.0 74.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:83.00 stddev:13.76 (16.6%) stddev-sans-first:14.22 18:30:23 INFO - PID 30909 | Values: 82.0 83.0 104.0 83.0 83.0 82.0 104.0 84.0 83.0 121.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 18:30:23 INFO - PID 30909 | Values: 114.0 114.0 114.0 114.0 114.0 113.0 116.0 113.0 114.0 114.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.45 (1.0%) stddev-sans-first:1.48 18:30:23 INFO - PID 30909 | Values: 150.0 151.0 151.0 151.0 151.0 155.0 150.0 151.0 151.0 150.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:94.00 stddev:2.62 (2.8%) stddev-sans-first:2.68 18:30:23 INFO - PID 30909 | Values: 94.0 96.0 94.0 94.0 93.0 97.0 98.0 100.0 100.0 94.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:56.50 stddev:2.92 (5.2%) stddev-sans-first:1.92 18:30:23 INFO - PID 30909 | Values: 64.0 55.0 55.0 56.0 60.0 56.0 60.0 57.0 56.0 56.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:56.50 stddev:0.97 (1.7%) stddev-sans-first:1.01 18:30:23 INFO - PID 30909 | Values: 57.0 56.0 56.0 56.0 59.0 56.0 57.0 57.0 56.0 56.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:87.50 stddev:11.44 (13.1%) stddev-sans-first:12.06 18:30:23 INFO - PID 30909 | Values: 95.0 86.0 89.0 85.0 88.0 87.0 87.0 88.0 123.0 86.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:137.50 stddev:7.64 (5.6%) stddev-sans-first:8.06 18:30:23 INFO - PID 30909 | Values: 136.0 136.0 131.0 139.0 132.0 131.0 143.0 135.0 143.0 156.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.30 Median:196.50 stddev:4.81 (2.4%) stddev-sans-first:5.00 18:30:23 INFO - PID 30909 | Values: 197.0 197.0 189.0 186.0 196.0 194.0 200.0 200.0 189.0 195.0 18:30:23 INFO - PID 30909 | 18:30:23 INFO - PID 30909 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:74.50 stddev:3.09 (4.2%) stddev-sans-first:2.50 18:30:23 INFO - PID 30909 | Values: 79.0 73.0 76.0 74.0 75.0 75.0 71.0 71.0 69.0 70.0 18:30:23 INFO - PID 30909 | -------- Summary: end -------- 18:30:23 INFO - PID 30909 | 18:30:24 INFO - TEST-INFO | 30909: exit 0 18:30:25 INFO - TEST-OK | kraken | took 93142ms 18:30:25 INFO - SUITE-END | took 1240s 18:30:25 INFO - Completed test suite (00:20:40) 18:30:25 INFO - javascript benchmark 18:30:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6919.784900234408, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2722.469118521889, 2729.2358139720873, 2730.140005898142, 2766.4605401946624, 2768.5293500104995, 5231.24146998685, 5284.947150528498, 5291.7883284668615, 5316.946830531693, 5344.893102137959, 5218.608604354669, 5239.973800131003, 5304.177852432879, 5366.382865970415, 5396.244525766386, 4693.694909830867, 4696.906061878761, 4719.362886010387, 4728.219843725781, 4761.190597598416, 4674.275487299474, 4765.714057156564, 4767.5709186173235, 4782.736949467778, 4802.447718512381, 4649.093426781779, 4681.74250416227, 4709.952900470986, 4712.104700106968, 4754.857354279377, 4673.556012178838, 4747.026859493795, 4752.786124624366, 4780.091782561337, 4802.663813533054, 4698.459677137139, 4701.130290896195, 4707.082118986765, 4726.574608285271, 4751.239801631722, 5188.273641690166, 5251.52736253739, 5265.131253343194, 5296.364436267672, 5338.839834804962, 5633.521150702195, 5636.577256705723, 5644.153376993443, 5762.394948530386, 5771.8557036074435, 5740.339860916007, 5761.222234998306, 5764.452377024176, 5778.711064446803, 5836.6789826559525, 5350.839474815762, 5352.090144675414, 5362.43694412085, 5365.356157261075, 5374.6506477078865, 5714.828555143269, 5768.2501274834, 5793.0, 5892.027815410409, 5917.230760001258, 5659.151127330933, 5677.318721753416, 5684.715764211773, 5699.74351154199, 5713.971430142823, 5620.803271885547, 5688.857778555486, 5721.8569535761935, 5729.455701708331, 5743.770249189985, 5615.185798059259, 5687.061634830289, 5724.885502290014, 5725.942740572541, 5726.77092916287, 5631.267935168484, 5654.46282603152, 5690.146478028246, 5702.030654788696, 5710.2862142232225, 4759.286107083896, 4775.570198682135, 4780.450248221429, 4782.665213435026, 4805.711657300573, 4093.0, 4095.28332541804, 4096.0, 4102.897427564335, 4148.294789885666, 4673.322368256651, 4730.385049943486, 4735.905281894343, 4800.279958006327, 4804.42346918372, 5720.427957204246, 5724.942750572524, 5749.9712501437225, 5754.74103665336, 5780.768769249183, 4778.856634300907, 4781.019890922353, 4784.832530861473, 4788.712677239377, 4828.903421931612, 4943.703377797344, 4998.400191976986, 5034.270030845581, 5071.923921141186, 5078.822241221539, 5256.0, 5280.04959107349, 5289.5503882168905, 5349.545288650508, 5362.490563396471, 5619.381867994599, 5733.111367738007, 5740.885182296414, 5772.076467765138, 5814.563907707024, 5246.554042906396, 5267.446918073547, 5318.308619879391, 5327.680339179662, 5336.813211537733, 5540.529055030206, 5638.407967163389, 5664.291963504562, 5696.373398926032, 5713.600047996601, 5778.27771528559, 5781.277340332458, 5782.161586570008, 5787.363390027178, 5787.710614469175, 5449.809256675997, 5459.426760190282, 5517.420670829505, 5533.280673512418, 5570.44295570456, 5545.085060965057, 5573.136163894603, 5584.441555844383, 5587.106063029895, 5595.552355811444, 5369.167778994262, 5389.784408623768, 5417.214503896834, 5420.620556561003, 5422.566194704493, 5512.5314348280845, 5602.635828671123, 5619.325680918316, 5633.464820842013, 5680.40355762639, 5300.469953004668, 5340.732963351739, 5345.358556973032, 5360.0887849064975, 5380.085385484399], "value": 5169.355355531969, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.8411857332101, 757.2692351880435, 786.7521730654842, 1107.341132026444, 1125.3641692443773, 33090.0, 34031.65968340319, 34062.8296858516, 34152.4877126843, 34179.31641367171, 34393.0, 34660.30679386411, 34692.82653586729, 34724.0, 34903.12742181447, 6516.185476815398, 6669.066330713704, 6681.730471210479, 6897.172339319276, 7010.614416207107, 6620.768273110442, 6683.832904177386, 6709.8322541936595, 6720.227173874993, 6728.697208625624, 6649.900251496208, 6693.4979876509215, 6725.293844146343, 6727.899081513781, 6736.730530778763, 6676.19885613727, 6708.19501659804, 6713.1608548931135, 6714.29499902513, 6724.058631791553, 6667.19993600771, 6678.532502724763, 6681.599104053772, 6692.464602831762, 6702.530822842403, 32278.193045173823, 32483.0, 32497.0, 32545.0, 32571.51142732861, 3036.969630303691, 3069.309405383793, 3074.323648797261, 3080.430120427706, 3081.6147981502313, 24343.634845477332, 24406.511869762504, 24517.264482065566, 24584.385390365205, 24600.876995614908, 3038.8632511537035, 3077.8461076946287, 3094.922626934322, 3121.3757248550155, 3152.6059242594674, 126218.36890815487, 126636.0, 135320.64679353178, 145565.0, 145941.27029364786, 39403.0, 39442.0, 39580.0, 39715.20569588592, 39742.60257397389, 41116.38325425121, 41139.7943010289, 41146.794266028475, 41170.58829411668, 44383.77808110939, 12445.875541244472, 12492.12555121151, 12594.37028148589, 12626.36868156607, 12647.0514711397, 10417.687469375931, 10492.527836247387, 10503.107235885036, 10677.89322106769, 10678.09236214915, 12973.545925892737, 13032.087753857139, 13040.739185216242, 13049.086563940622, 13168.341582920815, 5294.338207724035, 5348.491893270133, 5358.223057656618, 5362.383325917492, 5382.650127741685, 852.8933883264592, 908.7137551671335, 909.8544232922701, 920.6041402196986, 932.3054324528134, 20398.59202815965, 20998.0, 21264.893675531523, 21383.0538130412, 21628.35114946554, 973.9026097390346, 983.8573406855966, 989.7228775942748, 1000.9749756256152, 1016.1413605503337, 10946.343219406861, 11413.60052398162, 14492.0, 14884.553463396116, 14976.17631030282, 170702.0, 172779.0, 173015.0, 173289.0, 173388.0, 45390.0, 45987.0, 45997.7700111504, 45999.540004600196, 46084.0, 1191.7259030423052, 1239.2688313894846, 1245.0413181850106, 1245.701031752373, 1254.1534464236604, 24609.384765381008, 24662.753372466046, 25583.232503024938, 25668.101616443335, 25839.095631653552, 30171.396572068876, 36801.0, 37907.62092379151, 37954.43068353922, 37962.0, 162059.0, 162713.0, 163331.18334408727, 163419.0, 163862.0, 29926.551101733927, 30019.849900750356, 30127.54808677828, 30223.848880755457, 30484.237894052825, 35006.12484687801, 35365.82317088501, 35937.28125437529, 35988.64011359853, 35989.0, 27713.86143069272, 28063.0, 28085.4552999587, 28274.57588136221, 29356.853215733783, 27142.457150856477, 27235.0, 27383.315417114733, 27427.177184684493, 28543.0, 30640.540391893694, 30678.693213068476, 30717.23206919845, 30763.538546921365, 30805.69194308028, 26550.734492654825, 26907.865460673354, 27106.0, 27361.452770944867, 27926.3018424541, 21675.241366552094, 22620.886895566076, 22936.655950160428, 22965.425864353525, 23213.41966450785], "value": 14793.749818291983, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.6954714417042, 411.20431964149356, 427.5831064711906, 434.47862564922093, 440.3328956630703, 17881.642367152665, 18417.723734143998, 18664.346747863827, 18665.346712865037, 20487.18051277951, 19710.310139145135, 20229.39311820644, 20264.89867550664, 20276.188952441884, 20305.086271117834, 5571.303587051619, 5706.172604972297, 5709.229254050712, 5717.914231286534, 5718.485336319731, 5167.664101833388, 5468.179773034037, 5677.0, 5732.79935202268, 5754.16564598133, 5427.83716488506, 5456.590755693319, 5461.808836690697, 5462.289902312714, 5463.863403414906, 5446.074167391553, 5447.45525447456, 5448.891022179574, 5450.04624190767, 5457.2359869618285, 4949.480304568005, 4956.2565615157655, 4957.801687932479, 4958.950410495885, 4971.950280497185, 23633.645495317585, 23950.880245598833, 23955.0, 23958.0, 23993.0, 1557.3069983857188, 1629.5111466559983, 1636.3454618152834, 1636.909969951652, 1645.24318813346, 15313.61715957099, 15581.376744930189, 15607.531774046796, 15647.843521564866, 15656.530304090895, 2027.5032617008928, 2079.189116244666, 2085.3952353817376, 2092.686097085434, 2094.4240333908147, 99922.0, 102629.48685256526, 102777.0, 102824.48587757089, 102835.99999999926, 10802.00162969853, 11135.276207046516, 11234.887651123548, 11304.434778261055, 11666.241694290014, 15950.0, 15997.760033599505, 16004.599885002968, 16014.919925400298, 16042.0, 7853.136155022943, 7928.127905930343, 7978.202179782092, 8030.196980301923, 8233.50598964064, 7288.234735352712, 7336.96331518339, 7345.19202887682, 7415.777526674208, 7467.925320746832, 7079.221285658677, 7426.368758655467, 7516.285952834472, 7549.6225188740345, 7565.546067235983, 2008.6642382815555, 2036.6537688592975, 2051.938441846747, 2059.2792522617265, 2182.1162429216192, 836.7615229659518, 862.2455351567379, 889.1775108025051, 899.0739538275586, 906.8549032154824, 18223.0, 18626.627467450577, 18692.626147476974, 18848.34030808915, 18938.431847044612, 889.1819526036062, 893.6604090445719, 902.2962089570145, 906.329316305942, 908.6728777640044, 10016.499175041365, 10058.195344372432, 10280.794384112276, 10356.689299321033, 10395.220358472994, 340331.0, 340840.0, 362651.0, 362859.0, 364253.0, 85143.57428212819, 86150.56924715337, 86290.0, 86318.56840715882, 86908.56545717358, 1049.2550289294534, 1057.9100776433936, 1068.433730123036, 1084.924055316136, 1087.994560027195, 15730.685386292438, 15920.76118858195, 16007.35970561211, 16196.433124840574, 16583.17084145812, 42530.0, 44076.77961610172, 45075.0, 45459.09081818279, 45485.0, 53901.73049134729, 54048.729756350964, 54183.18725219046, 54292.72853635706, 54466.18300725571, 9658.75853103678, 9915.107640312406, 9942.66347408344, 14691.3388897502, 15479.458218962282, 16967.406140785013, 17220.397286094925, 17258.309667613154, 17316.30734770595, 17365.479035628952, 13057.151285166434, 13987.650308741955, 14144.929275353557, 14292.785608215678, 14305.57083287503, 11891.762164756483, 12133.635990920286, 12457.688557786129, 12935.870641293466, 13088.738225235633, 12859.16415432994, 13014.804777928528, 13124.0, 13352.332383380597, 13367.732645347232, 13556.0, 13698.65753356174, 13732.65668358299, 13753.931230344184, 13986.790198147239, 12146.420965274458, 12187.207831490925, 12223.0, 12260.632181034583, 12294.508219671114], "value": 9608.160554643247, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1237.9814302785458, 1288.92910889901, 1292.6509842342568, 1305.2038256663434, 1308.5354699081827, 10268.691939241817, 10524.105451036661, 10595.364278143317, 11025.338479691214, 11035.39305338206, 10944.0, 11137.665870023891, 11220.495077721502, 11228.101751859853, 11238.100951923847, 2171.8262538996883, 2235.519363336882, 2236.474428509299, 2243.618584840573, 2244.876531790751, 2165.436986383536, 2170.012644246872, 2249.887505624712, 2255.492514184312, 2265.3770213191337, 2189.638709612912, 2202.4714068623575, 2212.1483228956886, 2212.977870221301, 2228.3871935217862, 2125.9893700531475, 2134.7011418401435, 2134.9786502134934, 2136.7115439415793, 2137.540428807806, 2098.8845613491253, 2110.5356821499245, 2119.2476670781803, 2124.6600543913055, 2131.0623325736783, 10900.34597924127, 10958.945205273923, 10966.725831854268, 11014.44927753609, 11032.669019929335, 5339.866503337409, 5568.582356323292, 5602.299712535933, 5602.347307544243, 5606.887862242773, 3176.504078607691, 3302.207470207133, 3381.205416727067, 3387.0854869185428, 3390.7287417006582, 1014.8376259798397, 1063.5054699564662, 1072.4530489450437, 1072.6942821295893, 1076.8869268726828, 15832.604184895354, 16249.675006499921, 16277.511674649779, 16321.265543050591, 16391.83608163927, 4754.453237877619, 4789.401324834395, 4900.705957642553, 4903.705777653352, 4916.0, 12000.759984800256, 12024.699382515331, 12033.458494367775, 12047.819282710767, 12052.819207711891, 5516.062269414129, 5648.830535083872, 5662.745176467069, 5664.376918538957, 5669.971650141723, 5181.896362072813, 5199.74001299941, 5212.869678258074, 5213.3222681051975, 5215.9918431404185, 4154.0462924327085, 4157.08544120293, 4181.184668989578, 4214.452121224222, 4262.083652014831, 1214.5081242096965, 1216.793145165324, 1226.8466441694789, 1240.5347994502063, 1241.4661695470854, 696.8675951569186, 711.975080872167, 714.9821254468679, 722.3282347416848, 731.5574077683032, 5396.541293990055, 5417.972910135424, 5506.889862202814, 5587.497125258747, 5589.077802162679, 540.4190495217657, 558.9916151257735, 561.4441702714283, 562.6314763829698, 564.7910273198943, 3791.734578579473, 3865.7100717446306, 3883.6310550497656, 3920.745151565139, 3930.5872883346838, 13538.59384218475, 14131.576052718436, 14547.418103275962, 14553.27233638314, 14582.854171458363, 13833.377498012613, 14143.434262629586, 14233.074850134708, 14273.857261427253, 14454.0, 6461.450776684034, 7803.453758236982, 7868.0, 7910.406719496061, 7911.841763164704, 5967.671778052075, 6269.310375858743, 6402.199725034371, 6477.287498375269, 6573.112629794917, 11273.492692829006, 11491.367974761468, 11494.597689080842, 11519.078473721915, 11528.365939873387, 11472.541098355972, 11512.827307590225, 11624.418779061183, 11644.825327619923, 11722.355270459866, 8133.918660813316, 8291.378146638906, 8295.95852020736, 8296.792580185544, 8301.169883011651, 9509.334346595671, 9795.902040979785, 9866.210703143875, 9891.35706179096, 9905.356151850396, 8290.046644635702, 8358.958205208935, 8373.162683731578, 8389.706360277361, 8664.220220179963, 8025.0, 8166.224208700164, 8188.918110819054, 8194.713185038496, 8230.09468958402, 7356.190819010012, 7473.51422157558, 7499.88750168737, 7523.172451030273, 7547.132079810673, 4913.3121363008495, 4979.0788704089855, 5021.623378246573, 5038.370203724535, 5135.10135726239, 5158.509941555546, 5163.122269214317, 5278.5513231374225, 5282.8943421132135, 5324.547413469899], "value": 4776.734292347829, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.50332782440665, 366.3808164202496, 373.40441995017954, 379.8803376936265, 388.1828750480238, 5562.0, 5592.6085174037835, 5604.0, 5611.607187496882, 5636.746346414411, 5472.72636368182, 5478.698671573062, 5486.588505862056, 5501.697406642633, 5515.641483303582, 4083.1425400665894, 4223.303154979425, 4260.31834906415, 4269.316909294521, 4280.6361459275995, 4219.556946520602, 4226.704130710851, 4244.681648876332, 4244.97877510612, 4249.21389542934, 4184.7070705050655, 4184.916301673965, 4194.224068547313, 4195.937060944088, 4201.327787553992, 4170.70805043647, 4200.390943313233, 4205.243056249874, 4213.852515161954, 4227.640650544708, 3722.5532936047575, 3725.590185079639, 3726.049857286375, 3732.216234590739, 3746.512953316079, 5430.67415955044, 5436.972815135939, 5437.401885792559, 5440.265564148829, 5445.918311225335, 4973.62697797663, 4991.900161996739, 4999.12515309823, 5006.3241462402475, 5010.774515146791, 5847.152162936393, 5880.441358070976, 5901.616394934315, 5905.468507834273, 5910.202122713422, 4185.434966279544, 4185.539590645027, 4188.225178342016, 4192.0, 4201.747895126302, 5867.882642347172, 6135.785247516315, 6162.291336496271, 6180.258368995749, 6273.0, 4262.6376757975295, 4265.0, 4266.168097221012, 4268.0823622921225, 4275.636570891509, 4299.591538803808, 4312.159128969821, 4317.84887528935, 4326.199653064194, 4332.068605249887, 4910.558049775537, 4913.1893237616105, 4917.9918116785975, 4918.95081049185, 4932.136876046749, 5835.854103647443, 5840.737166827503, 5847.766089356463, 5857.330660761748, 5863.970680146572, 1482.9545170654662, 1483.1249562758026, 1483.8441963593882, 1486.4054378248786, 1490.128274959161, 944.3436811416137, 999.9300048996646, 1003.5534187286734, 1021.1779517488493, 1024.5338371041307, 4970.3290055842, 4991.126552853236, 4995.850124496271, 5030.37120359955, 5032.924506132411, 6027.336992930774, 6032.668203248863, 6036.939630603638, 6045.244344456943, 6049.667268300285, 4902.92645610309, 4931.9753401232765, 4935.210366341368, 4947.381577302837, 4959.454460009396, 3163.2724473371254, 3203.1511649412923, 3205.8742725842585, 3206.4228438881223, 3208.748588050662, 5566.526845218121, 5576.665400076008, 5579.609427340048, 5581.49766521015, 5602.663840169603, 6145.539084568675, 6163.7842675506145, 6203.720832562545, 6208.410201030895, 6221.160143380676, 5538.529225015838, 5549.472800083986, 5557.582816381797, 5613.550915926798, 5619.887602247851, 5983.640981541122, 5989.460948514655, 6040.2147720797775, 6047.637141771508, 6048.60684055535, 5928.170056192223, 5935.34711181761, 5947.453662047812, 5971.641701497924, 5992.880142397041, 5578.525825304894, 5582.106862901916, 5597.3412629000895, 5608.8878222434505, 5628.127640215773, 3965.6232657897453, 4219.113986062838, 4258.339957306623, 4275.529691733845, 4284.400183974184, 5904.586678932434, 6039.63762174271, 6067.817965461043, 6075.27096748393, 6085.3306136325855, 5840.8247752567495, 5844.912326315024, 5851.970740146272, 5857.1799948008165, 5886.91092147954, 5639.464250896158, 5789.044807606866, 5812.7674893003805, 5848.0, 5853.443922827325, 5666.34836993751, 5671.43285671446, 5678.6876721779045, 5679.119736440858, 5698.544116470755, 5905.232319798399, 5914.763409463573, 5916.792912248051, 5927.585069045125, 5942.0, 5708.34354049273, 5714.0, 5717.656940583578, 5721.456461636304, 5731.484166425042], "value": 4388.520566904851, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.7438896386262, 753.8680730872097, 769.307623139175, 772.9381649468044, 778.2334400615395, 13322.40049197786, 13978.580642580713, 13985.370658320362, 14001.649958751012, 14893.0, 16260.51218463445, 16455.2595133219, 16511.91744041281, 16529.66940661186, 16542.669146617092, 895.6417433026776, 913.4427998920653, 914.6935776514875, 915.4461550761794, 915.8992510823804, 870.9520976346298, 896.2202883491371, 896.3277541843618, 898.4923518212189, 916.6837441082815, 937.9484128372936, 938.9389689670184, 939.1359948847042, 940.802431489388, 942.3074040580168, 930.1256818590571, 930.9813803723955, 931.4597533430627, 931.4737173496986, 938.7090002099371, 683.835879388948, 683.8905775075964, 685.715428097339, 687.5702685821361, 688.9414399776025, 12056.156069075168, 12063.276203427735, 12068.336241506713, 12089.093318001098, 12152.696182595417, 15329.923350383177, 16244.02535847853, 16263.756043659354, 16421.507354779376, 16437.671246575002, 12190.329531875743, 12466.127371084027, 12563.371831408393, 12735.23588584688, 12743.235405875677, 3050.9847450762604, 3072.139800855764, 3077.5229839374933, 3081.6456107547697, 3081.7534597232166, 78301.0, 78758.6062069686, 81966.18033819586, 82090.0, 82111.58944205241, 12408.689782755504, 12417.44121514534, 12547.686307842378, 12614.55849045279, 12675.556355527513, 22068.558628827333, 22111.0, 22383.664245036336, 22610.321690349316, 22633.547329053326, 5795.7971470999155, 5885.323187833368, 5889.705514724246, 5902.76388944446, 5916.645001299936, 2754.394033312668, 2841.715828417142, 2881.394907069539, 2885.5094633912286, 2925.8390788506836, 3461.6884480396884, 3534.7879127252445, 3545.0, 3561.394562924309, 3562.9109272267883, 709.1136079900125, 713.4114355656604, 717.7452004538418, 718.6514540447879, 720.9855802883912, 549.7608540284989, 550.435803301611, 555.2143716640988, 592.5378205000106, 593.9316978547522, 9919.553620087114, 10106.0, 10116.74708132288, 11173.776524469466, 11363.431828408546, 507.11761534928957, 569.4476357932798, 595.0924839619528, 600.3336296710647, 618.0266080922565, 4458.175237581057, 4534.77326133692, 4582.88542786433, 4621.884452888705, 4690.085433340534, 78505.21494785094, 78679.0, 79413.60293198613, 79496.60251698704, 79965.0, 68239.31760682429, 68825.65587172032, 74808.0, 74926.0, 75903.62048189723, 68923.0, 71374.64312678507, 72950.63524682343, 73692.63153684305, 75424.62287688637, 10581.682549523526, 10615.924883564605, 10949.945250273699, 11305.0, 11483.25358851672, 28793.42413151767, 28845.855770721013, 28972.0, 29438.705612944454, 29915.850420747756, 37389.25221495609, 37399.0, 37567.0, 37647.623523764414, 38074.428883566216, 13969.511067112602, 14145.575632731034, 14541.636459088608, 14584.1978691173, 14800.62998425048, 17444.21501032482, 17767.111644417986, 18091.0, 18176.36382726598, 18272.908635456737, 14162.645933851736, 14353.641158970691, 14417.495387661802, 14423.423063077778, 14558.927205364329, 13506.189628621922, 13538.59384218475, 15724.213789310717, 15808.446704365291, 15887.28507217155, 13948.58154255374, 14309.713805724035, 14458.98787084894, 14570.271486425849, 14884.62788430298, 9825.55784989663, 10818.891811081789, 10884.238103333008, 10894.128469722562, 10915.890841091488, 11453.370064646524, 11722.355270460206, 12040.458179381774, 12052.397380131133, 12099.637010889688], "value": 7127.194787546415, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 109.0, 110.0, 109.0, 111.0, 110.0, 110.0, 110.0, 109.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 122.0, 124.0, 164.0, 127.0, 124.0, 123.0, 124.0, 147.0, 123.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 166.0, 173.0, 172.0, 169.0, 165.0, 165.0, 166.0], "value": 166.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 79.0, 108.0, 78.0, 76.0, 75.0, 77.0, 97.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 104.0, 83.0, 83.0, 82.0, 104.0, 84.0, 83.0, 121.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 116.0, 113.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 151.0, 151.0, 155.0, 150.0, 151.0, 151.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 94.0, 93.0, 97.0, 98.0, 100.0, 100.0, 94.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 55.0, 55.0, 56.0, 60.0, 56.0, 60.0, 57.0, 56.0, 56.0], "value": 57.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 56.0, 59.0, 56.0, 57.0, 57.0, 56.0, 56.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 86.0, 89.0, 85.0, 88.0, 87.0, 87.0, 88.0, 123.0, 86.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 136.0, 131.0, 139.0, 132.0, 131.0, 143.0, 135.0, 143.0, 156.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 197.0, 189.0, 186.0, 196.0, 194.0, 200.0, 200.0, 189.0, 195.0], "value": 194.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 73.0, 76.0, 74.0, 75.0, 75.0, 71.0, 71.0, 69.0, 70.0], "value": 73.3, "unit": "score"}]}]} 18:30:25 INFO - Return code: 0 18:30:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:30:25 INFO - # TBPL SUCCESS # 18:30:25 INFO - Running post-action listener: _resource_record_post_action 18:30:25 INFO - [mozharness: 2017-06-01 01:30:25.541639Z] Finished run-tests step (success) 18:30:25 INFO - Running post-run listener: _resource_record_post_run 18:30:25 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 12288; Write bytes: 411865088; Read time: 132; Write time: 242308 18:30:25 INFO - TinderboxPrint: CPU usage
12.7% 18:30:25 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 132 18:30:25 INFO - TinderboxPrint: I/O write bytes / time
411,865,088 / 242,308 18:30:25 INFO - TinderboxPrint: CPU idle
8,757.7 (87.3%) 18:30:25 INFO - TinderboxPrint: CPU user
1,224.1 (12.2%) 18:30:25 INFO - TinderboxPrint: Swap in / out
0 / 0 18:30:25 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 101076992; Read time: 48; Write time: 71772 18:30:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:30:25 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310788096; Read time: 72; Write time: 170536 18:30:26 INFO - Running post-run listener: _upload_blobber_files 18:30:26 INFO - Blob upload gear active. 18:30:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:30:26 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 18:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:30:26 INFO - (blobuploader) - INFO - Open directory for files ... 18:30:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:30:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:30:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:27 INFO - (blobuploader) - INFO - Done attempting. 18:30:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:30:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:30:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:28 INFO - (blobuploader) - INFO - Done attempting. 18:30:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:30:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:30:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:32 INFO - (blobuploader) - INFO - Done attempting. 18:30:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:30:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:30:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:30:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:30:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:30:33 INFO - (blobuploader) - INFO - Done attempting. 18:30:33 INFO - (blobuploader) - INFO - Iteration through files over. 18:30:33 INFO - Return code: 0 18:30:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:30:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:30:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f33b11df7bb9c17d2c323ccca900b454468a7ceac325137859af7fede6b95932ea12729b9dae7cd3fabde3beb290972c3a28401e0a2ab65b02a2b9ac84e29db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69448b5c681b2267653fec9de1d61683c09029492a600d7c736d6b4238463d000f359ce318e9d2ffe60b6c7d0f405ad46c0c47420a8fa891ce4af4f8c74790e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6601cb2916768b352241fd97a274b2d8a5370ffbe97ec0dc31a0dca8c29b3a877ab434e930b4da042e18341b7f154bb553cd0b980b7e49ad237279568da998eb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc232322b34ea5bd0e376499c2f156bb6f242aa5a8b2203fd32b3bee6ae8c12a3dd2a4a15d165430a773acd2cdb434daa107957d815dd09536ea39311444f58f"} 18:30:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:30:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:30:33 INFO - Contents: 18:30:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f33b11df7bb9c17d2c323ccca900b454468a7ceac325137859af7fede6b95932ea12729b9dae7cd3fabde3beb290972c3a28401e0a2ab65b02a2b9ac84e29db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69448b5c681b2267653fec9de1d61683c09029492a600d7c736d6b4238463d000f359ce318e9d2ffe60b6c7d0f405ad46c0c47420a8fa891ce4af4f8c74790e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6601cb2916768b352241fd97a274b2d8a5370ffbe97ec0dc31a0dca8c29b3a877ab434e930b4da042e18341b7f154bb553cd0b980b7e49ad237279568da998eb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc232322b34ea5bd0e376499c2f156bb6f242aa5a8b2203fd32b3bee6ae8c12a3dd2a4a15d165430a773acd2cdb434daa107957d815dd09536ea39311444f58f"} 18:30:33 INFO - Running post-run listener: copy_logs_to_upload_dir 18:30:33 INFO - Copying logs to upload dir... 18:30:33 INFO - mkdir: /builds/slave/test/build/upload/logs 18:30:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1323.712558 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2017-05-31 18:30:32.717741) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 18:30:32.721876) ========= 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=62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f33b11df7bb9c17d2c323ccca900b454468a7ceac325137859af7fede6b95932ea12729b9dae7cd3fabde3beb290972c3a28401e0a2ab65b02a2b9ac84e29db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69448b5c681b2267653fec9de1d61683c09029492a600d7c736d6b4238463d000f359ce318e9d2ffe60b6c7d0f405ad46c0c47420a8fa891ce4af4f8c74790e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6601cb2916768b352241fd97a274b2d8a5370ffbe97ec0dc31a0dca8c29b3a877ab434e930b4da042e18341b7f154bb553cd0b980b7e49ad237279568da998eb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc232322b34ea5bd0e376499c2f156bb6f242aa5a8b2203fd32b3bee6ae8c12a3dd2a4a15d165430a773acd2cdb434daa107957d815dd09536ea39311444f58f"} build_url:https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/QIDwbIK6QUiOx0mk4t3s6A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f33b11df7bb9c17d2c323ccca900b454468a7ceac325137859af7fede6b95932ea12729b9dae7cd3fabde3beb290972c3a28401e0a2ab65b02a2b9ac84e29db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/69448b5c681b2267653fec9de1d61683c09029492a600d7c736d6b4238463d000f359ce318e9d2ffe60b6c7d0f405ad46c0c47420a8fa891ce4af4f8c74790e2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6601cb2916768b352241fd97a274b2d8a5370ffbe97ec0dc31a0dca8c29b3a877ab434e930b4da042e18341b7f154bb553cd0b980b7e49ad237279568da998eb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc232322b34ea5bd0e376499c2f156bb6f242aa5a8b2203fd32b3bee6ae8c12a3dd2a4a15d165430a773acd2cdb434daa107957d815dd09536ea39311444f58f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-31 18:30:32.747896) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 18:30:32.748325) ========= 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=62c568580acbfdaac3eec7be000001dc-1496269532.393062-592615389 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-31 18:30:32.831209) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 18:30:32.831865) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-31 18:30:32.832467) ========= ========= Total master_lag: 0.17 =========