builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1496160169.05 results: success (0) revision: e15fb840661215dc3928c3bf1fea0ca0379511f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:49.050008) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:49.050404) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:49.050691) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:49.157117) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:49.157401) ========= 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=337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-30 09:02:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 100M=0s 2017-05-30 09:02:50 (100 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.117737 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:49.302564) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:49.302886) ========= 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=337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017672 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:49.366094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:49.366447) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e15fb840661215dc3928c3bf1fea0ca0379511f9 --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 e15fb840661215dc3928c3bf1fea0ca0379511f9 --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=337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-30 09:02:50,272 truncating revision to first 12 chars 2017-05-30 09:02:50,272 Setting DEBUG logging. 2017-05-30 09:02:50,272 attempt 1/10 2017-05-30 09:02:50,272 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e15fb8406612?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-30 09:02:50,686 unpacking tar archive at: mozilla-central-e15fb8406612/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703462 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:50.100017) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:50.100288) ========= script_repo_revision: e15fb840661215dc3928c3bf1fea0ca0379511f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:50.100687) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:50.100957) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-30 09:02:50.120953) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-05-30 09:02:50.121232) ========= /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=337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:02:51 INFO - MultiFileLogger online at 20170530 09:02:51 in /builds/slave/test 09:02:51 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 09:02:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:02:51 INFO - {'append_to_log': False, 09:02:51 INFO - 'base_work_dir': '/builds/slave/test', 09:02:51 INFO - 'blob_upload_branch': 'Firefox', 09:02:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:02:51 INFO - 'branch': 'Firefox', 09:02:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:02:51 INFO - 'config_files': ('talos/linux_config.py',), 09:02:51 INFO - 'default_actions': ('clobber', 09:02:51 INFO - 'read-buildbot-config', 09:02:51 INFO - 'download-and-extract', 09:02:51 INFO - 'populate-webroot', 09:02:51 INFO - 'create-virtualenv', 09:02:51 INFO - 'install', 09:02:51 INFO - 'setup-mitmproxy', 09:02:51 INFO - 'run-tests'), 09:02:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:02:51 INFO - 'download_minidump_stackwalk': True, 09:02:51 INFO - 'download_symbols': 'ondemand', 09:02:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:02:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:02:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:02:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:02:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:02:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:02:51 INFO - 'gecko_profile': False, 09:02:51 INFO - 'gecko_profile_interval': 0, 09:02:51 INFO - 'installer_path': 'installer.exe', 09:02:51 INFO - 'log_level': 'info', 09:02:51 INFO - 'log_name': 'talos', 09:02:51 INFO - 'log_to_console': True, 09:02:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:02:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:02:51 INFO - 'opt_config_files': (), 09:02:51 INFO - 'pip_index': False, 09:02:51 INFO - 'suite': 'dromaeojs-e10s', 09:02:51 INFO - 'system_bits': '32', 09:02:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:02:51 INFO - 'title': 'talos-linux64-ix-060', 09:02:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:02:51 INFO - 'use_talos_json': True, 09:02:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:02:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:02:51 INFO - 'work_dir': 'build'} 09:02:51 INFO - [mozharness: 2017-05-30 16:02:51.118747Z] Running clobber step. 09:02:51 INFO - Running pre-action listener: _resource_record_pre_action 09:02:51 INFO - Running main action method: clobber 09:02:51 INFO - rmtree: /builds/slave/test/build 09:02:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:02:52 INFO - Running post-action listener: _resource_record_post_action 09:02:52 INFO - [mozharness: 2017-05-30 16:02:52.656138Z] Finished clobber step (success) 09:02:52 INFO - [mozharness: 2017-05-30 16:02:52.656249Z] Running read-buildbot-config step. 09:02:52 INFO - Running pre-action listener: _resource_record_pre_action 09:02:52 INFO - Running main action method: read_buildbot_config 09:02:52 INFO - Using buildbot properties: 09:02:52 INFO - { 09:02:52 INFO - "project": "", 09:02:52 INFO - "product": "firefox", 09:02:52 INFO - "who": "bhearsum@mozilla.com", 09:02:52 INFO - "installer_path": "public/build/target.tar.bz2", 09:02:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 09:02:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:02:52 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 09:02:52 INFO - "stage_platform": "linux64-stylo", 09:02:52 INFO - "basedir": "/builds/slave/test", 09:02:52 INFO - "buildnumber": 129, 09:02:52 INFO - "platform": "ubuntu64_hw_stylo", 09:02:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:02:52 INFO - "slavebuilddir": "test", 09:02:52 INFO - "taskId": "YidCBjgSSfm9_f7mwL_U1g", 09:02:52 INFO - "branch": "mozilla-central", 09:02:52 INFO - "script_repo_revision": "production", 09:02:52 INFO - "revision": "e15fb840661215dc3928c3bf1fea0ca0379511f9", 09:02:52 INFO - "slavename": "talos-linux64-ix-060", 09:02:52 INFO - "repo_path": "mozilla-central" 09:02:52 INFO - } 09:02:52 INFO - Finding installer, test and symbols from parent task. 09:02:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YidCBjgSSfm9_f7mwL_U1g'}, attempt #1 09:02:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YidCBjgSSfm9_f7mwL_U1g'}, attempt #1 09:02:53 INFO - Task dependencies: GGu-oaChTbWCndW1LXf13A 09:02:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A'}, attempt #1 09:02:54 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.tar.bz2 09:02:54 INFO - Set test_url: https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/test_packages.json 09:02:54 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.crashreporter-symbols.zip 09:02:54 INFO - Running post-action listener: _resource_record_post_action 09:02:54 INFO - [mozharness: 2017-05-30 16:02:54.027169Z] Finished read-buildbot-config step (success) 09:02:54 INFO - [mozharness: 2017-05-30 16:02:54.027389Z] Running download-and-extract step. 09:02:54 INFO - Running pre-action listener: _resource_record_pre_action 09:02:54 INFO - Running main action method: download_and_extract 09:02:54 INFO - mkdir: /builds/slave/test/build/tests 09:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:02:54 INFO - trying https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.test_packages.json 09:02:54 INFO - Downloading https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:02:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:02:54 INFO - Downloaded 986 bytes. 09:02:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:02:54 INFO - Using the following test package requirements: 09:02:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:02:54 INFO - u'common': [u'target.common.tests.zip'], 09:02:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:02:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:02:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:02:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:02:54 INFO - u'mozbase': [u'target.common.tests.zip'], 09:02:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:02:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:02:54 INFO - u'web-platform': [u'target.common.tests.zip', 09:02:54 INFO - u'target.web-platform.tests.zip'], 09:02:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:02:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:02:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.common.tests.zip 09:02:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:02:54 INFO - Fetch https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.common.tests.zip into memory 09:02:56 INFO - Content-Length response header: 63528757 09:02:56 INFO - Bytes received: 63528757 09:03:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:03:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.common.tests.zip 09:03:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:03:07 INFO - Fetch https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.common.tests.zip into memory 09:03:09 INFO - Content-Length response header: 63528757 09:03:09 INFO - Bytes received: 63528757 09:03:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.talos.tests.zip 09:03:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:03:21 INFO - Fetch https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.talos.tests.zip into memory 09:03:22 INFO - Content-Length response header: 14447425 09:03:22 INFO - Bytes received: 14447425 09:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:22 INFO - trying https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.tar.bz2 09:03:22 INFO - Downloading https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:03:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:03:25 INFO - Downloaded 56077282 bytes. 09:03:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.tar.bz2 09:03:25 INFO - mkdir: /builds/slave/test/properties 09:03:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:03:25 INFO - Writing to file /builds/slave/test/properties/build_url 09:03:25 INFO - Contents: 09:03:25 INFO - build_url:https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.tar.bz2 09:03:25 INFO - Running post-action listener: _resource_record_post_action 09:03:25 INFO - Running post-action listener: set_extra_try_arguments 09:03:25 INFO - [mozharness: 2017-05-30 16:03:25.316607Z] Finished download-and-extract step (success) 09:03:25 INFO - [mozharness: 2017-05-30 16:03:25.316836Z] Running populate-webroot step. 09:03:25 INFO - Running pre-action listener: _resource_record_pre_action 09:03:25 INFO - Running main action method: populate_webroot 09:03:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:03:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:03:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:03:25 INFO - '--tppagecycles', 09:03:25 INFO - '7'], 09:03:25 INFO - 'tests': ['tsvgm']}}, 09:03:25 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:03:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:03:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:03:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:03:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:03:25 INFO - 'talos_options': ['--disable-e10s'], 09:03:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:03:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:03:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:03:25 INFO - 'talos_options': ['--disable-e10s'], 09:03:25 INFO - 'tests': ['damp', 'tps']}, 09:03:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:03:25 INFO - 'tests': ['damp', 'tps']}, 09:03:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:03:25 INFO - 'tests': ['dromaeo_dom']}, 09:03:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:03:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:03:25 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:03:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:03:25 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:03:25 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:03:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:03:25 INFO - 'tests': ['a11yr', 09:03:25 INFO - 'ts_paint', 09:03:25 INFO - 'tpaint', 09:03:25 INFO - 'sessionrestore', 09:03:25 INFO - 'sessionrestore_no_auto_restore', 09:03:25 INFO - 'tabpaint']}, 09:03:25 INFO - 'other-e10s': {'tests': ['a11yr', 09:03:25 INFO - 'ts_paint', 09:03:25 INFO - 'tpaint', 09:03:25 INFO - 'sessionrestore', 09:03:25 INFO - 'sessionrestore_no_auto_restore', 09:03:25 INFO - 'tabpaint']}, 09:03:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:03:25 INFO - 'ts_paint', 09:03:25 INFO - 'tpaint', 09:03:25 INFO - 'sessionrestore', 09:03:25 INFO - 'sessionrestore_no_auto_restore', 09:03:25 INFO - 'tabpaint']}, 09:03:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:03:25 INFO - 'ts_paint', 09:03:25 INFO - 'tpaint', 09:03:25 INFO - 'sessionrestore', 09:03:25 INFO - 'sessionrestore_no_auto_restore', 09:03:25 INFO - 'tabpaint']}, 09:03:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:03:25 INFO - 'tests': ['a11yr', 09:03:25 INFO - 'ts_paint', 09:03:25 INFO - 'tpaint', 09:03:25 INFO - 'sessionrestore', 09:03:25 INFO - 'sessionrestore_no_auto_restore', 09:03:25 INFO - 'tabpaint']}, 09:03:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:03:25 INFO - 'tests': ['a11yr', 09:03:25 INFO - 'ts_paint', 09:03:25 INFO - 'tpaint', 09:03:25 INFO - 'sessionrestore', 09:03:25 INFO - 'sessionrestore_no_auto_restore', 09:03:25 INFO - 'tabpaint']}, 09:03:25 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:03:25 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:03:25 INFO - 'bloom_basic_ref']}, 09:03:25 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:03:25 INFO - 'talos_options': ['--mitmproxy', 09:03:25 INFO - 'mitmproxy-recording-1.mp', 09:03:25 INFO - '--firstNonBlankPaint'], 09:03:25 INFO - 'tests': ['Quantum_1']}, 09:03:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:03:25 INFO - 'tests': ['tsvgx', 09:03:25 INFO - 'tsvgr_opacity', 09:03:25 INFO - 'tart', 09:03:25 INFO - 'tscrollx', 09:03:25 INFO - 'cart', 09:03:25 INFO - 'tsvg_static']}, 09:03:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:03:25 INFO - 'tsvgr_opacity', 09:03:25 INFO - 'tart', 09:03:25 INFO - 'tscrollx', 09:03:25 INFO - 'cart', 09:03:25 INFO - 'tsvg_static']}, 09:03:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:03:25 INFO - 'talos_options': ['--disable-e10s'], 09:03:25 INFO - 'tests': ['tp5o']}, 09:03:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:03:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:03:25 INFO - 'talos_options': ['--disable-e10s', 09:03:25 INFO - '--xperf_path', 09:03:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:25 INFO - 'tests': ['tp5n']}, 09:03:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:03:25 INFO - 'talos_options': ['--xperf_path', 09:03:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:03:25 INFO - 'tests': ['tp5n']}}, 09:03:25 INFO - 'talos.zip': {'path': '', 09:03:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:03:25 INFO - Running post-action listener: _resource_record_post_action 09:03:25 INFO - [mozharness: 2017-05-30 16:03:25.338526Z] Finished populate-webroot step (success) 09:03:25 INFO - [mozharness: 2017-05-30 16:03:25.338630Z] Running create-virtualenv step. 09:03:25 INFO - Running pre-action listener: _resource_record_pre_action 09:03:25 INFO - Running main action method: create_virtualenv 09:03:25 INFO - Creating virtualenv /builds/slave/test/build/venv 09:03:25 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 09:03:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:03:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:03:25 INFO - Using real prefix '/usr' 09:03:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:03:25 INFO - Installing distribute.............................................................................................................................................................................................done. 09:03:27 INFO - Installing pip.................done. 09:03:27 INFO - Return code: 0 09:03:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:03:28 INFO - Reading from file tmpfile_stdout 09:03:28 INFO - Output received: 09:03:28 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) 09:03:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c3c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6e40>, '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 0x1fb7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb8440>, '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': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', '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 09:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:03:28 INFO - Using env: {'DISPLAY': ':0', 09:03:28 INFO - 'HOME': '/home/cltbld', 09:03:28 INFO - 'LANG': 'en_US.UTF-8', 09:03:28 INFO - 'LANGUAGE': 'en_US:en', 09:03:28 INFO - 'LOGNAME': 'cltbld', 09:03:28 INFO - 'MAIL': '/var/mail/cltbld', 09:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:28 INFO - 'MOZ_NO_REMOTE': '1', 09:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:28 INFO - 'NO_EM_RESTART': '1', 09:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:28 INFO - 'PWD': '/builds/slave/test', 09:03:28 INFO - 'SHELL': '/bin/bash', 09:03:28 INFO - 'SHLVL': '1', 09:03:28 INFO - 'TERM': 'linux', 09:03:28 INFO - 'TMOUT': '86400', 09:03:28 INFO - 'USER': 'cltbld', 09:03:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', 09:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:28 INFO - '_': '/tools/buildbot/bin/python'} 09:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:28 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 09:03:28 INFO - Cleaning up... 09:03:28 INFO - Return code: 0 09:03:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1c3c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6e40>, '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 0x1fb7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb8440>, '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': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', '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 09:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:03:28 INFO - Using env: {'DISPLAY': ':0', 09:03:28 INFO - 'HOME': '/home/cltbld', 09:03:28 INFO - 'LANG': 'en_US.UTF-8', 09:03:28 INFO - 'LANGUAGE': 'en_US:en', 09:03:28 INFO - 'LOGNAME': 'cltbld', 09:03:28 INFO - 'MAIL': '/var/mail/cltbld', 09:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:28 INFO - 'MOZ_NO_REMOTE': '1', 09:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:28 INFO - 'NO_EM_RESTART': '1', 09:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:28 INFO - 'PWD': '/builds/slave/test', 09:03:28 INFO - 'SHELL': '/bin/bash', 09:03:28 INFO - 'SHLVL': '1', 09:03:28 INFO - 'TERM': 'linux', 09:03:28 INFO - 'TMOUT': '86400', 09:03:28 INFO - 'USER': 'cltbld', 09:03:28 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', 09:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:28 INFO - '_': '/tools/buildbot/bin/python'} 09:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:28 INFO - Downloading/unpacking psutil>=3.1.1 09:03:28 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 09:03:28 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 09:03:28 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 09:03:28 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 09:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:03:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:29 INFO - Installing collected packages: psutil 09:03:29 INFO - Running setup.py install for psutil 09:03:29 INFO - building 'psutil._psutil_linux' extension 09:03:29 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 09:03:29 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 09:03:30 INFO - building 'psutil._psutil_posix' extension 09:03:30 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 09:03:30 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 09:03:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:03:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:03:30 INFO - Successfully installed psutil 09:03:30 INFO - Cleaning up... 09:03:30 INFO - Return code: 0 09:03:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:30 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 0x1c3c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6e40>, '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 0x1fb7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb8440>, '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': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', '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 09:03:30 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 09:03:30 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 09:03:30 INFO - Using env: {'DISPLAY': ':0', 09:03:30 INFO - 'HOME': '/home/cltbld', 09:03:30 INFO - 'LANG': 'en_US.UTF-8', 09:03:30 INFO - 'LANGUAGE': 'en_US:en', 09:03:30 INFO - 'LOGNAME': 'cltbld', 09:03:30 INFO - 'MAIL': '/var/mail/cltbld', 09:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:30 INFO - 'MOZ_NO_REMOTE': '1', 09:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:30 INFO - 'NO_EM_RESTART': '1', 09:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:30 INFO - 'PWD': '/builds/slave/test', 09:03:30 INFO - 'SHELL': '/bin/bash', 09:03:30 INFO - 'SHLVL': '1', 09:03:30 INFO - 'TERM': 'linux', 09:03:30 INFO - 'TMOUT': '86400', 09:03:30 INFO - 'USER': 'cltbld', 09:03:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', 09:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:30 INFO - '_': '/tools/buildbot/bin/python'} 09:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:03:30 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 09:03:30 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 09:03:30 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 09:03:30 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 09:03:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:03:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:03:31 INFO - Installing collected packages: mozsystemmonitor 09:03:31 INFO - Running setup.py install for mozsystemmonitor 09:03:31 INFO - Successfully installed mozsystemmonitor 09:03:31 INFO - Cleaning up... 09:03:31 INFO - Return code: 0 09:03:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:31 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 0x1c3c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6e40>, '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 0x1fb7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb8440>, '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': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', '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 09:03:31 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 09:03:31 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 09:03:31 INFO - Using env: {'DISPLAY': ':0', 09:03:31 INFO - 'HOME': '/home/cltbld', 09:03:31 INFO - 'LANG': 'en_US.UTF-8', 09:03:31 INFO - 'LANGUAGE': 'en_US:en', 09:03:31 INFO - 'LOGNAME': 'cltbld', 09:03:31 INFO - 'MAIL': '/var/mail/cltbld', 09:03:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:31 INFO - 'MOZ_NO_REMOTE': '1', 09:03:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:31 INFO - 'NO_EM_RESTART': '1', 09:03:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:31 INFO - 'PWD': '/builds/slave/test', 09:03:31 INFO - 'SHELL': '/bin/bash', 09:03:31 INFO - 'SHLVL': '1', 09:03:31 INFO - 'TERM': 'linux', 09:03:31 INFO - 'TMOUT': '86400', 09:03:31 INFO - 'USER': 'cltbld', 09:03:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', 09:03:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:31 INFO - '_': '/tools/buildbot/bin/python'} 09:03:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:03:31 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 09:03:31 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 09:03:31 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 09:03:31 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 09:03:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:03:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:03:33 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 09:03:33 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 09:03:33 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 09:03:33 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 09:03:33 INFO - Downloading functools32-3.2.3-2.tar.gz 09:03:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:03:33 INFO - warning: no files found matching '*.txt' 09:03:33 INFO - no previously-included directories found matching 'build' 09:03:33 INFO - no previously-included directories found matching 'dist' 09:03:33 INFO - no previously-included directories found matching '.git*' 09:03:33 INFO - Installing collected packages: jsonschema, functools32 09:03:33 INFO - Running setup.py install for functools32 09:03:33 INFO - warning: no files found matching '*.txt' 09:03:33 INFO - no previously-included directories found matching 'build' 09:03:33 INFO - no previously-included directories found matching 'dist' 09:03:33 INFO - no previously-included directories found matching '.git*' 09:03:33 INFO - Successfully installed jsonschema functools32 09:03:33 INFO - Cleaning up... 09:03:33 INFO - Return code: 0 09:03:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:03:33 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')]} 09:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:33 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')]} 09:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:33 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 0x1c3c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6e40>, '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 0x1fb7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb8440>, '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': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', '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 09:03:33 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 09:03:33 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 09:03:33 INFO - Using env: {'DISPLAY': ':0', 09:03:33 INFO - 'HOME': '/home/cltbld', 09:03:33 INFO - 'LANG': 'en_US.UTF-8', 09:03:33 INFO - 'LANGUAGE': 'en_US:en', 09:03:33 INFO - 'LOGNAME': 'cltbld', 09:03:33 INFO - 'MAIL': '/var/mail/cltbld', 09:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:33 INFO - 'MOZ_NO_REMOTE': '1', 09:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:33 INFO - 'NO_EM_RESTART': '1', 09:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:33 INFO - 'PWD': '/builds/slave/test', 09:03:33 INFO - 'SHELL': '/bin/bash', 09:03:33 INFO - 'SHLVL': '1', 09:03:33 INFO - 'TERM': 'linux', 09:03:33 INFO - 'TMOUT': '86400', 09:03:33 INFO - 'USER': 'cltbld', 09:03:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', 09:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:33 INFO - '_': '/tools/buildbot/bin/python'} 09:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:03:33 INFO - Cleaning up... 09:03:33 INFO - Return code: 0 09:03:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:03:33 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')]} 09:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:33 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')]} 09:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:33 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 0x1c3c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6e40>, '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 0x1fb7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb8440>, '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': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', '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 09:03:33 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 09:03:33 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 09:03:33 INFO - Using env: {'DISPLAY': ':0', 09:03:33 INFO - 'HOME': '/home/cltbld', 09:03:33 INFO - 'LANG': 'en_US.UTF-8', 09:03:33 INFO - 'LANGUAGE': 'en_US:en', 09:03:33 INFO - 'LOGNAME': 'cltbld', 09:03:33 INFO - 'MAIL': '/var/mail/cltbld', 09:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:33 INFO - 'MOZ_NO_REMOTE': '1', 09:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:33 INFO - 'NO_EM_RESTART': '1', 09:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:33 INFO - 'PWD': '/builds/slave/test', 09:03:33 INFO - 'SHELL': '/bin/bash', 09:03:33 INFO - 'SHLVL': '1', 09:03:33 INFO - 'TERM': 'linux', 09:03:33 INFO - 'TMOUT': '86400', 09:03:33 INFO - 'USER': 'cltbld', 09:03:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', 09:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:33 INFO - '_': '/tools/buildbot/bin/python'} 09:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:34 INFO - Downloading/unpacking blobuploader==1.2.4 09:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:35 INFO - Downloading blobuploader-1.2.4.tar.gz 09:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:03:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:03:35 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 09:03:35 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 09:03:35 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 09:03:35 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 09:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:03:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:03:35 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 09:03:35 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 09:03:35 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 09:03:35 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 09:03:35 INFO - Downloading docopt-0.6.1.tar.gz 09:03:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:03:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:03:35 INFO - Running setup.py install for blobuploader 09:03:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:03:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:03:35 INFO - Running setup.py install for requests 09:03:36 INFO - Running setup.py install for docopt 09:03:36 INFO - Successfully installed blobuploader requests docopt 09:03:36 INFO - Cleaning up... 09:03:36 INFO - Return code: 0 09:03:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:36 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 0x1c3c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6e40>, '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 0x1fb7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb8440>, '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': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', '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 09:03:36 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 09:03:36 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 09:03:36 INFO - Using env: {'DISPLAY': ':0', 09:03:36 INFO - 'HOME': '/home/cltbld', 09:03:36 INFO - 'LANG': 'en_US.UTF-8', 09:03:36 INFO - 'LANGUAGE': 'en_US:en', 09:03:36 INFO - 'LOGNAME': 'cltbld', 09:03:36 INFO - 'MAIL': '/var/mail/cltbld', 09:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:36 INFO - 'MOZ_NO_REMOTE': '1', 09:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:36 INFO - 'NO_EM_RESTART': '1', 09:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:36 INFO - 'PWD': '/builds/slave/test', 09:03:36 INFO - 'SHELL': '/bin/bash', 09:03:36 INFO - 'SHLVL': '1', 09:03:36 INFO - 'TERM': 'linux', 09:03:36 INFO - 'TMOUT': '86400', 09:03:36 INFO - 'USER': 'cltbld', 09:03:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', 09:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:36 INFO - '_': '/tools/buildbot/bin/python'} 09:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:36 INFO - Running setup.py (path:/tmp/pip-TWYDUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:36 INFO - Running setup.py (path:/tmp/pip-NeP9wK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:36 INFO - Running setup.py (path:/tmp/pip-S3fDvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:36 INFO - Running setup.py (path:/tmp/pip-9lKuid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:36 INFO - Running setup.py (path:/tmp/pip-SuBscY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:36 INFO - Running setup.py (path:/tmp/pip-ZV4REC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:36 INFO - Running setup.py (path:/tmp/pip-6OgdUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:37 INFO - Running setup.py (path:/tmp/pip-Vr1FAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:37 INFO - Running setup.py (path:/tmp/pip-a4lzTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:37 INFO - Running setup.py (path:/tmp/pip-9ya1Y0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:37 INFO - Running setup.py (path:/tmp/pip-25SA_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:37 INFO - Running setup.py (path:/tmp/pip-9AAVoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:37 INFO - Running setup.py (path:/tmp/pip-4QFg0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:37 INFO - Running setup.py (path:/tmp/pip-yjDVDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:37 INFO - Running setup.py (path:/tmp/pip-DDJa5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:37 INFO - Running setup.py (path:/tmp/pip-DEwfEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:37 INFO - Running setup.py (path:/tmp/pip-07Ex5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:03:37 INFO - Running setup.py install for manifestparser 09:03:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:03:37 INFO - Running setup.py install for mozcrash 09:03:37 INFO - Running setup.py install for mozdebug 09:03:38 INFO - Running setup.py install for mozdevice 09:03:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:03:38 INFO - Running setup.py install for mozfile 09:03:38 INFO - Running setup.py install for mozhttpd 09:03:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:03:38 INFO - Running setup.py install for mozinfo 09:03:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:03:38 INFO - Running setup.py install for mozInstall 09:03:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:03:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:03:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:03:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:03:38 INFO - Running setup.py install for mozleak 09:03:38 INFO - Running setup.py install for mozlog 09:03:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:03:38 INFO - Running setup.py install for moznetwork 09:03:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:03:38 INFO - Running setup.py install for mozprocess 09:03:39 INFO - Running setup.py install for mozprofile 09:03:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:03:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:03:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:03:39 INFO - Running setup.py install for mozrunner 09:03:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:03:39 INFO - Running setup.py install for mozscreenshot 09:03:39 INFO - Running setup.py install for moztest 09:03:39 INFO - Running setup.py install for mozversion 09:03:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:03:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:03:39 INFO - Cleaning up... 09:03:39 INFO - Return code: 0 09:03:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:39 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 0x1c3c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6e40>, '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 0x1fb7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb8440>, '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': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', '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 09:03:39 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 09:03:39 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 09:03:39 INFO - Using env: {'DISPLAY': ':0', 09:03:39 INFO - 'HOME': '/home/cltbld', 09:03:39 INFO - 'LANG': 'en_US.UTF-8', 09:03:39 INFO - 'LANGUAGE': 'en_US:en', 09:03:39 INFO - 'LOGNAME': 'cltbld', 09:03:39 INFO - 'MAIL': '/var/mail/cltbld', 09:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:39 INFO - 'MOZ_NO_REMOTE': '1', 09:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:39 INFO - 'NO_EM_RESTART': '1', 09:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:39 INFO - 'PWD': '/builds/slave/test', 09:03:39 INFO - 'SHELL': '/bin/bash', 09:03:39 INFO - 'SHLVL': '1', 09:03:39 INFO - 'TERM': 'linux', 09:03:39 INFO - 'TMOUT': '86400', 09:03:39 INFO - 'USER': 'cltbld', 09:03:39 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', 09:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:39 INFO - '_': '/tools/buildbot/bin/python'} 09:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:03:39 INFO - Running setup.py (path:/tmp/pip-tcfq0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:03:39 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)) 09:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:03:39 INFO - Running setup.py (path:/tmp/pip-GoFooV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:03:39 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)) 09:03:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:03:39 INFO - Running setup.py (path:/tmp/pip-U0ZXYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:03:40 INFO - Running setup.py (path:/tmp/pip-7XSvZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:03:40 INFO - Running setup.py (path:/tmp/pip-OuydZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:03:40 INFO - Running setup.py (path:/tmp/pip-EtUhKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:03:40 INFO - Running setup.py (path:/tmp/pip-6sgn2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:03:40 INFO - Running setup.py (path:/tmp/pip-aUBXcc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:03:40 INFO - Running setup.py (path:/tmp/pip-Any1Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:03:40 INFO - Running setup.py (path:/tmp/pip-zp9GVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:03:40 INFO - Running setup.py (path:/tmp/pip-RvFubJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:03:40 INFO - Running setup.py (path:/tmp/pip-_kCaW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:03:40 INFO - Running setup.py (path:/tmp/pip-SxuJOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:03:40 INFO - Running setup.py (path:/tmp/pip-H8GXRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:40 INFO - Running setup.py (path:/tmp/pip-Nyp4EC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:03:40 INFO - Running setup.py (path:/tmp/pip-YmYADc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:03:40 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)) 09:03:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:03:40 INFO - Running setup.py (path:/tmp/pip-PBcyh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:03:41 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)) 09:03:41 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)) 09:03:41 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)) 09:03:41 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)) 09:03:41 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)) 09:03:41 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)) 09:03:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:03:41 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 09:03:41 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 09:03:41 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 09:03:41 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 09:03:42 INFO - Downloading blessings-1.6.tar.gz 09:03:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:03:42 INFO - Installing collected packages: blessings 09:03:42 INFO - Running setup.py install for blessings 09:03:42 INFO - Successfully installed blessings 09:03:42 INFO - Cleaning up... 09:03:42 INFO - Return code: 0 09:03:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:03:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:42 INFO - Reading from file tmpfile_stdout 09:03:42 INFO - Current package versions: 09:03:42 INFO - argparse == 1.2.1 09:03:42 INFO - blessings == 1.6 09:03:42 INFO - blobuploader == 1.2.4 09:03:42 INFO - docopt == 0.6.1 09:03:42 INFO - functools32 == 3.2.3-2 09:03:42 INFO - jsonschema == 2.5.1 09:03:42 INFO - manifestparser == 1.1 09:03:42 INFO - mozInstall == 1.12 09:03:42 INFO - mozcrash == 1.0 09:03:42 INFO - mozdebug == 0.1 09:03:42 INFO - mozdevice == 0.51 09:03:42 INFO - mozfile == 1.2 09:03:42 INFO - mozhttpd == 0.7 09:03:42 INFO - mozinfo == 0.9 09:03:42 INFO - mozleak == 0.1 09:03:42 INFO - mozlog == 3.4 09:03:42 INFO - moznetwork == 0.27 09:03:42 INFO - mozprocess == 0.25 09:03:42 INFO - mozprofile == 0.28 09:03:42 INFO - mozrunner == 6.13 09:03:42 INFO - mozscreenshot == 0.1 09:03:42 INFO - mozsystemmonitor == 0.3 09:03:42 INFO - moztest == 0.8 09:03:42 INFO - mozversion == 1.4 09:03:42 INFO - psutil == 3.1.1 09:03:42 INFO - requests == 1.2.3 09:03:42 INFO - wsgiref == 0.1.2 09:03:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:03:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:42 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 0x1c3c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6e40>, '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 0x1fb7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb8440>, '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': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', '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 09:03:42 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 09:03:42 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 09:03:42 INFO - Using env: {'DISPLAY': ':0', 09:03:42 INFO - 'HOME': '/home/cltbld', 09:03:42 INFO - 'LANG': 'en_US.UTF-8', 09:03:42 INFO - 'LANGUAGE': 'en_US:en', 09:03:42 INFO - 'LOGNAME': 'cltbld', 09:03:42 INFO - 'MAIL': '/var/mail/cltbld', 09:03:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:42 INFO - 'MOZ_NO_REMOTE': '1', 09:03:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:42 INFO - 'NO_EM_RESTART': '1', 09:03:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:42 INFO - 'PWD': '/builds/slave/test', 09:03:42 INFO - 'SHELL': '/bin/bash', 09:03:42 INFO - 'SHLVL': '1', 09:03:42 INFO - 'TERM': 'linux', 09:03:42 INFO - 'TMOUT': '86400', 09:03:42 INFO - 'USER': 'cltbld', 09:03:42 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', 09:03:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:42 INFO - '_': '/tools/buildbot/bin/python'} 09:03:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:42 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)) 09:03:42 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)) 09:03:42 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)) 09:03:42 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)) 09:03:42 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)) 09:03:42 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)) 09:03:42 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)) 09:03:42 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)) 09:03:42 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)) 09:03:42 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:03:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:03:43 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:03:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:03:43 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)) 09:03:43 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)) 09:03:43 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)) 09:03:43 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)) 09:03:43 INFO - Installing collected packages: marionette-driver 09:03:43 INFO - Running setup.py install for marionette-driver 09:03:44 INFO - Successfully installed marionette-driver 09:03:44 INFO - Cleaning up... 09:03:44 INFO - Return code: 0 09:03:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:03: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')]} 09:03:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:03: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')]} 09:03:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:03:44 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 0x1c3c3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e16a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fb9ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb6e40>, '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 0x1fb7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb8440>, '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': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', '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 09:03:44 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 09:03:44 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 09:03:44 INFO - Using env: {'DISPLAY': ':0', 09:03:44 INFO - 'HOME': '/home/cltbld', 09:03:44 INFO - 'LANG': 'en_US.UTF-8', 09:03:44 INFO - 'LANGUAGE': 'en_US:en', 09:03:44 INFO - 'LOGNAME': 'cltbld', 09:03:44 INFO - 'MAIL': '/var/mail/cltbld', 09:03:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:03:44 INFO - 'MOZ_NO_REMOTE': '1', 09:03:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:03:44 INFO - 'NO_EM_RESTART': '1', 09:03:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:03:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:03:44 INFO - 'PWD': '/builds/slave/test', 09:03:44 INFO - 'SHELL': '/bin/bash', 09:03:44 INFO - 'SHLVL': '1', 09:03:44 INFO - 'TERM': 'linux', 09:03:44 INFO - 'TMOUT': '86400', 09:03:44 INFO - 'USER': 'cltbld', 09:03:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', 09:03:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:03:44 INFO - '_': '/tools/buildbot/bin/python'} 09:03:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:03:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:03:44 INFO - Cleaning up... 09:03:44 INFO - Return code: 0 09:03:44 INFO - Running post-action listener: _resource_record_post_action 09:03:44 INFO - Running post-action listener: _start_resource_monitoring 09:03:44 INFO - Starting resource monitoring. 09:03:44 INFO - [mozharness: 2017-05-30 16:03:44.375040Z] Finished create-virtualenv step (success) 09:03:44 INFO - [mozharness: 2017-05-30 16:03:44.375517Z] Running install step. 09:03:44 INFO - Running pre-action listener: _resource_record_pre_action 09:03:44 INFO - Running main action method: install 09:03:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:03:44 INFO - Reading from file tmpfile_stdout 09:03:44 INFO - Detecting whether we're running mozinstall >=1.0... 09:03:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:03:44 INFO - Reading from file tmpfile_stdout 09:03:44 INFO - Output received: 09:03:44 INFO - Usage: mozinstall [options] installer 09:03:44 INFO - Options: 09:03:44 INFO - -h, --help show this help message and exit 09:03:44 INFO - -d DEST, --destination=DEST 09:03:44 INFO - Directory to install application into. [default: 09:03:44 INFO - "/builds/slave/test"] 09:03:44 INFO - --app=APP Application being installed. [default: firefox] 09:03:44 INFO - mkdir: /builds/slave/test/build/application 09:03:44 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'] 09:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:04:00 INFO - Reading from file tmpfile_stdout 09:04:00 INFO - Output received: 09:04:00 INFO - /builds/slave/test/build/application/firefox/firefox 09:04:00 INFO - Running post-action listener: _resource_record_post_action 09:04:00 INFO - [mozharness: 2017-05-30 16:04:00.756747Z] Finished install step (success) 09:04:00 INFO - [mozharness: 2017-05-30 16:04:00.757028Z] Running setup-mitmproxy step. 09:04:00 INFO - Running pre-action listener: _resource_record_pre_action 09:04:00 INFO - Running main action method: setup_mitmproxy 09:04:00 INFO - Skipping: mitmproxy is not required 09:04:00 INFO - Running post-action listener: _resource_record_post_action 09:04:00 INFO - [mozharness: 2017-05-30 16:04:00.758167Z] Finished setup-mitmproxy step (success) 09:04:00 INFO - [mozharness: 2017-05-30 16:04:00.758388Z] Running run-tests step. 09:04:00 INFO - Running pre-action listener: _resource_record_pre_action 09:04:00 INFO - Running main action method: run_tests 09:04:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:04:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:04:00 INFO - Python 2.7.3 09:04:00 INFO - Return code: 0 09:04:00 INFO - grabbing minidump binary from tooltool 09:04:00 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')]} 09:04:00 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 0x1fb6e40>, '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 0x1fb7fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fb8440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:04:00 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 09:04:00 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 09:04:00 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 09:04:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:04:00 INFO - Return code: 0 09:04:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:04:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:04:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:04:00 INFO - ENV: RUST_BACKTRACE is now 1 09:04:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:04:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:04:00 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/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 09:04:00 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/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 09:04:00 INFO - Using env: {'DISPLAY': ':0', 09:04:00 INFO - 'HOME': '/home/cltbld', 09:04:00 INFO - 'LANG': 'en_US.UTF-8', 09:04:00 INFO - 'LANGUAGE': 'en_US:en', 09:04:00 INFO - 'LOGNAME': 'cltbld', 09:04:00 INFO - 'MAIL': '/var/mail/cltbld', 09:04:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:04:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:04:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:04:00 INFO - 'MOZ_NO_REMOTE': '1', 09:04:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:04:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:04:00 INFO - 'NO_EM_RESTART': '1', 09:04:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:04:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:04:00 INFO - 'PWD': '/builds/slave/test', 09:04:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:04:00 INFO - 'RUST_BACKTRACE': '1', 09:04:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:04:00 INFO - 'SHELL': '/bin/bash', 09:04:00 INFO - 'SHLVL': '1', 09:04:00 INFO - 'TERM': 'linux', 09:04:00 INFO - 'TMOUT': '86400', 09:04:00 INFO - 'USER': 'cltbld', 09:04:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842', 09:04:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:04:00 INFO - '_': '/tools/buildbot/bin/python'} 09:04:00 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/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 09:04:01 INFO - mozversion application_buildid: 20170530152434 09:04:01 INFO - mozversion application_changeset: e15fb840661215dc3928c3bf1fea0ca0379511f9 09:04:01 INFO - mozversion application_display_name: Nightly 09:04:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:04:01 INFO - mozversion application_name: Firefox 09:04:01 INFO - mozversion application_remotingname: firefox 09:04:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:04:01 INFO - mozversion application_vendor: Mozilla 09:04:01 INFO - mozversion application_version: 55.0a1 09:04:01 INFO - mozversion platform_buildid: 20170530152434 09:04:01 INFO - mozversion platform_changeset: e15fb840661215dc3928c3bf1fea0ca0379511f9 09:04:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:04:01 INFO - mozversion platform_version: 55.0a1 09:04:01 INFO - using testdate: 1496160241 09:04:01 INFO - actual date: 1496160241 09:04:01 INFO - starting webserver on 'localhost:55788' 09:04:01 INFO - SUITE-START | Running 2 tests 09:04:01 INFO - TEST-START | dromaeo_css 09:04:01 INFO - operating with platform_type : linux_ 09:04:01 INFO - Initialising browser for dromaeo_css test... 09:04:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55788/getInfo.html -profile /tmp/tmp3Sexvf/profile 09:04:01 INFO - TEST-INFO | started process 16643 (/builds/slave/test/build/application/firefox/firefox http://localhost:55788/getInfo.html) 09:04:36 INFO - TEST-INFO | 16643: killed by SIGTERM 09:04:36 INFO - Browser initialized. 09:04:36 INFO - Running cycle 1/1 for dromaeo_css test... 09:04:36 INFO - TEST-INFO | started process 16869 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3Sexvf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:48 INFO - PID 16869 | RSS: Main: 186580992 09:04:48 INFO - PID 16869 | 09:07:53 INFO - PID 16869 | Cycle 1(1): loaded http://localhost:55788/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55788/tests/dromaeo/cssquery-ext.html) 09:07:55 INFO - PID 16869 | RSS: Main: 181518336 09:07:55 INFO - PID 16869 | 09:10:57 INFO - PID 16869 | Cycle 1(1): loaded http://localhost:55788/tests/dromaeo/cssquery-ext.html (next: http://localhost:55788/tests/dromaeo/cssquery-jquery.html) 09:10:57 INFO - PID 16869 | RSS: Main: 187826176 09:10:57 INFO - PID 16869 | 09:13:59 INFO - PID 16869 | Cycle 1(1): loaded http://localhost:55788/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55788/tests/dromaeo/cssquery-mootools.html) 09:14:00 INFO - PID 16869 | RSS: Main: 183775232 09:14:00 INFO - PID 16869 | 09:17:01 INFO - PID 16869 | Cycle 1(1): loaded http://localhost:55788/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55788/tests/dromaeo/cssquery-prototype.html) 09:17:02 INFO - PID 16869 | RSS: Main: 189083648 09:17:02 INFO - PID 16869 | 09:20:05 INFO - PID 16869 | Cycle 1(1): loaded http://localhost:55788/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55788/tests/dromaeo/cssquery-yui.html) 09:20:06 INFO - PID 16869 | RSS: Main: 187457536 09:20:06 INFO - PID 16869 | 09:23:07 INFO - PID 16869 | Cycle 1(1): loaded http://localhost:55788/tests/dromaeo/cssquery-yui.html (next: http://localhost:55788/tests/dromaeo/cssquery-dojo.html) 09:23:08 INFO - PID 16869 | RSS: Main: 185004032 09:23:08 INFO - PID 16869 | 09:23:08 INFO - PID 16869 | __start_tp_report 09:23:08 INFO - PID 16869 | _x_x_mozilla_page_load 09:23:08 INFO - PID 16869 | _x_x_mozilla_page_load_details 09:23:08 INFO - PID 16869 | |i|pagename|runs| 09:23:08 INFO - PID 16869 | |0;dojo.html;2686.489566982273;2718.320419895026;2747.258240275126;2769.349202937309;2771.6673999120094;5064.164412871872;5160.380754309479;5195.480451954802;5207.843764687056;5230.2416149658275;5185.766640501187;5197.870053248671;5254.4220135785035;5288.23320618511;5299.973500132494;4584.793684284207;4621.514740952202;4653.9761252524395;4671.205894997858;4685.3206285088645;4570.10882877839;4698.2482802751565;4737.7631118444115;4744.312074749159;4776.665633405663;4577.588017078446;4709.764511774431;4732.739699316537;4743.407074115736;4766.73782941938;4555.772211389451;4631.930521042187;4672.345871577982;4686.43762748469;4717.693349932278;4628.8148474061;4640.211164102077;4641.187792136397;4669.626429885635;4678.649101317381;5130.256112863651;5211.530962213381;5216.26972223889;5221.399539052982;5268.104422248227;5615.354234263071;5648.096304591287;5686.886262274773;5714.342850572196;5741.540676745892;5686.118651609007;5692.0608099663505;5694.373618901917;5746.913796293059;5757.740901659436;5264.184051472028;5271.998320319165;5289.497497737786;5294.179402192666;5308.840734777963;5692.260006199168;5741.62679425836;5790.913136302959;5830.912536311958;5870;5537.473939975695;5601.019821531216;5606.719664016864;5618.747156377973;5637.7181140942785;5677.318721753416;5680.318361796611;5709.22925405065;5709.3434255060365;5720.170575266563;5470.91793623096;5567.276254086943;5602;5667.518260947783;5681.687507187145;5470.425605311465;5504.394516603171;5549.38956714761;5567.276254086943;5589.776408943678;4591.403117594691;4596.6092882105395;4607.170709272363;4618.49196588375;4639.074783964685;3976.960230397659;3999.080211551301;4005.098852758106;4037.2127435149864;4055.8377664893665;4728.219843725747;4731.621470282369;4781.115493633689;4786.329913812069;4799.160146974265;5670.064439367458;5710.543811328084;5738.741756620962;5763.366029736726;5779.2775903012125;4820.975895120572;4832.251001094836;4839.2983017462275;4852.490488498657;4880.511948805162;4880.243562247857;4960.677555958851;4982.77577509013;4992.775325110379;5003.4746351633285;5276.182191760283;5335.11970524859;5377.569794416359;5378.7579558920725;5385.488378604026;5479.698616576126;5684.914726279192;5716.942830571641;5719.685417302088;5724.685142317213;5285.867853303698;5297.629165958346;5310.8141215057285;5313.043652142652;5350.277712508917;5537.446255374431;5656.095024796013;5660.37735849048;5698.943010570007;5721.628094173865;5582.553395728413;5649.265595472727;5753.942460575508;5758.856028599319;5782.884342313214;5498.780048798003;5500.80747173847;5512.283403157564;5550.666959982414;5590.496855283044;5507.586930980273;5515.448455154453;5523.475269849358;5523.558115350843;5572.665640061609;5358.919616205838;5444.945550544602;5450.964316779799;5456.42707515721;5464.1257398816;5364.034473794598;5441.782328706966;5441.863953401038;5571.303587051619;5622.5501959842295;5326.174442961347;5402.108652072521;5426.728663566885;5428.647137936022;5430.755615997211 09:23:08 INFO - PID 16869 | |1;ext.html;677.915260592426;734.3244215321904;750.0324581290135;1087.1954753482426;1090.6237348114903;32609.836950815243;33507.99476015718;33623.83188084059;33950.49074263888;34018.14954626135;35822.82088589553;35951.82024089882;36023;36133.2773344533;36377.45433818495;6686.364795344459;6875.243723190445;7014.719411223545;7176.712931482734;7197.280271972787;6660.50046246531;6728.0580718699175;6737.124173857392;6749.730010799587;6755.729770809186;6697.799066028027;6737.2925842786535;6737.764178253762;6756.662166891636;6762.797116086525;6722.462203023746;6746.055552222692;6757.189137303555;6760.628165450898;6768.255491895888;6752.426043786284;6755.1556055493065;6800.081988931481;6803.659817009179;6804.897926531106;32069.839650801598;32189.51715724266;32316.76832316773;32455.35089298201;32461.188470288194;2982.4333376658583;3021.123874076515;3029.59100521429;3036.817790932551;3048.9847550762324;24952.5009499809;25030.874845625836;25097.87451062733;25104.24687259367;25192.49615007708;2964.4219377221452;2967.2581854536365;2988.02889061056;3014.9698503014906;3027.818330900131;125353;127704;131663;142583;142787;41081.97295067647;41138.38292425616;41176.58823411787;41194;41263.174736505105;43196.3520547192;43235.13529729388;43343.78328108339;43384.56615433868;43476.565234347254;12047.33739644328;12154.75690486203;12170.513179472722;12188.57339993096;12202.38988050594;9574.186194173573;9598.712038638712;9600.567974441026;9615.51922403891;9624.03759624032;12949.417276222594;12966.795644740418;13062.869371306166;13103.27931963732;13266.142740016405;5304.177852432879;5334.333208348957;5368.4631536846;5422.349318081855;5448.482394172547;836.284976345216;872.5768002518773;890.238845786843;904.2675432899241;909.30892521684;20005.299814506714;20339.389818305473;21222;21568.784312156677;21796.128154873946;960.500539719342;972.246508955551;975.0931633580838;980.1472718734603;996.9152622027063;10508.474576271155;11095;11118.61084862026;11162.330260184415;11192.160587955936;167896.16051919662;168297;168416;168561;168764;42398.788006060386;42469;42611;42624.786876065424;42696.78651606784;1208.7038675524552;1234.938253087342;1236.8763123687559;1237.418413345726;1237.5297386993066;19446.222151113798;19881.502962426053;20743.481412964797;20987.58024839525;21105.894470528165;29707.40585188241;29757;29920.850395748752;29950.4009919796;29965.70034299629;148118;148129;149021;149094;149374;29079.7092029077;29224;29372.11883643494;30777.846110769304;30939.690603094583;37047.629523705495;37059.444108337855;37074.07314817151;37142.44286335653;37395.62604373921;26191;27965;28337.574936376383;28556.143315700563;28784.568231476125;27684.44631107407;27751.861240693666;28803.135905922856;29064;29080.765462217005;30867;31863.36273274475;31890.68109318877;32015.67984320127;32115.51826722648;27262;27427.31431714223;27470.587941181297;28233;28390.870684699144;21563.784362156177;22697.319080427613;22699.659505107767;22975.310740677807;23004.654930176395 09:23:08 INFO - PID 16869 | |2;jquery.html;410.72481437436915;417.50108620198864;421.34480882228144;434.6088520331701;443.81138016343056;13053.41259643316;17112.74330885036;17768.82231177688;17898.284068637255;17901.641967160664;18304.26782928681;18554.257829686798;18674.346397876077;18769.7184542232;18989.810101898976;5203.60972927032;5344;5431;5556.16657501374;5562.916556251659;5246.606504512158;5383.515483606475;5387.138057910735;5394.433584473632;5394.811181608645;5178.326817513718;5344.91982620259;5352.598555108363;5357.08929481989;5357.973210133944;5324.7071411072375;5425.864353391157;5429.4027656957705;5429.592780541475;5434.864128396782;4897.436794768611;4904.509549045067;4927.014597080562;4927.95072049282;4933.087378834891;21941.561168776694;22192.445188870246;22200.444988875406;22209.333719988266;22227.555448890933;1660.8588269997065;1672.6654669066236;1703.880728349016;1709.0429359558686;1713.5630414244413;14510.709785804225;14622.561323160216;14656.267186640733;14934.775978360334;15004.699906001819;2041.428400047989;2059.4027731957713;2116.0477784996815;2122.8514004019726;2148.140743702516;79957.83015144142;80802.59598701968;81063.5946820268;81150;81222;10827.67516974492;10883.292585981886;11117.888821111846;11193.608223712132;11198.608048718255;15092.471763488225;15644.452444164399;15797;15803;15818.76271855923;7466.589337586376;7540.622968851536;7670.117936437269;7683.500572462772;7710.151883292833;6921.48088893335;6993.685284162225;7051.753188638373;7129.750458734024;7154.928450715426;6858.554193977376;6955.89566156508;6970.93029069713;7077.787666370017;7105.89341159883;2056.92800751973;2087.8808009869995;2099.7270354854077;2102.4428526440506;2258.8080013198733;838.8322335532918;882.3029806452959;883.765802062454;896.950667713269;907.4555266839843;17035.318587256617;17177.914110429618;17197.57006074858;17482.475525734248;17719.55701107457;871.2115535440437;879.160401816264;887.8712586674895;888.3248730964384;905.2618971574461;9355.953220233856;9755.21958243353;9855;9866.457344846101;9997.300188986701;320715;324854;327112;327126;335090;75500;75879;76238;77259.61370193113;77474;1022.974425639365;1032.0762917189224;1046.220565678559;1052.6368402900987;1053.4664132760722;14581.489647862274;14949.103053816805;14963.326650300545;15100.39598416051;15529.84470155284;38328.42507362447;38329.80835095807;38423.615763842005;38806;39694;47148.76425617987;48228;48621.5137848617;49198.75400622974;49958.75020624873;8285.130061343472;8343.123971982854;8434.873476897728;8466.492010479391;8501.277391421798;11981.161318707607;12294.385280736105;12317.692057698629;12320.445579949102;12423.19249248832;10366.429846358222;10851.45742712877;10865.348079115278;10923.890761092287;11120.888791111985;9489.478078705737;9680.370775899544;9722.562484688347;9876.901230987598;10028.598856045968;10381.584736610452;10814.621488247874;10899.564017439214;10942.124630029419;11048.624888743108;8122.350211982909;8199.180081991992;8275.172482751677;8329.292010179202;8361.289290410383;10649.9467502662;10755.247132700635;10811.24321297533;10923.672289831318;10966.287191332538 09:23:08 INFO - PID 16869 | |3;mootools.html;1190.9166358354917;1237.1463690053863;1247.1706315300326;1250.5998080614206;1267.7527882062998;10129.645462408816;10445.634402795884;10574.418406987612;10584.259101862883;10705.892941070588;10425.5308511117;10728.302660327074;10738.516766745495;10741.785164296729;10761.677149685502;2100.611386893426;2131.9253826116087;2132.445564153316;2132.8507004509693;2141.5074532857375;1938.7479627648386;1996.0319245166156;2001.2395289789931;2012.0744457549545;2012.4063401296653;1844.271512752462;1857.8049304823003;1858.1081081081088;1861.8045105263955;1861.8417434518083;1890.2816929566814;1891.1111777464569;1895.6493048785949;1901.3060233014987;1901.5816520365497;1893.8863668179954;1971.0144927536232;1973.7631484221843;1988.0854806788896;1998.660227761284;10250;10328.79342413155;10331.845022324671;10342.482875856253;10351.896481035168;5516.255305533742;5630.831075067755;5699.515541179005;5728.79949201776;5729.28383952006;3237.838108094586;3390.5083762854497;3393.4400823864034;3416.6070901846356;3433.073070271038;1026.9332493387906;1034.7671773850898;1057.233505708363;1106.9114470842314;1137.8691450483134;15047.322870470745;15064.096154230672;15177.317020734094;15220.695586088326;15549.222538873011;4740.051989602093;4755.785989630475;4844.15227335215;4861.6353773467135;4922.655414120977;10861.402622855661;10934.359846023;10940.39827809478;10951.83572246417;10960.561577536968;5531.3362396512675;5564.499195072382;5566.304211973504;5584.162375643605;5611.270534830446;5082.085224659523;5145.665531740425;5145.9485405146215;5157.690538567698;5191.6884986900905;3833.501644786216;3924.6664033556895;3932.744371615836;4024.839006439768;4047.5547689754103;1171.3089277326249;1171.7129303320742;1182.633383651071;1190.4642910690225;1192.076140990739;674.231376231097;700.7162099349772;703.3739971425435;716.924722904098;722.0541091170584;5332.773462103738;5367.838964831061;5504.91742623861;5559.916601250984;5568.443155684399;530.5596355025319;532.6564365983996;542.9837104886859;544.5942772634334;547.5893080189858;3197.600299962505;3230.5638738769967;3276.6559511250975;3287.1453422109944;3336.632970373257;12455.252684838939;13116.934415328053;13144.145630534176;13413.93293033548;13449.193048417126;13118.344082795822;13256;13350.265735384453;13528.59414217575;13667.589972300846;6648.03603477493;7405.814854628569;7564.848703025908;7583.582902940391;7586.962065189638;5739.9139012915675;6227.844303892258;6256.593321434092;6277.74889004453;6311.589746666452;12178.025757939165;12241;12358.208059831095;12486.626471088355;12647.936760316139;11743;11831.112666550216;12372.92449581542;12505.312207828656;12555.87444125547;8388.790280243044;8624.913750862663;8643.438176518506;8644.22202001823;8647.221750042527;9263.16631503141;9763.072508111718;9769.364991275545;9835.901640983499;9836.21310295189;8134.959325203336;8245.752627421187;8274.29668478186;8294.253517183482;8702.173293537104;8022.759317220492;8235.464694794819;8327.20891515305;8327.750167494985;8434.957825210835;6804.96597517029;6954.652267386711;6961.582305061713;7008.194057683431;7020.0522929405915;4904.4605093440405;4946.851594452172;4952.588512274128;4997.750112494434;5037.697738135577;5175.948240517547;5307.071262529119;5317.282166907573;5340.465953404629;5398.352197736297 09:23:08 INFO - PID 16869 | |4;prototype.html;344.7552237911083;358.34244161962795;359.4554250310778;373.76266071044887;386.281516379534;5462.371827239864;5521.257891792536;5554.389017208104;5555.666660000393;5561.8887622247585;5379.81170659027;5414.187871819229;5427.158790387496;5454.61817672763;5478.863028424292;4014.1971605678837;4083.6528895043957;4186.39297301891;4187.539370669224;4192.559781222958;4105.568915263899;4108.26051310764;4128.525219599739;4130.421740956269;4132.834686612532;4067.6848368579663;4078.2047500737367;4080.1227736036744;4093.1199792044704;4098.569650186732;4040.333344998072;4090.550039495653;4101.446304748851;4105.958940410617;4108.342665173558;3561.9643803561894;3584.193556449778;3587.3542762302777;3588.102974256436;3599.6940260077927;5274.736263186864;5289.18017707256;5294.126469132589;5331.573474122061;5350.357957045179;4806.735629540374;4807.9038419231765;4818.132736107499;4825.20384136617;4826.662133650646;5596.076647353182;5653.717314134276;5748.856278593027;5759.280089988752;5777.740001699934;4007.1184339445276;4014.7791871447057;4017.6785857131654;4028.992751812047;4030.2745505808944;5878.29460464747;5991.430814072656;6045.727942242565;6069.848253793646;6080.361562036011;4068.6745060395097;4102.097538541576;4124.752514849119;4128.195001974586;4139.461869956886;4183.769892655872;4185.22573323936;4194.3708443733685;4206.768627725504;4232.238197124547;4679.251319788817;4784.138855006063;4843.2735089736825;4845.6608037437045;4856.41722993236;5792.652440853562;5802.390748971297;5820.30156381237;5821.332560486951;5824.213731146241;1428.8071110399962;1441.5315022617692;1443.0980637101811;1449.54339383094;1450.6808502129516;946.2950102173787;966.5360626899128;971.1114330387758;978.2272005116021;981.7349315684725;5013.523715247045;5023.14606516893;5027.4469808321055;5029.497050295015;5033.245013247969;5878.911816322759;5903.085021821625;5953.3451320354725;5956.9873121569435;5960.225170727777;4834.879128021757;4961.70229786214;4983.327250821165;4985.725785081855;4999.200127979506;3149.1497295730023;3160.7945483543494;3172.3972445235795;3179.3482336121037;3179.7456203503666;5468.781248750085;5547.861303467445;5573.749181286852;5574.777008919679;5599.496045355938;6046;6145.784897528654;6147.538934579835;6163.96918015407;6192.907106393408;5616.062458451827;5634.380218175916;5644.830655080272;5647.7176141193595;5652.434756524397;5858.5898987070495;5920.703964801829;5943.5631391131155;5964.970175149097;5969.492593129633;5798.449147330997;5836.766529338779;5857.384974577608;5857.414258574108;5904.9704751475965;5373.811916582901;5597.020521408818;5617.8033768817895;5634.4365563443325;5635.408282130481;4088.836446542105;4111.198316328288;4111.876643700693;4122.9381559277235;4134.91730165389;5872.911906321323;5977.372375900642;6038.215032045806;6051.697415129314;6060.606060606046;5785.8553536161935;5791.942080579141;5819.010768169506;5821.301443826598;5826.854328641648;5799.565032622654;5813.505852002458;5824.621399609012;5824.708764561839;5825.6795876225515;5596.38439771633;5670.376258611467;5688.260526131577;5701.543876489954;5757.91363129545;5854.151148083419;5854.5609079320075;5861.794837180678;5870.53035757147;5873.882522349614;5542.307211598551;5628.74670639814;5661.264035675501;5683.261176047087;5694.829155125353 09:23:08 INFO - PID 16869 | |5;yui.html;742.6806473216517;742.8365759532908;744.594196163091;753.86807308721;765.7664412354231;12997.480100795969;13686.657833554165;13717.451301947922;15007.774883376758;15386;15359.69280614387;15477.226138693048;15649.374025039013;15658.217089145526;15676.608084797886;870.8780770692108;888.2849306308419;890.5591732092623;892.9107089291051;893.70954439807;880.3617377401365;883.3816328570026;883.8762573239752;884.1732979664002;896.3994123936945;931.7204838548408;933.8132373525289;937.0629370629371;938.629241449627;940.6754669638964;912.3750231091724;918.9448633082036;920.8158368326361;934.654177954158;942.3686130292721;677.5900580148988;678.8913773796169;682.0587589127023;682.1609420412871;682.2427105912433;13647;13650.93174534131;13655.248961307125;13693;13781.793273100911;16366.181690915406;16559.25483353252;16882.07148606826;16919.154042297836;17025;12764.106512544126;13075.150115242574;13155.73688526224;13253.73492530144;13357.666058348523;2828.6747024092288;2835.5321371973805;2848.3875966667265;2854.957175642367;2861.6852146263896;85529.14470855275;86445.56777216136;87274;87340;87819;12594.937025314997;12658.303793291458;12751.744965100646;12872.613821585368;12905.483780648856;22902.541949161256;23665;23703.170389036302;23728.288151355486;23785.167519136747;6120.663363515049;6193.84515387119;6287.811365659038;6292.811215663537;6354.269259035178;2861.2846788302923;2918.9124326270244;2922.561615757611;2932.5747766574154;2946.5285554311636;3721.330160571123;3801.239752049601;3803.3344164771056;3807.162424266657;3816.732828701964;660.6696651674163;672.9938741581367;675.3719041291646;675.6284043775904;678.0845858091635;562.7973929385417;583.7198144890476;585.1836687820552;588.5997521685209;610.5146408605169;10313.639022634172;10635.627753028606;10733.195010374253;11027;11533.76932461346;593.3354642800092;611.2512172588544;613.4662843326334;616.5098746496546;619.7397093220858;4633.559811817872;4828.082664293773;4860.538248866352;4896.069746748107;4972.57733092684;83015;83946.58026709827;84081.06946096968;84233;84313.57843210745;71943;72918.27081729221;74690.25309746942;75113;75635;57898.842023159305;59557.40442595519;59843.700781496686;60117;67756.6612166936;9420.896355194242;10233.897661023295;10259.435731034864;10318.742031448974;10965.232433729563;26336.20991370262;26579.60130598004;26625.33436664099;27140.185794426197;28028.719712803428;33812;34080.65919340874;34218.65781342254;34747.82626086853;34791.82604086964;14063.859361406256;14292.285385730464;14332.068415552956;14536.41854325815;14538.636534086732;15908.363665453253;16064;16350.918245408697;16593.170341483117;16629.750553741946;15463.84536154624;15528.912976092017;15754.448594299145;15835.920820395824;16138;15793.447229347377;16038.839611603735;16144.1927903602;16212.35150593963;16451.67096658084;14707;14804.62988425298;14858.108513488793;14993.2503374833;15033.849661503682;10870.891291086988;10948.781024379627;11235.213535052468;11325.263857849213;11792.23350482216;10896.727581810519;11099.500522476346;11734.354610496162;11769.117316201147;11842.348670823187 09:23:08 INFO - PID 16869 | __end_tp_report 09:23:08 INFO - PID 16869 | __start_cc_report 09:23:08 INFO - PID 16869 | _x_x_mozilla_cycle_collect,391 09:23:08 INFO - PID 16869 | __end_cc_report 09:23:08 INFO - PID 16869 | __startTimestamp1496161388081__endTimestamp 09:23:08 INFO - PID 16869 | 09:23:08 INFO - PID 16869 | ------- Summary: start ------- 09:23:08 INFO - PID 16869 | Number of tests: 6 09:23:08 INFO - PID 16869 | 09:23:08 INFO - PID 16869 | [#0] dojo.html Cycles:165 Average:5170.64 Median:5350.28 stddev:618.71 (11.6%) stddev-sans-first:589.12 09:23:08 INFO - PID 16869 | Values: 2686.5 2718.3 2747.3 2769.3 2771.7 5064.2 5160.4 5195.5 5207.8 5230.2 5185.8 5197.9 5254.4 5288.2 5300.0 4584.8 4621.5 4654.0 4671.2 4685.3 4570.1 4698.2 4737.8 4744.3 4776.7 4577.6 4709.8 4732.7 4743.4 4766.7 4555.8 4631.9 4672.3 4686.4 4717.7 4628.8 4640.2 4641.2 4669.6 4678.6 5130.3 5211.5 5216.3 5221.4 5268.1 5615.4 5648.1 5686.9 5714.3 5741.5 5686.1 5692.1 5694.4 5746.9 5757.7 5264.2 5272.0 5289.5 5294.2 5308.8 5692.3 5741.6 5790.9 5830.9 5870.0 5537.5 5601.0 5606.7 5618.7 5637.7 5677.3 5680.3 5709.2 5709.3 5720.2 5470.9 5567.3 5602.0 5667.5 5681.7 5470.4 5504.4 5549.4 5567.3 5589.8 4591.4 4596.6 4607.2 4618.5 4639.1 3977.0 3999.1 4005.1 4037.2 4055.8 4728.2 4731.6 4781.1 4786.3 4799.2 5670.1 5710.5 5738.7 5763.4 5779.3 4821.0 4832.3 4839.3 4852.5 4880.5 4880.2 4960.7 4982.8 4992.8 5003.5 5276.2 5335.1 5377.6 5378.8 5385.5 5479.7 5684.9 5716.9 5719.7 5724.7 5285.9 5297.6 5310.8 5313.0 5350.3 5537.4 5656.1 5660.4 5698.9 5721.6 5582.6 5649.3 5753.9 5758.9 5782.9 5498.8 5500.8 5512.3 5550.7 5590.5 5507.6 5515.4 5523.5 5523.6 5572.7 5358.9 5444.9 5451.0 5456.4 5464.1 5364.0 5441.8 5441.9 5571.3 5622.6 5326.2 5402.1 5426.7 5428.6 5430.8 09:23:08 INFO - PID 16869 | 09:23:08 INFO - PID 16869 | [#1] ext.html Cycles:180 Average:29922.47 Median:30822.42 stddev:39004.93 (126.5%) stddev-sans-first:39052.53 09:23:08 INFO - PID 16869 | Values: 677.9 734.3 750.0 1087.2 1090.6 32609.8 33508.0 33623.8 33950.5 34018.1 35822.8 35951.8 36023.0 36133.3 36377.5 6686.4 6875.2 7014.7 7176.7 7197.3 6660.5 6728.1 6737.1 6749.7 6755.7 6697.8 6737.3 6737.8 6756.7 6762.8 6722.5 6746.1 6757.2 6760.6 6768.3 6752.4 6755.2 6800.1 6803.7 6804.9 32069.8 32189.5 32316.8 32455.4 32461.2 2982.4 3021.1 3029.6 3036.8 3049.0 24952.5 25030.9 25097.9 25104.2 25192.5 2964.4 2967.3 2988.0 3015.0 3027.8 125353.0 127704.0 131663.0 142583.0 142787.0 41082.0 41138.4 41176.6 41194.0 41263.2 43196.4 43235.1 43343.8 43384.6 43476.6 12047.3 12154.8 12170.5 12188.6 12202.4 9574.2 9598.7 9600.6 9615.5 9624.0 12949.4 12966.8 13062.9 13103.3 13266.1 5304.2 5334.3 5368.5 5422.3 5448.5 836.3 872.6 890.2 904.3 909.3 20005.3 20339.4 21222.0 21568.8 21796.1 960.5 972.2 975.1 980.1 996.9 10508.5 11095.0 11118.6 11162.3 11192.2 167896.2 168297.0 168416.0 168561.0 168764.0 42398.8 42469.0 42611.0 42624.8 42696.8 1208.7 1234.9 1236.9 1237.4 1237.5 19446.2 19881.5 20743.5 20987.6 21105.9 29707.4 29757.0 29920.9 29950.4 29965.7 148118.0 148129.0 149021.0 149094.0 149374.0 29079.7 29224.0 29372.1 30777.8 30939.7 37047.6 37059.4 37074.1 37142.4 37395.6 26191.0 27965.0 28337.6 28556.1 28784.6 27684.4 27751.9 28803.1 29064.0 29080.8 30867.0 31863.4 31890.7 32015.7 32115.5 27262.0 27427.3 27470.6 28233.0 28390.9 21563.8 22697.3 22699.7 22975.3 23004.7 09:23:08 INFO - PID 16869 | 09:23:08 INFO - PID 16869 | [#2] jquery.html Cycles:180 Average:23364.32 Median:20052.36 stddev:54647.00 (272.5%) stddev-sans-first:54773.12 09:23:08 INFO - PID 16869 | Values: 410.7 417.5 421.3 434.6 443.8 13053.4 17112.7 17768.8 17898.3 17901.6 18304.3 18554.3 18674.3 18769.7 18989.8 5203.6 5344.0 5431.0 5556.2 5562.9 5246.6 5383.5 5387.1 5394.4 5394.8 5178.3 5344.9 5352.6 5357.1 5358.0 5324.7 5425.9 5429.4 5429.6 5434.9 4897.4 4904.5 4927.0 4928.0 4933.1 21941.6 22192.4 22200.4 22209.3 22227.6 1660.9 1672.7 1703.9 1709.0 1713.6 14510.7 14622.6 14656.3 14934.8 15004.7 2041.4 2059.4 2116.0 2122.9 2148.1 79957.8 80802.6 81063.6 81150.0 81222.0 10827.7 10883.3 11117.9 11193.6 11198.6 15092.5 15644.5 15797.0 15803.0 15818.8 7466.6 7540.6 7670.1 7683.5 7710.2 6921.5 6993.7 7051.8 7129.8 7154.9 6858.6 6955.9 6970.9 7077.8 7105.9 2056.9 2087.9 2099.7 2102.4 2258.8 838.8 882.3 883.8 897.0 907.5 17035.3 17177.9 17197.6 17482.5 17719.6 871.2 879.2 887.9 888.3 905.3 9356.0 9755.2 9855.0 9866.5 9997.3 320715.0 324854.0 327112.0 327126.0 335090.0 75500.0 75879.0 76238.0 77259.6 77474.0 1023.0 1032.1 1046.2 1052.6 1053.5 14581.5 14949.1 14963.3 15100.4 15529.8 38328.4 38329.8 38423.6 38806.0 39694.0 47148.8 48228.0 48621.5 49198.8 49958.8 8285.1 8343.1 8434.9 8466.5 8501.3 11981.2 12294.4 12317.7 12320.4 12423.2 10366.4 10851.5 10865.3 10923.9 11120.9 9489.5 9680.4 9722.6 9876.9 10028.6 10381.6 10814.6 10899.6 10942.1 11048.6 8122.4 8199.2 8275.2 8329.3 8361.3 10649.9 10755.2 10811.2 10923.7 10966.3 09:23:08 INFO - PID 16869 | 09:23:08 INFO - PID 16869 | [#3] mootools.html Cycles:180 Average:6282.73 Median:3363.57 stddev:4154.75 (123.5%) stddev-sans-first:4148.79 09:23:08 INFO - PID 16869 | Values: 1190.9 1237.1 1247.2 1250.6 1267.8 10129.6 10445.6 10574.4 10584.3 10705.9 10425.5 10728.3 10738.5 10741.8 10761.7 2100.6 2131.9 2132.4 2132.9 2141.5 1938.7 1996.0 2001.2 2012.1 2012.4 1844.3 1857.8 1858.1 1861.8 1861.8 1890.3 1891.1 1895.6 1901.3 1901.6 1893.9 1971.0 1973.8 1988.1 1998.7 10250.0 10328.8 10331.8 10342.5 10351.9 5516.3 5630.8 5699.5 5728.8 5729.3 3237.8 3390.5 3393.4 3416.6 3433.1 1026.9 1034.8 1057.2 1106.9 1137.9 15047.3 15064.1 15177.3 15220.7 15549.2 4740.1 4755.8 4844.2 4861.6 4922.7 10861.4 10934.4 10940.4 10951.8 10960.6 5531.3 5564.5 5566.3 5584.2 5611.3 5082.1 5145.7 5145.9 5157.7 5191.7 3833.5 3924.7 3932.7 4024.8 4047.6 1171.3 1171.7 1182.6 1190.5 1192.1 674.2 700.7 703.4 716.9 722.1 5332.8 5367.8 5504.9 5559.9 5568.4 530.6 532.7 543.0 544.6 547.6 3197.6 3230.6 3276.7 3287.1 3336.6 12455.3 13116.9 13144.1 13413.9 13449.2 13118.3 13256.0 13350.3 13528.6 13667.6 6648.0 7405.8 7564.8 7583.6 7587.0 5739.9 6227.8 6256.6 6277.7 6311.6 12178.0 12241.0 12358.2 12486.6 12647.9 11743.0 11831.1 12372.9 12505.3 12555.9 8388.8 8624.9 8643.4 8644.2 8647.2 9263.2 9763.1 9769.4 9835.9 9836.2 8135.0 8245.8 8274.3 8294.3 8702.2 8022.8 8235.5 8327.2 8327.8 8435.0 6805.0 6954.7 6961.6 7008.2 7020.1 4904.5 4946.9 4952.6 4997.8 5037.7 5175.9 5307.1 5317.3 5340.5 5398.4 09:23:08 INFO - PID 16869 | 09:23:08 INFO - PID 16869 | [#4] prototype.html Cycles:180 Average:4756.46 Median:5465.58 stddev:1414.31 (25.9%) stddev-sans-first:1378.97 09:23:08 INFO - PID 16869 | Values: 344.8 358.3 359.5 373.8 386.3 5462.4 5521.3 5554.4 5555.7 5561.9 5379.8 5414.2 5427.2 5454.6 5478.9 4014.2 4083.7 4186.4 4187.5 4192.6 4105.6 4108.3 4128.5 4130.4 4132.8 4067.7 4078.2 4080.1 4093.1 4098.6 4040.3 4090.6 4101.4 4106.0 4108.3 3562.0 3584.2 3587.4 3588.1 3599.7 5274.7 5289.2 5294.1 5331.6 5350.4 4806.7 4807.9 4818.1 4825.2 4826.7 5596.1 5653.7 5748.9 5759.3 5777.7 4007.1 4014.8 4017.7 4029.0 4030.3 5878.3 5991.4 6045.7 6069.8 6080.4 4068.7 4102.1 4124.8 4128.2 4139.5 4183.8 4185.2 4194.4 4206.8 4232.2 4679.3 4784.1 4843.3 4845.7 4856.4 5792.7 5802.4 5820.3 5821.3 5824.2 1428.8 1441.5 1443.1 1449.5 1450.7 946.3 966.5 971.1 978.2 981.7 5013.5 5023.1 5027.4 5029.5 5033.2 5878.9 5903.1 5953.3 5957.0 5960.2 4834.9 4961.7 4983.3 4985.7 4999.2 3149.1 3160.8 3172.4 3179.3 3179.7 5468.8 5547.9 5573.7 5574.8 5599.5 6046.0 6145.8 6147.5 6164.0 6192.9 5616.1 5634.4 5644.8 5647.7 5652.4 5858.6 5920.7 5943.6 5965.0 5969.5 5798.4 5836.8 5857.4 5857.4 5905.0 5373.8 5597.0 5617.8 5634.4 5635.4 4088.8 4111.2 4111.9 4122.9 4134.9 5872.9 5977.4 6038.2 6051.7 6060.6 5785.9 5791.9 5819.0 5821.3 5826.9 5799.6 5813.5 5824.6 5824.7 5825.7 5596.4 5670.4 5688.3 5701.5 5757.9 5854.2 5854.6 5861.8 5870.5 5873.9 5542.3 5628.7 5661.3 5683.3 5694.8 09:23:08 INFO - PID 16869 | 09:23:08 INFO - PID 16869 | [#5] yui.html Cycles:180 Average:17376.12 Median:2920.74 stddev:22691.70 (776.9%) stddev-sans-first:22720.98 09:23:08 INFO - PID 16869 | Values: 742.7 742.8 744.6 753.9 765.8 12997.5 13686.7 13717.5 15007.8 15386.0 15359.7 15477.2 15649.4 15658.2 15676.6 870.9 888.3 890.6 892.9 893.7 880.4 883.4 883.9 884.2 896.4 931.7 933.8 937.1 938.6 940.7 912.4 918.9 920.8 934.7 942.4 677.6 678.9 682.1 682.2 682.2 13647.0 13650.9 13655.2 13693.0 13781.8 16366.2 16559.3 16882.1 16919.2 17025.0 12764.1 13075.2 13155.7 13253.7 13357.7 2828.7 2835.5 2848.4 2855.0 2861.7 85529.1 86445.6 87274.0 87340.0 87819.0 12594.9 12658.3 12751.7 12872.6 12905.5 22902.5 23665.0 23703.2 23728.3 23785.2 6120.7 6193.8 6287.8 6292.8 6354.3 2861.3 2918.9 2922.6 2932.6 2946.5 3721.3 3801.2 3803.3 3807.2 3816.7 660.7 673.0 675.4 675.6 678.1 562.8 583.7 585.2 588.6 610.5 10313.6 10635.6 10733.2 11027.0 11533.8 593.3 611.3 613.5 616.5 619.7 4633.6 4828.1 4860.5 4896.1 4972.6 83015.0 83946.6 84081.1 84233.0 84313.6 71943.0 72918.3 74690.3 75113.0 75635.0 57898.8 59557.4 59843.7 60117.0 67756.7 9420.9 10233.9 10259.4 10318.7 10965.2 26336.2 26579.6 26625.3 27140.2 28028.7 33812.0 34080.7 34218.7 34747.8 34791.8 14063.9 14292.3 14332.1 14536.4 14538.6 15908.4 16064.0 16350.9 16593.2 16629.8 15463.8 15528.9 15754.4 15835.9 16138.0 15793.4 16038.8 16144.2 16212.4 16451.7 14707.0 14804.6 14858.1 14993.3 15033.8 10870.9 10948.8 11235.2 11325.3 11792.2 10896.7 11099.5 11734.4 11769.1 11842.3 09:23:08 INFO - PID 16869 | -------- Summary: end -------- 09:23:08 INFO - PID 16869 | 09:23:08 INFO - TEST-INFO | 16869: exit 0 09:23:08 INFO - TEST-OK | dromaeo_css | took 1147850ms 09:23:08 INFO - TEST-START | kraken 09:23:08 INFO - operating with platform_type : linux_ 09:23:08 INFO - Initialising browser for kraken test... 09:23:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55788/getInfo.html -profile /tmp/tmpOXBZAM/profile 09:23:08 INFO - TEST-INFO | started process 17293 (/builds/slave/test/build/application/firefox/firefox http://localhost:55788/getInfo.html) 09:23:43 INFO - TEST-INFO | 17293: killed by SIGTERM 09:23:44 INFO - Browser initialized. 09:23:44 INFO - Running cycle 1/1 for kraken test... 09:23:44 INFO - TEST-INFO | started process 17516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOXBZAM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:23:56 INFO - PID 17516 | RSS: Main: 186646528 09:23:56 INFO - PID 17516 | 09:23:58 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55788/tests/kraken/driver.html?testName=audio-beat-detection) 09:23:59 INFO - PID 17516 | RSS: Main: 189517824 09:23:59 INFO - PID 17516 | 09:24:02 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55788/tests/kraken/driver.html?testName=audio-dft) 09:24:03 INFO - PID 17516 | RSS: Main: 188526592 09:24:03 INFO - PID 17516 | 09:24:06 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55788/tests/kraken/driver.html?testName=audio-fft) 09:24:06 INFO - PID 17516 | RSS: Main: 185552896 09:24:06 INFO - PID 17516 | 09:24:08 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55788/tests/kraken/driver.html?testName=audio-oscillator) 09:24:09 INFO - PID 17516 | RSS: Main: 185962496 09:24:09 INFO - PID 17516 | 09:24:11 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55788/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:12 INFO - PID 17516 | RSS: Main: 185946112 09:24:12 INFO - PID 17516 | 09:24:15 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55788/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:16 INFO - PID 17516 | RSS: Main: 190390272 09:24:16 INFO - PID 17516 | 09:24:19 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55788/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:20 INFO - PID 17516 | RSS: Main: 186191872 09:24:20 INFO - PID 17516 | 09:24:23 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55788/tests/kraken/driver.html?testName=json-parse-financial) 09:24:23 INFO - PID 17516 | RSS: Main: 186933248 09:24:23 INFO - PID 17516 | 09:24:25 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55788/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:26 INFO - PID 17516 | RSS: Main: 187101184 09:24:26 INFO - PID 17516 | 09:24:28 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:24:28 INFO - PID 17516 | RSS: Main: 186761216 09:24:28 INFO - PID 17516 | 09:24:30 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:24:31 INFO - PID 17516 | RSS: Main: 186982400 09:24:31 INFO - PID 17516 | 09:24:34 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:24:35 INFO - PID 17516 | RSS: Main: 187072512 09:24:35 INFO - PID 17516 | 09:24:38 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:24:38 INFO - PID 17516 | RSS: Main: 186609664 09:24:38 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | Cycle 1(1): loaded http://localhost:55788/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55788/tests/kraken/driver.html?testName=ai-astar) 09:24:40 INFO - PID 17516 | RSS: Main: 188108800 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | __start_tp_report 09:24:40 INFO - PID 17516 | _x_x_mozilla_page_load 09:24:40 INFO - PID 17516 | _x_x_mozilla_page_load_details 09:24:40 INFO - PID 17516 | |i|pagename|runs| 09:24:40 INFO - PID 17516 | |0;ai-astar;104;115;114;111;110;110;113;111;111;112 09:24:40 INFO - PID 17516 | |1;audio-beat-detection;150;124;123;166;126;124;125;123;155;123 09:24:40 INFO - PID 17516 | |2;audio-dft;165;164;166;185;169;171;164;165;163;162 09:24:40 INFO - PID 17516 | |3;audio-fft;73;74;74;117;75;74;75;74;93;74 09:24:40 INFO - PID 17516 | |4;audio-oscillator;85;86;109;84;84;83;97;83;93;110 09:24:40 INFO - PID 17516 | |5;imaging-gaussian-blur;118;119;116;114;114;114;114;114;118;115 09:24:40 INFO - PID 17516 | |6;imaging-darkroom;152;150;150;150;151;151;150;152;150;150 09:24:40 INFO - PID 17516 | |7;imaging-desaturate;96;95;94;94;95;94;94;94;95;94 09:24:40 INFO - PID 17516 | |8;json-parse-financial;56;56;56;56;56;60;57;58;57;57 09:24:40 INFO - PID 17516 | |9;json-stringify-tinderbox;57;56;56;57;58;57;59;57;57;59 09:24:40 INFO - PID 17516 | |10;stanford-crypto-aes;89;89;88;87;87;86;88;88;115;88 09:24:40 INFO - PID 17516 | |11;stanford-crypto-ccm;136;135;134;138;134;133;132;142;136;135 09:24:40 INFO - PID 17516 | |12;stanford-crypto-pbkdf2;183;194;191;195;190;196;186;192;183;199 09:24:40 INFO - PID 17516 | |13;stanford-crypto-sha256-iterative;78;73;77;79;74;72;73;76;73;76 09:24:40 INFO - PID 17516 | __end_tp_report 09:24:40 INFO - PID 17516 | __start_cc_report 09:24:40 INFO - PID 17516 | _x_x_mozilla_cycle_collect,1025 09:24:40 INFO - PID 17516 | __end_cc_report 09:24:40 INFO - PID 17516 | __startTimestamp1496161480943__endTimestamp 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | ------- Summary: start ------- 09:24:40 INFO - PID 17516 | Number of tests: 14 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.50 stddev:3.00 (2.7%) stddev-sans-first:1.76 09:24:40 INFO - PID 17516 | Values: 104.0 115.0 114.0 111.0 110.0 110.0 113.0 111.0 111.0 112.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:125.50 stddev:16.43 (13.1%) stddev-sans-first:16.36 09:24:40 INFO - PID 17516 | Values: 150.0 124.0 123.0 166.0 126.0 124.0 125.0 123.0 155.0 123.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#2] audio-dft Cycles:10 Average:167.40 Median:165.50 stddev:6.75 (4.1%) stddev-sans-first:7.11 09:24:40 INFO - PID 17516 | Values: 165.0 164.0 166.0 185.0 169.0 171.0 164.0 165.0 163.0 162.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#3] audio-fft Cycles:10 Average:80.30 Median:74.00 stddev:14.21 (19.2%) stddev-sans-first:14.82 09:24:40 INFO - PID 17516 | Values: 73.0 74.0 74.0 117.0 75.0 74.0 75.0 74.0 93.0 74.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:84.50 stddev:10.60 (12.5%) stddev-sans-first:10.98 09:24:40 INFO - PID 17516 | Values: 85.0 86.0 109.0 84.0 84.0 83.0 97.0 83.0 93.0 110.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.50 stddev:2.01 (1.7%) stddev-sans-first:1.94 09:24:40 INFO - PID 17516 | Values: 118.0 119.0 116.0 114.0 114.0 114.0 114.0 114.0 118.0 115.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 09:24:40 INFO - PID 17516 | Values: 152.0 150.0 150.0 150.0 151.0 151.0 150.0 152.0 150.0 150.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.50 09:24:40 INFO - PID 17516 | Values: 96.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:1.29 (2.3%) stddev-sans-first:1.32 09:24:40 INFO - PID 17516 | Values: 56.0 56.0 56.0 56.0 56.0 60.0 57.0 58.0 57.0 57.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:57.00 stddev:1.06 (1.9%) stddev-sans-first:1.12 09:24:40 INFO - PID 17516 | Values: 57.0 56.0 56.0 57.0 58.0 57.0 59.0 57.0 57.0 59.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:88.00 stddev:8.66 (9.8%) stddev-sans-first:9.17 09:24:40 INFO - PID 17516 | Values: 89.0 89.0 88.0 87.0 87.0 86.0 88.0 88.0 115.0 88.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:135.50 stddev:2.84 (2.1%) stddev-sans-first:3.00 09:24:40 INFO - PID 17516 | Values: 136.0 135.0 134.0 138.0 134.0 133.0 132.0 142.0 136.0 135.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.90 Median:193.00 stddev:5.47 (2.8%) stddev-sans-first:4.99 09:24:40 INFO - PID 17516 | Values: 183.0 194.0 191.0 195.0 190.0 196.0 186.0 192.0 183.0 199.0 09:24:40 INFO - PID 17516 | 09:24:40 INFO - PID 17516 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:76.00 stddev:2.42 (3.2%) stddev-sans-first:2.33 09:24:40 INFO - PID 17516 | Values: 78.0 73.0 77.0 79.0 74.0 72.0 73.0 76.0 73.0 76.0 09:24:40 INFO - PID 17516 | -------- Summary: end -------- 09:24:40 INFO - PID 17516 | 09:24:42 INFO - TEST-INFO | 17516: exit 0 09:24:42 INFO - TEST-OK | kraken | took 93260ms 09:24:42 INFO - SUITE-END | took 1241s 09:24:42 INFO - Completed test suite (00:20:41) 09:24:42 INFO - javascript benchmark 09:24:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6723.068498472698, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.489566982273, 2718.320419895026, 2747.258240275126, 2769.349202937309, 2771.6673999120094, 5064.164412871872, 5160.380754309479, 5195.480451954802, 5207.843764687056, 5230.2416149658275, 5185.766640501187, 5197.870053248671, 5254.4220135785035, 5288.23320618511, 5299.973500132494, 4584.793684284207, 4621.514740952202, 4653.9761252524395, 4671.205894997858, 4685.3206285088645, 4570.10882877839, 4698.2482802751565, 4737.7631118444115, 4744.312074749159, 4776.665633405663, 4577.588017078446, 4709.764511774431, 4732.739699316537, 4743.407074115736, 4766.73782941938, 4555.772211389451, 4631.930521042187, 4672.345871577982, 4686.43762748469, 4717.693349932278, 4628.8148474061, 4640.211164102077, 4641.187792136397, 4669.626429885635, 4678.649101317381, 5130.256112863651, 5211.530962213381, 5216.26972223889, 5221.399539052982, 5268.104422248227, 5615.354234263071, 5648.096304591287, 5686.886262274773, 5714.342850572196, 5741.540676745892, 5686.118651609007, 5692.0608099663505, 5694.373618901917, 5746.913796293059, 5757.740901659436, 5264.184051472028, 5271.998320319165, 5289.497497737786, 5294.179402192666, 5308.840734777963, 5692.260006199168, 5741.62679425836, 5790.913136302959, 5830.912536311958, 5870.0, 5537.473939975695, 5601.019821531216, 5606.719664016864, 5618.747156377973, 5637.7181140942785, 5677.318721753416, 5680.318361796611, 5709.22925405065, 5709.3434255060365, 5720.170575266563, 5470.91793623096, 5567.276254086943, 5602.0, 5667.518260947783, 5681.687507187145, 5470.425605311465, 5504.394516603171, 5549.38956714761, 5567.276254086943, 5589.776408943678, 4591.403117594691, 4596.6092882105395, 4607.170709272363, 4618.49196588375, 4639.074783964685, 3976.960230397659, 3999.080211551301, 4005.098852758106, 4037.2127435149864, 4055.8377664893665, 4728.219843725747, 4731.621470282369, 4781.115493633689, 4786.329913812069, 4799.160146974265, 5670.064439367458, 5710.543811328084, 5738.741756620962, 5763.366029736726, 5779.2775903012125, 4820.975895120572, 4832.251001094836, 4839.2983017462275, 4852.490488498657, 4880.511948805162, 4880.243562247857, 4960.677555958851, 4982.77577509013, 4992.775325110379, 5003.4746351633285, 5276.182191760283, 5335.11970524859, 5377.569794416359, 5378.7579558920725, 5385.488378604026, 5479.698616576126, 5684.914726279192, 5716.942830571641, 5719.685417302088, 5724.685142317213, 5285.867853303698, 5297.629165958346, 5310.8141215057285, 5313.043652142652, 5350.277712508917, 5537.446255374431, 5656.095024796013, 5660.37735849048, 5698.943010570007, 5721.628094173865, 5582.553395728413, 5649.265595472727, 5753.942460575508, 5758.856028599319, 5782.884342313214, 5498.780048798003, 5500.80747173847, 5512.283403157564, 5550.666959982414, 5590.496855283044, 5507.586930980273, 5515.448455154453, 5523.475269849358, 5523.558115350843, 5572.665640061609, 5358.919616205838, 5444.945550544602, 5450.964316779799, 5456.42707515721, 5464.1257398816, 5364.034473794598, 5441.782328706966, 5441.863953401038, 5571.303587051619, 5622.5501959842295, 5326.174442961347, 5402.108652072521, 5426.728663566885, 5428.647137936022, 5430.755615997211], "value": 5125.232089377216, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.915260592426, 734.3244215321904, 750.0324581290135, 1087.1954753482426, 1090.6237348114903, 32609.836950815243, 33507.99476015718, 33623.83188084059, 33950.49074263888, 34018.14954626135, 35822.82088589553, 35951.82024089882, 36023.0, 36133.2773344533, 36377.45433818495, 6686.364795344459, 6875.243723190445, 7014.719411223545, 7176.712931482734, 7197.280271972787, 6660.50046246531, 6728.0580718699175, 6737.124173857392, 6749.730010799587, 6755.729770809186, 6697.799066028027, 6737.2925842786535, 6737.764178253762, 6756.662166891636, 6762.797116086525, 6722.462203023746, 6746.055552222692, 6757.189137303555, 6760.628165450898, 6768.255491895888, 6752.426043786284, 6755.1556055493065, 6800.081988931481, 6803.659817009179, 6804.897926531106, 32069.839650801598, 32189.51715724266, 32316.76832316773, 32455.35089298201, 32461.188470288194, 2982.4333376658583, 3021.123874076515, 3029.59100521429, 3036.817790932551, 3048.9847550762324, 24952.5009499809, 25030.874845625836, 25097.87451062733, 25104.24687259367, 25192.49615007708, 2964.4219377221452, 2967.2581854536365, 2988.02889061056, 3014.9698503014906, 3027.818330900131, 125353.0, 127704.0, 131663.0, 142583.0, 142787.0, 41081.97295067647, 41138.38292425616, 41176.58823411787, 41194.0, 41263.174736505105, 43196.3520547192, 43235.13529729388, 43343.78328108339, 43384.56615433868, 43476.565234347254, 12047.33739644328, 12154.75690486203, 12170.513179472722, 12188.57339993096, 12202.38988050594, 9574.186194173573, 9598.712038638712, 9600.567974441026, 9615.51922403891, 9624.03759624032, 12949.417276222594, 12966.795644740418, 13062.869371306166, 13103.27931963732, 13266.142740016405, 5304.177852432879, 5334.333208348957, 5368.4631536846, 5422.349318081855, 5448.482394172547, 836.284976345216, 872.5768002518773, 890.238845786843, 904.2675432899241, 909.30892521684, 20005.299814506714, 20339.389818305473, 21222.0, 21568.784312156677, 21796.128154873946, 960.500539719342, 972.246508955551, 975.0931633580838, 980.1472718734603, 996.9152622027063, 10508.474576271155, 11095.0, 11118.61084862026, 11162.330260184415, 11192.160587955936, 167896.16051919662, 168297.0, 168416.0, 168561.0, 168764.0, 42398.788006060386, 42469.0, 42611.0, 42624.786876065424, 42696.78651606784, 1208.7038675524552, 1234.938253087342, 1236.8763123687559, 1237.418413345726, 1237.5297386993066, 19446.222151113798, 19881.502962426053, 20743.481412964797, 20987.58024839525, 21105.894470528165, 29707.40585188241, 29757.0, 29920.850395748752, 29950.4009919796, 29965.70034299629, 148118.0, 148129.0, 149021.0, 149094.0, 149374.0, 29079.7092029077, 29224.0, 29372.11883643494, 30777.846110769304, 30939.690603094583, 37047.629523705495, 37059.444108337855, 37074.07314817151, 37142.44286335653, 37395.62604373921, 26191.0, 27965.0, 28337.574936376383, 28556.143315700563, 28784.568231476125, 27684.44631107407, 27751.861240693666, 28803.135905922856, 29064.0, 29080.765462217005, 30867.0, 31863.36273274475, 31890.68109318877, 32015.67984320127, 32115.51826722648, 27262.0, 27427.31431714223, 27470.587941181297, 28233.0, 28390.870684699144, 21563.784362156177, 22697.319080427613, 22699.659505107767, 22975.310740677807, 23004.654930176395], "value": 14482.421111392789, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.72481437436915, 417.50108620198864, 421.34480882228144, 434.6088520331701, 443.81138016343056, 13053.41259643316, 17112.74330885036, 17768.82231177688, 17898.284068637255, 17901.641967160664, 18304.26782928681, 18554.257829686798, 18674.346397876077, 18769.7184542232, 18989.810101898976, 5203.60972927032, 5344.0, 5431.0, 5556.16657501374, 5562.916556251659, 5246.606504512158, 5383.515483606475, 5387.138057910735, 5394.433584473632, 5394.811181608645, 5178.326817513718, 5344.91982620259, 5352.598555108363, 5357.08929481989, 5357.973210133944, 5324.7071411072375, 5425.864353391157, 5429.4027656957705, 5429.592780541475, 5434.864128396782, 4897.436794768611, 4904.509549045067, 4927.014597080562, 4927.95072049282, 4933.087378834891, 21941.561168776694, 22192.445188870246, 22200.444988875406, 22209.333719988266, 22227.555448890933, 1660.8588269997065, 1672.6654669066236, 1703.880728349016, 1709.0429359558686, 1713.5630414244413, 14510.709785804225, 14622.561323160216, 14656.267186640733, 14934.775978360334, 15004.699906001819, 2041.428400047989, 2059.4027731957713, 2116.0477784996815, 2122.8514004019726, 2148.140743702516, 79957.83015144142, 80802.59598701968, 81063.5946820268, 81150.0, 81222.0, 10827.67516974492, 10883.292585981886, 11117.888821111846, 11193.608223712132, 11198.608048718255, 15092.471763488225, 15644.452444164399, 15797.0, 15803.0, 15818.76271855923, 7466.589337586376, 7540.622968851536, 7670.117936437269, 7683.500572462772, 7710.151883292833, 6921.48088893335, 6993.685284162225, 7051.753188638373, 7129.750458734024, 7154.928450715426, 6858.554193977376, 6955.89566156508, 6970.93029069713, 7077.787666370017, 7105.89341159883, 2056.92800751973, 2087.8808009869995, 2099.7270354854077, 2102.4428526440506, 2258.8080013198733, 838.8322335532918, 882.3029806452959, 883.765802062454, 896.950667713269, 907.4555266839843, 17035.318587256617, 17177.914110429618, 17197.57006074858, 17482.475525734248, 17719.55701107457, 871.2115535440437, 879.160401816264, 887.8712586674895, 888.3248730964384, 905.2618971574461, 9355.953220233856, 9755.21958243353, 9855.0, 9866.457344846101, 9997.300188986701, 320715.0, 324854.0, 327112.0, 327126.0, 335090.0, 75500.0, 75879.0, 76238.0, 77259.61370193113, 77474.0, 1022.974425639365, 1032.0762917189224, 1046.220565678559, 1052.6368402900987, 1053.4664132760722, 14581.489647862274, 14949.103053816805, 14963.326650300545, 15100.39598416051, 15529.84470155284, 38328.42507362447, 38329.80835095807, 38423.615763842005, 38806.0, 39694.0, 47148.76425617987, 48228.0, 48621.5137848617, 49198.75400622974, 49958.75020624873, 8285.130061343472, 8343.123971982854, 8434.873476897728, 8466.492010479391, 8501.277391421798, 11981.161318707607, 12294.385280736105, 12317.692057698629, 12320.445579949102, 12423.19249248832, 10366.429846358222, 10851.45742712877, 10865.348079115278, 10923.890761092287, 11120.888791111985, 9489.478078705737, 9680.370775899544, 9722.562484688347, 9876.901230987598, 10028.598856045968, 10381.584736610452, 10814.621488247874, 10899.564017439214, 10942.124630029419, 11048.624888743108, 8122.350211982909, 8199.180081991992, 8275.172482751677, 8329.292010179202, 8361.289290410383, 10649.9467502662, 10755.247132700635, 10811.24321297533, 10923.672289831318, 10966.287191332538], "value": 8721.56641091979, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1190.9166358354917, 1237.1463690053863, 1247.1706315300326, 1250.5998080614206, 1267.7527882062998, 10129.645462408816, 10445.634402795884, 10574.418406987612, 10584.259101862883, 10705.892941070588, 10425.5308511117, 10728.302660327074, 10738.516766745495, 10741.785164296729, 10761.677149685502, 2100.611386893426, 2131.9253826116087, 2132.445564153316, 2132.8507004509693, 2141.5074532857375, 1938.7479627648386, 1996.0319245166156, 2001.2395289789931, 2012.0744457549545, 2012.4063401296653, 1844.271512752462, 1857.8049304823003, 1858.1081081081088, 1861.8045105263955, 1861.8417434518083, 1890.2816929566814, 1891.1111777464569, 1895.6493048785949, 1901.3060233014987, 1901.5816520365497, 1893.8863668179954, 1971.0144927536232, 1973.7631484221843, 1988.0854806788896, 1998.660227761284, 10250.0, 10328.79342413155, 10331.845022324671, 10342.482875856253, 10351.896481035168, 5516.255305533742, 5630.831075067755, 5699.515541179005, 5728.79949201776, 5729.28383952006, 3237.838108094586, 3390.5083762854497, 3393.4400823864034, 3416.6070901846356, 3433.073070271038, 1026.9332493387906, 1034.7671773850898, 1057.233505708363, 1106.9114470842314, 1137.8691450483134, 15047.322870470745, 15064.096154230672, 15177.317020734094, 15220.695586088326, 15549.222538873011, 4740.051989602093, 4755.785989630475, 4844.15227335215, 4861.6353773467135, 4922.655414120977, 10861.402622855661, 10934.359846023, 10940.39827809478, 10951.83572246417, 10960.561577536968, 5531.3362396512675, 5564.499195072382, 5566.304211973504, 5584.162375643605, 5611.270534830446, 5082.085224659523, 5145.665531740425, 5145.9485405146215, 5157.690538567698, 5191.6884986900905, 3833.501644786216, 3924.6664033556895, 3932.744371615836, 4024.839006439768, 4047.5547689754103, 1171.3089277326249, 1171.7129303320742, 1182.633383651071, 1190.4642910690225, 1192.076140990739, 674.231376231097, 700.7162099349772, 703.3739971425435, 716.924722904098, 722.0541091170584, 5332.773462103738, 5367.838964831061, 5504.91742623861, 5559.916601250984, 5568.443155684399, 530.5596355025319, 532.6564365983996, 542.9837104886859, 544.5942772634334, 547.5893080189858, 3197.600299962505, 3230.5638738769967, 3276.6559511250975, 3287.1453422109944, 3336.632970373257, 12455.252684838939, 13116.934415328053, 13144.145630534176, 13413.93293033548, 13449.193048417126, 13118.344082795822, 13256.0, 13350.265735384453, 13528.59414217575, 13667.589972300846, 6648.03603477493, 7405.814854628569, 7564.848703025908, 7583.582902940391, 7586.962065189638, 5739.9139012915675, 6227.844303892258, 6256.593321434092, 6277.74889004453, 6311.589746666452, 12178.025757939165, 12241.0, 12358.208059831095, 12486.626471088355, 12647.936760316139, 11743.0, 11831.112666550216, 12372.92449581542, 12505.312207828656, 12555.87444125547, 8388.790280243044, 8624.913750862663, 8643.438176518506, 8644.22202001823, 8647.221750042527, 9263.16631503141, 9763.072508111718, 9769.364991275545, 9835.901640983499, 9836.21310295189, 8134.959325203336, 8245.752627421187, 8274.29668478186, 8294.253517183482, 8702.173293537104, 8022.759317220492, 8235.464694794819, 8327.20891515305, 8327.750167494985, 8434.957825210835, 6804.96597517029, 6954.652267386711, 6961.582305061713, 7008.194057683431, 7020.0522929405915, 4904.4605093440405, 4946.851594452172, 4952.588512274128, 4997.750112494434, 5037.697738135577, 5175.948240517547, 5307.071262529119, 5317.282166907573, 5340.465953404629, 5398.352197736297], "value": 4612.146396733868, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.7552237911083, 358.34244161962795, 359.4554250310778, 373.76266071044887, 386.281516379534, 5462.371827239864, 5521.257891792536, 5554.389017208104, 5555.666660000393, 5561.8887622247585, 5379.81170659027, 5414.187871819229, 5427.158790387496, 5454.61817672763, 5478.863028424292, 4014.1971605678837, 4083.6528895043957, 4186.39297301891, 4187.539370669224, 4192.559781222958, 4105.568915263899, 4108.26051310764, 4128.525219599739, 4130.421740956269, 4132.834686612532, 4067.6848368579663, 4078.2047500737367, 4080.1227736036744, 4093.1199792044704, 4098.569650186732, 4040.333344998072, 4090.550039495653, 4101.446304748851, 4105.958940410617, 4108.342665173558, 3561.9643803561894, 3584.193556449778, 3587.3542762302777, 3588.102974256436, 3599.6940260077927, 5274.736263186864, 5289.18017707256, 5294.126469132589, 5331.573474122061, 5350.357957045179, 4806.735629540374, 4807.9038419231765, 4818.132736107499, 4825.20384136617, 4826.662133650646, 5596.076647353182, 5653.717314134276, 5748.856278593027, 5759.280089988752, 5777.740001699934, 4007.1184339445276, 4014.7791871447057, 4017.6785857131654, 4028.992751812047, 4030.2745505808944, 5878.29460464747, 5991.430814072656, 6045.727942242565, 6069.848253793646, 6080.361562036011, 4068.6745060395097, 4102.097538541576, 4124.752514849119, 4128.195001974586, 4139.461869956886, 4183.769892655872, 4185.22573323936, 4194.3708443733685, 4206.768627725504, 4232.238197124547, 4679.251319788817, 4784.138855006063, 4843.2735089736825, 4845.6608037437045, 4856.41722993236, 5792.652440853562, 5802.390748971297, 5820.30156381237, 5821.332560486951, 5824.213731146241, 1428.8071110399962, 1441.5315022617692, 1443.0980637101811, 1449.54339383094, 1450.6808502129516, 946.2950102173787, 966.5360626899128, 971.1114330387758, 978.2272005116021, 981.7349315684725, 5013.523715247045, 5023.14606516893, 5027.4469808321055, 5029.497050295015, 5033.245013247969, 5878.911816322759, 5903.085021821625, 5953.3451320354725, 5956.9873121569435, 5960.225170727777, 4834.879128021757, 4961.70229786214, 4983.327250821165, 4985.725785081855, 4999.200127979506, 3149.1497295730023, 3160.7945483543494, 3172.3972445235795, 3179.3482336121037, 3179.7456203503666, 5468.781248750085, 5547.861303467445, 5573.749181286852, 5574.777008919679, 5599.496045355938, 6046.0, 6145.784897528654, 6147.538934579835, 6163.96918015407, 6192.907106393408, 5616.062458451827, 5634.380218175916, 5644.830655080272, 5647.7176141193595, 5652.434756524397, 5858.5898987070495, 5920.703964801829, 5943.5631391131155, 5964.970175149097, 5969.492593129633, 5798.449147330997, 5836.766529338779, 5857.384974577608, 5857.414258574108, 5904.9704751475965, 5373.811916582901, 5597.020521408818, 5617.8033768817895, 5634.4365563443325, 5635.408282130481, 4088.836446542105, 4111.198316328288, 4111.876643700693, 4122.9381559277235, 4134.91730165389, 5872.911906321323, 5977.372375900642, 6038.215032045806, 6051.697415129314, 6060.606060606046, 5785.8553536161935, 5791.942080579141, 5819.010768169506, 5821.301443826598, 5826.854328641648, 5799.565032622654, 5813.505852002458, 5824.621399609012, 5824.708764561839, 5825.6795876225515, 5596.38439771633, 5670.376258611467, 5688.260526131577, 5701.543876489954, 5757.91363129545, 5854.151148083419, 5854.5609079320075, 5861.794837180678, 5870.53035757147, 5873.882522349614, 5542.307211598551, 5628.74670639814, 5661.264035675501, 5683.261176047087, 5694.829155125353], "value": 4315.338249063249, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.6806473216517, 742.8365759532908, 744.594196163091, 753.86807308721, 765.7664412354231, 12997.480100795969, 13686.657833554165, 13717.451301947922, 15007.774883376758, 15386.0, 15359.69280614387, 15477.226138693048, 15649.374025039013, 15658.217089145526, 15676.608084797886, 870.8780770692108, 888.2849306308419, 890.5591732092623, 892.9107089291051, 893.70954439807, 880.3617377401365, 883.3816328570026, 883.8762573239752, 884.1732979664002, 896.3994123936945, 931.7204838548408, 933.8132373525289, 937.0629370629371, 938.629241449627, 940.6754669638964, 912.3750231091724, 918.9448633082036, 920.8158368326361, 934.654177954158, 942.3686130292721, 677.5900580148988, 678.8913773796169, 682.0587589127023, 682.1609420412871, 682.2427105912433, 13647.0, 13650.93174534131, 13655.248961307125, 13693.0, 13781.793273100911, 16366.181690915406, 16559.25483353252, 16882.07148606826, 16919.154042297836, 17025.0, 12764.106512544126, 13075.150115242574, 13155.73688526224, 13253.73492530144, 13357.666058348523, 2828.6747024092288, 2835.5321371973805, 2848.3875966667265, 2854.957175642367, 2861.6852146263896, 85529.14470855275, 86445.56777216136, 87274.0, 87340.0, 87819.0, 12594.937025314997, 12658.303793291458, 12751.744965100646, 12872.613821585368, 12905.483780648856, 22902.541949161256, 23665.0, 23703.170389036302, 23728.288151355486, 23785.167519136747, 6120.663363515049, 6193.84515387119, 6287.811365659038, 6292.811215663537, 6354.269259035178, 2861.2846788302923, 2918.9124326270244, 2922.561615757611, 2932.5747766574154, 2946.5285554311636, 3721.330160571123, 3801.239752049601, 3803.3344164771056, 3807.162424266657, 3816.732828701964, 660.6696651674163, 672.9938741581367, 675.3719041291646, 675.6284043775904, 678.0845858091635, 562.7973929385417, 583.7198144890476, 585.1836687820552, 588.5997521685209, 610.5146408605169, 10313.639022634172, 10635.627753028606, 10733.195010374253, 11027.0, 11533.76932461346, 593.3354642800092, 611.2512172588544, 613.4662843326334, 616.5098746496546, 619.7397093220858, 4633.559811817872, 4828.082664293773, 4860.538248866352, 4896.069746748107, 4972.57733092684, 83015.0, 83946.58026709827, 84081.06946096968, 84233.0, 84313.57843210745, 71943.0, 72918.27081729221, 74690.25309746942, 75113.0, 75635.0, 57898.842023159305, 59557.40442595519, 59843.700781496686, 60117.0, 67756.6612166936, 9420.896355194242, 10233.897661023295, 10259.435731034864, 10318.742031448974, 10965.232433729563, 26336.20991370262, 26579.60130598004, 26625.33436664099, 27140.185794426197, 28028.719712803428, 33812.0, 34080.65919340874, 34218.65781342254, 34747.82626086853, 34791.82604086964, 14063.859361406256, 14292.285385730464, 14332.068415552956, 14536.41854325815, 14538.636534086732, 15908.363665453253, 16064.0, 16350.918245408697, 16593.170341483117, 16629.750553741946, 15463.84536154624, 15528.912976092017, 15754.448594299145, 15835.920820395824, 16138.0, 15793.447229347377, 16038.839611603735, 16144.1927903602, 16212.35150593963, 16451.67096658084, 14707.0, 14804.62988425298, 14858.108513488793, 14993.2503374833, 15033.849661503682, 10870.891291086988, 10948.781024379627, 11235.213535052468, 11325.263857849213, 11792.23350482216, 10896.727581810519, 11099.500522476346, 11734.354610496162, 11769.117316201147, 11842.348670823187], "value": 7166.477829881904, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 114.0, 111.0, 110.0, 110.0, 113.0, 111.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 124.0, 123.0, 166.0, 126.0, 124.0, 125.0, 123.0, 155.0, 123.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 166.0, 185.0, 169.0, 171.0, 164.0, 165.0, 163.0, 162.0], "value": 167.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 117.0, 75.0, 74.0, 75.0, 74.0, 93.0, 74.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 109.0, 84.0, 84.0, 83.0, 97.0, 83.0, 93.0, 110.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 116.0, 114.0, 114.0, 114.0, 114.0, 114.0, 118.0, 115.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 150.0, 150.0, 151.0, 151.0, 150.0, 152.0, 150.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 60.0, 57.0, 58.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 57.0, 58.0, 57.0, 59.0, 57.0, 57.0, 59.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 87.0, 87.0, 86.0, 88.0, 88.0, 115.0, 88.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 134.0, 138.0, 134.0, 133.0, 132.0, 142.0, 136.0, 135.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 194.0, 191.0, 195.0, 190.0, 196.0, 186.0, 192.0, 183.0, 199.0], "value": 190.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 77.0, 79.0, 74.0, 72.0, 73.0, 76.0, 73.0, 76.0], "value": 75.1, "unit": "score"}]}]} 09:24:42 INFO - Return code: 0 09:24:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:24:42 INFO - # TBPL SUCCESS # 09:24:42 INFO - Running post-action listener: _resource_record_post_action 09:24:42 INFO - [mozharness: 2017-05-30 16:24:42.722127Z] Finished run-tests step (success) 09:24:42 INFO - Running post-run listener: _resource_record_post_run 09:24:42 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 4096; Write bytes: 410939392; Read time: 12; Write time: 210892 09:24:42 INFO - TinderboxPrint: CPU usage
12.7% 09:24:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:24:42 INFO - TinderboxPrint: I/O write bytes / time
410,939,392 / 210,892 09:24:42 INFO - TinderboxPrint: CPU idle
8,766.3 (87.3%) 09:24:42 INFO - TinderboxPrint: CPU user
1,222.5 (12.2%) 09:24:42 INFO - TinderboxPrint: Swap in / out
0 / 0 09:24:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99500032; Read time: 0; Write time: 55928 09:24:42 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:24:42 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 0; Write bytes: 311439360; Read time: 0; Write time: 154964 09:24:43 INFO - Running post-run listener: _upload_blobber_files 09:24:43 INFO - Blob upload gear active. 09:24:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:24:43 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 09:24:43 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'] 09:24:43 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 09:24:43 INFO - (blobuploader) - INFO - Open directory for files ... 09:24:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:24:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:24:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:44 INFO - (blobuploader) - INFO - Done attempting. 09:24:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:24:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:24:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:45 INFO - (blobuploader) - INFO - Done attempting. 09:24:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:24:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:24:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:52 INFO - (blobuploader) - INFO - Done attempting. 09:24:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:24:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:24:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:24:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:24:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:24:53 INFO - (blobuploader) - INFO - Done attempting. 09:24:53 INFO - (blobuploader) - INFO - Iteration through files over. 09:24:53 INFO - Return code: 0 09:24:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:24:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:24:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd127c17a379f70375e75a0a1a4ae8193878f9667889319e3e1ab2fe53faac9399c762110c71765c7222625798a025085313cbbd0fdbd1fcd75d836f2c209b6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99ad33b9ba83834c8850f8a5268916f1c5f473ef4d318aa6ada8cc1f9af0fae6becdc1088c57c062875cba6f28cf7f504cf9f6ac28afd06d97283b1a9d2a748e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/698faa809811f8f1d760228b1e8743a2e408e26322e4f11604fd4d13376d8c2bdaac8378e7a690b06dfdeb8d074795ac082ddbb3154f8ec3c9e3a78631c78a69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/224c6c542d42453e64cdb357aa986fe61128a292e44e23b7088eecc1ee8a36c494235cf9462b99f6c2323e8e425846861b77a44175118eb59d3e33f16bd8492c"} 09:24:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:24:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:24:53 INFO - Contents: 09:24:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd127c17a379f70375e75a0a1a4ae8193878f9667889319e3e1ab2fe53faac9399c762110c71765c7222625798a025085313cbbd0fdbd1fcd75d836f2c209b6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99ad33b9ba83834c8850f8a5268916f1c5f473ef4d318aa6ada8cc1f9af0fae6becdc1088c57c062875cba6f28cf7f504cf9f6ac28afd06d97283b1a9d2a748e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/698faa809811f8f1d760228b1e8743a2e408e26322e4f11604fd4d13376d8c2bdaac8378e7a690b06dfdeb8d074795ac082ddbb3154f8ec3c9e3a78631c78a69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/224c6c542d42453e64cdb357aa986fe61128a292e44e23b7088eecc1ee8a36c494235cf9462b99f6c2323e8e425846861b77a44175118eb59d3e33f16bd8492c"} 09:24:53 INFO - Running post-run listener: copy_logs_to_upload_dir 09:24:53 INFO - Copying logs to upload dir... 09:24:53 INFO - mkdir: /builds/slave/test/build/upload/logs 09:24:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1322.103661 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 2 secs) (at 2017-05-30 09:24:52.304665) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 09:24:52.309158) ========= 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=337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd127c17a379f70375e75a0a1a4ae8193878f9667889319e3e1ab2fe53faac9399c762110c71765c7222625798a025085313cbbd0fdbd1fcd75d836f2c209b6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99ad33b9ba83834c8850f8a5268916f1c5f473ef4d318aa6ada8cc1f9af0fae6becdc1088c57c062875cba6f28cf7f504cf9f6ac28afd06d97283b1a9d2a748e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/698faa809811f8f1d760228b1e8743a2e408e26322e4f11604fd4d13376d8c2bdaac8378e7a690b06dfdeb8d074795ac082ddbb3154f8ec3c9e3a78631c78a69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/224c6c542d42453e64cdb357aa986fe61128a292e44e23b7088eecc1ee8a36c494235cf9462b99f6c2323e8e425846861b77a44175118eb59d3e33f16bd8492c"} build_url:https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/GGu-oaChTbWCndW1LXf13A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd127c17a379f70375e75a0a1a4ae8193878f9667889319e3e1ab2fe53faac9399c762110c71765c7222625798a025085313cbbd0fdbd1fcd75d836f2c209b6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/99ad33b9ba83834c8850f8a5268916f1c5f473ef4d318aa6ada8cc1f9af0fae6becdc1088c57c062875cba6f28cf7f504cf9f6ac28afd06d97283b1a9d2a748e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/698faa809811f8f1d760228b1e8743a2e408e26322e4f11604fd4d13376d8c2bdaac8378e7a690b06dfdeb8d074795ac082ddbb3154f8ec3c9e3a78631c78a69", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/224c6c542d42453e64cdb357aa986fe61128a292e44e23b7088eecc1ee8a36c494235cf9462b99f6c2323e8e425846861b77a44175118eb59d3e33f16bd8492c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-30 09:24:52.333124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:24:52.333439) ========= 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=337fe3f4b1febe37b85fccc40000019e-1496152580.13416-1489980842 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004568 ========= master_lag: 0.12 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-30 09:24:52.457490) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 09:24:52.459044) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-30 09:24:52.459337) ========= ========= Total master_lag: 0.31 =========