builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1502992966.47 results: success (0) revision: f53a37fc0e92c093bf48baada9f9adab16422cd7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:02:46.474139) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-17 11:02:46.474511) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:02:46.474787) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-17 11:02:46.500552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:02:46.500823) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-17 11:02:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 95.8M=0s 2017-08-17 11:02:46 (95.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125165 ========= master_lag: 0.35 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:02:46.971199) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:02:46.971477) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018952 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:02:47.048548) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-17 11:02:47.048919) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f53a37fc0e92c093bf48baada9f9adab16422cd7 --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 f53a37fc0e92c093bf48baada9f9adab16422cd7 --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=ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-17 11:02:47,475 truncating revision to first 12 chars 2017-08-17 11:02:47,475 Setting DEBUG logging. 2017-08-17 11:02:47,475 attempt 1/10 2017-08-17 11:02:47,475 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f53a37fc0e92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-17 11:02:48,835 unpacking tar archive at: mozilla-central-f53a37fc0e92/testing/mozharness/ program finished with exit code 0 elapsedTime=1.683734 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-17 11:02:48.763528) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:02:48.763837) ========= script_repo_revision: f53a37fc0e92c093bf48baada9f9adab16422cd7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-17 11:02:48.767241) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:02:48.767505) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-17 11:02:48.778991) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-17 11:02:48.779255) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:02:49 INFO - MultiFileLogger online at 20170817 11:02:49 in /builds/slave/test 11:02:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 11:02:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:02:49 INFO - {'append_to_log': False, 11:02:49 INFO - 'base_work_dir': '/builds/slave/test', 11:02:49 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 11:02:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:02:49 INFO - 'branch': 'Firefox-Non-PGO', 11:02:49 INFO - 'buildbot_json_path': 'buildprops.json', 11:02:49 INFO - 'code_coverage': False, 11:02:49 INFO - 'config_files': ('talos/linux_config.py',), 11:02:49 INFO - 'default_actions': ('clobber', 11:02:49 INFO - 'read-buildbot-config', 11:02:49 INFO - 'download-and-extract', 11:02:49 INFO - 'populate-webroot', 11:02:49 INFO - 'create-virtualenv', 11:02:49 INFO - 'install', 11:02:49 INFO - 'setup-mitmproxy', 11:02:49 INFO - 'run-tests'), 11:02:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:02:49 INFO - 'disable_ccov_upload': False, 11:02:49 INFO - 'download_minidump_stackwalk': True, 11:02:49 INFO - 'download_symbols': 'ondemand', 11:02:49 INFO - 'enable_stylo': False, 11:02:49 INFO - 'enable_webrender': False, 11:02:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:02:49 INFO - 'tooltool.py': '/tools/tooltool.py', 11:02:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:02:49 INFO - '/tools/misc-python/virtualenv.py')}, 11:02:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:02:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:02:49 INFO - 'gecko_profile': False, 11:02:49 INFO - 'gecko_profile_interval': 0, 11:02:49 INFO - 'installer_path': 'installer.exe', 11:02:49 INFO - 'log_level': 'info', 11:02:49 INFO - 'log_name': 'talos', 11:02:49 INFO - 'log_to_console': True, 11:02:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:02:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:02:49 INFO - 'opt_config_files': (), 11:02:49 INFO - 'pip_index': False, 11:02:49 INFO - 'suite': 'dromaeojs-e10s', 11:02:49 INFO - 'system_bits': '32', 11:02:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:02:49 INFO - 'title': 'talos-linux64-ix-029', 11:02:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:02:49 INFO - 'use_talos_json': True, 11:02:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:02:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:02:49 INFO - 'work_dir': 'build'} 11:02:49 INFO - [mozharness: 2017-08-17 18:02:49.291123Z] Running clobber step. 11:02:49 INFO - Running pre-action listener: _resource_record_pre_action 11:02:49 INFO - Running main action method: clobber 11:02:49 INFO - rmtree: /builds/slave/test/build 11:02:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:02:50 INFO - Running post-action listener: _resource_record_post_action 11:02:50 INFO - [mozharness: 2017-08-17 18:02:50.824611Z] Finished clobber step (success) 11:02:50 INFO - [mozharness: 2017-08-17 18:02:50.824712Z] Running read-buildbot-config step. 11:02:50 INFO - Running pre-action listener: _resource_record_pre_action 11:02:50 INFO - Running main action method: read_buildbot_config 11:02:50 INFO - Using buildbot properties: 11:02:50 INFO - { 11:02:50 INFO - "project": "", 11:02:50 INFO - "product": "firefox", 11:02:50 INFO - "who": "ffxbld@noreply.mozilla.org", 11:02:50 INFO - "installer_path": "public/build/target.tar.bz2", 11:02:50 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 11:02:50 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:02:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 11:02:50 INFO - "stage_platform": "linux64", 11:02:50 INFO - "basedir": "/builds/slave/test", 11:02:50 INFO - "buildnumber": 775, 11:02:50 INFO - "platform": "ubuntu64_hw", 11:02:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:02:50 INFO - "slavebuilddir": "test", 11:02:50 INFO - "taskId": "fRHKvjAySFCsRUyBoWRHPQ", 11:02:50 INFO - "branch": "mozilla-central", 11:02:50 INFO - "script_repo_revision": "production", 11:02:50 INFO - "revision": "f53a37fc0e92c093bf48baada9f9adab16422cd7", 11:02:50 INFO - "slavename": "talos-linux64-ix-029", 11:02:50 INFO - "repo_path": "mozilla-central" 11:02:50 INFO - } 11:02:50 INFO - Finding installer, test and symbols from parent task. 11:02:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fRHKvjAySFCsRUyBoWRHPQ'}, attempt #1 11:02:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fRHKvjAySFCsRUyBoWRHPQ'}, attempt #1 11:02:51 INFO - Task dependencies: cTdeNkkcRCqHXVCQPBeYMQ 11:02:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ'}, attempt #1 11:02:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2 11:02:52 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.test_packages.json 11:02:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.crashreporter-symbols.zip 11:02:52 INFO - Running post-action listener: _resource_record_post_action 11:02:52 INFO - [mozharness: 2017-08-17 18:02:52.266302Z] Finished read-buildbot-config step (success) 11:02:52 INFO - [mozharness: 2017-08-17 18:02:52.266528Z] Running download-and-extract step. 11:02:52 INFO - Running pre-action listener: _resource_record_pre_action 11:02:52 INFO - Running main action method: download_and_extract 11:02:52 INFO - mkdir: /builds/slave/test/build/tests 11:02:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:02:52 INFO - trying https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.test_packages.json 11:02:52 INFO - Downloading https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:02:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:02:52 INFO - Downloaded 989 bytes. 11:02:52 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:02:52 INFO - Using the following test package requirements: 11:02:52 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:02:52 INFO - u'common': [u'target.common.tests.zip'], 11:02:52 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:02:52 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:02:52 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:02:52 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:02:52 INFO - u'mozbase': [u'target.common.tests.zip'], 11:02:52 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:02:52 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:02:52 INFO - u'web-platform': [u'target.common.tests.zip', 11:02:52 INFO - u'target.web-platform.tests.tar.gz'], 11:02:52 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:02:52 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:02:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.common.tests.zip 11:02:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:02:52 INFO - Fetch https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.common.tests.zip into memory 11:02:53 INFO - Content-Length response header: 53999443 11:02:53 INFO - Bytes received: 53999443 11:03:04 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:03:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.common.tests.zip 11:03:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:03:04 INFO - Fetch https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.common.tests.zip into memory 11:03:05 INFO - Content-Length response header: 53999443 11:03:05 INFO - Bytes received: 53999443 11:03:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.talos.tests.zip 11:03:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:03:17 INFO - Fetch https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.talos.tests.zip into memory 11:03:18 INFO - Content-Length response header: 14496161 11:03:18 INFO - Bytes received: 14496161 11:03:18 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')]} 11:03:18 INFO - trying https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2 11:03:18 INFO - Downloading https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:03:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:03:19 INFO - Downloaded 62259900 bytes. 11:03:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2 11:03:19 INFO - mkdir: /builds/slave/test/properties 11:03:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:03:19 INFO - Writing to file /builds/slave/test/properties/build_url 11:03:19 INFO - Contents: 11:03:19 INFO - build_url:https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2 11:03:19 INFO - Running post-action listener: _resource_record_post_action 11:03:19 INFO - Running post-action listener: set_extra_try_arguments 11:03:19 INFO - [mozharness: 2017-08-17 18:03:19.888377Z] Finished download-and-extract step (success) 11:03:19 INFO - [mozharness: 2017-08-17 18:03:19.888475Z] Running populate-webroot step. 11:03:19 INFO - Running pre-action listener: _resource_record_pre_action 11:03:19 INFO - Running main action method: populate_webroot 11:03:19 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:03:19 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 11:03:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:03:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:03:19 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 11:03:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:03:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:03:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:19 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:03:19 INFO - 'talos_options': ['--stylo'], 11:03:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:03:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:03:19 INFO - 'tests': ['damp', 'tps']}, 11:03:19 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:03:19 INFO - 'talos_options': ['--stylo'], 11:03:19 INFO - 'tests': ['damp', 'tps']}, 11:03:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:03:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:03:19 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 11:03:19 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:03:19 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:03:19 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:03:19 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:03:19 INFO - 'talos_options': ['--stylo'], 11:03:19 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:03:19 INFO - 'other-e10s': {'tests': ['a11yr', 11:03:19 INFO - 'ts_paint', 11:03:19 INFO - 'tpaint', 11:03:19 INFO - 'sessionrestore', 11:03:19 INFO - 'sessionrestore_many_windows', 11:03:19 INFO - 'sessionrestore_no_auto_restore', 11:03:19 INFO - 'tabpaint']}, 11:03:19 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 11:03:19 INFO - 'tests': ['a11yr', 11:03:19 INFO - 'ts_paint', 11:03:19 INFO - 'tpaint', 11:03:19 INFO - 'sessionrestore', 11:03:19 INFO - 'sessionrestore_many_windows', 11:03:19 INFO - 'sessionrestore_no_auto_restore', 11:03:19 INFO - 'tabpaint']}, 11:03:19 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:03:19 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:03:19 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 11:03:19 INFO - 'tests': ['bloom_basic_singleton']}, 11:03:19 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 11:03:19 INFO - 'tests': ['bloom_basic']}, 11:03:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:03:19 INFO - 'tsvgr_opacity', 11:03:19 INFO - 'tart', 11:03:19 INFO - 'tscrollx', 11:03:19 INFO - 'tsvg_static']}, 11:03:19 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 11:03:19 INFO - 'tests': ['tsvgx', 11:03:19 INFO - 'tsvgr_opacity', 11:03:19 INFO - 'tart', 11:03:19 INFO - 'tscrollx', 11:03:19 INFO - 'tsvg_static']}, 11:03:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:03:19 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:03:19 INFO - 'talos_options': ['--stylo'], 11:03:19 INFO - 'tests': ['tp5o']}, 11:03:19 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:19 INFO - 'talos_options': ['--mitmproxy', 11:03:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:19 INFO - '--firstNonBlankPaint'], 11:03:19 INFO - 'tests': ['tp6_google', 11:03:19 INFO - 'tp6_youtube', 11:03:19 INFO - 'tp6_amazon', 11:03:19 INFO - 'tp6_facebook']}, 11:03:19 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:19 INFO - 'talos_options': ['--stylo', 11:03:19 INFO - '--mitmproxy', 11:03:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:19 INFO - '--firstNonBlankPaint'], 11:03:19 INFO - 'tests': ['tp6_google', 11:03:19 INFO - 'tp6_youtube', 11:03:19 INFO - 'tp6_amazon', 11:03:19 INFO - 'tp6_facebook']}, 11:03:19 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:03:19 INFO - 'talos_options': ['--stylo', 11:03:19 INFO - '--stylo-threads=1', 11:03:19 INFO - '--mitmproxy', 11:03:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:03:19 INFO - '--firstNonBlankPaint'], 11:03:19 INFO - 'tests': ['tp6_google', 11:03:19 INFO - 'tp6_youtube', 11:03:19 INFO - 'tp6_amazon', 11:03:19 INFO - 'tp6_facebook']}, 11:03:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:03:19 INFO - 'talos_options': ['--xperf_path', 11:03:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:19 INFO - 'tests': ['tp5n']}, 11:03:19 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 11:03:19 INFO - 'talos_options': ['--stylo', 11:03:19 INFO - '--xperf_path', 11:03:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:03:19 INFO - 'tests': ['tp5n']}}} 11:03:19 INFO - Running post-action listener: _resource_record_post_action 11:03:19 INFO - [mozharness: 2017-08-17 18:03:19.902774Z] Finished populate-webroot step (success) 11:03:19 INFO - [mozharness: 2017-08-17 18:03:19.902865Z] Running create-virtualenv step. 11:03:19 INFO - Running pre-action listener: _resource_record_pre_action 11:03:19 INFO - Running main action method: create_virtualenv 11:03:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:03:19 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 11:03:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:03:19 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:03:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:03:19 INFO - Using real prefix '/usr' 11:03:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:03:20 INFO - Installing distribute.............................................................................................................................................................................................done. 11:03:22 INFO - Installing pip.................done. 11:03:22 INFO - Return code: 0 11:03:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:03:22 INFO - Reading from file tmpfile_stdout 11:03:22 INFO - Output received: 11:03:22 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) 11:03:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1693a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690bb0>, '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 0x1691ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691f40>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', '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 11:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:03:22 INFO - Using env: {'DISPLAY': ':0', 11:03:22 INFO - 'HOME': '/home/cltbld', 11:03:22 INFO - 'LANG': 'en_US.UTF-8', 11:03:22 INFO - 'LANGUAGE': 'en_US:en', 11:03:22 INFO - 'LOGNAME': 'cltbld', 11:03:22 INFO - 'MAIL': '/var/mail/cltbld', 11:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:22 INFO - 'MOZ_NO_REMOTE': '1', 11:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:22 INFO - 'NO_EM_RESTART': '1', 11:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:22 INFO - 'PWD': '/builds/slave/test', 11:03:22 INFO - 'SHELL': '/bin/bash', 11:03:22 INFO - 'SHLVL': '1', 11:03:22 INFO - 'TERM': 'linux', 11:03:22 INFO - 'TMOUT': '86400', 11:03:22 INFO - 'USER': 'cltbld', 11:03:22 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', 11:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:22 INFO - '_': '/tools/buildbot/bin/python'} 11:03:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:22 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 11:03:22 INFO - Cleaning up... 11:03:22 INFO - Return code: 0 11:03:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1693a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690bb0>, '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 0x1691ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691f40>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', '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 11:03:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:03:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:03:22 INFO - Using env: {'DISPLAY': ':0', 11:03:22 INFO - 'HOME': '/home/cltbld', 11:03:22 INFO - 'LANG': 'en_US.UTF-8', 11:03:22 INFO - 'LANGUAGE': 'en_US:en', 11:03:22 INFO - 'LOGNAME': 'cltbld', 11:03:22 INFO - 'MAIL': '/var/mail/cltbld', 11:03:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:22 INFO - 'MOZ_NO_REMOTE': '1', 11:03:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:22 INFO - 'NO_EM_RESTART': '1', 11:03:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:22 INFO - 'PWD': '/builds/slave/test', 11:03:22 INFO - 'SHELL': '/bin/bash', 11:03:22 INFO - 'SHLVL': '1', 11:03:22 INFO - 'TERM': 'linux', 11:03:22 INFO - 'TMOUT': '86400', 11:03:22 INFO - 'USER': 'cltbld', 11:03:22 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', 11:03:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:22 INFO - '_': '/tools/buildbot/bin/python'} 11:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:23 INFO - Downloading/unpacking psutil>=3.1.1 11:03:23 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 11:03:23 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 11:03:23 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 11:03:23 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 11:03:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:03:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:24 INFO - Installing collected packages: psutil 11:03:24 INFO - Running setup.py install for psutil 11:03:24 INFO - building 'psutil._psutil_linux' extension 11:03:24 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 11:03:24 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 11:03:24 INFO - building 'psutil._psutil_posix' extension 11:03:24 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 11:03:24 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 11:03:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:03:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:03:24 INFO - Successfully installed psutil 11:03:24 INFO - Cleaning up... 11:03:24 INFO - Return code: 0 11:03:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:03: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')]} 11:03:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03: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')]} 11:03:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:24 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 0x13ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1693a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690bb0>, '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 0x1691ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691f40>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', '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 11:03:24 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 11:03:24 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 11:03:24 INFO - Using env: {'DISPLAY': ':0', 11:03:24 INFO - 'HOME': '/home/cltbld', 11:03:24 INFO - 'LANG': 'en_US.UTF-8', 11:03:24 INFO - 'LANGUAGE': 'en_US:en', 11:03:24 INFO - 'LOGNAME': 'cltbld', 11:03:24 INFO - 'MAIL': '/var/mail/cltbld', 11:03:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:24 INFO - 'MOZ_NO_REMOTE': '1', 11:03:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:24 INFO - 'NO_EM_RESTART': '1', 11:03:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:24 INFO - 'PWD': '/builds/slave/test', 11:03:24 INFO - 'SHELL': '/bin/bash', 11:03:24 INFO - 'SHLVL': '1', 11:03:24 INFO - 'TERM': 'linux', 11:03:24 INFO - 'TMOUT': '86400', 11:03:24 INFO - 'USER': 'cltbld', 11:03:24 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', 11:03:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:24 INFO - '_': '/tools/buildbot/bin/python'} 11:03:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:03:26 INFO - Installing collected packages: mozsystemmonitor 11:03:26 INFO - Running setup.py install for mozsystemmonitor 11:03:26 INFO - Successfully installed mozsystemmonitor 11:03:26 INFO - Cleaning up... 11:03:26 INFO - Return code: 0 11:03:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:26 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 0x13ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1693a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690bb0>, '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 0x1691ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691f40>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', '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 11:03:26 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 11:03:26 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 11:03:26 INFO - Using env: {'DISPLAY': ':0', 11:03:26 INFO - 'HOME': '/home/cltbld', 11:03:26 INFO - 'LANG': 'en_US.UTF-8', 11:03:26 INFO - 'LANGUAGE': 'en_US:en', 11:03:26 INFO - 'LOGNAME': 'cltbld', 11:03:26 INFO - 'MAIL': '/var/mail/cltbld', 11:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:26 INFO - 'MOZ_NO_REMOTE': '1', 11:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:26 INFO - 'NO_EM_RESTART': '1', 11:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:26 INFO - 'PWD': '/builds/slave/test', 11:03:26 INFO - 'SHELL': '/bin/bash', 11:03:26 INFO - 'SHLVL': '1', 11:03:26 INFO - 'TERM': 'linux', 11:03:26 INFO - 'TMOUT': '86400', 11:03:26 INFO - 'USER': 'cltbld', 11:03:26 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', 11:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:26 INFO - '_': '/tools/buildbot/bin/python'} 11:03:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:26 INFO - Downloading/unpacking jsonschema==2.5.1 11:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:03:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:27 INFO - Downloading functools32-3.2.3-2.tar.gz 11:03:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:03:27 INFO - warning: no files found matching '*.txt' 11:03:27 INFO - no previously-included directories found matching 'build' 11:03:27 INFO - no previously-included directories found matching 'dist' 11:03:27 INFO - no previously-included directories found matching '.git*' 11:03:27 INFO - Installing collected packages: jsonschema, functools32 11:03:27 INFO - Running setup.py install for functools32 11:03:27 INFO - warning: no files found matching '*.txt' 11:03:27 INFO - no previously-included directories found matching 'build' 11:03:27 INFO - no previously-included directories found matching 'dist' 11:03:27 INFO - no previously-included directories found matching '.git*' 11:03:28 INFO - Successfully installed jsonschema functools32 11:03:28 INFO - Cleaning up... 11:03:28 INFO - Return code: 0 11:03:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1693a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690bb0>, '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 0x1691ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691f40>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', '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 11:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:03:28 INFO - Using env: {'DISPLAY': ':0', 11:03:28 INFO - 'HOME': '/home/cltbld', 11:03:28 INFO - 'LANG': 'en_US.UTF-8', 11:03:28 INFO - 'LANGUAGE': 'en_US:en', 11:03:28 INFO - 'LOGNAME': 'cltbld', 11:03:28 INFO - 'MAIL': '/var/mail/cltbld', 11:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:28 INFO - 'MOZ_NO_REMOTE': '1', 11:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:28 INFO - 'NO_EM_RESTART': '1', 11:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:28 INFO - 'PWD': '/builds/slave/test', 11:03:28 INFO - 'SHELL': '/bin/bash', 11:03:28 INFO - 'SHLVL': '1', 11:03:28 INFO - 'TERM': 'linux', 11:03:28 INFO - 'TMOUT': '86400', 11:03:28 INFO - 'USER': 'cltbld', 11:03:28 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', 11:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:28 INFO - '_': '/tools/buildbot/bin/python'} 11:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:03:28 INFO - Cleaning up... 11:03:28 INFO - Return code: 0 11:03:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1693a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690bb0>, '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 0x1691ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691f40>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', '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 11:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:03:28 INFO - Using env: {'DISPLAY': ':0', 11:03:28 INFO - 'HOME': '/home/cltbld', 11:03:28 INFO - 'LANG': 'en_US.UTF-8', 11:03:28 INFO - 'LANGUAGE': 'en_US:en', 11:03:28 INFO - 'LOGNAME': 'cltbld', 11:03:28 INFO - 'MAIL': '/var/mail/cltbld', 11:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:28 INFO - 'MOZ_NO_REMOTE': '1', 11:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:28 INFO - 'NO_EM_RESTART': '1', 11:03:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:28 INFO - 'PWD': '/builds/slave/test', 11:03:28 INFO - 'SHELL': '/bin/bash', 11:03:28 INFO - 'SHLVL': '1', 11:03:28 INFO - 'TERM': 'linux', 11:03:28 INFO - 'TMOUT': '86400', 11:03:28 INFO - 'USER': 'cltbld', 11:03:28 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', 11:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:28 INFO - '_': '/tools/buildbot/bin/python'} 11:03:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:28 INFO - Downloading/unpacking blobuploader==1.2.4 11:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:29 INFO - Downloading blobuploader-1.2.4.tar.gz 11:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:03:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:03:29 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 11:03:29 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 11:03:29 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 11:03:29 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 11:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:03:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:03:29 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 11:03:29 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 11:03:29 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 11:03:29 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 11:03:30 INFO - Downloading docopt-0.6.1.tar.gz 11:03:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:03:30 INFO - Installing collected packages: blobuploader, requests, docopt 11:03:30 INFO - Running setup.py install for blobuploader 11:03:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:03:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:03:30 INFO - Running setup.py install for requests 11:03:30 INFO - Running setup.py install for docopt 11:03:30 INFO - Successfully installed blobuploader requests docopt 11:03:30 INFO - Cleaning up... 11:03:30 INFO - Return code: 0 11:03:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:30 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 0x13ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1693a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690bb0>, '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 0x1691ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691f40>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', '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 11:03:30 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 11:03:30 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 11:03:30 INFO - Using env: {'DISPLAY': ':0', 11:03:30 INFO - 'HOME': '/home/cltbld', 11:03:30 INFO - 'LANG': 'en_US.UTF-8', 11:03:30 INFO - 'LANGUAGE': 'en_US:en', 11:03:30 INFO - 'LOGNAME': 'cltbld', 11:03:30 INFO - 'MAIL': '/var/mail/cltbld', 11:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:30 INFO - 'MOZ_NO_REMOTE': '1', 11:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:30 INFO - 'NO_EM_RESTART': '1', 11:03:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:30 INFO - 'PWD': '/builds/slave/test', 11:03:30 INFO - 'SHELL': '/bin/bash', 11:03:30 INFO - 'SHLVL': '1', 11:03:30 INFO - 'TERM': 'linux', 11:03:30 INFO - 'TMOUT': '86400', 11:03:30 INFO - 'USER': 'cltbld', 11:03:30 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', 11:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:30 INFO - '_': '/tools/buildbot/bin/python'} 11:03:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:31 INFO - Running setup.py (path:/tmp/pip-nrtWDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:31 INFO - Running setup.py (path:/tmp/pip-AKGWsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:31 INFO - Running setup.py (path:/tmp/pip-TnyOIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:31 INFO - Running setup.py (path:/tmp/pip-48vqZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:31 INFO - Running setup.py (path:/tmp/pip-2AJ8oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:31 INFO - Running setup.py (path:/tmp/pip-0AEB6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:31 INFO - Running setup.py (path:/tmp/pip-6x8aO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:31 INFO - Running setup.py (path:/tmp/pip-7oeg2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:31 INFO - Running setup.py (path:/tmp/pip-ogNK8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:31 INFO - Running setup.py (path:/tmp/pip-iubkpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:31 INFO - Running setup.py (path:/tmp/pip-KKOYV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:31 INFO - Running setup.py (path:/tmp/pip-XJGeJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:31 INFO - Running setup.py (path:/tmp/pip-ejzao2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:31 INFO - Running setup.py (path:/tmp/pip-wNIxAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:32 INFO - Running setup.py (path:/tmp/pip-iQr3IE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:32 INFO - Running setup.py (path:/tmp/pip-knacT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:32 INFO - Running setup.py (path:/tmp/pip-XJs0tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:03:32 INFO - Running setup.py install for manifestparser 11:03:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:03:32 INFO - Running setup.py install for mozcrash 11:03:32 INFO - Running setup.py install for mozdebug 11:03:32 INFO - Running setup.py install for mozdevice 11:03:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:03:32 INFO - Running setup.py install for mozfile 11:03:32 INFO - Running setup.py install for mozhttpd 11:03:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:03:32 INFO - Running setup.py install for mozinfo 11:03:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:03:32 INFO - Running setup.py install for mozInstall 11:03:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:03:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:03:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:03:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:03:32 INFO - Running setup.py install for mozleak 11:03:33 INFO - Running setup.py install for mozlog 11:03:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:03:33 INFO - Running setup.py install for moznetwork 11:03:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:03:33 INFO - Running setup.py install for mozprocess 11:03:33 INFO - Running setup.py install for mozprofile 11:03:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:03:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:03:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:03:33 INFO - Running setup.py install for mozrunner 11:03:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:03:33 INFO - Running setup.py install for mozscreenshot 11:03:33 INFO - Running setup.py install for moztest 11:03:33 INFO - Running setup.py install for mozversion 11:03:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:03:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:03:33 INFO - Cleaning up... 11:03:33 INFO - Return code: 0 11:03:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:33 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 0x13ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1693a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690bb0>, '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 0x1691ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691f40>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', '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 11:03:33 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 11:03:33 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 11:03:33 INFO - Using env: {'DISPLAY': ':0', 11:03:33 INFO - 'HOME': '/home/cltbld', 11:03:34 INFO - 'LANG': 'en_US.UTF-8', 11:03:34 INFO - 'LANGUAGE': 'en_US:en', 11:03:34 INFO - 'LOGNAME': 'cltbld', 11:03:34 INFO - 'MAIL': '/var/mail/cltbld', 11:03:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:34 INFO - 'MOZ_NO_REMOTE': '1', 11:03:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:34 INFO - 'NO_EM_RESTART': '1', 11:03:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:34 INFO - 'PWD': '/builds/slave/test', 11:03:34 INFO - 'SHELL': '/bin/bash', 11:03:34 INFO - 'SHLVL': '1', 11:03:34 INFO - 'TERM': 'linux', 11:03:34 INFO - 'TMOUT': '86400', 11:03:34 INFO - 'USER': 'cltbld', 11:03:34 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', 11:03:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:34 INFO - '_': '/tools/buildbot/bin/python'} 11:03:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:03:34 INFO - Running setup.py (path:/tmp/pip-pmlM1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:03:34 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)) 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:03:34 INFO - Running setup.py (path:/tmp/pip-nROm1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:03:34 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)) 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:03:34 INFO - Running setup.py (path:/tmp/pip-fYeau0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:03:34 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)) 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:03:34 INFO - Running setup.py (path:/tmp/pip-SvilHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:03:34 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)) 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:03:34 INFO - Running setup.py (path:/tmp/pip-nc5OYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:03:34 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)) 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:03:34 INFO - Running setup.py (path:/tmp/pip-IfNCbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:03:34 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)) 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:03:34 INFO - Running setup.py (path:/tmp/pip-jrIlYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:03:34 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)) 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:03:34 INFO - Running setup.py (path:/tmp/pip-TuSS9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:03:34 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)) 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:03:34 INFO - Running setup.py (path:/tmp/pip-93pcix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:03:34 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)) 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:03:34 INFO - Running setup.py (path:/tmp/pip-yHPUIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:03:34 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)) 11:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:03:34 INFO - Running setup.py (path:/tmp/pip-6XTUhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:03:35 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)) 11:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:03:35 INFO - Running setup.py (path:/tmp/pip-Ku_zVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:03:35 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)) 11:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:03:35 INFO - Running setup.py (path:/tmp/pip-RuqweB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:03:35 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)) 11:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:03:35 INFO - Running setup.py (path:/tmp/pip-WYIQPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:03:35 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)) 11:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:35 INFO - Running setup.py (path:/tmp/pip-kfMpSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:03:35 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)) 11:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:03:35 INFO - Running setup.py (path:/tmp/pip-knVLPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:03:35 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)) 11:03:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:03:35 INFO - Running setup.py (path:/tmp/pip-rWhA7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:03:35 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)) 11:03:35 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)) 11:03:35 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)) 11:03:35 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)) 11:03:35 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)) 11:03:35 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)) 11:03:35 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)) 11:03:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:03:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:03:36 INFO - Downloading blessings-1.6.tar.gz 11:03:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:03:36 INFO - Installing collected packages: blessings 11:03:36 INFO - Running setup.py install for blessings 11:03:36 INFO - Successfully installed blessings 11:03:36 INFO - Cleaning up... 11:03:36 INFO - Return code: 0 11:03:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:03:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:36 INFO - Reading from file tmpfile_stdout 11:03:36 INFO - Current package versions: 11:03:36 INFO - argparse == 1.2.1 11:03:36 INFO - blessings == 1.6 11:03:36 INFO - blobuploader == 1.2.4 11:03:36 INFO - docopt == 0.6.1 11:03:36 INFO - functools32 == 3.2.3-2 11:03:36 INFO - jsonschema == 2.5.1 11:03:36 INFO - manifestparser == 1.1 11:03:36 INFO - mozInstall == 1.13 11:03:36 INFO - mozcrash == 1.0 11:03:36 INFO - mozdebug == 0.1 11:03:36 INFO - mozdevice == 0.51 11:03:36 INFO - mozfile == 1.2 11:03:36 INFO - mozhttpd == 0.7 11:03:36 INFO - mozinfo == 0.10 11:03:36 INFO - mozleak == 0.1 11:03:36 INFO - mozlog == 3.5 11:03:36 INFO - moznetwork == 0.27 11:03:36 INFO - mozprocess == 0.25 11:03:36 INFO - mozprofile == 0.28 11:03:36 INFO - mozrunner == 6.13 11:03:36 INFO - mozscreenshot == 0.1 11:03:36 INFO - mozsystemmonitor == 0.3 11:03:36 INFO - moztest == 0.8 11:03:36 INFO - mozversion == 1.4 11:03:36 INFO - psutil == 3.1.1 11:03:36 INFO - requests == 1.2.3 11:03:36 INFO - wsgiref == 0.1.2 11:03:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:36 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 0x13ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1693a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690bb0>, '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 0x1691ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691f40>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', '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 11:03:37 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 11:03:37 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 11:03:37 INFO - Using env: {'DISPLAY': ':0', 11:03:37 INFO - 'HOME': '/home/cltbld', 11:03:37 INFO - 'LANG': 'en_US.UTF-8', 11:03:37 INFO - 'LANGUAGE': 'en_US:en', 11:03:37 INFO - 'LOGNAME': 'cltbld', 11:03:37 INFO - 'MAIL': '/var/mail/cltbld', 11:03:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:37 INFO - 'MOZ_NO_REMOTE': '1', 11:03:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:37 INFO - 'NO_EM_RESTART': '1', 11:03:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:37 INFO - 'PWD': '/builds/slave/test', 11:03:37 INFO - 'SHELL': '/bin/bash', 11:03:37 INFO - 'SHLVL': '1', 11:03:37 INFO - 'TERM': 'linux', 11:03:37 INFO - 'TMOUT': '86400', 11:03:37 INFO - 'USER': 'cltbld', 11:03:37 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', 11:03:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:37 INFO - '_': '/tools/buildbot/bin/python'} 11:03:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:37 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)) 11:03:37 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)) 11:03:37 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)) 11:03:37 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)) 11:03:37 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)) 11:03:37 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)) 11:03:37 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)) 11:03:37 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)) 11:03:37 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)) 11:03:37 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:03:37 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 11:03:37 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 11:03:37 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 11:03:37 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 11:03:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:03:38 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)) 11:03:38 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)) 11:03:38 INFO - Installing collected packages: simplejson 11:03:38 INFO - Running setup.py install for simplejson 11:03:38 INFO - building 'simplejson._speedups' extension 11:03:38 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 11:03:39 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 11:03:39 INFO - Successfully installed simplejson 11:03:39 INFO - Cleaning up... 11:03:39 INFO - Return code: 0 11:03:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:03:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:03:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:03:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13ea1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1693a10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1690bb0>, '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 0x1691ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691f40>, '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': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', '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 11:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:03:39 INFO - Using env: {'DISPLAY': ':0', 11:03:39 INFO - 'HOME': '/home/cltbld', 11:03:39 INFO - 'LANG': 'en_US.UTF-8', 11:03:39 INFO - 'LANGUAGE': 'en_US:en', 11:03:39 INFO - 'LOGNAME': 'cltbld', 11:03:39 INFO - 'MAIL': '/var/mail/cltbld', 11:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:39 INFO - 'MOZ_NO_REMOTE': '1', 11:03:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:39 INFO - 'NO_EM_RESTART': '1', 11:03:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:39 INFO - 'PWD': '/builds/slave/test', 11:03:39 INFO - 'SHELL': '/bin/bash', 11:03:39 INFO - 'SHLVL': '1', 11:03:39 INFO - 'TERM': 'linux', 11:03:39 INFO - 'TMOUT': '86400', 11:03:39 INFO - 'USER': 'cltbld', 11:03:39 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', 11:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:39 INFO - '_': '/tools/buildbot/bin/python'} 11:03:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:03:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:03:39 INFO - Cleaning up... 11:03:39 INFO - Return code: 0 11:03:39 INFO - Running post-action listener: _resource_record_post_action 11:03:39 INFO - Running post-action listener: _start_resource_monitoring 11:03:39 INFO - Starting resource monitoring. 11:03:39 INFO - [mozharness: 2017-08-17 18:03:39.688760Z] Finished create-virtualenv step (success) 11:03:39 INFO - [mozharness: 2017-08-17 18:03:39.689227Z] Running install step. 11:03:39 INFO - Running pre-action listener: _resource_record_pre_action 11:03:39 INFO - Running main action method: install 11:03:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:03:39 INFO - Reading from file tmpfile_stdout 11:03:39 INFO - Detecting whether we're running mozinstall >=1.0... 11:03:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:03:40 INFO - Reading from file tmpfile_stdout 11:03:40 INFO - Output received: 11:03:40 INFO - Usage: mozinstall [options] installer 11:03:40 INFO - Options: 11:03:40 INFO - -h, --help show this help message and exit 11:03:40 INFO - -d DEST, --destination=DEST 11:03:40 INFO - Directory to install application into. [default: 11:03:40 INFO - "/builds/slave/test"] 11:03:40 INFO - --app=APP Application being installed. [default: firefox] 11:03:40 INFO - mkdir: /builds/slave/test/build/application 11:03:40 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'] 11:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:03:58 INFO - Reading from file tmpfile_stdout 11:03:58 INFO - Output received: 11:03:58 INFO - /builds/slave/test/build/application/firefox/firefox 11:03:58 INFO - Running post-action listener: _resource_record_post_action 11:03:58 INFO - [mozharness: 2017-08-17 18:03:58.039860Z] Finished install step (success) 11:03:58 INFO - [mozharness: 2017-08-17 18:03:58.040143Z] Running setup-mitmproxy step. 11:03:58 INFO - Running pre-action listener: _resource_record_pre_action 11:03:58 INFO - Running main action method: setup_mitmproxy 11:03:58 INFO - Skipping: mitmproxy is not required 11:03:58 INFO - Running post-action listener: _resource_record_post_action 11:03:58 INFO - [mozharness: 2017-08-17 18:03:58.041358Z] Finished setup-mitmproxy step (success) 11:03:58 INFO - [mozharness: 2017-08-17 18:03:58.041591Z] Running run-tests step. 11:03:58 INFO - Running pre-action listener: _resource_record_pre_action 11:03:58 INFO - Running pre-action listener: _set_gcov_prefix 11:03:58 INFO - Running main action method: run_tests 11:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:03:58 INFO - Python 2.7.3 11:03:58 INFO - Return code: 0 11:03:58 INFO - grabbing minidump binary from tooltool 11:03: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')]} 11:03:58 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 0x1690bb0>, '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 0x1691ab0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1691f40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:03:58 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 11:03:58 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 11:03:58 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 11:03:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:03:58 INFO - Return code: 0 11:03:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:03:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:03:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:03:58 INFO - ENV: RUST_BACKTRACE is now full 11:03:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:03:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:03:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 11:03:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 11:03:58 INFO - Using env: {'DISPLAY': ':0', 11:03:58 INFO - 'HOME': '/home/cltbld', 11:03:58 INFO - 'LANG': 'en_US.UTF-8', 11:03:58 INFO - 'LANGUAGE': 'en_US:en', 11:03:58 INFO - 'LOGNAME': 'cltbld', 11:03:58 INFO - 'MAIL': '/var/mail/cltbld', 11:03:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:03:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:03:58 INFO - 'MOZ_NO_REMOTE': '1', 11:03:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:03:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:03:58 INFO - 'NO_EM_RESTART': '1', 11:03:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:03:58 INFO - 'PWD': '/builds/slave/test', 11:03:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:03:58 INFO - 'RUST_BACKTRACE': 'full', 11:03:58 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:03:58 INFO - 'SHELL': '/bin/bash', 11:03:58 INFO - 'SHLVL': '1', 11:03:58 INFO - 'TERM': 'linux', 11:03:58 INFO - 'TMOUT': '86400', 11:03:58 INFO - 'USER': 'cltbld', 11:03:58 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247', 11:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:03:58 INFO - '_': '/tools/buildbot/bin/python'} 11:03:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 11:03:58 INFO - mozversion application_buildid: 20170817171339 11:03:58 INFO - mozversion application_changeset: f53a37fc0e92c093bf48baada9f9adab16422cd7 11:03:58 INFO - mozversion application_display_name: Nightly 11:03:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:03:58 INFO - mozversion application_name: Firefox 11:03:58 INFO - mozversion application_remotingname: firefox 11:03:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:03:58 INFO - mozversion application_vendor: Mozilla 11:03:58 INFO - mozversion application_version: 57.0a1 11:03:58 INFO - mozversion platform_buildid: 20170817171339 11:03:58 INFO - mozversion platform_changeset: f53a37fc0e92c093bf48baada9f9adab16422cd7 11:03:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:03:58 INFO - mozversion platform_version: 57.0a1 11:03:58 INFO - using testdate: 1502993038 11:03:58 INFO - actual date: 1502993038 11:03:58 INFO - starting webserver on 'localhost:42631' 11:03:58 INFO - SUITE-START | Running 2 tests 11:03:58 INFO - TEST-START | dromaeo_css 11:03:58 INFO - Initialising browser for dromaeo_css test... 11:03:58 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42631/getInfo.html -profile /tmp/tmpJo6Qr_/profile 11:03:58 INFO - TEST-INFO | started process 19063 (/builds/slave/test/build/application/firefox/firefox http://localhost:42631/getInfo.html) 11:04:05 INFO - TEST-INFO | 19063: exit 0 11:04:05 INFO - Browser initialized. 11:04:05 INFO - Running cycle 1/1 for dromaeo_css test... 11:04:05 INFO - TEST-INFO | started process 19240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJo6Qr_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:04:06 INFO - PID 19240 | 11:04:06 INFO - PID 19240 | (/builds/slave/test/build/application/firefox/firefox:19288): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:04:06 INFO - PID 19240 | 11:04:16 INFO - PID 19240 | RSS: Main: 164069376 11:04:16 INFO - PID 19240 | 11:07:15 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:42631/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42631/tests/dromaeo/cssquery-ext.html) 11:07:17 INFO - PID 19240 | RSS: Main: 171675648 11:07:17 INFO - PID 19240 | 11:10:19 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:42631/tests/dromaeo/cssquery-ext.html (next: http://localhost:42631/tests/dromaeo/cssquery-jquery.html) 11:10:19 INFO - PID 19240 | RSS: Main: 168587264 11:10:19 INFO - PID 19240 | 11:13:21 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:42631/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42631/tests/dromaeo/cssquery-mootools.html) 11:13:21 INFO - PID 19240 | RSS: Main: 170835968 11:13:21 INFO - PID 19240 | 11:16:23 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:42631/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42631/tests/dromaeo/cssquery-prototype.html) 11:16:24 INFO - PID 19240 | RSS: Main: 170422272 11:16:24 INFO - PID 19240 | 11:19:27 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:42631/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42631/tests/dromaeo/cssquery-yui.html) 11:19:28 INFO - PID 19240 | RSS: Main: 173699072 11:19:28 INFO - PID 19240 | 11:22:30 INFO - PID 19240 | Cycle 1(1): loaded http://localhost:42631/tests/dromaeo/cssquery-yui.html (next: http://localhost:42631/tests/dromaeo/cssquery-dojo.html) 11:22:30 INFO - PID 19240 | RSS: Main: 173670400 11:22:30 INFO - PID 19240 | 11:22:30 INFO - PID 19240 | __start_tp_report 11:22:30 INFO - PID 19240 | _x_x_mozilla_page_load 11:22:30 INFO - PID 19240 | _x_x_mozilla_page_load_details 11:22:30 INFO - PID 19240 | |i|pagename|runs| 11:22:30 INFO - PID 19240 | |0;dojo.html;3152.810831350118;3188.8405579721007;3211.197200699825;3215.5980502437196;3222.033389983006;6034.155218269446;6128.846778830532;6142.508599312056;6153.261608606962;6277.843053923654;6199.349068347826;6239.750409983595;6289;6298.338674439186;6323.20959880015;5659.094544872821;5700.857478563028;5743.195952566644;5776.624519406225;5799.82600521985;5511.834644960658;5606.187102870082;5640.323161220639;5650.152477128422;5746.367899531048;5696.946064977992;5700.458456446651;5702.173184888209;5706.800261990831;5707.258056452655;5626.381098079208;5643.576731745095;5715.171300161495;5722.513586345166;5726.77092916287;5531;5536.695481748502;5605.131204663284;5610.102383618642;5682.119271512922;6045.818625441244;6086.421789929949;6086.847828804315;6099.512039036911;6111.724972376253;6579.605223686594;6663.86672266552;6666.733330666768;6667.499937504706;6674.132362792854;6575.3095924927675;6669.666516674147;6738.797836064926;6752.966235168842;6766.458683305324;6106.2977757558;6189.04069869171;6210.565260431817;6226.346233645448;6297.2128483939505;6896.793096207121;6954.061201737802;6962.408195303456;6974.930250697529;6975.82560435983;6562.934370656232;6579.638119903451;6588.341165883469;6643.933560664428;6676.49926255523;6379.585326953733;6637.568558043712;6672.366125218096;6765.932340676629;6789.456843452512;6586.27550969393;6606.306337834554;6691.330866913367;6692.096566963398;6705.731770729116;6731.225909020427;6732.225794033749;6737.494687898427;6751.324867513307;6753.1220941277315;5407.432219616883;5439.592030597721;5501.174823776466;5502.257195278587;5506.091494903296;4632.513586073481;4671.602913752301;4683.297505374153;4694.037722266927;4706.435227772621;5591.440855914376;5664.830055098354;5675.006873797069;5758.136279558016;5841.795537156264;6638.336166383419;6674.098996635489;6679.532432729759;6684.064231007663;6723.193216813916;5788.45009724084;5825.70871456434;5845.561582881216;5853.590248682552;5866.354700982888;5878.000739874232;5948.583599148018;5953.226080609493;5960.225170727865;5960.731767070492;6549.934500654933;6550.288116804639;6626.271110177877;6640.601563906181;6658.3674550917585;6583.275839657729;6657.167854018247;6661.533692641468;6664.5334826561675;6664.8000559983275;6447.516436267392;6475.352464753487;6481.578697384655;6487.805365839033;6495.220573531017;6583.407493325623;6638.800835974928;6643.169603799525;6669.166354205724;6671.499637527108;6219.253689557282;6691.5650482718465;6711.697973591103;6730.0241464988285;6803.081583986099;6465.903011454926;6467.579607325509;6472;6486.318936511787;6488.610683359014;6466.418022378009;6472.385123413268;6474.708638111202;6477.708503117466;6482.2869484357625;6400.967995160181;6480.25477070143;6518.282988871126;6552.508561857975;6557.9344206557325;6459.418652321314;6573.317775184738;6582.506312026521;6589.17635295588;6676.632785196666;6231.53263505248;6335.3981371769605;6348.492120630431;6350.110984462087;6360.141380913517 11:22:30 INFO - PID 19240 | |1;ext.html;786.1666633368629;855.5636625321087;881.1364862434814;882.5587206396801;1150.9251898626583;30146.849265753695;38993.80503097484;40020.79989600048;40102.79948600253;40107.59892401075;41264;41827.16345673092;41882;41930.79034604823;41935;7442.367398771111;7464.402847772165;7603.543787372748;7638.236176382345;7664.38684905209;7451.068616422947;7529;7529.171791102975;7529.849403011936;7529.887051694229;7549;7600.277973592528;7601.163871974079;7634.351080158193;7640;7516.5114267572435;7530.6987720491115;7563.848723025564;7563.962180189092;7564.810879727996;7469.925300746977;7529.134149572759;7546.245375462465;7567.31894129531;7568.659410326549;37575.624243757484;37788.62211377879;37795.244095117945;37821.62178378209;37826.62173378259;3571.14292569784;3596.6403359663823;3603.783772973604;3610.981945090258;3611.458281257806;31516.36967260642;31567;31582.210444739067;31591.052268431755;31633.20916977071;4944.9258261126115;4950.183219768734;4957.405111386621;5003.524665156804;5011.348524691767;180310;181827;182542.08728956402;182628;182936;46879.76560117246;46962.76518617385;46981;47255.29117063247;47520.7623961878;49244;49319.260211096866;49382.75308623434;49387.75306123446;49390.75304623454;14346.928265358607;15861.444849430214;16311.592210194603;16335.101569413797;16335.91832040856;12117.515299388102;13559.59321220365;13753.79369309461;13765.38055787492;13823.723525529635;14206.573802785933;14292.28538573088;14306.356213970397;14353.6411589709;14471.565853024425;5782.739776710058;5829;5855.209546711225;5887.499562537147;5897.410258974069;992.6972273456665;1008.7478130467383;1008.8638033865334;1021.6883850425543;1030.253066526777;22801.429964250696;23015.309540713806;23200.3039908803;23269.76730232676;23431.179908703114;1108.1688733449912;1111.6942840718866;1113.3653817324048;1115.5482029777952;1127.537709539085;11782.587609433629;12174.086943479275;12175.512979480898;12255.429368400044;12293.754124917452;212567;215286;224006;224736;224943;51469.97060058778;51668.48331516712;51848.48151518512;51998.740006299726;52169;1462.4369617697264;1476.5496523560203;1499.2878382768097;1504.2704288420107;1507.1635242440332;22747;22914.54170916539;22925.770742293033;23019.654705179102;23257.651135232645;37178.8141059293;37347.62652373441;37361.25277494489;37388.25223495569;37415.81292093522;189225;189549;190141;190263;190704;33631.327373452885;34774.47838282478;35737.28525429529;35781.92654220378;35810.28379432449;44636.55363446454;45720;45941.08117837692;45998.310025350314;45999.77000114978;33746.493802593475;34094.48858267078;34096.48855267223;34347.4847877287;34703.30593388169;33001.339973200884;33164.33671326608;33451.330973380886;34011.82994085014;34203.315933680686;36102.8194859024;36377.45433818442;36396;36510.63489365178;36597.81701091584;32624.510632340058;32764.836175818968;32866.1783455406;32887.835560822044;32982.175445614055;23398.883005585543;24117.15589954343;24269.393265168514;25420;25678.871605641853 11:22:30 INFO - PID 19240 | |2;jquery.html;579.5740131003712;579.6174524813623;579.8434422705869;585.3678027730052;585.5842351930129;21485.140594376226;22077;22373.216937407193;22454;22478.213262535835;24917.37706557337;26515.602265966027;26645.333866653342;26671.733282667166;26810.19569412921;6387.1696679431725;6582.473402127842;6617.437517810992;6623.370779775938;6624.93375066248;6097;6372.362763723614;6400.359964003609;6489.35106489352;6548.607083574977;6377.457916077139;6385.361463853601;6385.968070159643;6387.361263873622;6389.265234498046;6355.396237357444;6370.171877655898;6373.139626150457;6375.681215939185;6387.393197646216;5924.792632257893;5929.1995580596495;5929.495992840613;5945.019071853139;5956.821295361103;29068.84331435591;29871.253218669488;30414.239644008856;30931.536026959613;31168.22079448032;1935.332310352926;1962.901854907249;1966.2724791826972;1967.252444071258;1967.3409407848387;18998.33505827303;19639.607207855905;19695.803041969684;19771.209151633917;19775.703364449546;2329.900388316728;2409.8192635552405;2441.0235905637887;2448.4735781806817;2455.9386015349583;134149.32925335408;136997.3150134243;137182;137647;137745.311273443;13777.793333100011;14632.634184145269;14851.183184924932;15094.849051509564;15238.695226095639;23053.538929221657;23395.415114622272;23845;23970.280891573282;24047.51904961891;10489.632862849763;10535.525901334458;10676.733081672865;10696.679099627023;10800.081993030522;9945.552450139761;9970.651027214013;9979.60081596728;9990.40057596532;10139.797204055878;9126.448503754378;9255.814883702289;9390.85913711295;9496.952515237379;9531.571079301448;2743.7942154338502;2769.709180536055;2812.1282402454895;2813.4373125374595;2816.718328167167;952.1288021460425;974.133021610767;988.6094992477931;997.2470784557613;1003.117256813999;19816.801831981786;19870.807751534954;19901;19997.000149992735;20229.595408091755;1030.2633616963758;1040.4693606260862;1040.604570263295;1044.4516628769957;1050.175612144463;10700.464976751131;11229.71925701864;11231.550737970552;11316.377599231957;11389.658310250707;481867;496398;499476;504929;514779.0096673877;114118;115361;116960;119328;120611.39694301473;1169.7134202120365;1208.099965525689;1212.678640160358;1221.6274036418977;1229.280870690656;17743.645127097127;17783.19975601127;17834.46496605104;18097;18282.90858545699;53330.4666953341;53651.46348536621;53928.730356347965;54257;54877.45122548723;65512.67243663942;65920;67695.3230467689;68722.65638671775;69034;14453;14458.349374277972;14557;14581.854181458473;14617.415303387745;22358;22758.317250482512;22807.771922280564;22950.770492294865;23012.53974920459;17940.102994850466;17965.910170449064;18133.093345332418;18153.183106759963;18271.177796999433;16048.277827498025;16286.348546058025;16941.491755247363;17006.48980530586;17033.91483042577;18299.359522416653;18400.723989139908;18673.346432874783;18886.905565472633;18901.905490472458;14399.92800035993;14400.567982960529;14412.919031072503;14453.566393008226;14617.561473155822;17837.197326120615;18096.90951545234;18350.54123646866;18488.72266916024;18491 11:22:30 INFO - PID 19240 | |3;mootools.html;1360.6802401435662;1387.8612138786123;1403.8947078969077;1422.1182866622696;1424.5797489740526;13726.725465490685;13874.861251387483;14366.784498232522;14398.49605263816;14413.423463061477;14279.071860329072;14573.34419951102;14574.635634109152;14576.344064517096;14576.781348279757;2535.568953277947;2623.960640590393;2673.17131689176;2679.2765953192625;2681.12863319421;2654.2037388783287;2692.1250593557074;2692.851893145876;2693.340131667744;2693.3535951371628;2622.239550530344;2627.3300308421326;2635.0513815026575;2635.894564217429;2640.577507598775;2551.553478141327;2555.3483861615264;2563.5001174770928;2572.961405578918;2602.0502516581405;2573.5753600656058;2579.21333993132;2587.4178309880313;2589.106758168448;2592.8444293342272;13828.516001939985;13938.094023888516;13944.930275348559;14002.92998535011;14100.717985640229;7300.817479563;7553.395728341774;7565.886511702329;7568.5458872467825;7581.772546823604;4725.763711814396;4821.975890120562;4899.559039686445;4924.827631032933;4949.579285760715;1773.9379121730806;1797;1820.144532069925;1848.1406146141974;1850.2136591948367;23361;23441.296761097194;23442.17952371659;23620.1732939348;23623.763762362327;6434.356564343529;6487.481001519867;6508.674566271762;6638.369354911276;6670.599764014175;16091.597710057342;16094.195290235675;16095.517134485985;16118.677626447405;16137.273822678007;7509.474336796372;7686.769396918102;7691.923080769121;7695.999520062356;7703.3067023968115;7010.053642758265;7100.573965562083;7160.498765086394;7181.784546463615;7186.856262874818;5019;5179.48205179479;5189.351331083614;5206.401263854629;5278.208268759717;1478.571214347827;1484.487851691165;1501.9849801501846;1506.4426162320012;1512.538675703921;900.7703035725848;935.1303287942279;936.1761649748314;941.8634298026748;944.2587568758629;7506.549607023596;7519.473636845369;7538.208488108669;7538.773836784795;7583.317501424898;682.477904403132;695.7703957693949;699.3251512290664;710.4281053751677;711.3420086420144;4593.19619066662;4905.2151655734915;5153.175491921274;5214.426413094557;5274.789008439696;18671.81328186701;19233.90383048076;19403.80596194048;19552.217911283675;19581.902090489457;18674.439766807016;19167.712484312746;19167.90416047911;19191.80808191928;20403;10850.62022829213;11073.50169242386;11086.667399978014;11113.94443027796;11120.22158448917;8226.958865205635;8562.30413965939;8837.425567338103;8901.421407608485;9011.864822027806;17039.318427263268;17301.653966920843;17519.82480175182;17595.736063958793;17663.911680441517;17452.080271169907;18011.549711257325;18154.72767908456;18197.090145492406;18212.36256731008;11104.222704410613;11504.654860353869;11554.48004839801;11580.88419115798;11587.841215878345;12475.875241247471;12573.371331433575;12581.685457863261;12584.119111662096;12593.622191334274;10894.836577451186;10897.727556811144;11003.954624310678;11089.556417743523;11159.665210043711;10528.736781580521;10627.256092073481;10666.36001839892;10675;10803.891961080288;9151.725448236564;9355.06449355059;9367.953160234156;9368.297377696836;9372.859407109036;7355.7057717690695;7394.667239974106;7453.478256521991;7471.626418678936;7552.358049565849;7305.415566754753;7368.189499155196;7451.77045787439;7470.589117598584;7487.513311634726 11:22:30 INFO - PID 19240 | |4;prototype.html;500.16722157607586;511.70576918272;538.7952578020352;539.5521716974911;540.2032002795875;6051.606645568035;6096.298925623554;6118.541109416795;6185.907211391827;6297.401746834055;5872.882542349151;5977.970110149454;6009.248843894513;6035.758569657209;6135.760447436687;4864.818967799291;4923.704577725348;4935.136351138554;4945.530174633404;5001.524855138756;4880.292357608145;4897.853064408074;4957.157283261854;4959.256111583255;5003.4996500350035;4805.543473370024;4839.5160483951495;4848.490908454597;4896.43690975537;4958.553730164284;4838.564529192372;4871.928175801318;4896.632752543555;4928.33467481889;4938.135826230431;4381.948332400233;4413.426254586883;4428.4243048403505;4429.579189976947;4437.622802061828;5940.821775346746;5973.940260597382;6010.939890601082;6037.728302226366;6039.4262545058145;5666.320041594994;5667.773289068432;5676.943230567683;5689.6017278790505;5703.315602127771;6352.396522330371;6369.9681501592195;6438.3883531064475;6465.870682586322;6474.1583594132935;4855.878603034917;4867.367242258484;4879.146149423872;4891.437484689271;4898.559129678346;6847.17833859935;6874.690638921261;6878.243393226741;6896.758583455026;6912.893936970111;4985.401751789808;4987.62592805541;5021.196608542616;5023.39719233687;5037.168867136881;5082.288479612857;5115.411727651368;5119.3088932994315;5119.87200319995;5125.308083408767;5709.65742055478;5713.800101978631;5733.168690539932;5752.7698892043845;5757.251557297524;6542.313057128933;6562.934370656232;6587.374199451045;6592.208934927839;6661.633610151392;1689.1807473375402;1714.8971061736336;1726.620143568413;1755.2101554300361;1776.0320625259005;1218.6831423829867;1240.9193402428814;1248.581725122076;1248.89384402325;1258.8552316483722;5727.541796656341;5741.62679425836;5753.280839895013;5770.740316685676;5792.870390273941;6571.178602674666;6609.7771912196395;6666;6680;6730.495212859055;5569.972150139223;5690.9146362804595;5728.742206600713;5745.569082318842;5778.393268706809;3446.638102999199;3529.2235708144167;3552.4138517144897;3561.786292822387;3594.4069228577514;6471;6493.415592596689;6529.833030979971;6564.785514679799;6576.139379369989;6806.421454176351;6853.348931851466;6887.173539175231;6896.931030689629;6970.895436568456;6472.9029064564065;6493.59736897351;6569;6582.736690532325;6583;6683;6725.697343619451;6770.898436523357;6775.89836152468;6799.286074962256;6475.64383958868;6515.078051974773;6597.175353080865;6630.933690663224;6672.833179170365;6397.104405383157;6417;6472.770173666988;6507.6746162692625;6566.11357466755;4926.285688575065;4963.429205641398;4992.076465853828;5019.372578427697;5038.244263360525;6523.18460192476;6597.208334999831;6636.668166591555;6676.265610782712;6747.898781518379;6418.679066046772;6441.004932706314;6482.319356467503;6484.5460817742305;6560.737570497126;6435.653460200763;6449.097126402401;6457.515686323451;6532.444742196966;6542.149520562487;6162.291336496361;6299.685015749286;6357.936420635734;6374;6413.62695802556;6525.412712855676;6549.639769812706;6570.342965703391;6589.341065893373;6608.306127856506;6251.6561589113035;6271.937280627318;6328.462080723006;6331.746730130927;6376.968115159394 11:22:30 INFO - PID 19240 | |5;yui.html;923.1091996223643;934.5000424772746;941.1012483078661;943.2406912435496;947.8625599288104;18988.62022759544;19681.409557713258;19687.5078123047;19743.308984185558;19753.308634197805;20115.899420502912;21691.891540542274;21935.451613709665;22563.09747610098;22578.435539111488;1019.734868934075;1050.3120456101228;1050.7373156710823;1050.842373643952;1051.1748277602085;957.3394357893067;1043.9947800260989;1046.8900765419635;1054.7995880782628;1056.9207309451822;1121.315997241686;1122.421952694363;1122.7361570031037;1123.4607388453546;1123.859517560305;1102.0192029094112;1111.972200694981;1113.4599719136254;1114.0085324061552;1115.16919894679;816.0859836982618;817.5054092274207;818.3575892924085;819.4345901328124;821.2116368286452;19371.806281937283;19670.40988770339;20195.697064544045;20253.29113481021;20581.897090514452;21912.23307184257;22041.11835526577;22363.88818055899;22595.774042259694;22728.318150455514;15805.550139728246;15808.841911580852;15993.440229592024;16126.596835079099;16156.838431615768;3637.4725664778457;3656.067702735785;3657.3965295726175;3660.816959152032;3661.066428060854;130631;132471;133192.33403833015;135184.32407838095;135429;17278.827211727974;17418.303267869396;17439.47681569555;17807.554811129565;17825.46523604294;31230.84384578108;31714.207144821103;32098;32197.839010804797;32350.676493235238;8549.187827156411;8626.913730862736;8636.78408039804;8653.480791152551;8657.783555411039;4143.97928010358;4231.153769246102;4233.1956928183545;4235.512916014698;4242.087951090531;4828.903421931612;5095.133827249302;5112.769925353368;5681.0910254359105;5916.230889984275;968;984.4585477987079;1000.7798284377425;1001.7746007148479;1003.9046290602381;683.5898460923406;694.2467422846269;701.2181417719308;707.3881092854643;713.2760248347931;11643.417829108681;11842.407879606157;11937.403129843473;12336.629901102802;12711.491540338282;689.7827184436986;708.5890183693446;712.344642928507;717.3794667612477;717.9804677358164;5826.271716035496;5896.292444906639;6083.422074902877;6129.356417576179;6413.198350206224;103284;104238.478807607;105021;105682;111878;95470.52264738631;96847;98717.50641246891;99406;100925.49537252414;87243;87257.56371218231;88058.55970720106;88922.55538722135;89145.55427222823;11939.538552159924;12141.271523708252;12871.871281287067;12872.420741066488;12875.613731588068;38112.428313575874;38930.80534597309;39336.803315983234;40479.392809107296;40803;65417.67291163704;67647.3235267641;70888.64555677188;71508.28491715224;73715.63142184255;17353.566160845574;17376.478705638852;17379.391721289696;17460.388886388915;17597.824021759618;17687.82312176862;18144.45566633003;18886.52783680419;18993.480521557965;18996.810031899506;16487;16640.001599904044;17243.655126897644;17868;18182.09089545491;20014.599708006048;20228;20334.89832550828;20340.79659203389;20348;18817.341393051178;19005.904970475058;19058.904705476383;19133.33033343826;19166.233350665818;12822.23066616006;13066.869331306565;13332.733345333232;13434.193948363129;13478.989075819156;13945.948102995964;14529.34617942174;14653.487127950471;14689.706205876037;14723.043002204822 11:22:30 INFO - PID 19240 | __end_tp_report 11:22:30 INFO - PID 19240 | __start_cc_report 11:22:30 INFO - PID 19240 | _x_x_mozilla_cycle_collect,369 11:22:30 INFO - PID 19240 | __end_cc_report 11:22:30 INFO - PID 19240 | __startTimestamp1502994150597__endTimestamp 11:22:30 INFO - PID 19240 | 11:22:30 INFO - PID 19240 | ------- Summary: start ------- 11:22:30 INFO - PID 19240 | Number of tests: 6 11:22:30 INFO - PID 19240 | 11:22:30 INFO - PID 19240 | [#0] dojo.html Cycles:165 Average:6147.99 Median:6400.97 stddev:722.58 (11.3%) stddev-sans-first:685.53 11:22:30 INFO - PID 19240 | Values: 3152.8 3188.8 3211.2 3215.6 3222.0 6034.2 6128.8 6142.5 6153.3 6277.8 6199.3 6239.8 6289.0 6298.3 6323.2 5659.1 5700.9 5743.2 5776.6 5799.8 5511.8 5606.2 5640.3 5650.2 5746.4 5696.9 5700.5 5702.2 5706.8 5707.3 5626.4 5643.6 5715.2 5722.5 5726.8 5531.0 5536.7 5605.1 5610.1 5682.1 6045.8 6086.4 6086.8 6099.5 6111.7 6579.6 6663.9 6666.7 6667.5 6674.1 6575.3 6669.7 6738.8 6753.0 6766.5 6106.3 6189.0 6210.6 6226.3 6297.2 6896.8 6954.1 6962.4 6974.9 6975.8 6562.9 6579.6 6588.3 6643.9 6676.5 6379.6 6637.6 6672.4 6765.9 6789.5 6586.3 6606.3 6691.3 6692.1 6705.7 6731.2 6732.2 6737.5 6751.3 6753.1 5407.4 5439.6 5501.2 5502.3 5506.1 4632.5 4671.6 4683.3 4694.0 4706.4 5591.4 5664.8 5675.0 5758.1 5841.8 6638.3 6674.1 6679.5 6684.1 6723.2 5788.5 5825.7 5845.6 5853.6 5866.4 5878.0 5948.6 5953.2 5960.2 5960.7 6549.9 6550.3 6626.3 6640.6 6658.4 6583.3 6657.2 6661.5 6664.5 6664.8 6447.5 6475.4 6481.6 6487.8 6495.2 6583.4 6638.8 6643.2 6669.2 6671.5 6219.3 6691.6 6711.7 6730.0 6803.1 6465.9 6467.6 6472.0 6486.3 6488.6 6466.4 6472.4 6474.7 6477.7 6482.3 6401.0 6480.3 6518.3 6552.5 6557.9 6459.4 6573.3 6582.5 6589.2 6676.6 6231.5 6335.4 6348.5 6350.1 6360.1 11:22:30 INFO - PID 19240 | 11:22:30 INFO - PID 19240 | [#1] ext.html Cycles:180 Average:36884.88 Median:35796.11 stddev:51243.58 (143.2%) stddev-sans-first:51315.64 11:22:30 INFO - PID 19240 | Values: 786.2 855.6 881.1 882.6 1150.9 30146.8 38993.8 40020.8 40102.8 40107.6 41264.0 41827.2 41882.0 41930.8 41935.0 7442.4 7464.4 7603.5 7638.2 7664.4 7451.1 7529.0 7529.2 7529.8 7529.9 7549.0 7600.3 7601.2 7634.4 7640.0 7516.5 7530.7 7563.8 7564.0 7564.8 7469.9 7529.1 7546.2 7567.3 7568.7 37575.6 37788.6 37795.2 37821.6 37826.6 3571.1 3596.6 3603.8 3611.0 3611.5 31516.4 31567.0 31582.2 31591.1 31633.2 4944.9 4950.2 4957.4 5003.5 5011.3 180310.0 181827.0 182542.1 182628.0 182936.0 46879.8 46962.8 46981.0 47255.3 47520.8 49244.0 49319.3 49382.8 49387.8 49390.8 14346.9 15861.4 16311.6 16335.1 16335.9 12117.5 13559.6 13753.8 13765.4 13823.7 14206.6 14292.3 14306.4 14353.6 14471.6 5782.7 5829.0 5855.2 5887.5 5897.4 992.7 1008.7 1008.9 1021.7 1030.3 22801.4 23015.3 23200.3 23269.8 23431.2 1108.2 1111.7 1113.4 1115.5 1127.5 11782.6 12174.1 12175.5 12255.4 12293.8 212567.0 215286.0 224006.0 224736.0 224943.0 51470.0 51668.5 51848.5 51998.7 52169.0 1462.4 1476.5 1499.3 1504.3 1507.2 22747.0 22914.5 22925.8 23019.7 23257.7 37178.8 37347.6 37361.3 37388.3 37415.8 189225.0 189549.0 190141.0 190263.0 190704.0 33631.3 34774.5 35737.3 35781.9 35810.3 44636.6 45720.0 45941.1 45998.3 45999.8 33746.5 34094.5 34096.5 34347.5 34703.3 33001.3 33164.3 33451.3 34011.8 34203.3 36102.8 36377.5 36396.0 36510.6 36597.8 32624.5 32764.8 32866.2 32887.8 32982.2 23398.9 24117.2 24269.4 25420.0 25678.9 11:22:30 INFO - PID 19240 | 11:22:30 INFO - PID 19240 | [#2] jquery.html Cycles:180 Average:34909.85 Median:22413.61 stddev:83984.06 (374.7%) stddev-sans-first:84180.10 11:22:30 INFO - PID 19240 | Values: 579.6 579.6 579.8 585.4 585.6 21485.1 22077.0 22373.2 22454.0 22478.2 24917.4 26515.6 26645.3 26671.7 26810.2 6387.2 6582.5 6617.4 6623.4 6624.9 6097.0 6372.4 6400.4 6489.4 6548.6 6377.5 6385.4 6386.0 6387.4 6389.3 6355.4 6370.2 6373.1 6375.7 6387.4 5924.8 5929.2 5929.5 5945.0 5956.8 29068.8 29871.3 30414.2 30931.5 31168.2 1935.3 1962.9 1966.3 1967.3 1967.3 18998.3 19639.6 19695.8 19771.2 19775.7 2329.9 2409.8 2441.0 2448.5 2455.9 134149.3 136997.3 137182.0 137647.0 137745.3 13777.8 14632.6 14851.2 15094.8 15238.7 23053.5 23395.4 23845.0 23970.3 24047.5 10489.6 10535.5 10676.7 10696.7 10800.1 9945.6 9970.7 9979.6 9990.4 10139.8 9126.4 9255.8 9390.9 9497.0 9531.6 2743.8 2769.7 2812.1 2813.4 2816.7 952.1 974.1 988.6 997.2 1003.1 19816.8 19870.8 19901.0 19997.0 20229.6 1030.3 1040.5 1040.6 1044.5 1050.2 10700.5 11229.7 11231.6 11316.4 11389.7 481867.0 496398.0 499476.0 504929.0 514779.0 114118.0 115361.0 116960.0 119328.0 120611.4 1169.7 1208.1 1212.7 1221.6 1229.3 17743.6 17783.2 17834.5 18097.0 18282.9 53330.5 53651.5 53928.7 54257.0 54877.5 65512.7 65920.0 67695.3 68722.7 69034.0 14453.0 14458.3 14557.0 14581.9 14617.4 22358.0 22758.3 22807.8 22950.8 23012.5 17940.1 17965.9 18133.1 18153.2 18271.2 16048.3 16286.3 16941.5 17006.5 17033.9 18299.4 18400.7 18673.3 18886.9 18901.9 14399.9 14400.6 14412.9 14453.6 14617.6 17837.2 18096.9 18350.5 18488.7 18491.0 11:22:30 INFO - PID 19240 | 11:22:30 INFO - PID 19240 | [#3] mootools.html Cycles:180 Average:8800.75 Median:2576.39 stddev:6043.20 (234.6%) stddev-sans-first:6034.29 11:22:30 INFO - PID 19240 | Values: 1360.7 1387.9 1403.9 1422.1 1424.6 13726.7 13874.9 14366.8 14398.5 14413.4 14279.1 14573.3 14574.6 14576.3 14576.8 2535.6 2624.0 2673.2 2679.3 2681.1 2654.2 2692.1 2692.9 2693.3 2693.4 2622.2 2627.3 2635.1 2635.9 2640.6 2551.6 2555.3 2563.5 2573.0 2602.1 2573.6 2579.2 2587.4 2589.1 2592.8 13828.5 13938.1 13944.9 14002.9 14100.7 7300.8 7553.4 7565.9 7568.5 7581.8 4725.8 4822.0 4899.6 4924.8 4949.6 1773.9 1797.0 1820.1 1848.1 1850.2 23361.0 23441.3 23442.2 23620.2 23623.8 6434.4 6487.5 6508.7 6638.4 6670.6 16091.6 16094.2 16095.5 16118.7 16137.3 7509.5 7686.8 7691.9 7696.0 7703.3 7010.1 7100.6 7160.5 7181.8 7186.9 5019.0 5179.5 5189.4 5206.4 5278.2 1478.6 1484.5 1502.0 1506.4 1512.5 900.8 935.1 936.2 941.9 944.3 7506.5 7519.5 7538.2 7538.8 7583.3 682.5 695.8 699.3 710.4 711.3 4593.2 4905.2 5153.2 5214.4 5274.8 18671.8 19233.9 19403.8 19552.2 19581.9 18674.4 19167.7 19167.9 19191.8 20403.0 10850.6 11073.5 11086.7 11113.9 11120.2 8227.0 8562.3 8837.4 8901.4 9011.9 17039.3 17301.7 17519.8 17595.7 17663.9 17452.1 18011.5 18154.7 18197.1 18212.4 11104.2 11504.7 11554.5 11580.9 11587.8 12475.9 12573.4 12581.7 12584.1 12593.6 10894.8 10897.7 11004.0 11089.6 11159.7 10528.7 10627.3 10666.4 10675.0 10803.9 9151.7 9355.1 9368.0 9368.3 9372.9 7355.7 7394.7 7453.5 7471.6 7552.4 7305.4 7368.2 7451.8 7470.6 7487.5 11:22:30 INFO - PID 19240 | 11:22:30 INFO - PID 19240 | [#4] prototype.html Cycles:180 Average:5478.04 Median:6023.35 stddev:1535.30 (25.5%) stddev-sans-first:1493.45 11:22:30 INFO - PID 19240 | Values: 500.2 511.7 538.8 539.6 540.2 6051.6 6096.3 6118.5 6185.9 6297.4 5872.9 5978.0 6009.2 6035.8 6135.8 4864.8 4923.7 4935.1 4945.5 5001.5 4880.3 4897.9 4957.2 4959.3 5003.5 4805.5 4839.5 4848.5 4896.4 4958.6 4838.6 4871.9 4896.6 4928.3 4938.1 4381.9 4413.4 4428.4 4429.6 4437.6 5940.8 5973.9 6010.9 6037.7 6039.4 5666.3 5667.8 5676.9 5689.6 5703.3 6352.4 6370.0 6438.4 6465.9 6474.2 4855.9 4867.4 4879.1 4891.4 4898.6 6847.2 6874.7 6878.2 6896.8 6912.9 4985.4 4987.6 5021.2 5023.4 5037.2 5082.3 5115.4 5119.3 5119.9 5125.3 5709.7 5713.8 5733.2 5752.8 5757.3 6542.3 6562.9 6587.4 6592.2 6661.6 1689.2 1714.9 1726.6 1755.2 1776.0 1218.7 1240.9 1248.6 1248.9 1258.9 5727.5 5741.6 5753.3 5770.7 5792.9 6571.2 6609.8 6666.0 6680.0 6730.5 5570.0 5690.9 5728.7 5745.6 5778.4 3446.6 3529.2 3552.4 3561.8 3594.4 6471.0 6493.4 6529.8 6564.8 6576.1 6806.4 6853.3 6887.2 6896.9 6970.9 6472.9 6493.6 6569.0 6582.7 6583.0 6683.0 6725.7 6770.9 6775.9 6799.3 6475.6 6515.1 6597.2 6630.9 6672.8 6397.1 6417.0 6472.8 6507.7 6566.1 4926.3 4963.4 4992.1 5019.4 5038.2 6523.2 6597.2 6636.7 6676.3 6747.9 6418.7 6441.0 6482.3 6484.5 6560.7 6435.7 6449.1 6457.5 6532.4 6542.1 6162.3 6299.7 6357.9 6374.0 6413.6 6525.4 6549.6 6570.3 6589.3 6608.3 6251.7 6271.9 6328.5 6331.7 6377.0 11:22:30 INFO - PID 19240 | 11:22:30 INFO - PID 19240 | [#5] yui.html Cycles:180 Average:24044.17 Median:20065.25 stddev:32595.77 (162.4%) stddev-sans-first:32640.97 11:22:30 INFO - PID 19240 | Values: 923.1 934.5 941.1 943.2 947.9 18988.6 19681.4 19687.5 19743.3 19753.3 20115.9 21691.9 21935.5 22563.1 22578.4 1019.7 1050.3 1050.7 1050.8 1051.2 957.3 1044.0 1046.9 1054.8 1056.9 1121.3 1122.4 1122.7 1123.5 1123.9 1102.0 1112.0 1113.5 1114.0 1115.2 816.1 817.5 818.4 819.4 821.2 19371.8 19670.4 20195.7 20253.3 20581.9 21912.2 22041.1 22363.9 22595.8 22728.3 15805.6 15808.8 15993.4 16126.6 16156.8 3637.5 3656.1 3657.4 3660.8 3661.1 130631.0 132471.0 133192.3 135184.3 135429.0 17278.8 17418.3 17439.5 17807.6 17825.5 31230.8 31714.2 32098.0 32197.8 32350.7 8549.2 8626.9 8636.8 8653.5 8657.8 4144.0 4231.2 4233.2 4235.5 4242.1 4828.9 5095.1 5112.8 5681.1 5916.2 968.0 984.5 1000.8 1001.8 1003.9 683.6 694.2 701.2 707.4 713.3 11643.4 11842.4 11937.4 12336.6 12711.5 689.8 708.6 712.3 717.4 718.0 5826.3 5896.3 6083.4 6129.4 6413.2 103284.0 104238.5 105021.0 105682.0 111878.0 95470.5 96847.0 98717.5 99406.0 100925.5 87243.0 87257.6 88058.6 88922.6 89145.6 11939.5 12141.3 12871.9 12872.4 12875.6 38112.4 38930.8 39336.8 40479.4 40803.0 65417.7 67647.3 70888.6 71508.3 73715.6 17353.6 17376.5 17379.4 17460.4 17597.8 17687.8 18144.5 18886.5 18993.5 18996.8 16487.0 16640.0 17243.7 17868.0 18182.1 20014.6 20228.0 20334.9 20340.8 20348.0 18817.3 19005.9 19058.9 19133.3 19166.2 12822.2 13066.9 13332.7 13434.2 13479.0 13945.9 14529.3 14653.5 14689.7 14723.0 11:22:30 INFO - PID 19240 | -------- Summary: end -------- 11:22:30 INFO - PID 19240 | 11:22:31 INFO - TEST-INFO | 19240: exit 0 11:22:31 INFO - TEST-OK | dromaeo_css | took 1112940ms 11:22:31 INFO - TEST-START | kraken 11:22:31 INFO - Initialising browser for kraken test... 11:22:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42631/getInfo.html -profile /tmp/tmpHUnJFA/profile 11:22:31 INFO - TEST-INFO | started process 19612 (/builds/slave/test/build/application/firefox/firefox http://localhost:42631/getInfo.html) 11:22:37 INFO - TEST-INFO | 19612: exit 0 11:22:38 INFO - Browser initialized. 11:22:38 INFO - Running cycle 1/1 for kraken test... 11:22:38 INFO - TEST-INFO | started process 19784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHUnJFA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:22:38 INFO - PID 19784 | 11:22:38 INFO - PID 19784 | (/builds/slave/test/build/application/firefox/firefox:19833): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:22:38 INFO - PID 19784 | 11:22:49 INFO - PID 19784 | RSS: Main: 163876864 11:22:49 INFO - PID 19784 | 11:22:51 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42631/tests/kraken/driver.html?testName=audio-beat-detection) 11:22:52 INFO - PID 19784 | RSS: Main: 169345024 11:22:52 INFO - PID 19784 | 11:22:55 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42631/tests/kraken/driver.html?testName=audio-dft) 11:22:56 INFO - PID 19784 | RSS: Main: 173686784 11:22:56 INFO - PID 19784 | 11:22:59 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42631/tests/kraken/driver.html?testName=audio-fft) 11:22:59 INFO - PID 19784 | RSS: Main: 167727104 11:22:59 INFO - PID 19784 | 11:23:01 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42631/tests/kraken/driver.html?testName=audio-oscillator) 11:23:02 INFO - PID 19784 | RSS: Main: 167702528 11:23:02 INFO - PID 19784 | 11:23:04 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42631/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:23:05 INFO - PID 19784 | RSS: Main: 168579072 11:23:05 INFO - PID 19784 | 11:23:08 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42631/tests/kraken/driver.html?testName=imaging-darkroom) 11:23:08 INFO - PID 19784 | RSS: Main: 168919040 11:23:08 INFO - PID 19784 | 11:23:12 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42631/tests/kraken/driver.html?testName=imaging-desaturate) 11:23:13 INFO - PID 19784 | RSS: Main: 170057728 11:23:13 INFO - PID 19784 | 11:23:15 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42631/tests/kraken/driver.html?testName=json-parse-financial) 11:23:16 INFO - PID 19784 | RSS: Main: 170127360 11:23:16 INFO - PID 19784 | 11:23:18 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42631/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:23:18 INFO - PID 19784 | RSS: Main: 169775104 11:23:18 INFO - PID 19784 | 11:23:20 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42631/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:23:21 INFO - PID 19784 | RSS: Main: 170254336 11:23:21 INFO - PID 19784 | 11:23:23 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42631/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:23:23 INFO - PID 19784 | RSS: Main: 170119168 11:23:23 INFO - PID 19784 | 11:23:26 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:23:27 INFO - PID 19784 | RSS: Main: 170549248 11:23:27 INFO - PID 19784 | 11:23:30 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:23:30 INFO - PID 19784 | RSS: Main: 169857024 11:23:30 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | Cycle 1(1): loaded http://localhost:42631/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42631/tests/kraken/driver.html?testName=ai-astar) 11:23:32 INFO - PID 19784 | RSS: Main: 171921408 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | __start_tp_report 11:23:32 INFO - PID 19784 | _x_x_mozilla_page_load 11:23:32 INFO - PID 19784 | _x_x_mozilla_page_load_details 11:23:32 INFO - PID 19784 | |i|pagename|runs| 11:23:32 INFO - PID 19784 | |0;ai-astar;99;107;101;108;106;111;109;98;112;108 11:23:32 INFO - PID 19784 | |1;audio-beat-detection;142;116;142;190;119;144;146;115;168;118 11:23:32 INFO - PID 19784 | |2;audio-dft;162;165;163;164;163;164;161;171;167;162 11:23:32 INFO - PID 19784 | |3;audio-fft;75;75;75;170;77;76;73;75;152;76 11:23:32 INFO - PID 19784 | |4;audio-oscillator;79;79;129;78;78;82;135;80;78;127 11:23:32 INFO - PID 19784 | |5;imaging-gaussian-blur;114;114;114;114;114;115;114;115;114;114 11:23:32 INFO - PID 19784 | |6;imaging-darkroom;152;150;150;150;151;149;158;151;151;149 11:23:32 INFO - PID 19784 | |7;imaging-desaturate;94;93;94;94;93;94;94;94;94;94 11:23:32 INFO - PID 19784 | |8;json-parse-financial;54;54;54;54;54;54;56;53;54;53 11:23:32 INFO - PID 19784 | |9;json-stringify-tinderbox;54;54;55;55;54;54;54;54;55;54 11:23:32 INFO - PID 19784 | |10;stanford-crypto-aes;79;77;76;84;76;76;75;76;76;75 11:23:32 INFO - PID 19784 | |11;stanford-crypto-ccm;125;120;121;119;128;133;127;121;121;155 11:23:32 INFO - PID 19784 | |12;stanford-crypto-pbkdf2;185;179;172;176;187;211;173;175;172;178 11:23:32 INFO - PID 19784 | |13;stanford-crypto-sha256-iterative;75;67;71;68;66;72;69;66;66;70 11:23:32 INFO - PID 19784 | __end_tp_report 11:23:32 INFO - PID 19784 | __start_cc_report 11:23:32 INFO - PID 19784 | _x_x_mozilla_cycle_collect,962 11:23:32 INFO - PID 19784 | __end_cc_report 11:23:32 INFO - PID 19784 | __startTimestamp1502994212855__endTimestamp 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | ------- Summary: start ------- 11:23:32 INFO - PID 19784 | Number of tests: 14 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#0] ai-astar Cycles:10 Average:105.90 Median:110.00 stddev:4.91 (4.5%) stddev-sans-first:4.53 11:23:32 INFO - PID 19784 | Values: 99.0 107.0 101.0 108.0 106.0 111.0 109.0 98.0 112.0 108.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:143.00 stddev:24.65 (17.2%) stddev-sans-first:26.14 11:23:32 INFO - PID 19784 | Values: 142.0 116.0 142.0 190.0 119.0 144.0 146.0 115.0 168.0 118.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.94 (1.8%) stddev-sans-first:3.00 11:23:32 INFO - PID 19784 | Values: 162.0 165.0 163.0 164.0 163.0 164.0 161.0 171.0 167.0 162.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#3] audio-fft Cycles:10 Average:92.40 Median:75.00 stddev:36.42 (48.6%) stddev-sans-first:38.08 11:23:32 INFO - PID 19784 | Values: 75.0 75.0 75.0 170.0 77.0 76.0 73.0 75.0 152.0 76.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:78.50 stddev:24.83 (31.6%) stddev-sans-first:25.70 11:23:32 INFO - PID 19784 | Values: 79.0 79.0 129.0 78.0 78.0 82.0 135.0 80.0 78.0 127.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:23:32 INFO - PID 19784 | Values: 114.0 114.0 114.0 114.0 114.0 115.0 114.0 115.0 114.0 114.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:2.60 (1.7%) stddev-sans-first:2.74 11:23:32 INFO - PID 19784 | Values: 152.0 150.0 150.0 150.0 151.0 149.0 158.0 151.0 151.0 149.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:23:32 INFO - PID 19784 | Values: 94.0 93.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.87 11:23:32 INFO - PID 19784 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 56.0 53.0 54.0 53.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 11:23:32 INFO - PID 19784 | Values: 54.0 54.0 55.0 55.0 54.0 54.0 54.0 54.0 55.0 54.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:76.00 stddev:2.71 (3.6%) stddev-sans-first:2.77 11:23:32 INFO - PID 19784 | Values: 79.0 77.0 76.0 84.0 76.0 76.0 75.0 76.0 76.0 75.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:126.00 stddev:10.78 (8.6%) stddev-sans-first:11.41 11:23:32 INFO - PID 19784 | Values: 125.0 120.0 121.0 119.0 128.0 133.0 127.0 121.0 121.0 155.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.80 Median:178.50 stddev:11.79 (6.6%) stddev-sans-first:12.41 11:23:32 INFO - PID 19784 | Values: 185.0 179.0 172.0 176.0 187.0 211.0 173.0 175.0 172.0 178.0 11:23:32 INFO - PID 19784 | 11:23:32 INFO - PID 19784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.50 stddev:3.02 (4.3%) stddev-sans-first:2.29 11:23:32 INFO - PID 19784 | Values: 75.0 67.0 71.0 68.0 66.0 72.0 69.0 66.0 66.0 70.0 11:23:32 INFO - PID 19784 | -------- Summary: end -------- 11:23:32 INFO - PID 19784 | 11:23:33 INFO - PID 19784 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:23:33 INFO - TEST-INFO | 19784: exit 0 11:23:33 INFO - TEST-OK | kraken | took 62334ms 11:23:33 INFO - SUITE-END | took 1175s 11:23:34 INFO - Completed test suite (00:19:35) 11:23:34 INFO - javascript benchmark 11:23:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8486.19857224255, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.810831350118, 3188.8405579721007, 3211.197200699825, 3215.5980502437196, 3222.033389983006, 6034.155218269446, 6128.846778830532, 6142.508599312056, 6153.261608606962, 6277.843053923654, 6199.349068347826, 6239.750409983595, 6289.0, 6298.338674439186, 6323.20959880015, 5659.094544872821, 5700.857478563028, 5743.195952566644, 5776.624519406225, 5799.82600521985, 5511.834644960658, 5606.187102870082, 5640.323161220639, 5650.152477128422, 5746.367899531048, 5696.946064977992, 5700.458456446651, 5702.173184888209, 5706.800261990831, 5707.258056452655, 5626.381098079208, 5643.576731745095, 5715.171300161495, 5722.513586345166, 5726.77092916287, 5531.0, 5536.695481748502, 5605.131204663284, 5610.102383618642, 5682.119271512922, 6045.818625441244, 6086.421789929949, 6086.847828804315, 6099.512039036911, 6111.724972376253, 6579.605223686594, 6663.86672266552, 6666.733330666768, 6667.499937504706, 6674.132362792854, 6575.3095924927675, 6669.666516674147, 6738.797836064926, 6752.966235168842, 6766.458683305324, 6106.2977757558, 6189.04069869171, 6210.565260431817, 6226.346233645448, 6297.2128483939505, 6896.793096207121, 6954.061201737802, 6962.408195303456, 6974.930250697529, 6975.82560435983, 6562.934370656232, 6579.638119903451, 6588.341165883469, 6643.933560664428, 6676.49926255523, 6379.585326953733, 6637.568558043712, 6672.366125218096, 6765.932340676629, 6789.456843452512, 6586.27550969393, 6606.306337834554, 6691.330866913367, 6692.096566963398, 6705.731770729116, 6731.225909020427, 6732.225794033749, 6737.494687898427, 6751.324867513307, 6753.1220941277315, 5407.432219616883, 5439.592030597721, 5501.174823776466, 5502.257195278587, 5506.091494903296, 4632.513586073481, 4671.602913752301, 4683.297505374153, 4694.037722266927, 4706.435227772621, 5591.440855914376, 5664.830055098354, 5675.006873797069, 5758.136279558016, 5841.795537156264, 6638.336166383419, 6674.098996635489, 6679.532432729759, 6684.064231007663, 6723.193216813916, 5788.45009724084, 5825.70871456434, 5845.561582881216, 5853.590248682552, 5866.354700982888, 5878.000739874232, 5948.583599148018, 5953.226080609493, 5960.225170727865, 5960.731767070492, 6549.934500654933, 6550.288116804639, 6626.271110177877, 6640.601563906181, 6658.3674550917585, 6583.275839657729, 6657.167854018247, 6661.533692641468, 6664.5334826561675, 6664.8000559983275, 6447.516436267392, 6475.352464753487, 6481.578697384655, 6487.805365839033, 6495.220573531017, 6583.407493325623, 6638.800835974928, 6643.169603799525, 6669.166354205724, 6671.499637527108, 6219.253689557282, 6691.5650482718465, 6711.697973591103, 6730.0241464988285, 6803.081583986099, 6465.903011454926, 6467.579607325509, 6472.0, 6486.318936511787, 6488.610683359014, 6466.418022378009, 6472.385123413268, 6474.708638111202, 6477.708503117466, 6482.2869484357625, 6400.967995160181, 6480.25477070143, 6518.282988871126, 6552.508561857975, 6557.9344206557325, 6459.418652321314, 6573.317775184738, 6582.506312026521, 6589.17635295588, 6676.632785196666, 6231.53263505248, 6335.3981371769605, 6348.492120630431, 6350.110984462087, 6360.141380913517], "value": 6094.653393129094, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.1666633368629, 855.5636625321087, 881.1364862434814, 882.5587206396801, 1150.9251898626583, 30146.849265753695, 38993.80503097484, 40020.79989600048, 40102.79948600253, 40107.59892401075, 41264.0, 41827.16345673092, 41882.0, 41930.79034604823, 41935.0, 7442.367398771111, 7464.402847772165, 7603.543787372748, 7638.236176382345, 7664.38684905209, 7451.068616422947, 7529.0, 7529.171791102975, 7529.849403011936, 7529.887051694229, 7549.0, 7600.277973592528, 7601.163871974079, 7634.351080158193, 7640.0, 7516.5114267572435, 7530.6987720491115, 7563.848723025564, 7563.962180189092, 7564.810879727996, 7469.925300746977, 7529.134149572759, 7546.245375462465, 7567.31894129531, 7568.659410326549, 37575.624243757484, 37788.62211377879, 37795.244095117945, 37821.62178378209, 37826.62173378259, 3571.14292569784, 3596.6403359663823, 3603.783772973604, 3610.981945090258, 3611.458281257806, 31516.36967260642, 31567.0, 31582.210444739067, 31591.052268431755, 31633.20916977071, 4944.9258261126115, 4950.183219768734, 4957.405111386621, 5003.524665156804, 5011.348524691767, 180310.0, 181827.0, 182542.08728956402, 182628.0, 182936.0, 46879.76560117246, 46962.76518617385, 46981.0, 47255.29117063247, 47520.7623961878, 49244.0, 49319.260211096866, 49382.75308623434, 49387.75306123446, 49390.75304623454, 14346.928265358607, 15861.444849430214, 16311.592210194603, 16335.101569413797, 16335.91832040856, 12117.515299388102, 13559.59321220365, 13753.79369309461, 13765.38055787492, 13823.723525529635, 14206.573802785933, 14292.28538573088, 14306.356213970397, 14353.6411589709, 14471.565853024425, 5782.739776710058, 5829.0, 5855.209546711225, 5887.499562537147, 5897.410258974069, 992.6972273456665, 1008.7478130467383, 1008.8638033865334, 1021.6883850425543, 1030.253066526777, 22801.429964250696, 23015.309540713806, 23200.3039908803, 23269.76730232676, 23431.179908703114, 1108.1688733449912, 1111.6942840718866, 1113.3653817324048, 1115.5482029777952, 1127.537709539085, 11782.587609433629, 12174.086943479275, 12175.512979480898, 12255.429368400044, 12293.754124917452, 212567.0, 215286.0, 224006.0, 224736.0, 224943.0, 51469.97060058778, 51668.48331516712, 51848.48151518512, 51998.740006299726, 52169.0, 1462.4369617697264, 1476.5496523560203, 1499.2878382768097, 1504.2704288420107, 1507.1635242440332, 22747.0, 22914.54170916539, 22925.770742293033, 23019.654705179102, 23257.651135232645, 37178.8141059293, 37347.62652373441, 37361.25277494489, 37388.25223495569, 37415.81292093522, 189225.0, 189549.0, 190141.0, 190263.0, 190704.0, 33631.327373452885, 34774.47838282478, 35737.28525429529, 35781.92654220378, 35810.28379432449, 44636.55363446454, 45720.0, 45941.08117837692, 45998.310025350314, 45999.77000114978, 33746.493802593475, 34094.48858267078, 34096.48855267223, 34347.4847877287, 34703.30593388169, 33001.339973200884, 33164.33671326608, 33451.330973380886, 34011.82994085014, 34203.315933680686, 36102.8194859024, 36377.45433818442, 36396.0, 36510.63489365178, 36597.81701091584, 32624.510632340058, 32764.836175818968, 32866.1783455406, 32887.835560822044, 32982.175445614055, 23398.883005585543, 24117.15589954343, 24269.393265168514, 25420.0, 25678.871605641853], "value": 17150.994342887505, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.5740131003712, 579.6174524813623, 579.8434422705869, 585.3678027730052, 585.5842351930129, 21485.140594376226, 22077.0, 22373.216937407193, 22454.0, 22478.213262535835, 24917.37706557337, 26515.602265966027, 26645.333866653342, 26671.733282667166, 26810.19569412921, 6387.1696679431725, 6582.473402127842, 6617.437517810992, 6623.370779775938, 6624.93375066248, 6097.0, 6372.362763723614, 6400.359964003609, 6489.35106489352, 6548.607083574977, 6377.457916077139, 6385.361463853601, 6385.968070159643, 6387.361263873622, 6389.265234498046, 6355.396237357444, 6370.171877655898, 6373.139626150457, 6375.681215939185, 6387.393197646216, 5924.792632257893, 5929.1995580596495, 5929.495992840613, 5945.019071853139, 5956.821295361103, 29068.84331435591, 29871.253218669488, 30414.239644008856, 30931.536026959613, 31168.22079448032, 1935.332310352926, 1962.901854907249, 1966.2724791826972, 1967.252444071258, 1967.3409407848387, 18998.33505827303, 19639.607207855905, 19695.803041969684, 19771.209151633917, 19775.703364449546, 2329.900388316728, 2409.8192635552405, 2441.0235905637887, 2448.4735781806817, 2455.9386015349583, 134149.32925335408, 136997.3150134243, 137182.0, 137647.0, 137745.311273443, 13777.793333100011, 14632.634184145269, 14851.183184924932, 15094.849051509564, 15238.695226095639, 23053.538929221657, 23395.415114622272, 23845.0, 23970.280891573282, 24047.51904961891, 10489.632862849763, 10535.525901334458, 10676.733081672865, 10696.679099627023, 10800.081993030522, 9945.552450139761, 9970.651027214013, 9979.60081596728, 9990.40057596532, 10139.797204055878, 9126.448503754378, 9255.814883702289, 9390.85913711295, 9496.952515237379, 9531.571079301448, 2743.7942154338502, 2769.709180536055, 2812.1282402454895, 2813.4373125374595, 2816.718328167167, 952.1288021460425, 974.133021610767, 988.6094992477931, 997.2470784557613, 1003.117256813999, 19816.801831981786, 19870.807751534954, 19901.0, 19997.000149992735, 20229.595408091755, 1030.2633616963758, 1040.4693606260862, 1040.604570263295, 1044.4516628769957, 1050.175612144463, 10700.464976751131, 11229.71925701864, 11231.550737970552, 11316.377599231957, 11389.658310250707, 481867.0, 496398.0, 499476.0, 504929.0, 514779.0096673877, 114118.0, 115361.0, 116960.0, 119328.0, 120611.39694301473, 1169.7134202120365, 1208.099965525689, 1212.678640160358, 1221.6274036418977, 1229.280870690656, 17743.645127097127, 17783.19975601127, 17834.46496605104, 18097.0, 18282.90858545699, 53330.4666953341, 53651.46348536621, 53928.730356347965, 54257.0, 54877.45122548723, 65512.67243663942, 65920.0, 67695.3230467689, 68722.65638671775, 69034.0, 14453.0, 14458.349374277972, 14557.0, 14581.854181458473, 14617.415303387745, 22358.0, 22758.317250482512, 22807.771922280564, 22950.770492294865, 23012.53974920459, 17940.102994850466, 17965.910170449064, 18133.093345332418, 18153.183106759963, 18271.177796999433, 16048.277827498025, 16286.348546058025, 16941.491755247363, 17006.48980530586, 17033.91483042577, 18299.359522416653, 18400.723989139908, 18673.346432874783, 18886.905565472633, 18901.905490472458, 14399.92800035993, 14400.567982960529, 14412.919031072503, 14453.566393008226, 14617.561473155822, 17837.197326120615, 18096.90951545234, 18350.54123646866, 18488.72266916024, 18491.0], "value": 11979.042487799754, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.6802401435662, 1387.8612138786123, 1403.8947078969077, 1422.1182866622696, 1424.5797489740526, 13726.725465490685, 13874.861251387483, 14366.784498232522, 14398.49605263816, 14413.423463061477, 14279.071860329072, 14573.34419951102, 14574.635634109152, 14576.344064517096, 14576.781348279757, 2535.568953277947, 2623.960640590393, 2673.17131689176, 2679.2765953192625, 2681.12863319421, 2654.2037388783287, 2692.1250593557074, 2692.851893145876, 2693.340131667744, 2693.3535951371628, 2622.239550530344, 2627.3300308421326, 2635.0513815026575, 2635.894564217429, 2640.577507598775, 2551.553478141327, 2555.3483861615264, 2563.5001174770928, 2572.961405578918, 2602.0502516581405, 2573.5753600656058, 2579.21333993132, 2587.4178309880313, 2589.106758168448, 2592.8444293342272, 13828.516001939985, 13938.094023888516, 13944.930275348559, 14002.92998535011, 14100.717985640229, 7300.817479563, 7553.395728341774, 7565.886511702329, 7568.5458872467825, 7581.772546823604, 4725.763711814396, 4821.975890120562, 4899.559039686445, 4924.827631032933, 4949.579285760715, 1773.9379121730806, 1797.0, 1820.144532069925, 1848.1406146141974, 1850.2136591948367, 23361.0, 23441.296761097194, 23442.17952371659, 23620.1732939348, 23623.763762362327, 6434.356564343529, 6487.481001519867, 6508.674566271762, 6638.369354911276, 6670.599764014175, 16091.597710057342, 16094.195290235675, 16095.517134485985, 16118.677626447405, 16137.273822678007, 7509.474336796372, 7686.769396918102, 7691.923080769121, 7695.999520062356, 7703.3067023968115, 7010.053642758265, 7100.573965562083, 7160.498765086394, 7181.784546463615, 7186.856262874818, 5019.0, 5179.48205179479, 5189.351331083614, 5206.401263854629, 5278.208268759717, 1478.571214347827, 1484.487851691165, 1501.9849801501846, 1506.4426162320012, 1512.538675703921, 900.7703035725848, 935.1303287942279, 936.1761649748314, 941.8634298026748, 944.2587568758629, 7506.549607023596, 7519.473636845369, 7538.208488108669, 7538.773836784795, 7583.317501424898, 682.477904403132, 695.7703957693949, 699.3251512290664, 710.4281053751677, 711.3420086420144, 4593.19619066662, 4905.2151655734915, 5153.175491921274, 5214.426413094557, 5274.789008439696, 18671.81328186701, 19233.90383048076, 19403.80596194048, 19552.217911283675, 19581.902090489457, 18674.439766807016, 19167.712484312746, 19167.90416047911, 19191.80808191928, 20403.0, 10850.62022829213, 11073.50169242386, 11086.667399978014, 11113.94443027796, 11120.22158448917, 8226.958865205635, 8562.30413965939, 8837.425567338103, 8901.421407608485, 9011.864822027806, 17039.318427263268, 17301.653966920843, 17519.82480175182, 17595.736063958793, 17663.911680441517, 17452.080271169907, 18011.549711257325, 18154.72767908456, 18197.090145492406, 18212.36256731008, 11104.222704410613, 11504.654860353869, 11554.48004839801, 11580.88419115798, 11587.841215878345, 12475.875241247471, 12573.371331433575, 12581.685457863261, 12584.119111662096, 12593.622191334274, 10894.836577451186, 10897.727556811144, 11003.954624310678, 11089.556417743523, 11159.665210043711, 10528.736781580521, 10627.256092073481, 10666.36001839892, 10675.0, 10803.891961080288, 9151.725448236564, 9355.06449355059, 9367.953160234156, 9368.297377696836, 9372.859407109036, 7355.7057717690695, 7394.667239974106, 7453.478256521991, 7471.626418678936, 7552.358049565849, 7305.415566754753, 7368.189499155196, 7451.77045787439, 7470.589117598584, 7487.513311634726], "value": 6360.0353818016265, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.16722157607586, 511.70576918272, 538.7952578020352, 539.5521716974911, 540.2032002795875, 6051.606645568035, 6096.298925623554, 6118.541109416795, 6185.907211391827, 6297.401746834055, 5872.882542349151, 5977.970110149454, 6009.248843894513, 6035.758569657209, 6135.760447436687, 4864.818967799291, 4923.704577725348, 4935.136351138554, 4945.530174633404, 5001.524855138756, 4880.292357608145, 4897.853064408074, 4957.157283261854, 4959.256111583255, 5003.4996500350035, 4805.543473370024, 4839.5160483951495, 4848.490908454597, 4896.43690975537, 4958.553730164284, 4838.564529192372, 4871.928175801318, 4896.632752543555, 4928.33467481889, 4938.135826230431, 4381.948332400233, 4413.426254586883, 4428.4243048403505, 4429.579189976947, 4437.622802061828, 5940.821775346746, 5973.940260597382, 6010.939890601082, 6037.728302226366, 6039.4262545058145, 5666.320041594994, 5667.773289068432, 5676.943230567683, 5689.6017278790505, 5703.315602127771, 6352.396522330371, 6369.9681501592195, 6438.3883531064475, 6465.870682586322, 6474.1583594132935, 4855.878603034917, 4867.367242258484, 4879.146149423872, 4891.437484689271, 4898.559129678346, 6847.17833859935, 6874.690638921261, 6878.243393226741, 6896.758583455026, 6912.893936970111, 4985.401751789808, 4987.62592805541, 5021.196608542616, 5023.39719233687, 5037.168867136881, 5082.288479612857, 5115.411727651368, 5119.3088932994315, 5119.87200319995, 5125.308083408767, 5709.65742055478, 5713.800101978631, 5733.168690539932, 5752.7698892043845, 5757.251557297524, 6542.313057128933, 6562.934370656232, 6587.374199451045, 6592.208934927839, 6661.633610151392, 1689.1807473375402, 1714.8971061736336, 1726.620143568413, 1755.2101554300361, 1776.0320625259005, 1218.6831423829867, 1240.9193402428814, 1248.581725122076, 1248.89384402325, 1258.8552316483722, 5727.541796656341, 5741.62679425836, 5753.280839895013, 5770.740316685676, 5792.870390273941, 6571.178602674666, 6609.7771912196395, 6666.0, 6680.0, 6730.495212859055, 5569.972150139223, 5690.9146362804595, 5728.742206600713, 5745.569082318842, 5778.393268706809, 3446.638102999199, 3529.2235708144167, 3552.4138517144897, 3561.786292822387, 3594.4069228577514, 6471.0, 6493.415592596689, 6529.833030979971, 6564.785514679799, 6576.139379369989, 6806.421454176351, 6853.348931851466, 6887.173539175231, 6896.931030689629, 6970.895436568456, 6472.9029064564065, 6493.59736897351, 6569.0, 6582.736690532325, 6583.0, 6683.0, 6725.697343619451, 6770.898436523357, 6775.89836152468, 6799.286074962256, 6475.64383958868, 6515.078051974773, 6597.175353080865, 6630.933690663224, 6672.833179170365, 6397.104405383157, 6417.0, 6472.770173666988, 6507.6746162692625, 6566.11357466755, 4926.285688575065, 4963.429205641398, 4992.076465853828, 5019.372578427697, 5038.244263360525, 6523.18460192476, 6597.208334999831, 6636.668166591555, 6676.265610782712, 6747.898781518379, 6418.679066046772, 6441.004932706314, 6482.319356467503, 6484.5460817742305, 6560.737570497126, 6435.653460200763, 6449.097126402401, 6457.515686323451, 6532.444742196966, 6542.149520562487, 6162.291336496361, 6299.685015749286, 6357.936420635734, 6374.0, 6413.62695802556, 6525.412712855676, 6549.639769812706, 6570.342965703391, 6589.341065893373, 6608.306127856506, 6251.6561589113035, 6271.937280627318, 6328.462080723006, 6331.746730130927, 6376.968115159394], "value": 5031.084330125301, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [923.1091996223643, 934.5000424772746, 941.1012483078661, 943.2406912435496, 947.8625599288104, 18988.62022759544, 19681.409557713258, 19687.5078123047, 19743.308984185558, 19753.308634197805, 20115.899420502912, 21691.891540542274, 21935.451613709665, 22563.09747610098, 22578.435539111488, 1019.734868934075, 1050.3120456101228, 1050.7373156710823, 1050.842373643952, 1051.1748277602085, 957.3394357893067, 1043.9947800260989, 1046.8900765419635, 1054.7995880782628, 1056.9207309451822, 1121.315997241686, 1122.421952694363, 1122.7361570031037, 1123.4607388453546, 1123.859517560305, 1102.0192029094112, 1111.972200694981, 1113.4599719136254, 1114.0085324061552, 1115.16919894679, 816.0859836982618, 817.5054092274207, 818.3575892924085, 819.4345901328124, 821.2116368286452, 19371.806281937283, 19670.40988770339, 20195.697064544045, 20253.29113481021, 20581.897090514452, 21912.23307184257, 22041.11835526577, 22363.88818055899, 22595.774042259694, 22728.318150455514, 15805.550139728246, 15808.841911580852, 15993.440229592024, 16126.596835079099, 16156.838431615768, 3637.4725664778457, 3656.067702735785, 3657.3965295726175, 3660.816959152032, 3661.066428060854, 130631.0, 132471.0, 133192.33403833015, 135184.32407838095, 135429.0, 17278.827211727974, 17418.303267869396, 17439.47681569555, 17807.554811129565, 17825.46523604294, 31230.84384578108, 31714.207144821103, 32098.0, 32197.839010804797, 32350.676493235238, 8549.187827156411, 8626.913730862736, 8636.78408039804, 8653.480791152551, 8657.783555411039, 4143.97928010358, 4231.153769246102, 4233.1956928183545, 4235.512916014698, 4242.087951090531, 4828.903421931612, 5095.133827249302, 5112.769925353368, 5681.0910254359105, 5916.230889984275, 968.0, 984.4585477987079, 1000.7798284377425, 1001.7746007148479, 1003.9046290602381, 683.5898460923406, 694.2467422846269, 701.2181417719308, 707.3881092854643, 713.2760248347931, 11643.417829108681, 11842.407879606157, 11937.403129843473, 12336.629901102802, 12711.491540338282, 689.7827184436986, 708.5890183693446, 712.344642928507, 717.3794667612477, 717.9804677358164, 5826.271716035496, 5896.292444906639, 6083.422074902877, 6129.356417576179, 6413.198350206224, 103284.0, 104238.478807607, 105021.0, 105682.0, 111878.0, 95470.52264738631, 96847.0, 98717.50641246891, 99406.0, 100925.49537252414, 87243.0, 87257.56371218231, 88058.55970720106, 88922.55538722135, 89145.55427222823, 11939.538552159924, 12141.271523708252, 12871.871281287067, 12872.420741066488, 12875.613731588068, 38112.428313575874, 38930.80534597309, 39336.803315983234, 40479.392809107296, 40803.0, 65417.67291163704, 67647.3235267641, 70888.64555677188, 71508.28491715224, 73715.63142184255, 17353.566160845574, 17376.478705638852, 17379.391721289696, 17460.388886388915, 17597.824021759618, 17687.82312176862, 18144.45566633003, 18886.52783680419, 18993.480521557965, 18996.810031899506, 16487.0, 16640.001599904044, 17243.655126897644, 17868.0, 18182.09089545491, 20014.599708006048, 20228.0, 20334.89832550828, 20340.79659203389, 20348.0, 18817.341393051178, 19005.904970475058, 19058.904705476383, 19133.33033343826, 19166.233350665818, 12822.23066616006, 13066.869331306565, 13332.733345333232, 13434.193948363129, 13478.989075819156, 13945.948102995964, 14529.34617942174, 14653.487127950471, 14689.706205876037, 14723.043002204822], "value": 9321.174124236686, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 101.0, 108.0, 106.0, 111.0, 109.0, 98.0, 112.0, 108.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 142.0, 190.0, 119.0, 144.0, 146.0, 115.0, 168.0, 118.0], "value": 140.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 163.0, 164.0, 163.0, 164.0, 161.0, 171.0, 167.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 170.0, 77.0, 76.0, 73.0, 75.0, 152.0, 76.0], "value": 92.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 129.0, 78.0, 78.0, 82.0, 135.0, 80.0, 78.0, 127.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 150.0, 150.0, 151.0, 149.0, 158.0, 151.0, 151.0, 149.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 56.0, 53.0, 54.0, 53.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 76.0, 84.0, 76.0, 76.0, 75.0, 76.0, 76.0, 75.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 120.0, 121.0, 119.0, 128.0, 133.0, 127.0, 121.0, 121.0, 155.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 179.0, 172.0, 176.0, 187.0, 211.0, 173.0, 175.0, 172.0, 178.0], "value": 180.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 67.0, 71.0, 68.0, 66.0, 72.0, 69.0, 66.0, 66.0, 70.0], "value": 69.0, "unit": "score"}]}]} 11:23:34 INFO - Return code: 0 11:23:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:23:34 INFO - # TBPL SUCCESS # 11:23:34 INFO - Running post-action listener: _package_coverage_data 11:23:34 INFO - Running post-action listener: _resource_record_post_action 11:23:34 INFO - [mozharness: 2017-08-17 18:23:34.114265Z] Finished run-tests step (success) 11:23:34 INFO - Running post-run listener: _resource_record_post_run 11:23:34 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431513600; Read time: 12; Write time: 457848 11:23:34 INFO - TinderboxPrint: CPU usage
13.1% 11:23:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:23:34 INFO - TinderboxPrint: I/O write bytes / time
431,513,600 / 457,848 11:23:34 INFO - TinderboxPrint: CPU idle
8,269.1 (86.9%) 11:23:34 INFO - TinderboxPrint: CPU user
1,197.3 (12.6%) 11:23:34 INFO - TinderboxPrint: Swap in / out
0 / 0 11:23:34 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107814912; Read time: 0; Write time: 117984 11:23:34 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:23:34 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 323698688; Read time: 0; Write time: 339864 11:23:34 INFO - Running post-run listener: _upload_blobber_files 11:23:34 INFO - Blob upload gear active. 11:23:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:23:34 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 11:23:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:23:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:23:35 INFO - (blobuploader) - INFO - Open directory for files ... 11:23:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:23:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:23:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:36 INFO - (blobuploader) - INFO - Done attempting. 11:23:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:23:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:23:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:37 INFO - (blobuploader) - INFO - Done attempting. 11:23:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:23:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:23:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:37 INFO - (blobuploader) - INFO - Done attempting. 11:23:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:23:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:23:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:23:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:23:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:23:44 INFO - (blobuploader) - INFO - Done attempting. 11:23:44 INFO - (blobuploader) - INFO - Iteration through files over. 11:23:44 INFO - Return code: 0 11:23:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:23:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:23:44 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db789d44baf3da469c7e300c84cade47dfddc9323233ebff396e8f11cc5ccbd5c528fd02127ac1a415e42d925187fc962562eea47b147eb4c540e9e47ec93e72", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c496c0db6fe8d98ff003e02238c0038c1566a164ea1f7a3f839cee8451bb4098f68de0f0eaf7c5aa6e42b1597adb8c811f33424ae71405e15e34a9abfb7a54ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3034f566298b731325c73b1f8577c7b1109be9d1de49c3b8911c81052cf6781ff4d314ecbd3c7e94485ae11a6c2446c7ad2deff50589587f575cc4a86ac4e380", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7870fe756ef8c700592229ff420e4b5b294c811f7f4959a2c529419848e098b69b5eb13ff675e765f4ad0b048c4a646bbc17c21034d4f762f918064d930a480a"} 11:23:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:23:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:23:44 INFO - Contents: 11:23:44 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db789d44baf3da469c7e300c84cade47dfddc9323233ebff396e8f11cc5ccbd5c528fd02127ac1a415e42d925187fc962562eea47b147eb4c540e9e47ec93e72", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c496c0db6fe8d98ff003e02238c0038c1566a164ea1f7a3f839cee8451bb4098f68de0f0eaf7c5aa6e42b1597adb8c811f33424ae71405e15e34a9abfb7a54ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3034f566298b731325c73b1f8577c7b1109be9d1de49c3b8911c81052cf6781ff4d314ecbd3c7e94485ae11a6c2446c7ad2deff50589587f575cc4a86ac4e380", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7870fe756ef8c700592229ff420e4b5b294c811f7f4959a2c529419848e098b69b5eb13ff675e765f4ad0b048c4a646bbc17c21034d4f762f918064d930a480a"} 11:23:44 INFO - Running post-run listener: copy_logs_to_upload_dir 11:23:44 INFO - Copying logs to upload dir... 11:23:44 INFO - mkdir: /builds/slave/test/build/upload/logs 11:23:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.712911 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-17 11:23:44.551455) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:23:44.554311) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db789d44baf3da469c7e300c84cade47dfddc9323233ebff396e8f11cc5ccbd5c528fd02127ac1a415e42d925187fc962562eea47b147eb4c540e9e47ec93e72", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c496c0db6fe8d98ff003e02238c0038c1566a164ea1f7a3f839cee8451bb4098f68de0f0eaf7c5aa6e42b1597adb8c811f33424ae71405e15e34a9abfb7a54ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3034f566298b731325c73b1f8577c7b1109be9d1de49c3b8911c81052cf6781ff4d314ecbd3c7e94485ae11a6c2446c7ad2deff50589587f575cc4a86ac4e380", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7870fe756ef8c700592229ff420e4b5b294c811f7f4959a2c529419848e098b69b5eb13ff675e765f4ad0b048c4a646bbc17c21034d4f762f918064d930a480a"} build_url:https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/cTdeNkkcRCqHXVCQPBeYMQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/db789d44baf3da469c7e300c84cade47dfddc9323233ebff396e8f11cc5ccbd5c528fd02127ac1a415e42d925187fc962562eea47b147eb4c540e9e47ec93e72", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c496c0db6fe8d98ff003e02238c0038c1566a164ea1f7a3f839cee8451bb4098f68de0f0eaf7c5aa6e42b1597adb8c811f33424ae71405e15e34a9abfb7a54ed", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3034f566298b731325c73b1f8577c7b1109be9d1de49c3b8911c81052cf6781ff4d314ecbd3c7e94485ae11a6c2446c7ad2deff50589587f575cc4a86ac4e380", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7870fe756ef8c700592229ff420e4b5b294c811f7f4959a2c529419848e098b69b5eb13ff675e765f4ad0b048c4a646bbc17c21034d4f762f918064d930a480a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-17 11:23:44.581364) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:23:44.581722) ========= 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=ba164b0a7b0ec7655860e956000001c1-1502981953.672521-205958247 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-17 11:23:44.669629) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:23:44.669948) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-17 11:23:44.670234) ========= ========= Total master_lag: 0.59 =========