builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-066 starttime: 1503539979.8 results: success (0) revision: d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:39.797345) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:39.798128) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:39.798719) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:39.811895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:39.812290) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-23 18:59:39-- 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% 225M=0s 2017-08-23 18:59:40 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114149 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:39.940347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:39.940731) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014489 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:39.992604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:39.993111) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 --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 d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 --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=82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-23 18:59:40,234 truncating revision to first 12 chars 2017-08-23 18:59:40,234 Setting DEBUG logging. 2017-08-23 18:59:40,234 attempt 1/10 2017-08-23 18:59:40,234 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d1c70c20e7b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-23 18:59:40,705 unpacking tar archive at: mozilla-central-d1c70c20e7b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.789323 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:40.799892) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:40.800287) ========= script_repo_revision: d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:40.800754) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:40.801117) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-23 18:59:40.852082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-23 18:59:40.852822) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:59:41 INFO - MultiFileLogger online at 20170823 18:59:41 in /builds/slave/test 18:59:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:59:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:59:41 INFO - {'append_to_log': False, 18:59:41 INFO - 'base_work_dir': '/builds/slave/test', 18:59:41 INFO - 'blob_upload_branch': 'Firefox', 18:59:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:59:41 INFO - 'branch': 'Firefox', 18:59:41 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:41 INFO - 'code_coverage': False, 18:59:41 INFO - 'config_files': ('talos/linux_config.py',), 18:59:41 INFO - 'default_actions': ('clobber', 18:59:41 INFO - 'read-buildbot-config', 18:59:41 INFO - 'download-and-extract', 18:59:41 INFO - 'populate-webroot', 18:59:41 INFO - 'create-virtualenv', 18:59:41 INFO - 'install', 18:59:41 INFO - 'setup-mitmproxy', 18:59:41 INFO - 'run-tests'), 18:59:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:41 INFO - 'disable_ccov_upload': False, 18:59:41 INFO - 'download_minidump_stackwalk': True, 18:59:41 INFO - 'download_symbols': 'ondemand', 18:59:41 INFO - 'enable_stylo': False, 18:59:41 INFO - 'enable_webrender': False, 18:59:41 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 18:59:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:41 INFO - 'gecko_profile': False, 18:59:41 INFO - 'gecko_profile_interval': 0, 18:59:41 INFO - 'installer_path': 'installer.exe', 18:59:41 INFO - 'log_level': 'info', 18:59:41 INFO - 'log_name': 'talos', 18:59:41 INFO - 'log_to_console': True, 18:59:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:59:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:59:41 INFO - 'opt_config_files': (), 18:59:41 INFO - 'pip_index': False, 18:59:41 INFO - 'suite': 'dromaeojs-e10s', 18:59:41 INFO - 'system_bits': '32', 18:59:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:41 INFO - 'title': 'talos-linux64-ix-066', 18:59:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:41 INFO - 'use_talos_json': True, 18:59:41 INFO - 'verify': 'False', 18:59:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:59:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:41 INFO - 'work_dir': 'build'} 18:59:41 INFO - [mozharness: 2017-08-24 01:59:41.228863Z] Running clobber step. 18:59:41 INFO - Running pre-action listener: _resource_record_pre_action 18:59:41 INFO - Running main action method: clobber 18:59:41 INFO - rmtree: /builds/slave/test/build 18:59:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:59:42 INFO - Running post-action listener: _resource_record_post_action 18:59:42 INFO - [mozharness: 2017-08-24 01:59:42.784945Z] Finished clobber step (success) 18:59:42 INFO - [mozharness: 2017-08-24 01:59:42.785043Z] Running read-buildbot-config step. 18:59:42 INFO - Running pre-action listener: _resource_record_pre_action 18:59:42 INFO - Running main action method: read_buildbot_config 18:59:42 INFO - Using buildbot properties: 18:59:42 INFO - { 18:59:42 INFO - "project": "", 18:59:42 INFO - "product": "firefox", 18:59:42 INFO - "who": "kwierso@gmail.com", 18:59:42 INFO - "installer_path": "public/build/target.tar.bz2", 18:59:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:59:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:59:42 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:59:42 INFO - "stage_platform": "linux64-stylosequential", 18:59:42 INFO - "basedir": "/builds/slave/test", 18:59:42 INFO - "buildnumber": 207, 18:59:42 INFO - "platform": "ubuntu64_hw_styloseq", 18:59:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:59:42 INFO - "slavebuilddir": "test", 18:59:42 INFO - "taskId": "X24eNL6JRDehjiuZETnpoQ", 18:59:42 INFO - "branch": "mozilla-central", 18:59:42 INFO - "script_repo_revision": "production", 18:59:42 INFO - "revision": "d1c70c20e7b52f7295411343e4dc5db8ee7c92b9", 18:59:42 INFO - "slavename": "talos-linux64-ix-066", 18:59:42 INFO - "repo_path": "mozilla-central" 18:59:42 INFO - } 18:59:42 INFO - Finding installer, test and symbols from parent task. 18:59:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X24eNL6JRDehjiuZETnpoQ'}, attempt #1 18:59:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X24eNL6JRDehjiuZETnpoQ'}, attempt #1 18:59:43 INFO - Task dependencies: LUZZ1SOYRVeP5njBkcTVNw 18:59:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw'}, attempt #1 18:59:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2 18:59:44 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.test_packages.json 18:59:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.crashreporter-symbols.zip 18:59:44 INFO - Running post-action listener: _resource_record_post_action 18:59:44 INFO - [mozharness: 2017-08-24 01:59:44.137287Z] Finished read-buildbot-config step (success) 18:59:44 INFO - [mozharness: 2017-08-24 01:59:44.137503Z] Running download-and-extract step. 18:59:44 INFO - Running pre-action listener: _resource_record_pre_action 18:59:44 INFO - Running main action method: download_and_extract 18:59:44 INFO - mkdir: /builds/slave/test/build/tests 18:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:59:44 INFO - trying https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.test_packages.json 18:59:44 INFO - Downloading https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:59:44 INFO - Downloaded 989 bytes. 18:59:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:59:44 INFO - Using the following test package requirements: 18:59:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:59:44 INFO - u'common': [u'target.common.tests.zip'], 18:59:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:59:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:59:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:59:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:59:44 INFO - u'mozbase': [u'target.common.tests.zip'], 18:59:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:59:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:59:44 INFO - u'web-platform': [u'target.common.tests.zip', 18:59:44 INFO - u'target.web-platform.tests.tar.gz'], 18:59:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:59:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:59:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.common.tests.zip 18:59:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:59:44 INFO - Fetch https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.common.tests.zip into memory 18:59:45 INFO - Content-Length response header: 54950783 18:59:45 INFO - Bytes received: 54950783 18:59:57 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:59:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.common.tests.zip 18:59:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:59:57 INFO - Fetch https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.common.tests.zip into memory 18:59:58 INFO - Content-Length response header: 54950783 18:59:58 INFO - Bytes received: 54950783 19:00:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.talos.tests.zip 19:00:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:00:10 INFO - Fetch https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.talos.tests.zip into memory 19:00:10 INFO - Content-Length response header: 14496384 19:00:10 INFO - Bytes received: 14496384 19:00:11 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')]} 19:00:11 INFO - trying https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2 19:00:11 INFO - Downloading https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:00:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:00:12 INFO - Downloaded 61057864 bytes. 19:00:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2 19:00:12 INFO - mkdir: /builds/slave/test/properties 19:00:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:00:12 INFO - Writing to file /builds/slave/test/properties/build_url 19:00:12 INFO - Contents: 19:00:12 INFO - build_url:https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2 19:00:12 INFO - Running post-action listener: _resource_record_post_action 19:00:12 INFO - Running post-action listener: find_tests_for_verification 19:00:12 INFO - Running post-action listener: set_extra_try_arguments 19:00:12 INFO - [mozharness: 2017-08-24 02:00:12.283820Z] Finished download-and-extract step (success) 19:00:12 INFO - [mozharness: 2017-08-24 02:00:12.283914Z] Running populate-webroot step. 19:00:12 INFO - Running pre-action listener: _resource_record_pre_action 19:00:12 INFO - Running main action method: populate_webroot 19:00:12 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:00:12 INFO - 'chromez-stylo-e10s': {'talos_options': ['--stylo'], 19:00:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:00:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:00:12 INFO - 'dromaeojs-stylo-e10s': {'talos_options': ['--stylo'], 19:00:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:00:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:00:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:12 INFO - 'g1-stylo-e10s': {'pagesets_name': 'tp5n.zip', 19:00:12 INFO - 'talos_options': ['--stylo'], 19:00:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:00:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:00:12 INFO - 'tests': ['damp', 'tps']}, 19:00:12 INFO - 'g2-stylo-e10s': {'pagesets_name': 'tp5n.zip', 19:00:12 INFO - 'talos_options': ['--stylo'], 19:00:12 INFO - 'tests': ['damp', 'tps']}, 19:00:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:00:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:00:12 INFO - 'g4-stylo-e10s': {'talos_options': ['--stylo'], 19:00:12 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:00:12 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:00:12 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:00:12 INFO - 'g5-stylo-e10s': {'pagesets_name': 'tp5n.zip', 19:00:12 INFO - 'talos_options': ['--stylo'], 19:00:12 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:00:12 INFO - 'other-e10s': {'tests': ['a11yr', 19:00:12 INFO - 'ts_paint', 19:00:12 INFO - 'tpaint', 19:00:12 INFO - 'sessionrestore', 19:00:12 INFO - 'sessionrestore_many_windows', 19:00:12 INFO - 'sessionrestore_no_auto_restore', 19:00:12 INFO - 'tabpaint']}, 19:00:12 INFO - 'other-stylo-e10s': {'talos_options': ['--stylo'], 19:00:12 INFO - 'tests': ['a11yr', 19:00:12 INFO - 'ts_paint', 19:00:12 INFO - 'tpaint', 19:00:12 INFO - 'sessionrestore', 19:00:12 INFO - 'sessionrestore_many_windows', 19:00:12 INFO - 'sessionrestore_no_auto_restore', 19:00:12 INFO - 'tabpaint']}, 19:00:12 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 19:00:12 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 19:00:12 INFO - 'perf-reftest-singletons-stylo-e10s': {'talos_options': ['--stylo'], 19:00:12 INFO - 'tests': ['bloom_basic_singleton']}, 19:00:12 INFO - 'perf-reftest-stylo-e10s': {'talos_options': ['--stylo'], 19:00:12 INFO - 'tests': ['bloom_basic']}, 19:00:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:00:12 INFO - 'tsvgr_opacity', 19:00:12 INFO - 'tart', 19:00:12 INFO - 'tscrollx', 19:00:12 INFO - 'tsvg_static']}, 19:00:12 INFO - 'svgr-stylo-e10s': {'talos_options': ['--stylo'], 19:00:12 INFO - 'tests': ['tsvgx', 19:00:12 INFO - 'tsvgr_opacity', 19:00:12 INFO - 'tart', 19:00:12 INFO - 'tscrollx', 19:00:12 INFO - 'tsvg_static']}, 19:00:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:00:12 INFO - 'tp5o-stylo-e10s': {'pagesets_name': 'tp5n.zip', 19:00:12 INFO - 'talos_options': ['--stylo'], 19:00:12 INFO - 'tests': ['tp5o']}, 19:00:12 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:00:12 INFO - 'talos_options': ['--mitmproxy', 19:00:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:00:12 INFO - '--firstNonBlankPaint'], 19:00:12 INFO - 'tests': ['tp6_google', 19:00:12 INFO - 'tp6_youtube', 19:00:12 INFO - 'tp6_amazon', 19:00:12 INFO - 'tp6_facebook']}, 19:00:12 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:00:12 INFO - 'talos_options': ['--stylo', 19:00:12 INFO - '--mitmproxy', 19:00:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:00:12 INFO - '--firstNonBlankPaint'], 19:00:12 INFO - 'tests': ['tp6_google', 19:00:12 INFO - 'tp6_youtube', 19:00:12 INFO - 'tp6_amazon', 19:00:12 INFO - 'tp6_facebook']}, 19:00:12 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 19:00:12 INFO - 'talos_options': ['--stylo', 19:00:12 INFO - '--stylo-threads=1', 19:00:12 INFO - '--mitmproxy', 19:00:12 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 19:00:12 INFO - '--firstNonBlankPaint'], 19:00:12 INFO - 'tests': ['tp6_google', 19:00:12 INFO - 'tp6_youtube', 19:00:12 INFO - 'tp6_amazon', 19:00:12 INFO - 'tp6_facebook']}, 19:00:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:00:12 INFO - 'talos_options': ['--xperf_path', 19:00:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:12 INFO - 'tests': ['tp5n']}, 19:00:12 INFO - 'xperf-stylo-e10s': {'pagesets_name': 'tp5n.zip', 19:00:12 INFO - 'talos_options': ['--stylo', 19:00:12 INFO - '--xperf_path', 19:00:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:00:12 INFO - 'tests': ['tp5n']}}} 19:00:12 INFO - Running post-action listener: _resource_record_post_action 19:00:12 INFO - [mozharness: 2017-08-24 02:00:12.298071Z] Finished populate-webroot step (success) 19:00:12 INFO - [mozharness: 2017-08-24 02:00:12.298160Z] Running create-virtualenv step. 19:00:12 INFO - Running pre-action listener: _resource_record_pre_action 19:00:12 INFO - Running main action method: create_virtualenv 19:00:12 INFO - Creating virtualenv /builds/slave/test/build/venv 19:00:12 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:00:12 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 19:00:12 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:00:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:00:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:00:13 INFO - Installing distribute.............................................................................................................................................................................................done. 19:00:13 INFO - Installing pip...............done. 19:00:13 INFO - Return code: 0 19:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:00:13 INFO - Reading from file tmpfile_stdout 19:00:13 INFO - Output received: 19:00:13 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 19:00:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:00:13 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')]} 19:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:13 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')]} 19:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:13 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c130>, '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 0x244d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d4c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', '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 19:00:13 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 19:00:13 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 19:00:13 INFO - Using env: {'DISPLAY': ':0', 19:00:13 INFO - 'HOME': '/home/cltbld', 19:00:13 INFO - 'LANG': 'en_US.UTF-8', 19:00:13 INFO - 'LANGUAGE': 'en_US:en', 19:00:13 INFO - 'LOGNAME': 'cltbld', 19:00:13 INFO - 'MAIL': '/var/mail/cltbld', 19:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:13 INFO - 'MOZ_NO_REMOTE': '1', 19:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:13 INFO - 'NO_EM_RESTART': '1', 19:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:13 INFO - 'PWD': '/builds/slave/test', 19:00:13 INFO - 'SHELL': '/bin/bash', 19:00:13 INFO - 'SHLVL': '1', 19:00:13 INFO - 'TERM': 'linux', 19:00:13 INFO - 'TMOUT': '86400', 19:00:13 INFO - 'USER': 'cltbld', 19:00:13 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', 19:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:13 INFO - '_': '/tools/buildbot/bin/python'} 19:00:14 INFO - Ignoring indexes: http://pypi.python.org/simple/ 19:00:14 INFO - Downloading/unpacking pip>=1.5 19:00:14 INFO - Running setup.py egg_info for package pip 19:00:14 INFO - warning: no files found matching 'pip/cacert.pem' 19:00:14 INFO - warning: no files found matching '*.html' under directory 'docs' 19:00:14 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 19:00:14 INFO - no previously-included directories found matching 'docs/_build/_sources' 19:00:14 INFO - Installing collected packages: pip 19:00:14 INFO - Found existing installation: pip 1.1 19:00:14 INFO - Uninstalling pip: 19:00:14 INFO - Successfully uninstalled pip 19:00:14 INFO - Running setup.py install for pip 19:00:14 INFO - warning: no files found matching 'pip/cacert.pem' 19:00:14 INFO - warning: no files found matching '*.html' under directory 'docs' 19:00:14 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 19:00:14 INFO - no previously-included directories found matching 'docs/_build/_sources' 19:00:14 INFO - Installing pip script to /builds/slave/test/build/venv/bin 19:00:14 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 19:00:14 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 19:00:14 INFO - Successfully installed pip 19:00:14 INFO - Cleaning up... 19:00:14 INFO - Return code: 0 19:00:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00: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')]} 19:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:14 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c130>, '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 0x244d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d4c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', '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 19:00:14 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 19:00:14 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 19:00:14 INFO - Using env: {'DISPLAY': ':0', 19:00:14 INFO - 'HOME': '/home/cltbld', 19:00:14 INFO - 'LANG': 'en_US.UTF-8', 19:00:14 INFO - 'LANGUAGE': 'en_US:en', 19:00:14 INFO - 'LOGNAME': 'cltbld', 19:00:14 INFO - 'MAIL': '/var/mail/cltbld', 19:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:14 INFO - 'MOZ_NO_REMOTE': '1', 19:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:14 INFO - 'NO_EM_RESTART': '1', 19:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:14 INFO - 'PWD': '/builds/slave/test', 19:00:14 INFO - 'SHELL': '/bin/bash', 19:00:14 INFO - 'SHLVL': '1', 19:00:14 INFO - 'TERM': 'linux', 19:00:14 INFO - 'TMOUT': '86400', 19:00:14 INFO - 'USER': 'cltbld', 19:00:14 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', 19:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:14 INFO - '_': '/tools/buildbot/bin/python'} 19:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:14 INFO - Downloading/unpacking psutil>=3.1.1 19:00:14 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 19:00:14 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 19:00:14 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 19:00:14 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 19:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:00:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:16 INFO - Installing collected packages: psutil 19:00:16 INFO - Running setup.py install for psutil 19:00:16 INFO - building 'psutil._psutil_linux' extension 19:00:16 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 19:00:16 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 19:00:16 INFO - building 'psutil._psutil_posix' extension 19:00:16 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 19:00:16 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 19:00:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:00:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:00:16 INFO - Successfully installed psutil 19:00:16 INFO - Cleaning up... 19:00:16 INFO - Return code: 0 19:00:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00: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')]} 19:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c130>, '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 0x244d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d4c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', '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 19:00: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:00: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 mozsystemmonitor==0.3 19:00:16 INFO - Using env: {'DISPLAY': ':0', 19:00:16 INFO - 'HOME': '/home/cltbld', 19:00:16 INFO - 'LANG': 'en_US.UTF-8', 19:00:16 INFO - 'LANGUAGE': 'en_US:en', 19:00:16 INFO - 'LOGNAME': 'cltbld', 19:00:16 INFO - 'MAIL': '/var/mail/cltbld', 19:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:16 INFO - 'MOZ_NO_REMOTE': '1', 19:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:16 INFO - 'NO_EM_RESTART': '1', 19:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:16 INFO - 'PWD': '/builds/slave/test', 19:00:16 INFO - 'SHELL': '/bin/bash', 19:00:16 INFO - 'SHLVL': '1', 19:00:16 INFO - 'TERM': 'linux', 19:00:16 INFO - 'TMOUT': '86400', 19:00:16 INFO - 'USER': 'cltbld', 19:00:16 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', 19:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:16 INFO - '_': '/tools/buildbot/bin/python'} 19:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:00:16 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 19:00:16 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 19:00:16 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 19:00:16 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 19:00:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:00:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:00:18 INFO - Installing collected packages: mozsystemmonitor 19:00:18 INFO - Running setup.py install for mozsystemmonitor 19:00:18 INFO - Successfully installed mozsystemmonitor 19:00:18 INFO - Cleaning up... 19:00:18 INFO - Return code: 0 19:00:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:18 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c130>, '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 0x244d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d4c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', '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 19:00:18 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 19:00:18 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 19:00:18 INFO - Using env: {'DISPLAY': ':0', 19:00:18 INFO - 'HOME': '/home/cltbld', 19:00:18 INFO - 'LANG': 'en_US.UTF-8', 19:00:18 INFO - 'LANGUAGE': 'en_US:en', 19:00:18 INFO - 'LOGNAME': 'cltbld', 19:00:18 INFO - 'MAIL': '/var/mail/cltbld', 19:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:18 INFO - 'MOZ_NO_REMOTE': '1', 19:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:18 INFO - 'NO_EM_RESTART': '1', 19:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:18 INFO - 'PWD': '/builds/slave/test', 19:00:18 INFO - 'SHELL': '/bin/bash', 19:00:18 INFO - 'SHLVL': '1', 19:00:18 INFO - 'TERM': 'linux', 19:00:18 INFO - 'TMOUT': '86400', 19:00:18 INFO - 'USER': 'cltbld', 19:00:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', 19:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:18 INFO - '_': '/tools/buildbot/bin/python'} 19:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:18 INFO - Downloading/unpacking jsonschema==2.5.1 19:00:18 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 19:00:18 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 19:00:18 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 19:00:18 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 19:00:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:00: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 19:00: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 19:00: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 19:00: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 19:00:19 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:19 INFO - warning: no files found matching '*.txt' 19:00:19 INFO - no previously-included directories found matching 'build' 19:00:19 INFO - no previously-included directories found matching 'dist' 19:00:19 INFO - no previously-included directories found matching '.git*' 19:00:19 INFO - Installing collected packages: jsonschema, functools32 19:00:19 INFO - Running setup.py install for functools32 19:00:19 INFO - warning: no files found matching '*.txt' 19:00:19 INFO - no previously-included directories found matching 'build' 19:00:19 INFO - no previously-included directories found matching 'dist' 19:00:19 INFO - no previously-included directories found matching '.git*' 19:00:19 INFO - Successfully installed jsonschema functools32 19:00:19 INFO - Cleaning up... 19:00:19 INFO - Return code: 0 19:00:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00: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')]} 19:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00: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', '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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c130>, '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 0x244d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d4c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', '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 19:00: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:00: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 functools32==3.2.3-2 19:00:19 INFO - Using env: {'DISPLAY': ':0', 19:00:19 INFO - 'HOME': '/home/cltbld', 19:00:19 INFO - 'LANG': 'en_US.UTF-8', 19:00:19 INFO - 'LANGUAGE': 'en_US:en', 19:00:19 INFO - 'LOGNAME': 'cltbld', 19:00:19 INFO - 'MAIL': '/var/mail/cltbld', 19:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:19 INFO - 'MOZ_NO_REMOTE': '1', 19:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:19 INFO - 'NO_EM_RESTART': '1', 19:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:19 INFO - 'PWD': '/builds/slave/test', 19:00:19 INFO - 'SHELL': '/bin/bash', 19:00:19 INFO - 'SHLVL': '1', 19:00:19 INFO - 'TERM': 'linux', 19:00:19 INFO - 'TMOUT': '86400', 19:00:19 INFO - 'USER': 'cltbld', 19:00:19 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', 19:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:19 INFO - '_': '/tools/buildbot/bin/python'} 19:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:00:20 INFO - Cleaning up... 19:00:20 INFO - Return code: 0 19:00:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:00:20 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')]} 19:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:20 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')]} 19:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:20 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c130>, '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 0x244d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d4c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', '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 19:00:20 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 19:00:20 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 19:00:20 INFO - Using env: {'DISPLAY': ':0', 19:00:20 INFO - 'HOME': '/home/cltbld', 19:00:20 INFO - 'LANG': 'en_US.UTF-8', 19:00:20 INFO - 'LANGUAGE': 'en_US:en', 19:00:20 INFO - 'LOGNAME': 'cltbld', 19:00:20 INFO - 'MAIL': '/var/mail/cltbld', 19:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:20 INFO - 'MOZ_NO_REMOTE': '1', 19:00:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:20 INFO - 'NO_EM_RESTART': '1', 19:00:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:20 INFO - 'PWD': '/builds/slave/test', 19:00:20 INFO - 'SHELL': '/bin/bash', 19:00:20 INFO - 'SHLVL': '1', 19:00:20 INFO - 'TERM': 'linux', 19:00:20 INFO - 'TMOUT': '86400', 19:00:20 INFO - 'USER': 'cltbld', 19:00:20 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', 19:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:20 INFO - '_': '/tools/buildbot/bin/python'} 19:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:20 INFO - Downloading/unpacking blobuploader==1.2.4 19:00:20 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 19:00:20 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 19:00:20 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 19:00:20 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 19:00:21 INFO - Downloading blobuploader-1.2.4.tar.gz 19:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:00:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:00: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 19:00: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 19:00: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 19:00: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 19:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:00:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:00: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 19:00: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 19:00: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 19:00: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 19:00:21 INFO - Downloading docopt-0.6.1.tar.gz 19:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:21 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:21 INFO - Running setup.py install for blobuploader 19:00:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:00:22 INFO - Running setup.py install for requests 19:00:22 INFO - Running setup.py install for docopt 19:00:22 INFO - Successfully installed blobuploader requests docopt 19:00:22 INFO - Cleaning up... 19:00:22 INFO - Return code: 0 19:00:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00: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')]} 19:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:22 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c130>, '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 0x244d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d4c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', '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 19:00:22 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 19:00:22 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 19:00:22 INFO - Using env: {'DISPLAY': ':0', 19:00:22 INFO - 'HOME': '/home/cltbld', 19:00:22 INFO - 'LANG': 'en_US.UTF-8', 19:00:22 INFO - 'LANGUAGE': 'en_US:en', 19:00:22 INFO - 'LOGNAME': 'cltbld', 19:00:22 INFO - 'MAIL': '/var/mail/cltbld', 19:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:22 INFO - 'MOZ_NO_REMOTE': '1', 19:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:22 INFO - 'NO_EM_RESTART': '1', 19:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:22 INFO - 'PWD': '/builds/slave/test', 19:00:22 INFO - 'SHELL': '/bin/bash', 19:00:22 INFO - 'SHLVL': '1', 19:00:22 INFO - 'TERM': 'linux', 19:00:22 INFO - 'TMOUT': '86400', 19:00:22 INFO - 'USER': 'cltbld', 19:00:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', 19:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:22 INFO - '_': '/tools/buildbot/bin/python'} 19:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:22 INFO - Running setup.py (path:/tmp/pip-c2xPyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:22 INFO - Running setup.py (path:/tmp/pip-9sUpmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:22 INFO - Running setup.py (path:/tmp/pip-euTU3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:23 INFO - Running setup.py (path:/tmp/pip-ygnUlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:23 INFO - Running setup.py (path:/tmp/pip-VudvlP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:23 INFO - Running setup.py (path:/tmp/pip-o6rjqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:23 INFO - Running setup.py (path:/tmp/pip-Y8Okjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:23 INFO - Running setup.py (path:/tmp/pip-6E7aib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:23 INFO - Running setup.py (path:/tmp/pip-0w5elG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:23 INFO - Running setup.py (path:/tmp/pip-uZ8hq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:23 INFO - Running setup.py (path:/tmp/pip-ie7DXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:23 INFO - Running setup.py (path:/tmp/pip-KlyOny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:23 INFO - Running setup.py (path:/tmp/pip-WnAV5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:23 INFO - Running setup.py (path:/tmp/pip-52rbz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:23 INFO - Running setup.py (path:/tmp/pip-UNIgdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:23 INFO - Running setup.py (path:/tmp/pip-G5LDS5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:23 INFO - Running setup.py (path:/tmp/pip-upRE7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:23 INFO - Running setup.py install for manifestparser 19:00:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:00:24 INFO - Running setup.py install for mozcrash 19:00:24 INFO - Running setup.py install for mozdebug 19:00:24 INFO - Running setup.py install for mozdevice 19:00:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:00:24 INFO - Running setup.py install for mozfile 19:00:24 INFO - Running setup.py install for mozhttpd 19:00:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:00:24 INFO - Running setup.py install for mozinfo 19:00:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:00:24 INFO - Running setup.py install for mozInstall 19:00:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:00:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:00:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:00:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:00:24 INFO - Running setup.py install for mozleak 19:00:24 INFO - Running setup.py install for mozlog 19:00:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:00:24 INFO - Running setup.py install for moznetwork 19:00:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:00:25 INFO - Running setup.py install for mozprocess 19:00:25 INFO - Running setup.py install for mozprofile 19:00:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:00:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:00:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:00:25 INFO - Running setup.py install for mozrunner 19:00:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:00:25 INFO - Running setup.py install for mozscreenshot 19:00:25 INFO - Running setup.py install for moztest 19:00:25 INFO - Running setup.py install for mozversion 19:00:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:00:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:25 INFO - Cleaning up... 19:00:25 INFO - Return code: 0 19:00:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00: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')]} 19:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:25 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c130>, '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 0x244d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d4c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', '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 19:00:25 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 19:00:25 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 19:00:25 INFO - Using env: {'DISPLAY': ':0', 19:00:25 INFO - 'HOME': '/home/cltbld', 19:00:25 INFO - 'LANG': 'en_US.UTF-8', 19:00:25 INFO - 'LANGUAGE': 'en_US:en', 19:00:25 INFO - 'LOGNAME': 'cltbld', 19:00:25 INFO - 'MAIL': '/var/mail/cltbld', 19:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:25 INFO - 'MOZ_NO_REMOTE': '1', 19:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:25 INFO - 'NO_EM_RESTART': '1', 19:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:25 INFO - 'PWD': '/builds/slave/test', 19:00:25 INFO - 'SHELL': '/bin/bash', 19:00:25 INFO - 'SHLVL': '1', 19:00:25 INFO - 'TERM': 'linux', 19:00:25 INFO - 'TMOUT': '86400', 19:00:25 INFO - 'USER': 'cltbld', 19:00:25 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', 19:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:25 INFO - '_': '/tools/buildbot/bin/python'} 19:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:25 INFO - Running setup.py (path:/tmp/pip-sd8z_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:26 INFO - Running setup.py (path:/tmp/pip-gyfWEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:26 INFO - Running setup.py (path:/tmp/pip-w6ZSKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:26 INFO - Running setup.py (path:/tmp/pip-dUAP47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:26 INFO - Running setup.py (path:/tmp/pip-3vACbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:26 INFO - Running setup.py (path:/tmp/pip-zgSWz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:26 INFO - Running setup.py (path:/tmp/pip-4dIHQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:26 INFO - Running setup.py (path:/tmp/pip-WQsoZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:26 INFO - Running setup.py (path:/tmp/pip-55XHgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:26 INFO - Running setup.py (path:/tmp/pip-4grrLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:26 INFO - Running setup.py (path:/tmp/pip-wo5ign-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:26 INFO - Running setup.py (path:/tmp/pip-At4wBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:26 INFO - Running setup.py (path:/tmp/pip-YmOnr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:26 INFO - Running setup.py (path:/tmp/pip-_h0gzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:26 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)) 19:00:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:26 INFO - Running setup.py (path:/tmp/pip-p8XorF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:27 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)) 19:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:27 INFO - Running setup.py (path:/tmp/pip-YiJsn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:27 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)) 19:00:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:27 INFO - Running setup.py (path:/tmp/pip-Zr2ADM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:27 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)) 19:00:27 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)) 19:00:27 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)) 19:00:27 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)) 19:00:27 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)) 19:00:27 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)) 19:00:27 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)) 19:00:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:28 INFO - Downloading blessings-1.6.tar.gz 19:00:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:28 INFO - Installing collected packages: blessings 19:00:28 INFO - Running setup.py install for blessings 19:00:28 INFO - Successfully installed blessings 19:00:28 INFO - Cleaning up... 19:00:28 INFO - Return code: 0 19:00:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:00:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:28 INFO - Reading from file tmpfile_stdout 19:00:28 INFO - Current package versions: 19:00:28 INFO - argparse == 1.2.1 19:00:28 INFO - blessings == 1.6 19:00:28 INFO - blobuploader == 1.2.4 19:00:28 INFO - docopt == 0.6.1 19:00:28 INFO - functools32 == 3.2.3-2 19:00:28 INFO - jsonschema == 2.5.1 19:00:28 INFO - manifestparser == 1.1 19:00:28 INFO - mozInstall == 1.13 19:00:28 INFO - mozcrash == 1.0 19:00:28 INFO - mozdebug == 0.1 19:00:28 INFO - mozdevice == 0.51 19:00:28 INFO - mozfile == 1.2 19:00:28 INFO - mozhttpd == 0.7 19:00:28 INFO - mozinfo == 0.10 19:00:28 INFO - mozleak == 0.1 19:00:28 INFO - mozlog == 3.5 19:00:28 INFO - moznetwork == 0.27 19:00:28 INFO - mozprocess == 0.25 19:00:28 INFO - mozprofile == 0.28 19:00:28 INFO - mozrunner == 6.13 19:00:28 INFO - mozscreenshot == 0.1 19:00:28 INFO - mozsystemmonitor == 0.3 19:00:28 INFO - moztest == 0.8 19:00:28 INFO - mozversion == 1.4 19:00:28 INFO - psutil == 3.1.1 19:00:28 INFO - requests == 1.2.3 19:00:28 INFO - wsgiref == 0.1.2 19:00:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00: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')]} 19:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:28 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 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c130>, '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 0x244d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d4c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', '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 19:00:28 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 19:00:28 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 19:00:28 INFO - Using env: {'DISPLAY': ':0', 19:00:28 INFO - 'HOME': '/home/cltbld', 19:00:28 INFO - 'LANG': 'en_US.UTF-8', 19:00:28 INFO - 'LANGUAGE': 'en_US:en', 19:00:28 INFO - 'LOGNAME': 'cltbld', 19:00:28 INFO - 'MAIL': '/var/mail/cltbld', 19:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:28 INFO - 'MOZ_NO_REMOTE': '1', 19:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:28 INFO - 'NO_EM_RESTART': '1', 19:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:28 INFO - 'PWD': '/builds/slave/test', 19:00:28 INFO - 'SHELL': '/bin/bash', 19:00:28 INFO - 'SHLVL': '1', 19:00:28 INFO - 'TERM': 'linux', 19:00:28 INFO - 'TMOUT': '86400', 19:00:28 INFO - 'USER': 'cltbld', 19:00:28 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', 19:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:28 INFO - '_': '/tools/buildbot/bin/python'} 19:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:28 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)) 19:00:28 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)) 19:00:28 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)) 19:00:28 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)) 19:00:28 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)) 19:00:28 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)) 19:00:28 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)) 19:00:28 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)) 19:00:28 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)) 19:00:28 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 19:00:30 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)) 19:00:30 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)) 19:00:30 INFO - Installing collected packages: simplejson 19:00:30 INFO - Running setup.py install for simplejson 19:00:30 INFO - building 'simplejson._speedups' extension 19:00:30 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 19:00:30 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 19:00:31 INFO - Successfully installed simplejson 19:00:31 INFO - Cleaning up... 19:00:31 INFO - Return code: 0 19:00:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00: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')]} 19:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22aba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x244ef90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x244c130>, '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 0x244d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d4c0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', '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 19:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:00:31 INFO - Using env: {'DISPLAY': ':0', 19:00:31 INFO - 'HOME': '/home/cltbld', 19:00:31 INFO - 'LANG': 'en_US.UTF-8', 19:00:31 INFO - 'LANGUAGE': 'en_US:en', 19:00:31 INFO - 'LOGNAME': 'cltbld', 19:00:31 INFO - 'MAIL': '/var/mail/cltbld', 19:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:31 INFO - 'MOZ_NO_REMOTE': '1', 19:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:31 INFO - 'NO_EM_RESTART': '1', 19:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:31 INFO - 'PWD': '/builds/slave/test', 19:00:31 INFO - 'SHELL': '/bin/bash', 19:00:31 INFO - 'SHLVL': '1', 19:00:31 INFO - 'TERM': 'linux', 19:00:31 INFO - 'TMOUT': '86400', 19:00:31 INFO - 'USER': 'cltbld', 19:00:31 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', 19:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:31 INFO - '_': '/tools/buildbot/bin/python'} 19:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:00:31 INFO - Cleaning up... 19:00:31 INFO - Return code: 0 19:00:31 INFO - Running post-action listener: _resource_record_post_action 19:00:31 INFO - Running post-action listener: _start_resource_monitoring 19:00:31 INFO - Starting resource monitoring. 19:00:31 INFO - [mozharness: 2017-08-24 02:00:31.396124Z] Finished create-virtualenv step (success) 19:00:31 INFO - [mozharness: 2017-08-24 02:00:31.396595Z] Running install step. 19:00:31 INFO - Running pre-action listener: _resource_record_pre_action 19:00:31 INFO - Running main action method: install 19:00:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:31 INFO - Reading from file tmpfile_stdout 19:00:31 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:00:31 INFO - Reading from file tmpfile_stdout 19:00:31 INFO - Output received: 19:00:31 INFO - Usage: mozinstall [options] installer 19:00:31 INFO - Options: 19:00:31 INFO - -h, --help show this help message and exit 19:00:31 INFO - -d DEST, --destination=DEST 19:00:31 INFO - Directory to install application into. [default: 19:00:31 INFO - "/builds/slave/test"] 19:00:31 INFO - --app=APP Application being installed. [default: firefox] 19:00:31 INFO - mkdir: /builds/slave/test/build/application 19:00:31 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'] 19:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:00:49 INFO - Reading from file tmpfile_stdout 19:00:49 INFO - Output received: 19:00:49 INFO - /builds/slave/test/build/application/firefox/firefox 19:00:49 INFO - Running post-action listener: _resource_record_post_action 19:00:49 INFO - [mozharness: 2017-08-24 02:00:49.363188Z] Finished install step (success) 19:00:49 INFO - [mozharness: 2017-08-24 02:00:49.363439Z] Running setup-mitmproxy step. 19:00:49 INFO - Running pre-action listener: _resource_record_pre_action 19:00:49 INFO - Running main action method: setup_mitmproxy 19:00:49 INFO - Skipping: mitmproxy is not required 19:00:49 INFO - Running post-action listener: _resource_record_post_action 19:00:49 INFO - [mozharness: 2017-08-24 02:00:49.364561Z] Finished setup-mitmproxy step (success) 19:00:49 INFO - [mozharness: 2017-08-24 02:00:49.364780Z] Running run-tests step. 19:00:49 INFO - Running pre-action listener: _resource_record_pre_action 19:00:49 INFO - Running pre-action listener: _set_gcov_prefix 19:00:49 INFO - Running main action method: run_tests 19:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:00:49 INFO - Python 2.7.3 19:00:49 INFO - Return code: 0 19:00:49 INFO - grabbing minidump binary from tooltool 19:00:49 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')]} 19:00:49 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 0x244c130>, '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 0x244d030>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x244d4c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:00:49 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 19:00:49 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 19:00:49 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 19:00:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:00:49 INFO - Return code: 0 19:00:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:00:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:00:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:00:49 INFO - ENV: RUST_BACKTRACE is now full 19:00:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:00:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:00:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 19:00:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 19:00:49 INFO - Using env: {'DISPLAY': ':0', 19:00:49 INFO - 'HOME': '/home/cltbld', 19:00:49 INFO - 'LANG': 'en_US.UTF-8', 19:00:49 INFO - 'LANGUAGE': 'en_US:en', 19:00:49 INFO - 'LOGNAME': 'cltbld', 19:00:49 INFO - 'MAIL': '/var/mail/cltbld', 19:00:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:00:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:49 INFO - 'MOZ_NO_REMOTE': '1', 19:00:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:49 INFO - 'NO_EM_RESTART': '1', 19:00:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:49 INFO - 'PWD': '/builds/slave/test', 19:00:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:00:49 INFO - 'RUST_BACKTRACE': 'full', 19:00:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:00:49 INFO - 'SHELL': '/bin/bash', 19:00:49 INFO - 'SHLVL': '1', 19:00:49 INFO - 'STYLO_FORCE_ENABLED': '1', 19:00:49 INFO - 'TERM': 'linux', 19:00:49 INFO - 'TMOUT': '86400', 19:00:49 INFO - 'USER': 'cltbld', 19:00:49 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237', 19:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:49 INFO - '_': '/tools/buildbot/bin/python'} 19:00:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 19:00:49 INFO - mozversion application_buildid: 20170824010741 19:00:49 INFO - mozversion application_changeset: d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 19:00:49 INFO - mozversion application_display_name: Nightly 19:00:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:00:49 INFO - mozversion application_name: Firefox 19:00:49 INFO - mozversion application_remotingname: firefox 19:00:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:00:49 INFO - mozversion application_vendor: Mozilla 19:00:49 INFO - mozversion application_version: 57.0a1 19:00:49 INFO - mozversion platform_buildid: 20170824010741 19:00:49 INFO - mozversion platform_changeset: d1c70c20e7b52f7295411343e4dc5db8ee7c92b9 19:00:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:00:49 INFO - mozversion platform_version: 57.0a1 19:00:49 INFO - using testdate: 1503540049 19:00:49 INFO - actual date: 1503540049 19:00:49 INFO - starting webserver on 'localhost:45441' 19:00:49 INFO - SUITE-START | Running 2 tests 19:00:49 INFO - TEST-START | dromaeo_css 19:00:49 INFO - Initialising browser for dromaeo_css test... 19:00:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45441/getInfo.html -profile /tmp/tmp7IwNPI/profile 19:00:49 INFO - TEST-INFO | started process 3251 (/builds/slave/test/build/application/firefox/firefox http://localhost:45441/getInfo.html) 19:00:55 INFO - TEST-INFO | 3251: exit 0 19:00:56 INFO - Browser initialized. 19:00:56 INFO - Running cycle 1/1 for dromaeo_css test... 19:00:56 INFO - TEST-INFO | started process 3437 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7IwNPI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:57 INFO - PID 3437 | 19:00:57 INFO - PID 3437 | (/builds/slave/test/build/application/firefox/firefox:3488): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:00:57 INFO - PID 3437 | 19:00:57 INFO - PID 3437 | 19:00:57 INFO - PID 3437 | (/builds/slave/test/build/application/firefox/firefox:3550): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:00:57 INFO - PID 3437 | 19:00:57 INFO - PID 3437 | __metrics Screen width/height:1600/1200 19:00:57 INFO - PID 3437 | colorDepth:24 19:00:57 INFO - PID 3437 | Browser inner width/height: 1024/768 19:00:57 INFO - PID 3437 | __metrics 19:01:07 INFO - PID 3437 | RSS: Main: 174370816 19:01:07 INFO - PID 3437 | 19:04:06 INFO - PID 3437 | Cycle 1(1): loaded http://localhost:45441/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45441/tests/dromaeo/cssquery-ext.html) 19:04:07 INFO - PID 3437 | RSS: Main: 176222208 19:04:07 INFO - PID 3437 | 19:07:09 INFO - PID 3437 | Cycle 1(1): loaded http://localhost:45441/tests/dromaeo/cssquery-ext.html (next: http://localhost:45441/tests/dromaeo/cssquery-jquery.html) 19:07:09 INFO - PID 3437 | RSS: Main: 175362048 19:07:09 INFO - PID 3437 | 19:10:11 INFO - PID 3437 | Cycle 1(1): loaded http://localhost:45441/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45441/tests/dromaeo/cssquery-mootools.html) 19:10:12 INFO - PID 3437 | RSS: Main: 177324032 19:10:12 INFO - PID 3437 | 19:13:14 INFO - PID 3437 | Cycle 1(1): loaded http://localhost:45441/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45441/tests/dromaeo/cssquery-prototype.html) 19:13:14 INFO - PID 3437 | RSS: Main: 175468544 19:13:14 INFO - PID 3437 | 19:16:18 INFO - PID 3437 | Cycle 1(1): loaded http://localhost:45441/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45441/tests/dromaeo/cssquery-yui.html) 19:16:19 INFO - PID 3437 | RSS: Main: 179249152 19:16:19 INFO - PID 3437 | 19:19:20 INFO - PID 3437 | Cycle 1(1): loaded http://localhost:45441/tests/dromaeo/cssquery-yui.html (next: http://localhost:45441/tests/dromaeo/cssquery-dojo.html) 19:19:21 INFO - PID 3437 | RSS: Main: 179654656 19:19:21 INFO - PID 3437 | 19:19:21 INFO - PID 3437 | __start_tp_report 19:19:21 INFO - PID 3437 | _x_x_mozilla_page_load 19:19:21 INFO - PID 3437 | _x_x_mozilla_page_load_details 19:19:21 INFO - PID 3437 | |i|pagename|runs| 19:19:21 INFO - PID 3437 | |0;dojo.html;3275.230320874594;3278.08213700164;3300.1089705779455;3307.7684562080653;3318.2865683877963;6195.101710252011;6221.160143380643;6222.408871157233;6238.62568245905;6253.437190652846;6119.755209791603;6213.844653883655;6230.221222347207;6231.937680623192;6232;5733.684647344395;5748.655080695172;5797.246357973458;5825.679587622679;5857.8828423431505;5713.028785106521;5759.5968282220265;5799.681017544033;5802.39074897136;5900.911486327687;5554.694491802969;5626.071698169797;5652.067408877571;5659.009673307175;5697.544196464273;5741.712914354265;5753.626014309057;5776.306843178803;5807.767689292423;5827.88344233113;5593.32880054392;5664.858378540528;5671.9716401418145;5747.856303592402;5771.682557459338;6133.417325354084;6159.38406159385;6174.691265436711;6208.379162083801;6247.187865577446;6578.309277525838;6580.5393622446445;6652.168478940132;6671.432928201109;6707.93292067078;6637.2367177774695;6668.366505182;6751.358620931003;6762.2223444304045;6849.897251541231;6087.421694938974;6259.4679452246155;6341.55609107358;6354.364563543655;6379.968100159516;6852.109225800614;6879.828004299932;6956;6959.791206263821;6980.546264492893;6404.231492220963;6496.447801936793;6569.343065693392;6602.933970660328;6646.069550262967;6614.6361950093205;6655.367740064686;6658.866822663616;6663.433608143265;6665.966670166715;6599.043138744855;6615.801525954229;6621.27166011748;6700.061991321219;6706.094677218611;6707.496937729592;6734.3602357775935;6750.932490675031;6794.0827988221945;6815.965920170367;4840.419149701988;4896.4858689837765;4900.509949005071;4909.533594308535;4921.434035086011;4339.804708788112;4345.152695224464;4391.165678521071;4397.098594788061;4408.9118217636105;5873.383294754075;5938.376470470625;5965.821025369159;5991.370906054802;6003.0695242237525;6701.865962680817;6706.094677218513;6781.6609169541325;6794;6826.590404575742;5791.768329266866;5855.882882342415;5863.355030946593;5872.618279811799;5881;5719.771209151588;5746.2529871116485;5817.360090390053;5824.534037277008;5824.825255242349;6395.584287021422;6400.103985442041;6486.4486518646445;6487.3836985486305;6492.318306577836;6689.431398331002;6706.094677218708;6773.18721753373;6781.762638307636;6783.626900520519;6297.307296197506;6391.296957334783;6397.96801015992;6492.805215843532;6501.804945851632;6550.213974323112;6598.670066496752;6629.701663425061;6651.7006734698025;6654.633995130121;6665.366790154928;6758.2903795102775;6776.119104516579;6810.216825064983;6830.248672645906;6417.743290268337;6436.67816609177;6458.095866578588;6510.18622672166;6543.1821022372205;6472.708728107341;6497.805065848032;6539.182602174728;6554.770583029571;6562.278149403466;6435.742570297136;6449.677516124269;6468.741250349934;6486.578372405778;6522.771702990372;6485.578437401554;6495;6579.144711187515;6599.5050371223315;6643.468522518284;6054.39456054391;6137.539684523768;6271.62370257786;6368.299487056327;6382.776602818879 19:19:21 INFO - PID 3437 | |1;ext.html;772.362800689431;781.3436713160945;808.6603626476879;1143.999000874235;1158.3571118029502;30183;40683.18633627329;41427.585724142715;41520.79239603798;41548.58451415492;41625.16749665005;42151.57848421515;42159.156816863644;42215.78892105543;42269.788651056704;7744.49660772048;7891.013623297088;7893.486923349992;7894.684212631488;7895.368370530344;7762.45662803604;7828.178041305667;7835.608219589027;7840.803979900519;7854.7250846220395;7614.809629759245;7843.058832940055;7851.725189618364;7852.528848269094;7852.685892564291;7747.612619369037;7847.96076019622;7852.17552157021;7855.764327070197;7860.68557257709;7692.730754423625;7733.922660773376;7745.225477452266;7751.534907905488;7799.883001754978;38032.80983595064;38310.616893830986;38337;38364;38506.07469626536;3515.3145136698354;3532.434810430319;3544.6278140795102;3546.7871927684164;3547.8048707321086;31143.532847007315;31417.8429107853;31447.84276078628;31459;31530.211744706565;4928.654994150411;5145.6398052136365;5159.5614372778355;5196.402413722432;5220.451852555465;196701;196956;197439;197739;198188;46679.533204668194;46811.063778724914;46858.76570617193;46957;46993.295100573516;49125.50874491209;49232.261516077284;49352;49360.50639493631;49551.75224123929;15785.289661965238;15989.520314390587;16078.839211607969;16101.597460063593;16147.273372698257;13201.73596528064;13214.207147571176;13247.80128298057;13249.867501325056;13254.668633284246;12501.24992500453;12818.55135070268;14054.086484378482;14228;15415.768763468557;5956.255468066492;6164.106204600308;6164.167837341902;6164.722587483574;6202.875942481125;1006.2050979726081;1025.707673313117;1033.540074666781;1036.383351905615;1044.613493007592;23387;23952.760472395054;24179.274621761375;24195.51608967811;25542.48915021689;1114.8662160540787;1119.4179026905963;1119.6137332620233;1126.4592995362273;1127.3799410324289;12217.51129954792;12256.387180640932;12283.938580307042;12335.198212116184;12361.134720569475;240597;241902;241978;242662;243291;51117.74441127771;51420.48579514157;51476.742616286676;51514.48485515172;51698;1438.6691061056015;1451.0930668332292;1453.2080016391092;1456.6358410397402;1459.4381163252012;22379.77620223777;22438.663420048386;22464.438389040406;22831.20090796814;22853.428664283525;36711.26577468382;36973.63026369702;37013.25973480461;37066.62933370632;37125.628743712216;200924;201472;201857;202068;202371;33463.66536334605;33608.66391336056;33629.32741345208;33776.32447351088;33858.49212261867;35951.820240898625;40077.799611001756;40951;41097.58902410937;41527;30569.54145687772;30710.846445767627;30862.074137775904;30898;31359;30358.241043974078;30397.544036839907;30432.239194020327;30544.541831872983;30872.53691194589;34866.302673946884;35033.82483087568;35125.473117902744;35152;35220.64779352276;30024.24939376533;30037.24906877258;30039.84980075173;30050;30201.546976794925;22298.88850555737;22372.776272237068;22702.09191632382;22873.542529149658;22945.65581516312 19:19:21 INFO - PID 3437 | |2;jquery.html;554.2074832988827;554.7725432572646;559.6222549778898;561.4609974424552;564.887022595481;21632.675509867364;22014.559708805813;22947.770522294773;22989.195378161767;22998.88500557495;24202;25005.49989000219;25030.624540631907;25136.120235791706;25144.622830657554;6476.74093036278;6575.309592492791;6623.900641490357;6632.237292711352;6646.700898459557;6264.27960784511;6467.256265529454;6523.543351965364;6534.052562378452;6542.182227221598;6446.774362897299;6462.903056454157;6490.383413575702;6508;6527.053577231299;6486.448651864597;6513.902291465632;6533.118029066063;6535.836604084889;6536.93463065368;6021.458068773788;6023.578349515536;6028.065649824284;6048.092786082123;6061.242344706911;27987;28793.568096478568;29370.55944160839;29386.41227175466;29445.11664650064;2036.0837623069679;2075.94126995232;2077.8233850122756;2078.8025137611903;2081.2819577245828;19337.9033104835;19444.805551944442;20005.699914501292;20284.695729564068;20314.898425507927;2454.607262837955;2465.432950421395;2513.0576033987254;2523.6466894634764;2526.987365063163;135666.32166839202;139542;140049;140224.29887850597;140586;14278.928605356907;14312.28438578067;14516;14723.190224537539;14794.852051479562;22972;22990.310290691305;22993.770062299496;23056.19303324409;23125.7687423127;10044.347117437343;10257.692269231935;10281.74295642615;10360.979608976328;10531.684049478528;7945.165757595485;8028.83942321162;9727.708168754949;9737.367071140496;9935.155511781435;8731.781705457415;8871.866921996176;8970;9039.186473217442;9117.270618350516;2514.981432519832;2522.823402361854;2568.576184929466;2662.467506498708;2663.440677457717;955.5604421965835;966.260651054255;969.8157350103457;983.8425851863667;989.0653332600623;19586.21655133807;19710.21159153618;19964.50088747793;19988.800111998695;24056.676882771266;1033.2302434686208;1052.4579841381694;1059.3220338983058;1061.4851796878509;1074.070928646715;10893.128549716004;11131.666050018512;11161.218714689894;11315.321080735182;11630.244034137753;481510;483770;484530;531393;532978;118918.4054079724;120767;120995;122709;124766.37616812039;1229.1764517773113;1244.8630650628425;1255.190402190582;1260.0738457233927;1260.9558665446482;18874.622507550048;18945.242190312783;19012.049397530343;19075.713864292324;19102.522436939187;62904.685476572326;64030.3596964043;64352.35647643464;64801;65661;72131;72907.27092729005;73444.26555734374;73450.63274683592;73606.26393735994;16264.756028659343;18325.450236492925;20535.794642053388;21077.262295820186;21353.25263615766;22612;22621.43446413853;22772.089116435156;23201;23278.76721232766;18443.538911527317;18454.538636534195;18563.535911602317;18578.44264672062;18638.627227455647;15589.532314030597;15616.297266623256;15639.139847308506;15809.920950395175;15875.285612147713;19082.904585476983;19103.140358683613;19117.23531058742;19135.71296430527;19253;20403.69394459114;20409.387718368474;20513;20719.792802071785;20756.688649669966;18156.27374904989;18202.635947280716;18251.81748182501;18337.174827132545;18410.711250212356 19:19:21 INFO - PID 3437 | |3;mootools.html;1293.7089154940138;1341.899357548184;1348.1439286053353;1355.9084936626011;1363.5568440256914;14293.857061429382;14982.175980321077;15026.624334391632;15060.623484412881;15089.924550377233;12405.317707526083;12851.550195743128;12857.614271571845;14707.779383309258;15193.77209341858;2689.4217743185163;2729.372244383793;2730.4675588260297;2730.5085084684747;2732.8496932668795;2648.8410695358243;2748.8350698958125;2749.6562929633797;2750.8624568771584;2752.2431331383827;2602.4404752978107;2729.0311939261474;2743.067357098596;2754.7107553706874;2756.503829310723;2748.038186634682;2758.917232483029;2788.5538313869783;2789.386335006295;2792.0786140573564;2684.1276585109918;2698.1500827239356;2713.3894873653467;2729.6997330293652;2740.767034802024;14157;14335.283235838166;14457.349419276157;14466.566003019821;14519.637009074751;7911.367090632793;8165.959170204171;8204.466709663853;8222.38332125087;8223.629936652866;5369.9463005369835;5467.535259502947;5541.9168712468945;5629.099344104964;5670.319561652587;1901.7337572739827;1924.807519248078;1945.2802463088606;1973.5658155205974;1979.772326182493;25258.115965941102;25462.745372546407;25487;25522.872385637955;25531.744682553122;6490.707918143695;6663.4669226461765;6758.763443279461;6772.153480814898;6800.557963732342;16731.079790611635;16742.83257167437;16756.078415687254;16757.916210419113;16770.245338959776;7266.091738532684;7415.555066696015;7707.807304817312;7789.727359542502;7792.961035194788;7172.354488096096;7214.0621719177225;7215.49491535598;7233.638318084075;7234.66158760631;5104.259882317043;5125;5143.7685304161405;5144.6913185209005;5218.425973142951;1372.8078069070139;1522.2236659303614;1529.5487831089633;1538.2001359293106;1559.6724687815686;736.5654263984275;872.8821609082693;900.3697411811627;903.2864037410372;925.6297481007516;7889.960550197212;8030.638621262057;8122.918770812216;8240.670373185005;8439.156084391634;950.14486961735;973.3964941736027;1008.2538921198407;1009.7021378693303;1017.811704834608;5259.500347466985;5387.919181212285;5509.862253443696;5512.283403157564;5605.747741351649;20351.796482035286;21353.46616334573;21466.356009319745;21490.24784132548;21508.139674412847;20013.699794503093;20863.8956805215;21337;21395.144194232056;21617.78382216189;10298.639547615798;10627;10646.254762166574;10661.573537058586;10679.466026698634;8329.167083291622;8610.870836937576;8688.869666955126;8765.07966663491;9098.954505227432;17464.388746394325;17508.99999999949;17775.644487110443;17921.28314867391;18242.45272641823;17949.820501795337;18050.097495125454;18123.818761812214;18136.782441509575;18362.265509379475;11442.313461192354;11984.820227696766;11997;12087.879121209027;12106.092043096627;13408.463661453432;13413.731725365633;13526;13537.864621353661;13573.11774734639;11051.889481105087;11076.556937722724;11173.162012848907;11212.159088068265;11416.828747568627;10902.727431814268;10938.398388088413;10989.725256868642;11029.172812039289;11222.607208747655;9846.113849753556;9942.502874856084;9962.750931226778;9974.251931105051;10045.196384289386;7358.337749602561;7407.888816677541;7441.293077157661;7451.888221676788;7486.812829679302;7546.547207167588;7707.499012564165;7724.729634462767;7745;7769.72805951789 19:19:21 INFO - PID 3437 | |4;prototype.html;501.3657722980428;506.71623890621254;517.8498235511702;524.7009204753291;524.7979527881764;6213.627182369061;6248.750049998001;6282.654454005034;6323.766865461237;6328.772326113686;6039.637621742699;6110.755569777203;6205.286392064914;6228.564000519966;6280.80171939822;5151.562117220041;5162.6128040397125;5169.224616307565;5169.999999999991;5241;4832.323474713526;5016.774245158977;5098.439171691111;5187.3775146982225;5211.400688920785;4931.556159945604;4971;4972.179590367585;4996.375453068366;5028.547430731233;4802;4999.725015124167;5013.548780609763;5036.974815125937;5042.5209605087275;4425.933610995838;4431.645468362523;4434.933475997863;4474.686771925966;4496;5988.19159413478;6035.939640603582;6072.696365181768;6101.115338275969;6140.50875929929;5599.740058486848;5640.943590564083;5681.460261275172;5748.42515748426;5760.243125846615;6448.290688024314;6484.319146489598;6493.610383377012;6529.877789718361;6565.57323773958;4863.732494712789;4901.828436004758;4913.975430122827;4920.926186107211;4923.655344125913;6477.805665830033;6684.028211677567;6738.191417029988;6861.2795656455855;6909.343612356868;4962.379702537183;4979.526944940225;4991.425986011655;5035.345405097314;5054.342935418372;5026.924596131061;5049.586115887558;5054.764950431727;5057.924131138036;5111.105556527593;5659.302209337182;5670.177824215466;5684.914726279109;5719.3136823581435;5732.6847023413275;6589.17635295588;6615.437687796495;6635.236947750974;6641.468682505388;6694.698738556776;1725.5341057914293;1740.4082611911758;1761.2162587648374;1765.1968354398718;1767.2754170789915;1163.1450883600546;1181.2203945395997;1194.5759255464186;1207.7403358278013;1231.9260844349367;5871.6183448075735;5872.442117998783;5921.437463440966;5922.763089476372;5983.790567330123;6741.494422900065;6756.398786467245;6790.253072162058;6801.319868013258;6833.658317084225;5779.7110144493445;5822.82531524055;5835.241418615553;5907.1139329100115;5917.497012753965;3532.8586856525453;3538.8584456621447;3591.425371940477;3598.3522965865873;3619.5837478690287;6479.1901012373455;6512.479001679854;6520.217573891068;6529.836754081186;6547.410733034049;6959.6868140933775;7003.26465721092;7009.369156775914;7031.413978870813;7034.909589013711;5999.670018149044;6466.773662921681;6498.480121590262;6535.0850880876715;6566.244881838554;6615.470762339098;6666.633335166613;6699.39705426514;6753.662316884038;6790.061764176667;6617.437517810848;6625.494663628779;6716.29478904708;6723.226828914541;6733.865322693617;6398.168238129014;6400.327965563549;6435.393665565453;6484.513661475503;6532.150820393318;4951.72765497901;4957.7273249971595;4970.478099799614;5003.199488081889;5040.193569029085;6402.6158430494315;6640.269570347355;6650.567713098633;6779.593224406552;6813.523053386215;6467;6477.708503117466;6496.447801936888;6499;6563.409293163638;6470.870582588416;6478.4169424752;6490.902636460552;6505.804825855232;6580.341965803382;6443.162388889415;6480.222373315232;6488.280605639604;6550.148480697479;6575.868482630225;6607.240167380813;6607.306232845482;6649.63427011519;6663.7001334941015;6663.966680166568;6381;6429.939060055039;6435;6456.903146452901;6508.186476690414 19:19:21 INFO - PID 3437 | |5;yui.html;875.7591662292873;881.2729498164015;899.1817446124029;900.3202582050551;905.0768216419252;18252.90873545632;19115.330963416265;19146.138423770928;19176.328828490972;22093.116275349006;20496.487587810312;21186.788132118676;21257.893710531465;21300.786992130073;21319.893400532976;879.2350654930203;893.7988952485671;894.3650008493977;894.6466145872377;897.4884315939917;916.9128932751378;941.3316545252878;951.6336210558916;954.0221273194996;954.7231302922145;1000.3247807729754;1002.9849552256723;1005.5927349423495;1007.0483393193435;1007.3049595778889;989.9752506187367;994.5325696922434;995.7112437393183;996.1632228927663;996.23290066649;730.2551397574445;733.4682355292424;733.677182039906;733.941284697223;735.5219107580116;18628.81371186298;19171.712424313508;19327.806721932742;19329.51676208092;20082.89958550198;20498;20642;20942.267020654355;20944.266950656653;20969;16763.329466821313;16789.496315110566;17000.829991700048;17029.14854257282;17176.570585735455;3652.7625704329134;3714.275716235308;3714.7213958952916;3715.1826598148637;3716.256748650254;119929;120743;121561.99999999911;123385;124882;16473.83526164747;17143.399981000606;17235.3967611133;17236.138193090297;17394.82605173932;30222.697773022428;30258;30873.073807785804;30916;30942;7541.773746787605;7904;8222.13667564909;8626.611802468904;8782.648694052166;4209.810558524874;4275.722078064916;4310;4311.396404503372;4332.805023773938;5174;5226.764795584208;5282.630215884851;5298.284731561267;5340.546053585411;1026.461107918349;1039.2361614213546;1053.657561292583;1062.2776511971779;1062.8033813744482;671.4796033074407;693.8161387232387;699.1889408286363;699.622204009829;710.4919982212742;11087.334759914269;11602.477888495037;12070.215435996632;12075.637730868088;12081.818772718416;631.8104568629393;632.2318383164385;637.8819918315127;646.5926466326184;678.9660516974131;5481.725913704299;5516.503514683698;5563.888722225533;5690.2887139107615;5918.526517878646;107122.46438767757;108683;111241.44379278051;111292.44353778179;115665;99331;103281;103565;103596;106469;81842;81983;82890.58554707188;87052.12947870567;89693;11235.887641123483;11802;12403.689907752378;12768.808467872803;12884.677883052998;43780;44274.33588496111;44785.32822007607;44959.55040449685;47713.28430073621;73281.6335918317;76043;76257;77719.61140194263;79571;18972.71540926915;19521.414357569294;19545.609087818448;19856.503587409854;19880.50298742543;20663.17347306091;21035.263765768126;21475.892620536797;21712.240071597418;22015.889920550293;18057.277708891495;18100.185491652643;18228.72656910174;18690.15894284733;18812.7178092326;17292.567685807957;17387;17391.739123913405;17632.823671763632;18713.625727485647;16126.516204513884;16299.429519966745;16348.509544713677;16397.09815960086;19093.14080866392;12334.444949977453;12935.223886566837;13050;13126.474941002252;13217.669558261121;13693.794593080913;13743.587692369245;14138.575842724735;14532;14662.560123196321 19:19:21 INFO - PID 3437 | __end_tp_report 19:19:21 INFO - PID 3437 | __start_cc_report 19:19:21 INFO - PID 3437 | _x_x_mozilla_cycle_collect,390 19:19:21 INFO - PID 3437 | __end_cc_report 19:19:21 INFO - PID 3437 | __startTimestamp1503541161140__endTimestamp 19:19:21 INFO - PID 3437 | 19:19:21 INFO - PID 3437 | ------- Summary: start ------- 19:19:21 INFO - PID 3437 | Number of tests: 6 19:19:21 INFO - PID 3437 | 19:19:21 INFO - PID 3437 | [#0] dojo.html Cycles:165 Average:6142.33 Median:6395.58 stddev:747.87 (11.7%) stddev-sans-first:715.54 19:19:21 INFO - PID 3437 | Values: 3275.2 3278.1 3300.1 3307.8 3318.3 6195.1 6221.2 6222.4 6238.6 6253.4 6119.8 6213.8 6230.2 6231.9 6232.0 5733.7 5748.7 5797.2 5825.7 5857.9 5713.0 5759.6 5799.7 5802.4 5900.9 5554.7 5626.1 5652.1 5659.0 5697.5 5741.7 5753.6 5776.3 5807.8 5827.9 5593.3 5664.9 5672.0 5747.9 5771.7 6133.4 6159.4 6174.7 6208.4 6247.2 6578.3 6580.5 6652.2 6671.4 6707.9 6637.2 6668.4 6751.4 6762.2 6849.9 6087.4 6259.5 6341.6 6354.4 6380.0 6852.1 6879.8 6956.0 6959.8 6980.5 6404.2 6496.4 6569.3 6602.9 6646.1 6614.6 6655.4 6658.9 6663.4 6666.0 6599.0 6615.8 6621.3 6700.1 6706.1 6707.5 6734.4 6750.9 6794.1 6816.0 4840.4 4896.5 4900.5 4909.5 4921.4 4339.8 4345.2 4391.2 4397.1 4408.9 5873.4 5938.4 5965.8 5991.4 6003.1 6701.9 6706.1 6781.7 6794.0 6826.6 5791.8 5855.9 5863.4 5872.6 5881.0 5719.8 5746.3 5817.4 5824.5 5824.8 6395.6 6400.1 6486.4 6487.4 6492.3 6689.4 6706.1 6773.2 6781.8 6783.6 6297.3 6391.3 6398.0 6492.8 6501.8 6550.2 6598.7 6629.7 6651.7 6654.6 6665.4 6758.3 6776.1 6810.2 6830.2 6417.7 6436.7 6458.1 6510.2 6543.2 6472.7 6497.8 6539.2 6554.8 6562.3 6435.7 6449.7 6468.7 6486.6 6522.8 6485.6 6495.0 6579.1 6599.5 6643.5 6054.4 6137.5 6271.6 6368.3 6382.8 19:19:21 INFO - PID 3437 | 19:19:21 INFO - PID 3437 | [#1] ext.html Cycles:180 Average:37779.93 Median:33702.83 stddev:55639.80 (165.1%) stddev-sans-first:55726.49 19:19:21 INFO - PID 3437 | Values: 772.4 781.3 808.7 1144.0 1158.4 30183.0 40683.2 41427.6 41520.8 41548.6 41625.2 42151.6 42159.2 42215.8 42269.8 7744.5 7891.0 7893.5 7894.7 7895.4 7762.5 7828.2 7835.6 7840.8 7854.7 7614.8 7843.1 7851.7 7852.5 7852.7 7747.6 7848.0 7852.2 7855.8 7860.7 7692.7 7733.9 7745.2 7751.5 7799.9 38032.8 38310.6 38337.0 38364.0 38506.1 3515.3 3532.4 3544.6 3546.8 3547.8 31143.5 31417.8 31447.8 31459.0 31530.2 4928.7 5145.6 5159.6 5196.4 5220.5 196701.0 196956.0 197439.0 197739.0 198188.0 46679.5 46811.1 46858.8 46957.0 46993.3 49125.5 49232.3 49352.0 49360.5 49551.8 15785.3 15989.5 16078.8 16101.6 16147.3 13201.7 13214.2 13247.8 13249.9 13254.7 12501.2 12818.6 14054.1 14228.0 15415.8 5956.3 6164.1 6164.2 6164.7 6202.9 1006.2 1025.7 1033.5 1036.4 1044.6 23387.0 23952.8 24179.3 24195.5 25542.5 1114.9 1119.4 1119.6 1126.5 1127.4 12217.5 12256.4 12283.9 12335.2 12361.1 240597.0 241902.0 241978.0 242662.0 243291.0 51117.7 51420.5 51476.7 51514.5 51698.0 1438.7 1451.1 1453.2 1456.6 1459.4 22379.8 22438.7 22464.4 22831.2 22853.4 36711.3 36973.6 37013.3 37066.6 37125.6 200924.0 201472.0 201857.0 202068.0 202371.0 33463.7 33608.7 33629.3 33776.3 33858.5 35951.8 40077.8 40951.0 41097.6 41527.0 30569.5 30710.8 30862.1 30898.0 31359.0 30358.2 30397.5 30432.2 30544.5 30872.5 34866.3 35033.8 35125.5 35152.0 35220.6 30024.2 30037.2 30039.8 30050.0 30201.5 22298.9 22372.8 22702.1 22873.5 22945.7 19:19:21 INFO - PID 3437 | 19:19:21 INFO - PID 3437 | [#2] jquery.html Cycles:180 Average:35886.27 Median:22980.60 stddev:84870.51 (369.3%) stddev-sans-first:85067.14 19:19:21 INFO - PID 3437 | Values: 554.2 554.8 559.6 561.5 564.9 21632.7 22014.6 22947.8 22989.2 22998.9 24202.0 25005.5 25030.6 25136.1 25144.6 6476.7 6575.3 6623.9 6632.2 6646.7 6264.3 6467.3 6523.5 6534.1 6542.2 6446.8 6462.9 6490.4 6508.0 6527.1 6486.4 6513.9 6533.1 6535.8 6536.9 6021.5 6023.6 6028.1 6048.1 6061.2 27987.0 28793.6 29370.6 29386.4 29445.1 2036.1 2075.9 2077.8 2078.8 2081.3 19337.9 19444.8 20005.7 20284.7 20314.9 2454.6 2465.4 2513.1 2523.6 2527.0 135666.3 139542.0 140049.0 140224.3 140586.0 14278.9 14312.3 14516.0 14723.2 14794.9 22972.0 22990.3 22993.8 23056.2 23125.8 10044.3 10257.7 10281.7 10361.0 10531.7 7945.2 8028.8 9727.7 9737.4 9935.2 8731.8 8871.9 8970.0 9039.2 9117.3 2515.0 2522.8 2568.6 2662.5 2663.4 955.6 966.3 969.8 983.8 989.1 19586.2 19710.2 19964.5 19988.8 24056.7 1033.2 1052.5 1059.3 1061.5 1074.1 10893.1 11131.7 11161.2 11315.3 11630.2 481510.0 483770.0 484530.0 531393.0 532978.0 118918.4 120767.0 120995.0 122709.0 124766.4 1229.2 1244.9 1255.2 1260.1 1261.0 18874.6 18945.2 19012.0 19075.7 19102.5 62904.7 64030.4 64352.4 64801.0 65661.0 72131.0 72907.3 73444.3 73450.6 73606.3 16264.8 18325.5 20535.8 21077.3 21353.3 22612.0 22621.4 22772.1 23201.0 23278.8 18443.5 18454.5 18563.5 18578.4 18638.6 15589.5 15616.3 15639.1 15809.9 15875.3 19082.9 19103.1 19117.2 19135.7 19253.0 20403.7 20409.4 20513.0 20719.8 20756.7 18156.3 18202.6 18251.8 18337.2 18410.7 19:19:21 INFO - PID 3437 | 19:19:21 INFO - PID 3437 | [#3] mootools.html Cycles:180 Average:9152.64 Median:2666.48 stddev:6386.68 (239.5%) stddev-sans-first:6377.29 19:19:21 INFO - PID 3437 | Values: 1293.7 1341.9 1348.1 1355.9 1363.6 14293.9 14982.2 15026.6 15060.6 15089.9 12405.3 12851.6 12857.6 14707.8 15193.8 2689.4 2729.4 2730.5 2730.5 2732.8 2648.8 2748.8 2749.7 2750.9 2752.2 2602.4 2729.0 2743.1 2754.7 2756.5 2748.0 2758.9 2788.6 2789.4 2792.1 2684.1 2698.2 2713.4 2729.7 2740.8 14157.0 14335.3 14457.3 14466.6 14519.6 7911.4 8166.0 8204.5 8222.4 8223.6 5369.9 5467.5 5541.9 5629.1 5670.3 1901.7 1924.8 1945.3 1973.6 1979.8 25258.1 25462.7 25487.0 25522.9 25531.7 6490.7 6663.5 6758.8 6772.2 6800.6 16731.1 16742.8 16756.1 16757.9 16770.2 7266.1 7415.6 7707.8 7789.7 7793.0 7172.4 7214.1 7215.5 7233.6 7234.7 5104.3 5125.0 5143.8 5144.7 5218.4 1372.8 1522.2 1529.5 1538.2 1559.7 736.6 872.9 900.4 903.3 925.6 7890.0 8030.6 8122.9 8240.7 8439.2 950.1 973.4 1008.3 1009.7 1017.8 5259.5 5387.9 5509.9 5512.3 5605.7 20351.8 21353.5 21466.4 21490.2 21508.1 20013.7 20863.9 21337.0 21395.1 21617.8 10298.6 10627.0 10646.3 10661.6 10679.5 8329.2 8610.9 8688.9 8765.1 9099.0 17464.4 17509.0 17775.6 17921.3 18242.5 17949.8 18050.1 18123.8 18136.8 18362.3 11442.3 11984.8 11997.0 12087.9 12106.1 13408.5 13413.7 13526.0 13537.9 13573.1 11051.9 11076.6 11173.2 11212.2 11416.8 10902.7 10938.4 10989.7 11029.2 11222.6 9846.1 9942.5 9962.8 9974.3 10045.2 7358.3 7407.9 7441.3 7451.9 7486.8 7546.5 7707.5 7724.7 7745.0 7769.7 19:19:21 INFO - PID 3437 | 19:19:21 INFO - PID 3437 | [#4] prototype.html Cycles:180 Average:5527.95 Median:6105.94 stddev:1549.19 (25.4%) stddev-sans-first:1506.89 19:19:21 INFO - PID 3437 | Values: 501.4 506.7 517.8 524.7 524.8 6213.6 6248.8 6282.7 6323.8 6328.8 6039.6 6110.8 6205.3 6228.6 6280.8 5151.6 5162.6 5169.2 5170.0 5241.0 4832.3 5016.8 5098.4 5187.4 5211.4 4931.6 4971.0 4972.2 4996.4 5028.5 4802.0 4999.7 5013.5 5037.0 5042.5 4425.9 4431.6 4434.9 4474.7 4496.0 5988.2 6035.9 6072.7 6101.1 6140.5 5599.7 5640.9 5681.5 5748.4 5760.2 6448.3 6484.3 6493.6 6529.9 6565.6 4863.7 4901.8 4914.0 4920.9 4923.7 6477.8 6684.0 6738.2 6861.3 6909.3 4962.4 4979.5 4991.4 5035.3 5054.3 5026.9 5049.6 5054.8 5057.9 5111.1 5659.3 5670.2 5684.9 5719.3 5732.7 6589.2 6615.4 6635.2 6641.5 6694.7 1725.5 1740.4 1761.2 1765.2 1767.3 1163.1 1181.2 1194.6 1207.7 1231.9 5871.6 5872.4 5921.4 5922.8 5983.8 6741.5 6756.4 6790.3 6801.3 6833.7 5779.7 5822.8 5835.2 5907.1 5917.5 3532.9 3538.9 3591.4 3598.4 3619.6 6479.2 6512.5 6520.2 6529.8 6547.4 6959.7 7003.3 7009.4 7031.4 7034.9 5999.7 6466.8 6498.5 6535.1 6566.2 6615.5 6666.6 6699.4 6753.7 6790.1 6617.4 6625.5 6716.3 6723.2 6733.9 6398.2 6400.3 6435.4 6484.5 6532.2 4951.7 4957.7 4970.5 5003.2 5040.2 6402.6 6640.3 6650.6 6779.6 6813.5 6467.0 6477.7 6496.4 6499.0 6563.4 6470.9 6478.4 6490.9 6505.8 6580.3 6443.2 6480.2 6488.3 6550.1 6575.9 6607.2 6607.3 6649.6 6663.7 6664.0 6381.0 6429.9 6435.0 6456.9 6508.2 19:19:21 INFO - PID 3437 | 19:19:21 INFO - PID 3437 | [#5] yui.html Cycles:180 Average:24107.77 Median:21111.03 stddev:32485.40 (153.9%) stddev-sans-first:32529.69 19:19:21 INFO - PID 3437 | Values: 875.8 881.3 899.2 900.3 905.1 18252.9 19115.3 19146.1 19176.3 22093.1 20496.5 21186.8 21257.9 21300.8 21319.9 879.2 893.8 894.4 894.6 897.5 916.9 941.3 951.6 954.0 954.7 1000.3 1003.0 1005.6 1007.0 1007.3 990.0 994.5 995.7 996.2 996.2 730.3 733.5 733.7 733.9 735.5 18628.8 19171.7 19327.8 19329.5 20082.9 20498.0 20642.0 20942.3 20944.3 20969.0 16763.3 16789.5 17000.8 17029.1 17176.6 3652.8 3714.3 3714.7 3715.2 3716.3 119929.0 120743.0 121562.0 123385.0 124882.0 16473.8 17143.4 17235.4 17236.1 17394.8 30222.7 30258.0 30873.1 30916.0 30942.0 7541.8 7904.0 8222.1 8626.6 8782.6 4209.8 4275.7 4310.0 4311.4 4332.8 5174.0 5226.8 5282.6 5298.3 5340.5 1026.5 1039.2 1053.7 1062.3 1062.8 671.5 693.8 699.2 699.6 710.5 11087.3 11602.5 12070.2 12075.6 12081.8 631.8 632.2 637.9 646.6 679.0 5481.7 5516.5 5563.9 5690.3 5918.5 107122.5 108683.0 111241.4 111292.4 115665.0 99331.0 103281.0 103565.0 103596.0 106469.0 81842.0 81983.0 82890.6 87052.1 89693.0 11235.9 11802.0 12403.7 12768.8 12884.7 43780.0 44274.3 44785.3 44959.6 47713.3 73281.6 76043.0 76257.0 77719.6 79571.0 18972.7 19521.4 19545.6 19856.5 19880.5 20663.2 21035.3 21475.9 21712.2 22015.9 18057.3 18100.2 18228.7 18690.2 18812.7 17292.6 17387.0 17391.7 17632.8 18713.6 16126.5 16299.4 16348.5 16397.1 19093.1 12334.4 12935.2 13050.0 13126.5 13217.7 13693.8 13743.6 14138.6 14532.0 14662.6 19:19:21 INFO - PID 3437 | -------- Summary: end -------- 19:19:21 INFO - PID 3437 | 19:19:21 INFO - TEST-INFO | 3437: exit 0 19:19:21 INFO - TEST-OK | dromaeo_css | took 1112076ms 19:19:21 INFO - TEST-START | kraken 19:19:21 INFO - Initialising browser for kraken test... 19:19:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45441/getInfo.html -profile /tmp/tmp2wpRKn/profile 19:19:21 INFO - TEST-INFO | started process 3864 (/builds/slave/test/build/application/firefox/firefox http://localhost:45441/getInfo.html) 19:19:27 INFO - TEST-INFO | 3864: exit 0 19:19:27 INFO - Browser initialized. 19:19:27 INFO - Running cycle 1/1 for kraken test... 19:19:27 INFO - TEST-INFO | started process 4052 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2wpRKn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:28 INFO - PID 4052 | 19:19:28 INFO - PID 4052 | (/builds/slave/test/build/application/firefox/firefox:4102): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:19:28 INFO - PID 4052 | 19:19:29 INFO - PID 4052 | 19:19:29 INFO - PID 4052 | (/builds/slave/test/build/application/firefox/firefox:4160): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 19:19:29 INFO - PID 4052 | 19:19:29 INFO - PID 4052 | __metrics Screen width/height:1600/1200 19:19:29 INFO - PID 4052 | colorDepth:24 19:19:29 INFO - PID 4052 | Browser inner width/height: 1024/768 19:19:29 INFO - PID 4052 | __metrics 19:19:39 INFO - PID 4052 | RSS: Main: 174731264 19:19:39 INFO - PID 4052 | 19:19:41 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45441/tests/kraken/driver.html?testName=audio-beat-detection) 19:19:42 INFO - PID 4052 | RSS: Main: 179097600 19:19:42 INFO - PID 4052 | 19:19:45 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45441/tests/kraken/driver.html?testName=audio-dft) 19:19:46 INFO - PID 4052 | RSS: Main: 179085312 19:19:46 INFO - PID 4052 | 19:19:49 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45441/tests/kraken/driver.html?testName=audio-fft) 19:19:49 INFO - PID 4052 | RSS: Main: 173969408 19:19:49 INFO - PID 4052 | 19:19:52 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45441/tests/kraken/driver.html?testName=audio-oscillator) 19:19:52 INFO - PID 4052 | RSS: Main: 174534656 19:19:52 INFO - PID 4052 | 19:19:55 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45441/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:19:55 INFO - PID 4052 | RSS: Main: 175194112 19:19:55 INFO - PID 4052 | 19:19:58 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45441/tests/kraken/driver.html?testName=imaging-darkroom) 19:19:59 INFO - PID 4052 | RSS: Main: 175710208 19:19:59 INFO - PID 4052 | 19:20:03 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45441/tests/kraken/driver.html?testName=imaging-desaturate) 19:20:03 INFO - PID 4052 | RSS: Main: 174821376 19:20:03 INFO - PID 4052 | 19:20:06 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45441/tests/kraken/driver.html?testName=json-parse-financial) 19:20:07 INFO - PID 4052 | RSS: Main: 175673344 19:20:07 INFO - PID 4052 | 19:20:08 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45441/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:20:09 INFO - PID 4052 | RSS: Main: 176287744 19:20:09 INFO - PID 4052 | 19:20:11 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45441/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:20:12 INFO - PID 4052 | RSS: Main: 176381952 19:20:12 INFO - PID 4052 | 19:20:14 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45441/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:20:14 INFO - PID 4052 | RSS: Main: 176242688 19:20:14 INFO - PID 4052 | 19:20:17 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:20:18 INFO - PID 4052 | RSS: Main: 176758784 19:20:18 INFO - PID 4052 | 19:20:21 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:21 INFO - PID 4052 | RSS: Main: 176758784 19:20:21 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | Cycle 1(1): loaded http://localhost:45441/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45441/tests/kraken/driver.html?testName=ai-astar) 19:20:23 INFO - PID 4052 | RSS: Main: 178192384 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | __start_tp_report 19:20:23 INFO - PID 4052 | _x_x_mozilla_page_load 19:20:23 INFO - PID 4052 | _x_x_mozilla_page_load_details 19:20:23 INFO - PID 4052 | |i|pagename|runs| 19:20:23 INFO - PID 4052 | |0;ai-astar;99;108;99;116;107;109;109;101;108;108 19:20:23 INFO - PID 4052 | |1;audio-beat-detection;149;118;151;172;118;142;141;117;173;122 19:20:23 INFO - PID 4052 | |2;audio-dft;164;166;163;162;161;172;168;167;164;163 19:20:23 INFO - PID 4052 | |3;audio-fft;75;81;73;183;78;75;76;73;164;74 19:20:23 INFO - PID 4052 | |4;audio-oscillator;79;79;135;79;80;84;139;83;79;135 19:20:23 INFO - PID 4052 | |5;imaging-gaussian-blur;114;113;114;117;113;114;114;115;114;118 19:20:23 INFO - PID 4052 | |6;imaging-darkroom;149;157;149;153;148;148;148;148;148;150 19:20:23 INFO - PID 4052 | |7;imaging-desaturate;99;98;94;94;93;94;96;99;98;99 19:20:23 INFO - PID 4052 | |8;json-parse-financial;52;55;60;52;52;52;53;55;52;53 19:20:23 INFO - PID 4052 | |9;json-stringify-tinderbox;55;55;54;57;56;55;55;55;62;60 19:20:23 INFO - PID 4052 | |10;stanford-crypto-aes;77;79;74;78;74;78;86;76;78;74 19:20:23 INFO - PID 4052 | |11;stanford-crypto-ccm;129;120;119;117;121;117;116;123;129;161 19:20:23 INFO - PID 4052 | |12;stanford-crypto-pbkdf2;181;170;170;176;168;172;174;174;174;172 19:20:23 INFO - PID 4052 | |13;stanford-crypto-sha256-iterative;67;64;67;68;71;68;68;68;68;78 19:20:23 INFO - PID 4052 | __end_tp_report 19:20:23 INFO - PID 4052 | __start_cc_report 19:20:23 INFO - PID 4052 | _x_x_mozilla_cycle_collect,945 19:20:23 INFO - PID 4052 | __end_cc_report 19:20:23 INFO - PID 4052 | __startTimestamp1503541223963__endTimestamp 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | ------- Summary: start ------- 19:20:23 INFO - PID 4052 | Number of tests: 14 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#0] ai-astar Cycles:10 Average:106.40 Median:109.00 stddev:5.30 (4.9%) stddev-sans-first:4.89 19:20:23 INFO - PID 4052 | Values: 99.0 108.0 99.0 116.0 107.0 109.0 109.0 101.0 108.0 108.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:145.50 stddev:21.45 (14.7%) stddev-sans-first:22.52 19:20:23 INFO - PID 4052 | Values: 149.0 118.0 151.0 172.0 118.0 142.0 141.0 117.0 173.0 122.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#2] audio-dft Cycles:10 Average:165.00 Median:165.00 stddev:3.30 (2.0%) stddev-sans-first:3.48 19:20:23 INFO - PID 4052 | Values: 164.0 166.0 163.0 162.0 161.0 172.0 168.0 167.0 164.0 163.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#3] audio-fft Cycles:10 Average:95.20 Median:75.00 stddev:41.58 (55.4%) stddev-sans-first:43.45 19:20:23 INFO - PID 4052 | Values: 75.0 81.0 73.0 183.0 78.0 75.0 76.0 73.0 164.0 74.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:79.00 stddev:27.08 (34.3%) stddev-sans-first:27.91 19:20:23 INFO - PID 4052 | Values: 79.0 79.0 135.0 79.0 80.0 84.0 139.0 83.0 79.0 135.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.65 (1.4%) stddev-sans-first:1.73 19:20:23 INFO - PID 4052 | Values: 114.0 113.0 114.0 117.0 113.0 114.0 114.0 115.0 114.0 118.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:149.00 stddev:2.97 (2.0%) stddev-sans-first:3.14 19:20:23 INFO - PID 4052 | Values: 149.0 157.0 149.0 153.0 148.0 148.0 148.0 148.0 148.0 150.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:98.00 stddev:2.46 (2.5%) stddev-sans-first:2.42 19:20:23 INFO - PID 4052 | Values: 99.0 98.0 94.0 94.0 93.0 94.0 96.0 99.0 98.0 99.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.00 stddev:2.55 (4.8%) stddev-sans-first:2.64 19:20:23 INFO - PID 4052 | Values: 52.0 55.0 60.0 52.0 52.0 52.0 53.0 55.0 52.0 53.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:55.50 stddev:2.59 (4.7%) stddev-sans-first:2.70 19:20:23 INFO - PID 4052 | Values: 55.0 55.0 54.0 57.0 56.0 55.0 55.0 55.0 62.0 60.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:78.00 stddev:3.57 (4.6%) stddev-sans-first:3.78 19:20:23 INFO - PID 4052 | Values: 77.0 79.0 74.0 78.0 74.0 78.0 86.0 76.0 78.0 74.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:122.00 stddev:13.41 (11.0%) stddev-sans-first:14.15 19:20:23 INFO - PID 4052 | Values: 129.0 120.0 119.0 117.0 121.0 117.0 116.0 123.0 129.0 161.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:174.00 stddev:3.67 (2.1%) stddev-sans-first:2.54 19:20:23 INFO - PID 4052 | Values: 181.0 170.0 170.0 176.0 168.0 172.0 174.0 174.0 174.0 172.0 19:20:23 INFO - PID 4052 | 19:20:23 INFO - PID 4052 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:68.00 stddev:3.68 (5.4%) stddev-sans-first:3.86 19:20:23 INFO - PID 4052 | Values: 67.0 64.0 67.0 68.0 71.0 68.0 68.0 68.0 68.0 78.0 19:20:23 INFO - PID 4052 | -------- Summary: end -------- 19:20:23 INFO - PID 4052 | 19:20:24 INFO - PID 4052 | 19:20:24 INFO - PID 4052 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x150081,name=PBrowser::Msg_Destroy) Closed channel: cannot send/recv 19:20:24 INFO - PID 4052 | 19:20:24 INFO - PID 4052 | 19:20:24 INFO - PID 4052 | ###!!! [Child][MessageChannel] Error: (msgtype=0x150001,name=PBrowser::Msg_AsyncMessage) Closed channel: cannot send/recv 19:20:24 INFO - PID 4052 | 19:20:24 INFO - PID 4052 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 19:20:24 INFO - TEST-INFO | 4052: exit 0 19:20:24 INFO - TEST-OK | kraken | took 62861ms 19:20:24 INFO - SUITE-END | took 1174s 19:20:25 INFO - Completed test suite (00:19:35) 19:20:25 INFO - javascript benchmark 19:20:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8553.14091979706, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3275.230320874594, 3278.08213700164, 3300.1089705779455, 3307.7684562080653, 3318.2865683877963, 6195.101710252011, 6221.160143380643, 6222.408871157233, 6238.62568245905, 6253.437190652846, 6119.755209791603, 6213.844653883655, 6230.221222347207, 6231.937680623192, 6232.0, 5733.684647344395, 5748.655080695172, 5797.246357973458, 5825.679587622679, 5857.8828423431505, 5713.028785106521, 5759.5968282220265, 5799.681017544033, 5802.39074897136, 5900.911486327687, 5554.694491802969, 5626.071698169797, 5652.067408877571, 5659.009673307175, 5697.544196464273, 5741.712914354265, 5753.626014309057, 5776.306843178803, 5807.767689292423, 5827.88344233113, 5593.32880054392, 5664.858378540528, 5671.9716401418145, 5747.856303592402, 5771.682557459338, 6133.417325354084, 6159.38406159385, 6174.691265436711, 6208.379162083801, 6247.187865577446, 6578.309277525838, 6580.5393622446445, 6652.168478940132, 6671.432928201109, 6707.93292067078, 6637.2367177774695, 6668.366505182, 6751.358620931003, 6762.2223444304045, 6849.897251541231, 6087.421694938974, 6259.4679452246155, 6341.55609107358, 6354.364563543655, 6379.968100159516, 6852.109225800614, 6879.828004299932, 6956.0, 6959.791206263821, 6980.546264492893, 6404.231492220963, 6496.447801936793, 6569.343065693392, 6602.933970660328, 6646.069550262967, 6614.6361950093205, 6655.367740064686, 6658.866822663616, 6663.433608143265, 6665.966670166715, 6599.043138744855, 6615.801525954229, 6621.27166011748, 6700.061991321219, 6706.094677218611, 6707.496937729592, 6734.3602357775935, 6750.932490675031, 6794.0827988221945, 6815.965920170367, 4840.419149701988, 4896.4858689837765, 4900.509949005071, 4909.533594308535, 4921.434035086011, 4339.804708788112, 4345.152695224464, 4391.165678521071, 4397.098594788061, 4408.9118217636105, 5873.383294754075, 5938.376470470625, 5965.821025369159, 5991.370906054802, 6003.0695242237525, 6701.865962680817, 6706.094677218513, 6781.6609169541325, 6794.0, 6826.590404575742, 5791.768329266866, 5855.882882342415, 5863.355030946593, 5872.618279811799, 5881.0, 5719.771209151588, 5746.2529871116485, 5817.360090390053, 5824.534037277008, 5824.825255242349, 6395.584287021422, 6400.103985442041, 6486.4486518646445, 6487.3836985486305, 6492.318306577836, 6689.431398331002, 6706.094677218708, 6773.18721753373, 6781.762638307636, 6783.626900520519, 6297.307296197506, 6391.296957334783, 6397.96801015992, 6492.805215843532, 6501.804945851632, 6550.213974323112, 6598.670066496752, 6629.701663425061, 6651.7006734698025, 6654.633995130121, 6665.366790154928, 6758.2903795102775, 6776.119104516579, 6810.216825064983, 6830.248672645906, 6417.743290268337, 6436.67816609177, 6458.095866578588, 6510.18622672166, 6543.1821022372205, 6472.708728107341, 6497.805065848032, 6539.182602174728, 6554.770583029571, 6562.278149403466, 6435.742570297136, 6449.677516124269, 6468.741250349934, 6486.578372405778, 6522.771702990372, 6485.578437401554, 6495.0, 6579.144711187515, 6599.5050371223315, 6643.468522518284, 6054.39456054391, 6137.539684523768, 6271.62370257786, 6368.299487056327, 6382.776602818879], "value": 6085.9499093111, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.362800689431, 781.3436713160945, 808.6603626476879, 1143.999000874235, 1158.3571118029502, 30183.0, 40683.18633627329, 41427.585724142715, 41520.79239603798, 41548.58451415492, 41625.16749665005, 42151.57848421515, 42159.156816863644, 42215.78892105543, 42269.788651056704, 7744.49660772048, 7891.013623297088, 7893.486923349992, 7894.684212631488, 7895.368370530344, 7762.45662803604, 7828.178041305667, 7835.608219589027, 7840.803979900519, 7854.7250846220395, 7614.809629759245, 7843.058832940055, 7851.725189618364, 7852.528848269094, 7852.685892564291, 7747.612619369037, 7847.96076019622, 7852.17552157021, 7855.764327070197, 7860.68557257709, 7692.730754423625, 7733.922660773376, 7745.225477452266, 7751.534907905488, 7799.883001754978, 38032.80983595064, 38310.616893830986, 38337.0, 38364.0, 38506.07469626536, 3515.3145136698354, 3532.434810430319, 3544.6278140795102, 3546.7871927684164, 3547.8048707321086, 31143.532847007315, 31417.8429107853, 31447.84276078628, 31459.0, 31530.211744706565, 4928.654994150411, 5145.6398052136365, 5159.5614372778355, 5196.402413722432, 5220.451852555465, 196701.0, 196956.0, 197439.0, 197739.0, 198188.0, 46679.533204668194, 46811.063778724914, 46858.76570617193, 46957.0, 46993.295100573516, 49125.50874491209, 49232.261516077284, 49352.0, 49360.50639493631, 49551.75224123929, 15785.289661965238, 15989.520314390587, 16078.839211607969, 16101.597460063593, 16147.273372698257, 13201.73596528064, 13214.207147571176, 13247.80128298057, 13249.867501325056, 13254.668633284246, 12501.24992500453, 12818.55135070268, 14054.086484378482, 14228.0, 15415.768763468557, 5956.255468066492, 6164.106204600308, 6164.167837341902, 6164.722587483574, 6202.875942481125, 1006.2050979726081, 1025.707673313117, 1033.540074666781, 1036.383351905615, 1044.613493007592, 23387.0, 23952.760472395054, 24179.274621761375, 24195.51608967811, 25542.48915021689, 1114.8662160540787, 1119.4179026905963, 1119.6137332620233, 1126.4592995362273, 1127.3799410324289, 12217.51129954792, 12256.387180640932, 12283.938580307042, 12335.198212116184, 12361.134720569475, 240597.0, 241902.0, 241978.0, 242662.0, 243291.0, 51117.74441127771, 51420.48579514157, 51476.742616286676, 51514.48485515172, 51698.0, 1438.6691061056015, 1451.0930668332292, 1453.2080016391092, 1456.6358410397402, 1459.4381163252012, 22379.77620223777, 22438.663420048386, 22464.438389040406, 22831.20090796814, 22853.428664283525, 36711.26577468382, 36973.63026369702, 37013.25973480461, 37066.62933370632, 37125.628743712216, 200924.0, 201472.0, 201857.0, 202068.0, 202371.0, 33463.66536334605, 33608.66391336056, 33629.32741345208, 33776.32447351088, 33858.49212261867, 35951.820240898625, 40077.799611001756, 40951.0, 41097.58902410937, 41527.0, 30569.54145687772, 30710.846445767627, 30862.074137775904, 30898.0, 31359.0, 30358.241043974078, 30397.544036839907, 30432.239194020327, 30544.541831872983, 30872.53691194589, 34866.302673946884, 35033.82483087568, 35125.473117902744, 35152.0, 35220.64779352276, 30024.24939376533, 30037.24906877258, 30039.84980075173, 30050.0, 30201.546976794925, 22298.88850555737, 22372.776272237068, 22702.09191632382, 22873.542529149658, 22945.65581516312], "value": 17118.906807888437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.2074832988827, 554.7725432572646, 559.6222549778898, 561.4609974424552, 564.887022595481, 21632.675509867364, 22014.559708805813, 22947.770522294773, 22989.195378161767, 22998.88500557495, 24202.0, 25005.49989000219, 25030.624540631907, 25136.120235791706, 25144.622830657554, 6476.74093036278, 6575.309592492791, 6623.900641490357, 6632.237292711352, 6646.700898459557, 6264.27960784511, 6467.256265529454, 6523.543351965364, 6534.052562378452, 6542.182227221598, 6446.774362897299, 6462.903056454157, 6490.383413575702, 6508.0, 6527.053577231299, 6486.448651864597, 6513.902291465632, 6533.118029066063, 6535.836604084889, 6536.93463065368, 6021.458068773788, 6023.578349515536, 6028.065649824284, 6048.092786082123, 6061.242344706911, 27987.0, 28793.568096478568, 29370.55944160839, 29386.41227175466, 29445.11664650064, 2036.0837623069679, 2075.94126995232, 2077.8233850122756, 2078.8025137611903, 2081.2819577245828, 19337.9033104835, 19444.805551944442, 20005.699914501292, 20284.695729564068, 20314.898425507927, 2454.607262837955, 2465.432950421395, 2513.0576033987254, 2523.6466894634764, 2526.987365063163, 135666.32166839202, 139542.0, 140049.0, 140224.29887850597, 140586.0, 14278.928605356907, 14312.28438578067, 14516.0, 14723.190224537539, 14794.852051479562, 22972.0, 22990.310290691305, 22993.770062299496, 23056.19303324409, 23125.7687423127, 10044.347117437343, 10257.692269231935, 10281.74295642615, 10360.979608976328, 10531.684049478528, 7945.165757595485, 8028.83942321162, 9727.708168754949, 9737.367071140496, 9935.155511781435, 8731.781705457415, 8871.866921996176, 8970.0, 9039.186473217442, 9117.270618350516, 2514.981432519832, 2522.823402361854, 2568.576184929466, 2662.467506498708, 2663.440677457717, 955.5604421965835, 966.260651054255, 969.8157350103457, 983.8425851863667, 989.0653332600623, 19586.21655133807, 19710.21159153618, 19964.50088747793, 19988.800111998695, 24056.676882771266, 1033.2302434686208, 1052.4579841381694, 1059.3220338983058, 1061.4851796878509, 1074.070928646715, 10893.128549716004, 11131.666050018512, 11161.218714689894, 11315.321080735182, 11630.244034137753, 481510.0, 483770.0, 484530.0, 531393.0, 532978.0, 118918.4054079724, 120767.0, 120995.0, 122709.0, 124766.37616812039, 1229.1764517773113, 1244.8630650628425, 1255.190402190582, 1260.0738457233927, 1260.9558665446482, 18874.622507550048, 18945.242190312783, 19012.049397530343, 19075.713864292324, 19102.522436939187, 62904.685476572326, 64030.3596964043, 64352.35647643464, 64801.0, 65661.0, 72131.0, 72907.27092729005, 73444.26555734374, 73450.63274683592, 73606.26393735994, 16264.756028659343, 18325.450236492925, 20535.794642053388, 21077.262295820186, 21353.25263615766, 22612.0, 22621.43446413853, 22772.089116435156, 23201.0, 23278.76721232766, 18443.538911527317, 18454.538636534195, 18563.535911602317, 18578.44264672062, 18638.627227455647, 15589.532314030597, 15616.297266623256, 15639.139847308506, 15809.920950395175, 15875.285612147713, 19082.904585476983, 19103.140358683613, 19117.23531058742, 19135.71296430527, 19253.0, 20403.69394459114, 20409.387718368474, 20513.0, 20719.792802071785, 20756.688649669966, 18156.27374904989, 18202.635947280716, 18251.81748182501, 18337.174827132545, 18410.711250212356], "value": 12267.108172919936, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.7089154940138, 1341.899357548184, 1348.1439286053353, 1355.9084936626011, 1363.5568440256914, 14293.857061429382, 14982.175980321077, 15026.624334391632, 15060.623484412881, 15089.924550377233, 12405.317707526083, 12851.550195743128, 12857.614271571845, 14707.779383309258, 15193.77209341858, 2689.4217743185163, 2729.372244383793, 2730.4675588260297, 2730.5085084684747, 2732.8496932668795, 2648.8410695358243, 2748.8350698958125, 2749.6562929633797, 2750.8624568771584, 2752.2431331383827, 2602.4404752978107, 2729.0311939261474, 2743.067357098596, 2754.7107553706874, 2756.503829310723, 2748.038186634682, 2758.917232483029, 2788.5538313869783, 2789.386335006295, 2792.0786140573564, 2684.1276585109918, 2698.1500827239356, 2713.3894873653467, 2729.6997330293652, 2740.767034802024, 14157.0, 14335.283235838166, 14457.349419276157, 14466.566003019821, 14519.637009074751, 7911.367090632793, 8165.959170204171, 8204.466709663853, 8222.38332125087, 8223.629936652866, 5369.9463005369835, 5467.535259502947, 5541.9168712468945, 5629.099344104964, 5670.319561652587, 1901.7337572739827, 1924.807519248078, 1945.2802463088606, 1973.5658155205974, 1979.772326182493, 25258.115965941102, 25462.745372546407, 25487.0, 25522.872385637955, 25531.744682553122, 6490.707918143695, 6663.4669226461765, 6758.763443279461, 6772.153480814898, 6800.557963732342, 16731.079790611635, 16742.83257167437, 16756.078415687254, 16757.916210419113, 16770.245338959776, 7266.091738532684, 7415.555066696015, 7707.807304817312, 7789.727359542502, 7792.961035194788, 7172.354488096096, 7214.0621719177225, 7215.49491535598, 7233.638318084075, 7234.66158760631, 5104.259882317043, 5125.0, 5143.7685304161405, 5144.6913185209005, 5218.425973142951, 1372.8078069070139, 1522.2236659303614, 1529.5487831089633, 1538.2001359293106, 1559.6724687815686, 736.5654263984275, 872.8821609082693, 900.3697411811627, 903.2864037410372, 925.6297481007516, 7889.960550197212, 8030.638621262057, 8122.918770812216, 8240.670373185005, 8439.156084391634, 950.14486961735, 973.3964941736027, 1008.2538921198407, 1009.7021378693303, 1017.811704834608, 5259.500347466985, 5387.919181212285, 5509.862253443696, 5512.283403157564, 5605.747741351649, 20351.796482035286, 21353.46616334573, 21466.356009319745, 21490.24784132548, 21508.139674412847, 20013.699794503093, 20863.8956805215, 21337.0, 21395.144194232056, 21617.78382216189, 10298.639547615798, 10627.0, 10646.254762166574, 10661.573537058586, 10679.466026698634, 8329.167083291622, 8610.870836937576, 8688.869666955126, 8765.07966663491, 9098.954505227432, 17464.388746394325, 17508.99999999949, 17775.644487110443, 17921.28314867391, 18242.45272641823, 17949.820501795337, 18050.097495125454, 18123.818761812214, 18136.782441509575, 18362.265509379475, 11442.313461192354, 11984.820227696766, 11997.0, 12087.879121209027, 12106.092043096627, 13408.463661453432, 13413.731725365633, 13526.0, 13537.864621353661, 13573.11774734639, 11051.889481105087, 11076.556937722724, 11173.162012848907, 11212.159088068265, 11416.828747568627, 10902.727431814268, 10938.398388088413, 10989.725256868642, 11029.172812039289, 11222.607208747655, 9846.113849753556, 9942.502874856084, 9962.750931226778, 9974.251931105051, 10045.196384289386, 7358.337749602561, 7407.888816677541, 7441.293077157661, 7451.888221676788, 7486.812829679302, 7546.547207167588, 7707.499012564165, 7724.729634462767, 7745.0, 7769.72805951789], "value": 6623.518229617268, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.3657722980428, 506.71623890621254, 517.8498235511702, 524.7009204753291, 524.7979527881764, 6213.627182369061, 6248.750049998001, 6282.654454005034, 6323.766865461237, 6328.772326113686, 6039.637621742699, 6110.755569777203, 6205.286392064914, 6228.564000519966, 6280.80171939822, 5151.562117220041, 5162.6128040397125, 5169.224616307565, 5169.999999999991, 5241.0, 4832.323474713526, 5016.774245158977, 5098.439171691111, 5187.3775146982225, 5211.400688920785, 4931.556159945604, 4971.0, 4972.179590367585, 4996.375453068366, 5028.547430731233, 4802.0, 4999.725015124167, 5013.548780609763, 5036.974815125937, 5042.5209605087275, 4425.933610995838, 4431.645468362523, 4434.933475997863, 4474.686771925966, 4496.0, 5988.19159413478, 6035.939640603582, 6072.696365181768, 6101.115338275969, 6140.50875929929, 5599.740058486848, 5640.943590564083, 5681.460261275172, 5748.42515748426, 5760.243125846615, 6448.290688024314, 6484.319146489598, 6493.610383377012, 6529.877789718361, 6565.57323773958, 4863.732494712789, 4901.828436004758, 4913.975430122827, 4920.926186107211, 4923.655344125913, 6477.805665830033, 6684.028211677567, 6738.191417029988, 6861.2795656455855, 6909.343612356868, 4962.379702537183, 4979.526944940225, 4991.425986011655, 5035.345405097314, 5054.342935418372, 5026.924596131061, 5049.586115887558, 5054.764950431727, 5057.924131138036, 5111.105556527593, 5659.302209337182, 5670.177824215466, 5684.914726279109, 5719.3136823581435, 5732.6847023413275, 6589.17635295588, 6615.437687796495, 6635.236947750974, 6641.468682505388, 6694.698738556776, 1725.5341057914293, 1740.4082611911758, 1761.2162587648374, 1765.1968354398718, 1767.2754170789915, 1163.1450883600546, 1181.2203945395997, 1194.5759255464186, 1207.7403358278013, 1231.9260844349367, 5871.6183448075735, 5872.442117998783, 5921.437463440966, 5922.763089476372, 5983.790567330123, 6741.494422900065, 6756.398786467245, 6790.253072162058, 6801.319868013258, 6833.658317084225, 5779.7110144493445, 5822.82531524055, 5835.241418615553, 5907.1139329100115, 5917.497012753965, 3532.8586856525453, 3538.8584456621447, 3591.425371940477, 3598.3522965865873, 3619.5837478690287, 6479.1901012373455, 6512.479001679854, 6520.217573891068, 6529.836754081186, 6547.410733034049, 6959.6868140933775, 7003.26465721092, 7009.369156775914, 7031.413978870813, 7034.909589013711, 5999.670018149044, 6466.773662921681, 6498.480121590262, 6535.0850880876715, 6566.244881838554, 6615.470762339098, 6666.633335166613, 6699.39705426514, 6753.662316884038, 6790.061764176667, 6617.437517810848, 6625.494663628779, 6716.29478904708, 6723.226828914541, 6733.865322693617, 6398.168238129014, 6400.327965563549, 6435.393665565453, 6484.513661475503, 6532.150820393318, 4951.72765497901, 4957.7273249971595, 4970.478099799614, 5003.199488081889, 5040.193569029085, 6402.6158430494315, 6640.269570347355, 6650.567713098633, 6779.593224406552, 6813.523053386215, 6467.0, 6477.708503117466, 6496.447801936888, 6499.0, 6563.409293163638, 6470.870582588416, 6478.4169424752, 6490.902636460552, 6505.804825855232, 6580.341965803382, 6443.162388889415, 6480.222373315232, 6488.280605639604, 6550.148480697479, 6575.868482630225, 6607.240167380813, 6607.306232845482, 6649.63427011519, 6663.7001334941015, 6663.966680166568, 6381.0, 6429.939060055039, 6435.0, 6456.903146452901, 6508.186476690414], "value": 5069.497133715408, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [875.7591662292873, 881.2729498164015, 899.1817446124029, 900.3202582050551, 905.0768216419252, 18252.90873545632, 19115.330963416265, 19146.138423770928, 19176.328828490972, 22093.116275349006, 20496.487587810312, 21186.788132118676, 21257.893710531465, 21300.786992130073, 21319.893400532976, 879.2350654930203, 893.7988952485671, 894.3650008493977, 894.6466145872377, 897.4884315939917, 916.9128932751378, 941.3316545252878, 951.6336210558916, 954.0221273194996, 954.7231302922145, 1000.3247807729754, 1002.9849552256723, 1005.5927349423495, 1007.0483393193435, 1007.3049595778889, 989.9752506187367, 994.5325696922434, 995.7112437393183, 996.1632228927663, 996.23290066649, 730.2551397574445, 733.4682355292424, 733.677182039906, 733.941284697223, 735.5219107580116, 18628.81371186298, 19171.712424313508, 19327.806721932742, 19329.51676208092, 20082.89958550198, 20498.0, 20642.0, 20942.267020654355, 20944.266950656653, 20969.0, 16763.329466821313, 16789.496315110566, 17000.829991700048, 17029.14854257282, 17176.570585735455, 3652.7625704329134, 3714.275716235308, 3714.7213958952916, 3715.1826598148637, 3716.256748650254, 119929.0, 120743.0, 121561.99999999911, 123385.0, 124882.0, 16473.83526164747, 17143.399981000606, 17235.3967611133, 17236.138193090297, 17394.82605173932, 30222.697773022428, 30258.0, 30873.073807785804, 30916.0, 30942.0, 7541.773746787605, 7904.0, 8222.13667564909, 8626.611802468904, 8782.648694052166, 4209.810558524874, 4275.722078064916, 4310.0, 4311.396404503372, 4332.805023773938, 5174.0, 5226.764795584208, 5282.630215884851, 5298.284731561267, 5340.546053585411, 1026.461107918349, 1039.2361614213546, 1053.657561292583, 1062.2776511971779, 1062.8033813744482, 671.4796033074407, 693.8161387232387, 699.1889408286363, 699.622204009829, 710.4919982212742, 11087.334759914269, 11602.477888495037, 12070.215435996632, 12075.637730868088, 12081.818772718416, 631.8104568629393, 632.2318383164385, 637.8819918315127, 646.5926466326184, 678.9660516974131, 5481.725913704299, 5516.503514683698, 5563.888722225533, 5690.2887139107615, 5918.526517878646, 107122.46438767757, 108683.0, 111241.44379278051, 111292.44353778179, 115665.0, 99331.0, 103281.0, 103565.0, 103596.0, 106469.0, 81842.0, 81983.0, 82890.58554707188, 87052.12947870567, 89693.0, 11235.887641123483, 11802.0, 12403.689907752378, 12768.808467872803, 12884.677883052998, 43780.0, 44274.33588496111, 44785.32822007607, 44959.55040449685, 47713.28430073621, 73281.6335918317, 76043.0, 76257.0, 77719.61140194263, 79571.0, 18972.71540926915, 19521.414357569294, 19545.609087818448, 19856.503587409854, 19880.50298742543, 20663.17347306091, 21035.263765768126, 21475.892620536797, 21712.240071597418, 22015.889920550293, 18057.277708891495, 18100.185491652643, 18228.72656910174, 18690.15894284733, 18812.7178092326, 17292.567685807957, 17387.0, 17391.739123913405, 17632.823671763632, 18713.625727485647, 16126.516204513884, 16299.429519966745, 16348.509544713677, 16397.09815960086, 19093.14080866392, 12334.444949977453, 12935.223886566837, 13050.0, 13126.474941002252, 13217.669558261121, 13693.794593080913, 13743.587692369245, 14138.575842724735, 14532.0, 14662.560123196321], "value": 9122.780763817893, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 99.0, 116.0, 107.0, 109.0, 109.0, 101.0, 108.0, 108.0], "value": 106.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 118.0, 151.0, 172.0, 118.0, 142.0, 141.0, 117.0, 173.0, 122.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 163.0, 162.0, 161.0, 172.0, 168.0, 167.0, 164.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 81.0, 73.0, 183.0, 78.0, 75.0, 76.0, 73.0, 164.0, 74.0], "value": 95.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 135.0, 79.0, 80.0, 84.0, 139.0, 83.0, 79.0, 135.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 117.0, 113.0, 114.0, 114.0, 115.0, 114.0, 118.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 157.0, 149.0, 153.0, 148.0, 148.0, 148.0, 148.0, 148.0, 150.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 98.0, 94.0, 94.0, 93.0, 94.0, 96.0, 99.0, 98.0, 99.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 55.0, 60.0, 52.0, 52.0, 52.0, 53.0, 55.0, 52.0, 53.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 57.0, 56.0, 55.0, 55.0, 55.0, 62.0, 60.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 74.0, 78.0, 74.0, 78.0, 86.0, 76.0, 78.0, 74.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 120.0, 119.0, 117.0, 121.0, 117.0, 116.0, 123.0, 129.0, 161.0], "value": 125.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 170.0, 170.0, 176.0, 168.0, 172.0, 174.0, 174.0, 174.0, 172.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 67.0, 68.0, 71.0, 68.0, 68.0, 68.0, 68.0, 78.0], "value": 68.7, "unit": "score"}]}]} 19:20:25 INFO - Return code: 0 19:20:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:20:25 INFO - # TBPL SUCCESS # 19:20:25 INFO - Running post-action listener: _package_coverage_data 19:20:25 INFO - Running post-action listener: _resource_record_post_action 19:20:25 INFO - [mozharness: 2017-08-24 02:20:25.244421Z] Finished run-tests step (success) 19:20:25 INFO - Running post-run listener: _resource_record_post_run 19:20:25 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 427581440; Read time: 48; Write time: 241340 19:20:25 INFO - TinderboxPrint: CPU usage
13.1% 19:20:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 48 19:20:25 INFO - TinderboxPrint: I/O write bytes / time
427,581,440 / 241,340 19:20:25 INFO - TinderboxPrint: CPU idle
8,260.5 (86.8%) 19:20:25 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 19:20:25 INFO - TinderboxPrint: Swap in / out
0 / 0 19:20:25 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 104714240; Read time: 0; Write time: 76332 19:20:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:20:25 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322453504; Read time: 48; Write time: 164972 19:20:25 INFO - Running post-run listener: _upload_blobber_files 19:20:25 INFO - Blob upload gear active. 19:20:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:25 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 19:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:20:26 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:20:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:20:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:27 INFO - (blobuploader) - INFO - Done attempting. 19:20:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:20:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:20:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:28 INFO - (blobuploader) - INFO - Done attempting. 19:20:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:20:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:20:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:33 INFO - (blobuploader) - INFO - Done attempting. 19:20:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:20:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:20:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:34 INFO - (blobuploader) - INFO - Done attempting. 19:20:34 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:34 INFO - Return code: 0 19:20:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:20:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:34 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fef3191ba3388704941eaa21f7c14876298c3c166ba03279aa2c405c727a5cbd36f93963b2bf489b53782468502e08300df693999aebd2c7a66915f9f64f0fed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/106df02d53134061a98dbd034e7ffc9df5f3984ae310d497afb6b9559a78013e2040d97e3f6bb83a5be92e019b5f466293960c88b9a82b6be419815812b4f1a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c830c163ccaa92e6bbc19e064dd952ba538014af242a25f8800da01a1ff1400fe6cf4361a95c9b38a2570c3bb544914e940a3d5dcbcd869144e91fceb1aa29d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47468fddc33218a26d48952c37273ea1f84abee78c69ae55826f9eddcfc7635d4ed728c2674d358d544e34c10aac9797db05cd0d0caaa3cf3538a785bf514cfe"} 19:20:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:20:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:20:34 INFO - Contents: 19:20:34 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fef3191ba3388704941eaa21f7c14876298c3c166ba03279aa2c405c727a5cbd36f93963b2bf489b53782468502e08300df693999aebd2c7a66915f9f64f0fed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/106df02d53134061a98dbd034e7ffc9df5f3984ae310d497afb6b9559a78013e2040d97e3f6bb83a5be92e019b5f466293960c88b9a82b6be419815812b4f1a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c830c163ccaa92e6bbc19e064dd952ba538014af242a25f8800da01a1ff1400fe6cf4361a95c9b38a2570c3bb544914e940a3d5dcbcd869144e91fceb1aa29d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47468fddc33218a26d48952c37273ea1f84abee78c69ae55826f9eddcfc7635d4ed728c2674d358d544e34c10aac9797db05cd0d0caaa3cf3538a785bf514cfe"} 19:20:34 INFO - Running post-run listener: copy_logs_to_upload_dir 19:20:34 INFO - Copying logs to upload dir... 19:20:34 INFO - mkdir: /builds/slave/test/build/upload/logs 19:20:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.631176 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-23 19:20:34.479872) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 19:20:34.483781) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237 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/sha512/fef3191ba3388704941eaa21f7c14876298c3c166ba03279aa2c405c727a5cbd36f93963b2bf489b53782468502e08300df693999aebd2c7a66915f9f64f0fed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/106df02d53134061a98dbd034e7ffc9df5f3984ae310d497afb6b9559a78013e2040d97e3f6bb83a5be92e019b5f466293960c88b9a82b6be419815812b4f1a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c830c163ccaa92e6bbc19e064dd952ba538014af242a25f8800da01a1ff1400fe6cf4361a95c9b38a2570c3bb544914e940a3d5dcbcd869144e91fceb1aa29d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47468fddc33218a26d48952c37273ea1f84abee78c69ae55826f9eddcfc7635d4ed728c2674d358d544e34c10aac9797db05cd0d0caaa3cf3538a785bf514cfe"} build_url:https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/LUZZ1SOYRVeP5njBkcTVNw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fef3191ba3388704941eaa21f7c14876298c3c166ba03279aa2c405c727a5cbd36f93963b2bf489b53782468502e08300df693999aebd2c7a66915f9f64f0fed", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/106df02d53134061a98dbd034e7ffc9df5f3984ae310d497afb6b9559a78013e2040d97e3f6bb83a5be92e019b5f466293960c88b9a82b6be419815812b4f1a7", "dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1c830c163ccaa92e6bbc19e064dd952ba538014af242a25f8800da01a1ff1400fe6cf4361a95c9b38a2570c3bb544914e940a3d5dcbcd869144e91fceb1aa29d", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47468fddc33218a26d48952c37273ea1f84abee78c69ae55826f9eddcfc7635d4ed728c2674d358d544e34c10aac9797db05cd0d0caaa3cf3538a785bf514cfe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-23 19:20:34.511024) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:20:34.511392) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1503539979.132793-1571220237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-23 19:20:34.594329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 19:20:34.594647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-23 19:20:34.594965) ========= ========= Total master_lag: 0.16 =========