builder: mozilla-beta_ubuntu64_hw_devedition_test-dromaeojs-e10s slave: talos-linux64-ix-025 starttime: 1500570000.39 results: success (0) revision: 293c0a44fda7e1b2f895d18a6411275172269d50 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-20 10:00:00.390155) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-20 10:00:00.390755) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-20 10:00:00.391137) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-20 10:00:00.441330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 10:00:00.441644) ========= 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=232498196343f89f466a4a9a000001c8-1500569911.655761-982460044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-20 10:00:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 27.0M=0s 2017-07-20 10:00:02 (27.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.214894 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 10:00:00.671746) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 10:00:00.672025) ========= 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=232498196343f89f466a4a9a000001c8-1500569911.655761-982460044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015231 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 10:00:00.724829) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-20 10:00:00.725122) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 293c0a44fda7e1b2f895d18a6411275172269d50 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 293c0a44fda7e1b2f895d18a6411275172269d50 --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=232498196343f89f466a4a9a000001c8-1500569911.655761-982460044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-20 10:00:02,797 truncating revision to first 12 chars 2017-07-20 10:00:02,797 Setting DEBUG logging. 2017-07-20 10:00:02,797 attempt 1/10 2017-07-20 10:00:02,797 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/293c0a44fda7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-20 10:00:03,973 unpacking tar archive at: mozilla-beta-293c0a44fda7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.488703 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-20 10:00:02.226713) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-20 10:00:02.227064) ========= script_repo_revision: 293c0a44fda7e1b2f895d18a6411275172269d50 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-20 10:00:02.231508) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-20 10:00:02.231828) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-20 10:00:02.288698) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2017-07-20 10:00:02.288973) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=232498196343f89f466a4a9a000001c8-1500569911.655761-982460044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:00:04 INFO - MultiFileLogger online at 20170720 10:00:04 in /builds/slave/test 10:00:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:00:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:00:04 INFO - {'append_to_log': False, 10:00:04 INFO - 'base_work_dir': '/builds/slave/test', 10:00:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:00:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:00:04 INFO - 'branch': 'Mozilla-Beta', 10:00:04 INFO - 'buildbot_json_path': 'buildprops.json', 10:00:04 INFO - 'config_files': ('talos/linux_config.py',), 10:00:04 INFO - 'default_actions': ('clobber', 10:00:04 INFO - 'read-buildbot-config', 10:00:04 INFO - 'download-and-extract', 10:00:04 INFO - 'populate-webroot', 10:00:04 INFO - 'create-virtualenv', 10:00:04 INFO - 'install', 10:00:04 INFO - 'setup-mitmproxy', 10:00:04 INFO - 'run-tests'), 10:00:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:00:04 INFO - 'download_minidump_stackwalk': True, 10:00:04 INFO - 'download_symbols': 'ondemand', 10:00:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:00:04 INFO - 'tooltool.py': '/tools/tooltool.py', 10:00:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:00:04 INFO - '/tools/misc-python/virtualenv.py')}, 10:00:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:00:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:00:04 INFO - 'gecko_profile': False, 10:00:04 INFO - 'gecko_profile_interval': 0, 10:00:04 INFO - 'installer_path': 'installer.exe', 10:00:04 INFO - 'log_level': 'info', 10:00:04 INFO - 'log_name': 'talos', 10:00:04 INFO - 'log_to_console': True, 10:00:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:00:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:00:04 INFO - 'opt_config_files': (), 10:00:04 INFO - 'pip_index': False, 10:00:04 INFO - 'suite': 'dromaeojs-e10s', 10:00:04 INFO - 'system_bits': '32', 10:00:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:00:04 INFO - 'title': 'talos-linux64-ix-025', 10:00:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:00:04 INFO - 'use_talos_json': True, 10:00:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:00:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:00:04 INFO - 'work_dir': 'build'} 10:00:04 INFO - [mozharness: 2017-07-20 17:00:04.469131Z] Running clobber step. 10:00:04 INFO - Running pre-action listener: _resource_record_pre_action 10:00:04 INFO - Running main action method: clobber 10:00:04 INFO - rmtree: /builds/slave/test/build 10:00:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:00:06 INFO - Running post-action listener: _resource_record_post_action 10:00:06 INFO - [mozharness: 2017-07-20 17:00:06.041208Z] Finished clobber step (success) 10:00:06 INFO - [mozharness: 2017-07-20 17:00:06.041308Z] Running read-buildbot-config step. 10:00:06 INFO - Running pre-action listener: _resource_record_pre_action 10:00:06 INFO - Running main action method: read_buildbot_config 10:00:06 INFO - Using buildbot properties: 10:00:06 INFO - { 10:00:06 INFO - "project": "", 10:00:06 INFO - "product": "firefox", 10:00:06 INFO - "who": "ryanvm@gmail.com", 10:00:06 INFO - "installer_path": "public/build/target.tar.bz2", 10:00:06 INFO - "builddir": "mozilla-beta_ubuntu64_hw_devedition_test-dromaeojs-e10s", 10:00:06 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 10:00:06 INFO - "buildername": "Ubuntu HW 12.04 x64 devedition mozilla-beta talos dromaeojs-e10s", 10:00:06 INFO - "stage_platform": "linux64-devedition", 10:00:06 INFO - "basedir": "/builds/slave/test", 10:00:06 INFO - "buildnumber": 8, 10:00:06 INFO - "platform": "ubuntu64_hw_devedition", 10:00:06 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:00:06 INFO - "slavebuilddir": "test", 10:00:06 INFO - "taskId": "eNS4qST4T4SH-H1fb4WfBQ", 10:00:06 INFO - "branch": "mozilla-beta", 10:00:06 INFO - "script_repo_revision": "production", 10:00:06 INFO - "revision": "293c0a44fda7e1b2f895d18a6411275172269d50", 10:00:06 INFO - "slavename": "talos-linux64-ix-025", 10:00:06 INFO - "repo_path": "releases/mozilla-beta" 10:00:06 INFO - } 10:00:06 INFO - Finding installer, test and symbols from parent task. 10:00:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eNS4qST4T4SH-H1fb4WfBQ'}, attempt #1 10:00:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eNS4qST4T4SH-H1fb4WfBQ'}, attempt #1 10:00:06 INFO - Task dependencies: G7HVj4DpTqiZL1yK9mDQ1w 10:00:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w'}, attempt #1 10:00:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.tar.bz2 10:00:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/test_packages.json 10:00:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.crashreporter-symbols.zip 10:00:07 INFO - Running post-action listener: _resource_record_post_action 10:00:07 INFO - [mozharness: 2017-07-20 17:00:07.446968Z] Finished read-buildbot-config step (success) 10:00:07 INFO - [mozharness: 2017-07-20 17:00:07.447273Z] Running download-and-extract step. 10:00:07 INFO - Running pre-action listener: _resource_record_pre_action 10:00:07 INFO - Running main action method: download_and_extract 10:00:07 INFO - mkdir: /builds/slave/test/build/tests 10:00:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:07 INFO - trying https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.test_packages.json 10:00:07 INFO - Downloading https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:00:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:00:08 INFO - Downloaded 989 bytes. 10:00:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:00:08 INFO - Using the following test package requirements: 10:00:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:00:08 INFO - u'common': [u'target.common.tests.zip'], 10:00:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:00:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:00:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:00:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:00:08 INFO - u'mozbase': [u'target.common.tests.zip'], 10:00:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:00:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:00:08 INFO - u'web-platform': [u'target.common.tests.zip', 10:00:08 INFO - u'target.web-platform.tests.tar.gz'], 10:00:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:00:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:00:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.common.tests.zip 10:00:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:00:08 INFO - Fetch https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.common.tests.zip into memory 10:00:09 INFO - Content-Length response header: 68423701 10:00:09 INFO - Bytes received: 68423701 10:00:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:00:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.common.tests.zip 10:00:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:00:20 INFO - Fetch https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.common.tests.zip into memory 10:00:21 INFO - Content-Length response header: 68423701 10:00:21 INFO - Bytes received: 68423701 10:00:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.talos.tests.zip 10:00:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:00:34 INFO - Fetch https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.talos.tests.zip into memory 10:00:34 INFO - Content-Length response header: 14454898 10:00:34 INFO - Bytes received: 14454898 10:00:35 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')]} 10:00:35 INFO - trying https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.tar.bz2 10:00:35 INFO - Downloading https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:00:36 INFO - Downloaded 58467065 bytes. 10:00:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.tar.bz2 10:00:36 INFO - mkdir: /builds/slave/test/properties 10:00:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:00:36 INFO - Writing to file /builds/slave/test/properties/build_url 10:00:36 INFO - Contents: 10:00:36 INFO - build_url:https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.tar.bz2 10:00:36 INFO - Running post-action listener: _resource_record_post_action 10:00:36 INFO - Running post-action listener: set_extra_try_arguments 10:00:36 INFO - [mozharness: 2017-07-20 17:00:36.193036Z] Finished download-and-extract step (success) 10:00:36 INFO - [mozharness: 2017-07-20 17:00:36.193134Z] Running populate-webroot step. 10:00:36 INFO - Running pre-action listener: _resource_record_pre_action 10:00:36 INFO - Running main action method: populate_webroot 10:00:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:00:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:00:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:00:36 INFO - '--tppagecycles', 10:00:36 INFO - '7'], 10:00:36 INFO - 'tests': ['tsvgm']}}, 10:00:36 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:00:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:00:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:00:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:00:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:00:36 INFO - 'talos_options': ['--disable-e10s'], 10:00:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:00:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:00:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:00:36 INFO - 'talos_options': ['--disable-e10s'], 10:00:36 INFO - 'tests': ['damp', 'tps']}, 10:00:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:00:36 INFO - 'tests': ['damp', 'tps']}, 10:00:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:00:36 INFO - 'tests': ['dromaeo_dom']}, 10:00:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:00:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:00:36 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:00:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:00:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:00:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:00:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:00:36 INFO - 'tests': ['a11yr', 10:00:36 INFO - 'ts_paint', 10:00:36 INFO - 'tpaint', 10:00:36 INFO - 'sessionrestore', 10:00:36 INFO - 'sessionrestore_no_auto_restore', 10:00:36 INFO - 'tabpaint']}, 10:00:36 INFO - 'other-e10s': {'tests': ['a11yr', 10:00:36 INFO - 'ts_paint', 10:00:36 INFO - 'tpaint', 10:00:36 INFO - 'sessionrestore', 10:00:36 INFO - 'sessionrestore_no_auto_restore', 10:00:36 INFO - 'tabpaint']}, 10:00:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:00:36 INFO - 'ts_paint', 10:00:36 INFO - 'tpaint', 10:00:36 INFO - 'sessionrestore', 10:00:36 INFO - 'sessionrestore_no_auto_restore', 10:00:36 INFO - 'tabpaint']}, 10:00:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:00:36 INFO - 'ts_paint', 10:00:36 INFO - 'tpaint', 10:00:36 INFO - 'sessionrestore', 10:00:36 INFO - 'sessionrestore_no_auto_restore', 10:00:36 INFO - 'tabpaint']}, 10:00:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:00:36 INFO - 'tests': ['a11yr', 10:00:36 INFO - 'ts_paint', 10:00:36 INFO - 'tpaint', 10:00:36 INFO - 'sessionrestore', 10:00:36 INFO - 'sessionrestore_no_auto_restore', 10:00:36 INFO - 'tabpaint']}, 10:00:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:00:36 INFO - 'tests': ['a11yr', 10:00:36 INFO - 'ts_paint', 10:00:36 INFO - 'tpaint', 10:00:36 INFO - 'sessionrestore', 10:00:36 INFO - 'sessionrestore_no_auto_restore', 10:00:36 INFO - 'tabpaint']}, 10:00:36 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:00:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:00:36 INFO - 'bloom_basic_ref']}, 10:00:36 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:00:36 INFO - 'talos_options': ['--mitmproxy', 10:00:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:00:36 INFO - '--firstNonBlankPaint'], 10:00:36 INFO - 'tests': ['quantum_pageload_google', 10:00:36 INFO - 'quantum_pageload_youtube', 10:00:36 INFO - 'quantum_pageload_amazon', 10:00:36 INFO - 'quantum_pageload_facebook']}, 10:00:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:00:36 INFO - 'tests': ['tsvgx', 10:00:36 INFO - 'tsvgr_opacity', 10:00:36 INFO - 'tart', 10:00:36 INFO - 'tscrollx', 10:00:36 INFO - 'cart', 10:00:36 INFO - 'tsvg_static']}, 10:00:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:00:36 INFO - 'tsvgr_opacity', 10:00:36 INFO - 'tart', 10:00:36 INFO - 'tscrollx', 10:00:36 INFO - 'cart', 10:00:36 INFO - 'tsvg_static']}, 10:00:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:00:36 INFO - 'talos_options': ['--disable-e10s'], 10:00:36 INFO - 'tests': ['tp5o']}, 10:00:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:00:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:00:36 INFO - 'talos_options': ['--disable-e10s', 10:00:36 INFO - '--xperf_path', 10:00:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:36 INFO - 'tests': ['tp5n']}, 10:00:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:00:36 INFO - 'talos_options': ['--xperf_path', 10:00:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:00:36 INFO - 'tests': ['tp5n']}}, 10:00:36 INFO - 'talos.zip': {'path': '', 10:00:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:00:36 INFO - Running post-action listener: _resource_record_post_action 10:00:36 INFO - [mozharness: 2017-07-20 17:00:36.207977Z] Finished populate-webroot step (success) 10:00:36 INFO - [mozharness: 2017-07-20 17:00:36.208067Z] Running create-virtualenv step. 10:00:36 INFO - Running pre-action listener: _resource_record_pre_action 10:00:36 INFO - Running main action method: create_virtualenv 10:00:36 INFO - Creating virtualenv /builds/slave/test/build/venv 10:00:36 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 10:00:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:00:36 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:00:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:00:36 INFO - Using real prefix '/usr' 10:00:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:00:36 INFO - Installing distribute.............................................................................................................................................................................................done. 10:00:38 INFO - Installing pip.................done. 10:00:38 INFO - Return code: 0 10:00:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:00:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:00:38 INFO - Reading from file tmpfile_stdout 10:00:38 INFO - Output received: 10:00:38 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) 10:00:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:00:38 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')]} 10:00:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:38 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')]} 10:00:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:38 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 0x240d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789140>, '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 0x2789a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789ed0>, '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': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', '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 10:00:38 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 10:00:38 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 10:00:39 INFO - Using env: {'DISPLAY': ':0', 10:00:39 INFO - 'HOME': '/home/cltbld', 10:00:39 INFO - 'LANG': 'en_US.UTF-8', 10:00:39 INFO - 'LANGUAGE': 'en_US:en', 10:00:39 INFO - 'LOGNAME': 'cltbld', 10:00:39 INFO - 'MAIL': '/var/mail/cltbld', 10:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:39 INFO - 'MOZ_NO_REMOTE': '1', 10:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:39 INFO - 'NO_EM_RESTART': '1', 10:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:39 INFO - 'PWD': '/builds/slave/test', 10:00:39 INFO - 'SHELL': '/bin/bash', 10:00:39 INFO - 'SHLVL': '1', 10:00:39 INFO - 'TERM': 'linux', 10:00:39 INFO - 'TMOUT': '86400', 10:00:39 INFO - 'USER': 'cltbld', 10:00:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', 10:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:39 INFO - '_': '/tools/buildbot/bin/python'} 10:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:39 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 10:00:39 INFO - Cleaning up... 10:00:39 INFO - Return code: 0 10:00:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00: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')]} 10:00:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:39 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 0x240d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789140>, '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 0x2789a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789ed0>, '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': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', '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 10:00:39 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 10:00:39 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 10:00:39 INFO - Using env: {'DISPLAY': ':0', 10:00:39 INFO - 'HOME': '/home/cltbld', 10:00:39 INFO - 'LANG': 'en_US.UTF-8', 10:00:39 INFO - 'LANGUAGE': 'en_US:en', 10:00:39 INFO - 'LOGNAME': 'cltbld', 10:00:39 INFO - 'MAIL': '/var/mail/cltbld', 10:00:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:39 INFO - 'MOZ_NO_REMOTE': '1', 10:00:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:39 INFO - 'NO_EM_RESTART': '1', 10:00:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:39 INFO - 'PWD': '/builds/slave/test', 10:00:39 INFO - 'SHELL': '/bin/bash', 10:00:39 INFO - 'SHLVL': '1', 10:00:39 INFO - 'TERM': 'linux', 10:00:39 INFO - 'TMOUT': '86400', 10:00:39 INFO - 'USER': 'cltbld', 10:00:39 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', 10:00:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:39 INFO - '_': '/tools/buildbot/bin/python'} 10:00:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:39 INFO - Downloading/unpacking psutil>=3.1.1 10:00:39 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 10:00:39 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 10:00:39 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 10:00:39 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 10:00:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:00:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:40 INFO - Installing collected packages: psutil 10:00:40 INFO - Running setup.py install for psutil 10:00:40 INFO - building 'psutil._psutil_linux' extension 10:00:40 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 10:00:40 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 10:00:40 INFO - building 'psutil._psutil_posix' extension 10:00:40 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 10:00:41 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 10:00:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:00:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:00:41 INFO - Successfully installed psutil 10:00:41 INFO - Cleaning up... 10:00:41 INFO - Return code: 0 10:00:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:41 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 0x240d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789140>, '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 0x2789a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789ed0>, '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': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', '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 10:00:41 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 10:00:41 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 10:00:41 INFO - Using env: {'DISPLAY': ':0', 10:00:41 INFO - 'HOME': '/home/cltbld', 10:00:41 INFO - 'LANG': 'en_US.UTF-8', 10:00:41 INFO - 'LANGUAGE': 'en_US:en', 10:00:41 INFO - 'LOGNAME': 'cltbld', 10:00:41 INFO - 'MAIL': '/var/mail/cltbld', 10:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:41 INFO - 'MOZ_NO_REMOTE': '1', 10:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:41 INFO - 'NO_EM_RESTART': '1', 10:00:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:41 INFO - 'PWD': '/builds/slave/test', 10:00:41 INFO - 'SHELL': '/bin/bash', 10:00:41 INFO - 'SHLVL': '1', 10:00:41 INFO - 'TERM': 'linux', 10:00:41 INFO - 'TMOUT': '86400', 10:00:41 INFO - 'USER': 'cltbld', 10:00:41 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', 10:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:41 INFO - '_': '/tools/buildbot/bin/python'} 10:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:00: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 10:00: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 10:00: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 10:00: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 10:00:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:00:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:00:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:00:42 INFO - Installing collected packages: mozsystemmonitor 10:00:42 INFO - Running setup.py install for mozsystemmonitor 10:00:42 INFO - Successfully installed mozsystemmonitor 10:00:42 INFO - Cleaning up... 10:00:43 INFO - Return code: 0 10:00:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:00:43 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')]} 10:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:43 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')]} 10:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:43 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 0x240d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789140>, '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 0x2789a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789ed0>, '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': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', '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 10:00:43 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 10:00:43 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 10:00:43 INFO - Using env: {'DISPLAY': ':0', 10:00:43 INFO - 'HOME': '/home/cltbld', 10:00:43 INFO - 'LANG': 'en_US.UTF-8', 10:00:43 INFO - 'LANGUAGE': 'en_US:en', 10:00:43 INFO - 'LOGNAME': 'cltbld', 10:00:43 INFO - 'MAIL': '/var/mail/cltbld', 10:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:43 INFO - 'MOZ_NO_REMOTE': '1', 10:00:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:43 INFO - 'NO_EM_RESTART': '1', 10:00:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:43 INFO - 'PWD': '/builds/slave/test', 10:00:43 INFO - 'SHELL': '/bin/bash', 10:00:43 INFO - 'SHLVL': '1', 10:00:43 INFO - 'TERM': 'linux', 10:00:43 INFO - 'TMOUT': '86400', 10:00:43 INFO - 'USER': 'cltbld', 10:00:43 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', 10:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:43 INFO - '_': '/tools/buildbot/bin/python'} 10:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:43 INFO - Downloading/unpacking jsonschema==2.5.1 10:00:43 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 10:00:43 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 10:00:43 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 10:00:43 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 10:00:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:00:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:00:44 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 10:00:44 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 10:00:44 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 10:00:44 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 10:00:44 INFO - Downloading functools32-3.2.3-2.tar.gz 10:00:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:00:44 INFO - warning: no files found matching '*.txt' 10:00:44 INFO - no previously-included directories found matching 'build' 10:00:44 INFO - no previously-included directories found matching 'dist' 10:00:44 INFO - no previously-included directories found matching '.git*' 10:00:44 INFO - Installing collected packages: jsonschema, functools32 10:00:44 INFO - Running setup.py install for functools32 10:00:44 INFO - warning: no files found matching '*.txt' 10:00:44 INFO - no previously-included directories found matching 'build' 10:00:44 INFO - no previously-included directories found matching 'dist' 10:00:44 INFO - no previously-included directories found matching '.git*' 10:00:44 INFO - Successfully installed jsonschema functools32 10:00:44 INFO - Cleaning up... 10:00:44 INFO - Return code: 0 10:00:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00: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')]} 10:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00: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', '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 0x240d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789140>, '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 0x2789a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789ed0>, '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': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', '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 10:00: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:00: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 functools32==3.2.3-2 10:00:44 INFO - Using env: {'DISPLAY': ':0', 10:00:44 INFO - 'HOME': '/home/cltbld', 10:00:44 INFO - 'LANG': 'en_US.UTF-8', 10:00:44 INFO - 'LANGUAGE': 'en_US:en', 10:00:44 INFO - 'LOGNAME': 'cltbld', 10:00:44 INFO - 'MAIL': '/var/mail/cltbld', 10:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:44 INFO - 'MOZ_NO_REMOTE': '1', 10:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:44 INFO - 'NO_EM_RESTART': '1', 10:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:44 INFO - 'PWD': '/builds/slave/test', 10:00:44 INFO - 'SHELL': '/bin/bash', 10:00:44 INFO - 'SHLVL': '1', 10:00:44 INFO - 'TERM': 'linux', 10:00:44 INFO - 'TMOUT': '86400', 10:00:44 INFO - 'USER': 'cltbld', 10:00:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', 10:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:44 INFO - '_': '/tools/buildbot/bin/python'} 10:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:00:44 INFO - Cleaning up... 10:00:44 INFO - Return code: 0 10:00:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:00: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')]} 10:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00: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')]} 10:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00: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', '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 0x240d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789140>, '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 0x2789a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789ed0>, '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': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', '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 10:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:00: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 blobuploader==1.2.4 10:00:44 INFO - Using env: {'DISPLAY': ':0', 10:00:44 INFO - 'HOME': '/home/cltbld', 10:00:44 INFO - 'LANG': 'en_US.UTF-8', 10:00:44 INFO - 'LANGUAGE': 'en_US:en', 10:00:44 INFO - 'LOGNAME': 'cltbld', 10:00:44 INFO - 'MAIL': '/var/mail/cltbld', 10:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:44 INFO - 'MOZ_NO_REMOTE': '1', 10:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:44 INFO - 'NO_EM_RESTART': '1', 10:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:44 INFO - 'PWD': '/builds/slave/test', 10:00:44 INFO - 'SHELL': '/bin/bash', 10:00:44 INFO - 'SHLVL': '1', 10:00:44 INFO - 'TERM': 'linux', 10:00:44 INFO - 'TMOUT': '86400', 10:00:44 INFO - 'USER': 'cltbld', 10:00:44 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', 10:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:44 INFO - '_': '/tools/buildbot/bin/python'} 10:00:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:45 INFO - Downloading/unpacking blobuploader==1.2.4 10:00:45 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 10:00:45 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 10:00:45 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 10:00:45 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 10:00:46 INFO - Downloading blobuploader-1.2.4.tar.gz 10:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:00:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:00:46 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 10:00:46 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 10:00:46 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 10:00:46 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 10:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:00:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:00:46 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 10:00:46 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 10:00:46 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 10:00:46 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 10:00:46 INFO - Downloading docopt-0.6.1.tar.gz 10:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:00:46 INFO - Installing collected packages: blobuploader, requests, docopt 10:00:46 INFO - Running setup.py install for blobuploader 10:00:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:00:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:00:46 INFO - Running setup.py install for requests 10:00:47 INFO - Running setup.py install for docopt 10:00:47 INFO - Successfully installed blobuploader requests docopt 10:00:47 INFO - Cleaning up... 10:00:47 INFO - Return code: 0 10:00:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:47 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')]} 10:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:47 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')]} 10:00:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:47 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 0x240d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789140>, '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 0x2789a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789ed0>, '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': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', '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 10:00:47 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 10:00:47 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 10:00:47 INFO - Using env: {'DISPLAY': ':0', 10:00:47 INFO - 'HOME': '/home/cltbld', 10:00:47 INFO - 'LANG': 'en_US.UTF-8', 10:00:47 INFO - 'LANGUAGE': 'en_US:en', 10:00:47 INFO - 'LOGNAME': 'cltbld', 10:00:47 INFO - 'MAIL': '/var/mail/cltbld', 10:00:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:47 INFO - 'MOZ_NO_REMOTE': '1', 10:00:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:47 INFO - 'NO_EM_RESTART': '1', 10:00:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:47 INFO - 'PWD': '/builds/slave/test', 10:00:47 INFO - 'SHELL': '/bin/bash', 10:00:47 INFO - 'SHLVL': '1', 10:00:47 INFO - 'TERM': 'linux', 10:00:47 INFO - 'TMOUT': '86400', 10:00:47 INFO - 'USER': 'cltbld', 10:00:47 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', 10:00:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:47 INFO - '_': '/tools/buildbot/bin/python'} 10:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:47 INFO - Running setup.py (path:/tmp/pip-rupvOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:47 INFO - Running setup.py (path:/tmp/pip-jgVcSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:47 INFO - Running setup.py (path:/tmp/pip-qeUBH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:47 INFO - Running setup.py (path:/tmp/pip-q1kPVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:47 INFO - Running setup.py (path:/tmp/pip-PGLkIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:48 INFO - Running setup.py (path:/tmp/pip-I5_QiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:48 INFO - Running setup.py (path:/tmp/pip-1NrhzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:48 INFO - Running setup.py (path:/tmp/pip-1iLTYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:48 INFO - Running setup.py (path:/tmp/pip-mv9Uo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:48 INFO - Running setup.py (path:/tmp/pip-7dQJpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:48 INFO - Running setup.py (path:/tmp/pip-BPEUn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:48 INFO - Running setup.py (path:/tmp/pip-MYFjYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:48 INFO - Running setup.py (path:/tmp/pip-OtblWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:48 INFO - Running setup.py (path:/tmp/pip-QaqwUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:48 INFO - Running setup.py (path:/tmp/pip-1FRd6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:48 INFO - Running setup.py (path:/tmp/pip-2VNAiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:48 INFO - Running setup.py (path:/tmp/pip-nJ3izm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:00:48 INFO - Running setup.py install for manifestparser 10:00:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:00:49 INFO - Running setup.py install for mozcrash 10:00:49 INFO - Running setup.py install for mozdebug 10:00:49 INFO - Running setup.py install for mozdevice 10:00:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:00:49 INFO - Running setup.py install for mozfile 10:00:49 INFO - Running setup.py install for mozhttpd 10:00:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:00:49 INFO - Running setup.py install for mozinfo 10:00:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:00:49 INFO - Running setup.py install for mozInstall 10:00:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:00:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:00:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:00:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:00:49 INFO - Running setup.py install for mozleak 10:00:49 INFO - Running setup.py install for mozlog 10:00:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:00:49 INFO - Running setup.py install for moznetwork 10:00:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:00:50 INFO - Running setup.py install for mozprocess 10:00:50 INFO - Running setup.py install for mozprofile 10:00:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:00:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:00:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:00:50 INFO - Running setup.py install for mozrunner 10:00:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:00:50 INFO - Running setup.py install for mozscreenshot 10:00:50 INFO - Running setup.py install for moztest 10:00:50 INFO - Running setup.py install for mozversion 10:00:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:00:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:00:50 INFO - Cleaning up... 10:00:50 INFO - Return code: 0 10:00:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:50 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')]} 10:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:50 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')]} 10:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:50 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 0x240d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789140>, '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 0x2789a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789ed0>, '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': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', '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 10:00:50 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 10:00:50 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 10:00:50 INFO - Using env: {'DISPLAY': ':0', 10:00:50 INFO - 'HOME': '/home/cltbld', 10:00:50 INFO - 'LANG': 'en_US.UTF-8', 10:00:50 INFO - 'LANGUAGE': 'en_US:en', 10:00:50 INFO - 'LOGNAME': 'cltbld', 10:00:50 INFO - 'MAIL': '/var/mail/cltbld', 10:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:50 INFO - 'MOZ_NO_REMOTE': '1', 10:00:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:50 INFO - 'NO_EM_RESTART': '1', 10:00:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:50 INFO - 'PWD': '/builds/slave/test', 10:00:50 INFO - 'SHELL': '/bin/bash', 10:00:50 INFO - 'SHLVL': '1', 10:00:50 INFO - 'TERM': 'linux', 10:00:50 INFO - 'TMOUT': '86400', 10:00:50 INFO - 'USER': 'cltbld', 10:00:50 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', 10:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:50 INFO - '_': '/tools/buildbot/bin/python'} 10:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:00:50 INFO - Running setup.py (path:/tmp/pip-fKUn0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:00:50 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)) 10:00:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:00:51 INFO - Running setup.py (path:/tmp/pip-trCMF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:00:51 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:00:51 INFO - Running setup.py (path:/tmp/pip-pX0x37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:00:51 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:00:51 INFO - Running setup.py (path:/tmp/pip-ypeHJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:00:51 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:00:51 INFO - Running setup.py (path:/tmp/pip-LZbHgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:00:51 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:00:51 INFO - Running setup.py (path:/tmp/pip-ypYGAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:00:51 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:00:51 INFO - Running setup.py (path:/tmp/pip-SdxNxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:00:51 INFO - Running setup.py (path:/tmp/pip-iHEJzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:00:51 INFO - Running setup.py (path:/tmp/pip-kZUHOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:00:51 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:00:51 INFO - Running setup.py (path:/tmp/pip-DlZzoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:00:51 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:00:51 INFO - Running setup.py (path:/tmp/pip-Gxey5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:00:51 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:00:51 INFO - Running setup.py (path:/tmp/pip-GKgxoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:00:51 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:00:51 INFO - Running setup.py (path:/tmp/pip-0TPrAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:00:51 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:00:51 INFO - Running setup.py (path:/tmp/pip-ba3CmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:00:51 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)) 10:00:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:51 INFO - Running setup.py (path:/tmp/pip-4DEPCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:00:52 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)) 10:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:00:52 INFO - Running setup.py (path:/tmp/pip-HoI3QB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:00:52 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)) 10:00:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:00:52 INFO - Running setup.py (path:/tmp/pip-seisjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:00:52 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)) 10:00:52 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)) 10:00:52 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)) 10:00:52 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)) 10:00:52 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)) 10:00:52 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)) 10:00:52 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:00:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:00:52 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 10:00:52 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 10:00:52 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 10:00:52 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 10:00:53 INFO - Downloading blessings-1.6.tar.gz 10:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:00:53 INFO - Installing collected packages: blessings 10:00:53 INFO - Running setup.py install for blessings 10:00:53 INFO - Successfully installed blessings 10:00:53 INFO - Cleaning up... 10:00:53 INFO - Return code: 0 10:00:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:00:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:53 INFO - Reading from file tmpfile_stdout 10:00:53 INFO - Current package versions: 10:00:53 INFO - argparse == 1.2.1 10:00:53 INFO - blessings == 1.6 10:00:53 INFO - blobuploader == 1.2.4 10:00:53 INFO - docopt == 0.6.1 10:00:53 INFO - functools32 == 3.2.3-2 10:00:53 INFO - jsonschema == 2.5.1 10:00:53 INFO - manifestparser == 1.1 10:00:53 INFO - mozInstall == 1.13 10:00:53 INFO - mozcrash == 1.0 10:00:53 INFO - mozdebug == 0.1 10:00:53 INFO - mozdevice == 0.51 10:00:53 INFO - mozfile == 1.2 10:00:53 INFO - mozhttpd == 0.7 10:00:53 INFO - mozinfo == 0.10 10:00:53 INFO - mozleak == 0.1 10:00:53 INFO - mozlog == 3.4 10:00:53 INFO - moznetwork == 0.27 10:00:53 INFO - mozprocess == 0.25 10:00:53 INFO - mozprofile == 0.28 10:00:53 INFO - mozrunner == 6.13 10:00:53 INFO - mozscreenshot == 0.1 10:00:53 INFO - mozsystemmonitor == 0.3 10:00:53 INFO - moztest == 0.8 10:00:53 INFO - mozversion == 1.4 10:00:53 INFO - psutil == 3.1.1 10:00:53 INFO - requests == 1.2.3 10:00:53 INFO - wsgiref == 0.1.2 10:00:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:00:53 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')]} 10:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:53 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')]} 10:00:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:53 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 0x240d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789140>, '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 0x2789a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789ed0>, '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': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', '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 10:00:53 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 10:00:53 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 10:00:53 INFO - Using env: {'DISPLAY': ':0', 10:00:53 INFO - 'HOME': '/home/cltbld', 10:00:53 INFO - 'LANG': 'en_US.UTF-8', 10:00:53 INFO - 'LANGUAGE': 'en_US:en', 10:00:53 INFO - 'LOGNAME': 'cltbld', 10:00:53 INFO - 'MAIL': '/var/mail/cltbld', 10:00:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:53 INFO - 'MOZ_NO_REMOTE': '1', 10:00:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:53 INFO - 'NO_EM_RESTART': '1', 10:00:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:53 INFO - 'PWD': '/builds/slave/test', 10:00:53 INFO - 'SHELL': '/bin/bash', 10:00:53 INFO - 'SHLVL': '1', 10:00:53 INFO - 'TERM': 'linux', 10:00:53 INFO - 'TMOUT': '86400', 10:00:53 INFO - 'USER': 'cltbld', 10:00:53 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', 10:00:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:53 INFO - '_': '/tools/buildbot/bin/python'} 10:00:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:53 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)) 10:00:53 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)) 10:00:53 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)) 10:00:53 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)) 10:00:53 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)) 10:00:53 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)) 10:00:53 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)) 10:00:53 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)) 10:00:53 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)) 10:00:53 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:00:53 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 10:00:53 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 10:00:53 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 10:00:53 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 10:00:54 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:00:55 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)) 10:00:55 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)) 10:00:55 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)) 10:00:55 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)) 10:00:55 INFO - Installing collected packages: marionette-driver 10:00:55 INFO - Running setup.py install for marionette-driver 10:00:55 INFO - Successfully installed marionette-driver 10:00:55 INFO - Cleaning up... 10:00:55 INFO - Return code: 0 10:00:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:00:55 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')]} 10:00:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:00:55 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')]} 10:00:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:00:55 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 0x240d3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x278b9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2789140>, '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 0x2789a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789ed0>, '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': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', '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 10:00:55 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 10:00:55 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 10:00:55 INFO - Using env: {'DISPLAY': ':0', 10:00:55 INFO - 'HOME': '/home/cltbld', 10:00:55 INFO - 'LANG': 'en_US.UTF-8', 10:00:55 INFO - 'LANGUAGE': 'en_US:en', 10:00:55 INFO - 'LOGNAME': 'cltbld', 10:00:55 INFO - 'MAIL': '/var/mail/cltbld', 10:00:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:00:55 INFO - 'MOZ_NO_REMOTE': '1', 10:00:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:00:55 INFO - 'NO_EM_RESTART': '1', 10:00:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:00:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:00:55 INFO - 'PWD': '/builds/slave/test', 10:00:55 INFO - 'SHELL': '/bin/bash', 10:00:55 INFO - 'SHLVL': '1', 10:00:55 INFO - 'TERM': 'linux', 10:00:55 INFO - 'TMOUT': '86400', 10:00:55 INFO - 'USER': 'cltbld', 10:00:55 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', 10:00:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:00:55 INFO - '_': '/tools/buildbot/bin/python'} 10:00:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:00:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:00:55 INFO - Cleaning up... 10:00:55 INFO - Return code: 0 10:00:55 INFO - Running post-action listener: _resource_record_post_action 10:00:55 INFO - Running post-action listener: _start_resource_monitoring 10:00:55 INFO - Starting resource monitoring. 10:00:55 INFO - [mozharness: 2017-07-20 17:00:55.495461Z] Finished create-virtualenv step (success) 10:00:55 INFO - [mozharness: 2017-07-20 17:00:55.495994Z] Running install step. 10:00:55 INFO - Running pre-action listener: _resource_record_pre_action 10:00:55 INFO - Running main action method: install 10:00:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:00:55 INFO - Reading from file tmpfile_stdout 10:00:55 INFO - Detecting whether we're running mozinstall >=1.0... 10:00:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:00:55 INFO - Reading from file tmpfile_stdout 10:00:55 INFO - Output received: 10:00:55 INFO - Usage: mozinstall [options] installer 10:00:55 INFO - Options: 10:00:55 INFO - -h, --help show this help message and exit 10:00:55 INFO - -d DEST, --destination=DEST 10:00:55 INFO - Directory to install application into. [default: 10:00:55 INFO - "/builds/slave/test"] 10:00:55 INFO - --app=APP Application being installed. [default: firefox] 10:00:55 INFO - mkdir: /builds/slave/test/build/application 10:00:55 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'] 10:00:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:01:12 INFO - Reading from file tmpfile_stdout 10:01:12 INFO - Output received: 10:01:12 INFO - /builds/slave/test/build/application/firefox/firefox 10:01:12 INFO - Running post-action listener: _resource_record_post_action 10:01:12 INFO - [mozharness: 2017-07-20 17:01:12.381762Z] Finished install step (success) 10:01:12 INFO - [mozharness: 2017-07-20 17:01:12.382108Z] Running setup-mitmproxy step. 10:01:12 INFO - Running pre-action listener: _resource_record_pre_action 10:01:12 INFO - Running main action method: setup_mitmproxy 10:01:12 INFO - Skipping: mitmproxy is not required 10:01:12 INFO - Running post-action listener: _resource_record_post_action 10:01:12 INFO - [mozharness: 2017-07-20 17:01:12.383921Z] Finished setup-mitmproxy step (success) 10:01:12 INFO - [mozharness: 2017-07-20 17:01:12.384231Z] Running run-tests step. 10:01:12 INFO - Running pre-action listener: _resource_record_pre_action 10:01:12 INFO - Running main action method: run_tests 10:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:01:12 INFO - Python 2.7.3 10:01:12 INFO - Return code: 0 10:01:12 INFO - grabbing minidump binary from tooltool 10:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:01:12 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 0x2789140>, '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 0x2789a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2789ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:01:12 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 10:01:12 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 10:01:12 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 10:01:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:01:12 INFO - Return code: 0 10:01:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:01:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:01:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:01:12 INFO - ENV: RUST_BACKTRACE is now 1 10:01:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:01:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 10:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 10:01:12 INFO - Using env: {'DISPLAY': ':0', 10:01:12 INFO - 'HOME': '/home/cltbld', 10:01:12 INFO - 'LANG': 'en_US.UTF-8', 10:01:12 INFO - 'LANGUAGE': 'en_US:en', 10:01:12 INFO - 'LOGNAME': 'cltbld', 10:01:12 INFO - 'MAIL': '/var/mail/cltbld', 10:01:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:01:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:01:12 INFO - 'MOZ_NO_REMOTE': '1', 10:01:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:01:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:01:12 INFO - 'NO_EM_RESTART': '1', 10:01:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:01:12 INFO - 'PWD': '/builds/slave/test', 10:01:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:01:12 INFO - 'RUST_BACKTRACE': '1', 10:01:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:01:12 INFO - 'SHELL': '/bin/bash', 10:01:12 INFO - 'SHLVL': '1', 10:01:12 INFO - 'TERM': 'linux', 10:01:12 INFO - 'TMOUT': '86400', 10:01:12 INFO - 'USER': 'cltbld', 10:01:12 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1500569911.655761-982460044', 10:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:01:12 INFO - '_': '/tools/buildbot/bin/python'} 10:01:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 10:01:12 INFO - mozversion application_buildid: 20170720160617 10:01:12 INFO - mozversion application_changeset: 293c0a44fda7e1b2f895d18a6411275172269d50 10:01:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:01:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:01:12 INFO - mozversion application_name: Firefox 10:01:12 INFO - mozversion application_remotingname: firefox-dev 10:01:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:01:12 INFO - mozversion application_vendor: Mozilla 10:01:12 INFO - mozversion application_version: 55.0 10:01:12 INFO - mozversion platform_buildid: 20170720160617 10:01:12 INFO - mozversion platform_changeset: 293c0a44fda7e1b2f895d18a6411275172269d50 10:01:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:01:12 INFO - mozversion platform_version: 55.0 10:01:12 INFO - using testdate: 1500570072 10:01:12 INFO - actual date: 1500570072 10:01:12 INFO - starting webserver on 'localhost:45976' 10:01:12 INFO - SUITE-START | Running 2 tests 10:01:12 INFO - TEST-START | dromaeo_css 10:01:12 INFO - operating with platform_type : linux_ 10:01:12 INFO - Initialising browser for dromaeo_css test... 10:01:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45976/getInfo.html -profile /tmp/tmpV3h3NM/profile 10:01:12 INFO - TEST-INFO | started process 5488 (/builds/slave/test/build/application/firefox/firefox http://localhost:45976/getInfo.html) 10:01:47 INFO - TEST-INFO | 5488: killed by SIGTERM 10:01:47 INFO - Browser initialized. 10:01:47 INFO - Running cycle 1/1 for dromaeo_css test... 10:01:47 INFO - TEST-INFO | started process 5693 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV3h3NM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:01:58 INFO - PID 5693 | RSS: Main: 158203904 10:01:58 INFO - PID 5693 | 10:05:00 INFO - PID 5693 | Cycle 1(1): loaded http://localhost:45976/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45976/tests/dromaeo/cssquery-ext.html) 10:05:02 INFO - PID 5693 | RSS: Main: 165007360 10:05:02 INFO - PID 5693 | 10:08:03 INFO - PID 5693 | Cycle 1(1): loaded http://localhost:45976/tests/dromaeo/cssquery-ext.html (next: http://localhost:45976/tests/dromaeo/cssquery-jquery.html) 10:08:04 INFO - PID 5693 | RSS: Main: 164782080 10:08:04 INFO - PID 5693 | 10:11:05 INFO - PID 5693 | Cycle 1(1): loaded http://localhost:45976/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45976/tests/dromaeo/cssquery-mootools.html) 10:11:06 INFO - PID 5693 | RSS: Main: 164712448 10:11:06 INFO - PID 5693 | 10:14:08 INFO - PID 5693 | Cycle 1(1): loaded http://localhost:45976/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45976/tests/dromaeo/cssquery-prototype.html) 10:14:08 INFO - PID 5693 | RSS: Main: 168407040 10:14:08 INFO - PID 5693 | 10:17:11 INFO - PID 5693 | Cycle 1(1): loaded http://localhost:45976/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45976/tests/dromaeo/cssquery-yui.html) 10:17:11 INFO - PID 5693 | RSS: Main: 167104512 10:17:11 INFO - PID 5693 | 10:20:13 INFO - PID 5693 | Cycle 1(1): loaded http://localhost:45976/tests/dromaeo/cssquery-yui.html (next: http://localhost:45976/tests/dromaeo/cssquery-dojo.html) 10:20:13 INFO - PID 5693 | RSS: Main: 165560320 10:20:13 INFO - PID 5693 | 10:20:13 INFO - PID 5693 | __start_tp_report 10:20:13 INFO - PID 5693 | _x_x_mozilla_page_load 10:20:13 INFO - PID 5693 | _x_x_mozilla_page_load_details 10:20:13 INFO - PID 5693 | |i|pagename|runs| 10:20:13 INFO - PID 5693 | |0;dojo.html;3499.352619765342;3549.2901419716063;3557.217412169323;3559.0746405934456;3586.713062954964;6097.512199024073;6098.939010609893;6148.139260503527;6173.722182501787;6277.623342599447;6215.720292586833;6233.065040243954;6235.968820155893;6241.531885108612;6244.281907580618;5517.503424691777;5521.806736764214;5534.833954981357;5570.969370666439;5590.245316882209;5464.480874316953;5484.588655850807;5508.228847961289;5517.282753242073;5553.805616803393;5399.649022813504;5475.534579560742;5476.096444086721;5508.03609368363;5534.889302213974;5556.972215138899;5566.443355664442;5583.6928968906695;5601.271834661508;5610.607257491977;5467.480589344006;5534.1975413565215;5538.9169162462595;5553.944460555384;5558.610897237195;6159.938400615982;6169.969150154266;6176.7838125665385;6184.196054512884;6189.473894718954;6518.674066296666;6579.0460383244645;6589.901151482732;6643.335666433318;6658.86682266352;6836.1113055302985;6850.4862135340045;6856;6866.485013623948;6867.793966181022;6319.210098737658;6388.233411990498;6390.13733146024;6396.360363963567;6404.199475065617;6628.635425051572;6678.065070889982;7000.509964302551;7005.859882802417;7019.19279282889;6514.120593719882;6531.6081035137095;6532.248791388956;6534.085228068075;6570.178727659043;6706.960421134732;6778.8305292367095;6780.93219067803;6786;6813.591184528944;6617.404433600999;6712.563683360566;6716.3955244028275;6721.1598550181225;6746.831329216809;6725.192976842713;6726.697298621574;6730.899036514456;6736.528443008942;6748.223954245226;5015.623828212899;5047.9495205048215;5049.293098966147;5052.216906379517;5069.923951140736;4394.934075988863;4439.600435960714;4441.71128876622;4446.555344465528;4528.705634133771;6394.744210231632;6429.935700643027;6430.678466076677;6431.935680643227;6454.064160696673;6776.525643205027;6835.555688880207;6836.213835408992;6836.282190370039;6845.691943862538;6382.361763823674;6413.29453760086;6414.839629009219;6417.96791016042;6430.067640192239;5520.696361700145;5639.210510528529;5689.43105689436;5699.544036477072;5702.971485142548;6931.445484361239;6982.1970473395195;6984.40632546219;7023.8595228095155;7027.648617569203;6750.35871592198;6771.966140169465;6833.58998460094;6844.315568443116;6846.041554182518;6970.51206415546;6991.650417479004;6996.930030699627;7002.509824312249;7003.789886303419;6689.163854518185;6689.163854518185;6689.698963546554;6698.028785826125;6699.0621313015245;6560.901586476302;6654.767083152066;6656.700448479927;6739.73041078371;6821.045053692388;6594.208694956636;6616.437602803623;6640.269570347355;6660.800175994728;6680.866382672417;6630.336966303331;6643.667816609247;6650;6672.599644021374;6682.665866706548;6597.50518711089;6633.900491492728;6644.83387915306;6650.401463868275;6670;6388.8083357499345;6510.381513756186;6553.442957348679;6620.768273110611;6642.535022548375;6420.133282007057;6460.127882735958;6499.252585952676;6509.479241660751;6513.934860651522 10:20:13 INFO - PID 5693 | |1;ext.html;684.4250829303384;723.5586292361659;744.7356188553064;746.7013194722107;750.89487471754;29315.560266595992;30069.849650751745;30154.849225753842;30209.546856797166;37218;40259.597404026026;40429.191416171736;40603;40681.796591017075;40731.79634101833;7324.853502929952;7360.521566098213;7408.851822963565;7433.219511951248;7434.702611895517;7283.672234749449;7342.4493163012985;7385.224551422104;7395.741149059784;7402.3707984821085;7375.262473752636;7383.630818459083;7406.333429991299;7515.549067055967;7521.135069467026;7503.587302698349;7559.735409260705;7594.5822979736095;7609.239076092402;7639.388848892076;7173.354398104144;7210.819729506752;7237.3848222901115;7257.709691612329;7263.927360726378;37148.81425592882;37653.24693506142;37802.62197378019;37806.24387512262;37976.43035354472;3522.6653467920505;3535.1515636247373;3541.451075083366;3546.202104526487;3554.964450355489;29690.109296721133;29725.256868578243;29736.55395169074;29765.255868603243;29780.851095744598;3336.282699219655;3366.091155388056;3379.797212167278;3380.8985730428126;3424.8630054797777;179584;181513.0924345383;220062;221470;221685;40596.54929330981;46395;46920;47133.76433117881;47314.290285645744;50410.49589504058;50445.24332135021;50491.747541262055;50673;50684.691801196575;17197.7420338695;17316.567085822702;17319.56701082458;17335.913320433316;17364.652706946043;14187.503437379642;14214.573562793134;14235.85764142366;14316;14346.139231646135;14509.564713058626;14616.123032618078;14619.342129603981;14647.194404307866;14688.265586720834;5712.485876271073;5738.741756620962;5853.678047707417;5904.468597826216;5937.851553711192;1029.577873072037;1041.4116024446316;1044.5978298355035;1066.589363095214;1082.5128692088592;23604.173853915032;24144.517109657707;24498.51002979966;24584.508309834062;25046.121540884506;1150.396042077899;1152.5562658376418;1153.331067980586;1180.612779983533;1182.633383651071;12869.22784632925;12899.613011609667;12936.547220847413;13218.140820846615;13232;277616;278472;279359;281716;282615;53901.73049134729;54111.72944135254;54405;54451.45548544543;54516.727416362664;1453.4694836384645;1505.9698806023819;1514.0310201471068;1523.9064698661514;1542.7371110102276;24033;28692.569611455427;30266;30289.697103028688;30348.24129396783;49346.75326623344;49728;49857;50158.49841501538;50287.49712502828;213388;213534;213954;214955;215729;29957;30237.244068897573;30718.078457646305;31762.52356214705;32851.67148328486;40170;40193.39709904295;40338.193236134524;40521;42008.789956051245;29748.553771693874;30808.53787193239;31151.84424077865;31159.37681246317;32061.198470038435;30796.38407231798;31062.22344441317;31244.531332029583;31738.52392214165;31810.204744880637;37193.81403092967;37222.813885930394;37230;37397.6260237405;37513;29312.853435732686;30459.390812184076;30771.692283077777;30975.69024309728;31357.686423135478;23410.414739631644;25378.746212538375;25603.23190304294;25767.613485797352;25945.481090378464 10:20:13 INFO - PID 5693 | |2;jquery.html;542.4467043615509;544.3984397241051;546.8988237176122;566.5014786987451;568.6815383385303;21308.89345553272;22147.114115435365;22189.334319970385;22209.55580888381;22290;24357.878210608924;25182.496350072986;26068.60897086545;26100.73899261007;26248;5935.614185077978;6025.578209525335;6054.364291749369;6055.666938318391;6060.454559089681;6018.398160183969;6019.367966363535;6052.667103309316;6056.848578785543;6068.27180738312;5630.380658127623;5929.940700593003;5997.070454079603;6001.579889407743;6025.638461692312;6033.607815492001;6049.5462840287155;6051.152838602599;6071.089336599545;6076.361981991893;5661.8584535386535;5670.461306175906;5675.34733505648;5686.829395118111;5687.971560142214;29432.8528357359;29757.553636695466;29810.850945745133;29866.70133298661;29876.402471950656;2276.6243569810963;2364.929052128439;2365.810735141202;2370.7155141382973;2396.053558844264;20734.170633174654;20866.95665216733;20912.058957346955;20926.267580634758;20938.89530552353;2498.762617551348;2513.861737604431;2566.7304932982142;2568.7559681830385;2602.817802753808;137804;141308;142047.28976355155;142059;142499;21386.679199812017;21392.251271205743;22826.65760013601;23235.514672799214;23772.405689857893;44882.775586122516;45033.77483112629;45189.54810451919;45321.77339113283;45378.77310613492;11735.647930562096;11800.17398782077;11819;11828.526858925547;12022.699432514257;9824.115829575372;9927.80144397108;9957.502124893726;9998.900010999942;10047.648332308334;11906.226095303777;12100.636980890587;12321.507139714491;12380.62858114258;12524.937375313066;2676.4780867730606;2728.4815884982186;4268.487781466244;4545.477270113979;4631.791569379386;987.8294221347583;1007.3905287301077;1023.2888142740724;1062.829947208443;1065.3128731967838;21450;21546.892265538572;21580.352589422342;21594;21757.67363489549;1059.6026490066224;1080.1197024425069;1080.1844607321423;1111.4387234446554;1130.2483848240993;11367.658970230907;11393.487293071832;11511.25176863518;11541.711457213636;11599.942000290113;544201;559636;561245;566658;568005;110076.4496177514;110092;111734;112239.43880280547;113687.43156284331;1224.1186345830988;1251.3180316727405;1260.684828792802;1271.0975207602705;1272.026899421943;17504.737428938322;18680.53298667544;18722.906385467984;19188.424347269603;19330.516737081685;51854.74072629613;52543.47456525539;52577;54278.728606356715;54426.727866360416;65568.34431655813;67061;67849.66075169592;68103;69509;12211.69470763238;12565.371731413576;12662.620121396372;12673.93663031679;12695.492180312684;17674.77029763041;18536.0731963404;18778.15498302607;18906;18990.810091898904;15662.843371566138;15811.446599368966;15965.521034368987;16080.195990200209;16124.355025799307;13597.116187447784;14024.439022438988;14027;14448.927755361156;14521.564353069425;15946.68106637884;17098.230579623698;17200.655986880443;17269.827301726822;17326.220320085373;12221.327826969602;12221.877781222074;12222.938885305517;12337.074719395901;12372;15292.464763733216;15953;16047;16266.51200463988;16360.34558617642 10:20:13 INFO - PID 5693 | |3;mootools.html;1400.5168216965146;1450.1444147952711;1459.3141223624905;1464.4508309383975;1488.3748825493287;13545.390457429414;14040.227787471686;14186.503472378468;14210.147391156537;14225.71548569028;13930.164190148573;14176.78734818976;14180.858191418083;14183.361748721307;14214.573562793106;2620.174644986828;2654.9070782522617;2656.415588570521;2664.4138289576263;2666.3734022504696;2635.6441880346197;2717.1305182341657;2747.8213916095488;2766.4743698697184;2774.7780177585746;2830.037787152368;2851.6863145054026;2860.8569571521443;2866.4410439964217;2873.913782586526;2515.5094756522485;2542.084849454195;2551.8341307815026;2553.9361515962064;2571.90998315059;2706.742859428351;2708.0657173275386;2708.1469337158733;2733.248356701903;2738.904138355148;13597.252151131685;13934.372953217027;13989.930050349785;13990.370433330525;14031.43874245029;7682.308592226726;7938.483998540134;7940.086890007666;7940.364770818321;7954.840903181904;4436.378906953029;4515.503294637587;4588.655850811169;4598.724076555417;4636.652251081148;1447.905886117399;1458.5259790568107;1467.0610809082195;1469.8236211654562;1487.8586534279227;23442.882785585964;23802.880985595133;23822.404439888967;23839;23847.523049539086;6525.902111468332;6537.1174891389055;6549.783677773492;6573.638449885302;6660.433863121689;16060.357585696442;16078.598035048983;16111.67776644484;16130.919345403432;16237.350505979864;7713.460057796013;7866.056073271129;7870;7870.645820938072;7877.251661092187;6852.794416167523;7300.561966281934;7313.305236002571;7323.304286092813;7406.111266648037;5348.358197016383;5457.508824205841;5462.8361149165585;5489.39616642169;5502.147167189092;1336.6791969927342;1349.9865001350058;1582.8100627924723;1593.9362425503082;1604.7031299209684;943.9433633981984;948.9572969216401;955.8470644696815;961.9038096190465;979.9706008819746;8620.568971551398;8658.307335413152;8680.565971701515;8749.737507874774;8757.343199260082;1031.8091153136543;1062.219268837404;1073.4847273308856;1076.6662334676275;1096.8903109689127;5251.842444726664;5405;5459.208414779835;5586.469285417878;5637.869538719745;18027.639447210982;19196.328128515433;19684.409467715992;19710.60578788416;19724.40826775199;18650.440486785417;19347.226110955686;19485.90257048706;19529.316473923343;19761.110750016283;10966.287191332538;11343.319400835811;11485.540578376938;11498.42507874603;11580.76838463226;7926.445148839526;8108.3513318933165;8442.577871106543;8573.614187361709;8857.734267971971;16701.66596668084;16894.915525422293;16919.577010574343;17782.733259000866;17935.461936141935;15680.686386272439;16182;16310.918445407697;16615.08617026075;16657.583560411087;11129.610463633733;11215.719607009563;11352.432378381212;11359.48882300282;11364.54541818318;12639.431225594686;13081.67295817574;13103.410346534238;13233.404496797475;13242.933785331012;10378.273520853469;10650.147988161083;10664.893351066701;10871.456427178451;11095.889041109485;10398.428086455318;10600.628977985734;10762.784744305227;10777.946110269399;11013.724656883642;9333.25333973294;9489.193418559224;9511.048895110434;9513.857292140761;9526;7310.378617817332;7366.373858222111;7502.924970750222;7561.697532098655;7667.923320766721;7333.266673332624;7687.692492300469;7690.9230907692445;7797.532148071134;7897.1707970662255 10:20:13 INFO - PID 5693 | |4;prototype.html;472.9929051064237;492.14612647057373;502.2441225954938;506.8352785344762;519.9220116982455;6256.84357891053;6332.746690132395;6362.840928976772;6379.808605741823;6428.3250258722865;6261.217347831521;6280.4661603763625;6284;6312.179416675837;6332.3351048139975;4923.679960802545;4934.605231581483;4939.555440010398;4953.207486802113;4992.825251116212;4983.277424773406;4985.6260780441435;4992.126377883874;4992.425871024842;4997.825076122336;4747.620190384779;4959.851204463872;4962.354893863792;4964.776585053663;4976.626752993522;4941.135301322254;4962.330085438492;4964.106460837048;4970.850874473772;4998.425810707488;4437.689361744679;4446.555344465528;4451.532589078165;4454.554544545552;4471.686981911267;6164.383561643845;6187.854137727733;6199.783007594712;6217.098520714516;6224.315325314212;5900.940990590125;5917.112433135021;5917.940820591825;5923.526117910556;5927.703614819242;6766.391024807791;6773.4242589379965;6806.319368063204;6807.421369183626;6823.454123670144;5078.13671675816;5080.669756465818;5080.77136528857;5091.9236211456855;5095.872603184913;7047.8590428191665;7047.999999999949;7091.751788687371;7104.289571042906;7105.786826395217;5221;5232.686038837605;5238.528532432099;5252.002119597264;5256.763445644955;5295.735213239323;5297.894042119136;5318.680879147263;5319.521243088141;5330.946690533123;5902.4097590240635;5908.527317814564;5909.793157239476;5917.437843404869;5924.585279030426;6374.26695929974;6795.218549866829;6803.965980170166;6806.557573757789;6810.31896810315;1757.3409971260778;1789.391606853676;1799.5783331168493;1805.1425572853052;1813.5103522048973;1170.4323403149465;1246.8192112143688;1277.6933535951305;1277.7891647877996;1287.3756228229302;6307.013290813379;6311.684415779193;6323.083152942798;6467.676616169173;6475.158229430238;6843.7604683835825;6867.622280774605;6875.7937261882225;6893.414059804973;6907.579149344424;6421.8073457796345;6458.967705161444;6468.8059358219325;6481.870362592722;6508.8047358579315;3598.1904071583685;3618.4029635109914;3629.764065335745;3636.5272514573467;3643.927121457556;7114.181869085018;7117.82205444868;7120.501564890408;7141.750038748619;7168.598519495923;7049.541779784297;7072.929270707227;7076.893846592306;7079.2566780487305;7091.539049961736;7029.964850175818;7084.752033678797;7092.148942126874;7102.360787529147;7104.893426598605;6863.176418829772;6874.828129296808;6884.173899132136;6904.240533541407;6915.51591388598;6704.161979752531;6746.055552222595;6759.628220447923;6795.626240556817;6800.557963732342;6741.426978706669;7089.964550177217;7141.178764441948;7152.5350852196525;7199.71201151948;5582.8325150245555;5607.299087614048;5613.624661957683;5627.521660658726;5652.971735141298;6885.414739747178;6934.306569343025;6949.270326615632;6969.16370035599;6980.7905762827195;6709.597424154566;6740.662966851736;6762.628055456997;6766;6782.642591917032;6754.628495432602;6772.661366931732;6801;6805.489588280998;6808.251092379934;6714.736142549418;6723.462123030048;6738.8652226956165;6756.662166891734;6787.961163107943;6763.323667633197;6796.72813087471;6799.218089919723;6822.283660215606;6823;6586.176727909012;6592.241892182268;6603.7688680895935;6611.148878314079;6623.569467984566 10:20:13 INFO - PID 5693 | |5;yui.html;815.0545367373848;832.4797001873828;848.7284069097889;848.821747433039;851.450814224825;18141.637167256664;18503.167357468912;18550.257989680413;18598.25606975721;18645.533861653465;16976;19163.904180479112;19551.804481955176;19560.51098722529;19669.21323147076;997.6308765756662;1007.969760907174;1015.9949200253989;1016.5476363018423;1020.8621836052113;999.8500224966241;1006.4514839412537;1007.4358359318768;1007.5415685862915;1012.0082319327064;1058.745900983766;1063.2132222155626;1064.249703958711;1065.6802959112274;1067.0823092140752;987.7036888933363;1027.6505987964129;1031.7575369788094;1059.3590877519105;1064.473085822519;759.8404335089638;760.8516339313836;763.6487215880702;764.121260550366;767.4052609227838;16687.83312166887;16727.498175054647;16750.246238919277;16833.494995150166;16878.493645190665;19261.61476770471;20471.38585842427;20601.58796824055;20620.175192992414;20655.277065302642;15576.454824081104;16354.264058117413;16410;16431.671366572722;16587.253573589216;3485.4771784232316;3525.0306165804354;3526.224230669274;3526.5415495985358;3528.188516641161;95928;99330.0066999328;104923;106382.46808765907;107535;14770.929309768268;15145;15576;15643.608909777347;15718;28729.138125856258;28997;29292.121236362516;29444.11667649974;29575.26061848471;8976.371653984159;9176.541172941459;9245.72262832116;9250.583723732449;9296.442213467213;4485.686001979895;4511.751853648016;4512.774361281923;4526.117407105648;4547.772611369418;4897.2898929655;4905.043516514245;4933.432655244621;4958.801647934114;4973.452920178777;889.2667458211772;904.6426661468814;917.3165991336497;924.6301479408156;926.8285367207088;698.3296035805683;698.5494356140262;699.6257002503636;733.1056111543908;737.5537799631146;12550.435230414654;12598.370081495888;13349.399277032557;13656.112352697042;14019.509317174054;696.098552374676;699.8985147153634;702.6802804723839;709.6451774112943;738.9556626602421;5482.205080263339;5922.466977972003;5999.520038396918;6062.090686396988;6072.666003369857;108821.45589272161;112725;113798.96426773543;119084.40457797656;121141.39429302973;99154;101142.49428752957;101986;102982.48508757408;106613;85599.35082285227;88635;89963;91551.08448915559;93480;11265.098792096449;11481.598144064918;11891.702707432383;11996.460159292677;12040.75918481608;42250.15499690051;42330.576694232666;43110;43697.344539832564;43972.34041489444;50797;52639.68400789858;53047.73476132595;54358;54450.45549544454;15938.8406115942;15949.8405015953;15966.68066638684;16247.268872900511;16353.34586616522;16501;16531.752023719895;16544.172791360623;16571.171441428123;16741;15112.244387780347;15236.466723664618;15271.389144434543;15349.155796431303;15474.922625386802;15088.24558772079;15211.315490802719;15418.074915505105;15640.687186255984;15713.607159821097;16178.757318639995;16214.594635134215;16240;16424.917875411025;16434.589135271715;10155.847662284923;10540.367577945348;10627.734306642396;10678.786424271626;10743.89256107429;12054.819177712518;12102.45538950767;12152.027837773134;12255.75488490243;12529.93735031319 10:20:13 INFO - PID 5693 | __end_tp_report 10:20:13 INFO - PID 5693 | __start_cc_report 10:20:13 INFO - PID 5693 | _x_x_mozilla_cycle_collect,295 10:20:13 INFO - PID 5693 | __end_cc_report 10:20:13 INFO - PID 5693 | __startTimestamp1500571213623__endTimestamp 10:20:13 INFO - PID 5693 | 10:20:13 INFO - PID 5693 | ------- Summary: start ------- 10:20:13 INFO - PID 5693 | Number of tests: 6 10:20:13 INFO - PID 5693 | 10:20:13 INFO - PID 5693 | [#0] dojo.html Cycles:165 Average:6216.80 Median:6514.12 stddev:770.43 (11.8%) stddev-sans-first:742.71 10:20:13 INFO - PID 5693 | Values: 3499.4 3549.3 3557.2 3559.1 3586.7 6097.5 6098.9 6148.1 6173.7 6277.6 6215.7 6233.1 6236.0 6241.5 6244.3 5517.5 5521.8 5534.8 5571.0 5590.2 5464.5 5484.6 5508.2 5517.3 5553.8 5399.6 5475.5 5476.1 5508.0 5534.9 5557.0 5566.4 5583.7 5601.3 5610.6 5467.5 5534.2 5538.9 5553.9 5558.6 6159.9 6170.0 6176.8 6184.2 6189.5 6518.7 6579.0 6589.9 6643.3 6658.9 6836.1 6850.5 6856.0 6866.5 6867.8 6319.2 6388.2 6390.1 6396.4 6404.2 6628.6 6678.1 7000.5 7005.9 7019.2 6514.1 6531.6 6532.2 6534.1 6570.2 6707.0 6778.8 6780.9 6786.0 6813.6 6617.4 6712.6 6716.4 6721.2 6746.8 6725.2 6726.7 6730.9 6736.5 6748.2 5015.6 5047.9 5049.3 5052.2 5069.9 4394.9 4439.6 4441.7 4446.6 4528.7 6394.7 6429.9 6430.7 6431.9 6454.1 6776.5 6835.6 6836.2 6836.3 6845.7 6382.4 6413.3 6414.8 6418.0 6430.1 5520.7 5639.2 5689.4 5699.5 5703.0 6931.4 6982.2 6984.4 7023.9 7027.6 6750.4 6772.0 6833.6 6844.3 6846.0 6970.5 6991.7 6996.9 7002.5 7003.8 6689.2 6689.2 6689.7 6698.0 6699.1 6560.9 6654.8 6656.7 6739.7 6821.0 6594.2 6616.4 6640.3 6660.8 6680.9 6630.3 6643.7 6650.0 6672.6 6682.7 6597.5 6633.9 6644.8 6650.4 6670.0 6388.8 6510.4 6553.4 6620.8 6642.5 6420.1 6460.1 6499.3 6509.5 6513.9 10:20:13 INFO - PID 5693 | 10:20:13 INFO - PID 5693 | [#1] ext.html Cycles:180 Average:39792.95 Median:31786.36 stddev:61377.85 (193.1%) stddev-sans-first:61479.79 10:20:13 INFO - PID 5693 | Values: 684.4 723.6 744.7 746.7 750.9 29315.6 30069.8 30154.8 30209.5 37218.0 40259.6 40429.2 40603.0 40681.8 40731.8 7324.9 7360.5 7408.9 7433.2 7434.7 7283.7 7342.4 7385.2 7395.7 7402.4 7375.3 7383.6 7406.3 7515.5 7521.1 7503.6 7559.7 7594.6 7609.2 7639.4 7173.4 7210.8 7237.4 7257.7 7263.9 37148.8 37653.2 37802.6 37806.2 37976.4 3522.7 3535.2 3541.5 3546.2 3555.0 29690.1 29725.3 29736.6 29765.3 29780.9 3336.3 3366.1 3379.8 3380.9 3424.9 179584.0 181513.1 220062.0 221470.0 221685.0 40596.5 46395.0 46920.0 47133.8 47314.3 50410.5 50445.2 50491.7 50673.0 50684.7 17197.7 17316.6 17319.6 17335.9 17364.7 14187.5 14214.6 14235.9 14316.0 14346.1 14509.6 14616.1 14619.3 14647.2 14688.3 5712.5 5738.7 5853.7 5904.5 5937.9 1029.6 1041.4 1044.6 1066.6 1082.5 23604.2 24144.5 24498.5 24584.5 25046.1 1150.4 1152.6 1153.3 1180.6 1182.6 12869.2 12899.6 12936.5 13218.1 13232.0 277616.0 278472.0 279359.0 281716.0 282615.0 53901.7 54111.7 54405.0 54451.5 54516.7 1453.5 1506.0 1514.0 1523.9 1542.7 24033.0 28692.6 30266.0 30289.7 30348.2 49346.8 49728.0 49857.0 50158.5 50287.5 213388.0 213534.0 213954.0 214955.0 215729.0 29957.0 30237.2 30718.1 31762.5 32851.7 40170.0 40193.4 40338.2 40521.0 42008.8 29748.6 30808.5 31151.8 31159.4 32061.2 30796.4 31062.2 31244.5 31738.5 31810.2 37193.8 37222.8 37230.0 37397.6 37513.0 29312.9 30459.4 30771.7 30975.7 31357.7 23410.4 25378.7 25603.2 25767.6 25945.5 10:20:13 INFO - PID 5693 | 10:20:13 INFO - PID 5693 | [#2] jquery.html Cycles:180 Average:37052.21 Median:21587.18 stddev:93379.80 (432.6%) stddev-sans-first:93601.52 10:20:13 INFO - PID 5693 | Values: 542.4 544.4 546.9 566.5 568.7 21308.9 22147.1 22189.3 22209.6 22290.0 24357.9 25182.5 26068.6 26100.7 26248.0 5935.6 6025.6 6054.4 6055.7 6060.5 6018.4 6019.4 6052.7 6056.8 6068.3 5630.4 5929.9 5997.1 6001.6 6025.6 6033.6 6049.5 6051.2 6071.1 6076.4 5661.9 5670.5 5675.3 5686.8 5688.0 29432.9 29757.6 29810.9 29866.7 29876.4 2276.6 2364.9 2365.8 2370.7 2396.1 20734.2 20867.0 20912.1 20926.3 20938.9 2498.8 2513.9 2566.7 2568.8 2602.8 137804.0 141308.0 142047.3 142059.0 142499.0 21386.7 21392.3 22826.7 23235.5 23772.4 44882.8 45033.8 45189.5 45321.8 45378.8 11735.6 11800.2 11819.0 11828.5 12022.7 9824.1 9927.8 9957.5 9998.9 10047.6 11906.2 12100.6 12321.5 12380.6 12524.9 2676.5 2728.5 4268.5 4545.5 4631.8 987.8 1007.4 1023.3 1062.8 1065.3 21450.0 21546.9 21580.4 21594.0 21757.7 1059.6 1080.1 1080.2 1111.4 1130.2 11367.7 11393.5 11511.3 11541.7 11599.9 544201.0 559636.0 561245.0 566658.0 568005.0 110076.4 110092.0 111734.0 112239.4 113687.4 1224.1 1251.3 1260.7 1271.1 1272.0 17504.7 18680.5 18722.9 19188.4 19330.5 51854.7 52543.5 52577.0 54278.7 54426.7 65568.3 67061.0 67849.7 68103.0 69509.0 12211.7 12565.4 12662.6 12673.9 12695.5 17674.8 18536.1 18778.2 18906.0 18990.8 15662.8 15811.4 15965.5 16080.2 16124.4 13597.1 14024.4 14027.0 14448.9 14521.6 15946.7 17098.2 17200.7 17269.8 17326.2 12221.3 12221.9 12222.9 12337.1 12372.0 15292.5 15953.0 16047.0 16266.5 16360.3 10:20:13 INFO - PID 5693 | 10:20:13 INFO - PID 5693 | [#3] mootools.html Cycles:180 Average:8832.05 Median:2528.80 stddev:5954.02 (235.4%) stddev-sans-first:5944.54 10:20:13 INFO - PID 5693 | Values: 1400.5 1450.1 1459.3 1464.5 1488.4 13545.4 14040.2 14186.5 14210.1 14225.7 13930.2 14176.8 14180.9 14183.4 14214.6 2620.2 2654.9 2656.4 2664.4 2666.4 2635.6 2717.1 2747.8 2766.5 2774.8 2830.0 2851.7 2860.9 2866.4 2873.9 2515.5 2542.1 2551.8 2553.9 2571.9 2706.7 2708.1 2708.1 2733.2 2738.9 13597.3 13934.4 13989.9 13990.4 14031.4 7682.3 7938.5 7940.1 7940.4 7954.8 4436.4 4515.5 4588.7 4598.7 4636.7 1447.9 1458.5 1467.1 1469.8 1487.9 23442.9 23802.9 23822.4 23839.0 23847.5 6525.9 6537.1 6549.8 6573.6 6660.4 16060.4 16078.6 16111.7 16130.9 16237.4 7713.5 7866.1 7870.0 7870.6 7877.3 6852.8 7300.6 7313.3 7323.3 7406.1 5348.4 5457.5 5462.8 5489.4 5502.1 1336.7 1350.0 1582.8 1593.9 1604.7 943.9 949.0 955.8 961.9 980.0 8620.6 8658.3 8680.6 8749.7 8757.3 1031.8 1062.2 1073.5 1076.7 1096.9 5251.8 5405.0 5459.2 5586.5 5637.9 18027.6 19196.3 19684.4 19710.6 19724.4 18650.4 19347.2 19485.9 19529.3 19761.1 10966.3 11343.3 11485.5 11498.4 11580.8 7926.4 8108.4 8442.6 8573.6 8857.7 16701.7 16894.9 16919.6 17782.7 17935.5 15680.7 16182.0 16310.9 16615.1 16657.6 11129.6 11215.7 11352.4 11359.5 11364.5 12639.4 13081.7 13103.4 13233.4 13242.9 10378.3 10650.1 10664.9 10871.5 11095.9 10398.4 10600.6 10762.8 10777.9 11013.7 9333.3 9489.2 9511.0 9513.9 9526.0 7310.4 7366.4 7502.9 7561.7 7667.9 7333.3 7687.7 7690.9 7797.5 7897.2 10:20:13 INFO - PID 5693 | 10:20:13 INFO - PID 5693 | [#4] prototype.html Cycles:180 Average:5731.47 Median:6368.55 stddev:1636.49 (25.7%) stddev-sans-first:1592.78 10:20:13 INFO - PID 5693 | Values: 473.0 492.1 502.2 506.8 519.9 6256.8 6332.7 6362.8 6379.8 6428.3 6261.2 6280.5 6284.0 6312.2 6332.3 4923.7 4934.6 4939.6 4953.2 4992.8 4983.3 4985.6 4992.1 4992.4 4997.8 4747.6 4959.9 4962.4 4964.8 4976.6 4941.1 4962.3 4964.1 4970.9 4998.4 4437.7 4446.6 4451.5 4454.6 4471.7 6164.4 6187.9 6199.8 6217.1 6224.3 5900.9 5917.1 5917.9 5923.5 5927.7 6766.4 6773.4 6806.3 6807.4 6823.5 5078.1 5080.7 5080.8 5091.9 5095.9 7047.9 7048.0 7091.8 7104.3 7105.8 5221.0 5232.7 5238.5 5252.0 5256.8 5295.7 5297.9 5318.7 5319.5 5330.9 5902.4 5908.5 5909.8 5917.4 5924.6 6374.3 6795.2 6804.0 6806.6 6810.3 1757.3 1789.4 1799.6 1805.1 1813.5 1170.4 1246.8 1277.7 1277.8 1287.4 6307.0 6311.7 6323.1 6467.7 6475.2 6843.8 6867.6 6875.8 6893.4 6907.6 6421.8 6459.0 6468.8 6481.9 6508.8 3598.2 3618.4 3629.8 3636.5 3643.9 7114.2 7117.8 7120.5 7141.8 7168.6 7049.5 7072.9 7076.9 7079.3 7091.5 7030.0 7084.8 7092.1 7102.4 7104.9 6863.2 6874.8 6884.2 6904.2 6915.5 6704.2 6746.1 6759.6 6795.6 6800.6 6741.4 7090.0 7141.2 7152.5 7199.7 5582.8 5607.3 5613.6 5627.5 5653.0 6885.4 6934.3 6949.3 6969.2 6980.8 6709.6 6740.7 6762.6 6766.0 6782.6 6754.6 6772.7 6801.0 6805.5 6808.3 6714.7 6723.5 6738.9 6756.7 6788.0 6763.3 6796.7 6799.2 6822.3 6823.0 6586.2 6592.2 6603.8 6611.1 6623.6 10:20:13 INFO - PID 5693 | 10:20:13 INFO - PID 5693 | [#5] yui.html Cycles:180 Average:22367.63 Median:18322.40 stddev:30759.33 (167.9%) stddev-sans-first:30803.04 10:20:13 INFO - PID 5693 | Values: 815.1 832.5 848.7 848.8 851.5 18141.6 18503.2 18550.3 18598.3 18645.5 16976.0 19163.9 19551.8 19560.5 19669.2 997.6 1008.0 1016.0 1016.5 1020.9 999.9 1006.5 1007.4 1007.5 1012.0 1058.7 1063.2 1064.2 1065.7 1067.1 987.7 1027.7 1031.8 1059.4 1064.5 759.8 760.9 763.6 764.1 767.4 16687.8 16727.5 16750.2 16833.5 16878.5 19261.6 20471.4 20601.6 20620.2 20655.3 15576.5 16354.3 16410.0 16431.7 16587.3 3485.5 3525.0 3526.2 3526.5 3528.2 95928.0 99330.0 104923.0 106382.5 107535.0 14770.9 15145.0 15576.0 15643.6 15718.0 28729.1 28997.0 29292.1 29444.1 29575.3 8976.4 9176.5 9245.7 9250.6 9296.4 4485.7 4511.8 4512.8 4526.1 4547.8 4897.3 4905.0 4933.4 4958.8 4973.5 889.3 904.6 917.3 924.6 926.8 698.3 698.5 699.6 733.1 737.6 12550.4 12598.4 13349.4 13656.1 14019.5 696.1 699.9 702.7 709.6 739.0 5482.2 5922.5 5999.5 6062.1 6072.7 108821.5 112725.0 113799.0 119084.4 121141.4 99154.0 101142.5 101986.0 102982.5 106613.0 85599.4 88635.0 89963.0 91551.1 93480.0 11265.1 11481.6 11891.7 11996.5 12040.8 42250.2 42330.6 43110.0 43697.3 43972.3 50797.0 52639.7 53047.7 54358.0 54450.5 15938.8 15949.8 15966.7 16247.3 16353.3 16501.0 16531.8 16544.2 16571.2 16741.0 15112.2 15236.5 15271.4 15349.2 15474.9 15088.2 15211.3 15418.1 15640.7 15713.6 16178.8 16214.6 16240.0 16424.9 16434.6 10155.8 10540.4 10627.7 10678.8 10743.9 12054.8 12102.5 12152.0 12255.8 12529.9 10:20:13 INFO - PID 5693 | -------- Summary: end -------- 10:20:13 INFO - PID 5693 | 10:20:14 INFO - TEST-INFO | 5693: exit 0 10:20:14 INFO - TEST-OK | dromaeo_css | took 1141785ms 10:20:14 INFO - TEST-START | kraken 10:20:14 INFO - operating with platform_type : linux_ 10:20:14 INFO - Initialising browser for kraken test... 10:20:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45976/getInfo.html -profile /tmp/tmpDGwvCE/profile 10:20:14 INFO - TEST-INFO | started process 6098 (/builds/slave/test/build/application/firefox/firefox http://localhost:45976/getInfo.html) 10:20:48 INFO - TEST-INFO | 6098: killed by SIGTERM 10:20:48 INFO - Browser initialized. 10:20:48 INFO - Running cycle 1/1 for kraken test... 10:20:48 INFO - TEST-INFO | started process 6304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDGwvCE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:21:00 INFO - PID 6304 | RSS: Main: 158535680 10:21:00 INFO - PID 6304 | 10:21:02 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45976/tests/kraken/driver.html?testName=audio-beat-detection) 10:21:03 INFO - PID 6304 | RSS: Main: 163745792 10:21:03 INFO - PID 6304 | 10:21:06 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45976/tests/kraken/driver.html?testName=audio-dft) 10:21:06 INFO - PID 6304 | RSS: Main: 164671488 10:21:06 INFO - PID 6304 | 10:21:09 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45976/tests/kraken/driver.html?testName=audio-fft) 10:21:10 INFO - PID 6304 | RSS: Main: 165380096 10:21:10 INFO - PID 6304 | 10:21:12 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45976/tests/kraken/driver.html?testName=audio-oscillator) 10:21:12 INFO - PID 6304 | RSS: Main: 165572608 10:21:12 INFO - PID 6304 | 10:21:15 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45976/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:21:15 INFO - PID 6304 | RSS: Main: 165429248 10:21:15 INFO - PID 6304 | 10:21:18 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45976/tests/kraken/driver.html?testName=imaging-darkroom) 10:21:19 INFO - PID 6304 | RSS: Main: 166223872 10:21:19 INFO - PID 6304 | 10:21:22 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45976/tests/kraken/driver.html?testName=imaging-desaturate) 10:21:23 INFO - PID 6304 | RSS: Main: 165797888 10:21:23 INFO - PID 6304 | 10:21:26 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45976/tests/kraken/driver.html?testName=json-parse-financial) 10:21:26 INFO - PID 6304 | RSS: Main: 165679104 10:21:26 INFO - PID 6304 | 10:21:28 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45976/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:21:28 INFO - PID 6304 | RSS: Main: 165187584 10:21:28 INFO - PID 6304 | 10:21:30 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45976/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:21:31 INFO - PID 6304 | RSS: Main: 165371904 10:21:31 INFO - PID 6304 | 10:21:32 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45976/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:21:33 INFO - PID 6304 | RSS: Main: 165740544 10:21:33 INFO - PID 6304 | 10:21:36 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:21:36 INFO - PID 6304 | RSS: Main: 165548032 10:21:36 INFO - PID 6304 | 10:21:39 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:21:40 INFO - PID 6304 | RSS: Main: 165535744 10:21:40 INFO - PID 6304 | 10:21:41 INFO - PID 6304 | Cycle 1(1): loaded http://localhost:45976/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45976/tests/kraken/driver.html?testName=ai-astar) 10:21:42 INFO - PID 6304 | RSS: Main: 167030784 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | __start_tp_report 10:21:42 INFO - PID 6304 | _x_x_mozilla_page_load 10:21:42 INFO - PID 6304 | _x_x_mozilla_page_load_details 10:21:42 INFO - PID 6304 | |i|pagename|runs| 10:21:42 INFO - PID 6304 | |0;ai-astar;98;107;102;108;109;110;107;97;106;107 10:21:42 INFO - PID 6304 | |1;audio-beat-detection;151;118;141;165;116;148;149;120;165;117 10:21:42 INFO - PID 6304 | |2;audio-dft;162;162;162;163;166;169;162;163;162;162 10:21:42 INFO - PID 6304 | |3;audio-fft;75;75;74;183;73;73;73;76;170;76 10:21:42 INFO - PID 6304 | |4;audio-oscillator;81;80;149;81;80;80;129;80;81;138 10:21:42 INFO - PID 6304 | |5;imaging-gaussian-blur;114;113;115;113;114;113;113;114;115;114 10:21:42 INFO - PID 6304 | |6;imaging-darkroom;147;148;149;149;148;149;148;148;150;148 10:21:42 INFO - PID 6304 | |7;imaging-desaturate;94;94;95;94;95;100;100;95;95;95 10:21:42 INFO - PID 6304 | |8;json-parse-financial;48;50;47;47;44;46;49;44;46;46 10:21:42 INFO - PID 6304 | |9;json-stringify-tinderbox;53;52;53;53;53;53;54;55;54;53 10:21:42 INFO - PID 6304 | |10;stanford-crypto-aes;74;74;79;73;72;72;74;74;74;75 10:21:42 INFO - PID 6304 | |11;stanford-crypto-ccm;118;118;120;116;117;124;118;121;120;139 10:21:42 INFO - PID 6304 | |12;stanford-crypto-pbkdf2;182;174;174;172;164;169;174;172;172;172 10:21:42 INFO - PID 6304 | |13;stanford-crypto-sha256-iterative;64;66;62;62;63;64;63;61;63;60 10:21:42 INFO - PID 6304 | __end_tp_report 10:21:42 INFO - PID 6304 | __start_cc_report 10:21:42 INFO - PID 6304 | _x_x_mozilla_cycle_collect,800 10:21:42 INFO - PID 6304 | __end_cc_report 10:21:42 INFO - PID 6304 | __startTimestamp1500571302137__endTimestamp 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | ------- Summary: start ------- 10:21:42 INFO - PID 6304 | Number of tests: 14 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#0] ai-astar Cycles:10 Average:105.10 Median:108.50 stddev:4.53 (4.2%) stddev-sans-first:4.01 10:21:42 INFO - PID 6304 | Values: 98.0 107.0 102.0 108.0 109.0 110.0 107.0 97.0 106.0 107.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:148.50 stddev:19.71 (13.3%) stddev-sans-first:20.42 10:21:42 INFO - PID 6304 | Values: 151.0 118.0 141.0 165.0 116.0 148.0 149.0 120.0 165.0 117.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#2] audio-dft Cycles:10 Average:163.30 Median:162.50 stddev:2.36 (1.5%) stddev-sans-first:2.46 10:21:42 INFO - PID 6304 | Values: 162.0 162.0 162.0 163.0 166.0 169.0 162.0 163.0 162.0 162.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#3] audio-fft Cycles:10 Average:94.80 Median:74.50 stddev:43.18 (58.0%) stddev-sans-first:45.21 10:21:42 INFO - PID 6304 | Values: 75.0 75.0 74.0 183.0 73.0 73.0 73.0 76.0 170.0 76.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:80.00 stddev:28.53 (35.7%) stddev-sans-first:29.60 10:21:42 INFO - PID 6304 | Values: 81.0 80.0 149.0 81.0 80.0 80.0 129.0 80.0 81.0 138.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 10:21:42 INFO - PID 6304 | Values: 114.0 113.0 115.0 113.0 114.0 113.0 113.0 114.0 115.0 114.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#6] imaging-darkroom Cycles:10 Average:148.40 Median:148.50 stddev:0.84 (0.6%) stddev-sans-first:0.73 10:21:42 INFO - PID 6304 | Values: 147.0 148.0 149.0 149.0 148.0 149.0 148.0 148.0 150.0 148.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:2.31 (2.4%) stddev-sans-first:2.37 10:21:42 INFO - PID 6304 | Values: 94.0 94.0 95.0 94.0 95.0 100.0 100.0 95.0 95.0 95.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#8] json-parse-financial Cycles:10 Average:46.70 Median:47.00 stddev:1.95 (4.1%) stddev-sans-first:2.01 10:21:42 INFO - PID 6304 | Values: 48.0 50.0 47.0 47.0 44.0 46.0 49.0 44.0 46.0 46.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#9] json-stringify-tinderbox Cycles:10 Average:53.30 Median:53.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 10:21:42 INFO - PID 6304 | Values: 53.0 52.0 53.0 53.0 53.0 53.0 54.0 55.0 54.0 53.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#10] stanford-crypto-aes Cycles:10 Average:74.10 Median:74.00 stddev:1.97 (2.7%) stddev-sans-first:2.09 10:21:42 INFO - PID 6304 | Values: 74.0 74.0 79.0 73.0 72.0 72.0 74.0 74.0 74.0 75.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#11] stanford-crypto-ccm Cycles:10 Average:121.10 Median:120.00 stddev:6.69 (5.6%) stddev-sans-first:7.00 10:21:42 INFO - PID 6304 | Values: 118.0 118.0 120.0 116.0 117.0 124.0 118.0 121.0 120.0 139.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.50 Median:173.00 stddev:4.50 (2.6%) stddev-sans-first:3.21 10:21:42 INFO - PID 6304 | Values: 182.0 174.0 174.0 172.0 164.0 169.0 174.0 172.0 172.0 172.0 10:21:42 INFO - PID 6304 | 10:21:42 INFO - PID 6304 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.69 (2.7%) stddev-sans-first:1.73 10:21:42 INFO - PID 6304 | Values: 64.0 66.0 62.0 62.0 63.0 64.0 63.0 61.0 63.0 60.0 10:21:42 INFO - PID 6304 | -------- Summary: end -------- 10:21:42 INFO - PID 6304 | 10:21:43 INFO - TEST-INFO | 6304: exit 0 10:21:43 INFO - TEST-OK | kraken | took 88800ms 10:21:43 INFO - SUITE-END | took 1230s 10:21:43 INFO - Completed test suite (00:20:30) 10:21:43 INFO - javascript benchmark 10:21:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8521.209674948448, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3499.352619765342, 3549.2901419716063, 3557.217412169323, 3559.0746405934456, 3586.713062954964, 6097.512199024073, 6098.939010609893, 6148.139260503527, 6173.722182501787, 6277.623342599447, 6215.720292586833, 6233.065040243954, 6235.968820155893, 6241.531885108612, 6244.281907580618, 5517.503424691777, 5521.806736764214, 5534.833954981357, 5570.969370666439, 5590.245316882209, 5464.480874316953, 5484.588655850807, 5508.228847961289, 5517.282753242073, 5553.805616803393, 5399.649022813504, 5475.534579560742, 5476.096444086721, 5508.03609368363, 5534.889302213974, 5556.972215138899, 5566.443355664442, 5583.6928968906695, 5601.271834661508, 5610.607257491977, 5467.480589344006, 5534.1975413565215, 5538.9169162462595, 5553.944460555384, 5558.610897237195, 6159.938400615982, 6169.969150154266, 6176.7838125665385, 6184.196054512884, 6189.473894718954, 6518.674066296666, 6579.0460383244645, 6589.901151482732, 6643.335666433318, 6658.86682266352, 6836.1113055302985, 6850.4862135340045, 6856.0, 6866.485013623948, 6867.793966181022, 6319.210098737658, 6388.233411990498, 6390.13733146024, 6396.360363963567, 6404.199475065617, 6628.635425051572, 6678.065070889982, 7000.509964302551, 7005.859882802417, 7019.19279282889, 6514.120593719882, 6531.6081035137095, 6532.248791388956, 6534.085228068075, 6570.178727659043, 6706.960421134732, 6778.8305292367095, 6780.93219067803, 6786.0, 6813.591184528944, 6617.404433600999, 6712.563683360566, 6716.3955244028275, 6721.1598550181225, 6746.831329216809, 6725.192976842713, 6726.697298621574, 6730.899036514456, 6736.528443008942, 6748.223954245226, 5015.623828212899, 5047.9495205048215, 5049.293098966147, 5052.216906379517, 5069.923951140736, 4394.934075988863, 4439.600435960714, 4441.71128876622, 4446.555344465528, 4528.705634133771, 6394.744210231632, 6429.935700643027, 6430.678466076677, 6431.935680643227, 6454.064160696673, 6776.525643205027, 6835.555688880207, 6836.213835408992, 6836.282190370039, 6845.691943862538, 6382.361763823674, 6413.29453760086, 6414.839629009219, 6417.96791016042, 6430.067640192239, 5520.696361700145, 5639.210510528529, 5689.43105689436, 5699.544036477072, 5702.971485142548, 6931.445484361239, 6982.1970473395195, 6984.40632546219, 7023.8595228095155, 7027.648617569203, 6750.35871592198, 6771.966140169465, 6833.58998460094, 6844.315568443116, 6846.041554182518, 6970.51206415546, 6991.650417479004, 6996.930030699627, 7002.509824312249, 7003.789886303419, 6689.163854518185, 6689.163854518185, 6689.698963546554, 6698.028785826125, 6699.0621313015245, 6560.901586476302, 6654.767083152066, 6656.700448479927, 6739.73041078371, 6821.045053692388, 6594.208694956636, 6616.437602803623, 6640.269570347355, 6660.800175994728, 6680.866382672417, 6630.336966303331, 6643.667816609247, 6650.0, 6672.599644021374, 6682.665866706548, 6597.50518711089, 6633.900491492728, 6644.83387915306, 6650.401463868275, 6670.0, 6388.8083357499345, 6510.381513756186, 6553.442957348679, 6620.768273110611, 6642.535022548375, 6420.133282007057, 6460.127882735958, 6499.252585952676, 6509.479241660751, 6513.934860651522], "value": 6160.270570020104, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.4250829303384, 723.5586292361659, 744.7356188553064, 746.7013194722107, 750.89487471754, 29315.560266595992, 30069.849650751745, 30154.849225753842, 30209.546856797166, 37218.0, 40259.597404026026, 40429.191416171736, 40603.0, 40681.796591017075, 40731.79634101833, 7324.853502929952, 7360.521566098213, 7408.851822963565, 7433.219511951248, 7434.702611895517, 7283.672234749449, 7342.4493163012985, 7385.224551422104, 7395.741149059784, 7402.3707984821085, 7375.262473752636, 7383.630818459083, 7406.333429991299, 7515.549067055967, 7521.135069467026, 7503.587302698349, 7559.735409260705, 7594.5822979736095, 7609.239076092402, 7639.388848892076, 7173.354398104144, 7210.819729506752, 7237.3848222901115, 7257.709691612329, 7263.927360726378, 37148.81425592882, 37653.24693506142, 37802.62197378019, 37806.24387512262, 37976.43035354472, 3522.6653467920505, 3535.1515636247373, 3541.451075083366, 3546.202104526487, 3554.964450355489, 29690.109296721133, 29725.256868578243, 29736.55395169074, 29765.255868603243, 29780.851095744598, 3336.282699219655, 3366.091155388056, 3379.797212167278, 3380.8985730428126, 3424.8630054797777, 179584.0, 181513.0924345383, 220062.0, 221470.0, 221685.0, 40596.54929330981, 46395.0, 46920.0, 47133.76433117881, 47314.290285645744, 50410.49589504058, 50445.24332135021, 50491.747541262055, 50673.0, 50684.691801196575, 17197.7420338695, 17316.567085822702, 17319.56701082458, 17335.913320433316, 17364.652706946043, 14187.503437379642, 14214.573562793134, 14235.85764142366, 14316.0, 14346.139231646135, 14509.564713058626, 14616.123032618078, 14619.342129603981, 14647.194404307866, 14688.265586720834, 5712.485876271073, 5738.741756620962, 5853.678047707417, 5904.468597826216, 5937.851553711192, 1029.577873072037, 1041.4116024446316, 1044.5978298355035, 1066.589363095214, 1082.5128692088592, 23604.173853915032, 24144.517109657707, 24498.51002979966, 24584.508309834062, 25046.121540884506, 1150.396042077899, 1152.5562658376418, 1153.331067980586, 1180.612779983533, 1182.633383651071, 12869.22784632925, 12899.613011609667, 12936.547220847413, 13218.140820846615, 13232.0, 277616.0, 278472.0, 279359.0, 281716.0, 282615.0, 53901.73049134729, 54111.72944135254, 54405.0, 54451.45548544543, 54516.727416362664, 1453.4694836384645, 1505.9698806023819, 1514.0310201471068, 1523.9064698661514, 1542.7371110102276, 24033.0, 28692.569611455427, 30266.0, 30289.697103028688, 30348.24129396783, 49346.75326623344, 49728.0, 49857.0, 50158.49841501538, 50287.49712502828, 213388.0, 213534.0, 213954.0, 214955.0, 215729.0, 29957.0, 30237.244068897573, 30718.078457646305, 31762.52356214705, 32851.67148328486, 40170.0, 40193.39709904295, 40338.193236134524, 40521.0, 42008.789956051245, 29748.553771693874, 30808.53787193239, 31151.84424077865, 31159.37681246317, 32061.198470038435, 30796.38407231798, 31062.22344441317, 31244.531332029583, 31738.52392214165, 31810.204744880637, 37193.81403092967, 37222.813885930394, 37230.0, 37397.6260237405, 37513.0, 29312.853435732686, 30459.390812184076, 30771.692283077777, 30975.69024309728, 31357.686423135478, 23410.414739631644, 25378.746212538375, 25603.23190304294, 25767.613485797352, 25945.481090378464], "value": 17141.894440095555, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.4467043615509, 544.3984397241051, 546.8988237176122, 566.5014786987451, 568.6815383385303, 21308.89345553272, 22147.114115435365, 22189.334319970385, 22209.55580888381, 22290.0, 24357.878210608924, 25182.496350072986, 26068.60897086545, 26100.73899261007, 26248.0, 5935.614185077978, 6025.578209525335, 6054.364291749369, 6055.666938318391, 6060.454559089681, 6018.398160183969, 6019.367966363535, 6052.667103309316, 6056.848578785543, 6068.27180738312, 5630.380658127623, 5929.940700593003, 5997.070454079603, 6001.579889407743, 6025.638461692312, 6033.607815492001, 6049.5462840287155, 6051.152838602599, 6071.089336599545, 6076.361981991893, 5661.8584535386535, 5670.461306175906, 5675.34733505648, 5686.829395118111, 5687.971560142214, 29432.8528357359, 29757.553636695466, 29810.850945745133, 29866.70133298661, 29876.402471950656, 2276.6243569810963, 2364.929052128439, 2365.810735141202, 2370.7155141382973, 2396.053558844264, 20734.170633174654, 20866.95665216733, 20912.058957346955, 20926.267580634758, 20938.89530552353, 2498.762617551348, 2513.861737604431, 2566.7304932982142, 2568.7559681830385, 2602.817802753808, 137804.0, 141308.0, 142047.28976355155, 142059.0, 142499.0, 21386.679199812017, 21392.251271205743, 22826.65760013601, 23235.514672799214, 23772.405689857893, 44882.775586122516, 45033.77483112629, 45189.54810451919, 45321.77339113283, 45378.77310613492, 11735.647930562096, 11800.17398782077, 11819.0, 11828.526858925547, 12022.699432514257, 9824.115829575372, 9927.80144397108, 9957.502124893726, 9998.900010999942, 10047.648332308334, 11906.226095303777, 12100.636980890587, 12321.507139714491, 12380.62858114258, 12524.937375313066, 2676.4780867730606, 2728.4815884982186, 4268.487781466244, 4545.477270113979, 4631.791569379386, 987.8294221347583, 1007.3905287301077, 1023.2888142740724, 1062.829947208443, 1065.3128731967838, 21450.0, 21546.892265538572, 21580.352589422342, 21594.0, 21757.67363489549, 1059.6026490066224, 1080.1197024425069, 1080.1844607321423, 1111.4387234446554, 1130.2483848240993, 11367.658970230907, 11393.487293071832, 11511.25176863518, 11541.711457213636, 11599.942000290113, 544201.0, 559636.0, 561245.0, 566658.0, 568005.0, 110076.4496177514, 110092.0, 111734.0, 112239.43880280547, 113687.43156284331, 1224.1186345830988, 1251.3180316727405, 1260.684828792802, 1271.0975207602705, 1272.026899421943, 17504.737428938322, 18680.53298667544, 18722.906385467984, 19188.424347269603, 19330.516737081685, 51854.74072629613, 52543.47456525539, 52577.0, 54278.728606356715, 54426.727866360416, 65568.34431655813, 67061.0, 67849.66075169592, 68103.0, 69509.0, 12211.69470763238, 12565.371731413576, 12662.620121396372, 12673.93663031679, 12695.492180312684, 17674.77029763041, 18536.0731963404, 18778.15498302607, 18906.0, 18990.810091898904, 15662.843371566138, 15811.446599368966, 15965.521034368987, 16080.195990200209, 16124.355025799307, 13597.116187447784, 14024.439022438988, 14027.0, 14448.927755361156, 14521.564353069425, 15946.68106637884, 17098.230579623698, 17200.655986880443, 17269.827301726822, 17326.220320085373, 12221.327826969602, 12221.877781222074, 12222.938885305517, 12337.074719395901, 12372.0, 15292.464763733216, 15953.0, 16047.0, 16266.51200463988, 16360.34558617642], "value": 12302.465926771638, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.5168216965146, 1450.1444147952711, 1459.3141223624905, 1464.4508309383975, 1488.3748825493287, 13545.390457429414, 14040.227787471686, 14186.503472378468, 14210.147391156537, 14225.71548569028, 13930.164190148573, 14176.78734818976, 14180.858191418083, 14183.361748721307, 14214.573562793106, 2620.174644986828, 2654.9070782522617, 2656.415588570521, 2664.4138289576263, 2666.3734022504696, 2635.6441880346197, 2717.1305182341657, 2747.8213916095488, 2766.4743698697184, 2774.7780177585746, 2830.037787152368, 2851.6863145054026, 2860.8569571521443, 2866.4410439964217, 2873.913782586526, 2515.5094756522485, 2542.084849454195, 2551.8341307815026, 2553.9361515962064, 2571.90998315059, 2706.742859428351, 2708.0657173275386, 2708.1469337158733, 2733.248356701903, 2738.904138355148, 13597.252151131685, 13934.372953217027, 13989.930050349785, 13990.370433330525, 14031.43874245029, 7682.308592226726, 7938.483998540134, 7940.086890007666, 7940.364770818321, 7954.840903181904, 4436.378906953029, 4515.503294637587, 4588.655850811169, 4598.724076555417, 4636.652251081148, 1447.905886117399, 1458.5259790568107, 1467.0610809082195, 1469.8236211654562, 1487.8586534279227, 23442.882785585964, 23802.880985595133, 23822.404439888967, 23839.0, 23847.523049539086, 6525.902111468332, 6537.1174891389055, 6549.783677773492, 6573.638449885302, 6660.433863121689, 16060.357585696442, 16078.598035048983, 16111.67776644484, 16130.919345403432, 16237.350505979864, 7713.460057796013, 7866.056073271129, 7870.0, 7870.645820938072, 7877.251661092187, 6852.794416167523, 7300.561966281934, 7313.305236002571, 7323.304286092813, 7406.111266648037, 5348.358197016383, 5457.508824205841, 5462.8361149165585, 5489.39616642169, 5502.147167189092, 1336.6791969927342, 1349.9865001350058, 1582.8100627924723, 1593.9362425503082, 1604.7031299209684, 943.9433633981984, 948.9572969216401, 955.8470644696815, 961.9038096190465, 979.9706008819746, 8620.568971551398, 8658.307335413152, 8680.565971701515, 8749.737507874774, 8757.343199260082, 1031.8091153136543, 1062.219268837404, 1073.4847273308856, 1076.6662334676275, 1096.8903109689127, 5251.842444726664, 5405.0, 5459.208414779835, 5586.469285417878, 5637.869538719745, 18027.639447210982, 19196.328128515433, 19684.409467715992, 19710.60578788416, 19724.40826775199, 18650.440486785417, 19347.226110955686, 19485.90257048706, 19529.316473923343, 19761.110750016283, 10966.287191332538, 11343.319400835811, 11485.540578376938, 11498.42507874603, 11580.76838463226, 7926.445148839526, 8108.3513318933165, 8442.577871106543, 8573.614187361709, 8857.734267971971, 16701.66596668084, 16894.915525422293, 16919.577010574343, 17782.733259000866, 17935.461936141935, 15680.686386272439, 16182.0, 16310.918445407697, 16615.08617026075, 16657.583560411087, 11129.610463633733, 11215.719607009563, 11352.432378381212, 11359.48882300282, 11364.54541818318, 12639.431225594686, 13081.67295817574, 13103.410346534238, 13233.404496797475, 13242.933785331012, 10378.273520853469, 10650.147988161083, 10664.893351066701, 10871.456427178451, 11095.889041109485, 10398.428086455318, 10600.628977985734, 10762.784744305227, 10777.946110269399, 11013.724656883642, 9333.25333973294, 9489.193418559224, 9511.048895110434, 9513.857292140761, 9526.0, 7310.378617817332, 7366.373858222111, 7502.924970750222, 7561.697532098655, 7667.923320766721, 7333.266673332624, 7687.692492300469, 7690.9230907692445, 7797.532148071134, 7897.1707970662255], "value": 6472.766756401526, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.9929051064237, 492.14612647057373, 502.2441225954938, 506.8352785344762, 519.9220116982455, 6256.84357891053, 6332.746690132395, 6362.840928976772, 6379.808605741823, 6428.3250258722865, 6261.217347831521, 6280.4661603763625, 6284.0, 6312.179416675837, 6332.3351048139975, 4923.679960802545, 4934.605231581483, 4939.555440010398, 4953.207486802113, 4992.825251116212, 4983.277424773406, 4985.6260780441435, 4992.126377883874, 4992.425871024842, 4997.825076122336, 4747.620190384779, 4959.851204463872, 4962.354893863792, 4964.776585053663, 4976.626752993522, 4941.135301322254, 4962.330085438492, 4964.106460837048, 4970.850874473772, 4998.425810707488, 4437.689361744679, 4446.555344465528, 4451.532589078165, 4454.554544545552, 4471.686981911267, 6164.383561643845, 6187.854137727733, 6199.783007594712, 6217.098520714516, 6224.315325314212, 5900.940990590125, 5917.112433135021, 5917.940820591825, 5923.526117910556, 5927.703614819242, 6766.391024807791, 6773.4242589379965, 6806.319368063204, 6807.421369183626, 6823.454123670144, 5078.13671675816, 5080.669756465818, 5080.77136528857, 5091.9236211456855, 5095.872603184913, 7047.8590428191665, 7047.999999999949, 7091.751788687371, 7104.289571042906, 7105.786826395217, 5221.0, 5232.686038837605, 5238.528532432099, 5252.002119597264, 5256.763445644955, 5295.735213239323, 5297.894042119136, 5318.680879147263, 5319.521243088141, 5330.946690533123, 5902.4097590240635, 5908.527317814564, 5909.793157239476, 5917.437843404869, 5924.585279030426, 6374.26695929974, 6795.218549866829, 6803.965980170166, 6806.557573757789, 6810.31896810315, 1757.3409971260778, 1789.391606853676, 1799.5783331168493, 1805.1425572853052, 1813.5103522048973, 1170.4323403149465, 1246.8192112143688, 1277.6933535951305, 1277.7891647877996, 1287.3756228229302, 6307.013290813379, 6311.684415779193, 6323.083152942798, 6467.676616169173, 6475.158229430238, 6843.7604683835825, 6867.622280774605, 6875.7937261882225, 6893.414059804973, 6907.579149344424, 6421.8073457796345, 6458.967705161444, 6468.8059358219325, 6481.870362592722, 6508.8047358579315, 3598.1904071583685, 3618.4029635109914, 3629.764065335745, 3636.5272514573467, 3643.927121457556, 7114.181869085018, 7117.82205444868, 7120.501564890408, 7141.750038748619, 7168.598519495923, 7049.541779784297, 7072.929270707227, 7076.893846592306, 7079.2566780487305, 7091.539049961736, 7029.964850175818, 7084.752033678797, 7092.148942126874, 7102.360787529147, 7104.893426598605, 6863.176418829772, 6874.828129296808, 6884.173899132136, 6904.240533541407, 6915.51591388598, 6704.161979752531, 6746.055552222595, 6759.628220447923, 6795.626240556817, 6800.557963732342, 6741.426978706669, 7089.964550177217, 7141.178764441948, 7152.5350852196525, 7199.71201151948, 5582.8325150245555, 5607.299087614048, 5613.624661957683, 5627.521660658726, 5652.971735141298, 6885.414739747178, 6934.306569343025, 6949.270326615632, 6969.16370035599, 6980.7905762827195, 6709.597424154566, 6740.662966851736, 6762.628055456997, 6766.0, 6782.642591917032, 6754.628495432602, 6772.661366931732, 6801.0, 6805.489588280998, 6808.251092379934, 6714.736142549418, 6723.462123030048, 6738.8652226956165, 6756.662166891734, 6787.961163107943, 6763.323667633197, 6796.72813087471, 6799.218089919723, 6822.283660215606, 6823.0, 6586.176727909012, 6592.241892182268, 6603.7688680895935, 6611.148878314079, 6623.569467984566], "value": 5239.403829175181, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.0545367373848, 832.4797001873828, 848.7284069097889, 848.821747433039, 851.450814224825, 18141.637167256664, 18503.167357468912, 18550.257989680413, 18598.25606975721, 18645.533861653465, 16976.0, 19163.904180479112, 19551.804481955176, 19560.51098722529, 19669.21323147076, 997.6308765756662, 1007.969760907174, 1015.9949200253989, 1016.5476363018423, 1020.8621836052113, 999.8500224966241, 1006.4514839412537, 1007.4358359318768, 1007.5415685862915, 1012.0082319327064, 1058.745900983766, 1063.2132222155626, 1064.249703958711, 1065.6802959112274, 1067.0823092140752, 987.7036888933363, 1027.6505987964129, 1031.7575369788094, 1059.3590877519105, 1064.473085822519, 759.8404335089638, 760.8516339313836, 763.6487215880702, 764.121260550366, 767.4052609227838, 16687.83312166887, 16727.498175054647, 16750.246238919277, 16833.494995150166, 16878.493645190665, 19261.61476770471, 20471.38585842427, 20601.58796824055, 20620.175192992414, 20655.277065302642, 15576.454824081104, 16354.264058117413, 16410.0, 16431.671366572722, 16587.253573589216, 3485.4771784232316, 3525.0306165804354, 3526.224230669274, 3526.5415495985358, 3528.188516641161, 95928.0, 99330.0066999328, 104923.0, 106382.46808765907, 107535.0, 14770.929309768268, 15145.0, 15576.0, 15643.608909777347, 15718.0, 28729.138125856258, 28997.0, 29292.121236362516, 29444.11667649974, 29575.26061848471, 8976.371653984159, 9176.541172941459, 9245.72262832116, 9250.583723732449, 9296.442213467213, 4485.686001979895, 4511.751853648016, 4512.774361281923, 4526.117407105648, 4547.772611369418, 4897.2898929655, 4905.043516514245, 4933.432655244621, 4958.801647934114, 4973.452920178777, 889.2667458211772, 904.6426661468814, 917.3165991336497, 924.6301479408156, 926.8285367207088, 698.3296035805683, 698.5494356140262, 699.6257002503636, 733.1056111543908, 737.5537799631146, 12550.435230414654, 12598.370081495888, 13349.399277032557, 13656.112352697042, 14019.509317174054, 696.098552374676, 699.8985147153634, 702.6802804723839, 709.6451774112943, 738.9556626602421, 5482.205080263339, 5922.466977972003, 5999.520038396918, 6062.090686396988, 6072.666003369857, 108821.45589272161, 112725.0, 113798.96426773543, 119084.40457797656, 121141.39429302973, 99154.0, 101142.49428752957, 101986.0, 102982.48508757408, 106613.0, 85599.35082285227, 88635.0, 89963.0, 91551.08448915559, 93480.0, 11265.098792096449, 11481.598144064918, 11891.702707432383, 11996.460159292677, 12040.75918481608, 42250.15499690051, 42330.576694232666, 43110.0, 43697.344539832564, 43972.34041489444, 50797.0, 52639.68400789858, 53047.73476132595, 54358.0, 54450.45549544454, 15938.8406115942, 15949.8405015953, 15966.68066638684, 16247.268872900511, 16353.34586616522, 16501.0, 16531.752023719895, 16544.172791360623, 16571.171441428123, 16741.0, 15112.244387780347, 15236.466723664618, 15271.389144434543, 15349.155796431303, 15474.922625386802, 15088.24558772079, 15211.315490802719, 15418.074915505105, 15640.687186255984, 15713.607159821097, 16178.757318639995, 16214.594635134215, 16240.0, 16424.917875411025, 16434.589135271715, 10155.847662284923, 10540.367577945348, 10627.734306642396, 10678.786424271626, 10743.89256107429, 12054.819177712518, 12102.45538950767, 12152.027837773134, 12255.75488490243, 12529.93735031319], "value": 8688.796062266343, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 102.0, 108.0, 109.0, 110.0, 107.0, 97.0, 106.0, 107.0], "value": 105.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 118.0, 141.0, 165.0, 116.0, 148.0, 149.0, 120.0, 165.0, 117.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 166.0, 169.0, 162.0, 163.0, 162.0, 162.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 183.0, 73.0, 73.0, 73.0, 76.0, 170.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 149.0, 81.0, 80.0, 80.0, 129.0, 80.0, 81.0, 138.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 113.0, 114.0, 113.0, 113.0, 114.0, 115.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 149.0, 148.0, 149.0, 148.0, 148.0, 150.0, 148.0], "value": 148.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 95.0, 100.0, 100.0, 95.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 50.0, 47.0, 47.0, 44.0, 46.0, 49.0, 44.0, 46.0, 46.0], "value": 46.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 54.0, 55.0, 54.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 79.0, 73.0, 72.0, 72.0, 74.0, 74.0, 74.0, 75.0], "value": 74.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 120.0, 116.0, 117.0, 124.0, 118.0, 121.0, 120.0, 139.0], "value": 121.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 174.0, 174.0, 172.0, 164.0, 169.0, 174.0, 172.0, 172.0, 172.0], "value": 172.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 62.0, 62.0, 63.0, 64.0, 63.0, 61.0, 63.0, 60.0], "value": 62.8, "unit": "score"}]}]} 10:21:43 INFO - Return code: 0 10:21:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:21:43 INFO - # TBPL SUCCESS # 10:21:43 INFO - Running post-action listener: _resource_record_post_action 10:21:43 INFO - [mozharness: 2017-07-20 17:21:43.497674Z] Finished run-tests step (success) 10:21:43 INFO - Running post-run listener: _resource_record_post_run 10:21:43 INFO - Total resource usage - Wall time: 1247s; CPU: 12.0%; Read bytes: 4096; Write bytes: 397094912; Read time: 8; Write time: 254152 10:21:43 INFO - TinderboxPrint: CPU usage
12.5% 10:21:43 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:21:43 INFO - TinderboxPrint: I/O write bytes / time
397,094,912 / 254,152 10:21:43 INFO - TinderboxPrint: CPU idle
8,708.6 (87.5%) 10:21:43 INFO - TinderboxPrint: CPU user
1,193.0 (12.0%) 10:21:43 INFO - TinderboxPrint: Swap in / out
0 / 0 10:21:43 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 98246656; Read time: 0; Write time: 93136 10:21:43 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:21:43 INFO - run-tests - Wall time: 1231s; CPU: 12.0%; Read bytes: 4096; Write bytes: 298848256; Read time: 8; Write time: 161016 10:21:44 INFO - Running post-run listener: _upload_blobber_files 10:21:44 INFO - Blob upload gear active. 10:21:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:21:44 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 10:21:44 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:21:44 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:21:44 INFO - (blobuploader) - INFO - Open directory for files ... 10:21:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:21:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:21:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:48 INFO - (blobuploader) - INFO - Done attempting. 10:21:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:21:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:21:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:49 INFO - (blobuploader) - INFO - Done attempting. 10:21:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:21:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:50 INFO - (blobuploader) - INFO - Done attempting. 10:21:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:21:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:21:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:21:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:21:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:21:51 INFO - (blobuploader) - INFO - Done attempting. 10:21:51 INFO - (blobuploader) - INFO - Iteration through files over. 10:21:51 INFO - Return code: 0 10:21:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:21:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:21:51 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/44cd2aa6725f599cb422130ab844c9d08b94d24ab0090aeec63c46298bbca5f5e4a1f17306c66a9697accc9033f990ac811e84fd128f6022624a5f7bf827efd1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc9f7ca80f9d0cc6d1ef229ff0a5b4f2cbd1870ecc341375661d81c38e30c9b61944707526d422b21f776f18a9c9ab3f6c708bd4f1027a2035e6a50322bb5e09", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40e3dbd590b7a7550e58764d20d4d8d95a1f36a0c192f2b56290a36afc9d380993a8f50d19bdd86fa61d3ad7c4e0b6020444ee516f7e6187bd6b8c0f0e0df9d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36a6f15659faf7fbb052cbfbae23c10bb3cd96a5864cebe6cc011b9437fd2c50de25b1e35a32537c5275c495f036b48ab8122c674ca21174c6adc7b81a7e5988"} 10:21:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:21:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:21:51 INFO - Contents: 10:21:51 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/44cd2aa6725f599cb422130ab844c9d08b94d24ab0090aeec63c46298bbca5f5e4a1f17306c66a9697accc9033f990ac811e84fd128f6022624a5f7bf827efd1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc9f7ca80f9d0cc6d1ef229ff0a5b4f2cbd1870ecc341375661d81c38e30c9b61944707526d422b21f776f18a9c9ab3f6c708bd4f1027a2035e6a50322bb5e09", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40e3dbd590b7a7550e58764d20d4d8d95a1f36a0c192f2b56290a36afc9d380993a8f50d19bdd86fa61d3ad7c4e0b6020444ee516f7e6187bd6b8c0f0e0df9d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36a6f15659faf7fbb052cbfbae23c10bb3cd96a5864cebe6cc011b9437fd2c50de25b1e35a32537c5275c495f036b48ab8122c674ca21174c6adc7b81a7e5988"} 10:21:51 INFO - Running post-run listener: copy_logs_to_upload_dir 10:21:51 INFO - Copying logs to upload dir... 10:21:51 INFO - mkdir: /builds/slave/test/build/upload/logs 10:21:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1306.791925 ========= master_lag: -0.78 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 46 secs) (at 2017-07-20 10:21:48.302610) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-20 10:21:48.305661) ========= 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=232498196343f89f466a4a9a000001c8-1500569911.655761-982460044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/44cd2aa6725f599cb422130ab844c9d08b94d24ab0090aeec63c46298bbca5f5e4a1f17306c66a9697accc9033f990ac811e84fd128f6022624a5f7bf827efd1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc9f7ca80f9d0cc6d1ef229ff0a5b4f2cbd1870ecc341375661d81c38e30c9b61944707526d422b21f776f18a9c9ab3f6c708bd4f1027a2035e6a50322bb5e09", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40e3dbd590b7a7550e58764d20d4d8d95a1f36a0c192f2b56290a36afc9d380993a8f50d19bdd86fa61d3ad7c4e0b6020444ee516f7e6187bd6b8c0f0e0df9d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36a6f15659faf7fbb052cbfbae23c10bb3cd96a5864cebe6cc011b9437fd2c50de25b1e35a32537c5275c495f036b48ab8122c674ca21174c6adc7b81a7e5988"} build_url:https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/G7HVj4DpTqiZL1yK9mDQ1w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/44cd2aa6725f599cb422130ab844c9d08b94d24ab0090aeec63c46298bbca5f5e4a1f17306c66a9697accc9033f990ac811e84fd128f6022624a5f7bf827efd1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc9f7ca80f9d0cc6d1ef229ff0a5b4f2cbd1870ecc341375661d81c38e30c9b61944707526d422b21f776f18a9c9ab3f6c708bd4f1027a2035e6a50322bb5e09", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/40e3dbd590b7a7550e58764d20d4d8d95a1f36a0c192f2b56290a36afc9d380993a8f50d19bdd86fa61d3ad7c4e0b6020444ee516f7e6187bd6b8c0f0e0df9d5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/36a6f15659faf7fbb052cbfbae23c10bb3cd96a5864cebe6cc011b9437fd2c50de25b1e35a32537c5275c495f036b48ab8122c674ca21174c6adc7b81a7e5988"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-20 10:21:48.332659) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 10:21:48.332939) ========= 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=232498196343f89f466a4a9a000001c8-1500569911.655761-982460044 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-20 10:21:48.414896) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-20 10:21:48.415180) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-20 10:21:48.418470) ========= ========= Total master_lag: -0.62 =========