builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-010 starttime: 1504693483.52 results: success (0) revision: c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:43.519745) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:43.520197) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:43.520480) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:43.533018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:43.533358) ========= 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=eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-06 03:24:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.0M=0s 2017-09-06 03:24:44 (54.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126303 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:43.673842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:43.674154) ========= 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=eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019259 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:43.727819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:43.730178) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e --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 c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e --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=eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-06 03:24:44,139 truncating revision to first 12 chars 2017-09-06 03:24:44,139 Setting DEBUG logging. 2017-09-06 03:24:44,139 attempt 1/10 2017-09-06 03:24:44,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c6e59f1b2e27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-06 03:24:44,558 unpacking tar archive at: mozilla-central-c6e59f1b2e27/testing/mozharness/ program finished with exit code 0 elapsedTime=0.759737 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:44.504707) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:44.505026) ========= script_repo_revision: c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:44.505386) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:44.505663) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-06 03:24:44.523493) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-06 03:24:44.523895) ========= /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=eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:24:45 INFO - MultiFileLogger online at 20170906 03:24:45 in /builds/slave/test 03:24:45 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 03:24:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:24:45 INFO - {'append_to_log': False, 03:24:45 INFO - 'base_work_dir': '/builds/slave/test', 03:24:45 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:24:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:24:45 INFO - 'branch': 'Firefox-Non-PGO', 03:24:45 INFO - 'buildbot_json_path': 'buildprops.json', 03:24:45 INFO - 'code_coverage': False, 03:24:45 INFO - 'config_files': ('talos/linux_config.py',), 03:24:45 INFO - 'default_actions': ('clobber', 03:24:45 INFO - 'read-buildbot-config', 03:24:45 INFO - 'download-and-extract', 03:24:45 INFO - 'populate-webroot', 03:24:45 INFO - 'create-virtualenv', 03:24:45 INFO - 'install', 03:24:45 INFO - 'setup-mitmproxy', 03:24:45 INFO - 'run-tests'), 03:24:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:24:45 INFO - 'disable_ccov_upload': False, 03:24:45 INFO - 'disable_stylo': False, 03:24:45 INFO - 'download_minidump_stackwalk': True, 03:24:45 INFO - 'download_symbols': 'ondemand', 03:24:45 INFO - 'enable_stylo': False, 03:24:45 INFO - 'enable_webrender': False, 03:24:45 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 03:24:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:24:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:24:45 INFO - 'gecko_profile': False, 03:24:45 INFO - 'gecko_profile_interval': 0, 03:24:45 INFO - 'installer_path': 'installer.exe', 03:24:45 INFO - 'log_level': 'info', 03:24:45 INFO - 'log_name': 'talos', 03:24:45 INFO - 'log_to_console': True, 03:24:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:24:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:24:45 INFO - 'opt_config_files': (), 03:24:45 INFO - 'pip_index': False, 03:24:45 INFO - 'suite': 'dromaeojs-e10s', 03:24:45 INFO - 'system_bits': '32', 03:24:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:24:45 INFO - 'title': 'talos-linux64-ix-010', 03:24:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:24:45 INFO - 'use_talos_json': True, 03:24:45 INFO - 'verify': 'False', 03:24:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:24:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:24:45 INFO - 'work_dir': 'build'} 03:24:45 INFO - [mozharness: 2017-09-06 10:24:45.069470Z] Running clobber step. 03:24:45 INFO - Running pre-action listener: _resource_record_pre_action 03:24:45 INFO - Running main action method: clobber 03:24:45 INFO - rmtree: /builds/slave/test/build 03:24:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:24:46 INFO - Running post-action listener: _resource_record_post_action 03:24:46 INFO - [mozharness: 2017-09-06 10:24:46.144912Z] Finished clobber step (success) 03:24:46 INFO - [mozharness: 2017-09-06 10:24:46.145011Z] Running read-buildbot-config step. 03:24:46 INFO - Running pre-action listener: _resource_record_pre_action 03:24:46 INFO - Running main action method: read_buildbot_config 03:24:46 INFO - Using buildbot properties: 03:24:46 INFO - { 03:24:46 INFO - "project": "", 03:24:46 INFO - "product": "firefox", 03:24:46 INFO - "who": "archaeopteryx@coole-files.de", 03:24:46 INFO - "installer_path": "public/build/target.tar.bz2", 03:24:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:24:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:24:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:24:46 INFO - "stage_platform": "linux64", 03:24:46 INFO - "basedir": "/builds/slave/test", 03:24:46 INFO - "buildnumber": 811, 03:24:46 INFO - "platform": "ubuntu64_hw", 03:24:46 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:24:46 INFO - "slavebuilddir": "test", 03:24:46 INFO - "taskId": "aj5NKtd0TqqcIX4JKj-uzQ", 03:24:46 INFO - "branch": "mozilla-central", 03:24:46 INFO - "script_repo_revision": "production", 03:24:46 INFO - "revision": "c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e", 03:24:46 INFO - "slavename": "talos-linux64-ix-010", 03:24:46 INFO - "repo_path": "mozilla-central" 03:24:46 INFO - } 03:24:46 INFO - Finding installer, test and symbols from parent task. 03:24:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aj5NKtd0TqqcIX4JKj-uzQ'}, attempt #1 03:24:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aj5NKtd0TqqcIX4JKj-uzQ'}, attempt #1 03:24:47 INFO - Task dependencies: dt_5wMQwQieSp4r1UgpK9Q 03:24:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q'}, attempt #1 03:24:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2 03:24:47 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.test_packages.json 03:24:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.crashreporter-symbols.zip 03:24:47 INFO - Running post-action listener: _resource_record_post_action 03:24:47 INFO - [mozharness: 2017-09-06 10:24:47.502709Z] Finished read-buildbot-config step (success) 03:24:47 INFO - [mozharness: 2017-09-06 10:24:47.502927Z] Running download-and-extract step. 03:24:47 INFO - Running pre-action listener: _resource_record_pre_action 03:24:47 INFO - Running main action method: download_and_extract 03:24:47 INFO - mkdir: /builds/slave/test/build/tests 03:24:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:24:47 INFO - trying https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.test_packages.json 03:24:47 INFO - Downloading https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:24:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:24:48 INFO - Downloaded 989 bytes. 03:24:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:24:48 INFO - Using the following test package requirements: 03:24:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:24:48 INFO - u'common': [u'target.common.tests.zip'], 03:24:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:24:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:24:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:24:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:24:48 INFO - u'mozbase': [u'target.common.tests.zip'], 03:24:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:24:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:24:48 INFO - u'web-platform': [u'target.common.tests.zip', 03:24:48 INFO - u'target.web-platform.tests.tar.gz'], 03:24:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:24:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:24:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.common.tests.zip 03:24:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:24:48 INFO - Fetch https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.common.tests.zip into memory 03:24:49 INFO - Content-Length response header: 55020032 03:24:49 INFO - Bytes received: 55020032 03:25:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:25:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.common.tests.zip 03:25:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:25:00 INFO - Fetch https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.common.tests.zip into memory 03:25:01 INFO - Content-Length response header: 55020032 03:25:01 INFO - Bytes received: 55020032 03:25:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.talos.tests.zip 03:25:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:25:13 INFO - Fetch https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.talos.tests.zip into memory 03:25:13 INFO - Content-Length response header: 14496665 03:25:13 INFO - Bytes received: 14496665 03:25:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:14 INFO - trying https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2 03:25:14 INFO - Downloading https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:25:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:25:15 INFO - Downloaded 62781728 bytes. 03:25:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2 03:25:15 INFO - mkdir: /builds/slave/test/properties 03:25:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:25:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:25:15 INFO - Contents: 03:25:15 INFO - build_url:https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2 03:25:15 INFO - Running post-action listener: _resource_record_post_action 03:25:15 INFO - Running post-action listener: find_tests_for_verification 03:25:15 INFO - Running post-action listener: set_extra_try_arguments 03:25:15 INFO - [mozharness: 2017-09-06 10:25:15.357340Z] Finished download-and-extract step (success) 03:25:15 INFO - [mozharness: 2017-09-06 10:25:15.357437Z] Running populate-webroot step. 03:25:15 INFO - Running pre-action listener: _resource_record_pre_action 03:25:15 INFO - Running main action method: populate_webroot 03:25:15 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:25:15 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:15 INFO - 'tests': ['tresize', 03:25:15 INFO - 'tcanvasmark']}, 03:25:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:25:15 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:15 INFO - 'tests': ['dromaeo_css', 03:25:15 INFO - 'kraken']}, 03:25:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:25:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:15 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:15 INFO - 'talos_options': ['--disable-stylo'], 03:25:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:25:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:25:15 INFO - 'tests': ['damp', 'tps']}, 03:25:15 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:15 INFO - 'talos_options': ['--disable-stylo'], 03:25:15 INFO - 'tests': ['damp', 'tps']}, 03:25:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:25:15 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:15 INFO - 'tests': ['dromaeo_dom']}, 03:25:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:25:15 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:15 INFO - 'tests': ['basic_compositor_video', 03:25:15 INFO - 'glvideo']}, 03:25:15 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:25:15 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:25:15 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:15 INFO - 'talos_options': ['--disable-stylo'], 03:25:15 INFO - 'tests': ['ts_paint_webext', 03:25:15 INFO - 'tp5o_webext']}, 03:25:15 INFO - 'other-e10s': {'tests': ['a11yr', 03:25:15 INFO - 'ts_paint', 03:25:15 INFO - 'tpaint', 03:25:15 INFO - 'sessionrestore', 03:25:15 INFO - 'sessionrestore_many_windows', 03:25:15 INFO - 'sessionrestore_no_auto_restore', 03:25:15 INFO - 'tabpaint']}, 03:25:15 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:15 INFO - 'tests': ['a11yr', 03:25:15 INFO - 'ts_paint', 03:25:15 INFO - 'tpaint', 03:25:15 INFO - 'sessionrestore', 03:25:15 INFO - 'sessionrestore_many_windows', 03:25:15 INFO - 'sessionrestore_no_auto_restore', 03:25:15 INFO - 'tabpaint']}, 03:25:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:25:15 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:25:15 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:15 INFO - 'tests': ['bloom_basic_singleton']}, 03:25:15 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:15 INFO - 'tests': ['bloom_basic']}, 03:25:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:25:15 INFO - 'tsvgr_opacity', 03:25:15 INFO - 'tart', 03:25:15 INFO - 'tscrollx', 03:25:15 INFO - 'tsvg_static']}, 03:25:15 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 03:25:15 INFO - 'tests': ['tsvgx', 03:25:15 INFO - 'tsvgr_opacity', 03:25:15 INFO - 'tart', 03:25:15 INFO - 'tscrollx', 03:25:15 INFO - 'tsvg_static']}, 03:25:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:25:15 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:15 INFO - 'talos_options': ['--disable-stylo'], 03:25:15 INFO - 'tests': ['tp5o']}, 03:25:15 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:15 INFO - 'talos_options': ['--mitmproxy', 03:25:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:15 INFO - '--firstNonBlankPaint'], 03:25:15 INFO - 'tests': ['tp6_google', 03:25:15 INFO - 'tp6_youtube', 03:25:15 INFO - 'tp6_amazon', 03:25:15 INFO - 'tp6_facebook']}, 03:25:15 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:15 INFO - 'talos_options': ['--disable-stylo', 03:25:15 INFO - '--mitmproxy', 03:25:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:15 INFO - '--firstNonBlankPaint'], 03:25:15 INFO - 'tests': ['tp6_google', 03:25:15 INFO - 'tp6_youtube', 03:25:15 INFO - 'tp6_amazon', 03:25:15 INFO - 'tp6_facebook']}, 03:25:15 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:25:15 INFO - 'talos_options': ['--stylo-threads=1', 03:25:15 INFO - '--mitmproxy', 03:25:15 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:25:15 INFO - '--firstNonBlankPaint'], 03:25:15 INFO - 'tests': ['tp6_google', 03:25:15 INFO - 'tp6_youtube', 03:25:15 INFO - 'tp6_amazon', 03:25:15 INFO - 'tp6_facebook']}, 03:25:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:25:15 INFO - 'talos_options': ['--xperf_path', 03:25:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:15 INFO - 'tests': ['tp5n']}, 03:25:15 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 03:25:15 INFO - 'talos_options': ['--disable-stylo', 03:25:15 INFO - '--xperf_path', 03:25:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:25:15 INFO - 'tests': ['tp5n']}}} 03:25:15 INFO - Running post-action listener: _resource_record_post_action 03:25:15 INFO - [mozharness: 2017-09-06 10:25:15.372368Z] Finished populate-webroot step (success) 03:25:15 INFO - [mozharness: 2017-09-06 10:25:15.372458Z] Running create-virtualenv step. 03:25:15 INFO - Running pre-action listener: _resource_record_pre_action 03:25:15 INFO - Running main action method: create_virtualenv 03:25:15 INFO - Creating virtualenv /builds/slave/test/build/venv 03:25:15 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:25:15 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 03:25:15 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:25:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:25:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:25:15 INFO - Installing distribute.............................................................................................................................................................................................done. 03:25:16 INFO - Installing pip...............done. 03:25:16 INFO - Return code: 0 03:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:25:16 INFO - Reading from file tmpfile_stdout 03:25:16 INFO - Output received: 03:25:16 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 03:25:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:25:16 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')]} 03:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:16 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')]} 03:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:16 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 0x13f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1769090>, '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 0x1769d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', '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 03:25:16 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 03:25:16 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 03:25:16 INFO - Using env: {'DISPLAY': ':0', 03:25:16 INFO - 'HOME': '/home/cltbld', 03:25:16 INFO - 'LANG': 'en_US.UTF-8', 03:25:16 INFO - 'LANGUAGE': 'en_US:en', 03:25:16 INFO - 'LOGNAME': 'cltbld', 03:25:16 INFO - 'MAIL': '/var/mail/cltbld', 03:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:16 INFO - 'MOZ_NO_REMOTE': '1', 03:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:16 INFO - 'NO_EM_RESTART': '1', 03:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:16 INFO - 'PWD': '/builds/slave/test', 03:25:16 INFO - 'SHELL': '/bin/bash', 03:25:16 INFO - 'SHLVL': '1', 03:25:16 INFO - 'TERM': 'linux', 03:25:16 INFO - 'TMOUT': '86400', 03:25:16 INFO - 'USER': 'cltbld', 03:25:16 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:16 INFO - '_': '/tools/buildbot/bin/python'} 03:25:17 INFO - Ignoring indexes: http://pypi.python.org/simple/ 03:25:17 INFO - Downloading/unpacking pip>=1.5 03:25:17 INFO - Running setup.py egg_info for package pip 03:25:17 INFO - warning: no files found matching 'pip/cacert.pem' 03:25:17 INFO - warning: no files found matching '*.html' under directory 'docs' 03:25:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:25:17 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:25:17 INFO - Installing collected packages: pip 03:25:17 INFO - Found existing installation: pip 1.1 03:25:17 INFO - Uninstalling pip: 03:25:17 INFO - Successfully uninstalled pip 03:25:17 INFO - Running setup.py install for pip 03:25:17 INFO - warning: no files found matching 'pip/cacert.pem' 03:25:17 INFO - warning: no files found matching '*.html' under directory 'docs' 03:25:17 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 03:25:17 INFO - no previously-included directories found matching 'docs/_build/_sources' 03:25:17 INFO - Installing pip script to /builds/slave/test/build/venv/bin 03:25:17 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 03:25:17 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 03:25:17 INFO - Successfully installed pip 03:25:17 INFO - Cleaning up... 03:25:17 INFO - Return code: 0 03:25:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1769090>, '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 0x1769d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', '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 03:25:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:25:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:25:17 INFO - Using env: {'DISPLAY': ':0', 03:25:17 INFO - 'HOME': '/home/cltbld', 03:25:17 INFO - 'LANG': 'en_US.UTF-8', 03:25:17 INFO - 'LANGUAGE': 'en_US:en', 03:25:17 INFO - 'LOGNAME': 'cltbld', 03:25:17 INFO - 'MAIL': '/var/mail/cltbld', 03:25:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:17 INFO - 'MOZ_NO_REMOTE': '1', 03:25:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:17 INFO - 'NO_EM_RESTART': '1', 03:25:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:17 INFO - 'PWD': '/builds/slave/test', 03:25:17 INFO - 'SHELL': '/bin/bash', 03:25:17 INFO - 'SHLVL': '1', 03:25:17 INFO - 'TERM': 'linux', 03:25:17 INFO - 'TMOUT': '86400', 03:25:17 INFO - 'USER': 'cltbld', 03:25:17 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:25:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:17 INFO - '_': '/tools/buildbot/bin/python'} 03:25:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:17 INFO - Downloading/unpacking psutil>=3.1.1 03:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:25:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:18 INFO - Installing collected packages: psutil 03:25:18 INFO - Running setup.py install for psutil 03:25:19 INFO - building 'psutil._psutil_linux' extension 03:25:19 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 03:25:19 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 03:25:19 INFO - building 'psutil._psutil_posix' extension 03:25:19 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 03:25:19 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 03:25:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:25:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:25:19 INFO - Successfully installed psutil 03:25:19 INFO - Cleaning up... 03:25:19 INFO - Return code: 0 03:25:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:19 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 0x13f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1769090>, '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 0x1769d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', '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 03:25:19 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 03:25:19 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 03:25:19 INFO - Using env: {'DISPLAY': ':0', 03:25:19 INFO - 'HOME': '/home/cltbld', 03:25:19 INFO - 'LANG': 'en_US.UTF-8', 03:25:19 INFO - 'LANGUAGE': 'en_US:en', 03:25:19 INFO - 'LOGNAME': 'cltbld', 03:25:19 INFO - 'MAIL': '/var/mail/cltbld', 03:25:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:19 INFO - 'MOZ_NO_REMOTE': '1', 03:25:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:19 INFO - 'NO_EM_RESTART': '1', 03:25:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:19 INFO - 'PWD': '/builds/slave/test', 03:25:19 INFO - 'SHELL': '/bin/bash', 03:25:19 INFO - 'SHLVL': '1', 03:25:19 INFO - 'TERM': 'linux', 03:25:19 INFO - 'TMOUT': '86400', 03:25:19 INFO - 'USER': 'cltbld', 03:25:19 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:25:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:19 INFO - '_': '/tools/buildbot/bin/python'} 03:25:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:25:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:25:20 INFO - Installing collected packages: mozsystemmonitor 03:25:20 INFO - Running setup.py install for mozsystemmonitor 03:25:20 INFO - Successfully installed mozsystemmonitor 03:25:20 INFO - Cleaning up... 03:25:21 INFO - Return code: 0 03:25:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:25:21 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')]} 03:25:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:21 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')]} 03:25:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:21 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 0x13f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1769090>, '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 0x1769d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', '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 03:25:21 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 03:25:21 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 03:25:21 INFO - Using env: {'DISPLAY': ':0', 03:25:21 INFO - 'HOME': '/home/cltbld', 03:25:21 INFO - 'LANG': 'en_US.UTF-8', 03:25:21 INFO - 'LANGUAGE': 'en_US:en', 03:25:21 INFO - 'LOGNAME': 'cltbld', 03:25:21 INFO - 'MAIL': '/var/mail/cltbld', 03:25:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:21 INFO - 'MOZ_NO_REMOTE': '1', 03:25:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:21 INFO - 'NO_EM_RESTART': '1', 03:25:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:21 INFO - 'PWD': '/builds/slave/test', 03:25:21 INFO - 'SHELL': '/bin/bash', 03:25:21 INFO - 'SHLVL': '1', 03:25:21 INFO - 'TERM': 'linux', 03:25:21 INFO - 'TMOUT': '86400', 03:25:21 INFO - 'USER': 'cltbld', 03:25:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:25:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:21 INFO - '_': '/tools/buildbot/bin/python'} 03:25:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:21 INFO - Downloading/unpacking jsonschema==2.5.1 03:25:21 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 03:25:21 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 03:25:21 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 03:25:21 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 03:25:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:25:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:25:22 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 03:25:22 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 03:25:22 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 03:25:22 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 03:25:22 INFO - Downloading functools32-3.2.3-2.tar.gz 03:25:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:25:22 INFO - warning: no files found matching '*.txt' 03:25:22 INFO - no previously-included directories found matching 'build' 03:25:22 INFO - no previously-included directories found matching 'dist' 03:25:22 INFO - no previously-included directories found matching '.git*' 03:25:22 INFO - Installing collected packages: jsonschema, functools32 03:25:22 INFO - Running setup.py install for functools32 03:25:22 INFO - warning: no files found matching '*.txt' 03:25:22 INFO - no previously-included directories found matching 'build' 03:25:22 INFO - no previously-included directories found matching 'dist' 03:25:22 INFO - no previously-included directories found matching '.git*' 03:25:22 INFO - Successfully installed jsonschema functools32 03:25:22 INFO - Cleaning up... 03:25:22 INFO - Return code: 0 03:25:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25: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')]} 03:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25: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', '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 0x13f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1769090>, '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 0x1769d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', '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 03:25: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:25: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 functools32==3.2.3-2 03:25:22 INFO - Using env: {'DISPLAY': ':0', 03:25:22 INFO - 'HOME': '/home/cltbld', 03:25:22 INFO - 'LANG': 'en_US.UTF-8', 03:25:22 INFO - 'LANGUAGE': 'en_US:en', 03:25:22 INFO - 'LOGNAME': 'cltbld', 03:25:22 INFO - 'MAIL': '/var/mail/cltbld', 03:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:22 INFO - 'MOZ_NO_REMOTE': '1', 03:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:22 INFO - 'NO_EM_RESTART': '1', 03:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:22 INFO - 'PWD': '/builds/slave/test', 03:25:22 INFO - 'SHELL': '/bin/bash', 03:25:22 INFO - 'SHLVL': '1', 03:25:22 INFO - 'TERM': 'linux', 03:25:22 INFO - 'TMOUT': '86400', 03:25:22 INFO - 'USER': 'cltbld', 03:25:22 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:22 INFO - '_': '/tools/buildbot/bin/python'} 03:25:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:25:22 INFO - Cleaning up... 03:25:22 INFO - Return code: 0 03:25:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25: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')]} 03:25:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25: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', '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 0x13f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1769090>, '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 0x1769d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', '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 03:25: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:25: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 blobuploader==1.2.4 03:25:22 INFO - Using env: {'DISPLAY': ':0', 03:25:22 INFO - 'HOME': '/home/cltbld', 03:25:22 INFO - 'LANG': 'en_US.UTF-8', 03:25:22 INFO - 'LANGUAGE': 'en_US:en', 03:25:22 INFO - 'LOGNAME': 'cltbld', 03:25:22 INFO - 'MAIL': '/var/mail/cltbld', 03:25:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:22 INFO - 'MOZ_NO_REMOTE': '1', 03:25:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:22 INFO - 'NO_EM_RESTART': '1', 03:25:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:22 INFO - 'PWD': '/builds/slave/test', 03:25:22 INFO - 'SHELL': '/bin/bash', 03:25:22 INFO - 'SHLVL': '1', 03:25:22 INFO - 'TERM': 'linux', 03:25:22 INFO - 'TMOUT': '86400', 03:25:22 INFO - 'USER': 'cltbld', 03:25:22 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:25:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:22 INFO - '_': '/tools/buildbot/bin/python'} 03:25:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:23 INFO - Downloading/unpacking blobuploader==1.2.4 03:25: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 03:25: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 03:25: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 03:25: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 03:25:24 INFO - Downloading blobuploader-1.2.4.tar.gz 03:25:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:25:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:25:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:24 INFO - Downloading docopt-0.6.1.tar.gz 03:25:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:25:24 INFO - Installing collected packages: blobuploader, requests, docopt 03:25:24 INFO - Running setup.py install for blobuploader 03:25:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:25:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:25:24 INFO - Running setup.py install for requests 03:25:25 INFO - Running setup.py install for docopt 03:25:25 INFO - Successfully installed blobuploader requests docopt 03:25:25 INFO - Cleaning up... 03:25:25 INFO - Return code: 0 03:25:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:25 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')]} 03:25:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:25 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')]} 03:25:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:25 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 0x13f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1769090>, '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 0x1769d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', '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 03:25:25 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 03:25:25 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 03:25:25 INFO - Using env: {'DISPLAY': ':0', 03:25:25 INFO - 'HOME': '/home/cltbld', 03:25:25 INFO - 'LANG': 'en_US.UTF-8', 03:25:25 INFO - 'LANGUAGE': 'en_US:en', 03:25:25 INFO - 'LOGNAME': 'cltbld', 03:25:25 INFO - 'MAIL': '/var/mail/cltbld', 03:25:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:25 INFO - 'MOZ_NO_REMOTE': '1', 03:25:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:25 INFO - 'NO_EM_RESTART': '1', 03:25:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:25 INFO - 'PWD': '/builds/slave/test', 03:25:25 INFO - 'SHELL': '/bin/bash', 03:25:25 INFO - 'SHLVL': '1', 03:25:25 INFO - 'TERM': 'linux', 03:25:25 INFO - 'TMOUT': '86400', 03:25:25 INFO - 'USER': 'cltbld', 03:25:25 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:25:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:25 INFO - '_': '/tools/buildbot/bin/python'} 03:25:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:25 INFO - Running setup.py (path:/tmp/pip-ITuvds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:25 INFO - Running setup.py (path:/tmp/pip-5m60OD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:25 INFO - Running setup.py (path:/tmp/pip-GqDWAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:25 INFO - Running setup.py (path:/tmp/pip-b_sXgo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:25 INFO - Running setup.py (path:/tmp/pip-AoS7UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:25 INFO - Running setup.py (path:/tmp/pip-Ad_Z4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:26 INFO - Running setup.py (path:/tmp/pip-sPt8y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:26 INFO - Running setup.py (path:/tmp/pip-gR_uAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:26 INFO - Running setup.py (path:/tmp/pip-ywxWzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:26 INFO - Running setup.py (path:/tmp/pip-xUtXr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:26 INFO - Running setup.py (path:/tmp/pip-Gm_5Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:26 INFO - Running setup.py (path:/tmp/pip-OiT8bS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:26 INFO - Running setup.py (path:/tmp/pip-wXuGZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:26 INFO - Running setup.py (path:/tmp/pip-UzaxJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:26 INFO - Running setup.py (path:/tmp/pip-8ciLBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:26 INFO - Running setup.py (path:/tmp/pip-J9qqWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:26 INFO - Running setup.py (path:/tmp/pip-DJfLU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:25:26 INFO - Running setup.py install for manifestparser 03:25:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:25:26 INFO - Running setup.py install for mozcrash 03:25:27 INFO - Running setup.py install for mozdebug 03:25:27 INFO - Running setup.py install for mozdevice 03:25:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:25:27 INFO - Running setup.py install for mozfile 03:25:27 INFO - Running setup.py install for mozhttpd 03:25:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:25:27 INFO - Running setup.py install for mozinfo 03:25:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:25:27 INFO - Running setup.py install for mozInstall 03:25:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:25:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:25:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:25:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:25:27 INFO - Running setup.py install for mozleak 03:25:27 INFO - Running setup.py install for mozlog 03:25:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:25:27 INFO - Running setup.py install for moznetwork 03:25:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:25:27 INFO - Running setup.py install for mozprocess 03:25:28 INFO - Running setup.py install for mozprofile 03:25:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:25:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:25:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:25:28 INFO - Running setup.py install for mozrunner 03:25:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:25:28 INFO - Running setup.py install for mozscreenshot 03:25:28 INFO - Running setup.py install for moztest 03:25:28 INFO - Running setup.py install for mozversion 03:25:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:25:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:25:28 INFO - Cleaning up... 03:25:28 INFO - Return code: 0 03:25:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25: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')]} 03:25:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:28 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 0x13f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1769090>, '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 0x1769d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', '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 03:25:28 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 03:25:28 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 03:25:28 INFO - Using env: {'DISPLAY': ':0', 03:25:28 INFO - 'HOME': '/home/cltbld', 03:25:28 INFO - 'LANG': 'en_US.UTF-8', 03:25:28 INFO - 'LANGUAGE': 'en_US:en', 03:25:28 INFO - 'LOGNAME': 'cltbld', 03:25:28 INFO - 'MAIL': '/var/mail/cltbld', 03:25:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:28 INFO - 'MOZ_NO_REMOTE': '1', 03:25:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:28 INFO - 'NO_EM_RESTART': '1', 03:25:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:28 INFO - 'PWD': '/builds/slave/test', 03:25:28 INFO - 'SHELL': '/bin/bash', 03:25:28 INFO - 'SHLVL': '1', 03:25:28 INFO - 'TERM': 'linux', 03:25:28 INFO - 'TMOUT': '86400', 03:25:28 INFO - 'USER': 'cltbld', 03:25:28 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:25:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:28 INFO - '_': '/tools/buildbot/bin/python'} 03:25:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:25:28 INFO - Running setup.py (path:/tmp/pip-pWk1ss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:25:28 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)) 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:25:28 INFO - Running setup.py (path:/tmp/pip-9AHe34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:25:28 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)) 03:25:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:25:28 INFO - Running setup.py (path:/tmp/pip-SE88rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:25:29 INFO - Running setup.py (path:/tmp/pip-UfNQgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:25:29 INFO - Running setup.py (path:/tmp/pip-Nu2X0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:25:29 INFO - Running setup.py (path:/tmp/pip-08xt81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:25:29 INFO - Running setup.py (path:/tmp/pip-ZQYM2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:25:29 INFO - Running setup.py (path:/tmp/pip-6WIo37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:25:29 INFO - Running setup.py (path:/tmp/pip-3__dVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:25:29 INFO - Running setup.py (path:/tmp/pip-PH0vcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:25:29 INFO - Running setup.py (path:/tmp/pip-0xbQ_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:25:29 INFO - Running setup.py (path:/tmp/pip-2uDFTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:25:29 INFO - Running setup.py (path:/tmp/pip-zPuIJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:25:29 INFO - Running setup.py (path:/tmp/pip-LoJ2MZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:29 INFO - Running setup.py (path:/tmp/pip-SmShzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:25:29 INFO - Running setup.py (path:/tmp/pip-88ZAw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:25:29 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)) 03:25:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:25:29 INFO - Running setup.py (path:/tmp/pip-JWf6jE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:25:30 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)) 03:25:30 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)) 03:25:30 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)) 03:25:30 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)) 03:25:30 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)) 03:25:30 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)) 03:25:30 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)) 03:25:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:31 INFO - Downloading blessings-1.6.tar.gz 03:25:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:25:31 INFO - Installing collected packages: blessings 03:25:31 INFO - Running setup.py install for blessings 03:25:31 INFO - Successfully installed blessings 03:25:31 INFO - Cleaning up... 03:25:31 INFO - Return code: 0 03:25:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:25:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:31 INFO - Reading from file tmpfile_stdout 03:25:31 INFO - Current package versions: 03:25:31 INFO - argparse == 1.2.1 03:25:31 INFO - blessings == 1.6 03:25:31 INFO - blobuploader == 1.2.4 03:25:31 INFO - docopt == 0.6.1 03:25:31 INFO - functools32 == 3.2.3-2 03:25:31 INFO - jsonschema == 2.5.1 03:25:31 INFO - manifestparser == 1.1 03:25:31 INFO - mozInstall == 1.13 03:25:31 INFO - mozcrash == 1.0 03:25:31 INFO - mozdebug == 0.1 03:25:31 INFO - mozdevice == 0.51 03:25:31 INFO - mozfile == 1.2 03:25:31 INFO - mozhttpd == 0.7 03:25:31 INFO - mozinfo == 0.10 03:25:31 INFO - mozleak == 0.1 03:25:31 INFO - mozlog == 3.5 03:25:31 INFO - moznetwork == 0.27 03:25:31 INFO - mozprocess == 0.25 03:25:31 INFO - mozprofile == 0.28 03:25:31 INFO - mozrunner == 6.13 03:25:31 INFO - mozscreenshot == 0.1 03:25:31 INFO - mozsystemmonitor == 0.3 03:25:31 INFO - moztest == 0.8 03:25:31 INFO - mozversion == 1.4 03:25:31 INFO - psutil == 3.1.1 03:25:31 INFO - requests == 1.2.3 03:25:31 INFO - wsgiref == 0.1.2 03:25:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:25:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:31 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 0x13f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1769090>, '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 0x1769d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', '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 03:25:31 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 03:25:31 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 03:25:31 INFO - Using env: {'DISPLAY': ':0', 03:25:31 INFO - 'HOME': '/home/cltbld', 03:25:31 INFO - 'LANG': 'en_US.UTF-8', 03:25:31 INFO - 'LANGUAGE': 'en_US:en', 03:25:31 INFO - 'LOGNAME': 'cltbld', 03:25:31 INFO - 'MAIL': '/var/mail/cltbld', 03:25:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:31 INFO - 'MOZ_NO_REMOTE': '1', 03:25:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:31 INFO - 'NO_EM_RESTART': '1', 03:25:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:31 INFO - 'PWD': '/builds/slave/test', 03:25:31 INFO - 'SHELL': '/bin/bash', 03:25:31 INFO - 'SHLVL': '1', 03:25:31 INFO - 'TERM': 'linux', 03:25:31 INFO - 'TMOUT': '86400', 03:25:31 INFO - 'USER': 'cltbld', 03:25:31 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:25:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:31 INFO - '_': '/tools/buildbot/bin/python'} 03:25:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:31 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)) 03:25:31 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)) 03:25:31 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)) 03:25:31 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)) 03:25:31 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)) 03:25:31 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)) 03:25:31 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)) 03:25:31 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)) 03:25:31 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)) 03:25:31 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:25:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:25:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:25:32 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)) 03:25:32 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)) 03:25:32 INFO - Installing collected packages: simplejson 03:25:32 INFO - Running setup.py install for simplejson 03:25:33 INFO - building 'simplejson._speedups' extension 03:25:33 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 03:25:33 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 03:25:33 INFO - Successfully installed simplejson 03:25:33 INFO - Cleaning up... 03:25:33 INFO - Return code: 0 03:25:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:25: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')]} 03:25:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:25: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')]} 03:25:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:25:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15c2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1765a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1769090>, '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 0x1769d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763f90>, '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': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', '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 03:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:25:33 INFO - Using env: {'DISPLAY': ':0', 03:25:33 INFO - 'HOME': '/home/cltbld', 03:25:33 INFO - 'LANG': 'en_US.UTF-8', 03:25:33 INFO - 'LANGUAGE': 'en_US:en', 03:25:33 INFO - 'LOGNAME': 'cltbld', 03:25:33 INFO - 'MAIL': '/var/mail/cltbld', 03:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:33 INFO - 'MOZ_NO_REMOTE': '1', 03:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:33 INFO - 'NO_EM_RESTART': '1', 03:25:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:33 INFO - 'PWD': '/builds/slave/test', 03:25:33 INFO - 'SHELL': '/bin/bash', 03:25:33 INFO - 'SHLVL': '1', 03:25:33 INFO - 'TERM': 'linux', 03:25:33 INFO - 'TMOUT': '86400', 03:25:33 INFO - 'USER': 'cltbld', 03:25:33 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:33 INFO - '_': '/tools/buildbot/bin/python'} 03:25:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:25:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:25:34 INFO - Cleaning up... 03:25:34 INFO - Return code: 0 03:25:34 INFO - Running post-action listener: _resource_record_post_action 03:25:34 INFO - Running post-action listener: _start_resource_monitoring 03:25:34 INFO - Starting resource monitoring. 03:25:34 INFO - [mozharness: 2017-09-06 10:25:34.238162Z] Finished create-virtualenv step (success) 03:25:34 INFO - [mozharness: 2017-09-06 10:25:34.238688Z] Running install step. 03:25:34 INFO - Running pre-action listener: _resource_record_pre_action 03:25:34 INFO - Running main action method: install 03:25:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:25:34 INFO - Reading from file tmpfile_stdout 03:25:34 INFO - Detecting whether we're running mozinstall >=1.0... 03:25:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:25:34 INFO - Reading from file tmpfile_stdout 03:25:34 INFO - Output received: 03:25:34 INFO - Usage: mozinstall [options] installer 03:25:34 INFO - Options: 03:25:34 INFO - -h, --help show this help message and exit 03:25:34 INFO - -d DEST, --destination=DEST 03:25:34 INFO - Directory to install application into. [default: 03:25:34 INFO - "/builds/slave/test"] 03:25:34 INFO - --app=APP Application being installed. [default: firefox] 03:25:34 INFO - mkdir: /builds/slave/test/build/application 03:25:34 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'] 03:25:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:25:52 INFO - Reading from file tmpfile_stdout 03:25:52 INFO - Output received: 03:25:52 INFO - /builds/slave/test/build/application/firefox/firefox 03:25:52 INFO - Running post-action listener: _resource_record_post_action 03:25:52 INFO - [mozharness: 2017-09-06 10:25:52.087629Z] Finished install step (success) 03:25:52 INFO - [mozharness: 2017-09-06 10:25:52.088116Z] Running setup-mitmproxy step. 03:25:52 INFO - Running pre-action listener: _resource_record_pre_action 03:25:52 INFO - Running main action method: setup_mitmproxy 03:25:52 INFO - Skipping: mitmproxy is not required 03:25:52 INFO - Running post-action listener: _resource_record_post_action 03:25:52 INFO - [mozharness: 2017-09-06 10:25:52.089721Z] Finished setup-mitmproxy step (success) 03:25:52 INFO - [mozharness: 2017-09-06 10:25:52.090030Z] Running run-tests step. 03:25:52 INFO - Running pre-action listener: _resource_record_pre_action 03:25:52 INFO - Running pre-action listener: _set_gcov_prefix 03:25:52 INFO - Running main action method: run_tests 03:25:52 WARNING - Try message not found. 03:25:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:25:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:25:52 INFO - Python 2.7.3 03:25:52 INFO - Return code: 0 03:25:52 INFO - grabbing minidump binary from tooltool 03:25: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')]} 03:25:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 0x1769090>, '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 0x1769d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1763f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:25:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 03:25:52 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:25:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--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 03:25:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:25:52 INFO - Return code: 0 03:25:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:25:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:25:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:25:52 INFO - ENV: RUST_BACKTRACE is now full 03:25:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:25:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:25:52 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/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 03:25:52 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/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-010 --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 03:25:52 INFO - Using env: {'DISPLAY': ':0', 03:25:52 INFO - 'HOME': '/home/cltbld', 03:25:52 INFO - 'LANG': 'en_US.UTF-8', 03:25:52 INFO - 'LANGUAGE': 'en_US:en', 03:25:52 INFO - 'LOGNAME': 'cltbld', 03:25:52 INFO - 'MAIL': '/var/mail/cltbld', 03:25:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:25:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:52 INFO - 'MOZ_NO_REMOTE': '1', 03:25:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:52 INFO - 'NO_EM_RESTART': '1', 03:25:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:52 INFO - 'PWD': '/builds/slave/test', 03:25:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:25:52 INFO - 'RUST_BACKTRACE': 'full', 03:25:52 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:25:52 INFO - 'SHELL': '/bin/bash', 03:25:52 INFO - 'SHLVL': '1', 03:25:52 INFO - 'TERM': 'linux', 03:25:52 INFO - 'TMOUT': '86400', 03:25:52 INFO - 'USER': 'cltbld', 03:25:52 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:52 INFO - '_': '/tools/buildbot/bin/python'} 03:25:52 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/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--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 03:25:52 INFO - mozversion application_buildid: 20170906092433 03:25:52 INFO - mozversion application_changeset: c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e 03:25:52 INFO - mozversion application_display_name: Nightly 03:25:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:25:52 INFO - mozversion application_name: Firefox 03:25:52 INFO - mozversion application_remotingname: firefox 03:25:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:25:52 INFO - mozversion application_vendor: Mozilla 03:25:52 INFO - mozversion application_version: 57.0a1 03:25:52 INFO - mozversion platform_buildid: 20170906092433 03:25:52 INFO - mozversion platform_changeset: c6e59f1b2e2720376a94d30ebabf9fcc60e4f87e 03:25:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:25:52 INFO - mozversion platform_version: 57.0a1 03:25:52 INFO - using testdate: 1504693552 03:25:52 INFO - actual date: 1504693552 03:25:52 INFO - starting webserver on 'localhost:48058' 03:25:52 INFO - SUITE-START | Running 2 tests 03:25:52 INFO - TEST-START | dromaeo_css 03:25:52 INFO - Initialising browser for dromaeo_css test... 03:25:52 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48058/getInfo.html -profile /tmp/tmpkzSAEQ/profile 03:25:52 INFO - TEST-INFO | started process 32245 (/builds/slave/test/build/application/firefox/firefox http://localhost:48058/getInfo.html) 03:25:58 INFO - TEST-INFO | 32245: exit 0 03:25:59 INFO - Browser initialized. 03:25:59 INFO - Running cycle 1/1 for dromaeo_css test... 03:25:59 INFO - Using env: {'DISPLAY': ':0', 03:25:59 INFO - 'HOME': '/home/cltbld', 03:25:59 INFO - 'JSGC_DISABLE_POISONING': '1', 03:25:59 INFO - 'LANG': 'en_US.UTF-8', 03:25:59 INFO - 'LANGUAGE': 'en_US:en', 03:25:59 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:25:59 INFO - 'LOGNAME': 'cltbld', 03:25:59 INFO - 'MAIL': '/var/mail/cltbld', 03:25:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:25:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:25:59 INFO - 'MOZ_CRASHREPORTER': '1', 03:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:25:59 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:25:59 INFO - 'MOZ_NO_REMOTE': '1', 03:25:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:25:59 INFO - 'NO_EM_RESTART': '1', 03:25:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:25:59 INFO - 'PWD': '/builds/slave/test', 03:25:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:25:59 INFO - 'RUST_BACKTRACE': 'full', 03:25:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:25:59 INFO - 'SHELL': '/bin/bash', 03:25:59 INFO - 'SHLVL': '1', 03:25:59 INFO - 'TERM': 'linux', 03:25:59 INFO - 'TMOUT': '86400', 03:25:59 INFO - 'USER': 'cltbld', 03:25:59 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:25:59 INFO - '_': '/tools/buildbot/bin/python'} 03:25:59 INFO - TEST-INFO | started process 32446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkzSAEQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:26:00 INFO - PID 32446 | 03:26:00 INFO - PID 32446 | (/builds/slave/test/build/application/firefox/firefox:32499): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:26:00 INFO - PID 32446 | 03:26:10 INFO - PID 32446 | RSS: Main: 170688512 03:26:10 INFO - PID 32446 | 03:29:06 INFO - PID 32446 | Cycle 1(1): loaded http://localhost:48058/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48058/tests/dromaeo/cssquery-ext.html) 03:29:08 INFO - PID 32446 | RSS: Main: 174903296 03:29:08 INFO - PID 32446 | 03:32:10 INFO - PID 32446 | Cycle 1(1): loaded http://localhost:48058/tests/dromaeo/cssquery-ext.html (next: http://localhost:48058/tests/dromaeo/cssquery-jquery.html) 03:32:11 INFO - PID 32446 | RSS: Main: 171094016 03:32:11 INFO - PID 32446 | 03:35:12 INFO - PID 32446 | Cycle 1(1): loaded http://localhost:48058/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48058/tests/dromaeo/cssquery-mootools.html) 03:35:13 INFO - PID 32446 | RSS: Main: 173490176 03:35:13 INFO - PID 32446 | 03:38:15 INFO - PID 32446 | Cycle 1(1): loaded http://localhost:48058/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48058/tests/dromaeo/cssquery-prototype.html) 03:38:15 INFO - PID 32446 | RSS: Main: 172507136 03:38:15 INFO - PID 32446 | 03:41:19 INFO - PID 32446 | Cycle 1(1): loaded http://localhost:48058/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48058/tests/dromaeo/cssquery-yui.html) 03:41:19 INFO - PID 32446 | RSS: Main: 173760512 03:41:19 INFO - PID 32446 | 03:44:21 INFO - PID 32446 | Cycle 1(1): loaded http://localhost:48058/tests/dromaeo/cssquery-yui.html (next: http://localhost:48058/tests/dromaeo/cssquery-dojo.html) 03:44:21 INFO - PID 32446 | RSS: Main: 176222208 03:44:21 INFO - PID 32446 | 03:44:21 INFO - PID 32446 | __start_tp_report 03:44:21 INFO - PID 32446 | _x_x_mozilla_page_load 03:44:21 INFO - PID 32446 | _x_x_mozilla_page_load_details 03:44:21 INFO - PID 32446 | |i|pagename|runs| 03:44:21 INFO - PID 32446 | |0;dojo.html;3250.4799232122864;3251.414745345838;3273.2635157089658;3277.786943848648;3278.803271803692;6345.873082538346;6365.968170159149;6370.108184854124;6380.52146089044;6392.55252132351;6251.624902505853;6318.147050148229;6337.619742815435;6339.366063393658;6364.268109167447;5845.444682755153;5858.88282234355;5865.149553314767;5874.647521148723;5892.204552385416;5918.201042859202;5956.255468066492;5958.79144229952;5960.642361458326;5964.671943043131;5846.356900740936;5888.764449422018;5940.732667029973;5950.345461999176;5962.314333851597;5404.891902161974;5676.86462707456;5754.74103665336;5762.769489220426;5960.791372301992;5794.62334948227;5840.678762668052;5877.235959325303;5909.2908850938165;5916.674582897939;6139.140520327113;6331.262857256956;6368.10846481493;6380.776672816475;6404.583702059398;6732.764353247613;6746.426553742937;6776.220734615484;6785.084013658192;6797.864042719118;6844.28135045818;6848.828779280508;6854.554453960476;6860.759873404457;6873.175218973755;6337.176167098248;6338.714757835908;6344.206974128234;6360.204974378203;6450.161479007699;6977.162740471176;7053.400460960773;7072.92927070733;7073.221945585981;7079.256678048834;6659.766908158192;6670.466362690973;6681.198256209189;6764.627945462948;6766.289539598271;6750.426213771884;6805.761798337035;6824.351686589766;6888.896666550006;6897.62063086525;6828.9658551706925;6887.139107611549;6887.6556172192195;6894.96575513677;6927.965360173167;6773.9322606774285;6816.045753594501;6874.518783685094;6881.65591720412;6932.896006559906;4963.230699241623;4984;5036.899262014739;5040.042391945519;5043.646944713908;4313.676474264443;4386.166628340605;4387.846425375096;4393.868183954486;4412.4043254160915;5912.674802885883;5979.5814292999075;5996.580239383288;6003.489703375175;6014.939850601438;6770.356816102462;6859.5541289816;6944.930550694529;6945.201301850352;6957.756478523227;5912.438318359749;5915.112733089984;5965.403459654087;5966.522678185735;5981.461668449861;5758.683272419973;5850.3272123705465;5854.8536286592325;5863.853403664943;5868.09044598088;6574.737010519621;6625.0724898514245;6655.933440665628;6677.599344039373;6688.39804417595;6761.695723692544;6844.8973265402055;6921.653917304216;6922.134733158356;6975.058367120577;6513.934860651333;6531.673416329069;6534.673266336569;6627.138471998609;6639.136912201383;6760.425363844129;6816.454683625199;6822.488313376417;6832.453403727591;6834.521583489108;6800.863982720417;6845.931540684729;6875.621840798604;6894.690008898293;6897.586144831125;6647.069410282661;6672.733090676318;6681.064650948968;6751.696173672099;6756.256811750802;6539.051837483634;6589.17635295588;6629.5359324846795;6682.365175308338;6686.264510903699;6546.0508226307875;6547.70535325921;6554.63949482783;6557.573757705924;6567.310432404529;6649.833754156185;6657.234418041793;6667.43326817226;6676.699548520425;6787;6501.1548498694865;6521.771737989147;6530.902036469552;6546.803595892131;6550.377714117151 03:44:21 INFO - PID 32446 | |1;ext.html;786.2923368967928;850.914908509149;888.8577827547593;1123.1407972900727;1148.4200478758225;36171.81914090429;39539.80230098846;39624.2075158497;39750.602493975086;39756.80121599388;39737.80131099348;39843.80078099613;40071.59928400715;40168;40184;7368.96315518423;7692.3076923076915;7695.923040769577;7699.422543309246;7699.6920123195005;7486.513376630502;7577.659005344745;7578.924210757877;7582.65878035487;7582.848343033136;7550.056242969629;7622.4664273500875;7626.961865190667;7635.083789945214;7635.541867487941;7542.396608271325;7560.546367217957;7601.8479630407355;7602.049743782028;7604.695812167507;7533.322001019879;7587.544747315179;7588.962055189744;7590.089189297264;7592.658330375147;36113.63886361129;36330.091747706254;36376.27247455063;36462.45306320407;36551.08622284437;3557.786532808014;3595.9101022474388;3597.8560857565667;3600.513930619359;3600.6219346968455;30264.54603180932;30272.54591181134;30304;30311.545326820116;30338.84830575833;5111.386633603955;5126.71803050832;5156.871078223037;5169.56058735008;5240.8689782755355;181714;181846;182399;182444;182995;44631.330530042076;44674.10651786946;44827.55172448299;44847.10305793931;44852.77573612111;49606.75196624066;50421.74789126031;50731.74634126806;50933;50993;11374.31754094757;11636.36000020007;12260.141790074787;12342.074344424203;13879.791803122962;11232.943835280772;11302.943485282522;11307.830382544269;11337.829932551018;11369.431528423545;13911.304434778423;13921.373538190806;13924.721505570034;13943.930280348737;14036.438542458187;5656.8868622627315;5825.213596164548;5900.43945825146;5900.704964751745;5942.346341902387;1004.1213937804421;1018.5671089786811;1033.9327943683636;1034.2760067952313;1046.053321743823;22455.43861403478;23421.882890585777;27719.86140069287;28502;28818.567721484196;1079.881213066562;1094.9014588687057;1098.1160166066234;1098.6209757633603;1103.0844399148687;12112.81830772539;12256.264624122581;12257.26456412618;12383.62849114528;12417.254964702146;247162;250006;250057;250252;250301;48278;48372.51627483751;48652.27021594608;48680.513194868305;48800.511994880304;1404.0522647213295;1416.5679467762432;1418.2554159066572;1434.189682829219;1436.0737324425895;22020.11919523201;22058.558828823014;22082.447938801015;22218.131706855904;22437.43906402353;31908.36183276368;32269.838650806596;35974.28051439009;35992.28015439624;36022;204425;205519;205602;205655;206002;28005.299867503476;28685.139445816658;28761.856190718914;30191;31084.378312434077;38993.41509877297;39074.023149420354;39200;39535.406968896066;39653.60346396499;28671.569926450702;28724.569131462627;29282.414351713272;29346.853265733534;29506;29307.41385172242;29470.852645736635;29487;29559.26101847471;29764;32623.510647339834;32753.836230818695;32917.835410822794;32969.34061318712;33096.17259568434;28664.14007579776;28897.56653650239;28909.710902890703;28982.13053608395;29032.274193145342;21912.561748765253;22001.559968800215;22081.779182208615;22248.332550023526;22348.888255558617 03:44:21 INFO - PID 32446 | |2;jquery.html;570.7802496039027;574.7155158196693;581.3343721438955;583.775246530086;591.8934591773481;20826.271080512186;21633.459163520918;21670.24154154605;21714.24000159995;22088.447788805286;25595.488090238185;26157.86921065392;26180.345491362725;26242.868785656046;26247.47505049898;6657.533972621931;6809.080774095508;6810.557313774613;6812.7956161315;6817.863642727142;6232.6883655817255;6508.837279068014;6533;6538.901916471256;6553.606783592976;6523.510736694743;6535.934640653581;6545.574537655061;6552;6552.410283074522;6514.41370276675;6521.152250207467;6528.902066469007;6532.934670653281;6553.279139294674;6050.576459647827;6051.939480605181;6067.908981365283;6071;6075.088736689488;28913.710862891312;29018.12945611635;29383.895710110915;30106;30212.8489357554;2062.504998800292;2095.19335056003;2103.9368818935304;2108.3780284816016;2110.5778844231213;19206.423807285802;19872.80127198724;19895;19923.601527969506;19924.3026494072;2388.7294858175487;2408.2775167449695;2447.4615584571366;2449.963250551243;2453.5338285725657;129871;135482.32258838642;135700;135908.32045839806;136124.63875361218;13950.720985580232;14645.267736613127;14901.552953411416;15146.364872430537;15372.769408458882;22769.203077892194;23428.765712343;23470.530589388116;23482.060717571447;23483.647745283834;9584.66453674118;9644.565994530263;9709.126178643815;9713.66002189934;9782.315237933419;8684.956575217084;8727.214550690469;8759.211670949646;8789.824203516022;8817.691380801642;9258.90741092594;9374.95312523433;9427.434353938786;9518.143367096995;9530;2693.676758788958;2712.7151649076563;2714.09077958882;2746.299693578125;2772.556390977434;958.166395236149;977.7213494154132;985.3348989432104;986.7039888033561;988.0761488008735;19544.413667589994;19688.384562006217;19857.4042778714;20206.89896550508;20261;1027.9743006424749;1030.7783826477194;1031.3193292427113;1035.6116456328878;1043.1811028342715;10968.780624387467;10970.616028439126;10982.560697572168;11085.224034317682;11104.833427498594;462576;463471;476047;499654;503010;112791;115396;116008;124818;131951.3402433001;1196.5393323570488;1209.6129238643725;1245.9688507787196;1254.3728135932033;1261.4575732434957;21042.789572104084;21082.78917210808;21490.355289340718;21607.45981350479;21998.89000555051;57512.71243643922;57712.71143644255;58645.413545863994;58957.41042589519;59061.11408328964;67092.32907670861;67271.66364168147;67548.3245167542;67865.66067169633;67915.3208467909;14454.855451445352;14947.701045979236;15021.248937553297;15027.398904043715;15035.173065481504;23403.88298058499;23523.529529409658;23698.881505592362;23748.643770343115;24683.753162468147;19813.702794457808;19951.102200400728;20108.899455503215;20231.79768202358;20267.189312427337;17509;17627.471175864746;17881.46355609334;17890.194941227415;18444.907775461037;19248.518787029876;19674.21303147858;20358.592828143057;20551.177952882314;20627.690584641543;20941;21418.892905535373;22082.88958555197;22091;22165.445863853533;18450.169742361893;19445;19577.8042219576;19720.30978915731;19765.70351444758 03:44:21 INFO - PID 32446 | |3;mootools.html;1335.3189873164686;1389.8123753293303;1408.1691801836914;1409.7180563887225;1416;14715.411383544659;15424.228788560584;15424.992126535317;15436.922815385935;15715.921420392911;15751.921240393782;16073.598160046005;16076.115813630246;16090.436834710787;16120.75818862718;2672.1983404978528;2752.2844060544203;2788.0659978907092;2802.285417218606;2803.341214814517;2797.8880844766286;2841.2754747539348;2841.8721157547857;2842.17576902699;2842.189975856881;2737.767289780361;2753.4630747004344;2766.9031583894566;2820.675622303441;2820.971790282091;2697.4470233602065;2701.2976626077166;2711.024031348713;2711.91864244073;2713.9050133245437;2709.4851978124093;2711.810173287851;2722.9319267018286;2724.645796046521;2725.2641786717477;14877.925610371878;15239.847601524065;15245;15247.847521524865;15255.08469491834;7719.536827790351;7987.281144696947;8009.559474228915;8010.839783204362;8014.398920080959;5191.844244672666;5250.7637156328055;5407.513323800877;5463.754131064112;5522.751476183581;1961.604931585084;1969.6651569233265;1978.782333943265;1982.544014876572;2040.9285675001452;26666.200013999613;26722.331941701417;26791.73208267912;26867.73132268672;26917.19248422531;7306.780796576111;7456.291652293024;7555.433342499335;7637.732679356196;7652.502587331805;17331.30674772995;17442.215100320514;17492.037937913283;17531.73702394465;17544.035078070574;8022.438429309892;8169.63236654352;8177.427580069457;8179.9775028121485;8181.100078991306;5761.740721667535;6458.095866578588;7401.370883474965;7410.555366678017;7556.055493063367;5283.735813209401;5423.810166644149;5450.400455949843;5481.643693159932;5525.806596769094;1520.293063725373;1530.7550791873248;1559.1035154786043;1562.0783737594872;1571.4735563586098;874.6501399440148;906.1799071839864;906.2025417632441;917.1195652173855;920.4201353147608;7566.092068951761;8765.649374024968;8768.561571921378;8853.15894989975;8937;721.6103304215769;723.3634401726447;726.8655298769639;727.4762171236702;731.701230316193;4851.781669824866;5150.356205474316;5350.866228344323;5482.205080263339;5631.746571404296;21481;21789.673154902688;22062.88968555147;22265.554688906454;22284;21553.461163470725;21695.674564881538;21726.23958161457;22774.544509110056;22792.886035569714;11403.144764142557;11667.941660291644;11680.182387232811;11759.235649682743;11780.234284771463;8240.093589705008;8571.828563428571;8667.609957551798;8741.125887411208;9273.53632318395;18683.719744203576;18810.15354309032;18961.241550337832;19290.324838631142;19359.4192174235;19481.123349449026;19564.706529402356;19666.311679091163;19820.50448738793;19930.70103948413;12335.50657973671;12450.128491005542;12543.745625437748;12692.555760548337;12762.106652534234;14370.784438233644;14519.128852268897;14529.346179422162;14545.127292362493;14573.5627931158;11257.324560526395;11431.085513159094;11532.423378830857;11548.769024619629;11611.361375124112;11100.167487438635;11265.887341126483;11328.32030078198;11368.772624547628;11482.885171148182;9607.711768646952;9824.084303560738;9858.507074646383;9861.950690246504;9865.06281903218;7430.7399241026305;7434.219406962191;7463.402927765875;7473.962630186814;7601.923980760122;7838.255365740246;7891.921080789119;7892.802679933047;7898;7980.401469889897 03:44:21 INFO - PID 32446 | |4;prototype.html;502.04257669960316;514.7040451740249;528.9233061206123;530.8646295194725;532.1034057612923;6273.451747483073;6335.176427064481;6337.397947195015;6347.016212487072;6366.14057102291;6242.656653884034;6266.310705822356;6308.148399966003;6308.968455157729;6323.9051414228825;5199.6360254782185;5206.297149884774;5210.661307015051;5224.6342756007;5231.816886408977;4863.14894893394;4981.676191047589;5170.405403378603;5199.922001169966;5211.843644690665;4879.828476328035;4989.151844186497;4996.375453068366;5006;5029.170186919154;4898.755062246873;4908.337374454439;4922.849376399089;4968.850934471971;4996.7001979881325;4378.562143785628;4389.253826849444;4422.977885110586;4430.867073987785;4441.156180325728;6133.846653833645;6150.661713605795;6165.612737134154;6167.784127555514;6194.287656919467;5585.972070139664;5609.411011843738;5632.324121105453;5635.436456354373;5693.231413759131;6577.177852768404;6591.274959754423;6596.472282217459;6601.042848786899;6605.306442823482;4877.6341774367065;4911.50884911506;4934.80260789568;4953.727544985024;4966.701997880139;6677.729571945513;6682.126685525173;6791.37007118293;6791.796246112624;6930.896036559456;4988.176950803077;4996.275540046673;5008.474110218447;5021.397432308073;5030.522100400456;5054.9241761373605;5067.569256613156;5069.543741063322;5087.694738315713;5093.796248150033;5573.7213139343685;5613.831585052455;5680.261565996394;5681.261436013292;5703.629264097904;6463.545702217058;6572.178477690289;6582.901256481156;6607.174103237096;6609.900851487231;1743.5379624399545;1745.3070521594034;1753.281154726556;1765.6556971390712;1767.5139336682514;1145.8682251541013;1224.6142465123457;1228.3489750432286;1231.5751065882257;1237.6287113865985;5824.796132135355;5831.504322132666;5840.88318233633;5854.385289544536;5861.853453663607;6698.698558564876;6739.966300168468;6765.627890465973;6794.388505034571;6801.557898736566;5671.015144699322;5706.600537962303;5727.799527016535;5763.366029736726;5804.622699524517;3537.168765340143;3539.433690609542;3563.2517171394297;3574.766705486603;3625.7643253188457;6422.165118534561;6440.259370172396;6467.773627923;6504.902426463606;6510.674466276762;6832.487563432763;6862.4853136015;6895.103636527219;6955.1653801544135;6968.233494315621;5967.522598192134;6345.524085693683;6446.613203207822;6488.351164883568;6509.544331896722;6490.8052758417325;6638.435732962752;6665.466762658879;6724.193096828412;6764.3573860483175;6631.136773439467;6683.665816709048;6701.3298670134545;6741.629210393476;6747.021681856201;6453.483721302191;6491.935080649322;6521.032930016926;6521.478281737354;6553.672316384257;4837.4920633332995;4915.483874193158;4933.679310844784;4966.279889416087;4974.701517908937;6378.298387177314;6650.301718319507;6673.165854268216;6752.358525940028;6803.965980170067;6328.905066423915;6507.446867016357;6583.436995738593;6595.076689263603;6632.369924857131;6540.247871494839;6573.57271777333;6573.769918052845;6581.14445122131;6583.144191255297;6525.846470664575;6534.190298171642;6542.967285163544;6553.279139294578;6582.111414958919;6537.49637583368;6560.917448620924;6583;6601.933980660324;6666.866662666816;6291.307956124731;6335.176427064452;6420.903686444801;6443.7744678936015;6457.6771161442675 03:44:21 INFO - PID 32446 | |5;yui.html;861.0700443520997;864.3387808326631;902.3367824648882;903.837309284329;907.4283201583002;17549.21028553715;19004.14481348339;20094.69857952132;20181.89909050453;20184.293549725764;15226.086434813891;15233.00985435946;15260.160691161982;15575.241903705544;19468.318608848695;929.3633860805336;941.8398872191709;942.58997336159;944.475815922163;947.6162154327474;899.644640367058;981.293468702533;982.4596471940404;983.2969426859794;985.6106837799065;1040.2354269611828;1042.4422933730455;1044.5299615173165;1046.08467590858;1047;1047.837585174303;1048.491481631408;1048.6172547020358;1048.8688913885765;1049.5382031905938;773.7214602743009;774.0595176860141;774.2644487736673;774.6668932359083;775.6587101675245;19024.143913523923;19250.326238581583;19941.9002904986;20103.89948050265;20160.899195503927;21555.2455664051;21770.346889593337;21983.23058692954;22049;22093.33719988403;15817.209139542976;16001.759973600405;16102.275397607136;16124.193790310555;16152.353905843753;3681.8711345102793;3714.962850371489;3716.2195938852874;3730.198007428416;3730.2166545025575;131264;132319;133023;133861.33069334688;137732;16648.75026874598;16996.575085622957;17061.914690426718;17104.486865394058;17161.141942903054;30627.38745225083;30726.38547229043;30753.84623076915;31466.685333146834;31610.841945790125;8767.561621918878;8792.34057445694;8864.335174861782;8874.511901845332;8896;4278.957210427918;4322.69741118125;4344.54382289855;4354.608085272277;4362.411074504965;5195;5294.655847369986;5308.416074231832;5313.256144139824;5332.066888294533;1110.1230028277732;1153.4982282707049;1158.8319693644373;1160.802663547199;1165.3998190931677;683.8051155420682;690.3903245731144;694.6110178300169;702.7118881258659;715.6314498033516;12446.439910204062;13656.65858353549;13850.930745346208;13983.391909930488;14037.481080219997;642.4603333200134;644.4972921121532;675.6891829758268;682.0962225051826;689.0456717446373;5788.913166302509;6179.81460556184;6422.100905873182;6446.161998940108;6652.968789837583;104532.47733761283;108776.4561177189;109147;110333;112575;94786.52606736922;95305;95558.52220738852;95783.52108239554;95806;82662.58668706618;83472.58263708765;85577.57211213904;86966.56516717376;87211;12810.167339122927;12909.935450322688;12913.031522635652;12935.935320323339;12940.870591294342;38789.41815872821;39370;39556.80221598873;39998.80000599979;41420.58579414288;52470;52575;53399;53507.46492535181;54873.45126548684;17958.19188136511;18550.44348669542;18701.6259674803;18878.24487020504;19118.713219301444;19462.513437164183;19727;19830.00849957525;19892.801071989674;19927.60144797125;19094.713579296043;19500;19966.700499492228;20099.59800804005;20160.79839201589;18468;19168.808311916702;19244.326448574793;19686.704699429232;19727.506812329808;18612.720809187602;18856;19276.421707348803;19495.610087797882;19614.509637259183;12582.433790479266;12624.431900564314;12902.80645790295;13170.682931706753;13223.404946777611;14571.377152112722;14741.92629036848;15028.248587570359;15142.54572362831;15313.846861531687 03:44:21 INFO - PID 32446 | __end_tp_report 03:44:21 INFO - PID 32446 | __start_cc_report 03:44:21 INFO - PID 32446 | _x_x_mozilla_cycle_collect,345 03:44:21 INFO - PID 32446 | __end_cc_report 03:44:21 INFO - PID 32446 | __startTimestamp1504694661687__endTimestamp 03:44:21 INFO - PID 32446 | 03:44:21 INFO - PID 32446 | ------- Summary: start ------- 03:44:21 INFO - PID 32446 | Number of tests: 6 03:44:21 INFO - PID 32446 | 03:44:21 INFO - PID 32446 | [#0] dojo.html Cycles:165 Average:6268.37 Median:6546.05 stddev:785.60 (12.0%) stddev-sans-first:751.49 03:44:21 INFO - PID 32446 | Values: 3250.5 3251.4 3273.3 3277.8 3278.8 6345.9 6366.0 6370.1 6380.5 6392.6 6251.6 6318.1 6337.6 6339.4 6364.3 5845.4 5858.9 5865.1 5874.6 5892.2 5918.2 5956.3 5958.8 5960.6 5964.7 5846.4 5888.8 5940.7 5950.3 5962.3 5404.9 5676.9 5754.7 5762.8 5960.8 5794.6 5840.7 5877.2 5909.3 5916.7 6139.1 6331.3 6368.1 6380.8 6404.6 6732.8 6746.4 6776.2 6785.1 6797.9 6844.3 6848.8 6854.6 6860.8 6873.2 6337.2 6338.7 6344.2 6360.2 6450.2 6977.2 7053.4 7072.9 7073.2 7079.3 6659.8 6670.5 6681.2 6764.6 6766.3 6750.4 6805.8 6824.4 6888.9 6897.6 6829.0 6887.1 6887.7 6895.0 6928.0 6773.9 6816.0 6874.5 6881.7 6932.9 4963.2 4984.0 5036.9 5040.0 5043.6 4313.7 4386.2 4387.8 4393.9 4412.4 5912.7 5979.6 5996.6 6003.5 6014.9 6770.4 6859.6 6944.9 6945.2 6957.8 5912.4 5915.1 5965.4 5966.5 5981.5 5758.7 5850.3 5854.9 5863.9 5868.1 6574.7 6625.1 6655.9 6677.6 6688.4 6761.7 6844.9 6921.7 6922.1 6975.1 6513.9 6531.7 6534.7 6627.1 6639.1 6760.4 6816.5 6822.5 6832.5 6834.5 6800.9 6845.9 6875.6 6894.7 6897.6 6647.1 6672.7 6681.1 6751.7 6756.3 6539.1 6589.2 6629.5 6682.4 6686.3 6546.1 6547.7 6554.6 6557.6 6567.3 6649.8 6657.2 6667.4 6676.7 6787.0 6501.2 6521.8 6530.9 6546.8 6550.4 03:44:21 INFO - PID 32446 | 03:44:21 INFO - PID 32446 | [#1] ext.html Cycles:180 Average:36878.06 Median:30711.61 stddev:55663.88 (181.2%) stddev-sans-first:55754.07 03:44:21 INFO - PID 32446 | Values: 786.3 850.9 888.9 1123.1 1148.4 36171.8 39539.8 39624.2 39750.6 39756.8 39737.8 39843.8 40071.6 40168.0 40184.0 7369.0 7692.3 7695.9 7699.4 7699.7 7486.5 7577.7 7578.9 7582.7 7582.8 7550.1 7622.5 7627.0 7635.1 7635.5 7542.4 7560.5 7601.8 7602.0 7604.7 7533.3 7587.5 7589.0 7590.1 7592.7 36113.6 36330.1 36376.3 36462.5 36551.1 3557.8 3595.9 3597.9 3600.5 3600.6 30264.5 30272.5 30304.0 30311.5 30338.8 5111.4 5126.7 5156.9 5169.6 5240.9 181714.0 181846.0 182399.0 182444.0 182995.0 44631.3 44674.1 44827.6 44847.1 44852.8 49606.8 50421.7 50731.7 50933.0 50993.0 11374.3 11636.4 12260.1 12342.1 13879.8 11232.9 11302.9 11307.8 11337.8 11369.4 13911.3 13921.4 13924.7 13943.9 14036.4 5656.9 5825.2 5900.4 5900.7 5942.3 1004.1 1018.6 1033.9 1034.3 1046.1 22455.4 23421.9 27719.9 28502.0 28818.6 1079.9 1094.9 1098.1 1098.6 1103.1 12112.8 12256.3 12257.3 12383.6 12417.3 247162.0 250006.0 250057.0 250252.0 250301.0 48278.0 48372.5 48652.3 48680.5 48800.5 1404.1 1416.6 1418.3 1434.2 1436.1 22020.1 22058.6 22082.4 22218.1 22437.4 31908.4 32269.8 35974.3 35992.3 36022.0 204425.0 205519.0 205602.0 205655.0 206002.0 28005.3 28685.1 28761.9 30191.0 31084.4 38993.4 39074.0 39200.0 39535.4 39653.6 28671.6 28724.6 29282.4 29346.9 29506.0 29307.4 29470.9 29487.0 29559.3 29764.0 32623.5 32753.8 32917.8 32969.3 33096.2 28664.1 28897.6 28909.7 28982.1 29032.3 21912.6 22001.6 22081.8 22248.3 22348.9 03:44:21 INFO - PID 32446 | 03:44:21 INFO - PID 32446 | [#2] jquery.html Cycles:180 Average:34954.53 Median:23503.59 stddev:81128.80 (345.2%) stddev-sans-first:81315.31 03:44:21 INFO - PID 32446 | Values: 570.8 574.7 581.3 583.8 591.9 20826.3 21633.5 21670.2 21714.2 22088.4 25595.5 26157.9 26180.3 26242.9 26247.5 6657.5 6809.1 6810.6 6812.8 6817.9 6232.7 6508.8 6533.0 6538.9 6553.6 6523.5 6535.9 6545.6 6552.0 6552.4 6514.4 6521.2 6528.9 6532.9 6553.3 6050.6 6051.9 6067.9 6071.0 6075.1 28913.7 29018.1 29383.9 30106.0 30212.8 2062.5 2095.2 2103.9 2108.4 2110.6 19206.4 19872.8 19895.0 19923.6 19924.3 2388.7 2408.3 2447.5 2450.0 2453.5 129871.0 135482.3 135700.0 135908.3 136124.6 13950.7 14645.3 14901.6 15146.4 15372.8 22769.2 23428.8 23470.5 23482.1 23483.6 9584.7 9644.6 9709.1 9713.7 9782.3 8685.0 8727.2 8759.2 8789.8 8817.7 9258.9 9375.0 9427.4 9518.1 9530.0 2693.7 2712.7 2714.1 2746.3 2772.6 958.2 977.7 985.3 986.7 988.1 19544.4 19688.4 19857.4 20206.9 20261.0 1028.0 1030.8 1031.3 1035.6 1043.2 10968.8 10970.6 10982.6 11085.2 11104.8 462576.0 463471.0 476047.0 499654.0 503010.0 112791.0 115396.0 116008.0 124818.0 131951.3 1196.5 1209.6 1246.0 1254.4 1261.5 21042.8 21082.8 21490.4 21607.5 21998.9 57512.7 57712.7 58645.4 58957.4 59061.1 67092.3 67271.7 67548.3 67865.7 67915.3 14454.9 14947.7 15021.2 15027.4 15035.2 23403.9 23523.5 23698.9 23748.6 24683.8 19813.7 19951.1 20108.9 20231.8 20267.2 17509.0 17627.5 17881.5 17890.2 18444.9 19248.5 19674.2 20358.6 20551.2 20627.7 20941.0 21418.9 22082.9 22091.0 22165.4 18450.2 19445.0 19577.8 19720.3 19765.7 03:44:21 INFO - PID 32446 | 03:44:21 INFO - PID 32446 | [#3] mootools.html Cycles:180 Average:9571.04 Median:2711.86 stddev:6822.09 (251.6%) stddev-sans-first:6813.17 03:44:21 INFO - PID 32446 | Values: 1335.3 1389.8 1408.2 1409.7 1416.0 14715.4 15424.2 15425.0 15436.9 15715.9 15751.9 16073.6 16076.1 16090.4 16120.8 2672.2 2752.3 2788.1 2802.3 2803.3 2797.9 2841.3 2841.9 2842.2 2842.2 2737.8 2753.5 2766.9 2820.7 2821.0 2697.4 2701.3 2711.0 2711.9 2713.9 2709.5 2711.8 2722.9 2724.6 2725.3 14877.9 15239.8 15245.0 15247.8 15255.1 7719.5 7987.3 8009.6 8010.8 8014.4 5191.8 5250.8 5407.5 5463.8 5522.8 1961.6 1969.7 1978.8 1982.5 2040.9 26666.2 26722.3 26791.7 26867.7 26917.2 7306.8 7456.3 7555.4 7637.7 7652.5 17331.3 17442.2 17492.0 17531.7 17544.0 8022.4 8169.6 8177.4 8180.0 8181.1 5761.7 6458.1 7401.4 7410.6 7556.1 5283.7 5423.8 5450.4 5481.6 5525.8 1520.3 1530.8 1559.1 1562.1 1571.5 874.7 906.2 906.2 917.1 920.4 7566.1 8765.6 8768.6 8853.2 8937.0 721.6 723.4 726.9 727.5 731.7 4851.8 5150.4 5350.9 5482.2 5631.7 21481.0 21789.7 22062.9 22265.6 22284.0 21553.5 21695.7 21726.2 22774.5 22792.9 11403.1 11667.9 11680.2 11759.2 11780.2 8240.1 8571.8 8667.6 8741.1 9273.5 18683.7 18810.2 18961.2 19290.3 19359.4 19481.1 19564.7 19666.3 19820.5 19930.7 12335.5 12450.1 12543.7 12692.6 12762.1 14370.8 14519.1 14529.3 14545.1 14573.6 11257.3 11431.1 11532.4 11548.8 11611.4 11100.2 11265.9 11328.3 11368.8 11482.9 9607.7 9824.1 9858.5 9862.0 9865.1 7430.7 7434.2 7463.4 7474.0 7601.9 7838.3 7891.9 7892.8 7898.0 7980.4 03:44:21 INFO - PID 32446 | 03:44:21 INFO - PID 32446 | [#4] prototype.html Cycles:180 Average:5523.23 Median:6218.47 stddev:1547.16 (24.9%) stddev-sans-first:1504.90 03:44:21 INFO - PID 32446 | Values: 502.0 514.7 528.9 530.9 532.1 6273.5 6335.2 6337.4 6347.0 6366.1 6242.7 6266.3 6308.1 6309.0 6323.9 5199.6 5206.3 5210.7 5224.6 5231.8 4863.1 4981.7 5170.4 5199.9 5211.8 4879.8 4989.2 4996.4 5006.0 5029.2 4898.8 4908.3 4922.8 4968.9 4996.7 4378.6 4389.3 4423.0 4430.9 4441.2 6133.8 6150.7 6165.6 6167.8 6194.3 5586.0 5609.4 5632.3 5635.4 5693.2 6577.2 6591.3 6596.5 6601.0 6605.3 4877.6 4911.5 4934.8 4953.7 4966.7 6677.7 6682.1 6791.4 6791.8 6930.9 4988.2 4996.3 5008.5 5021.4 5030.5 5054.9 5067.6 5069.5 5087.7 5093.8 5573.7 5613.8 5680.3 5681.3 5703.6 6463.5 6572.2 6582.9 6607.2 6609.9 1743.5 1745.3 1753.3 1765.7 1767.5 1145.9 1224.6 1228.3 1231.6 1237.6 5824.8 5831.5 5840.9 5854.4 5861.9 6698.7 6740.0 6765.6 6794.4 6801.6 5671.0 5706.6 5727.8 5763.4 5804.6 3537.2 3539.4 3563.3 3574.8 3625.8 6422.2 6440.3 6467.8 6504.9 6510.7 6832.5 6862.5 6895.1 6955.2 6968.2 5967.5 6345.5 6446.6 6488.4 6509.5 6490.8 6638.4 6665.5 6724.2 6764.4 6631.1 6683.7 6701.3 6741.6 6747.0 6453.5 6491.9 6521.0 6521.5 6553.7 4837.5 4915.5 4933.7 4966.3 4974.7 6378.3 6650.3 6673.2 6752.4 6804.0 6328.9 6507.4 6583.4 6595.1 6632.4 6540.2 6573.6 6573.8 6581.1 6583.1 6525.8 6534.2 6543.0 6553.3 6582.1 6537.5 6560.9 6583.0 6601.9 6666.9 6291.3 6335.2 6420.9 6443.8 6457.7 03:44:21 INFO - PID 32446 | 03:44:21 INFO - PID 32446 | [#5] yui.html Cycles:180 Average:23482.07 Median:20132.35 stddev:31946.44 (158.7%) stddev-sans-first:31990.90 03:44:21 INFO - PID 32446 | Values: 861.1 864.3 902.3 903.8 907.4 17549.2 19004.1 20094.7 20181.9 20184.3 15226.1 15233.0 15260.2 15575.2 19468.3 929.4 941.8 942.6 944.5 947.6 899.6 981.3 982.5 983.3 985.6 1040.2 1042.4 1044.5 1046.1 1047.0 1047.8 1048.5 1048.6 1048.9 1049.5 773.7 774.1 774.3 774.7 775.7 19024.1 19250.3 19941.9 20103.9 20160.9 21555.2 21770.3 21983.2 22049.0 22093.3 15817.2 16001.8 16102.3 16124.2 16152.4 3681.9 3715.0 3716.2 3730.2 3730.2 131264.0 132319.0 133023.0 133861.3 137732.0 16648.8 16996.6 17061.9 17104.5 17161.1 30627.4 30726.4 30753.8 31466.7 31610.8 8767.6 8792.3 8864.3 8874.5 8896.0 4279.0 4322.7 4344.5 4354.6 4362.4 5195.0 5294.7 5308.4 5313.3 5332.1 1110.1 1153.5 1158.8 1160.8 1165.4 683.8 690.4 694.6 702.7 715.6 12446.4 13656.7 13850.9 13983.4 14037.5 642.5 644.5 675.7 682.1 689.0 5788.9 6179.8 6422.1 6446.2 6653.0 104532.5 108776.5 109147.0 110333.0 112575.0 94786.5 95305.0 95558.5 95783.5 95806.0 82662.6 83472.6 85577.6 86966.6 87211.0 12810.2 12909.9 12913.0 12935.9 12940.9 38789.4 39370.0 39556.8 39998.8 41420.6 52470.0 52575.0 53399.0 53507.5 54873.5 17958.2 18550.4 18701.6 18878.2 19118.7 19462.5 19727.0 19830.0 19892.8 19927.6 19094.7 19500.0 19966.7 20099.6 20160.8 18468.0 19168.8 19244.3 19686.7 19727.5 18612.7 18856.0 19276.4 19495.6 19614.5 12582.4 12624.4 12902.8 13170.7 13223.4 14571.4 14741.9 15028.2 15142.5 15313.8 03:44:21 INFO - PID 32446 | -------- Summary: end -------- 03:44:21 INFO - PID 32446 | 03:44:22 INFO - TEST-INFO | 32446: exit 0 03:44:22 INFO - TEST-OK | dromaeo_css | took 1110002ms 03:44:22 INFO - TEST-START | kraken 03:44:22 INFO - Initialising browser for kraken test... 03:44:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:48058/getInfo.html -profile /tmp/tmpZ9iI32/profile 03:44:22 INFO - TEST-INFO | started process 364 (/builds/slave/test/build/application/firefox/firefox http://localhost:48058/getInfo.html) 03:44:29 INFO - TEST-INFO | 364: exit 0 03:44:29 INFO - Browser initialized. 03:44:29 INFO - Running cycle 1/1 for kraken test... 03:44:29 INFO - Using env: {'DISPLAY': ':0', 03:44:29 INFO - 'HOME': '/home/cltbld', 03:44:29 INFO - 'JSGC_DISABLE_POISONING': '1', 03:44:29 INFO - 'LANG': 'en_US.UTF-8', 03:44:29 INFO - 'LANGUAGE': 'en_US:en', 03:44:29 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 03:44:29 INFO - 'LOGNAME': 'cltbld', 03:44:29 INFO - 'MAIL': '/var/mail/cltbld', 03:44:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:44:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:44:29 INFO - 'MOZ_CRASHREPORTER': '1', 03:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:44:29 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 03:44:29 INFO - 'MOZ_NO_REMOTE': '1', 03:44:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:44:29 INFO - 'NO_EM_RESTART': '1', 03:44:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:44:29 INFO - 'PWD': '/builds/slave/test', 03:44:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:44:29 INFO - 'RUST_BACKTRACE': 'full', 03:44:29 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:44:29 INFO - 'SHELL': '/bin/bash', 03:44:29 INFO - 'SHLVL': '1', 03:44:29 INFO - 'TERM': 'linux', 03:44:29 INFO - 'TMOUT': '86400', 03:44:29 INFO - 'USER': 'cltbld', 03:44:29 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821', 03:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:44:29 INFO - '_': '/tools/buildbot/bin/python'} 03:44:29 INFO - TEST-INFO | started process 568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ9iI32/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:44:30 INFO - PID 568 | 03:44:30 INFO - PID 568 | (/builds/slave/test/build/application/firefox/firefox:620): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:44:30 INFO - PID 568 | 03:44:40 INFO - PID 568 | RSS: Main: 170188800 03:44:40 INFO - PID 568 | 03:44:43 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48058/tests/kraken/driver.html?testName=audio-beat-detection) 03:44:44 INFO - PID 568 | RSS: Main: 176697344 03:44:44 INFO - PID 568 | 03:44:46 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48058/tests/kraken/driver.html?testName=audio-dft) 03:44:47 INFO - PID 568 | RSS: Main: 176971776 03:44:47 INFO - PID 568 | 03:44:50 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48058/tests/kraken/driver.html?testName=audio-fft) 03:44:51 INFO - PID 568 | RSS: Main: 171532288 03:44:51 INFO - PID 568 | 03:44:53 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48058/tests/kraken/driver.html?testName=audio-oscillator) 03:44:53 INFO - PID 568 | RSS: Main: 172183552 03:44:53 INFO - PID 568 | 03:44:55 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48058/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:44:56 INFO - PID 568 | RSS: Main: 172580864 03:44:56 INFO - PID 568 | 03:44:59 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48058/tests/kraken/driver.html?testName=imaging-darkroom) 03:45:00 INFO - PID 568 | RSS: Main: 175448064 03:45:00 INFO - PID 568 | 03:45:03 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48058/tests/kraken/driver.html?testName=imaging-desaturate) 03:45:04 INFO - PID 568 | RSS: Main: 175329280 03:45:04 INFO - PID 568 | 03:45:07 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48058/tests/kraken/driver.html?testName=json-parse-financial) 03:45:07 INFO - PID 568 | RSS: Main: 175161344 03:45:07 INFO - PID 568 | 03:45:09 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48058/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:45:10 INFO - PID 568 | RSS: Main: 175300608 03:45:10 INFO - PID 568 | 03:45:11 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48058/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:45:12 INFO - PID 568 | RSS: Main: 175955968 03:45:12 INFO - PID 568 | 03:45:14 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48058/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:45:15 INFO - PID 568 | RSS: Main: 172343296 03:45:15 INFO - PID 568 | 03:45:17 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48058/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:45:18 INFO - PID 568 | RSS: Main: 173117440 03:45:18 INFO - PID 568 | 03:45:21 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48058/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:45:22 INFO - PID 568 | RSS: Main: 172802048 03:45:22 INFO - PID 568 | 03:45:23 INFO - PID 568 | Cycle 1(1): loaded http://localhost:48058/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48058/tests/kraken/driver.html?testName=ai-astar) 03:45:24 INFO - PID 568 | RSS: Main: 174690304 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | __start_tp_report 03:45:24 INFO - PID 568 | _x_x_mozilla_page_load 03:45:24 INFO - PID 568 | _x_x_mozilla_page_load_details 03:45:24 INFO - PID 568 | |i|pagename|runs| 03:45:24 INFO - PID 568 | |0;ai-astar;96;109;99;107;106;108;108;99;110;108 03:45:24 INFO - PID 568 | |1;audio-beat-detection;147;119;154;179;123;142;144;117;173;121 03:45:24 INFO - PID 568 | |2;audio-dft;163;163;162;162;163;162;175;173;164;166 03:45:24 INFO - PID 568 | |3;audio-fft;74;75;74;172;75;75;73;73;161;79 03:45:24 INFO - PID 568 | |4;audio-oscillator;79;79;128;79;79;81;140;79;79;124 03:45:24 INFO - PID 568 | |5;imaging-gaussian-blur;114;114;114;116;114;114;114;113;113;114 03:45:24 INFO - PID 568 | |6;imaging-darkroom;148;147;148;150;148;149;148;149;148;148 03:45:24 INFO - PID 568 | |7;imaging-desaturate;94;95;94;94;94;94;95;94;94;95 03:45:24 INFO - PID 568 | |8;json-parse-financial;53;54;55;54;53;54;53;53;53;59 03:45:24 INFO - PID 568 | |9;json-stringify-tinderbox;38;38;39;37;38;39;39;38;39;38 03:45:24 INFO - PID 568 | |10;stanford-crypto-aes;73;77;75;76;81;74;74;75;75;78 03:45:24 INFO - PID 568 | |11;stanford-crypto-ccm;131;124;114;118;116;126;115;121;124;192 03:45:24 INFO - PID 568 | |12;stanford-crypto-pbkdf2;170;170;169;168;168;168;169;174;174;166 03:45:24 INFO - PID 568 | |13;stanford-crypto-sha256-iterative;75;64;64;63;65;70;65;63;68;62 03:45:24 INFO - PID 568 | __end_tp_report 03:45:24 INFO - PID 568 | __start_cc_report 03:45:24 INFO - PID 568 | _x_x_mozilla_cycle_collect,947 03:45:24 INFO - PID 568 | __end_cc_report 03:45:24 INFO - PID 568 | __startTimestamp1504694724165__endTimestamp 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | ------- Summary: start ------- 03:45:24 INFO - PID 568 | Number of tests: 14 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#0] ai-astar Cycles:10 Average:105.00 Median:109.50 stddev:5.01 (4.6%) stddev-sans-first:4.12 03:45:24 INFO - PID 568 | Values: 96.0 109.0 99.0 107.0 106.0 108.0 108.0 99.0 110.0 108.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:145.50 stddev:22.26 (15.3%) stddev-sans-first:23.53 03:45:24 INFO - PID 568 | Values: 147.0 119.0 154.0 179.0 123.0 142.0 144.0 117.0 173.0 121.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#2] audio-dft Cycles:10 Average:165.30 Median:163.50 stddev:4.76 (2.9%) stddev-sans-first:4.98 03:45:24 INFO - PID 568 | Values: 163.0 163.0 162.0 162.0 163.0 162.0 175.0 173.0 164.0 166.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#3] audio-fft Cycles:10 Average:93.10 Median:74.50 stddev:38.81 (52.1%) stddev-sans-first:40.54 03:45:24 INFO - PID 568 | Values: 74.0 75.0 74.0 172.0 75.0 75.0 73.0 73.0 161.0 79.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:25.14 (31.8%) stddev-sans-first:26.01 03:45:24 INFO - PID 568 | Values: 79.0 79.0 128.0 79.0 79.0 81.0 140.0 79.0 79.0 124.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 03:45:24 INFO - PID 568 | Values: 114.0 114.0 114.0 116.0 114.0 114.0 114.0 113.0 113.0 114.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 03:45:24 INFO - PID 568 | Values: 148.0 147.0 148.0 150.0 148.0 149.0 148.0 149.0 148.0 148.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 03:45:24 INFO - PID 568 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.85 (3.4%) stddev-sans-first:1.92 03:45:24 INFO - PID 568 | Values: 53.0 54.0 55.0 54.0 53.0 54.0 53.0 53.0 53.0 59.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#9] json-stringify-tinderbox Cycles:10 Average:38.30 Median:38.50 stddev:0.67 (1.8%) stddev-sans-first:0.71 03:45:24 INFO - PID 568 | Values: 38.0 38.0 39.0 37.0 38.0 39.0 39.0 38.0 39.0 38.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:75.50 stddev:2.35 (3.1%) stddev-sans-first:2.26 03:45:24 INFO - PID 568 | Values: 73.0 77.0 75.0 76.0 81.0 74.0 74.0 75.0 75.0 78.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:124.00 stddev:23.09 (18.6%) stddev-sans-first:24.47 03:45:24 INFO - PID 568 | Values: 131.0 124.0 114.0 118.0 116.0 126.0 115.0 121.0 124.0 192.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:169.50 stddev:2.59 (1.5%) stddev-sans-first:2.74 03:45:24 INFO - PID 568 | Values: 170.0 170.0 169.0 168.0 168.0 168.0 169.0 174.0 174.0 166.0 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:65.00 stddev:4.01 (6.2%) stddev-sans-first:2.57 03:45:24 INFO - PID 568 | Values: 75.0 64.0 64.0 63.0 65.0 70.0 65.0 63.0 68.0 62.0 03:45:24 INFO - PID 568 | -------- Summary: end -------- 03:45:24 INFO - PID 568 | 03:45:24 INFO - PID 568 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:45:24 INFO - TEST-INFO | 568: exit 0 03:45:24 INFO - TEST-OK | kraken | took 62502ms 03:45:24 INFO - SUITE-END | took 1172s 03:45:25 INFO - Completed test suite (00:19:32) 03:45:25 INFO - javascript benchmark 03:45:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8577.637018358693, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3250.4799232122864, 3251.414745345838, 3273.2635157089658, 3277.786943848648, 3278.803271803692, 6345.873082538346, 6365.968170159149, 6370.108184854124, 6380.52146089044, 6392.55252132351, 6251.624902505853, 6318.147050148229, 6337.619742815435, 6339.366063393658, 6364.268109167447, 5845.444682755153, 5858.88282234355, 5865.149553314767, 5874.647521148723, 5892.204552385416, 5918.201042859202, 5956.255468066492, 5958.79144229952, 5960.642361458326, 5964.671943043131, 5846.356900740936, 5888.764449422018, 5940.732667029973, 5950.345461999176, 5962.314333851597, 5404.891902161974, 5676.86462707456, 5754.74103665336, 5762.769489220426, 5960.791372301992, 5794.62334948227, 5840.678762668052, 5877.235959325303, 5909.2908850938165, 5916.674582897939, 6139.140520327113, 6331.262857256956, 6368.10846481493, 6380.776672816475, 6404.583702059398, 6732.764353247613, 6746.426553742937, 6776.220734615484, 6785.084013658192, 6797.864042719118, 6844.28135045818, 6848.828779280508, 6854.554453960476, 6860.759873404457, 6873.175218973755, 6337.176167098248, 6338.714757835908, 6344.206974128234, 6360.204974378203, 6450.161479007699, 6977.162740471176, 7053.400460960773, 7072.92927070733, 7073.221945585981, 7079.256678048834, 6659.766908158192, 6670.466362690973, 6681.198256209189, 6764.627945462948, 6766.289539598271, 6750.426213771884, 6805.761798337035, 6824.351686589766, 6888.896666550006, 6897.62063086525, 6828.9658551706925, 6887.139107611549, 6887.6556172192195, 6894.96575513677, 6927.965360173167, 6773.9322606774285, 6816.045753594501, 6874.518783685094, 6881.65591720412, 6932.896006559906, 4963.230699241623, 4984.0, 5036.899262014739, 5040.042391945519, 5043.646944713908, 4313.676474264443, 4386.166628340605, 4387.846425375096, 4393.868183954486, 4412.4043254160915, 5912.674802885883, 5979.5814292999075, 5996.580239383288, 6003.489703375175, 6014.939850601438, 6770.356816102462, 6859.5541289816, 6944.930550694529, 6945.201301850352, 6957.756478523227, 5912.438318359749, 5915.112733089984, 5965.403459654087, 5966.522678185735, 5981.461668449861, 5758.683272419973, 5850.3272123705465, 5854.8536286592325, 5863.853403664943, 5868.09044598088, 6574.737010519621, 6625.0724898514245, 6655.933440665628, 6677.599344039373, 6688.39804417595, 6761.695723692544, 6844.8973265402055, 6921.653917304216, 6922.134733158356, 6975.058367120577, 6513.934860651333, 6531.673416329069, 6534.673266336569, 6627.138471998609, 6639.136912201383, 6760.425363844129, 6816.454683625199, 6822.488313376417, 6832.453403727591, 6834.521583489108, 6800.863982720417, 6845.931540684729, 6875.621840798604, 6894.690008898293, 6897.586144831125, 6647.069410282661, 6672.733090676318, 6681.064650948968, 6751.696173672099, 6756.256811750802, 6539.051837483634, 6589.17635295588, 6629.5359324846795, 6682.365175308338, 6686.264510903699, 6546.0508226307875, 6547.70535325921, 6554.63949482783, 6557.573757705924, 6567.310432404529, 6649.833754156185, 6657.234418041793, 6667.43326817226, 6676.699548520425, 6787.0, 6501.1548498694865, 6521.771737989147, 6530.902036469552, 6546.803595892131, 6550.377714117151], "value": 6206.574815884776, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.2923368967928, 850.914908509149, 888.8577827547593, 1123.1407972900727, 1148.4200478758225, 36171.81914090429, 39539.80230098846, 39624.2075158497, 39750.602493975086, 39756.80121599388, 39737.80131099348, 39843.80078099613, 40071.59928400715, 40168.0, 40184.0, 7368.96315518423, 7692.3076923076915, 7695.923040769577, 7699.422543309246, 7699.6920123195005, 7486.513376630502, 7577.659005344745, 7578.924210757877, 7582.65878035487, 7582.848343033136, 7550.056242969629, 7622.4664273500875, 7626.961865190667, 7635.083789945214, 7635.541867487941, 7542.396608271325, 7560.546367217957, 7601.8479630407355, 7602.049743782028, 7604.695812167507, 7533.322001019879, 7587.544747315179, 7588.962055189744, 7590.089189297264, 7592.658330375147, 36113.63886361129, 36330.091747706254, 36376.27247455063, 36462.45306320407, 36551.08622284437, 3557.786532808014, 3595.9101022474388, 3597.8560857565667, 3600.513930619359, 3600.6219346968455, 30264.54603180932, 30272.54591181134, 30304.0, 30311.545326820116, 30338.84830575833, 5111.386633603955, 5126.71803050832, 5156.871078223037, 5169.56058735008, 5240.8689782755355, 181714.0, 181846.0, 182399.0, 182444.0, 182995.0, 44631.330530042076, 44674.10651786946, 44827.55172448299, 44847.10305793931, 44852.77573612111, 49606.75196624066, 50421.74789126031, 50731.74634126806, 50933.0, 50993.0, 11374.31754094757, 11636.36000020007, 12260.141790074787, 12342.074344424203, 13879.791803122962, 11232.943835280772, 11302.943485282522, 11307.830382544269, 11337.829932551018, 11369.431528423545, 13911.304434778423, 13921.373538190806, 13924.721505570034, 13943.930280348737, 14036.438542458187, 5656.8868622627315, 5825.213596164548, 5900.43945825146, 5900.704964751745, 5942.346341902387, 1004.1213937804421, 1018.5671089786811, 1033.9327943683636, 1034.2760067952313, 1046.053321743823, 22455.43861403478, 23421.882890585777, 27719.86140069287, 28502.0, 28818.567721484196, 1079.881213066562, 1094.9014588687057, 1098.1160166066234, 1098.6209757633603, 1103.0844399148687, 12112.81830772539, 12256.264624122581, 12257.26456412618, 12383.62849114528, 12417.254964702146, 247162.0, 250006.0, 250057.0, 250252.0, 250301.0, 48278.0, 48372.51627483751, 48652.27021594608, 48680.513194868305, 48800.511994880304, 1404.0522647213295, 1416.5679467762432, 1418.2554159066572, 1434.189682829219, 1436.0737324425895, 22020.11919523201, 22058.558828823014, 22082.447938801015, 22218.131706855904, 22437.43906402353, 31908.36183276368, 32269.838650806596, 35974.28051439009, 35992.28015439624, 36022.0, 204425.0, 205519.0, 205602.0, 205655.0, 206002.0, 28005.299867503476, 28685.139445816658, 28761.856190718914, 30191.0, 31084.378312434077, 38993.41509877297, 39074.023149420354, 39200.0, 39535.406968896066, 39653.60346396499, 28671.569926450702, 28724.569131462627, 29282.414351713272, 29346.853265733534, 29506.0, 29307.41385172242, 29470.852645736635, 29487.0, 29559.26101847471, 29764.0, 32623.510647339834, 32753.836230818695, 32917.835410822794, 32969.34061318712, 33096.17259568434, 28664.14007579776, 28897.56653650239, 28909.710902890703, 28982.13053608395, 29032.274193145342, 21912.561748765253, 22001.559968800215, 22081.779182208615, 22248.332550023526, 22348.888255558617], "value": 16539.7296410171, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.7802496039027, 574.7155158196693, 581.3343721438955, 583.775246530086, 591.8934591773481, 20826.271080512186, 21633.459163520918, 21670.24154154605, 21714.24000159995, 22088.447788805286, 25595.488090238185, 26157.86921065392, 26180.345491362725, 26242.868785656046, 26247.47505049898, 6657.533972621931, 6809.080774095508, 6810.557313774613, 6812.7956161315, 6817.863642727142, 6232.6883655817255, 6508.837279068014, 6533.0, 6538.901916471256, 6553.606783592976, 6523.510736694743, 6535.934640653581, 6545.574537655061, 6552.0, 6552.410283074522, 6514.41370276675, 6521.152250207467, 6528.902066469007, 6532.934670653281, 6553.279139294674, 6050.576459647827, 6051.939480605181, 6067.908981365283, 6071.0, 6075.088736689488, 28913.710862891312, 29018.12945611635, 29383.895710110915, 30106.0, 30212.8489357554, 2062.504998800292, 2095.19335056003, 2103.9368818935304, 2108.3780284816016, 2110.5778844231213, 19206.423807285802, 19872.80127198724, 19895.0, 19923.601527969506, 19924.3026494072, 2388.7294858175487, 2408.2775167449695, 2447.4615584571366, 2449.963250551243, 2453.5338285725657, 129871.0, 135482.32258838642, 135700.0, 135908.32045839806, 136124.63875361218, 13950.720985580232, 14645.267736613127, 14901.552953411416, 15146.364872430537, 15372.769408458882, 22769.203077892194, 23428.765712343, 23470.530589388116, 23482.060717571447, 23483.647745283834, 9584.66453674118, 9644.565994530263, 9709.126178643815, 9713.66002189934, 9782.315237933419, 8684.956575217084, 8727.214550690469, 8759.211670949646, 8789.824203516022, 8817.691380801642, 9258.90741092594, 9374.95312523433, 9427.434353938786, 9518.143367096995, 9530.0, 2693.676758788958, 2712.7151649076563, 2714.09077958882, 2746.299693578125, 2772.556390977434, 958.166395236149, 977.7213494154132, 985.3348989432104, 986.7039888033561, 988.0761488008735, 19544.413667589994, 19688.384562006217, 19857.4042778714, 20206.89896550508, 20261.0, 1027.9743006424749, 1030.7783826477194, 1031.3193292427113, 1035.6116456328878, 1043.1811028342715, 10968.780624387467, 10970.616028439126, 10982.560697572168, 11085.224034317682, 11104.833427498594, 462576.0, 463471.0, 476047.0, 499654.0, 503010.0, 112791.0, 115396.0, 116008.0, 124818.0, 131951.3402433001, 1196.5393323570488, 1209.6129238643725, 1245.9688507787196, 1254.3728135932033, 1261.4575732434957, 21042.789572104084, 21082.78917210808, 21490.355289340718, 21607.45981350479, 21998.89000555051, 57512.71243643922, 57712.71143644255, 58645.413545863994, 58957.41042589519, 59061.11408328964, 67092.32907670861, 67271.66364168147, 67548.3245167542, 67865.66067169633, 67915.3208467909, 14454.855451445352, 14947.701045979236, 15021.248937553297, 15027.398904043715, 15035.173065481504, 23403.88298058499, 23523.529529409658, 23698.881505592362, 23748.643770343115, 24683.753162468147, 19813.702794457808, 19951.102200400728, 20108.899455503215, 20231.79768202358, 20267.189312427337, 17509.0, 17627.471175864746, 17881.46355609334, 17890.194941227415, 18444.907775461037, 19248.518787029876, 19674.21303147858, 20358.592828143057, 20551.177952882314, 20627.690584641543, 20941.0, 21418.892905535373, 22082.88958555197, 22091.0, 22165.445863853533, 18450.169742361893, 19445.0, 19577.8042219576, 19720.30978915731, 19765.70351444758], "value": 12279.572929704053, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.3189873164686, 1389.8123753293303, 1408.1691801836914, 1409.7180563887225, 1416.0, 14715.411383544659, 15424.228788560584, 15424.992126535317, 15436.922815385935, 15715.921420392911, 15751.921240393782, 16073.598160046005, 16076.115813630246, 16090.436834710787, 16120.75818862718, 2672.1983404978528, 2752.2844060544203, 2788.0659978907092, 2802.285417218606, 2803.341214814517, 2797.8880844766286, 2841.2754747539348, 2841.8721157547857, 2842.17576902699, 2842.189975856881, 2737.767289780361, 2753.4630747004344, 2766.9031583894566, 2820.675622303441, 2820.971790282091, 2697.4470233602065, 2701.2976626077166, 2711.024031348713, 2711.91864244073, 2713.9050133245437, 2709.4851978124093, 2711.810173287851, 2722.9319267018286, 2724.645796046521, 2725.2641786717477, 14877.925610371878, 15239.847601524065, 15245.0, 15247.847521524865, 15255.08469491834, 7719.536827790351, 7987.281144696947, 8009.559474228915, 8010.839783204362, 8014.398920080959, 5191.844244672666, 5250.7637156328055, 5407.513323800877, 5463.754131064112, 5522.751476183581, 1961.604931585084, 1969.6651569233265, 1978.782333943265, 1982.544014876572, 2040.9285675001452, 26666.200013999613, 26722.331941701417, 26791.73208267912, 26867.73132268672, 26917.19248422531, 7306.780796576111, 7456.291652293024, 7555.433342499335, 7637.732679356196, 7652.502587331805, 17331.30674772995, 17442.215100320514, 17492.037937913283, 17531.73702394465, 17544.035078070574, 8022.438429309892, 8169.63236654352, 8177.427580069457, 8179.9775028121485, 8181.100078991306, 5761.740721667535, 6458.095866578588, 7401.370883474965, 7410.555366678017, 7556.055493063367, 5283.735813209401, 5423.810166644149, 5450.400455949843, 5481.643693159932, 5525.806596769094, 1520.293063725373, 1530.7550791873248, 1559.1035154786043, 1562.0783737594872, 1571.4735563586098, 874.6501399440148, 906.1799071839864, 906.2025417632441, 917.1195652173855, 920.4201353147608, 7566.092068951761, 8765.649374024968, 8768.561571921378, 8853.15894989975, 8937.0, 721.6103304215769, 723.3634401726447, 726.8655298769639, 727.4762171236702, 731.701230316193, 4851.781669824866, 5150.356205474316, 5350.866228344323, 5482.205080263339, 5631.746571404296, 21481.0, 21789.673154902688, 22062.88968555147, 22265.554688906454, 22284.0, 21553.461163470725, 21695.674564881538, 21726.23958161457, 22774.544509110056, 22792.886035569714, 11403.144764142557, 11667.941660291644, 11680.182387232811, 11759.235649682743, 11780.234284771463, 8240.093589705008, 8571.828563428571, 8667.609957551798, 8741.125887411208, 9273.53632318395, 18683.719744203576, 18810.15354309032, 18961.241550337832, 19290.324838631142, 19359.4192174235, 19481.123349449026, 19564.706529402356, 19666.311679091163, 19820.50448738793, 19930.70103948413, 12335.50657973671, 12450.128491005542, 12543.745625437748, 12692.555760548337, 12762.106652534234, 14370.784438233644, 14519.128852268897, 14529.346179422162, 14545.127292362493, 14573.5627931158, 11257.324560526395, 11431.085513159094, 11532.423378830857, 11548.769024619629, 11611.361375124112, 11100.167487438635, 11265.887341126483, 11328.32030078198, 11368.772624547628, 11482.885171148182, 9607.711768646952, 9824.084303560738, 9858.507074646383, 9861.950690246504, 9865.06281903218, 7430.7399241026305, 7434.219406962191, 7463.402927765875, 7473.962630186814, 7601.923980760122, 7838.255365740246, 7891.921080789119, 7892.802679933047, 7898.0, 7980.401469889897], "value": 6791.067098545364, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.04257669960316, 514.7040451740249, 528.9233061206123, 530.8646295194725, 532.1034057612923, 6273.451747483073, 6335.176427064481, 6337.397947195015, 6347.016212487072, 6366.14057102291, 6242.656653884034, 6266.310705822356, 6308.148399966003, 6308.968455157729, 6323.9051414228825, 5199.6360254782185, 5206.297149884774, 5210.661307015051, 5224.6342756007, 5231.816886408977, 4863.14894893394, 4981.676191047589, 5170.405403378603, 5199.922001169966, 5211.843644690665, 4879.828476328035, 4989.151844186497, 4996.375453068366, 5006.0, 5029.170186919154, 4898.755062246873, 4908.337374454439, 4922.849376399089, 4968.850934471971, 4996.7001979881325, 4378.562143785628, 4389.253826849444, 4422.977885110586, 4430.867073987785, 4441.156180325728, 6133.846653833645, 6150.661713605795, 6165.612737134154, 6167.784127555514, 6194.287656919467, 5585.972070139664, 5609.411011843738, 5632.324121105453, 5635.436456354373, 5693.231413759131, 6577.177852768404, 6591.274959754423, 6596.472282217459, 6601.042848786899, 6605.306442823482, 4877.6341774367065, 4911.50884911506, 4934.80260789568, 4953.727544985024, 4966.701997880139, 6677.729571945513, 6682.126685525173, 6791.37007118293, 6791.796246112624, 6930.896036559456, 4988.176950803077, 4996.275540046673, 5008.474110218447, 5021.397432308073, 5030.522100400456, 5054.9241761373605, 5067.569256613156, 5069.543741063322, 5087.694738315713, 5093.796248150033, 5573.7213139343685, 5613.831585052455, 5680.261565996394, 5681.261436013292, 5703.629264097904, 6463.545702217058, 6572.178477690289, 6582.901256481156, 6607.174103237096, 6609.900851487231, 1743.5379624399545, 1745.3070521594034, 1753.281154726556, 1765.6556971390712, 1767.5139336682514, 1145.8682251541013, 1224.6142465123457, 1228.3489750432286, 1231.5751065882257, 1237.6287113865985, 5824.796132135355, 5831.504322132666, 5840.88318233633, 5854.385289544536, 5861.853453663607, 6698.698558564876, 6739.966300168468, 6765.627890465973, 6794.388505034571, 6801.557898736566, 5671.015144699322, 5706.600537962303, 5727.799527016535, 5763.366029736726, 5804.622699524517, 3537.168765340143, 3539.433690609542, 3563.2517171394297, 3574.766705486603, 3625.7643253188457, 6422.165118534561, 6440.259370172396, 6467.773627923, 6504.902426463606, 6510.674466276762, 6832.487563432763, 6862.4853136015, 6895.103636527219, 6955.1653801544135, 6968.233494315621, 5967.522598192134, 6345.524085693683, 6446.613203207822, 6488.351164883568, 6509.544331896722, 6490.8052758417325, 6638.435732962752, 6665.466762658879, 6724.193096828412, 6764.3573860483175, 6631.136773439467, 6683.665816709048, 6701.3298670134545, 6741.629210393476, 6747.021681856201, 6453.483721302191, 6491.935080649322, 6521.032930016926, 6521.478281737354, 6553.672316384257, 4837.4920633332995, 4915.483874193158, 4933.679310844784, 4966.279889416087, 4974.701517908937, 6378.298387177314, 6650.301718319507, 6673.165854268216, 6752.358525940028, 6803.965980170067, 6328.905066423915, 6507.446867016357, 6583.436995738593, 6595.076689263603, 6632.369924857131, 6540.247871494839, 6573.57271777333, 6573.769918052845, 6581.14445122131, 6583.144191255297, 6525.846470664575, 6534.190298171642, 6542.967285163544, 6553.279139294578, 6582.111414958919, 6537.49637583368, 6560.917448620924, 6583.0, 6601.933980660324, 6666.866662666816, 6291.307956124731, 6335.176427064452, 6420.903686444801, 6443.7744678936015, 6457.6771161442675], "value": 5068.337821799523, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [861.0700443520997, 864.3387808326631, 902.3367824648882, 903.837309284329, 907.4283201583002, 17549.21028553715, 19004.14481348339, 20094.69857952132, 20181.89909050453, 20184.293549725764, 15226.086434813891, 15233.00985435946, 15260.160691161982, 15575.241903705544, 19468.318608848695, 929.3633860805336, 941.8398872191709, 942.58997336159, 944.475815922163, 947.6162154327474, 899.644640367058, 981.293468702533, 982.4596471940404, 983.2969426859794, 985.6106837799065, 1040.2354269611828, 1042.4422933730455, 1044.5299615173165, 1046.08467590858, 1047.0, 1047.837585174303, 1048.491481631408, 1048.6172547020358, 1048.8688913885765, 1049.5382031905938, 773.7214602743009, 774.0595176860141, 774.2644487736673, 774.6668932359083, 775.6587101675245, 19024.143913523923, 19250.326238581583, 19941.9002904986, 20103.89948050265, 20160.899195503927, 21555.2455664051, 21770.346889593337, 21983.23058692954, 22049.0, 22093.33719988403, 15817.209139542976, 16001.759973600405, 16102.275397607136, 16124.193790310555, 16152.353905843753, 3681.8711345102793, 3714.962850371489, 3716.2195938852874, 3730.198007428416, 3730.2166545025575, 131264.0, 132319.0, 133023.0, 133861.33069334688, 137732.0, 16648.75026874598, 16996.575085622957, 17061.914690426718, 17104.486865394058, 17161.141942903054, 30627.38745225083, 30726.38547229043, 30753.84623076915, 31466.685333146834, 31610.841945790125, 8767.561621918878, 8792.34057445694, 8864.335174861782, 8874.511901845332, 8896.0, 4278.957210427918, 4322.69741118125, 4344.54382289855, 4354.608085272277, 4362.411074504965, 5195.0, 5294.655847369986, 5308.416074231832, 5313.256144139824, 5332.066888294533, 1110.1230028277732, 1153.4982282707049, 1158.8319693644373, 1160.802663547199, 1165.3998190931677, 683.8051155420682, 690.3903245731144, 694.6110178300169, 702.7118881258659, 715.6314498033516, 12446.439910204062, 13656.65858353549, 13850.930745346208, 13983.391909930488, 14037.481080219997, 642.4603333200134, 644.4972921121532, 675.6891829758268, 682.0962225051826, 689.0456717446373, 5788.913166302509, 6179.81460556184, 6422.100905873182, 6446.161998940108, 6652.968789837583, 104532.47733761283, 108776.4561177189, 109147.0, 110333.0, 112575.0, 94786.52606736922, 95305.0, 95558.52220738852, 95783.52108239554, 95806.0, 82662.58668706618, 83472.58263708765, 85577.57211213904, 86966.56516717376, 87211.0, 12810.167339122927, 12909.935450322688, 12913.031522635652, 12935.935320323339, 12940.870591294342, 38789.41815872821, 39370.0, 39556.80221598873, 39998.80000599979, 41420.58579414288, 52470.0, 52575.0, 53399.0, 53507.46492535181, 54873.45126548684, 17958.19188136511, 18550.44348669542, 18701.6259674803, 18878.24487020504, 19118.713219301444, 19462.513437164183, 19727.0, 19830.00849957525, 19892.801071989674, 19927.60144797125, 19094.713579296043, 19500.0, 19966.700499492228, 20099.59800804005, 20160.79839201589, 18468.0, 19168.808311916702, 19244.326448574793, 19686.704699429232, 19727.506812329808, 18612.720809187602, 18856.0, 19276.421707348803, 19495.610087797882, 19614.509637259183, 12582.433790479266, 12624.431900564314, 12902.80645790295, 13170.682931706753, 13223.404946777611, 14571.377152112722, 14741.92629036848, 15028.248587570359, 15142.54572362831, 15313.846861531687], "value": 9179.39352172555, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 109.0, 99.0, 107.0, 106.0, 108.0, 108.0, 99.0, 110.0, 108.0], "value": 105.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 154.0, 179.0, 123.0, 142.0, 144.0, 117.0, 173.0, 121.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 162.0, 163.0, 162.0, 175.0, 173.0, 164.0, 166.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 172.0, 75.0, 75.0, 73.0, 73.0, 161.0, 79.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 128.0, 79.0, 79.0, 81.0, 140.0, 79.0, 79.0, 124.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 116.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 150.0, 148.0, 149.0, 148.0, 149.0, 148.0, 148.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 54.0, 53.0, 54.0, 53.0, 53.0, 53.0, 59.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 39.0, 37.0, 38.0, 39.0, 39.0, 38.0, 39.0, 38.0], "value": 38.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 75.0, 76.0, 81.0, 74.0, 74.0, 75.0, 75.0, 78.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 124.0, 114.0, 118.0, 116.0, 126.0, 115.0, 121.0, 124.0, 192.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 170.0, 169.0, 168.0, 168.0, 168.0, 169.0, 174.0, 174.0, 166.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 64.0, 64.0, 63.0, 65.0, 70.0, 65.0, 63.0, 68.0, 62.0], "value": 65.9, "unit": "score"}]}]} 03:45:25 INFO - Return code: 0 03:45:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:45:25 INFO - # TBPL SUCCESS # 03:45:25 INFO - Running post-action listener: _package_coverage_data 03:45:25 INFO - Running post-action listener: _resource_record_post_action 03:45:25 INFO - [mozharness: 2017-09-06 10:45:25.456171Z] Finished run-tests step (success) 03:45:25 INFO - Running post-run listener: _resource_record_post_run 03:45:25 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 12288; Write bytes: 396599296; Read time: 24; Write time: 471376 03:45:25 INFO - TinderboxPrint: CPU usage
13.1% 03:45:25 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 24 03:45:25 INFO - TinderboxPrint: I/O write bytes / time
396,599,296 / 471,376 03:45:25 INFO - TinderboxPrint: CPU idle
8,246.8 (86.8%) 03:45:25 INFO - TinderboxPrint: CPU user
1,192.1 (12.6%) 03:45:25 INFO - TinderboxPrint: Swap in / out
0 / 0 03:45:25 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 117108736; Read time: 0; Write time: 206732 03:45:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:45:25 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 12288; Write bytes: 279490560; Read time: 24; Write time: 264644 03:45:26 INFO - Running post-run listener: _upload_blobber_files 03:45:26 INFO - Blob upload gear active. 03:45:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:45:26 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:45:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:45:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:45:26 INFO - (blobuploader) - INFO - Open directory for files ... 03:45:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:45:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:45:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:30 INFO - (blobuploader) - INFO - Done attempting. 03:45:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:45:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:45:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:31 INFO - (blobuploader) - INFO - Done attempting. 03:45:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:45:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:45:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:32 INFO - (blobuploader) - INFO - Done attempting. 03:45:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:45:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:45:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:45:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:45:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:45:33 INFO - (blobuploader) - INFO - Done attempting. 03:45:33 INFO - (blobuploader) - INFO - Iteration through files over. 03:45:33 INFO - Return code: 0 03:45:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:45:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:45:33 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43d0d3199a522452d0f63971a00c4c27fc72bd19beb0523173306dbb60615b638bbf4a24a2c8971e273a950f87f57ba48fa0517665af8d0fc0afae3afcfe2894", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbfb68608540c526593f8a37f4774fec64f3496c9f4b83c268cd5b4db6fd13128f23d71ab6679a05a2c4cd602076dfd0a7e71a8b9c2fd3fe8e38cd1ab888f11b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58d9958274323a78f034ddecd68893581b80b525853e7f9e5d8532d153dc90d106e012bf61e66d5e589f8e51afb7dfaf5b0ff39bcc11d47647058e84ead262b5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc75dda5161d75d19c154486ded7c2bb302bfd8c22db9a53cc53d684bee5c3945efe05cdc77202140f3c16d99fe880c9cbabab49ad54ea6b72ea35fa4af66c8c"} 03:45:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:45:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:45:33 INFO - Contents: 03:45:33 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43d0d3199a522452d0f63971a00c4c27fc72bd19beb0523173306dbb60615b638bbf4a24a2c8971e273a950f87f57ba48fa0517665af8d0fc0afae3afcfe2894", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbfb68608540c526593f8a37f4774fec64f3496c9f4b83c268cd5b4db6fd13128f23d71ab6679a05a2c4cd602076dfd0a7e71a8b9c2fd3fe8e38cd1ab888f11b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58d9958274323a78f034ddecd68893581b80b525853e7f9e5d8532d153dc90d106e012bf61e66d5e589f8e51afb7dfaf5b0ff39bcc11d47647058e84ead262b5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc75dda5161d75d19c154486ded7c2bb302bfd8c22db9a53cc53d684bee5c3945efe05cdc77202140f3c16d99fe880c9cbabab49ad54ea6b72ea35fa4af66c8c"} 03:45:33 INFO - Running post-run listener: copy_logs_to_upload_dir 03:45:33 INFO - Copying logs to upload dir... 03:45:33 INFO - mkdir: /builds/slave/test/build/upload/logs 03:45:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.955758 ========= master_lag: 0.58 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-09-06 03:45:34.058314) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 03:45:34.061814) ========= 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=eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43d0d3199a522452d0f63971a00c4c27fc72bd19beb0523173306dbb60615b638bbf4a24a2c8971e273a950f87f57ba48fa0517665af8d0fc0afae3afcfe2894", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbfb68608540c526593f8a37f4774fec64f3496c9f4b83c268cd5b4db6fd13128f23d71ab6679a05a2c4cd602076dfd0a7e71a8b9c2fd3fe8e38cd1ab888f11b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58d9958274323a78f034ddecd68893581b80b525853e7f9e5d8532d153dc90d106e012bf61e66d5e589f8e51afb7dfaf5b0ff39bcc11d47647058e84ead262b5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc75dda5161d75d19c154486ded7c2bb302bfd8c22db9a53cc53d684bee5c3945efe05cdc77202140f3c16d99fe880c9cbabab49ad54ea6b72ea35fa4af66c8c"} build_url:https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011337 build_url: 'https://queue.taskcluster.net/v1/task/dt_5wMQwQieSp4r1UgpK9Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/43d0d3199a522452d0f63971a00c4c27fc72bd19beb0523173306dbb60615b638bbf4a24a2c8971e273a950f87f57ba48fa0517665af8d0fc0afae3afcfe2894", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bbfb68608540c526593f8a37f4774fec64f3496c9f4b83c268cd5b4db6fd13128f23d71ab6679a05a2c4cd602076dfd0a7e71a8b9c2fd3fe8e38cd1ab888f11b", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/58d9958274323a78f034ddecd68893581b80b525853e7f9e5d8532d153dc90d106e012bf61e66d5e589f8e51afb7dfaf5b0ff39bcc11d47647058e84ead262b5", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fc75dda5161d75d19c154486ded7c2bb302bfd8c22db9a53cc53d684bee5c3945efe05cdc77202140f3c16d99fe880c9cbabab49ad54ea6b72ea35fa4af66c8c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-06 03:45:34.093072) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:45:34.093422) ========= 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=eca2ab57546de7b41f256b19000001ef-1504693482.300619-1646831821 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004753 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-06 03:45:34.174238) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 03:45:34.177562) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-06 03:45:34.177897) ========= ========= Total master_lag: 0.74 =========