builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-005 starttime: 1502932640.34 results: success (0) revision: 63ca686c3f1e870649b6d9c559973d100573aec2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 18:17:20.336747) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 18:17:20.337515) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 18:17:20.338007) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 18:17:20.365593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 18:17:20.366105) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 18:17:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-08-16 18:17:20 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077507 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 18:17:20.465103) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 18:17:20.465653) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018355 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 18:17:20.519030) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 18:17:20.519532) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 63ca686c3f1e870649b6d9c559973d100573aec2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 63ca686c3f1e870649b6d9c559973d100573aec2 --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=7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 18:17:20,677 truncating revision to first 12 chars 2017-08-16 18:17:20,678 Setting DEBUG logging. 2017-08-16 18:17:20,678 attempt 1/10 2017-08-16 18:17:20,678 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/63ca686c3f1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 18:17:21,288 unpacking tar archive at: mozilla-central-63ca686c3f1e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.009702 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 18:17:21.544116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 18:17:21.544442) ========= script_repo_revision: 63ca686c3f1e870649b6d9c559973d100573aec2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 18:17:21.544829) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 18:17:21.545128) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 18:17:21.556512) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-16 18:17:21.556820) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:17:21 INFO - MultiFileLogger online at 20170816 18:17:21 in /builds/slave/test 18:17:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:17:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:17:21 INFO - {'append_to_log': False, 18:17:21 INFO - 'base_work_dir': '/builds/slave/test', 18:17:21 INFO - 'blob_upload_branch': 'Firefox', 18:17:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:17:21 INFO - 'branch': 'Firefox', 18:17:21 INFO - 'buildbot_json_path': 'buildprops.json', 18:17:21 INFO - 'code_coverage': False, 18:17:21 INFO - 'config_files': ('talos/linux_config.py',), 18:17:21 INFO - 'default_actions': ('clobber', 18:17:21 INFO - 'read-buildbot-config', 18:17:21 INFO - 'download-and-extract', 18:17:21 INFO - 'populate-webroot', 18:17:21 INFO - 'create-virtualenv', 18:17:21 INFO - 'install', 18:17:21 INFO - 'setup-mitmproxy', 18:17:21 INFO - 'run-tests'), 18:17:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:17:21 INFO - 'disable_ccov_upload': False, 18:17:21 INFO - 'download_minidump_stackwalk': True, 18:17:21 INFO - 'download_symbols': 'ondemand', 18:17:21 INFO - 'enable_stylo': False, 18:17:21 INFO - 'enable_webrender': False, 18:17:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:17:21 INFO - 'tooltool.py': '/tools/tooltool.py', 18:17:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:17:21 INFO - '/tools/misc-python/virtualenv.py')}, 18:17:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:17:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:17:21 INFO - 'gecko_profile': False, 18:17:21 INFO - 'gecko_profile_interval': 0, 18:17:21 INFO - 'installer_path': 'installer.exe', 18:17:21 INFO - 'log_level': 'info', 18:17:21 INFO - 'log_name': 'talos', 18:17:21 INFO - 'log_to_console': True, 18:17:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:17:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:17:21 INFO - 'opt_config_files': (), 18:17:21 INFO - 'pip_index': False, 18:17:21 INFO - 'suite': 'dromaeojs-e10s', 18:17:21 INFO - 'system_bits': '32', 18:17:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:17:21 INFO - 'title': 'talos-linux64-ix-005', 18:17:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:17:21 INFO - 'use_talos_json': True, 18:17:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:17:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:17:21 INFO - 'work_dir': 'build'} 18:17:21 INFO - [mozharness: 2017-08-17 01:17:21.824255Z] Running clobber step. 18:17:21 INFO - Running pre-action listener: _resource_record_pre_action 18:17:21 INFO - Running main action method: clobber 18:17:21 INFO - rmtree: /builds/slave/test/build 18:17:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:17:23 INFO - Running post-action listener: _resource_record_post_action 18:17:23 INFO - [mozharness: 2017-08-17 01:17:23.351615Z] Finished clobber step (success) 18:17:23 INFO - [mozharness: 2017-08-17 01:17:23.351716Z] Running read-buildbot-config step. 18:17:23 INFO - Running pre-action listener: _resource_record_pre_action 18:17:23 INFO - Running main action method: read_buildbot_config 18:17:23 INFO - Using buildbot properties: 18:17:23 INFO - { 18:17:23 INFO - "project": "", 18:17:23 INFO - "product": "firefox", 18:17:23 INFO - "who": "kwierso@gmail.com", 18:17:23 INFO - "installer_path": "public/build/target.tar.bz2", 18:17:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:17:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:17:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:17:23 INFO - "stage_platform": "linux64-pgo", 18:17:23 INFO - "basedir": "/builds/slave/test", 18:17:23 INFO - "buildnumber": 123, 18:17:23 INFO - "platform": "ubuntu64_hw", 18:17:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:17:23 INFO - "slavebuilddir": "test", 18:17:23 INFO - "taskId": "MfKpSliqQfmQD21WKXN0cw", 18:17:23 INFO - "branch": "mozilla-central", 18:17:23 INFO - "script_repo_revision": "production", 18:17:23 INFO - "revision": "63ca686c3f1e870649b6d9c559973d100573aec2", 18:17:23 INFO - "slavename": "talos-linux64-ix-005", 18:17:23 INFO - "repo_path": "mozilla-central" 18:17:23 INFO - } 18:17:23 INFO - Finding installer, test and symbols from parent task. 18:17:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MfKpSliqQfmQD21WKXN0cw'}, attempt #1 18:17:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MfKpSliqQfmQD21WKXN0cw'}, attempt #1 18:17:24 INFO - Task dependencies: QxBtMBTTSBGv6jFTm8Uiww 18:17:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww'}, attempt #1 18:17:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.tar.bz2 18:17:24 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.test_packages.json 18:17:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.crashreporter-symbols.zip 18:17:24 INFO - Running post-action listener: _resource_record_post_action 18:17:24 INFO - [mozharness: 2017-08-17 01:17:24.790234Z] Finished read-buildbot-config step (success) 18:17:24 INFO - [mozharness: 2017-08-17 01:17:24.790454Z] Running download-and-extract step. 18:17:24 INFO - Running pre-action listener: _resource_record_pre_action 18:17:24 INFO - Running main action method: download_and_extract 18:17:24 INFO - mkdir: /builds/slave/test/build/tests 18:17:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:24 INFO - trying https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.test_packages.json 18:17:24 INFO - Downloading https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:17:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:17:25 INFO - Downloaded 989 bytes. 18:17:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:17:25 INFO - Using the following test package requirements: 18:17:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:17:25 INFO - u'common': [u'target.common.tests.zip'], 18:17:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:17:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:17:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:17:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:17:25 INFO - u'mozbase': [u'target.common.tests.zip'], 18:17:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:17:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:17:25 INFO - u'web-platform': [u'target.common.tests.zip', 18:17:25 INFO - u'target.web-platform.tests.tar.gz'], 18:17:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:17:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:17:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.common.tests.zip 18:17:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:17:25 INFO - Fetch https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.common.tests.zip into memory 18:17:26 INFO - Content-Length response header: 54615367 18:17:26 INFO - Bytes received: 54615367 18:17:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:17:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.common.tests.zip 18:17:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:17:37 INFO - Fetch https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.common.tests.zip into memory 18:17:38 INFO - Content-Length response header: 54615367 18:17:38 INFO - Bytes received: 54615367 18:17:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.talos.tests.zip 18:17:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:17:51 INFO - Fetch https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.talos.tests.zip into memory 18:17:51 INFO - Content-Length response header: 14496161 18:17:51 INFO - Bytes received: 14496161 18:17:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:51 INFO - trying https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.tar.bz2 18:17:51 INFO - Downloading https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:17:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:17:53 INFO - Downloaded 62758289 bytes. 18:17:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.tar.bz2 18:17:53 INFO - mkdir: /builds/slave/test/properties 18:17:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:17:53 INFO - Writing to file /builds/slave/test/properties/build_url 18:17:53 INFO - Contents: 18:17:53 INFO - build_url:https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.tar.bz2 18:17:53 INFO - Running post-action listener: _resource_record_post_action 18:17:53 INFO - Running post-action listener: set_extra_try_arguments 18:17:53 INFO - [mozharness: 2017-08-17 01:17:53.112405Z] Finished download-and-extract step (success) 18:17:53 INFO - [mozharness: 2017-08-17 01:17:53.112633Z] Running populate-webroot step. 18:17:53 INFO - Running pre-action listener: _resource_record_pre_action 18:17:53 INFO - Running main action method: populate_webroot 18:17:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:17:53 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 18:17:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:17:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:17:53 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 18:17:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:17:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:17:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:17:53 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:17:53 INFO - 'talos_options': ['--stylo'], 18:17:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:17:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:17:53 INFO - 'tests': ['damp', 'tps']}, 18:17:53 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:17:53 INFO - 'talos_options': ['--stylo'], 18:17:53 INFO - 'tests': ['damp', 'tps']}, 18:17:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:17:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:17:53 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 18:17:53 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:17:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:17:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:17:53 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:17:53 INFO - 'talos_options': ['--stylo'], 18:17:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:17:53 INFO - 'other-e10s': {'tests': ['a11yr', 18:17:53 INFO - 'ts_paint', 18:17:53 INFO - 'tpaint', 18:17:53 INFO - 'sessionrestore', 18:17:53 INFO - 'sessionrestore_many_windows', 18:17:53 INFO - 'sessionrestore_no_auto_restore', 18:17:53 INFO - 'tabpaint']}, 18:17:53 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 18:17:53 INFO - 'tests': ['a11yr', 18:17:53 INFO - 'ts_paint', 18:17:53 INFO - 'tpaint', 18:17:53 INFO - 'sessionrestore', 18:17:53 INFO - 'sessionrestore_many_windows', 18:17:53 INFO - 'sessionrestore_no_auto_restore', 18:17:53 INFO - 'tabpaint']}, 18:17:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:17:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:17:53 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 18:17:53 INFO - 'tests': ['bloom_basic_singleton']}, 18:17:53 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 18:17:53 INFO - 'tests': ['bloom_basic']}, 18:17:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:17:53 INFO - 'tsvgr_opacity', 18:17:53 INFO - 'tart', 18:17:53 INFO - 'tscrollx', 18:17:53 INFO - 'tsvg_static']}, 18:17:53 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 18:17:53 INFO - 'tests': ['tsvgx', 18:17:53 INFO - 'tsvgr_opacity', 18:17:53 INFO - 'tart', 18:17:53 INFO - 'tscrollx', 18:17:53 INFO - 'tsvg_static']}, 18:17:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:17:53 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:17:53 INFO - 'talos_options': ['--stylo'], 18:17:53 INFO - 'tests': ['tp5o']}, 18:17:53 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:17:53 INFO - 'talos_options': ['--mitmproxy', 18:17:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:17:53 INFO - '--firstNonBlankPaint'], 18:17:53 INFO - 'tests': ['tp6_google', 18:17:53 INFO - 'tp6_youtube', 18:17:53 INFO - 'tp6_amazon', 18:17:53 INFO - 'tp6_facebook']}, 18:17:53 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:17:53 INFO - 'talos_options': ['--stylo', 18:17:53 INFO - '--mitmproxy', 18:17:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:17:53 INFO - '--firstNonBlankPaint'], 18:17:53 INFO - 'tests': ['tp6_google', 18:17:53 INFO - 'tp6_youtube', 18:17:53 INFO - 'tp6_amazon', 18:17:53 INFO - 'tp6_facebook']}, 18:17:53 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:17:53 INFO - 'talos_options': ['--stylo', 18:17:53 INFO - '--stylo-threads=1', 18:17:53 INFO - '--mitmproxy', 18:17:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:17:53 INFO - '--firstNonBlankPaint'], 18:17:53 INFO - 'tests': ['tp6_google', 18:17:53 INFO - 'tp6_youtube', 18:17:53 INFO - 'tp6_amazon', 18:17:53 INFO - 'tp6_facebook']}, 18:17:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:17:53 INFO - 'talos_options': ['--xperf_path', 18:17:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:17:53 INFO - 'tests': ['tp5n']}, 18:17:53 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 18:17:53 INFO - 'talos_options': ['--stylo', 18:17:53 INFO - '--xperf_path', 18:17:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:17:53 INFO - 'tests': ['tp5n']}}} 18:17:53 INFO - Running post-action listener: _resource_record_post_action 18:17:53 INFO - [mozharness: 2017-08-17 01:17:53.131062Z] Finished populate-webroot step (success) 18:17:53 INFO - [mozharness: 2017-08-17 01:17:53.131153Z] Running create-virtualenv step. 18:17:53 INFO - Running pre-action listener: _resource_record_pre_action 18:17:53 INFO - Running main action method: create_virtualenv 18:17:53 INFO - Creating virtualenv /builds/slave/test/build/venv 18:17:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:17:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:17:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:17:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:17:53 INFO - Using real prefix '/usr' 18:17:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:17:53 INFO - Installing distribute.............................................................................................................................................................................................done. 18:17:55 INFO - Installing pip.................done. 18:17:55 INFO - Return code: 0 18:17:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:17:55 INFO - Reading from file tmpfile_stdout 18:17:55 INFO - Output received: 18:17:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:17:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:17: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')]} 18:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17: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')]} 18:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e0b0>, '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 0x200efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17: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', 'pip>=1.5'] in /builds/slave/test/build 18:17: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 pip>=1.5 18:17:55 INFO - Using env: {'DISPLAY': ':0', 18:17:55 INFO - 'HOME': '/home/cltbld', 18:17:55 INFO - 'LANG': 'en_US.UTF-8', 18:17:55 INFO - 'LANGUAGE': 'en_US:en', 18:17:55 INFO - 'LOGNAME': 'cltbld', 18:17:55 INFO - 'MAIL': '/var/mail/cltbld', 18:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:55 INFO - 'MOZ_NO_REMOTE': '1', 18:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:55 INFO - 'NO_EM_RESTART': '1', 18:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:55 INFO - 'PWD': '/builds/slave/test', 18:17:55 INFO - 'SHELL': '/bin/bash', 18:17:55 INFO - 'SHLVL': '1', 18:17:55 INFO - 'TERM': 'linux', 18:17:55 INFO - 'TMOUT': '86400', 18:17:55 INFO - 'USER': 'cltbld', 18:17:55 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 18:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:55 INFO - '_': '/tools/buildbot/bin/python'} 18:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:17:56 INFO - Cleaning up... 18:17:56 INFO - Return code: 0 18:17:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:56 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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e0b0>, '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 0x200efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:17:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:17:56 INFO - Using env: {'DISPLAY': ':0', 18:17:56 INFO - 'HOME': '/home/cltbld', 18:17:56 INFO - 'LANG': 'en_US.UTF-8', 18:17:56 INFO - 'LANGUAGE': 'en_US:en', 18:17:56 INFO - 'LOGNAME': 'cltbld', 18:17:56 INFO - 'MAIL': '/var/mail/cltbld', 18:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:56 INFO - 'MOZ_NO_REMOTE': '1', 18:17:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:56 INFO - 'NO_EM_RESTART': '1', 18:17:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:56 INFO - 'PWD': '/builds/slave/test', 18:17:56 INFO - 'SHELL': '/bin/bash', 18:17:56 INFO - 'SHLVL': '1', 18:17:56 INFO - 'TERM': 'linux', 18:17:56 INFO - 'TMOUT': '86400', 18:17:56 INFO - 'USER': 'cltbld', 18:17:56 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 18:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:56 INFO - '_': '/tools/buildbot/bin/python'} 18:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:56 INFO - Downloading/unpacking psutil>=3.1.1 18:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:17:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:17:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:17:57 INFO - Installing collected packages: psutil 18:17:57 INFO - Running setup.py install for psutil 18:17:57 INFO - building 'psutil._psutil_linux' extension 18:17:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:17:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:17:57 INFO - building 'psutil._psutil_posix' extension 18:17:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:17:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:17:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:17:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:17:58 INFO - Successfully installed psutil 18:17:58 INFO - Cleaning up... 18:17:58 INFO - Return code: 0 18:17:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:58 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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e0b0>, '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 0x200efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:17:58 INFO - Using env: {'DISPLAY': ':0', 18:17:58 INFO - 'HOME': '/home/cltbld', 18:17:58 INFO - 'LANG': 'en_US.UTF-8', 18:17:58 INFO - 'LANGUAGE': 'en_US:en', 18:17:58 INFO - 'LOGNAME': 'cltbld', 18:17:58 INFO - 'MAIL': '/var/mail/cltbld', 18:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:58 INFO - 'MOZ_NO_REMOTE': '1', 18:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:58 INFO - 'NO_EM_RESTART': '1', 18:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:58 INFO - 'PWD': '/builds/slave/test', 18:17:58 INFO - 'SHELL': '/bin/bash', 18:17:58 INFO - 'SHLVL': '1', 18:17:58 INFO - 'TERM': 'linux', 18:17:58 INFO - 'TMOUT': '86400', 18:17:58 INFO - 'USER': 'cltbld', 18:17:58 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 18:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:58 INFO - '_': '/tools/buildbot/bin/python'} 18:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:17:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:17:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:17:59 INFO - Installing collected packages: mozsystemmonitor 18:17:59 INFO - Running setup.py install for mozsystemmonitor 18:17:59 INFO - Successfully installed mozsystemmonitor 18:17:59 INFO - Cleaning up... 18:17:59 INFO - Return code: 0 18:17:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:17:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:17:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:17:59 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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e0b0>, '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 0x200efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:17:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:17:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:17:59 INFO - Using env: {'DISPLAY': ':0', 18:17:59 INFO - 'HOME': '/home/cltbld', 18:17:59 INFO - 'LANG': 'en_US.UTF-8', 18:17:59 INFO - 'LANGUAGE': 'en_US:en', 18:17:59 INFO - 'LOGNAME': 'cltbld', 18:17:59 INFO - 'MAIL': '/var/mail/cltbld', 18:17:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:17:59 INFO - 'MOZ_NO_REMOTE': '1', 18:17:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:17:59 INFO - 'NO_EM_RESTART': '1', 18:17:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:17:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:17:59 INFO - 'PWD': '/builds/slave/test', 18:17:59 INFO - 'SHELL': '/bin/bash', 18:17:59 INFO - 'SHLVL': '1', 18:17:59 INFO - 'TERM': 'linux', 18:17:59 INFO - 'TMOUT': '86400', 18:17:59 INFO - 'USER': 'cltbld', 18:17:59 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 18:17:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:17:59 INFO - '_': '/tools/buildbot/bin/python'} 18:17:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:17:59 INFO - Downloading/unpacking jsonschema==2.5.1 18:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:17:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:17:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:18:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:01 INFO - Downloading functools32-3.2.3-2.tar.gz 18:18:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:18:01 INFO - warning: no files found matching '*.txt' 18:18:01 INFO - no previously-included directories found matching 'build' 18:18:01 INFO - no previously-included directories found matching 'dist' 18:18:01 INFO - no previously-included directories found matching '.git*' 18:18:01 INFO - Installing collected packages: jsonschema, functools32 18:18:01 INFO - Running setup.py install for functools32 18:18:01 INFO - warning: no files found matching '*.txt' 18:18:01 INFO - no previously-included directories found matching 'build' 18:18:01 INFO - no previously-included directories found matching 'dist' 18:18:01 INFO - no previously-included directories found matching '.git*' 18:18:01 INFO - Successfully installed jsonschema functools32 18:18:01 INFO - Cleaning up... 18:18:01 INFO - Return code: 0 18:18:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:01 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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e0b0>, '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 0x200efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:18:01 INFO - Using env: {'DISPLAY': ':0', 18:18:01 INFO - 'HOME': '/home/cltbld', 18:18:01 INFO - 'LANG': 'en_US.UTF-8', 18:18:01 INFO - 'LANGUAGE': 'en_US:en', 18:18:01 INFO - 'LOGNAME': 'cltbld', 18:18:01 INFO - 'MAIL': '/var/mail/cltbld', 18:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:01 INFO - 'MOZ_NO_REMOTE': '1', 18:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:01 INFO - 'NO_EM_RESTART': '1', 18:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:01 INFO - 'PWD': '/builds/slave/test', 18:18:01 INFO - 'SHELL': '/bin/bash', 18:18:01 INFO - 'SHLVL': '1', 18:18:01 INFO - 'TERM': 'linux', 18:18:01 INFO - 'TMOUT': '86400', 18:18:01 INFO - 'USER': 'cltbld', 18:18:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 18:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:01 INFO - '_': '/tools/buildbot/bin/python'} 18:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:18:01 INFO - Cleaning up... 18:18:01 INFO - Return code: 0 18:18:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:01 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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e0b0>, '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 0x200efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:18:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:18:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:18:01 INFO - Using env: {'DISPLAY': ':0', 18:18:01 INFO - 'HOME': '/home/cltbld', 18:18:01 INFO - 'LANG': 'en_US.UTF-8', 18:18:01 INFO - 'LANGUAGE': 'en_US:en', 18:18:01 INFO - 'LOGNAME': 'cltbld', 18:18:01 INFO - 'MAIL': '/var/mail/cltbld', 18:18:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:01 INFO - 'MOZ_NO_REMOTE': '1', 18:18:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:01 INFO - 'NO_EM_RESTART': '1', 18:18:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:01 INFO - 'PWD': '/builds/slave/test', 18:18:01 INFO - 'SHELL': '/bin/bash', 18:18:01 INFO - 'SHLVL': '1', 18:18:01 INFO - 'TERM': 'linux', 18:18:01 INFO - 'TMOUT': '86400', 18:18:01 INFO - 'USER': 'cltbld', 18:18:01 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 18:18:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:01 INFO - '_': '/tools/buildbot/bin/python'} 18:18:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:01 INFO - Downloading/unpacking blobuploader==1.2.4 18:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:02 INFO - Downloading blobuploader-1.2.4.tar.gz 18:18:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:18:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:18:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:03 INFO - Downloading docopt-0.6.1.tar.gz 18:18:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:18:03 INFO - Installing collected packages: blobuploader, requests, docopt 18:18:03 INFO - Running setup.py install for blobuploader 18:18:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:18:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:18:03 INFO - Running setup.py install for requests 18:18:03 INFO - Running setup.py install for docopt 18:18:03 INFO - Successfully installed blobuploader requests docopt 18:18:03 INFO - Cleaning up... 18:18:04 INFO - Return code: 0 18:18:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:04 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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e0b0>, '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 0x200efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:18:04 INFO - Using env: {'DISPLAY': ':0', 18:18:04 INFO - 'HOME': '/home/cltbld', 18:18:04 INFO - 'LANG': 'en_US.UTF-8', 18:18:04 INFO - 'LANGUAGE': 'en_US:en', 18:18:04 INFO - 'LOGNAME': 'cltbld', 18:18:04 INFO - 'MAIL': '/var/mail/cltbld', 18:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:04 INFO - 'MOZ_NO_REMOTE': '1', 18:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:04 INFO - 'NO_EM_RESTART': '1', 18:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:04 INFO - 'PWD': '/builds/slave/test', 18:18:04 INFO - 'SHELL': '/bin/bash', 18:18:04 INFO - 'SHLVL': '1', 18:18:04 INFO - 'TERM': 'linux', 18:18:04 INFO - 'TMOUT': '86400', 18:18:04 INFO - 'USER': 'cltbld', 18:18:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 18:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:04 INFO - '_': '/tools/buildbot/bin/python'} 18:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:04 INFO - Running setup.py (path:/tmp/pip-tl05oU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:04 INFO - Running setup.py (path:/tmp/pip-QVbLV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:04 INFO - Running setup.py (path:/tmp/pip-NuCqGr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:04 INFO - Running setup.py (path:/tmp/pip-OD03ND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:04 INFO - Running setup.py (path:/tmp/pip-hUfsMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:04 INFO - Running setup.py (path:/tmp/pip-LKb1yB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:04 INFO - Running setup.py (path:/tmp/pip-yTmt6y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:04 INFO - Running setup.py (path:/tmp/pip-GFsiqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:04 INFO - Running setup.py (path:/tmp/pip-t7EAxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:04 INFO - Running setup.py (path:/tmp/pip-4dnIc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:04 INFO - Running setup.py (path:/tmp/pip-6FLHBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:05 INFO - Running setup.py (path:/tmp/pip-i3z5_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:05 INFO - Running setup.py (path:/tmp/pip-Ik_n3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:05 INFO - Running setup.py (path:/tmp/pip-KLlK3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:05 INFO - Running setup.py (path:/tmp/pip-K3Glgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:05 INFO - Running setup.py (path:/tmp/pip-f8NgC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:05 INFO - Running setup.py (path:/tmp/pip-LctHGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:18:05 INFO - Running setup.py install for manifestparser 18:18:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:18:05 INFO - Running setup.py install for mozcrash 18:18:05 INFO - Running setup.py install for mozdebug 18:18:05 INFO - Running setup.py install for mozdevice 18:18:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:18:05 INFO - Running setup.py install for mozfile 18:18:05 INFO - Running setup.py install for mozhttpd 18:18:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:18:06 INFO - Running setup.py install for mozinfo 18:18:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:18:06 INFO - Running setup.py install for mozInstall 18:18:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:18:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:18:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:18:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:18:06 INFO - Running setup.py install for mozleak 18:18:06 INFO - Running setup.py install for mozlog 18:18:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:18:06 INFO - Running setup.py install for moznetwork 18:18:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:18:06 INFO - Running setup.py install for mozprocess 18:18:06 INFO - Running setup.py install for mozprofile 18:18:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:18:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:18:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:18:06 INFO - Running setup.py install for mozrunner 18:18:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:18:06 INFO - Running setup.py install for mozscreenshot 18:18:07 INFO - Running setup.py install for moztest 18:18:07 INFO - Running setup.py install for mozversion 18:18:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:18:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:18:07 INFO - Cleaning up... 18:18:07 INFO - Return code: 0 18:18:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18: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')]} 18:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18: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')]} 18:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:07 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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e0b0>, '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 0x200efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:18:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:18:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:18:07 INFO - Using env: {'DISPLAY': ':0', 18:18:07 INFO - 'HOME': '/home/cltbld', 18:18:07 INFO - 'LANG': 'en_US.UTF-8', 18:18:07 INFO - 'LANGUAGE': 'en_US:en', 18:18:07 INFO - 'LOGNAME': 'cltbld', 18:18:07 INFO - 'MAIL': '/var/mail/cltbld', 18:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:07 INFO - 'MOZ_NO_REMOTE': '1', 18:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:07 INFO - 'NO_EM_RESTART': '1', 18:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:07 INFO - 'PWD': '/builds/slave/test', 18:18:07 INFO - 'SHELL': '/bin/bash', 18:18:07 INFO - 'SHLVL': '1', 18:18:07 INFO - 'TERM': 'linux', 18:18:07 INFO - 'TMOUT': '86400', 18:18:07 INFO - 'USER': 'cltbld', 18:18:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 18:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:07 INFO - '_': '/tools/buildbot/bin/python'} 18:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:18:07 INFO - Running setup.py (path:/tmp/pip-7o2ihM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:18:07 INFO - Running setup.py (path:/tmp/pip-jJG7me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:18:07 INFO - Running setup.py (path:/tmp/pip-jzhYEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:18:07 INFO - Running setup.py (path:/tmp/pip-Gbsdqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:18:07 INFO - Running setup.py (path:/tmp/pip-cnCLx5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:18:07 INFO - Running setup.py (path:/tmp/pip-JminwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:18:07 INFO - Running setup.py (path:/tmp/pip-jjrRKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:18:07 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)) 18:18:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:18:07 INFO - Running setup.py (path:/tmp/pip-J_BkZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:18:08 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)) 18:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:18:08 INFO - Running setup.py (path:/tmp/pip-qbK4bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:18:08 INFO - Running setup.py (path:/tmp/pip-owvZsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:18:08 INFO - Running setup.py (path:/tmp/pip-U9jn7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:18:08 INFO - Running setup.py (path:/tmp/pip-O3gaNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:18:08 INFO - Running setup.py (path:/tmp/pip-eBGY9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:18:08 INFO - Running setup.py (path:/tmp/pip-WXKQxQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:08 INFO - Running setup.py (path:/tmp/pip-XQbLsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:18:08 INFO - Running setup.py (path:/tmp/pip-Gj0OSK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:18:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:18:08 INFO - Running setup.py (path:/tmp/pip-OHwIvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:18:08 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)) 18:18:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:09 INFO - Downloading blessings-1.6.tar.gz 18:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:18:09 INFO - Installing collected packages: blessings 18:18:09 INFO - Running setup.py install for blessings 18:18:09 INFO - Successfully installed blessings 18:18:09 INFO - Cleaning up... 18:18:10 INFO - Return code: 0 18:18:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:18:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:10 INFO - Reading from file tmpfile_stdout 18:18:10 INFO - Current package versions: 18:18:10 INFO - argparse == 1.2.1 18:18:10 INFO - blessings == 1.6 18:18:10 INFO - blobuploader == 1.2.4 18:18:10 INFO - docopt == 0.6.1 18:18:10 INFO - functools32 == 3.2.3-2 18:18:10 INFO - jsonschema == 2.5.1 18:18:10 INFO - manifestparser == 1.1 18:18:10 INFO - mozInstall == 1.13 18:18:10 INFO - mozcrash == 1.0 18:18:10 INFO - mozdebug == 0.1 18:18:10 INFO - mozdevice == 0.51 18:18:10 INFO - mozfile == 1.2 18:18:10 INFO - mozhttpd == 0.7 18:18:10 INFO - mozinfo == 0.10 18:18:10 INFO - mozleak == 0.1 18:18:10 INFO - mozlog == 3.5 18:18:10 INFO - moznetwork == 0.27 18:18:10 INFO - mozprocess == 0.25 18:18:10 INFO - mozprofile == 0.28 18:18:10 INFO - mozrunner == 6.13 18:18:10 INFO - mozscreenshot == 0.1 18:18:10 INFO - mozsystemmonitor == 0.3 18:18:10 INFO - moztest == 0.8 18:18:10 INFO - mozversion == 1.4 18:18:10 INFO - psutil == 3.1.1 18:18:10 INFO - requests == 1.2.3 18:18:10 INFO - wsgiref == 0.1.2 18:18:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:10 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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e0b0>, '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 0x200efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:18:10 INFO - Using env: {'DISPLAY': ':0', 18:18:10 INFO - 'HOME': '/home/cltbld', 18:18:10 INFO - 'LANG': 'en_US.UTF-8', 18:18:10 INFO - 'LANGUAGE': 'en_US:en', 18:18:10 INFO - 'LOGNAME': 'cltbld', 18:18:10 INFO - 'MAIL': '/var/mail/cltbld', 18:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:10 INFO - 'MOZ_NO_REMOTE': '1', 18:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:10 INFO - 'NO_EM_RESTART': '1', 18:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:10 INFO - 'PWD': '/builds/slave/test', 18:18:10 INFO - 'SHELL': '/bin/bash', 18:18:10 INFO - 'SHLVL': '1', 18:18:10 INFO - 'TERM': 'linux', 18:18:10 INFO - 'TMOUT': '86400', 18:18:10 INFO - 'USER': 'cltbld', 18:18:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 18:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:10 INFO - '_': '/tools/buildbot/bin/python'} 18:18:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:18:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:18:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:18:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:18:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:18:11 INFO - Installing collected packages: simplejson 18:18:11 INFO - Running setup.py install for simplejson 18:18:11 INFO - building 'simplejson._speedups' extension 18:18:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 18:18:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 18:18:12 INFO - Successfully installed simplejson 18:18:12 INFO - Cleaning up... 18:18:12 INFO - Return code: 0 18:18:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:18:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:18:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2010ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x200e0b0>, '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 0x200efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f440>, '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': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:18:12 INFO - Using env: {'DISPLAY': ':0', 18:18:12 INFO - 'HOME': '/home/cltbld', 18:18:12 INFO - 'LANG': 'en_US.UTF-8', 18:18:12 INFO - 'LANGUAGE': 'en_US:en', 18:18:12 INFO - 'LOGNAME': 'cltbld', 18:18:12 INFO - 'MAIL': '/var/mail/cltbld', 18:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:12 INFO - 'MOZ_NO_REMOTE': '1', 18:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:12 INFO - 'NO_EM_RESTART': '1', 18:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:12 INFO - 'PWD': '/builds/slave/test', 18:18:12 INFO - 'SHELL': '/bin/bash', 18:18:12 INFO - 'SHLVL': '1', 18:18:12 INFO - 'TERM': 'linux', 18:18:12 INFO - 'TMOUT': '86400', 18:18:12 INFO - 'USER': 'cltbld', 18:18:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 18:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:12 INFO - '_': '/tools/buildbot/bin/python'} 18:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:18:12 INFO - Cleaning up... 18:18:12 INFO - Return code: 0 18:18:12 INFO - Running post-action listener: _resource_record_post_action 18:18:12 INFO - Running post-action listener: _start_resource_monitoring 18:18:12 INFO - Starting resource monitoring. 18:18:12 INFO - [mozharness: 2017-08-17 01:18:12.959740Z] Finished create-virtualenv step (success) 18:18:12 INFO - [mozharness: 2017-08-17 01:18:12.960691Z] Running install step. 18:18:12 INFO - Running pre-action listener: _resource_record_pre_action 18:18:12 INFO - Running main action method: install 18:18:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:18:13 INFO - Reading from file tmpfile_stdout 18:18:13 INFO - Detecting whether we're running mozinstall >=1.0... 18:18:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:18:13 INFO - Reading from file tmpfile_stdout 18:18:13 INFO - Output received: 18:18:13 INFO - Usage: mozinstall [options] installer 18:18:13 INFO - Options: 18:18:13 INFO - -h, --help show this help message and exit 18:18:13 INFO - -d DEST, --destination=DEST 18:18:13 INFO - Directory to install application into. [default: 18:18:13 INFO - "/builds/slave/test"] 18:18:13 INFO - --app=APP Application being installed. [default: firefox] 18:18:13 INFO - mkdir: /builds/slave/test/build/application 18:18:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:18:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:18:31 INFO - Reading from file tmpfile_stdout 18:18:31 INFO - Output received: 18:18:31 INFO - /builds/slave/test/build/application/firefox/firefox 18:18:31 INFO - Running post-action listener: _resource_record_post_action 18:18:31 INFO - [mozharness: 2017-08-17 01:18:31.329417Z] Finished install step (success) 18:18:31 INFO - [mozharness: 2017-08-17 01:18:31.329761Z] Running setup-mitmproxy step. 18:18:31 INFO - Running pre-action listener: _resource_record_pre_action 18:18:31 INFO - Running main action method: setup_mitmproxy 18:18:31 INFO - Skipping: mitmproxy is not required 18:18:31 INFO - Running post-action listener: _resource_record_post_action 18:18:31 INFO - [mozharness: 2017-08-17 01:18:31.331414Z] Finished setup-mitmproxy step (success) 18:18:31 INFO - [mozharness: 2017-08-17 01:18:31.331735Z] Running run-tests step. 18:18:31 INFO - Running pre-action listener: _resource_record_pre_action 18:18:31 INFO - Running pre-action listener: _set_gcov_prefix 18:18:31 INFO - Running main action method: run_tests 18:18:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:18:31 INFO - Python 2.7.3 18:18:31 INFO - Return code: 0 18:18:31 INFO - grabbing minidump binary from tooltool 18:18:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:18:31 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 0x200e0b0>, '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 0x200efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x200f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:18:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:18:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:18:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:18:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:18:31 INFO - Return code: 0 18:18:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:18:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:18:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:18:31 INFO - ENV: RUST_BACKTRACE is now full 18:18:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:18:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:18:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:18:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:18:31 INFO - Using env: {'DISPLAY': ':0', 18:18:31 INFO - 'HOME': '/home/cltbld', 18:18:31 INFO - 'LANG': 'en_US.UTF-8', 18:18:31 INFO - 'LANGUAGE': 'en_US:en', 18:18:31 INFO - 'LOGNAME': 'cltbld', 18:18:31 INFO - 'MAIL': '/var/mail/cltbld', 18:18:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:18:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:18:31 INFO - 'MOZ_NO_REMOTE': '1', 18:18:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:18:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:18:31 INFO - 'NO_EM_RESTART': '1', 18:18:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:18:31 INFO - 'PWD': '/builds/slave/test', 18:18:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:18:31 INFO - 'RUST_BACKTRACE': 'full', 18:18:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:18:31 INFO - 'SHELL': '/bin/bash', 18:18:31 INFO - 'SHLVL': '1', 18:18:31 INFO - 'TERM': 'linux', 18:18:31 INFO - 'TMOUT': '86400', 18:18:31 INFO - 'USER': 'cltbld', 18:18:31 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463', 18:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:18:31 INFO - '_': '/tools/buildbot/bin/python'} 18:18:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:18:31 INFO - mozversion application_buildid: 20170816235940 18:18:31 INFO - mozversion application_changeset: 63ca686c3f1e870649b6d9c559973d100573aec2 18:18:31 INFO - mozversion application_display_name: Nightly 18:18:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:18:31 INFO - mozversion application_name: Firefox 18:18:31 INFO - mozversion application_remotingname: firefox 18:18:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:18:31 INFO - mozversion application_vendor: Mozilla 18:18:31 INFO - mozversion application_version: 57.0a1 18:18:31 INFO - mozversion platform_buildid: 20170816235940 18:18:31 INFO - mozversion platform_changeset: 63ca686c3f1e870649b6d9c559973d100573aec2 18:18:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:18:31 INFO - mozversion platform_version: 57.0a1 18:18:31 INFO - using testdate: 1502932711 18:18:31 INFO - actual date: 1502932711 18:18:31 INFO - starting webserver on 'localhost:54153' 18:18:31 INFO - SUITE-START | Running 2 tests 18:18:31 INFO - TEST-START | dromaeo_css 18:18:31 INFO - Initialising browser for dromaeo_css test... 18:18:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54153/getInfo.html -profile /tmp/tmpfqsWIx/profile 18:18:31 INFO - TEST-INFO | started process 31127 (/builds/slave/test/build/application/firefox/firefox http://localhost:54153/getInfo.html) 18:18:37 INFO - TEST-INFO | 31127: exit 0 18:18:37 INFO - Browser initialized. 18:18:37 INFO - Running cycle 1/1 for dromaeo_css test... 18:18:37 INFO - TEST-INFO | started process 31301 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfqsWIx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:18:38 INFO - PID 31301 | 18:18:38 INFO - PID 31301 | (/builds/slave/test/build/application/firefox/firefox:31351): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:18:38 INFO - PID 31301 | 18:18:48 INFO - PID 31301 | RSS: Main: 156962816 18:18:48 INFO - PID 31301 | 18:21:46 INFO - PID 31301 | Cycle 1(1): loaded http://localhost:54153/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54153/tests/dromaeo/cssquery-ext.html) 18:21:47 INFO - PID 31301 | RSS: Main: 165388288 18:21:47 INFO - PID 31301 | 18:24:49 INFO - PID 31301 | Cycle 1(1): loaded http://localhost:54153/tests/dromaeo/cssquery-ext.html (next: http://localhost:54153/tests/dromaeo/cssquery-jquery.html) 18:24:49 INFO - PID 31301 | RSS: Main: 162701312 18:24:49 INFO - PID 31301 | 18:27:51 INFO - PID 31301 | Cycle 1(1): loaded http://localhost:54153/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54153/tests/dromaeo/cssquery-mootools.html) 18:27:51 INFO - PID 31301 | RSS: Main: 164704256 18:27:51 INFO - PID 31301 | 18:30:53 INFO - PID 31301 | Cycle 1(1): loaded http://localhost:54153/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54153/tests/dromaeo/cssquery-prototype.html) 18:30:54 INFO - PID 31301 | RSS: Main: 161153024 18:30:54 INFO - PID 31301 | 18:33:57 INFO - PID 31301 | Cycle 1(1): loaded http://localhost:54153/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54153/tests/dromaeo/cssquery-yui.html) 18:33:58 INFO - PID 31301 | RSS: Main: 166592512 18:33:58 INFO - PID 31301 | 18:36:59 INFO - PID 31301 | Cycle 1(1): loaded http://localhost:54153/tests/dromaeo/cssquery-yui.html (next: http://localhost:54153/tests/dromaeo/cssquery-dojo.html) 18:36:59 INFO - PID 31301 | RSS: Main: 167358464 18:36:59 INFO - PID 31301 | 18:36:59 INFO - PID 31301 | __start_tp_report 18:36:59 INFO - PID 31301 | _x_x_mozilla_page_load 18:36:59 INFO - PID 31301 | _x_x_mozilla_page_load_details 18:36:59 INFO - PID 31301 | |i|pagename|runs| 18:36:59 INFO - PID 31301 | |0;dojo.html;3451.0682115828713;3473.583170019598;3512.104413374588;3522.3835828729966;3528.752987290889;6228.190335256421;6359.80920572383;6378.808635740924;6383.457406120474;6403.327650596691;6240.812775616728;6259.687015649222;6319.5576309658345;6325.335839736819;6333.429991300782;5564.304461942247;5596.524295434893;5598.636088654245;5614.747336369853;5671.2060311556415;5356.705381204032;5511.724413779315;5518.862028449281;5525.861853453675;5596;5471.616986810925;5491.341039075297;5557.777688892439;5577.135543990688;5606.21512988182;5540.750666220029;5544.7227638618315;5592.972035139839;5608.46719561641;5626.2967129108865;5466.207399927028;5529.198266251411;5544.390117087117;5549.77800887964;5550.666959982414;6257.186565746424;6272.56092073555;6295.338989406138;6300.810975670737;6345.397187267202;6761.628110453923;6817.420519255819;6845.007473916304;6858.108445902001;6882.139732533434;6737.6968036438475;6797.524173307821;6814.48891333147;6880.518363714542;6891.483138764613;6289.748410063592;6339.0808332791485;6432.13166222554;6432.4532414744335;6440.0661904023655;6986.196587392414;6993.405560527311;7088;7090.936359546006;7154.892676609855;6692.464602831762;6708.765193218312;6787.457003439713;6799.694013769392;6807.18313802337;6822.488313376417;6839.316068393121;6875.965620171967;6940.271271516519;6946.861062778716;6820.795376138723;6833.282505336968;6846.7945961621235;6847.144106986627;6860.3825655690225;6751.324867513307;6821.658917054127;6828.658567071627;6830.419414349836;6893.034975103489;4854.63590230727;4890.657653964259;4932.926006109911;4973.32860063894;4982.302477653131;4344.674149438742;4375.321825117112;4383.912321753547;4397.2304846651705;4423;6370.362963703686;6382.170317858649;6452.419282264619;6473.385028422293;6477.935220647827;6685.197776266782;6768.864622707519;6772.83067923296;6807.591544507345;6897.896531552031;6450.5484616077365;6454.257760357619;6454.774082907075;6462.256840463407;6470.029495575702;5409.945900541023;5479.808206712746;5482.91775623366;5487.478689524489;5510.366307874646;7059;7072.681729322193;7108.751193708195;7207.783766487014;7224.855502889913;6768.4585233182215;6800.761973330909;6824.727010919508;6858.108445902001;6880.724771009103;7174.856502870018;7180.210176880434;7182.497225194186;7202.171750248579;7207.855842883008;6626.337366263335;6638.900416493853;6691.230508491391;6716.059751634677;6727.360900714424;6937.271586483346;6960.686769095301;6974.407175390149;6987.860242795217;6994.895076573957;6645.767398141042;6649.966750166218;6740;6741.494387920828;6750.628715420699;6679.265280819009;6692.631905245258;6757.358050985148;6772.153480814898;6773.5258531904265;6565.934340656723;6631.403173714389;6646.169228846395;6657;6725.058491811053;6574.868502629825;6683.933160668331;6686.431653309523;6734.3939045484185;6752.729890804313;6421.775237866839;6520.2447069994405;6613.338666133348;6623.172103487064;6624.171978502687 18:36:59 INFO - PID 31301 | |1;ext.html;865.2226932233899;906.6554709210495;934.0379409208515;954.8424509955858;961.3510880155893;41792.37311440327;42588.78705606471;42612.3608145878;42726.35910461345;42748.57251427485;39355.60644393563;39518.80240598793;39555.604443955555;39645.80177099111;39729.40405893914;6938.653067346625;7006.509544331899;7036.824079398005;7044.612546309951;7046.4010559102535;6947.79156625302;7042.964785176067;7046.154461464632;7048.753293634723;7048.964755176217;7537.924620753777;7735.303822655988;7738.419618528605;7738.419618528605;7743.8838417423785;7654.158042615336;7723.189065148163;7725.768226953201;7734.187910269425;7737.651805668758;7389.482736208468;7516.436267279922;7563.584002879839;7595.012648355733;7616.504927179715;38174.42738358927;38396;38479.23041539153;38536;38608.61391386078;3421.0250078727445;3469.8265086745814;3477.739169562293;3478.060923550627;3479.0606536235073;30409.543856842167;30453;30506.54240186399;30511.237219069702;30609.234769130726;5153.819616313411;5177.301064356301;5200.167973124319;5212.061828870802;5232.790688372461;209021;211228;224781;226698;272239.6388018067;49757.25364119541;50023;50064.749676251384;50078.74960625174;51289;52092.73953630208;52499.63751631186;52631.47368526266;52796.47203527993;52825.735871321165;16270.918645406933;16381;16383;16394.344226231056;16566.917165414096;13405;13408.530701425403;13416.664583385493;13499;13518.324083795967;14367.850571954219;14452;14544.781828272584;14575.708485830224;14587.489437869624;5903.881922361528;5932.881342373128;6055.004621187538;6071.423214794588;6169.784057557964;1070.6092276319087;1070.7995070130955;1078.449990504848;1096.8464414981909;1099.4502748625687;24544.913682336843;24557.263282101565;24596.631050534255;30603.637817309882;31758.682413176033;1178.6051672689746;1184.8459700239086;1193.1945936492832;1194.6475789642077;1195.4381440722846;12942;13412.39644215993;13473.393697283645;17137.314507419815;17490.21294041771;275030;275591;275715;276787;276938;55900.720496397254;56734;56813;56966;56981;1468.1338010573813;1486.6952274783644;1511.8034655494716;1520.8098987626547;1525.8931874768882;28420.715792842635;28741.56887646729;29190.854045729637;29357.119286421443;29989.250268742584;50531.49468505415;50607.240891387395;50624;50636.49363506465;50890.74554627203;254876;257389;257804;257813;258051;35522.82238588791;37042.25915481729;37188;37277.81361093177;37281.25437491289;46012.76993615011;46035.079298414516;46065.30902036539;46483.53516464927;46561;33789.66210337865;34079.659203407646;34113.48829767605;34340.14149646279;34483.482747759306;33993.83003084969;34159.65840341565;34178.97463076112;34534.654653453144;34729.65270347264;39587.2082558353;39610.60389396069;39720.20559588734;39818.402723958585;39829.80085099672;32742.50886236661;33045;33244;34024.65975340215;34750.304993900485;25522.617160742233;26641.20076397711;26877.596836047866;27006.459870802082;27060.05289814847 18:36:59 INFO - PID 31301 | |2;jquery.html;549.4478049560194;567.2030796730589;573.810642487979;579.1168468086171;588.7438964050639;21863;22563;22564.88717556414;22612.20857269994;22691.09235630573;25168.496630067388;25509.74490255097;25693.614595781033;25738.227853164433;25773.61339579908;5911.704414779255;6005.189299444584;6013.248343957005;6040.969795151018;6053.545984051214;5730;5957.1957785698805;5993.430624090726;6080.209572755558;6233.750649973996;6178.07328900664;6178.938210617904;6179.0422484514975;6179.752809887599;6196.535259855529;6149.2313460817395;6160.969195154041;6165.537584681167;6207.627542347428;6218.22272215973;5755.798547050833;5770.336411312711;5778.104393818965;5779.653220806765;5796.449337312949;28825.135245942656;29285.56071658927;29416;29669.554956675667;30380.84809575938;2100.19142630087;2150.817180539656;2152.0208305221086;2152.0208305221086;2153.849230553862;19784.80215197844;19818;20103.39689809308;20745.170193192254;20842.37472875816;2394.473215892501;2408.5544174327806;2431.222008957134;2433.965838726083;2470.542949554338;151404.2429787855;156364;156420.2178989098;156582;157018;14897;15298.235088245543;15424.922875385551;15811.288492017888;15950.441734539236;23546.411339716302;23552.411189720053;23695.7630423697;23698.170564030177;23734.7626523736;10269.897301026895;10376.584936602452;10408.791824163474;10421.166306695446;10453.477326133814;9328.34701570897;9341.11259430353;9384.67153649619;9440.356700123839;9461.52692365379;8496.320294376435;9740.853887191697;9753.268504862164;9792.167665748491;9848.409095454295;2572.305477521059;2586.818922675432;2730.8224965377185;2774.7652294729055;2825.3129665786346;1011.3022014809758;1049.6536143072767;1054.841773733946;1060.5174645536263;1068.1668298727006;21193.894030530057;21203.787962120183;21359.572808544053;21483.248086316904;21687.34937951864;1104.5305745058317;1118.552578968419;1124.4883577972003;1128.841962125303;1133;11648.95159435655;11888.28670279786;11937.52249909994;11945.820812687816;11966.324714539971;561150;573175;591102;599224;599864;127269.54556590474;130968;130994;131628.3418582901;133392;1229.0904730499544;1270.1934271737327;1271.961841144767;1272.8790764877322;1277.2208952538758;18969.95665238425;19144.617107658047;19245.230190792212;19250.903745481184;19458.221671133564;64063;64116.3588364129;64718.67640661766;64755.35244647682;66176;77525.61237193778;77953.58597087303;78086.6095669518;78398.60800696188;78428.60785696036;12728.363581821057;13051.804222936473;14628;14802.111873287637;14932.850671493581;23146.189883354004;24019.159329424085;24026.87986560056;24201.273961781175;24373.51252974895;19260.903695481433;19418.32035878794;19478;19557.11992960292;19600.705989410457;17367.47897563075;17483.300667973137;17540.421362076962;18029.368972085915;18133.637327253116;19668.90165549163;19727.309544165884;20092.698609520576;20206.19175232974;20308.390748277576;14331.426742930165;14357.56927292183;14424.350904209545;14444.133351998913;14480.710385792014;19067.523311917314;19090.33183838559;19132.426027219204;19166.61666766629;19181.808181918 18:36:59 INFO - PID 31301 | |3;mootools.html;1434.067855893669;1491.9030263032896;1492.1345619540668;1496.9027013244138;1498.4231071037648;15443.536693899174;16057.759133613004;16058.437954671588;16092.597685057879;16093.275802588882;15786.921065394657;16439.4246201383;16991.660166796686;17007.914960425212;17033.063181525013;2671.131882138303;2736.7536921677047;2739.849308288043;2741.753242208201;2742.149933520605;2651.4564514274525;2652.4429869727383;2704.9188524344204;2741.8080734348605;2753.1740477856665;2730.549459339207;2738.4523095381005;2759.18604011816;2761.4753196892625;2767.405007923296;2624.18650218431;2637.841729496227;2648.523265812153;2651.1383800264894;2655.8273712208743;2653.6417583626157;2660.068975858434;2662.387650840298;2662.427578070705;2663.307540039584;15715.764263536055;16072.59818504535;16105;16122.838771612369;16135.91932040344;8413.032501262373;8638.222559969632;8643.222110010067;8660.82678346436;8675.219230269306;5285.63000589955;5384.246205531229;5550.5282051025715;5593.04918163909;5604.075327570946;1809.7737782777153;1929.9228030878749;1936.5255512399413;1964.0965156028244;1974.8123928226796;29525.557116643267;29556.113316600753;29721.405571888656;29723.256918576993;29761.851190744124;7128.750493732695;7131.572105673677;7200.603966781878;7262.273772622695;7337.009503716929;19367.903160484388;19438.611227775364;19563.90218048929;19604.745454272943;19611.509712257306;7673.846523069507;7849.4897831640765;8425.11536288693;8427.41008129425;8433.03020152678;7609.505382150142;7742.225777422325;7762.990811194509;7830.177831327628;7881.605919703992;5021.5229553192385;5229.320188375486;5370.01309515474;5401.7299135043095;5424.945750542523;1410.1116296732991;1533.5246073717183;1560.4928398270608;1568.2785918477628;1590.4989928172588;945.3382632157517;986.3835103060587;989.1660392974078;1000.0049950299499;1017.3692310767224;9015.549222538846;9381.953090234505;9508.952455237679;9595.760105997266;9630.181434577999;1023.1098943918838;1043.3844032021143;1049.879263884663;1056.3133962924007;1062.0335494699787;4947.431045429749;5370.167624018283;5870.412958704095;5924.526037917042;6044.274687037584;23386.64920026201;23717.644235336484;24392.87803560971;24607;24651.3837154069;23553.528929421314;23623.645645315333;24302;24616.753832461447;24645.876770616032;12613.243205407705;12675;12862.228266304051;12911.677208069874;12932.70672932718;9049.683261085831;9120.179183873483;9160.862587061067;9216.95391523065;9250.629974800933;20779.584408311446;20912;21213.787862121182;21319.57360852805;21386.893065534572;20777.58444831065;21219.575608488052;21247.68128478105;21333;21376.786232137478;13627;13778.586642400744;13881;13904.443822246996;13909.443622254996;13041.804372934603;14273.714525709634;14416.42334306616;14441.422343106158;14490.203038832544;10257.179425645782;11829.408529573315;11835.230710003822;12303.200291980993;12464.563740269046;11327.490262938023;11330.943345283551;11388.088952883583;11548;11615.361155136548;10272.537735802056;10396.844047339448;10413.687589372332;10414.791704166026;10419.895801042196;7948.682052717826;8039.799005024921;8045.316148127475;8110.878336825071;8121.918780812116;7729.381649467917;7883.44815862907;7960.960195198987;8121.472104313437;8153.143919888326 18:36:59 INFO - PID 31301 | |4;prototype.html;511.7978398532582;513.3967588084001;532.3212903547976;535.1571275241496;535.1651423778903;6166.630002199871;6192.164057852195;6202.131701561785;6205.541697701036;6230.688465576714;6097.756089756404;6107.38926107389;6117.235345581802;6154.415330543602;6205.610839826665;4875.122477953976;4899.853004409855;4907.705537667734;4949.158643030693;4981.9750901245625;4699.859004229878;4841.104395686792;4852.757362131897;4887.242477416006;4943.431505376891;4720.669553131283;4743.241081426972;4760.2383618621025;4802.967362017165;4825.348577941985;4760.404949381327;4772.355731976173;4793.7842797074045;4796.064767370364;4796.592289655348;4327.117703798826;4339.218940590692;4347.260965635818;4349.608535231844;4361.280388735855;6015.909761353583;6061.121137435047;6078.331383547807;6097.542684298695;6131.570790044699;5694.487496125327;5727.742251598646;5732.366275611473;5740;5742.196092547047;6451.258105317902;6549.410553050201;6554.606723596552;6620.337966203389;6630.63531505767;4840.685355451885;4850.878728031792;4914.533119353656;4921.729304888229;4929.876753081202;6594.571352862096;6695.719097642121;6821.727130914708;6932.306769323078;6957.269486703874;4978.477259887732;5038.3198268234055;5062.493750624982;5068.82259120929;5072.771725272298;5140.254663073833;5153.484651534816;5181.689098654093;5182.455842136596;5191.091558977239;5662.915056274159;5693.800716974886;5704.914426283609;5752.3097228332035;5779.393163717833;6611.537192396582;6634.502412319095;6666.300038495985;6666.83332916681;6668.932970724661;1779.80422153563;1787.294018862542;1791.4715159028117;1800.7929088154767;1805.1786437171056;1206.4993027893502;1235.5366737473448;1239.8078297863844;1262.4255963536568;1266.1959655618564;6254.843628909313;6265.8746825063245;6292.433680968735;6299.149614802035;6352.650604216812;6692.59844409337;6721.361470660279;6759.741362941316;6759.763408280686;6771.424428923498;6205.782797602063;6259.71831267594;6297.622142671455;6299.338569450142;6342.302346741854;3558.8255875561003;3568.964310356915;3576.8569257229938;3592.694620957248;3617.9276414471565;7138.821529461805;7158.856822863618;7160.964195178991;7163.3552980232025;7186.425085993213;6520.717748787886;6953.20038195614;6977.476689248327;7013.649317534103;7016.2632923543315;7076.681549330293;7096.225943514121;7103.715851365888;7137.607431591312;7153.105861767279;6718.193816742022;6747.359000894907;6759.5606285591275;6814.965925170342;6861.1080559526945;6690.899636505359;6698.363655452724;6759.357861003196;6773;6788.185417749704;7009.894851577333;7034.402075823407;7073.540219885691;7080.185778635523;7126.85746285061;5027.69833809958;5128.102582048052;5131.204663277198;5137.255098010843;5141.28022076902;6637.53537252407;6747.257801641717;6790.049393084873;6903.344182302673;6950.409215216763;6477.643729594917;6507.772227971998;6515.576487528296;6611.570247933869;6630.30381809903;6488;6541.2249058188745;6559.704813283509;6648.368405001517;6672.132622759204;6494.675266236574;6533.150690410216;6613.867722645617;6636.767713130017;6664.866702666017;6643.468522518284;6668.699908504032;6711.228208756055;6711.697973591297;6731.46148308144;6484.28672845996;6486.254080780771;6490.740370385131;6531.126304426038;6545.410913017851 18:36:59 INFO - PID 31301 | |5;yui.html;936.2977766674994;942.7562401484468;965.3869792681645;972.8005758819443;985.0445068283765;19474.805251947477;19685.311014114508;20620.072096755644;20721.896390518046;20735.481612959684;22302.665460018114;22645.320640380774;22888.771112288872;23061;23138.30585082446;1038.792241551689;1056.6301794371984;1057.038095333247;1058.116472745255;1058.9841152382683;1043.3166276089173;1081.9296745711542;1088.1566785741036;1099.0328510910388;1099.1426687183969;1130.7851508213414;1137.3687603380122;1138.2828817844788;1139.2651739627936;1144.273386399638;1118.8657361116636;1120.1039168665077;1120.2046546951633;1120.7982563138632;1124.4658787076155;828.9461185022955;829.0341751859077;829.1749709039544;829.3738227638155;830.759079866844;19692.606147876962;19765.209391624318;19817.306394276133;20544;21458.570828583343;22719.88640056789;23123.7687623125;23347.76652233473;23529.764702352928;23676.171334003226;16193.757093643488;17305.480835574952;17349.219285132072;17428.302867885268;17534.473965781046;3698.9260214795554;3718.628137186287;3719.3119272934596;3719.888403347904;3727.1241258304276;142333;142692;142991.2850435741;143358;144343;16817.15914204285;17265.482035538953;17470.737938930924;17506.474805755846;17526.64946701059;33502.66497334996;33970.830145849606;34299.48550771741;34332;34456.48315275273;9184.770380740401;9365;9367.765805854771;9376.29677774156;9377.39046961959;4408.360787685768;4463.665225108065;4477.440319960005;4482.731036137842;4491.416115904977;5702.800401985911;5846.239988801513;5871.178035075093;5911.76352945886;5918.822435326947;1093.0708897437273;1114.7157474843864;1133.1331531378503;1134.8241022641503;1138.908887289015;684.1414025398193;701.2111374703459;708.6704682322745;712.9322714342129;715.3097261142918;11773.764524709457;11838.526458941546;12010.459529321202;12237.694057648452;12491.500339986298;695.9373656370951;746.268656716421;754.1591125894588;761.9238076192337;772.3628006894335;5721.427857214246;5960.791372301948;6034.125051867454;6061.848453788691;6213.254409470802;131174.34412827875;137053;139273;140838;145916;120763;126427.36786316194;127220;127495.99999999815;130925.34537327442;101882;103066.48466757618;104915.95084049215;105856;108871;12317.568885088978;12877.380167435778;12920.35398230066;13112.213267203999;13345.443475743841;38496.65261715827;48515;48516.78708032327;49101.75449122874;49947.50052499574;89468;90113;91135.54432227796;91806;93624;18918.43244702661;18957.241710331433;19014.524636884187;19175.808241917402;19277.710834337777;20225.898870506142;20575.69136462984;20753.066112025295;20782.792172078087;20855.582888341843;18984.620307594047;19123.713144303125;19305.227790888206;19439;19859.900700496404;17427.302907883543;17463.38878139259;17493.30026798914;17681.911590441967;18269.81730182681;17669.38157164493;17864.91067544706;19128.521786955436;19732.112054957848;20260.493487662927;14747.92626036863;14807.481738139113;14833.703325933637;14926.850731492546;15083.24583770829;15486.148261845707;15894.920525397762;16032.919835400748;16192.190390480193;16206 18:36:59 INFO - PID 31301 | __end_tp_report 18:36:59 INFO - PID 31301 | __start_cc_report 18:36:59 INFO - PID 31301 | _x_x_mozilla_cycle_collect,346 18:36:59 INFO - PID 31301 | __end_cc_report 18:36:59 INFO - PID 31301 | __startTimestamp1502933819922__endTimestamp 18:36:59 INFO - PID 31301 | 18:36:59 INFO - PID 31301 | ------- Summary: start ------- 18:36:59 INFO - PID 31301 | Number of tests: 6 18:36:59 INFO - PID 31301 | 18:36:59 INFO - PID 31301 | [#0] dojo.html Cycles:165 Average:6279.22 Median:6626.34 stddev:829.22 (12.5%) stddev-sans-first:801.53 18:36:59 INFO - PID 31301 | Values: 3451.1 3473.6 3512.1 3522.4 3528.8 6228.2 6359.8 6378.8 6383.5 6403.3 6240.8 6259.7 6319.6 6325.3 6333.4 5564.3 5596.5 5598.6 5614.7 5671.2 5356.7 5511.7 5518.9 5525.9 5596.0 5471.6 5491.3 5557.8 5577.1 5606.2 5540.8 5544.7 5593.0 5608.5 5626.3 5466.2 5529.2 5544.4 5549.8 5550.7 6257.2 6272.6 6295.3 6300.8 6345.4 6761.6 6817.4 6845.0 6858.1 6882.1 6737.7 6797.5 6814.5 6880.5 6891.5 6289.7 6339.1 6432.1 6432.5 6440.1 6986.2 6993.4 7088.0 7090.9 7154.9 6692.5 6708.8 6787.5 6799.7 6807.2 6822.5 6839.3 6876.0 6940.3 6946.9 6820.8 6833.3 6846.8 6847.1 6860.4 6751.3 6821.7 6828.7 6830.4 6893.0 4854.6 4890.7 4932.9 4973.3 4982.3 4344.7 4375.3 4383.9 4397.2 4423.0 6370.4 6382.2 6452.4 6473.4 6477.9 6685.2 6768.9 6772.8 6807.6 6897.9 6450.5 6454.3 6454.8 6462.3 6470.0 5409.9 5479.8 5482.9 5487.5 5510.4 7059.0 7072.7 7108.8 7207.8 7224.9 6768.5 6800.8 6824.7 6858.1 6880.7 7174.9 7180.2 7182.5 7202.2 7207.9 6626.3 6638.9 6691.2 6716.1 6727.4 6937.3 6960.7 6974.4 6987.9 6994.9 6645.8 6650.0 6740.0 6741.5 6750.6 6679.3 6692.6 6757.4 6772.2 6773.5 6565.9 6631.4 6646.2 6657.0 6725.1 6574.9 6683.9 6686.4 6734.4 6752.7 6421.8 6520.2 6613.3 6623.2 6624.2 18:36:59 INFO - PID 31301 | 18:36:59 INFO - PID 31301 | [#1] ext.html Cycles:180 Average:42960.53 Median:36282.54 stddev:66369.95 (182.9%) stddev-sans-first:66480.87 18:36:59 INFO - PID 31301 | Values: 865.2 906.7 934.0 954.8 961.4 41792.4 42588.8 42612.4 42726.4 42748.6 39355.6 39518.8 39555.6 39645.8 39729.4 6938.7 7006.5 7036.8 7044.6 7046.4 6947.8 7043.0 7046.2 7048.8 7049.0 7537.9 7735.3 7738.4 7738.4 7743.9 7654.2 7723.2 7725.8 7734.2 7737.7 7389.5 7516.4 7563.6 7595.0 7616.5 38174.4 38396.0 38479.2 38536.0 38608.6 3421.0 3469.8 3477.7 3478.1 3479.1 30409.5 30453.0 30506.5 30511.2 30609.2 5153.8 5177.3 5200.2 5212.1 5232.8 209021.0 211228.0 224781.0 226698.0 272239.6 49757.3 50023.0 50064.7 50078.7 51289.0 52092.7 52499.6 52631.5 52796.5 52825.7 16270.9 16381.0 16383.0 16394.3 16566.9 13405.0 13408.5 13416.7 13499.0 13518.3 14367.9 14452.0 14544.8 14575.7 14587.5 5903.9 5932.9 6055.0 6071.4 6169.8 1070.6 1070.8 1078.4 1096.8 1099.5 24544.9 24557.3 24596.6 30603.6 31758.7 1178.6 1184.8 1193.2 1194.6 1195.4 12942.0 13412.4 13473.4 17137.3 17490.2 275030.0 275591.0 275715.0 276787.0 276938.0 55900.7 56734.0 56813.0 56966.0 56981.0 1468.1 1486.7 1511.8 1520.8 1525.9 28420.7 28741.6 29190.9 29357.1 29989.3 50531.5 50607.2 50624.0 50636.5 50890.7 254876.0 257389.0 257804.0 257813.0 258051.0 35522.8 37042.3 37188.0 37277.8 37281.3 46012.8 46035.1 46065.3 46483.5 46561.0 33789.7 34079.7 34113.5 34340.1 34483.5 33993.8 34159.7 34179.0 34534.7 34729.7 39587.2 39610.6 39720.2 39818.4 39829.8 32742.5 33045.0 33244.0 34024.7 34750.3 25522.6 26641.2 26877.6 27006.5 27060.1 18:36:59 INFO - PID 31301 | 18:36:59 INFO - PID 31301 | [#2] jquery.html Cycles:180 Average:38971.56 Median:22213.00 stddev:98370.11 (442.8%) stddev-sans-first:98603.76 18:36:59 INFO - PID 31301 | Values: 549.4 567.2 573.8 579.1 588.7 21863.0 22563.0 22564.9 22612.2 22691.1 25168.5 25509.7 25693.6 25738.2 25773.6 5911.7 6005.2 6013.2 6041.0 6053.5 5730.0 5957.2 5993.4 6080.2 6233.8 6178.1 6178.9 6179.0 6179.8 6196.5 6149.2 6161.0 6165.5 6207.6 6218.2 5755.8 5770.3 5778.1 5779.7 5796.4 28825.1 29285.6 29416.0 29669.6 30380.8 2100.2 2150.8 2152.0 2152.0 2153.8 19784.8 19818.0 20103.4 20745.2 20842.4 2394.5 2408.6 2431.2 2434.0 2470.5 151404.2 156364.0 156420.2 156582.0 157018.0 14897.0 15298.2 15424.9 15811.3 15950.4 23546.4 23552.4 23695.8 23698.2 23734.8 10269.9 10376.6 10408.8 10421.2 10453.5 9328.3 9341.1 9384.7 9440.4 9461.5 8496.3 9740.9 9753.3 9792.2 9848.4 2572.3 2586.8 2730.8 2774.8 2825.3 1011.3 1049.7 1054.8 1060.5 1068.2 21193.9 21203.8 21359.6 21483.2 21687.3 1104.5 1118.6 1124.5 1128.8 1133.0 11649.0 11888.3 11937.5 11945.8 11966.3 561150.0 573175.0 591102.0 599224.0 599864.0 127269.5 130968.0 130994.0 131628.3 133392.0 1229.1 1270.2 1272.0 1272.9 1277.2 18970.0 19144.6 19245.2 19250.9 19458.2 64063.0 64116.4 64718.7 64755.4 66176.0 77525.6 77953.6 78086.6 78398.6 78428.6 12728.4 13051.8 14628.0 14802.1 14932.9 23146.2 24019.2 24026.9 24201.3 24373.5 19260.9 19418.3 19478.0 19557.1 19600.7 17367.5 17483.3 17540.4 18029.4 18133.6 19668.9 19727.3 20092.7 20206.2 20308.4 14331.4 14357.6 14424.4 14444.1 14480.7 19067.5 19090.3 19132.4 19166.6 19181.8 18:36:59 INFO - PID 31301 | 18:36:59 INFO - PID 31301 | [#3] mootools.html Cycles:180 Average:10165.23 Median:24648.63 stddev:7501.88 (30.4%) stddev-sans-first:7494.24 18:36:59 INFO - PID 31301 | Values: 1434.1 1491.9 1492.1 1496.9 1498.4 15443.5 16057.8 16058.4 16092.6 16093.3 15786.9 16439.4 16991.7 17007.9 17033.1 2671.1 2736.8 2739.8 2741.8 2742.1 2651.5 2652.4 2704.9 2741.8 2753.2 2730.5 2738.5 2759.2 2761.5 2767.4 2624.2 2637.8 2648.5 2651.1 2655.8 2653.6 2660.1 2662.4 2662.4 2663.3 15715.8 16072.6 16105.0 16122.8 16135.9 8413.0 8638.2 8643.2 8660.8 8675.2 5285.6 5384.2 5550.5 5593.0 5604.1 1809.8 1929.9 1936.5 1964.1 1974.8 29525.6 29556.1 29721.4 29723.3 29761.9 7128.8 7131.6 7200.6 7262.3 7337.0 19367.9 19438.6 19563.9 19604.7 19611.5 7673.8 7849.5 8425.1 8427.4 8433.0 7609.5 7742.2 7763.0 7830.2 7881.6 5021.5 5229.3 5370.0 5401.7 5424.9 1410.1 1533.5 1560.5 1568.3 1590.5 945.3 986.4 989.2 1000.0 1017.4 9015.5 9382.0 9509.0 9595.8 9630.2 1023.1 1043.4 1049.9 1056.3 1062.0 4947.4 5370.2 5870.4 5924.5 6044.3 23386.6 23717.6 24392.9 24607.0 24651.4 23553.5 23623.6 24302.0 24616.8 24645.9 12613.2 12675.0 12862.2 12911.7 12932.7 9049.7 9120.2 9160.9 9217.0 9250.6 20779.6 20912.0 21213.8 21319.6 21386.9 20777.6 21219.6 21247.7 21333.0 21376.8 13627.0 13778.6 13881.0 13904.4 13909.4 13041.8 14273.7 14416.4 14441.4 14490.2 10257.2 11829.4 11835.2 12303.2 12464.6 11327.5 11330.9 11388.1 11548.0 11615.4 10272.5 10396.8 10413.7 10414.8 10419.9 7948.7 8039.8 8045.3 8110.9 8121.9 7729.4 7883.4 7961.0 8121.5 8153.1 18:36:59 INFO - PID 31301 | 18:36:59 INFO - PID 31301 | [#4] prototype.html Cycles:180 Average:5602.73 Median:6242.77 stddev:1610.00 (25.8%) stddev-sans-first:1568.51 18:36:59 INFO - PID 31301 | Values: 511.8 513.4 532.3 535.2 535.2 6166.6 6192.2 6202.1 6205.5 6230.7 6097.8 6107.4 6117.2 6154.4 6205.6 4875.1 4899.9 4907.7 4949.2 4982.0 4699.9 4841.1 4852.8 4887.2 4943.4 4720.7 4743.2 4760.2 4803.0 4825.3 4760.4 4772.4 4793.8 4796.1 4796.6 4327.1 4339.2 4347.3 4349.6 4361.3 6015.9 6061.1 6078.3 6097.5 6131.6 5694.5 5727.7 5732.4 5740.0 5742.2 6451.3 6549.4 6554.6 6620.3 6630.6 4840.7 4850.9 4914.5 4921.7 4929.9 6594.6 6695.7 6821.7 6932.3 6957.3 4978.5 5038.3 5062.5 5068.8 5072.8 5140.3 5153.5 5181.7 5182.5 5191.1 5662.9 5693.8 5704.9 5752.3 5779.4 6611.5 6634.5 6666.3 6666.8 6668.9 1779.8 1787.3 1791.5 1800.8 1805.2 1206.5 1235.5 1239.8 1262.4 1266.2 6254.8 6265.9 6292.4 6299.1 6352.7 6692.6 6721.4 6759.7 6759.8 6771.4 6205.8 6259.7 6297.6 6299.3 6342.3 3558.8 3569.0 3576.9 3592.7 3617.9 7138.8 7158.9 7161.0 7163.4 7186.4 6520.7 6953.2 6977.5 7013.6 7016.3 7076.7 7096.2 7103.7 7137.6 7153.1 6718.2 6747.4 6759.6 6815.0 6861.1 6690.9 6698.4 6759.4 6773.0 6788.2 7009.9 7034.4 7073.5 7080.2 7126.9 5027.7 5128.1 5131.2 5137.3 5141.3 6637.5 6747.3 6790.0 6903.3 6950.4 6477.6 6507.8 6515.6 6611.6 6630.3 6488.0 6541.2 6559.7 6648.4 6672.1 6494.7 6533.2 6613.9 6636.8 6664.9 6643.5 6668.7 6711.2 6711.7 6731.5 6484.3 6486.3 6490.7 6531.1 6545.4 18:36:59 INFO - PID 31301 | 18:36:59 INFO - PID 31301 | [#5] yui.html Cycles:180 Average:27677.87 Median:19372.11 stddev:39645.29 (204.7%) stddev-sans-first:39705.66 18:36:59 INFO - PID 31301 | Values: 936.3 942.8 965.4 972.8 985.0 19474.8 19685.3 20620.1 20721.9 20735.5 22302.7 22645.3 22888.8 23061.0 23138.3 1038.8 1056.6 1057.0 1058.1 1059.0 1043.3 1081.9 1088.2 1099.0 1099.1 1130.8 1137.4 1138.3 1139.3 1144.3 1118.9 1120.1 1120.2 1120.8 1124.5 828.9 829.0 829.2 829.4 830.8 19692.6 19765.2 19817.3 20544.0 21458.6 22719.9 23123.8 23347.8 23529.8 23676.2 16193.8 17305.5 17349.2 17428.3 17534.5 3698.9 3718.6 3719.3 3719.9 3727.1 142333.0 142692.0 142991.3 143358.0 144343.0 16817.2 17265.5 17470.7 17506.5 17526.6 33502.7 33970.8 34299.5 34332.0 34456.5 9184.8 9365.0 9367.8 9376.3 9377.4 4408.4 4463.7 4477.4 4482.7 4491.4 5702.8 5846.2 5871.2 5911.8 5918.8 1093.1 1114.7 1133.1 1134.8 1138.9 684.1 701.2 708.7 712.9 715.3 11773.8 11838.5 12010.5 12237.7 12491.5 695.9 746.3 754.2 761.9 772.4 5721.4 5960.8 6034.1 6061.8 6213.3 131174.3 137053.0 139273.0 140838.0 145916.0 120763.0 126427.4 127220.0 127496.0 130925.3 101882.0 103066.5 104916.0 105856.0 108871.0 12317.6 12877.4 12920.4 13112.2 13345.4 38496.7 48515.0 48516.8 49101.8 49947.5 89468.0 90113.0 91135.5 91806.0 93624.0 18918.4 18957.2 19014.5 19175.8 19277.7 20225.9 20575.7 20753.1 20782.8 20855.6 18984.6 19123.7 19305.2 19439.0 19859.9 17427.3 17463.4 17493.3 17681.9 18269.8 17669.4 17864.9 19128.5 19732.1 20260.5 14747.9 14807.5 14833.7 14926.9 15083.2 15486.1 15894.9 16032.9 16192.2 16206.0 18:36:59 INFO - PID 31301 | -------- Summary: end -------- 18:36:59 INFO - PID 31301 | 18:37:00 INFO - TEST-INFO | 31301: exit 0 18:37:00 INFO - TEST-OK | dromaeo_css | took 1108843ms 18:37:00 INFO - TEST-START | kraken 18:37:00 INFO - Initialising browser for kraken test... 18:37:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:54153/getInfo.html -profile /tmp/tmpX1rnPJ/profile 18:37:00 INFO - TEST-INFO | started process 31668 (/builds/slave/test/build/application/firefox/firefox http://localhost:54153/getInfo.html) 18:37:05 INFO - TEST-INFO | 31668: exit 0 18:37:05 INFO - Browser initialized. 18:37:05 INFO - Running cycle 1/1 for kraken test... 18:37:05 INFO - TEST-INFO | started process 31839 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX1rnPJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:37:06 INFO - PID 31839 | 18:37:06 INFO - PID 31839 | (/builds/slave/test/build/application/firefox/firefox:31887): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:37:06 INFO - PID 31839 | 18:37:17 INFO - PID 31839 | RSS: Main: 157478912 18:37:17 INFO - PID 31839 | 18:37:19 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54153/tests/kraken/driver.html?testName=audio-beat-detection) 18:37:20 INFO - PID 31839 | RSS: Main: 163323904 18:37:20 INFO - PID 31839 | 18:37:23 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54153/tests/kraken/driver.html?testName=audio-dft) 18:37:23 INFO - PID 31839 | RSS: Main: 167944192 18:37:23 INFO - PID 31839 | 18:37:26 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54153/tests/kraken/driver.html?testName=audio-fft) 18:37:27 INFO - PID 31839 | RSS: Main: 160870400 18:37:27 INFO - PID 31839 | 18:37:29 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54153/tests/kraken/driver.html?testName=audio-oscillator) 18:37:29 INFO - PID 31839 | RSS: Main: 162000896 18:37:29 INFO - PID 31839 | 18:37:32 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54153/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:37:32 INFO - PID 31839 | RSS: Main: 161931264 18:37:32 INFO - PID 31839 | 18:37:35 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54153/tests/kraken/driver.html?testName=imaging-darkroom) 18:37:36 INFO - PID 31839 | RSS: Main: 162934784 18:37:36 INFO - PID 31839 | 18:37:39 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54153/tests/kraken/driver.html?testName=imaging-desaturate) 18:37:40 INFO - PID 31839 | RSS: Main: 165048320 18:37:40 INFO - PID 31839 | 18:37:43 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54153/tests/kraken/driver.html?testName=json-parse-financial) 18:37:43 INFO - PID 31839 | RSS: Main: 164347904 18:37:43 INFO - PID 31839 | 18:37:45 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54153/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:37:45 INFO - PID 31839 | RSS: Main: 164098048 18:37:45 INFO - PID 31839 | 18:37:47 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54153/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:37:48 INFO - PID 31839 | RSS: Main: 164069376 18:37:48 INFO - PID 31839 | 18:37:50 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54153/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:37:50 INFO - PID 31839 | RSS: Main: 163803136 18:37:50 INFO - PID 31839 | 18:37:53 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:37:54 INFO - PID 31839 | RSS: Main: 163667968 18:37:54 INFO - PID 31839 | 18:37:57 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:37:57 INFO - PID 31839 | RSS: Main: 164659200 18:37:57 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | Cycle 1(1): loaded http://localhost:54153/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54153/tests/kraken/driver.html?testName=ai-astar) 18:37:59 INFO - PID 31839 | RSS: Main: 166035456 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | __start_tp_report 18:37:59 INFO - PID 31839 | _x_x_mozilla_page_load 18:37:59 INFO - PID 31839 | _x_x_mozilla_page_load_details 18:37:59 INFO - PID 31839 | |i|pagename|runs| 18:37:59 INFO - PID 31839 | |0;ai-astar;97;110;98;106;106;107;107;101;107;111 18:37:59 INFO - PID 31839 | |1;audio-beat-detection;133;112;145;176;114;146;140;112;171;113 18:37:59 INFO - PID 31839 | |2;audio-dft;164;164;163;161;162;164;162;163;167;167 18:37:59 INFO - PID 31839 | |3;audio-fft;73;75;74;176;73;74;72;76;166;76 18:37:59 INFO - PID 31839 | |4;audio-oscillator;78;78;133;78;78;77;131;77;78;126 18:37:59 INFO - PID 31839 | |5;imaging-gaussian-blur;114;114;114;114;114;114;114;114;114;114 18:37:59 INFO - PID 31839 | |6;imaging-darkroom;148;148;152;148;148;148;149;148;149;148 18:37:59 INFO - PID 31839 | |7;imaging-desaturate;95;94;94;94;93;94;94;94;94;94 18:37:59 INFO - PID 31839 | |8;json-parse-financial;47;47;53;50;48;48;47;50;47;48 18:37:59 INFO - PID 31839 | |9;json-stringify-tinderbox;55;55;54;54;54;54;55;54;54;54 18:37:59 INFO - PID 31839 | |10;stanford-crypto-aes;72;71;74;74;73;73;71;74;75;73 18:37:59 INFO - PID 31839 | |11;stanford-crypto-ccm;117;115;118;114;118;113;110;113;111;158 18:37:59 INFO - PID 31839 | |12;stanford-crypto-pbkdf2;165;166;166;164;169;175;164;173;164;163 18:37:59 INFO - PID 31839 | |13;stanford-crypto-sha256-iterative;61;63;60;70;62;61;60;62;60;62 18:37:59 INFO - PID 31839 | __end_tp_report 18:37:59 INFO - PID 31839 | __start_cc_report 18:37:59 INFO - PID 31839 | _x_x_mozilla_cycle_collect,836 18:37:59 INFO - PID 31839 | __end_cc_report 18:37:59 INFO - PID 31839 | __startTimestamp1502933879545__endTimestamp 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | ------- Summary: start ------- 18:37:59 INFO - PID 31839 | Number of tests: 14 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#0] ai-astar Cycles:10 Average:105.00 Median:108.50 stddev:4.76 (4.4%) stddev-sans-first:4.08 18:37:59 INFO - PID 31839 | Values: 97.0 110.0 98.0 106.0 106.0 107.0 107.0 101.0 107.0 111.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:142.50 stddev:24.03 (16.9%) stddev-sans-first:25.46 18:37:59 INFO - PID 31839 | Values: 133.0 112.0 145.0 176.0 114.0 146.0 140.0 112.0 171.0 113.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#2] audio-dft Cycles:10 Average:163.70 Median:164.00 stddev:2.00 (1.2%) stddev-sans-first:2.12 18:37:59 INFO - PID 31839 | Values: 164.0 164.0 163.0 161.0 162.0 164.0 162.0 163.0 167.0 167.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#3] audio-fft Cycles:10 Average:93.50 Median:74.00 stddev:40.93 (55.3%) stddev-sans-first:42.74 18:37:59 INFO - PID 31839 | Values: 73.0 75.0 74.0 176.0 73.0 74.0 72.0 76.0 166.0 76.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#4] audio-oscillator Cycles:10 Average:93.40 Median:78.00 stddev:25.32 (32.5%) stddev-sans-first:26.23 18:37:59 INFO - PID 31839 | Values: 78.0 78.0 133.0 78.0 78.0 77.0 131.0 77.0 78.0 126.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 18:37:59 INFO - PID 31839 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.00 stddev:1.26 (0.9%) stddev-sans-first:1.32 18:37:59 INFO - PID 31839 | Values: 148.0 148.0 152.0 148.0 148.0 148.0 149.0 148.0 149.0 148.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 18:37:59 INFO - PID 31839 | Values: 95.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#8] json-parse-financial Cycles:10 Average:48.50 Median:48.00 stddev:1.96 (4.1%) stddev-sans-first:2.00 18:37:59 INFO - PID 31839 | Values: 47.0 47.0 53.0 50.0 48.0 48.0 47.0 50.0 47.0 48.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 18:37:59 INFO - PID 31839 | Values: 55.0 55.0 54.0 54.0 54.0 54.0 55.0 54.0 54.0 54.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#10] stanford-crypto-aes Cycles:10 Average:73.00 Median:73.50 stddev:1.33 (1.8%) stddev-sans-first:1.36 18:37:59 INFO - PID 31839 | Values: 72.0 71.0 74.0 74.0 73.0 73.0 71.0 74.0 75.0 73.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#11] stanford-crypto-ccm Cycles:10 Average:118.70 Median:116.00 stddev:14.08 (12.1%) stddev-sans-first:14.92 18:37:59 INFO - PID 31839 | Values: 117.0 115.0 118.0 114.0 118.0 113.0 110.0 113.0 111.0 158.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.90 Median:166.00 stddev:4.12 (2.5%) stddev-sans-first:4.31 18:37:59 INFO - PID 31839 | Values: 165.0 166.0 166.0 164.0 169.0 175.0 164.0 173.0 164.0 163.0 18:37:59 INFO - PID 31839 | 18:37:59 INFO - PID 31839 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:2.96 (4.8%) stddev-sans-first:3.11 18:37:59 INFO - PID 31839 | Values: 61.0 63.0 60.0 70.0 62.0 61.0 60.0 62.0 60.0 62.0 18:37:59 INFO - PID 31839 | -------- Summary: end -------- 18:37:59 INFO - PID 31839 | 18:38:00 INFO - PID 31839 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:38:00 INFO - TEST-INFO | 31839: exit 0 18:38:00 INFO - TEST-OK | kraken | took 59797ms 18:38:00 INFO - SUITE-END | took 1168s 18:38:00 INFO - Completed test suite (00:19:29) 18:38:00 INFO - javascript benchmark 18:38:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8946.304939493677, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3451.0682115828713, 3473.583170019598, 3512.104413374588, 3522.3835828729966, 3528.752987290889, 6228.190335256421, 6359.80920572383, 6378.808635740924, 6383.457406120474, 6403.327650596691, 6240.812775616728, 6259.687015649222, 6319.5576309658345, 6325.335839736819, 6333.429991300782, 5564.304461942247, 5596.524295434893, 5598.636088654245, 5614.747336369853, 5671.2060311556415, 5356.705381204032, 5511.724413779315, 5518.862028449281, 5525.861853453675, 5596.0, 5471.616986810925, 5491.341039075297, 5557.777688892439, 5577.135543990688, 5606.21512988182, 5540.750666220029, 5544.7227638618315, 5592.972035139839, 5608.46719561641, 5626.2967129108865, 5466.207399927028, 5529.198266251411, 5544.390117087117, 5549.77800887964, 5550.666959982414, 6257.186565746424, 6272.56092073555, 6295.338989406138, 6300.810975670737, 6345.397187267202, 6761.628110453923, 6817.420519255819, 6845.007473916304, 6858.108445902001, 6882.139732533434, 6737.6968036438475, 6797.524173307821, 6814.48891333147, 6880.518363714542, 6891.483138764613, 6289.748410063592, 6339.0808332791485, 6432.13166222554, 6432.4532414744335, 6440.0661904023655, 6986.196587392414, 6993.405560527311, 7088.0, 7090.936359546006, 7154.892676609855, 6692.464602831762, 6708.765193218312, 6787.457003439713, 6799.694013769392, 6807.18313802337, 6822.488313376417, 6839.316068393121, 6875.965620171967, 6940.271271516519, 6946.861062778716, 6820.795376138723, 6833.282505336968, 6846.7945961621235, 6847.144106986627, 6860.3825655690225, 6751.324867513307, 6821.658917054127, 6828.658567071627, 6830.419414349836, 6893.034975103489, 4854.63590230727, 4890.657653964259, 4932.926006109911, 4973.32860063894, 4982.302477653131, 4344.674149438742, 4375.321825117112, 4383.912321753547, 4397.2304846651705, 4423.0, 6370.362963703686, 6382.170317858649, 6452.419282264619, 6473.385028422293, 6477.935220647827, 6685.197776266782, 6768.864622707519, 6772.83067923296, 6807.591544507345, 6897.896531552031, 6450.5484616077365, 6454.257760357619, 6454.774082907075, 6462.256840463407, 6470.029495575702, 5409.945900541023, 5479.808206712746, 5482.91775623366, 5487.478689524489, 5510.366307874646, 7059.0, 7072.681729322193, 7108.751193708195, 7207.783766487014, 7224.855502889913, 6768.4585233182215, 6800.761973330909, 6824.727010919508, 6858.108445902001, 6880.724771009103, 7174.856502870018, 7180.210176880434, 7182.497225194186, 7202.171750248579, 7207.855842883008, 6626.337366263335, 6638.900416493853, 6691.230508491391, 6716.059751634677, 6727.360900714424, 6937.271586483346, 6960.686769095301, 6974.407175390149, 6987.860242795217, 6994.895076573957, 6645.767398141042, 6649.966750166218, 6740.0, 6741.494387920828, 6750.628715420699, 6679.265280819009, 6692.631905245258, 6757.358050985148, 6772.153480814898, 6773.5258531904265, 6565.934340656723, 6631.403173714389, 6646.169228846395, 6657.0, 6725.058491811053, 6574.868502629825, 6683.933160668331, 6686.431653309523, 6734.3939045484185, 6752.729890804313, 6421.775237866839, 6520.2447069994405, 6613.338666133348, 6623.172103487064, 6624.171978502687], "value": 6214.156610896752, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [865.2226932233899, 906.6554709210495, 934.0379409208515, 954.8424509955858, 961.3510880155893, 41792.37311440327, 42588.78705606471, 42612.3608145878, 42726.35910461345, 42748.57251427485, 39355.60644393563, 39518.80240598793, 39555.604443955555, 39645.80177099111, 39729.40405893914, 6938.653067346625, 7006.509544331899, 7036.824079398005, 7044.612546309951, 7046.4010559102535, 6947.79156625302, 7042.964785176067, 7046.154461464632, 7048.753293634723, 7048.964755176217, 7537.924620753777, 7735.303822655988, 7738.419618528605, 7738.419618528605, 7743.8838417423785, 7654.158042615336, 7723.189065148163, 7725.768226953201, 7734.187910269425, 7737.651805668758, 7389.482736208468, 7516.436267279922, 7563.584002879839, 7595.012648355733, 7616.504927179715, 38174.42738358927, 38396.0, 38479.23041539153, 38536.0, 38608.61391386078, 3421.0250078727445, 3469.8265086745814, 3477.739169562293, 3478.060923550627, 3479.0606536235073, 30409.543856842167, 30453.0, 30506.54240186399, 30511.237219069702, 30609.234769130726, 5153.819616313411, 5177.301064356301, 5200.167973124319, 5212.061828870802, 5232.790688372461, 209021.0, 211228.0, 224781.0, 226698.0, 272239.6388018067, 49757.25364119541, 50023.0, 50064.749676251384, 50078.74960625174, 51289.0, 52092.73953630208, 52499.63751631186, 52631.47368526266, 52796.47203527993, 52825.735871321165, 16270.918645406933, 16381.0, 16383.0, 16394.344226231056, 16566.917165414096, 13405.0, 13408.530701425403, 13416.664583385493, 13499.0, 13518.324083795967, 14367.850571954219, 14452.0, 14544.781828272584, 14575.708485830224, 14587.489437869624, 5903.881922361528, 5932.881342373128, 6055.004621187538, 6071.423214794588, 6169.784057557964, 1070.6092276319087, 1070.7995070130955, 1078.449990504848, 1096.8464414981909, 1099.4502748625687, 24544.913682336843, 24557.263282101565, 24596.631050534255, 30603.637817309882, 31758.682413176033, 1178.6051672689746, 1184.8459700239086, 1193.1945936492832, 1194.6475789642077, 1195.4381440722846, 12942.0, 13412.39644215993, 13473.393697283645, 17137.314507419815, 17490.21294041771, 275030.0, 275591.0, 275715.0, 276787.0, 276938.0, 55900.720496397254, 56734.0, 56813.0, 56966.0, 56981.0, 1468.1338010573813, 1486.6952274783644, 1511.8034655494716, 1520.8098987626547, 1525.8931874768882, 28420.715792842635, 28741.56887646729, 29190.854045729637, 29357.119286421443, 29989.250268742584, 50531.49468505415, 50607.240891387395, 50624.0, 50636.49363506465, 50890.74554627203, 254876.0, 257389.0, 257804.0, 257813.0, 258051.0, 35522.82238588791, 37042.25915481729, 37188.0, 37277.81361093177, 37281.25437491289, 46012.76993615011, 46035.079298414516, 46065.30902036539, 46483.53516464927, 46561.0, 33789.66210337865, 34079.659203407646, 34113.48829767605, 34340.14149646279, 34483.482747759306, 33993.83003084969, 34159.65840341565, 34178.97463076112, 34534.654653453144, 34729.65270347264, 39587.2082558353, 39610.60389396069, 39720.20559588734, 39818.402723958585, 39829.80085099672, 32742.50886236661, 33045.0, 33244.0, 34024.65975340215, 34750.304993900485, 25522.617160742233, 26641.20076397711, 26877.596836047866, 27006.459870802082, 27060.05289814847], "value": 18297.81964256556, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.4478049560194, 567.2030796730589, 573.810642487979, 579.1168468086171, 588.7438964050639, 21863.0, 22563.0, 22564.88717556414, 22612.20857269994, 22691.09235630573, 25168.496630067388, 25509.74490255097, 25693.614595781033, 25738.227853164433, 25773.61339579908, 5911.704414779255, 6005.189299444584, 6013.248343957005, 6040.969795151018, 6053.545984051214, 5730.0, 5957.1957785698805, 5993.430624090726, 6080.209572755558, 6233.750649973996, 6178.07328900664, 6178.938210617904, 6179.0422484514975, 6179.752809887599, 6196.535259855529, 6149.2313460817395, 6160.969195154041, 6165.537584681167, 6207.627542347428, 6218.22272215973, 5755.798547050833, 5770.336411312711, 5778.104393818965, 5779.653220806765, 5796.449337312949, 28825.135245942656, 29285.56071658927, 29416.0, 29669.554956675667, 30380.84809575938, 2100.19142630087, 2150.817180539656, 2152.0208305221086, 2152.0208305221086, 2153.849230553862, 19784.80215197844, 19818.0, 20103.39689809308, 20745.170193192254, 20842.37472875816, 2394.473215892501, 2408.5544174327806, 2431.222008957134, 2433.965838726083, 2470.542949554338, 151404.2429787855, 156364.0, 156420.2178989098, 156582.0, 157018.0, 14897.0, 15298.235088245543, 15424.922875385551, 15811.288492017888, 15950.441734539236, 23546.411339716302, 23552.411189720053, 23695.7630423697, 23698.170564030177, 23734.7626523736, 10269.897301026895, 10376.584936602452, 10408.791824163474, 10421.166306695446, 10453.477326133814, 9328.34701570897, 9341.11259430353, 9384.67153649619, 9440.356700123839, 9461.52692365379, 8496.320294376435, 9740.853887191697, 9753.268504862164, 9792.167665748491, 9848.409095454295, 2572.305477521059, 2586.818922675432, 2730.8224965377185, 2774.7652294729055, 2825.3129665786346, 1011.3022014809758, 1049.6536143072767, 1054.841773733946, 1060.5174645536263, 1068.1668298727006, 21193.894030530057, 21203.787962120183, 21359.572808544053, 21483.248086316904, 21687.34937951864, 1104.5305745058317, 1118.552578968419, 1124.4883577972003, 1128.841962125303, 1133.0, 11648.95159435655, 11888.28670279786, 11937.52249909994, 11945.820812687816, 11966.324714539971, 561150.0, 573175.0, 591102.0, 599224.0, 599864.0, 127269.54556590474, 130968.0, 130994.0, 131628.3418582901, 133392.0, 1229.0904730499544, 1270.1934271737327, 1271.961841144767, 1272.8790764877322, 1277.2208952538758, 18969.95665238425, 19144.617107658047, 19245.230190792212, 19250.903745481184, 19458.221671133564, 64063.0, 64116.3588364129, 64718.67640661766, 64755.35244647682, 66176.0, 77525.61237193778, 77953.58597087303, 78086.6095669518, 78398.60800696188, 78428.60785696036, 12728.363581821057, 13051.804222936473, 14628.0, 14802.111873287637, 14932.850671493581, 23146.189883354004, 24019.159329424085, 24026.87986560056, 24201.273961781175, 24373.51252974895, 19260.903695481433, 19418.32035878794, 19478.0, 19557.11992960292, 19600.705989410457, 17367.47897563075, 17483.300667973137, 17540.421362076962, 18029.368972085915, 18133.637327253116, 19668.90165549163, 19727.309544165884, 20092.698609520576, 20206.19175232974, 20308.390748277576, 14331.426742930165, 14357.56927292183, 14424.350904209545, 14444.133351998913, 14480.710385792014, 19067.523311917314, 19090.33183838559, 19132.426027219204, 19166.61666766629, 19181.808181918], "value": 12365.601570848014, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1434.067855893669, 1491.9030263032896, 1492.1345619540668, 1496.9027013244138, 1498.4231071037648, 15443.536693899174, 16057.759133613004, 16058.437954671588, 16092.597685057879, 16093.275802588882, 15786.921065394657, 16439.4246201383, 16991.660166796686, 17007.914960425212, 17033.063181525013, 2671.131882138303, 2736.7536921677047, 2739.849308288043, 2741.753242208201, 2742.149933520605, 2651.4564514274525, 2652.4429869727383, 2704.9188524344204, 2741.8080734348605, 2753.1740477856665, 2730.549459339207, 2738.4523095381005, 2759.18604011816, 2761.4753196892625, 2767.405007923296, 2624.18650218431, 2637.841729496227, 2648.523265812153, 2651.1383800264894, 2655.8273712208743, 2653.6417583626157, 2660.068975858434, 2662.387650840298, 2662.427578070705, 2663.307540039584, 15715.764263536055, 16072.59818504535, 16105.0, 16122.838771612369, 16135.91932040344, 8413.032501262373, 8638.222559969632, 8643.222110010067, 8660.82678346436, 8675.219230269306, 5285.63000589955, 5384.246205531229, 5550.5282051025715, 5593.04918163909, 5604.075327570946, 1809.7737782777153, 1929.9228030878749, 1936.5255512399413, 1964.0965156028244, 1974.8123928226796, 29525.557116643267, 29556.113316600753, 29721.405571888656, 29723.256918576993, 29761.851190744124, 7128.750493732695, 7131.572105673677, 7200.603966781878, 7262.273772622695, 7337.009503716929, 19367.903160484388, 19438.611227775364, 19563.90218048929, 19604.745454272943, 19611.509712257306, 7673.846523069507, 7849.4897831640765, 8425.11536288693, 8427.41008129425, 8433.03020152678, 7609.505382150142, 7742.225777422325, 7762.990811194509, 7830.177831327628, 7881.605919703992, 5021.5229553192385, 5229.320188375486, 5370.01309515474, 5401.7299135043095, 5424.945750542523, 1410.1116296732991, 1533.5246073717183, 1560.4928398270608, 1568.2785918477628, 1590.4989928172588, 945.3382632157517, 986.3835103060587, 989.1660392974078, 1000.0049950299499, 1017.3692310767224, 9015.549222538846, 9381.953090234505, 9508.952455237679, 9595.760105997266, 9630.181434577999, 1023.1098943918838, 1043.3844032021143, 1049.879263884663, 1056.3133962924007, 1062.0335494699787, 4947.431045429749, 5370.167624018283, 5870.412958704095, 5924.526037917042, 6044.274687037584, 23386.64920026201, 23717.644235336484, 24392.87803560971, 24607.0, 24651.3837154069, 23553.528929421314, 23623.645645315333, 24302.0, 24616.753832461447, 24645.876770616032, 12613.243205407705, 12675.0, 12862.228266304051, 12911.677208069874, 12932.70672932718, 9049.683261085831, 9120.179183873483, 9160.862587061067, 9216.95391523065, 9250.629974800933, 20779.584408311446, 20912.0, 21213.787862121182, 21319.57360852805, 21386.893065534572, 20777.58444831065, 21219.575608488052, 21247.68128478105, 21333.0, 21376.786232137478, 13627.0, 13778.586642400744, 13881.0, 13904.443822246996, 13909.443622254996, 13041.804372934603, 14273.714525709634, 14416.42334306616, 14441.422343106158, 14490.203038832544, 10257.179425645782, 11829.408529573315, 11835.230710003822, 12303.200291980993, 12464.563740269046, 11327.490262938023, 11330.943345283551, 11388.088952883583, 11548.0, 11615.361155136548, 10272.537735802056, 10396.844047339448, 10413.687589372332, 10414.791704166026, 10419.895801042196, 7948.682052717826, 8039.799005024921, 8045.316148127475, 8110.878336825071, 8121.918780812116, 7729.381649467917, 7883.44815862907, 7960.960195198987, 8121.472104313437, 8153.143919888326], "value": 7130.522888820877, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [511.7978398532582, 513.3967588084001, 532.3212903547976, 535.1571275241496, 535.1651423778903, 6166.630002199871, 6192.164057852195, 6202.131701561785, 6205.541697701036, 6230.688465576714, 6097.756089756404, 6107.38926107389, 6117.235345581802, 6154.415330543602, 6205.610839826665, 4875.122477953976, 4899.853004409855, 4907.705537667734, 4949.158643030693, 4981.9750901245625, 4699.859004229878, 4841.104395686792, 4852.757362131897, 4887.242477416006, 4943.431505376891, 4720.669553131283, 4743.241081426972, 4760.2383618621025, 4802.967362017165, 4825.348577941985, 4760.404949381327, 4772.355731976173, 4793.7842797074045, 4796.064767370364, 4796.592289655348, 4327.117703798826, 4339.218940590692, 4347.260965635818, 4349.608535231844, 4361.280388735855, 6015.909761353583, 6061.121137435047, 6078.331383547807, 6097.542684298695, 6131.570790044699, 5694.487496125327, 5727.742251598646, 5732.366275611473, 5740.0, 5742.196092547047, 6451.258105317902, 6549.410553050201, 6554.606723596552, 6620.337966203389, 6630.63531505767, 4840.685355451885, 4850.878728031792, 4914.533119353656, 4921.729304888229, 4929.876753081202, 6594.571352862096, 6695.719097642121, 6821.727130914708, 6932.306769323078, 6957.269486703874, 4978.477259887732, 5038.3198268234055, 5062.493750624982, 5068.82259120929, 5072.771725272298, 5140.254663073833, 5153.484651534816, 5181.689098654093, 5182.455842136596, 5191.091558977239, 5662.915056274159, 5693.800716974886, 5704.914426283609, 5752.3097228332035, 5779.393163717833, 6611.537192396582, 6634.502412319095, 6666.300038495985, 6666.83332916681, 6668.932970724661, 1779.80422153563, 1787.294018862542, 1791.4715159028117, 1800.7929088154767, 1805.1786437171056, 1206.4993027893502, 1235.5366737473448, 1239.8078297863844, 1262.4255963536568, 1266.1959655618564, 6254.843628909313, 6265.8746825063245, 6292.433680968735, 6299.149614802035, 6352.650604216812, 6692.59844409337, 6721.361470660279, 6759.741362941316, 6759.763408280686, 6771.424428923498, 6205.782797602063, 6259.71831267594, 6297.622142671455, 6299.338569450142, 6342.302346741854, 3558.8255875561003, 3568.964310356915, 3576.8569257229938, 3592.694620957248, 3617.9276414471565, 7138.821529461805, 7158.856822863618, 7160.964195178991, 7163.3552980232025, 7186.425085993213, 6520.717748787886, 6953.20038195614, 6977.476689248327, 7013.649317534103, 7016.2632923543315, 7076.681549330293, 7096.225943514121, 7103.715851365888, 7137.607431591312, 7153.105861767279, 6718.193816742022, 6747.359000894907, 6759.5606285591275, 6814.965925170342, 6861.1080559526945, 6690.899636505359, 6698.363655452724, 6759.357861003196, 6773.0, 6788.185417749704, 7009.894851577333, 7034.402075823407, 7073.540219885691, 7080.185778635523, 7126.85746285061, 5027.69833809958, 5128.102582048052, 5131.204663277198, 5137.255098010843, 5141.28022076902, 6637.53537252407, 6747.257801641717, 6790.049393084873, 6903.344182302673, 6950.409215216763, 6477.643729594917, 6507.772227971998, 6515.576487528296, 6611.570247933869, 6630.30381809903, 6488.0, 6541.2249058188745, 6559.704813283509, 6648.368405001517, 6672.132622759204, 6494.675266236574, 6533.150690410216, 6613.867722645617, 6636.767713130017, 6664.866702666017, 6643.468522518284, 6668.699908504032, 6711.228208756055, 6711.697973591297, 6731.46148308144, 6484.28672845996, 6486.254080780771, 6490.740370385131, 6531.126304426038, 6545.410913017851], "value": 5131.5097598563325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [936.2977766674994, 942.7562401484468, 965.3869792681645, 972.8005758819443, 985.0445068283765, 19474.805251947477, 19685.311014114508, 20620.072096755644, 20721.896390518046, 20735.481612959684, 22302.665460018114, 22645.320640380774, 22888.771112288872, 23061.0, 23138.30585082446, 1038.792241551689, 1056.6301794371984, 1057.038095333247, 1058.116472745255, 1058.9841152382683, 1043.3166276089173, 1081.9296745711542, 1088.1566785741036, 1099.0328510910388, 1099.1426687183969, 1130.7851508213414, 1137.3687603380122, 1138.2828817844788, 1139.2651739627936, 1144.273386399638, 1118.8657361116636, 1120.1039168665077, 1120.2046546951633, 1120.7982563138632, 1124.4658787076155, 828.9461185022955, 829.0341751859077, 829.1749709039544, 829.3738227638155, 830.759079866844, 19692.606147876962, 19765.209391624318, 19817.306394276133, 20544.0, 21458.570828583343, 22719.88640056789, 23123.7687623125, 23347.76652233473, 23529.764702352928, 23676.171334003226, 16193.757093643488, 17305.480835574952, 17349.219285132072, 17428.302867885268, 17534.473965781046, 3698.9260214795554, 3718.628137186287, 3719.3119272934596, 3719.888403347904, 3727.1241258304276, 142333.0, 142692.0, 142991.2850435741, 143358.0, 144343.0, 16817.15914204285, 17265.482035538953, 17470.737938930924, 17506.474805755846, 17526.64946701059, 33502.66497334996, 33970.830145849606, 34299.48550771741, 34332.0, 34456.48315275273, 9184.770380740401, 9365.0, 9367.765805854771, 9376.29677774156, 9377.39046961959, 4408.360787685768, 4463.665225108065, 4477.440319960005, 4482.731036137842, 4491.416115904977, 5702.800401985911, 5846.239988801513, 5871.178035075093, 5911.76352945886, 5918.822435326947, 1093.0708897437273, 1114.7157474843864, 1133.1331531378503, 1134.8241022641503, 1138.908887289015, 684.1414025398193, 701.2111374703459, 708.6704682322745, 712.9322714342129, 715.3097261142918, 11773.764524709457, 11838.526458941546, 12010.459529321202, 12237.694057648452, 12491.500339986298, 695.9373656370951, 746.268656716421, 754.1591125894588, 761.9238076192337, 772.3628006894335, 5721.427857214246, 5960.791372301948, 6034.125051867454, 6061.848453788691, 6213.254409470802, 131174.34412827875, 137053.0, 139273.0, 140838.0, 145916.0, 120763.0, 126427.36786316194, 127220.0, 127495.99999999815, 130925.34537327442, 101882.0, 103066.48466757618, 104915.95084049215, 105856.0, 108871.0, 12317.568885088978, 12877.380167435778, 12920.35398230066, 13112.213267203999, 13345.443475743841, 38496.65261715827, 48515.0, 48516.78708032327, 49101.75449122874, 49947.50052499574, 89468.0, 90113.0, 91135.54432227796, 91806.0, 93624.0, 18918.43244702661, 18957.241710331433, 19014.524636884187, 19175.808241917402, 19277.710834337777, 20225.898870506142, 20575.69136462984, 20753.066112025295, 20782.792172078087, 20855.582888341843, 18984.620307594047, 19123.713144303125, 19305.227790888206, 19439.0, 19859.900700496404, 17427.302907883543, 17463.38878139259, 17493.30026798914, 17681.911590441967, 18269.81730182681, 17669.38157164493, 17864.91067544706, 19128.521786955436, 19732.112054957848, 20260.493487662927, 14747.92626036863, 14807.481738139113, 14833.703325933637, 14926.850731492546, 15083.24583770829, 15486.148261845707, 15894.920525397762, 16032.919835400748, 16192.190390480193, 16206.0], "value": 9964.88446803603, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1471.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 110.0, 98.0, 106.0, 106.0, 107.0, 107.0, 101.0, 107.0, 111.0], "value": 105.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 112.0, 145.0, 176.0, 114.0, 146.0, 140.0, 112.0, 171.0, 113.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 161.0, 162.0, 164.0, 162.0, 163.0, 167.0, 167.0], "value": 163.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 176.0, 73.0, 74.0, 72.0, 76.0, 166.0, 76.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 133.0, 78.0, 78.0, 77.0, 131.0, 77.0, 78.0, 126.0], "value": 93.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 152.0, 148.0, 148.0, 148.0, 149.0, 148.0, 149.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 53.0, 50.0, 48.0, 48.0, 47.0, 50.0, 47.0, 48.0], "value": 48.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 74.0, 74.0, 73.0, 73.0, 71.0, 74.0, 75.0, 73.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 118.0, 114.0, 118.0, 113.0, 110.0, 113.0, 111.0, 158.0], "value": 118.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 164.0, 169.0, 175.0, 164.0, 173.0, 164.0, 163.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 60.0, 70.0, 62.0, 61.0, 60.0, 62.0, 60.0, 62.0], "value": 62.1, "unit": "score"}]}]} 18:38:00 INFO - Return code: 0 18:38:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:38:00 INFO - # TBPL SUCCESS # 18:38:00 INFO - Running post-action listener: _package_coverage_data 18:38:00 INFO - Running post-action listener: _resource_record_post_action 18:38:00 INFO - [mozharness: 2017-08-17 01:38:00.850957Z] Finished run-tests step (success) 18:38:00 INFO - Running post-run listener: _resource_record_post_run 18:38:00 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 440877056; Read time: 0; Write time: 289648 18:38:00 INFO - TinderboxPrint: CPU usage
13.0% 18:38:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:38:00 INFO - TinderboxPrint: I/O write bytes / time
440,877,056 / 289,648 18:38:00 INFO - TinderboxPrint: CPU idle
8,229.5 (86.9%) 18:38:00 INFO - TinderboxPrint: CPU user
1,187.5 (12.5%) 18:38:00 INFO - TinderboxPrint: Swap in / out
0 / 0 18:38:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119291904; Read time: 0; Write time: 93264 18:38:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:38:00 INFO - run-tests - Wall time: 1170s; CPU: 13.0%; Read bytes: 0; Write bytes: 321585152; Read time: 0; Write time: 196384 18:38:01 INFO - Running post-run listener: _upload_blobber_files 18:38:01 INFO - Blob upload gear active. 18:38:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:38:01 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:38:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:38:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:38:01 INFO - (blobuploader) - INFO - Open directory for files ... 18:38:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:38:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:38:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:02 INFO - (blobuploader) - INFO - Done attempting. 18:38:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:38:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:38:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:03 INFO - (blobuploader) - INFO - Done attempting. 18:38:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:38:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:38:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:10 INFO - (blobuploader) - INFO - Done attempting. 18:38:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:38:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:38:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:38:11 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:38:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:38:11 INFO - (blobuploader) - INFO - Done attempting. 18:38:11 INFO - (blobuploader) - INFO - Iteration through files over. 18:38:11 INFO - Return code: 0 18:38:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:38:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:38:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/455fca3878f8d859c94ccda67dc7a22e4e8450adbebd4c7034a5911a9d2950f1269b6aea8178f3ef4ea2116ee438de151963943d5f8e0953b76c8adc439cc707", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71f2e403e925cc6da8454a2802a2fda22736dd178898ca2befd1693ea1a38d1f377b9415b3c976356524b982495e033fc63e52840c5248e40aeb0cb9aaf3483f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70fac7d594b92451cc76bbf6b19338559d34f884280185116e79576aa350d3f3fd8a43c41a32008213e419564a1c10029276c4512de45764a46de6edeb20acbb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f96202c5dce5e8652c0bf50be314c4505213f22e90aee323971756dbd2284d183d028221b8f0863a138b28f29af0216514c5ae0d0b00e3c2e66bf86902e1f56"} 18:38:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:38:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:38:11 INFO - Contents: 18:38:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/455fca3878f8d859c94ccda67dc7a22e4e8450adbebd4c7034a5911a9d2950f1269b6aea8178f3ef4ea2116ee438de151963943d5f8e0953b76c8adc439cc707", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71f2e403e925cc6da8454a2802a2fda22736dd178898ca2befd1693ea1a38d1f377b9415b3c976356524b982495e033fc63e52840c5248e40aeb0cb9aaf3483f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70fac7d594b92451cc76bbf6b19338559d34f884280185116e79576aa350d3f3fd8a43c41a32008213e419564a1c10029276c4512de45764a46de6edeb20acbb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f96202c5dce5e8652c0bf50be314c4505213f22e90aee323971756dbd2284d183d028221b8f0863a138b28f29af0216514c5ae0d0b00e3c2e66bf86902e1f56"} 18:38:11 INFO - Running post-run listener: copy_logs_to_upload_dir 18:38:11 INFO - Copying logs to upload dir... 18:38:11 INFO - mkdir: /builds/slave/test/build/upload/logs 18:38:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.978518 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-16 18:38:11.559026) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 18:38:11.562879) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/455fca3878f8d859c94ccda67dc7a22e4e8450adbebd4c7034a5911a9d2950f1269b6aea8178f3ef4ea2116ee438de151963943d5f8e0953b76c8adc439cc707", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71f2e403e925cc6da8454a2802a2fda22736dd178898ca2befd1693ea1a38d1f377b9415b3c976356524b982495e033fc63e52840c5248e40aeb0cb9aaf3483f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70fac7d594b92451cc76bbf6b19338559d34f884280185116e79576aa350d3f3fd8a43c41a32008213e419564a1c10029276c4512de45764a46de6edeb20acbb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f96202c5dce5e8652c0bf50be314c4505213f22e90aee323971756dbd2284d183d028221b8f0863a138b28f29af0216514c5ae0d0b00e3c2e66bf86902e1f56"} build_url:https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011517 build_url: 'https://queue.taskcluster.net/v1/task/QxBtMBTTSBGv6jFTm8Uiww/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/455fca3878f8d859c94ccda67dc7a22e4e8450adbebd4c7034a5911a9d2950f1269b6aea8178f3ef4ea2116ee438de151963943d5f8e0953b76c8adc439cc707", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71f2e403e925cc6da8454a2802a2fda22736dd178898ca2befd1693ea1a38d1f377b9415b3c976356524b982495e033fc63e52840c5248e40aeb0cb9aaf3483f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70fac7d594b92451cc76bbf6b19338559d34f884280185116e79576aa350d3f3fd8a43c41a32008213e419564a1c10029276c4512de45764a46de6edeb20acbb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f96202c5dce5e8652c0bf50be314c4505213f22e90aee323971756dbd2284d183d028221b8f0863a138b28f29af0216514c5ae0d0b00e3c2e66bf86902e1f56"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 18:38:11.593029) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 18:38:11.593624) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1502932044.750749-1900830463 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 18:38:11.677197) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 18:38:11.677595) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 18:38:11.677943) ========= ========= Total master_lag: 0.19 =========