builder: mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s-pgo slave: talos-linux64-ix-042 starttime: 1505777065.37 results: success (0) revision: 948dc86aabc97e16d51ad19ea90debab6f93a628 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:25.368789) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:25.369145) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:25.369426) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:25.661995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:25.662239) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-09-18 16:24:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 107M=0s 2017-09-18 16:24:25 (107 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078912 ========= master_lag: 0.10 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:25.845084) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:25.845373) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019021 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:25.922839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:25.923178) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 948dc86aabc97e16d51ad19ea90debab6f93a628 --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 948dc86aabc97e16d51ad19ea90debab6f93a628 --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=74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-09-18 16:24:25,918 truncating revision to first 12 chars 2017-09-18 16:24:25,918 Setting DEBUG logging. 2017-09-18 16:24:25,918 attempt 1/10 2017-09-18 16:24:25,919 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/948dc86aabc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-09-18 16:24:26,285 unpacking tar archive at: mozilla-central-948dc86aabc9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685654 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.693040) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.698327) ========= script_repo_revision: 948dc86aabc97e16d51ad19ea90debab6f93a628 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.698752) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.699059) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-09-18 16:24:26.830097) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-18 16:24:26.830376) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-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-stylo-disabled-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=74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:24:26 INFO - MultiFileLogger online at 20170918 16:24:26 in /builds/slave/test 16:24:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-stylo-disabled-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:24:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:24:26 INFO - {'append_to_log': False, 16:24:26 INFO - 'base_work_dir': '/builds/slave/test', 16:24:26 INFO - 'blob_upload_branch': 'Firefox', 16:24:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:24:26 INFO - 'branch': 'Firefox', 16:24:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:24:26 INFO - 'code_coverage': False, 16:24:26 INFO - 'config_files': ('talos/linux_config.py',), 16:24:26 INFO - 'default_actions': ('clobber', 16:24:26 INFO - 'read-buildbot-config', 16:24:26 INFO - 'download-and-extract', 16:24:26 INFO - 'populate-webroot', 16:24:26 INFO - 'create-virtualenv', 16:24:26 INFO - 'install', 16:24:26 INFO - 'setup-mitmproxy', 16:24:26 INFO - 'run-tests'), 16:24:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:24:26 INFO - 'disable_ccov_upload': False, 16:24:26 INFO - 'disable_stylo': False, 16:24:26 INFO - 'download_minidump_stackwalk': True, 16:24:26 INFO - 'download_symbols': 'ondemand', 16:24:26 INFO - 'enable_stylo': False, 16:24:26 INFO - 'enable_webrender': False, 16:24:26 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 16:24:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:24:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:24:26 INFO - 'gecko_profile': False, 16:24:26 INFO - 'gecko_profile_interval': 0, 16:24:26 INFO - 'installer_path': 'installer.exe', 16:24:26 INFO - 'log_level': 'info', 16:24:26 INFO - 'log_name': 'talos', 16:24:26 INFO - 'log_to_console': True, 16:24:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:24:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:24:26 INFO - 'opt_config_files': (), 16:24:26 INFO - 'pip_index': False, 16:24:26 INFO - 'suite': 'dromaeojs-stylo-disabled-e10s', 16:24:26 INFO - 'system_bits': '32', 16:24:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:24:26 INFO - 'title': 'talos-linux64-ix-042', 16:24:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:24:26 INFO - 'use_talos_json': True, 16:24:26 INFO - 'verify': 'False', 16:24:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:24:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:24:26 INFO - 'work_dir': 'build'} 16:24:26 INFO - [mozharness: 2017-09-18 23:24:26.926353Z] Running clobber step. 16:24:26 INFO - Running pre-action listener: _resource_record_pre_action 16:24:26 INFO - Running main action method: clobber 16:24:26 INFO - rmtree: /builds/slave/test/build 16:24:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:24:27 INFO - Running post-action listener: _resource_record_post_action 16:24:27 INFO - [mozharness: 2017-09-18 23:24:27.927919Z] Finished clobber step (success) 16:24:27 INFO - [mozharness: 2017-09-18 23:24:27.928018Z] Running read-buildbot-config step. 16:24:27 INFO - Running pre-action listener: _resource_record_pre_action 16:24:27 INFO - Running main action method: read_buildbot_config 16:24:27 INFO - Using buildbot properties: 16:24:27 INFO - { 16:24:27 INFO - "project": "", 16:24:27 INFO - "product": "firefox", 16:24:27 INFO - "who": "kwierso@gmail.com", 16:24:27 INFO - "installer_path": "public/build/target.tar.bz2", 16:24:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-stylo-disabled-e10s", 16:24:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:24:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-stylo-disabled-e10s", 16:24:27 INFO - "stage_platform": "linux64-pgo", 16:24:27 INFO - "basedir": "/builds/slave/test", 16:24:27 INFO - "buildnumber": 31, 16:24:27 INFO - "platform": "ubuntu64_hw", 16:24:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:24:27 INFO - "slavebuilddir": "test", 16:24:27 INFO - "taskId": "RFBXPb2wTkqYCS_o4xHK6g", 16:24:27 INFO - "branch": "mozilla-central", 16:24:27 INFO - "script_repo_revision": "production", 16:24:27 INFO - "revision": "948dc86aabc97e16d51ad19ea90debab6f93a628", 16:24:27 INFO - "slavename": "talos-linux64-ix-042", 16:24:27 INFO - "repo_path": "mozilla-central" 16:24:27 INFO - } 16:24:27 INFO - Finding installer, test and symbols from parent task. 16:24:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RFBXPb2wTkqYCS_o4xHK6g'}, attempt #1 16:24:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RFBXPb2wTkqYCS_o4xHK6g'}, attempt #1 16:24:28 INFO - Task dependencies: UqTWGDHrQViBxHcj81BZMg 16:24:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg'}, attempt #1 16:24:29 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2 16:24:29 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.test_packages.json 16:24:29 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.crashreporter-symbols.zip 16:24:29 INFO - Running post-action listener: _resource_record_post_action 16:24:29 INFO - [mozharness: 2017-09-18 23:24:29.274266Z] Finished read-buildbot-config step (success) 16:24:29 INFO - [mozharness: 2017-09-18 23:24:29.274484Z] Running download-and-extract step. 16:24:29 INFO - Running pre-action listener: _resource_record_pre_action 16:24:29 INFO - Running main action method: download_and_extract 16:24:29 INFO - mkdir: /builds/slave/test/build/tests 16:24:29 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')]} 16:24:29 INFO - trying https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.test_packages.json 16:24:29 INFO - Downloading https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:24:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:24:29 INFO - Downloaded 989 bytes. 16:24:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:24:29 INFO - Using the following test package requirements: 16:24:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:24:29 INFO - u'common': [u'target.common.tests.zip'], 16:24:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:24:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:24:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:24:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:24:29 INFO - u'mozbase': [u'target.common.tests.zip'], 16:24:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:24:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:24:29 INFO - u'web-platform': [u'target.common.tests.zip', 16:24:29 INFO - u'target.web-platform.tests.tar.gz'], 16:24:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:24:29 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 16:24:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.common.tests.zip 16:24:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:24:29 INFO - Fetch https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.common.tests.zip into memory 16:24:32 INFO - Content-Length response header: 55322739 16:24:32 INFO - Bytes received: 55322739 16:24:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.talos.tests.zip 16:24:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:24:43 INFO - Fetch https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.talos.tests.zip into memory 16:24:45 INFO - Content-Length response header: 14508748 16:24:45 INFO - Bytes received: 14508748 16:24:45 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')]} 16:24:45 INFO - trying https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2 16:24:45 INFO - Downloading https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:24:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:24:49 INFO - Downloaded 62224112 bytes. 16:24:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2 16:24:49 INFO - mkdir: /builds/slave/test/properties 16:24:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:24:49 INFO - Writing to file /builds/slave/test/properties/build_url 16:24:49 INFO - Contents: 16:24:49 INFO - build_url:https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2 16:24:49 INFO - Running post-action listener: _resource_record_post_action 16:24:49 INFO - Running post-action listener: find_tests_for_verification 16:24:49 INFO - Running post-action listener: set_extra_try_arguments 16:24:49 INFO - [mozharness: 2017-09-18 23:24:49.736938Z] Finished download-and-extract step (success) 16:24:49 INFO - [mozharness: 2017-09-18 23:24:49.737110Z] Running populate-webroot step. 16:24:49 INFO - Running pre-action listener: _resource_record_pre_action 16:24:49 INFO - Running main action method: populate_webroot 16:24:49 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:24:49 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:49 INFO - 'tests': ['tresize', 16:24:49 INFO - 'tcanvasmark']}, 16:24:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:24:49 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:49 INFO - 'tests': ['dromaeo_css', 16:24:49 INFO - 'kraken']}, 16:24:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:24:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:24:49 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:24:49 INFO - 'talos_options': ['--disable-stylo'], 16:24:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:24:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:24:49 INFO - 'tests': ['damp', 'tps']}, 16:24:49 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:24:49 INFO - 'talos_options': ['--disable-stylo'], 16:24:49 INFO - 'tests': ['damp', 'tps']}, 16:24:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:24:49 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:49 INFO - 'tests': ['dromaeo_dom']}, 16:24:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:24:49 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:49 INFO - 'tests': ['basic_compositor_video', 16:24:49 INFO - 'glvideo']}, 16:24:49 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:24:49 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:24:50 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['ts_paint_webext', 16:24:50 INFO - 'tp5o_webext']}, 16:24:50 INFO - 'other-e10s': {'tests': ['a11yr', 16:24:50 INFO - 'ts_paint', 16:24:50 INFO - 'tpaint', 16:24:50 INFO - 'sessionrestore', 16:24:50 INFO - 'sessionrestore_many_windows', 16:24:50 INFO - 'sessionrestore_no_auto_restore', 16:24:50 INFO - 'tabpaint']}, 16:24:50 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['a11yr', 16:24:50 INFO - 'ts_paint', 16:24:50 INFO - 'tpaint', 16:24:50 INFO - 'sessionrestore', 16:24:50 INFO - 'sessionrestore_many_windows', 16:24:50 INFO - 'sessionrestore_no_auto_restore', 16:24:50 INFO - 'tabpaint']}, 16:24:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:24:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 16:24:50 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['perf_reftest_singletons']}, 16:24:50 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['bloom_basic']}, 16:24:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:24:50 INFO - 'tsvgr_opacity', 16:24:50 INFO - 'tart', 16:24:50 INFO - 'tscrollx', 16:24:50 INFO - 'tsvg_static']}, 16:24:50 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['tsvgx', 16:24:50 INFO - 'tsvgr_opacity', 16:24:50 INFO - 'tart', 16:24:50 INFO - 'tscrollx', 16:24:50 INFO - 'tsvg_static']}, 16:24:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:24:50 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'talos_options': ['--disable-stylo'], 16:24:50 INFO - 'tests': ['tp5o']}, 16:24:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:24:50 INFO - 'talos_options': ['--mitmproxy', 16:24:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:24:50 INFO - '--firstNonBlankPaint'], 16:24:50 INFO - 'tests': ['tp6_google', 16:24:50 INFO - 'tp6_youtube', 16:24:50 INFO - 'tp6_amazon', 16:24:50 INFO - 'tp6_facebook']}, 16:24:50 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:24:50 INFO - 'talos_options': ['--disable-stylo', 16:24:50 INFO - '--mitmproxy', 16:24:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:24:50 INFO - '--firstNonBlankPaint'], 16:24:50 INFO - 'tests': ['tp6_google', 16:24:50 INFO - 'tp6_youtube', 16:24:50 INFO - 'tp6_amazon', 16:24:50 INFO - 'tp6_facebook']}, 16:24:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:24:50 INFO - 'talos_options': ['--stylo-threads=1', 16:24:50 INFO - '--mitmproxy', 16:24:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:24:50 INFO - '--firstNonBlankPaint'], 16:24:50 INFO - 'tests': ['tp6_google', 16:24:50 INFO - 'tp6_youtube', 16:24:50 INFO - 'tp6_amazon', 16:24:50 INFO - 'tp6_facebook']}, 16:24:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'talos_options': ['--xperf_path', 16:24:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:24:50 INFO - 'tests': ['tp5n']}, 16:24:50 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 16:24:50 INFO - 'talos_options': ['--disable-stylo', 16:24:50 INFO - '--xperf_path', 16:24:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:24:50 INFO - 'tests': ['tp5n']}}} 16:24:50 INFO - Running post-action listener: _resource_record_post_action 16:24:50 INFO - [mozharness: 2017-09-18 23:24:50.007117Z] Finished populate-webroot step (success) 16:24:50 INFO - [mozharness: 2017-09-18 23:24:50.007340Z] Running create-virtualenv step. 16:24:50 INFO - Running pre-action listener: _resource_record_pre_action 16:24:50 INFO - Running main action method: create_virtualenv 16:24:50 INFO - Creating virtualenv /builds/slave/test/build/venv 16:24:50 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:24:50 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 16:24:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:24:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:24:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:24:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:24:50 INFO - Installing pip...............done. 16:24:50 INFO - Return code: 0 16:24:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:24:50 INFO - Reading from file tmpfile_stdout 16:24:50 INFO - Output received: 16:24:50 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 16:24:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:50 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', '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 16:24:50 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 16:24:50 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 16:24:50 INFO - Using env: {'DISPLAY': ':0', 16:24:50 INFO - 'HOME': '/home/cltbld', 16:24:50 INFO - 'LANG': 'en_US.UTF-8', 16:24:50 INFO - 'LANGUAGE': 'en_US:en', 16:24:50 INFO - 'LOGNAME': 'cltbld', 16:24:51 INFO - 'MAIL': '/var/mail/cltbld', 16:24:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:51 INFO - 'MOZ_NO_REMOTE': '1', 16:24:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:51 INFO - 'NO_EM_RESTART': '1', 16:24:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:51 INFO - 'PWD': '/builds/slave/test', 16:24:51 INFO - 'SHELL': '/bin/bash', 16:24:51 INFO - 'SHLVL': '1', 16:24:51 INFO - 'TERM': 'linux', 16:24:51 INFO - 'TMOUT': '86400', 16:24:51 INFO - 'USER': 'cltbld', 16:24:51 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:24:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:51 INFO - '_': '/tools/buildbot/bin/python'} 16:24:52 INFO - Ignoring indexes: http://pypi.python.org/simple/ 16:24:52 INFO - Downloading/unpacking pip>=1.5 16:24:52 INFO - Running setup.py egg_info for package pip 16:24:52 INFO - warning: no files found matching 'pip/cacert.pem' 16:24:52 INFO - warning: no files found matching '*.html' under directory 'docs' 16:24:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:24:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:24:52 INFO - Installing collected packages: pip 16:24:52 INFO - Found existing installation: pip 1.1 16:24:52 INFO - Uninstalling pip: 16:24:52 INFO - Successfully uninstalled pip 16:24:52 INFO - Running setup.py install for pip 16:24:52 INFO - warning: no files found matching 'pip/cacert.pem' 16:24:52 INFO - warning: no files found matching '*.html' under directory 'docs' 16:24:52 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 16:24:52 INFO - no previously-included directories found matching 'docs/_build/_sources' 16:24:52 INFO - Installing pip script to /builds/slave/test/build/venv/bin 16:24:52 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 16:24:52 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 16:24:52 INFO - Successfully installed pip 16:24:52 INFO - Cleaning up... 16:24:52 INFO - Return code: 0 16:24:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:52 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', '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 16:24:52 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 16:24:52 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 16:24:52 INFO - Using env: {'DISPLAY': ':0', 16:24:52 INFO - 'HOME': '/home/cltbld', 16:24:52 INFO - 'LANG': 'en_US.UTF-8', 16:24:52 INFO - 'LANGUAGE': 'en_US:en', 16:24:52 INFO - 'LOGNAME': 'cltbld', 16:24:52 INFO - 'MAIL': '/var/mail/cltbld', 16:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:52 INFO - 'MOZ_NO_REMOTE': '1', 16:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:52 INFO - 'NO_EM_RESTART': '1', 16:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:52 INFO - 'PWD': '/builds/slave/test', 16:24:52 INFO - 'SHELL': '/bin/bash', 16:24:52 INFO - 'SHLVL': '1', 16:24:52 INFO - 'TERM': 'linux', 16:24:52 INFO - 'TMOUT': '86400', 16:24:52 INFO - 'USER': 'cltbld', 16:24:52 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:52 INFO - '_': '/tools/buildbot/bin/python'} 16:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:52 INFO - Downloading/unpacking psutil>=3.1.1 16:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:24:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:53 INFO - Installing collected packages: psutil 16:24:53 INFO - Running setup.py install for psutil 16:24:53 INFO - building 'psutil._psutil_linux' extension 16:24:53 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 16:24:53 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 16:24:53 INFO - building 'psutil._psutil_posix' extension 16:24:53 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 16:24:54 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 16:24:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:24:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:24:54 INFO - Successfully installed psutil 16:24:54 INFO - Cleaning up... 16:24:54 INFO - Return code: 0 16:24:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:24:54 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')]} 16:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:54 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')]} 16:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:54 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', '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 16:24:54 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 16:24:54 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 16:24:54 INFO - Using env: {'DISPLAY': ':0', 16:24:54 INFO - 'HOME': '/home/cltbld', 16:24:54 INFO - 'LANG': 'en_US.UTF-8', 16:24:54 INFO - 'LANGUAGE': 'en_US:en', 16:24:54 INFO - 'LOGNAME': 'cltbld', 16:24:54 INFO - 'MAIL': '/var/mail/cltbld', 16:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:54 INFO - 'MOZ_NO_REMOTE': '1', 16:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:54 INFO - 'NO_EM_RESTART': '1', 16:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:54 INFO - 'PWD': '/builds/slave/test', 16:24:54 INFO - 'SHELL': '/bin/bash', 16:24:54 INFO - 'SHLVL': '1', 16:24:54 INFO - 'TERM': 'linux', 16:24:54 INFO - 'TMOUT': '86400', 16:24:54 INFO - 'USER': 'cltbld', 16:24:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:54 INFO - '_': '/tools/buildbot/bin/python'} 16:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:24:54 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 16:24:54 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 16:24:54 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 16:24:54 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 16:24:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:24:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:24:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:24:55 INFO - Installing collected packages: mozsystemmonitor 16:24:55 INFO - Running setup.py install for mozsystemmonitor 16:24:55 INFO - Successfully installed mozsystemmonitor 16:24:55 INFO - Cleaning up... 16:24:56 INFO - Return code: 0 16:24:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:24:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', '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 16:24:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:24:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:24:56 INFO - Using env: {'DISPLAY': ':0', 16:24:56 INFO - 'HOME': '/home/cltbld', 16:24:56 INFO - 'LANG': 'en_US.UTF-8', 16:24:56 INFO - 'LANGUAGE': 'en_US:en', 16:24:56 INFO - 'LOGNAME': 'cltbld', 16:24:56 INFO - 'MAIL': '/var/mail/cltbld', 16:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:24:56 INFO - 'MOZ_NO_REMOTE': '1', 16:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:24:56 INFO - 'NO_EM_RESTART': '1', 16:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:24:56 INFO - 'PWD': '/builds/slave/test', 16:24:56 INFO - 'SHELL': '/bin/bash', 16:24:56 INFO - 'SHLVL': '1', 16:24:56 INFO - 'TERM': 'linux', 16:24:56 INFO - 'TMOUT': '86400', 16:24:56 INFO - 'USER': 'cltbld', 16:24:56 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:24:56 INFO - '_': '/tools/buildbot/bin/python'} 16:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:24:57 INFO - Downloading/unpacking jsonschema==2.5.1 16:24:57 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 16:24:57 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 16:24:57 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 16:24:57 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 16:24:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:24:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:24:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:24:58 INFO - Downloading functools32-3.2.3-2.tar.gz 16:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:24:58 INFO - warning: no files found matching '*.txt' 16:24:58 INFO - no previously-included directories found matching 'build' 16:24:58 INFO - no previously-included directories found matching 'dist' 16:24:58 INFO - no previously-included directories found matching '.git*' 16:24:58 INFO - Installing collected packages: jsonschema, functools32 16:24:58 INFO - Running setup.py install for functools32 16:25:02 INFO - warning: no files found matching '*.txt' 16:25:02 INFO - no previously-included directories found matching 'build' 16:25:02 INFO - no previously-included directories found matching 'dist' 16:25:02 INFO - no previously-included directories found matching '.git*' 16:25:02 INFO - Successfully installed jsonschema functools32 16:25:02 INFO - Cleaning up... 16:25:02 INFO - Return code: 0 16:25:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:25:02 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')]} 16:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:02 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')]} 16:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:02 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', '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 16:25:02 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 16:25:02 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 16:25:02 INFO - Using env: {'DISPLAY': ':0', 16:25:02 INFO - 'HOME': '/home/cltbld', 16:25:02 INFO - 'LANG': 'en_US.UTF-8', 16:25:02 INFO - 'LANGUAGE': 'en_US:en', 16:25:02 INFO - 'LOGNAME': 'cltbld', 16:25:02 INFO - 'MAIL': '/var/mail/cltbld', 16:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:02 INFO - 'MOZ_NO_REMOTE': '1', 16:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:02 INFO - 'NO_EM_RESTART': '1', 16:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:02 INFO - 'PWD': '/builds/slave/test', 16:25:02 INFO - 'SHELL': '/bin/bash', 16:25:02 INFO - 'SHLVL': '1', 16:25:02 INFO - 'TERM': 'linux', 16:25:02 INFO - 'TMOUT': '86400', 16:25:02 INFO - 'USER': 'cltbld', 16:25:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:02 INFO - '_': '/tools/buildbot/bin/python'} 16:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:25:02 INFO - Cleaning up... 16:25:02 INFO - Return code: 0 16:25:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:25:02 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')]} 16:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:02 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')]} 16:25:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:02 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', '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 16:25:02 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 16:25:02 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 16:25:02 INFO - Using env: {'DISPLAY': ':0', 16:25:02 INFO - 'HOME': '/home/cltbld', 16:25:02 INFO - 'LANG': 'en_US.UTF-8', 16:25:02 INFO - 'LANGUAGE': 'en_US:en', 16:25:02 INFO - 'LOGNAME': 'cltbld', 16:25:02 INFO - 'MAIL': '/var/mail/cltbld', 16:25:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:02 INFO - 'MOZ_NO_REMOTE': '1', 16:25:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:02 INFO - 'NO_EM_RESTART': '1', 16:25:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:02 INFO - 'PWD': '/builds/slave/test', 16:25:02 INFO - 'SHELL': '/bin/bash', 16:25:02 INFO - 'SHLVL': '1', 16:25:02 INFO - 'TERM': 'linux', 16:25:02 INFO - 'TMOUT': '86400', 16:25:02 INFO - 'USER': 'cltbld', 16:25:02 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:25:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:02 INFO - '_': '/tools/buildbot/bin/python'} 16:25:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:02 INFO - Downloading/unpacking blobuploader==1.2.4 16:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:25:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:25:03 INFO - Downloading blobuploader-1.2.4.tar.gz 16:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:25:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:25:04 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 16:25:04 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 16:25:04 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 16:25:04 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 16:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:25:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:25:04 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 16:25:04 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 16:25:04 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 16:25:04 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 16:25:04 INFO - Downloading docopt-0.6.1.tar.gz 16:25:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:25:04 INFO - Installing collected packages: blobuploader, requests, docopt 16:25:04 INFO - Running setup.py install for blobuploader 16:25:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:25:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:25:04 INFO - Running setup.py install for requests 16:25:05 INFO - Running setup.py install for docopt 16:25:05 INFO - Successfully installed blobuploader requests docopt 16:25:05 INFO - Cleaning up... 16:25:05 INFO - Return code: 0 16:25:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:05 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')]} 16:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:05 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')]} 16:25:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:05 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', '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 16:25:05 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 16:25:05 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 16:25:05 INFO - Using env: {'DISPLAY': ':0', 16:25:05 INFO - 'HOME': '/home/cltbld', 16:25:05 INFO - 'LANG': 'en_US.UTF-8', 16:25:05 INFO - 'LANGUAGE': 'en_US:en', 16:25:05 INFO - 'LOGNAME': 'cltbld', 16:25:05 INFO - 'MAIL': '/var/mail/cltbld', 16:25:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:05 INFO - 'MOZ_NO_REMOTE': '1', 16:25:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:05 INFO - 'NO_EM_RESTART': '1', 16:25:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:05 INFO - 'PWD': '/builds/slave/test', 16:25:05 INFO - 'SHELL': '/bin/bash', 16:25:05 INFO - 'SHLVL': '1', 16:25:05 INFO - 'TERM': 'linux', 16:25:05 INFO - 'TMOUT': '86400', 16:25:05 INFO - 'USER': 'cltbld', 16:25:05 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:25:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:05 INFO - '_': '/tools/buildbot/bin/python'} 16:25:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:25:05 INFO - Running setup.py (path:/tmp/pip-ya2b9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:25:05 INFO - Running setup.py (path:/tmp/pip-yrXyS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:25:05 INFO - Running setup.py (path:/tmp/pip-eQZ2oJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:25:05 INFO - Running setup.py (path:/tmp/pip-xfHfKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:25:05 INFO - Running setup.py (path:/tmp/pip-b6VJTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:25:05 INFO - Running setup.py (path:/tmp/pip-t7E35e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:25:05 INFO - Running setup.py (path:/tmp/pip-XmTVuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:25:05 INFO - Running setup.py (path:/tmp/pip-Hn5F_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:25:05 INFO - Running setup.py (path:/tmp/pip-mAOqIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:25:06 INFO - Running setup.py (path:/tmp/pip-ep5wYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:25:06 INFO - Running setup.py (path:/tmp/pip-L_EcdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:25:06 INFO - Running setup.py (path:/tmp/pip-yNcUQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:25:06 INFO - Running setup.py (path:/tmp/pip-CGYGb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:25:06 INFO - Running setup.py (path:/tmp/pip-e4oYse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:06 INFO - Running setup.py (path:/tmp/pip-y7qtsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:25:06 INFO - Running setup.py (path:/tmp/pip-pZnAtx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:25:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:25:06 INFO - Running setup.py (path:/tmp/pip-3P6jA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:25:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:25:06 INFO - Running setup.py install for manifestparser 16:25:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:25:06 INFO - Running setup.py install for mozcrash 16:25:06 INFO - Running setup.py install for mozdebug 16:25:06 INFO - Running setup.py install for mozdevice 16:25:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:25:06 INFO - Running setup.py install for mozfile 16:25:07 INFO - Running setup.py install for mozhttpd 16:25:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:25:07 INFO - Running setup.py install for mozinfo 16:25:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:25:07 INFO - Running setup.py install for mozInstall 16:25:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:25:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:25:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:25:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:25:07 INFO - Running setup.py install for mozleak 16:25:07 INFO - Running setup.py install for mozlog 16:25:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:25:07 INFO - Running setup.py install for moznetwork 16:25:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:25:07 INFO - Running setup.py install for mozprocess 16:25:07 INFO - Running setup.py install for mozprofile 16:25:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:25:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:25:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:25:07 INFO - Running setup.py install for mozrunner 16:25:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:25:08 INFO - Running setup.py install for mozscreenshot 16:25:08 INFO - Running setup.py install for moztest 16:25:08 INFO - Running setup.py install for mozversion 16:25:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:25:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:25:08 INFO - Cleaning up... 16:25:08 INFO - Return code: 0 16:25:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25:08 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')]} 16:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25:08 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')]} 16:25:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:08 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', '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 16:25:08 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 16:25:08 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 16:25:08 INFO - Using env: {'DISPLAY': ':0', 16:25:08 INFO - 'HOME': '/home/cltbld', 16:25:08 INFO - 'LANG': 'en_US.UTF-8', 16:25:08 INFO - 'LANGUAGE': 'en_US:en', 16:25:08 INFO - 'LOGNAME': 'cltbld', 16:25:08 INFO - 'MAIL': '/var/mail/cltbld', 16:25:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:08 INFO - 'MOZ_NO_REMOTE': '1', 16:25:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:08 INFO - 'NO_EM_RESTART': '1', 16:25:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:08 INFO - 'PWD': '/builds/slave/test', 16:25:08 INFO - 'SHELL': '/bin/bash', 16:25:08 INFO - 'SHLVL': '1', 16:25:08 INFO - 'TERM': 'linux', 16:25:08 INFO - 'TMOUT': '86400', 16:25:08 INFO - 'USER': 'cltbld', 16:25:08 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:25:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:08 INFO - '_': '/tools/buildbot/bin/python'} 16:25:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:25:08 INFO - Running setup.py (path:/tmp/pip-MNoyyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:25:08 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)) 16:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:25:08 INFO - Running setup.py (path:/tmp/pip-LwEBCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:25:08 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)) 16:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:25:08 INFO - Running setup.py (path:/tmp/pip-cmE6Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:25:08 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)) 16:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:25:08 INFO - Running setup.py (path:/tmp/pip-ZZcS3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:25:08 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)) 16:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:25:08 INFO - Running setup.py (path:/tmp/pip-JV9Ref-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:25:08 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)) 16:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:25:08 INFO - Running setup.py (path:/tmp/pip-ZXwEle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:25:08 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)) 16:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:25:09 INFO - Running setup.py (path:/tmp/pip-aN8cs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:25:09 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)) 16:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:25:09 INFO - Running setup.py (path:/tmp/pip-nskEpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:25:09 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)) 16:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:25:09 INFO - Running setup.py (path:/tmp/pip-57gX6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:25:09 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)) 16:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:25:09 INFO - Running setup.py (path:/tmp/pip-Qgi6gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:25:09 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)) 16:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:25:09 INFO - Running setup.py (path:/tmp/pip-reRqXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:25:09 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)) 16:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:25:09 INFO - Running setup.py (path:/tmp/pip-GXyFgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:25:09 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)) 16:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:25:09 INFO - Running setup.py (path:/tmp/pip-PraR__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:25:09 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)) 16:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:25:09 INFO - Running setup.py (path:/tmp/pip-m3e1FO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:25:09 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)) 16:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:09 INFO - Running setup.py (path:/tmp/pip-VDCjuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:25:09 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)) 16:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:25:09 INFO - Running setup.py (path:/tmp/pip-S4GcRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:25:09 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)) 16:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:25:09 INFO - Running setup.py (path:/tmp/pip-dnX_xQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:25:09 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)) 16:25:09 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)) 16:25:09 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)) 16:25:09 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)) 16:25:09 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)) 16:25:09 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)) 16:25:09 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)) 16:25:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:25:09 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 16:25:09 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 16:25:09 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 16:25:09 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 16:25:10 INFO - Downloading blessings-1.6.tar.gz 16:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:25:10 INFO - Installing collected packages: blessings 16:25:10 INFO - Running setup.py install for blessings 16:25:11 INFO - Successfully installed blessings 16:25:11 INFO - Cleaning up... 16:25:11 INFO - Return code: 0 16:25:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:25:11 INFO - Reading from file tmpfile_stdout 16:25:11 INFO - Current package versions: 16:25:11 INFO - argparse == 1.2.1 16:25:11 INFO - blessings == 1.6 16:25:11 INFO - blobuploader == 1.2.4 16:25:11 INFO - docopt == 0.6.1 16:25:11 INFO - functools32 == 3.2.3-2 16:25:11 INFO - jsonschema == 2.5.1 16:25:11 INFO - manifestparser == 1.1 16:25:11 INFO - mozInstall == 1.13 16:25:11 INFO - mozcrash == 1.0 16:25:11 INFO - mozdebug == 0.1 16:25:11 INFO - mozdevice == 0.51 16:25:11 INFO - mozfile == 1.2 16:25:11 INFO - mozhttpd == 0.7 16:25:11 INFO - mozinfo == 0.10 16:25:11 INFO - mozleak == 0.1 16:25:11 INFO - mozlog == 3.5 16:25:11 INFO - moznetwork == 0.27 16:25:11 INFO - mozprocess == 0.25 16:25:11 INFO - mozprofile == 0.28 16:25:11 INFO - mozrunner == 6.13 16:25:11 INFO - mozscreenshot == 0.1 16:25:11 INFO - mozsystemmonitor == 0.3 16:25:11 INFO - moztest == 0.8 16:25:11 INFO - mozversion == 1.4 16:25:11 INFO - psutil == 3.1.1 16:25:11 INFO - requests == 1.2.3 16:25:11 INFO - wsgiref == 0.1.2 16:25:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25: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')]} 16:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25:11 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 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', '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 16:25:11 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 16:25:11 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 16:25:11 INFO - Using env: {'DISPLAY': ':0', 16:25:11 INFO - 'HOME': '/home/cltbld', 16:25:11 INFO - 'LANG': 'en_US.UTF-8', 16:25:11 INFO - 'LANGUAGE': 'en_US:en', 16:25:11 INFO - 'LOGNAME': 'cltbld', 16:25:11 INFO - 'MAIL': '/var/mail/cltbld', 16:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:11 INFO - 'MOZ_NO_REMOTE': '1', 16:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:11 INFO - 'NO_EM_RESTART': '1', 16:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:11 INFO - 'PWD': '/builds/slave/test', 16:25:11 INFO - 'SHELL': '/bin/bash', 16:25:11 INFO - 'SHLVL': '1', 16:25:11 INFO - 'TERM': 'linux', 16:25:11 INFO - 'TMOUT': '86400', 16:25:11 INFO - 'USER': 'cltbld', 16:25:11 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:11 INFO - '_': '/tools/buildbot/bin/python'} 16:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:11 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)) 16:25:11 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)) 16:25:11 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)) 16:25:11 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)) 16:25:11 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)) 16:25:11 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)) 16:25:11 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)) 16:25:11 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)) 16:25:11 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)) 16:25:11 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:25:11 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 16:25:11 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 16:25:11 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 16:25:11 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 16:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:25:12 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)) 16:25:12 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)) 16:25:12 INFO - Installing collected packages: simplejson 16:25:12 INFO - Running setup.py install for simplejson 16:25:12 INFO - building 'simplejson._speedups' extension 16:25:12 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 16:25:13 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 16:25:13 INFO - Successfully installed simplejson 16:25:13 INFO - Cleaning up... 16:25:13 INFO - Return code: 0 16:25:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:25: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')]} 16:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:25: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')]} 16:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:25: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22541f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25c0a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, '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': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', '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 16:25: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', 'jsonschema'] in /builds/slave/test/build 16:25: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 jsonschema 16:25:13 INFO - Using env: {'DISPLAY': ':0', 16:25:13 INFO - 'HOME': '/home/cltbld', 16:25:13 INFO - 'LANG': 'en_US.UTF-8', 16:25:13 INFO - 'LANGUAGE': 'en_US:en', 16:25:13 INFO - 'LOGNAME': 'cltbld', 16:25:13 INFO - 'MAIL': '/var/mail/cltbld', 16:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:13 INFO - 'MOZ_NO_REMOTE': '1', 16:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:13 INFO - 'NO_EM_RESTART': '1', 16:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:13 INFO - 'PWD': '/builds/slave/test', 16:25:13 INFO - 'SHELL': '/bin/bash', 16:25:13 INFO - 'SHLVL': '1', 16:25:13 INFO - 'TERM': 'linux', 16:25:13 INFO - 'TMOUT': '86400', 16:25:13 INFO - 'USER': 'cltbld', 16:25:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:13 INFO - '_': '/tools/buildbot/bin/python'} 16:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:25:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:25:14 INFO - Cleaning up... 16:25:14 INFO - Return code: 0 16:25:14 INFO - Running post-action listener: _resource_record_post_action 16:25:14 INFO - Running post-action listener: _start_resource_monitoring 16:25:14 INFO - Starting resource monitoring. 16:25:14 INFO - [mozharness: 2017-09-18 23:25:14.079723Z] Finished create-virtualenv step (success) 16:25:14 INFO - [mozharness: 2017-09-18 23:25:14.080238Z] Running install step. 16:25:14 INFO - Running pre-action listener: _resource_record_pre_action 16:25:14 INFO - Running main action method: install 16:25:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:25:14 INFO - Reading from file tmpfile_stdout 16:25:14 INFO - Detecting whether we're running mozinstall >=1.0... 16:25:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:25:14 INFO - Reading from file tmpfile_stdout 16:25:14 INFO - Output received: 16:25:14 INFO - Usage: mozinstall [options] installer 16:25:14 INFO - Options: 16:25:14 INFO - -h, --help show this help message and exit 16:25:14 INFO - -d DEST, --destination=DEST 16:25:14 INFO - Directory to install application into. [default: 16:25:14 INFO - "/builds/slave/test"] 16:25:14 INFO - --app=APP Application being installed. [default: firefox] 16:25:14 INFO - mkdir: /builds/slave/test/build/application 16:25:14 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'] 16:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:25:32 INFO - Reading from file tmpfile_stdout 16:25:32 INFO - Output received: 16:25:32 INFO - /builds/slave/test/build/application/firefox/firefox 16:25:32 INFO - Running post-action listener: _resource_record_post_action 16:25:32 INFO - [mozharness: 2017-09-18 23:25:32.032107Z] Finished install step (success) 16:25:32 INFO - [mozharness: 2017-09-18 23:25:32.032360Z] Running setup-mitmproxy step. 16:25:32 INFO - Running pre-action listener: _resource_record_pre_action 16:25:32 INFO - Running main action method: setup_mitmproxy 16:25:32 INFO - Skipping: mitmproxy is not required 16:25:32 INFO - Running post-action listener: _resource_record_post_action 16:25:32 INFO - [mozharness: 2017-09-18 23:25:32.033546Z] Finished setup-mitmproxy step (success) 16:25:32 INFO - [mozharness: 2017-09-18 23:25:32.033765Z] Running run-tests step. 16:25:32 INFO - Running pre-action listener: _resource_record_pre_action 16:25:32 INFO - Running pre-action listener: _set_gcov_prefix 16:25:32 INFO - Running main action method: run_tests 16:25:32 WARNING - Try message not found. 16:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:25:32 INFO - Python 2.7.3 16:25:32 INFO - Return code: 0 16:25:32 INFO - grabbing minidump binary from tooltool 16:25:32 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')]} 16:25:32 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 0x25c4090>, '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 0x25c4d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25bef90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:25:32 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 16:25:32 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 16:25:32 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 16:25:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:25:32 INFO - Return code: 0 16:25:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:25:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:25:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:25:32 INFO - ENV: RUST_BACKTRACE is now full 16:25:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:25:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] in /builds/slave/test/build 16:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-stylo-disabled-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log 16:25:32 INFO - Using env: {'DISPLAY': ':0', 16:25:32 INFO - 'HOME': '/home/cltbld', 16:25:32 INFO - 'LANG': 'en_US.UTF-8', 16:25:32 INFO - 'LANGUAGE': 'en_US:en', 16:25:32 INFO - 'LOGNAME': 'cltbld', 16:25:32 INFO - 'MAIL': '/var/mail/cltbld', 16:25:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:25:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:25:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:32 INFO - 'MOZ_NO_REMOTE': '1', 16:25:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:25:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:32 INFO - 'NO_EM_RESTART': '1', 16:25:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:32 INFO - 'PWD': '/builds/slave/test', 16:25:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:25:32 INFO - 'RUST_BACKTRACE': 'full', 16:25:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:25:32 INFO - 'SHELL': '/bin/bash', 16:25:32 INFO - 'SHLVL': '1', 16:25:32 INFO - 'TERM': 'linux', 16:25:32 INFO - 'TMOUT': '86400', 16:25:32 INFO - 'USER': 'cltbld', 16:25:32 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:25:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:32 INFO - '_': '/tools/buildbot/bin/python'} 16:25:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-stylo-disabled-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log'] with output_timeout 3600 16:25:32 INFO - mozversion application_buildid: 20170918220821 16:25:32 INFO - mozversion application_changeset: 948dc86aabc97e16d51ad19ea90debab6f93a628 16:25:32 INFO - mozversion application_display_name: Nightly 16:25:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:25:32 INFO - mozversion application_name: Firefox 16:25:32 INFO - mozversion application_remotingname: firefox 16:25:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:25:32 INFO - mozversion application_vendor: Mozilla 16:25:32 INFO - mozversion application_version: 57.0a1 16:25:32 INFO - mozversion platform_buildid: 20170918220821 16:25:32 INFO - mozversion platform_changeset: 948dc86aabc97e16d51ad19ea90debab6f93a628 16:25:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:25:32 INFO - mozversion platform_version: 57.0a1 16:25:32 INFO - using testdate: 1505777132 16:25:32 INFO - actual date: 1505777132 16:25:32 INFO - starting webserver on 'localhost:43314' 16:25:32 INFO - SUITE-START | Running 2 tests 16:25:32 INFO - TEST-START | dromaeo_css 16:25:32 INFO - Initialising browser for dromaeo_css test... 16:25:32 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43314/getInfo.html -profile /tmp/tmpjrOJGm/profile 16:25:32 INFO - TEST-INFO | started process 8359 (/builds/slave/test/build/application/firefox/firefox http://localhost:43314/getInfo.html) 16:25:38 INFO - TEST-INFO | 8359: exit 0 16:25:38 INFO - Browser initialized. 16:25:38 INFO - Running cycle 1/1 for dromaeo_css test... 16:25:38 INFO - Using env: {'DISPLAY': ':0', 16:25:38 INFO - 'HOME': '/home/cltbld', 16:25:38 INFO - 'JSGC_DISABLE_POISONING': '1', 16:25:38 INFO - 'LANG': 'en_US.UTF-8', 16:25:38 INFO - 'LANGUAGE': 'en_US:en', 16:25:38 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:25:38 INFO - 'LOGNAME': 'cltbld', 16:25:38 INFO - 'MAIL': '/var/mail/cltbld', 16:25:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:25:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:25:38 INFO - 'MOZ_CRASHREPORTER': '1', 16:25:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:25:38 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:25:38 INFO - 'MOZ_NO_REMOTE': '1', 16:25:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:25:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:25:38 INFO - 'NO_EM_RESTART': '1', 16:25:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:25:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:25:38 INFO - 'PWD': '/builds/slave/test', 16:25:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:25:38 INFO - 'RUST_BACKTRACE': 'full', 16:25:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:25:38 INFO - 'SHELL': '/bin/bash', 16:25:38 INFO - 'SHLVL': '1', 16:25:38 INFO - 'STYLO_FORCE_DISABLED': '1', 16:25:38 INFO - 'TERM': 'linux', 16:25:38 INFO - 'TMOUT': '86400', 16:25:38 INFO - 'USER': 'cltbld', 16:25:38 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:25:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:25:38 INFO - '_': '/tools/buildbot/bin/python'} 16:25:38 INFO - TEST-INFO | started process 8597 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjrOJGm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:25:39 INFO - PID 8597 | 16:25:39 INFO - PID 8597 | (/builds/slave/test/build/application/firefox/firefox:8646): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:25:39 INFO - PID 8597 | 16:25:49 INFO - PID 8597 | RSS: Main: 148262912 16:25:49 INFO - PID 8597 | 16:28:47 INFO - PID 8597 | Cycle 1(1): loaded http://localhost:43314/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43314/tests/dromaeo/cssquery-ext.html) 16:28:48 INFO - PID 8597 | RSS: Main: 151162880 16:28:48 INFO - PID 8597 | 16:31:50 INFO - PID 8597 | Cycle 1(1): loaded http://localhost:43314/tests/dromaeo/cssquery-ext.html (next: http://localhost:43314/tests/dromaeo/cssquery-jquery.html) 16:31:50 INFO - PID 8597 | RSS: Main: 148619264 16:31:50 INFO - PID 8597 | 16:34:52 INFO - PID 8597 | Cycle 1(1): loaded http://localhost:43314/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43314/tests/dromaeo/cssquery-mootools.html) 16:34:53 INFO - PID 8597 | RSS: Main: 150806528 16:34:53 INFO - PID 8597 | 16:37:54 INFO - PID 8597 | Cycle 1(1): loaded http://localhost:43314/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43314/tests/dromaeo/cssquery-prototype.html) 16:37:55 INFO - PID 8597 | RSS: Main: 149348352 16:37:55 INFO - PID 8597 | 16:40:58 INFO - PID 8597 | Cycle 1(1): loaded http://localhost:43314/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43314/tests/dromaeo/cssquery-yui.html) 16:40:58 INFO - PID 8597 | RSS: Main: 150630400 16:40:58 INFO - PID 8597 | 16:44:00 INFO - PID 8597 | Cycle 1(1): loaded http://localhost:43314/tests/dromaeo/cssquery-yui.html (next: http://localhost:43314/tests/dromaeo/cssquery-dojo.html) 16:44:00 INFO - PID 8597 | RSS: Main: 152600576 16:44:00 INFO - PID 8597 | 16:44:00 INFO - PID 8597 | __start_tp_report 16:44:00 INFO - PID 8597 | _x_x_mozilla_page_load 16:44:00 INFO - PID 8597 | _x_x_mozilla_page_load_details 16:44:00 INFO - PID 8597 | |i|pagename|runs| 16:44:00 INFO - PID 8597 | |0;dojo.html;3875.1862108957116;3891.630295121963;3896.337622604157;3909;3920.313945059614;6162.198914141155;6238.157848690436;6301.086342480337;6301.621902685836;6388.3611638836155;6264.029075493295;6275.717592708339;6298.905516417246;6331.493480521559;6365.108884756138;5633.915491267614;5637.098064309711;5650.773969041234;5652.09566469365;5689.345725241588;5660.858478538028;5676.602637815355;5707.65754054756;5715.771369145229;5736.627119237257;5665.206871038058;5667.121596152603;5706.828795136132;5726.398728133528;5753.367129615739;5593.356763972155;5676.205331253628;5696.060150075233;5750.539956803445;5759.078547432412;5072.264521644378;5510.008198524264;5553.944460555384;5564.721763911829;5594.9720251398885;6234.906476402857;6293.181886354791;6311.6213027218055;6324.051392291147;6375.043743438475;6775.695093720795;6780.321967803229;6781.389674929231;6888.070110535064;6890.31096890312;6818.386345228953;6888.862222755517;6890.31096890312;6896.137982752156;6897.3447522485285;6306.9999999999545;6350.110984462179;6384.48924086072;6388.265349484822;6393;6964.094667693269;6966.651667416609;6988.301169883072;7088.503804733722;7105.431565474853;6559.344065593498;6645.06969024337;6647.700853461606;6659.034440006172;6839.897401538981;6670;6764.966175169191;6776.085228494188;6777.423918966844;6781.389674929182;6817.284185160586;6841.931580684229;6843.692033858489;6854.143232095988;6858.588484690835;6793.728250870009;6795;6804.55770374924;6888.931110688829;6892.207396149407;4880.145974454527;4948.752562371867;4957.677750946249;5012.122878496249;5012.573931215888;4538.455385353779;4581.94615238497;4585.862424127282;4600.033992861537;4612.884677883079;6038.456538911519;6251.6561589113035;6253.249610046732;6333.240011198685;6348.396902294275;6873.140857392826;6882.346177113166;6899.517033807686;6903.1371078615175;6908.9309106909295;6196.81409557714;6213.565050446516;6262.843428914313;6295.622262664255;6311.274203466568;5500.779968801283;5505.394406615269;5564.415736347706;5568.777248910079;5570.944290557042;7106.5736055836815;7131.322524360177;7135.357817796424;7148.642567871586;7189.0294810201;6730.259671436236;6790.117284753148;6801.829954251183;6819.727210911508;6894.379505844498;7045.647717614202;7121.145462544528;7197.280271972761;7205.7838264852135;7256.455765817479;6593.604383736991;6716.194056713226;6721.966390168018;6731.360520750717;6831.248562658005;6829.795106146824;6832.658367081725;6843.076184715;6850.417714494324;6858.348456896587;6516.674166291761;6577.736890524326;6673.232578253563;6677.766278180435;6681;6519.315471875574;6558.540902136805;6560.573562718408;6564.081028655896;6571.277159512545;6531.608103513804;6586.901196482152;6596;6597.60414375139;6610.4050635443045;6558.081868538504;6638.468922486286;6654.334566543307;6742.056112144402;6758.357955994173;6367.140436041261;6404.423601875854;6416.550841441241;6450.612963222222;6534.640594767334 16:44:00 INFO - PID 8597 | |1;ext.html;881.8265159121665;911.1116661255281;931.1014870649822;958.3339578992603;966.1932286540738;44206.77896610521;44792;45104.32343514846;45132;45230.09539809206;42608.786956065174;43213;43242.135157296834;43270.78364608173;43382;7251.093613298351;7311;7342.302481264272;7365.968764372992;7371.483996120273;7279.162896266917;7327.157376901671;7348.485606007582;7371.852562948738;7377.926220737778;7354.117505899299;7979.601019948979;8182.18178182183;8206;8210.548419836907;8146.429749917508;8186.017677878634;8188.7133950312045;8205.466644668077;8218.178182181793;7920.762377128695;8097.392695547857;8109.107998120202;8123.7156699515235;8133.227343402367;42159.7892010538;42453.787731061144;42546.57453425457;42604.78697606492;42845;3703.833327500242;3728.3475391806596;3736.813159342022;3748.0817199785956;3749.268892565951;33828.32343353144;33954.660453395394;33961.32077358464;33998.1500462488;34004.6599534004;5558.305211848519;5576.079946808772;5593.608447408683;5595.412481689405;5611.046122159243;213001;213580;213777;213808;263302;52365;53028;53128.73435632874;53168;53426.46573534215;57807;58286;58288.12567811486;58358;58391;14219.075760075562;14332.283385830668;14458.27708614565;14469.710605788036;14492.492762753252;10964.780704386027;10977.451127443595;11046.834297485544;11057.11543076552;11071.778564428667;15620.531384058497;15783.210839457981;15789;15803.920980395254;15817.525474235792;6032.185654936615;6035.547333949971;6073.726682299307;6174.876502469925;6286.339934306832;1083.9729006774735;1085.3921803789904;1092.5411327242577;1096.4188979840696;1099.7305660113323;23688.289351319487;24187.032518699056;24383.268501944614;24433.755662443502;24500.877495612407;1152.8328392383225;1166.6150170443734;1176.505867535637;1177.5850034898863;1195.9880401195876;13123.737525249442;13190;13193.802092968614;13275.468981240641;13300.201987880759;283327;284260;287638;287696;288189;58844;59365.10952335718;59733.70133149307;60006.99999999913;60152.39847601556;1467.6551010512308;1472.904261223017;1485.2796393749022;1499.137995652504;1534.0642208252957;23493.412664682837;23679.64480532828;23700;23769.286921392384;23891.641625375287;41752.3737143937;41870.58129418789;41888.58111418847;41912.790436047624;41917;233068;233611;235345;235840;235973;33813;34261.657383425845;36217;37276.25447491089;37822.865314040624;46538.76730616325;46917.765411172724;47114.52885471102;47313;47979.5202047989;33843.66156338405;34000.14999625029;34484.310313794085;34557.308853823284;34797.30405391929;33616.663833362334;33951.320973580885;33988;34045.14887127842;34650.30699385948;35798;35841.28317433689;35991.64008359883;36071.81964090163;36102;32975;33001.349932502795;33072.66927330696;33352.33295334031;33393.165170870925;23432.882835586395;23699.289021329387;23769.881150594138;23875.08999280088;24504.754952450246 16:44:00 INFO - PID 8597 | |2;jquery.html;577.509117250337;592.6325678079588;597.1371368372697;611.8715069835334;620.3796203796204;22961.540769184605;23841.76158238417;23960.281191564238;24010.639840402408;24020.63969040466;24168.75831241687;25743.0989915353;25928.96284148632;26093.73906260937;26105;6345.968270158654;6542.1495205623205;6543.803685889431;6546;6568.343165683441;6369.394907483782;6459.869522833509;6560.442362399202;6602.570832895846;6616.27221005689;6523.575967562093;6555.278919318871;6556.246031706343;6559.4424473919535;6560.507961902877;6253.6873156342;6552.639604821733;6556.344365563429;6572.80281591553;6583.736650533973;6121.204243448323;6126.142340072393;6140.815775526697;6169.691515424211;6182.041783523561;29417.264568385748;30081.69918300811;30086.69913300861;30107.397852042835;30119.397612047636;2295.988520057406;2315.8842057897205;2316.5714342846627;2317.2121478697322;2318.408805754522;19967.201311947505;20376.592468150702;20479.89760051205;20669.276575319793;20682.68975965362;2310.4570425949887;2358.1157066100213;2359.539889721505;2368.3723813189517;2427.6965379327585;133805;140583;146739;146746;153729;15465.304061317043;15501.534953951399;16228.350865965465;16269.918650406673;16439.424620138238;25411.745882540938;25432.74567254304;25521.234362969142;25532.872335638574;25583.232503024938;9757.219422446187;9853.408795472295;9925.652602159034;9927.751806204902;9950.950245248727;8655.394122411497;8692.391532592785;8741;8805.459044667157;8865.867011994826;9462.952685236529;9588.856167157499;9664.487233319387;9672.661456848977;9750.414975101517;2897.492938735713;2926.4000879819587;2929.062699936;2952.719491648333;2953.3354995125924;1022.7238645565656;1034.6585626743156;1039.7036844499282;1041.193075366597;1053.3100818963592;20190.697139542917;20331.18675253003;20406.897965510077;20425.591488170154;20651;1068.423051552153;1070.2347821307803;1075.5160177919968;1077.5689724110418;1090.7218659241842;11337.603183888525;11379.260348077349;11509.309441433374;11580.88419115815;11638.1271404645;563353;582186;594794;595702;598952;131047;136114;136400.31799840936;137338;140032.29983850016;1073.173656284672;1131.1742428027585;1167.6847251242118;1189.7620475904853;1196.8085106382937;21326.36020919375;21902.123915043856;21973.450663733536;22056.11775529025;22059.889700551394;61494.69252653708;63213;63292.68353658202;64403.67798161167;65939;82890;83461.58269208614;83666;84419.57790211009;84588.57705711432;15468.690626187637;15836.445724399591;15846.683066338379;15938.442154524537;15984.120873352078;24992.750072499042;25219.36951576152;25408.87295563584;25542.10602628899;25553.872230638728;18606.81393186051;18856.905715471334;19075.141618626916;19257.8074219256;19415.902920485307;17802.109894505484;17852.285908563514;17945.282188712306;18237.635247294715;18580.163892624594;18628.627427451105;19178.657493975286;19332;19479.22083116716;19545.804541954967;15481.303341349441;15529.534113976148;15650.373985040926;15683.921580392025;15689.921550392175;18568.907155464138;18943.33698320552;19081.236750529824;19102.235910563977;19151.904240479267 16:44:00 INFO - PID 8597 | |3;mootools.html;1418.1136789506559;1508.766141248107;1509.9245037748124;1520.5134357005757;1521.7032678627668;15795.84204157958;16337.26482308296;16369.508914732547;16385.918070409647;16409.589760256;15925.681486370295;16025.599360016005;16053.314401987798;16059.116748578823;16072.678546429093;2676.050002249203;2692.151972128778;2727.5499542575453;2729.931751706203;2731.4537092581463;2604.8567328796908;2649.377396311865;2653.4162484253434;2654.707982121965;2663.800214983884;2645.193216069098;2699.284689557269;2702.1758363699064;2711.227300219438;2714.4299697063543;2670.7329267073137;2673.7459941305547;2688.610151528037;2690.8520031398266;2694.380292532709;2551.6810398700163;2583.276682528895;2607.647967524379;2617.973820261811;2669.54617714987;16342.918285408616;16494.587635309093;16496.25766840495;16500.83499165017;16501.0924399158;7936.6031698414845;8215.09633940266;8218.876716849252;8223.588820559007;8223.671053157866;5217.643412712684;5445.019896418643;5449.891002179934;5481.588880833953;5497.752601132918;1960.3828888433957;2016.6915732875227;2026.3211824038965;2047.3857842647146;2083.9791602083938;29445.11664650064;29550.999999999785;29562.70437295621;29661.258468538243;29694.851525742448;6365.427111559889;6492.740290388426;6639.800805975829;6646.6676666166495;6654.500912431587;19174.13716382766;19216.903915480332;19223.711644325347;19250.71123933142;19260.229590816492;7563;7764.13807575277;7768.728094516665;7772.300492955661;7773.183815699384;6682.264950855402;7113.253108423644;7169.533980291264;7317.341439270384;7321.74373896911;5254.710990895537;5459.863503412367;5502.5597952163735;5531.723413829292;5535.33575970878;1516.226724370579;1521.186165401505;1524.1769444500067;1529.5487831089856;1544.4208421841809;907.9546022698838;915.3821170709745;929.4934260827865;931.2084727981297;937.4281688170211;7927.841443171104;7940.880886786703;7998.880016799752;8015.278624923668;8667;729.5586170366958;754.3022703998779;754.3701009656997;765.9272369124924;774.9612519374122;4888.437829649564;4949.604031677529;4975.975120124449;5066.797328106834;5530.529904958124;23922.162724304566;24018.87990560071;24313;24555.26334209941;24959.12643057484;24023.159189428286;24318.39204019878;24582.508349832904;24609.63085553718;24713.752862471505;11626;11954.581589644495;11962.162648614687;11970.521179152911;12007.399630018464;8190.221928916743;8292.958535207285;8397.412181147261;8409.411341206056;8423.410361274651;20125.295614653416;20493.59012819765;20650.070746816127;20746;20900.68648970297;21557.78442215558;21565.568688626452;21815.563688726455;21902.23342183016;21944.45138871541;12049.879501204876;12136.33250171249;12367;12371.814422783485;12385.690357741129;14896.106233626017;14971.326290316743;15017.399304027716;15063;15179;12264.141510094209;12436.875631243573;12493.687657808627;12503.937480312905;12554.246745195318;11839.1712580122;12128.272303661808;12365.567205147776;12373;12512.124151309321;9711.611535538499;9816.607335706492;9878.950605246928;9887.901120988698;9893.25800564946;7445.9627701861145;7523.435742319239;7591.924080759121;7618.8095297618;7633.2366763323225;7207.71169153228;7241.637918103968;7294.854102918018;7403.666834992546;7428.368588670023 16:44:00 INFO - PID 8597 | |4;prototype.html;540.3164996279706;550.7466565379926;570.3298624116662;577.4658440942128;579.9768009279626;6340.556161068727;6351.079093531435;6353.205849268841;6357.23713154421;6401.167848179742;6167.167432396636;6200.534959878016;6217.62694238346;6232.439080482755;6283.8114856554375;5045.369328833895;5117.744112794355;5126.871828204306;5129.435762066169;5130.486951304877;4838.806447742086;5077.3907131144315;5086.516780905827;5102.107131252034;5117.257997590347;4969.826056088038;4983.16296451732;4995.450500444948;5012.774425150858;5021.522955319257;4984.177610694231;5021.096202683516;5031.6729412588065;5034.119029169918;5076.654686508042;4430.556944305576;4490.663200259994;4539.841105561322;4551.203539380628;4558.908821823545;6180.536459765535;6188.319284878659;6197.101420294077;6211.47202487789;6212;5825.1844741736195;5838;5841.211436456109;5857.794977175821;5887.499562537189;6587.143671322745;6638.236602790645;6640.966795166041;6649.401553860127;6710.261871194165;4802.807887684488;5040.697558146487;5044.192929131358;5060.2156665716875;5062.797488100471;6715.496337774686;6823.965880170567;6825.1809782825885;6904.447644188504;6911.75808846688;5075.467075956972;5110.105731497048;5129.820456284012;5133.332666753298;5140.691558506502;5183.688978661217;5190.11767999441;5204.479552044765;5208.609354298443;5229.816956406507;5761.164631128463;5813.360530341659;5818.5345172386105;5820.796272130539;5821.417858214145;6591.670416479157;6607.603543787388;6632.6352050636715;6646.540779911367;6663.267040625527;1789.454216463965;1802.6935420978466;1802.756627855249;1808.97286540702;1823.4073925974112;1208.0003970420403;1231.8090695942144;1257.5158563952943;1261.4954018392532;1272.4146892429585;6102.420270074336;6113;6116;6125.234345706786;6179.443850053517;6716.630585317855;6730.802868637358;6732;6732.528722989344;6734.360235777691;5952.565338822518;6014.969925150346;6050.152978583002;6051.57638965277;6146.569740118149;3393.6945674888884;3498.737594680409;3535.5227044348685;3573.8213089345427;3587.7084249670097;6867.690953907087;6970.198427180838;7004.964975175091;7032.12098487689;7041.683124259421;6746.190457145174;6834.6582670866255;6866.965665171642;6901.62041087735;6902;6864.38220560152;6934.965325173342;6938.375546200866;6971.895421568681;7000.654780648438;6626.304238054935;6701.195856497056;6706.865862682816;6779.220389655253;6807.829804254735;6667.966660166668;6676.9666151668935;6681.231658359351;6784.76253331131;6792.524523283323;6956.165260168812;6956.5478243913985;7052.188998265266;7091.468139889632;7096.929030709627;5081.110805609078;5083.771230294572;5136.717480538457;5136.8202112925865;5166.715830629351;6575;6620.735170593122;6653.301403352772;6759.594424334556;6777.89833152513;6324.565042458595;6339.207599050119;6467.450266727381;6479.574493611398;6520.152380190545;6410.358964103552;6474.902876456763;6487.156669632917;6540.168752749238;6573;6490.318516555693;6563.442107420923;6565.638889861103;6571.901421478778;6586.868262634816;6540.247871494839;6567.802965911031;6650.600963942179;6653.9667301663185;6676.9332306676315;6389.265234497906;6401.967990160019;6410.358964103739;6417.48660107181;6474.643894585843 16:44:00 INFO - PID 8597 | |5;yui.html;865.870119482078;880.2078129683284;880.5465185429505;981.2003217377837;1017.6617747661824;19663;20259.59480810383;20479.795202047975;20498;20544.794552054474;18477.722834157466;18530.166142523583;18613;19034.524136896584;19209.23163073479;1032.8192566300904;1073.3506228731621;1073.4632683658172;1074.1782536359692;1075.156002538008;1042.4579218806216;1078.6009176604666;1085.7502774361901;1087.662824524396;1090.4166271044992;1074.0977578833779;1075.3440401355167;1075.763332066948;1075.833245846895;1132.9293817342614;1072.0351683484887;1072.2762135558505;1072.4798472740715;1084.0677017764715;1131.2081542919948;805.5046146619845;808.4138999225573;816.6202715737152;818.0265484073933;818.643889907886;20564.383068507817;20606.690899636516;20659.483512912146;20746;20800.16799328025;22557.887210564008;23013;23096.076156953703;23286.76713232863;23364.883175584015;18310;18421.35525256623;18567.72148417775;18578.256869725195;18628.068596570254;3946.171304026158;3950.3876899080688;3967.841286348543;3973.324534829086;3976.0258736609426;144051;144359;144797;145425.27287363601;149287;17387.217575209146;17710;17896.105194740212;17917;17926.5518362042;31983.680163198536;32557.51163732546;32733.181670457954;32787.3442531148;32914.67085329164;8471.534065626449;8613.569321533898;8711.956440217758;8719.869201961976;8751.124887511325;4435.578620031157;4478.686491945533;4504.61710754583;4506.932396014063;4539.523350048264;6050.848728781815;6589.703463344161;6682.732690692318;6713.630750308682;6717.1267735194115;1187.9168458207841;1193.7075416523007;1205.391277404905;1208.2508844516456;1216.8053111502118;730.8099894027484;751.0686748431905;754.4944886925773;765.3379826450081;778.9961050194713;13564.593062208149;13763.862361376257;14136.222507761966;14690.853091468949;14759.262036898112;729.5075823818901;739.3567596191241;749.7863109013905;752.751591974647;759.2673070487007;6469.644169570624;6532.738690452424;6620.073189753439;6634.270230274666;6715.932840671629;149715;152535;153953;154460.22769886078;158033;133115.33442332727;133188;133825;134534;136741;114832.42583787028;116153;116706;117589.99999999828;119059;12411.875881241433;12436.253824770543;12473.87526124727;12498.43757030954;12578.245305281347;56562.15156772734;56894.7155264221;57195.71402142962;57471;59622;73399.63300183465;73666;74643;75842;77191.61404192942;16650.58373540671;16808.915955420143;17167.31330746756;17440;17470.825291746918;17818;18477.72283415723;18517;18560.443186704422;18569.25722971066;16655.91672041632;16786.992780433215;16953.91523042377;17205.139743012547;17274.13629318554;16587.17064146812;16678.332866685196;16722.33110675608;16904.492865214062;16975.236114374635;17873.553161171076;18037.729434058238;18058.548536286697;18154.364597239033;18302.81697183011;13327;13445.126066805626;13648.93175534116;13724.45102195901;13798.379072941541;13414;13506;13583.660408489472;13600.863991360355;13655.86344136546 16:44:00 INFO - PID 8597 | __end_tp_report 16:44:00 INFO - PID 8597 | __start_cc_report 16:44:00 INFO - PID 8597 | _x_x_mozilla_cycle_collect,257 16:44:00 INFO - PID 8597 | __end_cc_report 16:44:00 INFO - PID 8597 | __startTimestamp1505778240604__endTimestamp 16:44:00 INFO - PID 8597 | 16:44:00 INFO - PID 8597 | ------- Summary: start ------- 16:44:00 INFO - PID 8597 | Number of tests: 6 16:44:00 INFO - PID 8597 | 16:44:00 INFO - PID 8597 | [#0] dojo.html Cycles:165 Average:6279.42 Median:6534.64 stddev:749.01 (11.5%) stddev-sans-first:727.17 16:44:00 INFO - PID 8597 | Values: 3875.2 3891.6 3896.3 3909.0 3920.3 6162.2 6238.2 6301.1 6301.6 6388.4 6264.0 6275.7 6298.9 6331.5 6365.1 5633.9 5637.1 5650.8 5652.1 5689.3 5660.9 5676.6 5707.7 5715.8 5736.6 5665.2 5667.1 5706.8 5726.4 5753.4 5593.4 5676.2 5696.1 5750.5 5759.1 5072.3 5510.0 5553.9 5564.7 5595.0 6234.9 6293.2 6311.6 6324.1 6375.0 6775.7 6780.3 6781.4 6888.1 6890.3 6818.4 6888.9 6890.3 6896.1 6897.3 6307.0 6350.1 6384.5 6388.3 6393.0 6964.1 6966.7 6988.3 7088.5 7105.4 6559.3 6645.1 6647.7 6659.0 6839.9 6670.0 6765.0 6776.1 6777.4 6781.4 6817.3 6841.9 6843.7 6854.1 6858.6 6793.7 6795.0 6804.6 6888.9 6892.2 4880.1 4948.8 4957.7 5012.1 5012.6 4538.5 4581.9 4585.9 4600.0 4612.9 6038.5 6251.7 6253.2 6333.2 6348.4 6873.1 6882.3 6899.5 6903.1 6908.9 6196.8 6213.6 6262.8 6295.6 6311.3 5500.8 5505.4 5564.4 5568.8 5570.9 7106.6 7131.3 7135.4 7148.6 7189.0 6730.3 6790.1 6801.8 6819.7 6894.4 7045.6 7121.1 7197.3 7205.8 7256.5 6593.6 6716.2 6722.0 6731.4 6831.2 6829.8 6832.7 6843.1 6850.4 6858.3 6516.7 6577.7 6673.2 6677.8 6681.0 6519.3 6558.5 6560.6 6564.1 6571.3 6531.6 6586.9 6596.0 6597.6 6610.4 6558.1 6638.5 6654.3 6742.1 6758.4 6367.1 6404.4 6416.6 6450.6 6534.6 16:44:00 INFO - PID 8597 | 16:44:00 INFO - PID 8597 | [#1] ext.html Cycles:180 Average:42431.52 Median:36086.91 stddev:65166.56 (180.6%) stddev-sans-first:65274.69 16:44:00 INFO - PID 8597 | Values: 881.8 911.1 931.1 958.3 966.2 44206.8 44792.0 45104.3 45132.0 45230.1 42608.8 43213.0 43242.1 43270.8 43382.0 7251.1 7311.0 7342.3 7366.0 7371.5 7279.2 7327.2 7348.5 7371.9 7377.9 7354.1 7979.6 8182.2 8206.0 8210.5 8146.4 8186.0 8188.7 8205.5 8218.2 7920.8 8097.4 8109.1 8123.7 8133.2 42159.8 42453.8 42546.6 42604.8 42845.0 3703.8 3728.3 3736.8 3748.1 3749.3 33828.3 33954.7 33961.3 33998.2 34004.7 5558.3 5576.1 5593.6 5595.4 5611.0 213001.0 213580.0 213777.0 213808.0 263302.0 52365.0 53028.0 53128.7 53168.0 53426.5 57807.0 58286.0 58288.1 58358.0 58391.0 14219.1 14332.3 14458.3 14469.7 14492.5 10964.8 10977.5 11046.8 11057.1 11071.8 15620.5 15783.2 15789.0 15803.9 15817.5 6032.2 6035.5 6073.7 6174.9 6286.3 1084.0 1085.4 1092.5 1096.4 1099.7 23688.3 24187.0 24383.3 24433.8 24500.9 1152.8 1166.6 1176.5 1177.6 1196.0 13123.7 13190.0 13193.8 13275.5 13300.2 283327.0 284260.0 287638.0 287696.0 288189.0 58844.0 59365.1 59733.7 60007.0 60152.4 1467.7 1472.9 1485.3 1499.1 1534.1 23493.4 23679.6 23700.0 23769.3 23891.6 41752.4 41870.6 41888.6 41912.8 41917.0 233068.0 233611.0 235345.0 235840.0 235973.0 33813.0 34261.7 36217.0 37276.3 37822.9 46538.8 46917.8 47114.5 47313.0 47979.5 33843.7 34000.1 34484.3 34557.3 34797.3 33616.7 33951.3 33988.0 34045.1 34650.3 35798.0 35841.3 35991.6 36071.8 36102.0 32975.0 33001.3 33072.7 33352.3 33393.2 23432.9 23699.3 23769.9 23875.1 24504.8 16:44:00 INFO - PID 8597 | 16:44:00 INFO - PID 8597 | [#2] jquery.html Cycles:180 Average:39278.88 Median:23901.02 stddev:98483.91 (412.0%) stddev-sans-first:98717.31 16:44:00 INFO - PID 8597 | Values: 577.5 592.6 597.1 611.9 620.4 22961.5 23841.8 23960.3 24010.6 24020.6 24168.8 25743.1 25929.0 26093.7 26105.0 6346.0 6542.1 6543.8 6546.0 6568.3 6369.4 6459.9 6560.4 6602.6 6616.3 6523.6 6555.3 6556.2 6559.4 6560.5 6253.7 6552.6 6556.3 6572.8 6583.7 6121.2 6126.1 6140.8 6169.7 6182.0 29417.3 30081.7 30086.7 30107.4 30119.4 2296.0 2315.9 2316.6 2317.2 2318.4 19967.2 20376.6 20479.9 20669.3 20682.7 2310.5 2358.1 2359.5 2368.4 2427.7 133805.0 140583.0 146739.0 146746.0 153729.0 15465.3 15501.5 16228.4 16269.9 16439.4 25411.7 25432.7 25521.2 25532.9 25583.2 9757.2 9853.4 9925.7 9927.8 9951.0 8655.4 8692.4 8741.0 8805.5 8865.9 9463.0 9588.9 9664.5 9672.7 9750.4 2897.5 2926.4 2929.1 2952.7 2953.3 1022.7 1034.7 1039.7 1041.2 1053.3 20190.7 20331.2 20406.9 20425.6 20651.0 1068.4 1070.2 1075.5 1077.6 1090.7 11337.6 11379.3 11509.3 11580.9 11638.1 563353.0 582186.0 594794.0 595702.0 598952.0 131047.0 136114.0 136400.3 137338.0 140032.3 1073.2 1131.2 1167.7 1189.8 1196.8 21326.4 21902.1 21973.5 22056.1 22059.9 61494.7 63213.0 63292.7 64403.7 65939.0 82890.0 83461.6 83666.0 84419.6 84588.6 15468.7 15836.4 15846.7 15938.4 15984.1 24992.8 25219.4 25408.9 25542.1 25553.9 18606.8 18856.9 19075.1 19257.8 19415.9 17802.1 17852.3 17945.3 18237.6 18580.2 18628.6 19178.7 19332.0 19479.2 19545.8 15481.3 15529.5 15650.4 15683.9 15689.9 18568.9 18943.3 19081.2 19102.2 19151.9 16:44:00 INFO - PID 8597 | 16:44:00 INFO - PID 8597 | [#3] mootools.html Cycles:180 Average:9982.23 Median:2670.14 stddev:7576.46 (283.7%) stddev-sans-first:7570.40 16:44:00 INFO - PID 8597 | Values: 1418.1 1508.8 1509.9 1520.5 1521.7 15795.8 16337.3 16369.5 16385.9 16409.6 15925.7 16025.6 16053.3 16059.1 16072.7 2676.1 2692.2 2727.5 2729.9 2731.5 2604.9 2649.4 2653.4 2654.7 2663.8 2645.2 2699.3 2702.2 2711.2 2714.4 2670.7 2673.7 2688.6 2690.9 2694.4 2551.7 2583.3 2607.6 2618.0 2669.5 16342.9 16494.6 16496.3 16500.8 16501.1 7936.6 8215.1 8218.9 8223.6 8223.7 5217.6 5445.0 5449.9 5481.6 5497.8 1960.4 2016.7 2026.3 2047.4 2084.0 29445.1 29551.0 29562.7 29661.3 29694.9 6365.4 6492.7 6639.8 6646.7 6654.5 19174.1 19216.9 19223.7 19250.7 19260.2 7563.0 7764.1 7768.7 7772.3 7773.2 6682.3 7113.3 7169.5 7317.3 7321.7 5254.7 5459.9 5502.6 5531.7 5535.3 1516.2 1521.2 1524.2 1529.5 1544.4 908.0 915.4 929.5 931.2 937.4 7927.8 7940.9 7998.9 8015.3 8667.0 729.6 754.3 754.4 765.9 775.0 4888.4 4949.6 4976.0 5066.8 5530.5 23922.2 24018.9 24313.0 24555.3 24959.1 24023.2 24318.4 24582.5 24609.6 24713.8 11626.0 11954.6 11962.2 11970.5 12007.4 8190.2 8293.0 8397.4 8409.4 8423.4 20125.3 20493.6 20650.1 20746.0 20900.7 21557.8 21565.6 21815.6 21902.2 21944.5 12049.9 12136.3 12367.0 12371.8 12385.7 14896.1 14971.3 15017.4 15063.0 15179.0 12264.1 12436.9 12493.7 12503.9 12554.2 11839.2 12128.3 12365.6 12373.0 12512.1 9711.6 9816.6 9879.0 9887.9 9893.3 7446.0 7523.4 7591.9 7618.8 7633.2 7207.7 7241.6 7294.9 7403.7 7428.4 16:44:00 INFO - PID 8597 | 16:44:00 INFO - PID 8597 | [#4] prototype.html Cycles:180 Average:5615.61 Median:6211.74 stddev:1572.22 (25.3%) stddev-sans-first:1529.78 16:44:00 INFO - PID 8597 | Values: 540.3 550.7 570.3 577.5 580.0 6340.6 6351.1 6353.2 6357.2 6401.2 6167.2 6200.5 6217.6 6232.4 6283.8 5045.4 5117.7 5126.9 5129.4 5130.5 4838.8 5077.4 5086.5 5102.1 5117.3 4969.8 4983.2 4995.5 5012.8 5021.5 4984.2 5021.1 5031.7 5034.1 5076.7 4430.6 4490.7 4539.8 4551.2 4558.9 6180.5 6188.3 6197.1 6211.5 6212.0 5825.2 5838.0 5841.2 5857.8 5887.5 6587.1 6638.2 6641.0 6649.4 6710.3 4802.8 5040.7 5044.2 5060.2 5062.8 6715.5 6824.0 6825.2 6904.4 6911.8 5075.5 5110.1 5129.8 5133.3 5140.7 5183.7 5190.1 5204.5 5208.6 5229.8 5761.2 5813.4 5818.5 5820.8 5821.4 6591.7 6607.6 6632.6 6646.5 6663.3 1789.5 1802.7 1802.8 1809.0 1823.4 1208.0 1231.8 1257.5 1261.5 1272.4 6102.4 6113.0 6116.0 6125.2 6179.4 6716.6 6730.8 6732.0 6732.5 6734.4 5952.6 6015.0 6050.2 6051.6 6146.6 3393.7 3498.7 3535.5 3573.8 3587.7 6867.7 6970.2 7005.0 7032.1 7041.7 6746.2 6834.7 6867.0 6901.6 6902.0 6864.4 6935.0 6938.4 6971.9 7000.7 6626.3 6701.2 6706.9 6779.2 6807.8 6668.0 6677.0 6681.2 6784.8 6792.5 6956.2 6956.5 7052.2 7091.5 7096.9 5081.1 5083.8 5136.7 5136.8 5166.7 6575.0 6620.7 6653.3 6759.6 6777.9 6324.6 6339.2 6467.5 6479.6 6520.2 6410.4 6474.9 6487.2 6540.2 6573.0 6490.3 6563.4 6565.6 6571.9 6586.9 6540.2 6567.8 6650.6 6654.0 6676.9 6389.3 6402.0 6410.4 6417.5 6474.6 16:44:00 INFO - PID 8597 | 16:44:00 INFO - PID 8597 | [#5] yui.html Cycles:180 Average:28188.38 Median:18228.59 stddev:41871.51 (229.7%) stddev-sans-first:41938.71 16:44:00 INFO - PID 8597 | Values: 865.9 880.2 880.5 981.2 1017.7 19663.0 20259.6 20479.8 20498.0 20544.8 18477.7 18530.2 18613.0 19034.5 19209.2 1032.8 1073.4 1073.5 1074.2 1075.2 1042.5 1078.6 1085.8 1087.7 1090.4 1074.1 1075.3 1075.8 1075.8 1132.9 1072.0 1072.3 1072.5 1084.1 1131.2 805.5 808.4 816.6 818.0 818.6 20564.4 20606.7 20659.5 20746.0 20800.2 22557.9 23013.0 23096.1 23286.8 23364.9 18310.0 18421.4 18567.7 18578.3 18628.1 3946.2 3950.4 3967.8 3973.3 3976.0 144051.0 144359.0 144797.0 145425.3 149287.0 17387.2 17710.0 17896.1 17917.0 17926.6 31983.7 32557.5 32733.2 32787.3 32914.7 8471.5 8613.6 8712.0 8719.9 8751.1 4435.6 4478.7 4504.6 4506.9 4539.5 6050.8 6589.7 6682.7 6713.6 6717.1 1187.9 1193.7 1205.4 1208.3 1216.8 730.8 751.1 754.5 765.3 779.0 13564.6 13763.9 14136.2 14690.9 14759.3 729.5 739.4 749.8 752.8 759.3 6469.6 6532.7 6620.1 6634.3 6715.9 149715.0 152535.0 153953.0 154460.2 158033.0 133115.3 133188.0 133825.0 134534.0 136741.0 114832.4 116153.0 116706.0 117590.0 119059.0 12411.9 12436.3 12473.9 12498.4 12578.2 56562.2 56894.7 57195.7 57471.0 59622.0 73399.6 73666.0 74643.0 75842.0 77191.6 16650.6 16808.9 17167.3 17440.0 17470.8 17818.0 18477.7 18517.0 18560.4 18569.3 16655.9 16787.0 16953.9 17205.1 17274.1 16587.2 16678.3 16722.3 16904.5 16975.2 17873.6 18037.7 18058.5 18154.4 18302.8 13327.0 13445.1 13648.9 13724.5 13798.4 13414.0 13506.0 13583.7 13600.9 13655.9 16:44:00 INFO - PID 8597 | -------- Summary: end -------- 16:44:00 INFO - PID 8597 | 16:44:01 INFO - TEST-INFO | 8597: exit 0 16:44:01 INFO - TEST-OK | dromaeo_css | took 1108913ms 16:44:01 INFO - TEST-START | kraken 16:44:01 INFO - Initialising browser for kraken test... 16:44:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43314/getInfo.html -profile /tmp/tmpu7zc3q/profile 16:44:01 INFO - TEST-INFO | started process 8964 (/builds/slave/test/build/application/firefox/firefox http://localhost:43314/getInfo.html) 16:44:06 INFO - TEST-INFO | 8964: exit 0 16:44:06 INFO - Browser initialized. 16:44:06 INFO - Running cycle 1/1 for kraken test... 16:44:06 INFO - Using env: {'DISPLAY': ':0', 16:44:06 INFO - 'HOME': '/home/cltbld', 16:44:06 INFO - 'JSGC_DISABLE_POISONING': '1', 16:44:06 INFO - 'LANG': 'en_US.UTF-8', 16:44:06 INFO - 'LANGUAGE': 'en_US:en', 16:44:06 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 16:44:06 INFO - 'LOGNAME': 'cltbld', 16:44:06 INFO - 'MAIL': '/var/mail/cltbld', 16:44:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:44:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:44:06 INFO - 'MOZ_CRASHREPORTER': '1', 16:44:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:06 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 16:44:06 INFO - 'MOZ_NO_REMOTE': '1', 16:44:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:44:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:06 INFO - 'NO_EM_RESTART': '1', 16:44:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:06 INFO - 'PWD': '/builds/slave/test', 16:44:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:44:06 INFO - 'RUST_BACKTRACE': 'full', 16:44:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:44:06 INFO - 'SHELL': '/bin/bash', 16:44:06 INFO - 'SHLVL': '1', 16:44:06 INFO - 'STYLO_FORCE_DISABLED': '1', 16:44:06 INFO - 'TERM': 'linux', 16:44:06 INFO - 'TMOUT': '86400', 16:44:06 INFO - 'USER': 'cltbld', 16:44:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347', 16:44:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:06 INFO - '_': '/tools/buildbot/bin/python'} 16:44:06 INFO - TEST-INFO | started process 9202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu7zc3q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:44:07 INFO - PID 9202 | 16:44:07 INFO - PID 9202 | (/builds/slave/test/build/application/firefox/firefox:9252): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:44:07 INFO - PID 9202 | 16:44:18 INFO - PID 9202 | RSS: Main: 148635648 16:44:18 INFO - PID 9202 | 16:44:20 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43314/tests/kraken/driver.html?testName=audio-beat-detection) 16:44:21 INFO - PID 9202 | RSS: Main: 153612288 16:44:21 INFO - PID 9202 | 16:44:24 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43314/tests/kraken/driver.html?testName=audio-dft) 16:44:24 INFO - PID 9202 | RSS: Main: 153997312 16:44:24 INFO - PID 9202 | 16:44:27 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43314/tests/kraken/driver.html?testName=audio-fft) 16:44:28 INFO - PID 9202 | RSS: Main: 149995520 16:44:28 INFO - PID 9202 | 16:44:30 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43314/tests/kraken/driver.html?testName=audio-oscillator) 16:44:30 INFO - PID 9202 | RSS: Main: 150978560 16:44:30 INFO - PID 9202 | 16:44:32 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43314/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:44:33 INFO - PID 9202 | RSS: Main: 151011328 16:44:33 INFO - PID 9202 | 16:44:36 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43314/tests/kraken/driver.html?testName=imaging-darkroom) 16:44:37 INFO - PID 9202 | RSS: Main: 151175168 16:44:37 INFO - PID 9202 | 16:44:40 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43314/tests/kraken/driver.html?testName=imaging-desaturate) 16:44:41 INFO - PID 9202 | RSS: Main: 152645632 16:44:41 INFO - PID 9202 | 16:44:44 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43314/tests/kraken/driver.html?testName=json-parse-financial) 16:44:44 INFO - PID 9202 | RSS: Main: 154017792 16:44:44 INFO - PID 9202 | 16:44:46 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43314/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:44:47 INFO - PID 9202 | RSS: Main: 153837568 16:44:47 INFO - PID 9202 | 16:44:48 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43314/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:44:49 INFO - PID 9202 | RSS: Main: 153620480 16:44:49 INFO - PID 9202 | 16:44:51 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43314/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:44:51 INFO - PID 9202 | RSS: Main: 150728704 16:44:51 INFO - PID 9202 | 16:44:54 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:44:54 INFO - PID 9202 | RSS: Main: 150847488 16:44:54 INFO - PID 9202 | 16:44:57 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:44:58 INFO - PID 9202 | RSS: Main: 151412736 16:44:58 INFO - PID 9202 | 16:44:59 INFO - PID 9202 | Cycle 1(1): loaded http://localhost:43314/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43314/tests/kraken/driver.html?testName=ai-astar) 16:45:00 INFO - PID 9202 | RSS: Main: 153034752 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | __start_tp_report 16:45:00 INFO - PID 9202 | _x_x_mozilla_page_load 16:45:00 INFO - PID 9202 | _x_x_mozilla_page_load_details 16:45:00 INFO - PID 9202 | |i|pagename|runs| 16:45:00 INFO - PID 9202 | |0;ai-astar;105;106;104;106;106;108;109;108;106;108 16:45:00 INFO - PID 9202 | |1;audio-beat-detection;116;112;113;115;135;114;124;112;113;114 16:45:00 INFO - PID 9202 | |2;audio-dft;162;164;163;162;162;165;162;163;163;163 16:45:00 INFO - PID 9202 | |3;audio-fft;73;72;73;77;76;73;73;76;75;74 16:45:00 INFO - PID 9202 | |4;audio-oscillator;84;79;80;82;82;78;79;78;78;82 16:45:00 INFO - PID 9202 | |5;imaging-gaussian-blur;113;114;110;113;113;114;113;116;113;115 16:45:00 INFO - PID 9202 | |6;imaging-darkroom;160;150;150;150;151;152;150;149;152;150 16:45:00 INFO - PID 9202 | |7;imaging-desaturate;94;94;95;94;94;95;95;94;94;95 16:45:00 INFO - PID 9202 | |8;json-parse-financial;45;46;47;43;44;45;45;45;48;49 16:45:00 INFO - PID 9202 | |9;json-stringify-tinderbox;38;38;38;38;38;39;38;38;38;37 16:45:00 INFO - PID 9202 | |10;stanford-crypto-aes;75;72;71;75;76;70;77;71;75;72 16:45:00 INFO - PID 9202 | |11;stanford-crypto-ccm;113;103;113;110;106;109;106;111;105;114 16:45:00 INFO - PID 9202 | |12;stanford-crypto-pbkdf2;157;160;152;160;158;150;152;153;153;151 16:45:00 INFO - PID 9202 | |13;stanford-crypto-sha256-iterative;61;56;59;59;61;61;69;61;66;60 16:45:00 INFO - PID 9202 | __end_tp_report 16:45:00 INFO - PID 9202 | __start_cc_report 16:45:00 INFO - PID 9202 | _x_x_mozilla_cycle_collect,755 16:45:00 INFO - PID 9202 | __end_cc_report 16:45:00 INFO - PID 9202 | __startTimestamp1505778300196__endTimestamp 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | ------- Summary: start ------- 16:45:00 INFO - PID 9202 | Number of tests: 14 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#0] ai-astar Cycles:10 Average:106.60 Median:107.00 stddev:1.58 (1.5%) stddev-sans-first:1.56 16:45:00 INFO - PID 9202 | Values: 105.0 106.0 104.0 106.0 106.0 108.0 109.0 108.0 106.0 108.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#1] audio-beat-detection Cycles:10 Average:116.80 Median:114.50 stddev:7.28 (6.4%) stddev-sans-first:7.72 16:45:00 INFO - PID 9202 | Values: 116.0 112.0 113.0 115.0 135.0 114.0 124.0 112.0 113.0 114.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:0.99 (0.6%) stddev-sans-first:1.00 16:45:00 INFO - PID 9202 | Values: 162.0 164.0 163.0 162.0 162.0 165.0 162.0 163.0 163.0 163.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#3] audio-fft Cycles:10 Average:74.20 Median:74.50 stddev:1.69 (2.3%) stddev-sans-first:1.73 16:45:00 INFO - PID 9202 | Values: 73.0 72.0 73.0 77.0 76.0 73.0 73.0 76.0 75.0 74.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#4] audio-oscillator Cycles:10 Average:80.20 Median:81.00 stddev:2.15 (2.7%) stddev-sans-first:1.79 16:45:00 INFO - PID 9202 | Values: 84.0 79.0 80.0 82.0 82.0 78.0 79.0 78.0 78.0 82.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:1.58 (1.4%) stddev-sans-first:1.67 16:45:00 INFO - PID 9202 | Values: 113.0 114.0 110.0 113.0 113.0 114.0 113.0 116.0 113.0 115.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:150.50 stddev:3.17 (2.1%) stddev-sans-first:1.01 16:45:00 INFO - PID 9202 | Values: 160.0 150.0 150.0 150.0 151.0 152.0 150.0 149.0 152.0 150.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:45:00 INFO - PID 9202 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 94.0 95.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#8] json-parse-financial Cycles:10 Average:45.70 Median:45.50 stddev:1.83 (4.0%) stddev-sans-first:1.92 16:45:00 INFO - PID 9202 | Values: 45.0 46.0 47.0 43.0 44.0 45.0 45.0 45.0 48.0 49.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.47 (1.2%) stddev-sans-first:0.50 16:45:00 INFO - PID 9202 | Values: 38.0 38.0 38.0 38.0 38.0 39.0 38.0 38.0 38.0 37.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#10] stanford-crypto-aes Cycles:10 Average:73.40 Median:75.00 stddev:2.46 (3.3%) stddev-sans-first:2.54 16:45:00 INFO - PID 9202 | Values: 75.0 72.0 71.0 75.0 76.0 70.0 77.0 71.0 75.0 72.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#11] stanford-crypto-ccm Cycles:10 Average:109.00 Median:110.50 stddev:3.83 (3.5%) stddev-sans-first:3.78 16:45:00 INFO - PID 9202 | Values: 113.0 103.0 113.0 110.0 106.0 109.0 106.0 111.0 105.0 114.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:155.00 stddev:3.78 (2.4%) stddev-sans-first:3.91 16:45:00 INFO - PID 9202 | Values: 157.0 160.0 152.0 160.0 158.0 150.0 152.0 153.0 153.0 151.0 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.00 stddev:3.68 (6.0%) stddev-sans-first:3.91 16:45:00 INFO - PID 9202 | Values: 61.0 56.0 59.0 59.0 61.0 61.0 69.0 61.0 66.0 60.0 16:45:00 INFO - PID 9202 | -------- Summary: end -------- 16:45:00 INFO - PID 9202 | 16:45:00 INFO - PID 9202 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:45:00 INFO - TEST-INFO | 9202: exit 0 16:45:00 INFO - TEST-OK | kraken | took 59664ms 16:45:00 INFO - SUITE-END | took 1168s 16:45:01 INFO - Completed test suite (00:19:28) 16:45:01 INFO - javascript benchmark 16:45:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s", "stylo_disabled"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8921.718428767714, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3875.1862108957116, 3891.630295121963, 3896.337622604157, 3909.0, 3920.313945059614, 6162.198914141155, 6238.157848690436, 6301.086342480337, 6301.621902685836, 6388.3611638836155, 6264.029075493295, 6275.717592708339, 6298.905516417246, 6331.493480521559, 6365.108884756138, 5633.915491267614, 5637.098064309711, 5650.773969041234, 5652.09566469365, 5689.345725241588, 5660.858478538028, 5676.602637815355, 5707.65754054756, 5715.771369145229, 5736.627119237257, 5665.206871038058, 5667.121596152603, 5706.828795136132, 5726.398728133528, 5753.367129615739, 5593.356763972155, 5676.205331253628, 5696.060150075233, 5750.539956803445, 5759.078547432412, 5072.264521644378, 5510.008198524264, 5553.944460555384, 5564.721763911829, 5594.9720251398885, 6234.906476402857, 6293.181886354791, 6311.6213027218055, 6324.051392291147, 6375.043743438475, 6775.695093720795, 6780.321967803229, 6781.389674929231, 6888.070110535064, 6890.31096890312, 6818.386345228953, 6888.862222755517, 6890.31096890312, 6896.137982752156, 6897.3447522485285, 6306.9999999999545, 6350.110984462179, 6384.48924086072, 6388.265349484822, 6393.0, 6964.094667693269, 6966.651667416609, 6988.301169883072, 7088.503804733722, 7105.431565474853, 6559.344065593498, 6645.06969024337, 6647.700853461606, 6659.034440006172, 6839.897401538981, 6670.0, 6764.966175169191, 6776.085228494188, 6777.423918966844, 6781.389674929182, 6817.284185160586, 6841.931580684229, 6843.692033858489, 6854.143232095988, 6858.588484690835, 6793.728250870009, 6795.0, 6804.55770374924, 6888.931110688829, 6892.207396149407, 4880.145974454527, 4948.752562371867, 4957.677750946249, 5012.122878496249, 5012.573931215888, 4538.455385353779, 4581.94615238497, 4585.862424127282, 4600.033992861537, 4612.884677883079, 6038.456538911519, 6251.6561589113035, 6253.249610046732, 6333.240011198685, 6348.396902294275, 6873.140857392826, 6882.346177113166, 6899.517033807686, 6903.1371078615175, 6908.9309106909295, 6196.81409557714, 6213.565050446516, 6262.843428914313, 6295.622262664255, 6311.274203466568, 5500.779968801283, 5505.394406615269, 5564.415736347706, 5568.777248910079, 5570.944290557042, 7106.5736055836815, 7131.322524360177, 7135.357817796424, 7148.642567871586, 7189.0294810201, 6730.259671436236, 6790.117284753148, 6801.829954251183, 6819.727210911508, 6894.379505844498, 7045.647717614202, 7121.145462544528, 7197.280271972761, 7205.7838264852135, 7256.455765817479, 6593.604383736991, 6716.194056713226, 6721.966390168018, 6731.360520750717, 6831.248562658005, 6829.795106146824, 6832.658367081725, 6843.076184715, 6850.417714494324, 6858.348456896587, 6516.674166291761, 6577.736890524326, 6673.232578253563, 6677.766278180435, 6681.0, 6519.315471875574, 6558.540902136805, 6560.573562718408, 6564.081028655896, 6571.277159512545, 6531.608103513804, 6586.901196482152, 6596.0, 6597.60414375139, 6610.4050635443045, 6558.081868538504, 6638.468922486286, 6654.334566543307, 6742.056112144402, 6758.357955994173, 6367.140436041261, 6404.423601875854, 6416.550841441241, 6450.612963222222, 6534.640594767334], "value": 6228.7017194428945, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [881.8265159121665, 911.1116661255281, 931.1014870649822, 958.3339578992603, 966.1932286540738, 44206.77896610521, 44792.0, 45104.32343514846, 45132.0, 45230.09539809206, 42608.786956065174, 43213.0, 43242.135157296834, 43270.78364608173, 43382.0, 7251.093613298351, 7311.0, 7342.302481264272, 7365.968764372992, 7371.483996120273, 7279.162896266917, 7327.157376901671, 7348.485606007582, 7371.852562948738, 7377.926220737778, 7354.117505899299, 7979.601019948979, 8182.18178182183, 8206.0, 8210.548419836907, 8146.429749917508, 8186.017677878634, 8188.7133950312045, 8205.466644668077, 8218.178182181793, 7920.762377128695, 8097.392695547857, 8109.107998120202, 8123.7156699515235, 8133.227343402367, 42159.7892010538, 42453.787731061144, 42546.57453425457, 42604.78697606492, 42845.0, 3703.833327500242, 3728.3475391806596, 3736.813159342022, 3748.0817199785956, 3749.268892565951, 33828.32343353144, 33954.660453395394, 33961.32077358464, 33998.1500462488, 34004.6599534004, 5558.305211848519, 5576.079946808772, 5593.608447408683, 5595.412481689405, 5611.046122159243, 213001.0, 213580.0, 213777.0, 213808.0, 263302.0, 52365.0, 53028.0, 53128.73435632874, 53168.0, 53426.46573534215, 57807.0, 58286.0, 58288.12567811486, 58358.0, 58391.0, 14219.075760075562, 14332.283385830668, 14458.27708614565, 14469.710605788036, 14492.492762753252, 10964.780704386027, 10977.451127443595, 11046.834297485544, 11057.11543076552, 11071.778564428667, 15620.531384058497, 15783.210839457981, 15789.0, 15803.920980395254, 15817.525474235792, 6032.185654936615, 6035.547333949971, 6073.726682299307, 6174.876502469925, 6286.339934306832, 1083.9729006774735, 1085.3921803789904, 1092.5411327242577, 1096.4188979840696, 1099.7305660113323, 23688.289351319487, 24187.032518699056, 24383.268501944614, 24433.755662443502, 24500.877495612407, 1152.8328392383225, 1166.6150170443734, 1176.505867535637, 1177.5850034898863, 1195.9880401195876, 13123.737525249442, 13190.0, 13193.802092968614, 13275.468981240641, 13300.201987880759, 283327.0, 284260.0, 287638.0, 287696.0, 288189.0, 58844.0, 59365.10952335718, 59733.70133149307, 60006.99999999913, 60152.39847601556, 1467.6551010512308, 1472.904261223017, 1485.2796393749022, 1499.137995652504, 1534.0642208252957, 23493.412664682837, 23679.64480532828, 23700.0, 23769.286921392384, 23891.641625375287, 41752.3737143937, 41870.58129418789, 41888.58111418847, 41912.790436047624, 41917.0, 233068.0, 233611.0, 235345.0, 235840.0, 235973.0, 33813.0, 34261.657383425845, 36217.0, 37276.25447491089, 37822.865314040624, 46538.76730616325, 46917.765411172724, 47114.52885471102, 47313.0, 47979.5202047989, 33843.66156338405, 34000.14999625029, 34484.310313794085, 34557.308853823284, 34797.30405391929, 33616.663833362334, 33951.320973580885, 33988.0, 34045.14887127842, 34650.30699385948, 35798.0, 35841.28317433689, 35991.64008359883, 36071.81964090163, 36102.0, 32975.0, 33001.349932502795, 33072.66927330696, 33352.33295334031, 33393.165170870925, 23432.882835586395, 23699.289021329387, 23769.881150594138, 23875.08999280088, 24504.754952450246], "value": 18185.418443587812, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.509117250337, 592.6325678079588, 597.1371368372697, 611.8715069835334, 620.3796203796204, 22961.540769184605, 23841.76158238417, 23960.281191564238, 24010.639840402408, 24020.63969040466, 24168.75831241687, 25743.0989915353, 25928.96284148632, 26093.73906260937, 26105.0, 6345.968270158654, 6542.1495205623205, 6543.803685889431, 6546.0, 6568.343165683441, 6369.394907483782, 6459.869522833509, 6560.442362399202, 6602.570832895846, 6616.27221005689, 6523.575967562093, 6555.278919318871, 6556.246031706343, 6559.4424473919535, 6560.507961902877, 6253.6873156342, 6552.639604821733, 6556.344365563429, 6572.80281591553, 6583.736650533973, 6121.204243448323, 6126.142340072393, 6140.815775526697, 6169.691515424211, 6182.041783523561, 29417.264568385748, 30081.69918300811, 30086.69913300861, 30107.397852042835, 30119.397612047636, 2295.988520057406, 2315.8842057897205, 2316.5714342846627, 2317.2121478697322, 2318.408805754522, 19967.201311947505, 20376.592468150702, 20479.89760051205, 20669.276575319793, 20682.68975965362, 2310.4570425949887, 2358.1157066100213, 2359.539889721505, 2368.3723813189517, 2427.6965379327585, 133805.0, 140583.0, 146739.0, 146746.0, 153729.0, 15465.304061317043, 15501.534953951399, 16228.350865965465, 16269.918650406673, 16439.424620138238, 25411.745882540938, 25432.74567254304, 25521.234362969142, 25532.872335638574, 25583.232503024938, 9757.219422446187, 9853.408795472295, 9925.652602159034, 9927.751806204902, 9950.950245248727, 8655.394122411497, 8692.391532592785, 8741.0, 8805.459044667157, 8865.867011994826, 9462.952685236529, 9588.856167157499, 9664.487233319387, 9672.661456848977, 9750.414975101517, 2897.492938735713, 2926.4000879819587, 2929.062699936, 2952.719491648333, 2953.3354995125924, 1022.7238645565656, 1034.6585626743156, 1039.7036844499282, 1041.193075366597, 1053.3100818963592, 20190.697139542917, 20331.18675253003, 20406.897965510077, 20425.591488170154, 20651.0, 1068.423051552153, 1070.2347821307803, 1075.5160177919968, 1077.5689724110418, 1090.7218659241842, 11337.603183888525, 11379.260348077349, 11509.309441433374, 11580.88419115815, 11638.1271404645, 563353.0, 582186.0, 594794.0, 595702.0, 598952.0, 131047.0, 136114.0, 136400.31799840936, 137338.0, 140032.29983850016, 1073.173656284672, 1131.1742428027585, 1167.6847251242118, 1189.7620475904853, 1196.8085106382937, 21326.36020919375, 21902.123915043856, 21973.450663733536, 22056.11775529025, 22059.889700551394, 61494.69252653708, 63213.0, 63292.68353658202, 64403.67798161167, 65939.0, 82890.0, 83461.58269208614, 83666.0, 84419.57790211009, 84588.57705711432, 15468.690626187637, 15836.445724399591, 15846.683066338379, 15938.442154524537, 15984.120873352078, 24992.750072499042, 25219.36951576152, 25408.87295563584, 25542.10602628899, 25553.872230638728, 18606.81393186051, 18856.905715471334, 19075.141618626916, 19257.8074219256, 19415.902920485307, 17802.109894505484, 17852.285908563514, 17945.282188712306, 18237.635247294715, 18580.163892624594, 18628.627427451105, 19178.657493975286, 19332.0, 19479.22083116716, 19545.804541954967, 15481.303341349441, 15529.534113976148, 15650.373985040926, 15683.921580392025, 15689.921550392175, 18568.907155464138, 18943.33698320552, 19081.236750529824, 19102.235910563977, 19151.904240479267], "value": 12619.147235332895, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.1136789506559, 1508.766141248107, 1509.9245037748124, 1520.5134357005757, 1521.7032678627668, 15795.84204157958, 16337.26482308296, 16369.508914732547, 16385.918070409647, 16409.589760256, 15925.681486370295, 16025.599360016005, 16053.314401987798, 16059.116748578823, 16072.678546429093, 2676.050002249203, 2692.151972128778, 2727.5499542575453, 2729.931751706203, 2731.4537092581463, 2604.8567328796908, 2649.377396311865, 2653.4162484253434, 2654.707982121965, 2663.800214983884, 2645.193216069098, 2699.284689557269, 2702.1758363699064, 2711.227300219438, 2714.4299697063543, 2670.7329267073137, 2673.7459941305547, 2688.610151528037, 2690.8520031398266, 2694.380292532709, 2551.6810398700163, 2583.276682528895, 2607.647967524379, 2617.973820261811, 2669.54617714987, 16342.918285408616, 16494.587635309093, 16496.25766840495, 16500.83499165017, 16501.0924399158, 7936.6031698414845, 8215.09633940266, 8218.876716849252, 8223.588820559007, 8223.671053157866, 5217.643412712684, 5445.019896418643, 5449.891002179934, 5481.588880833953, 5497.752601132918, 1960.3828888433957, 2016.6915732875227, 2026.3211824038965, 2047.3857842647146, 2083.9791602083938, 29445.11664650064, 29550.999999999785, 29562.70437295621, 29661.258468538243, 29694.851525742448, 6365.427111559889, 6492.740290388426, 6639.800805975829, 6646.6676666166495, 6654.500912431587, 19174.13716382766, 19216.903915480332, 19223.711644325347, 19250.71123933142, 19260.229590816492, 7563.0, 7764.13807575277, 7768.728094516665, 7772.300492955661, 7773.183815699384, 6682.264950855402, 7113.253108423644, 7169.533980291264, 7317.341439270384, 7321.74373896911, 5254.710990895537, 5459.863503412367, 5502.5597952163735, 5531.723413829292, 5535.33575970878, 1516.226724370579, 1521.186165401505, 1524.1769444500067, 1529.5487831089856, 1544.4208421841809, 907.9546022698838, 915.3821170709745, 929.4934260827865, 931.2084727981297, 937.4281688170211, 7927.841443171104, 7940.880886786703, 7998.880016799752, 8015.278624923668, 8667.0, 729.5586170366958, 754.3022703998779, 754.3701009656997, 765.9272369124924, 774.9612519374122, 4888.437829649564, 4949.604031677529, 4975.975120124449, 5066.797328106834, 5530.529904958124, 23922.162724304566, 24018.87990560071, 24313.0, 24555.26334209941, 24959.12643057484, 24023.159189428286, 24318.39204019878, 24582.508349832904, 24609.63085553718, 24713.752862471505, 11626.0, 11954.581589644495, 11962.162648614687, 11970.521179152911, 12007.399630018464, 8190.221928916743, 8292.958535207285, 8397.412181147261, 8409.411341206056, 8423.410361274651, 20125.295614653416, 20493.59012819765, 20650.070746816127, 20746.0, 20900.68648970297, 21557.78442215558, 21565.568688626452, 21815.563688726455, 21902.23342183016, 21944.45138871541, 12049.879501204876, 12136.33250171249, 12367.0, 12371.814422783485, 12385.690357741129, 14896.106233626017, 14971.326290316743, 15017.399304027716, 15063.0, 15179.0, 12264.141510094209, 12436.875631243573, 12493.687657808627, 12503.937480312905, 12554.246745195318, 11839.1712580122, 12128.272303661808, 12365.567205147776, 12373.0, 12512.124151309321, 9711.611535538499, 9816.607335706492, 9878.950605246928, 9887.901120988698, 9893.25800564946, 7445.9627701861145, 7523.435742319239, 7591.924080759121, 7618.8095297618, 7633.2366763323225, 7207.71169153228, 7241.637918103968, 7294.854102918018, 7403.666834992546, 7428.368588670023], "value": 6897.174878198291, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.3164996279706, 550.7466565379926, 570.3298624116662, 577.4658440942128, 579.9768009279626, 6340.556161068727, 6351.079093531435, 6353.205849268841, 6357.23713154421, 6401.167848179742, 6167.167432396636, 6200.534959878016, 6217.62694238346, 6232.439080482755, 6283.8114856554375, 5045.369328833895, 5117.744112794355, 5126.871828204306, 5129.435762066169, 5130.486951304877, 4838.806447742086, 5077.3907131144315, 5086.516780905827, 5102.107131252034, 5117.257997590347, 4969.826056088038, 4983.16296451732, 4995.450500444948, 5012.774425150858, 5021.522955319257, 4984.177610694231, 5021.096202683516, 5031.6729412588065, 5034.119029169918, 5076.654686508042, 4430.556944305576, 4490.663200259994, 4539.841105561322, 4551.203539380628, 4558.908821823545, 6180.536459765535, 6188.319284878659, 6197.101420294077, 6211.47202487789, 6212.0, 5825.1844741736195, 5838.0, 5841.211436456109, 5857.794977175821, 5887.499562537189, 6587.143671322745, 6638.236602790645, 6640.966795166041, 6649.401553860127, 6710.261871194165, 4802.807887684488, 5040.697558146487, 5044.192929131358, 5060.2156665716875, 5062.797488100471, 6715.496337774686, 6823.965880170567, 6825.1809782825885, 6904.447644188504, 6911.75808846688, 5075.467075956972, 5110.105731497048, 5129.820456284012, 5133.332666753298, 5140.691558506502, 5183.688978661217, 5190.11767999441, 5204.479552044765, 5208.609354298443, 5229.816956406507, 5761.164631128463, 5813.360530341659, 5818.5345172386105, 5820.796272130539, 5821.417858214145, 6591.670416479157, 6607.603543787388, 6632.6352050636715, 6646.540779911367, 6663.267040625527, 1789.454216463965, 1802.6935420978466, 1802.756627855249, 1808.97286540702, 1823.4073925974112, 1208.0003970420403, 1231.8090695942144, 1257.5158563952943, 1261.4954018392532, 1272.4146892429585, 6102.420270074336, 6113.0, 6116.0, 6125.234345706786, 6179.443850053517, 6716.630585317855, 6730.802868637358, 6732.0, 6732.528722989344, 6734.360235777691, 5952.565338822518, 6014.969925150346, 6050.152978583002, 6051.57638965277, 6146.569740118149, 3393.6945674888884, 3498.737594680409, 3535.5227044348685, 3573.8213089345427, 3587.7084249670097, 6867.690953907087, 6970.198427180838, 7004.964975175091, 7032.12098487689, 7041.683124259421, 6746.190457145174, 6834.6582670866255, 6866.965665171642, 6901.62041087735, 6902.0, 6864.38220560152, 6934.965325173342, 6938.375546200866, 6971.895421568681, 7000.654780648438, 6626.304238054935, 6701.195856497056, 6706.865862682816, 6779.220389655253, 6807.829804254735, 6667.966660166668, 6676.9666151668935, 6681.231658359351, 6784.76253331131, 6792.524523283323, 6956.165260168812, 6956.5478243913985, 7052.188998265266, 7091.468139889632, 7096.929030709627, 5081.110805609078, 5083.771230294572, 5136.717480538457, 5136.8202112925865, 5166.715830629351, 6575.0, 6620.735170593122, 6653.301403352772, 6759.594424334556, 6777.89833152513, 6324.565042458595, 6339.207599050119, 6467.450266727381, 6479.574493611398, 6520.152380190545, 6410.358964103552, 6474.902876456763, 6487.156669632917, 6540.168752749238, 6573.0, 6490.318516555693, 6563.442107420923, 6565.638889861103, 6571.901421478778, 6586.868262634816, 6540.247871494839, 6567.802965911031, 6650.600963942179, 6653.9667301663185, 6676.9332306676315, 6389.265234497906, 6401.967990160019, 6410.358964103739, 6417.48660107181, 6474.643894585843], "value": 5161.358987155565, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [865.870119482078, 880.2078129683284, 880.5465185429505, 981.2003217377837, 1017.6617747661824, 19663.0, 20259.59480810383, 20479.795202047975, 20498.0, 20544.794552054474, 18477.722834157466, 18530.166142523583, 18613.0, 19034.524136896584, 19209.23163073479, 1032.8192566300904, 1073.3506228731621, 1073.4632683658172, 1074.1782536359692, 1075.156002538008, 1042.4579218806216, 1078.6009176604666, 1085.7502774361901, 1087.662824524396, 1090.4166271044992, 1074.0977578833779, 1075.3440401355167, 1075.763332066948, 1075.833245846895, 1132.9293817342614, 1072.0351683484887, 1072.2762135558505, 1072.4798472740715, 1084.0677017764715, 1131.2081542919948, 805.5046146619845, 808.4138999225573, 816.6202715737152, 818.0265484073933, 818.643889907886, 20564.383068507817, 20606.690899636516, 20659.483512912146, 20746.0, 20800.16799328025, 22557.887210564008, 23013.0, 23096.076156953703, 23286.76713232863, 23364.883175584015, 18310.0, 18421.35525256623, 18567.72148417775, 18578.256869725195, 18628.068596570254, 3946.171304026158, 3950.3876899080688, 3967.841286348543, 3973.324534829086, 3976.0258736609426, 144051.0, 144359.0, 144797.0, 145425.27287363601, 149287.0, 17387.217575209146, 17710.0, 17896.105194740212, 17917.0, 17926.5518362042, 31983.680163198536, 32557.51163732546, 32733.181670457954, 32787.3442531148, 32914.67085329164, 8471.534065626449, 8613.569321533898, 8711.956440217758, 8719.869201961976, 8751.124887511325, 4435.578620031157, 4478.686491945533, 4504.61710754583, 4506.932396014063, 4539.523350048264, 6050.848728781815, 6589.703463344161, 6682.732690692318, 6713.630750308682, 6717.1267735194115, 1187.9168458207841, 1193.7075416523007, 1205.391277404905, 1208.2508844516456, 1216.8053111502118, 730.8099894027484, 751.0686748431905, 754.4944886925773, 765.3379826450081, 778.9961050194713, 13564.593062208149, 13763.862361376257, 14136.222507761966, 14690.853091468949, 14759.262036898112, 729.5075823818901, 739.3567596191241, 749.7863109013905, 752.751591974647, 759.2673070487007, 6469.644169570624, 6532.738690452424, 6620.073189753439, 6634.270230274666, 6715.932840671629, 149715.0, 152535.0, 153953.0, 154460.22769886078, 158033.0, 133115.33442332727, 133188.0, 133825.0, 134534.0, 136741.0, 114832.42583787028, 116153.0, 116706.0, 117589.99999999828, 119059.0, 12411.875881241433, 12436.253824770543, 12473.87526124727, 12498.43757030954, 12578.245305281347, 56562.15156772734, 56894.7155264221, 57195.71402142962, 57471.0, 59622.0, 73399.63300183465, 73666.0, 74643.0, 75842.0, 77191.61404192942, 16650.58373540671, 16808.915955420143, 17167.31330746756, 17440.0, 17470.825291746918, 17818.0, 18477.72283415723, 18517.0, 18560.443186704422, 18569.25722971066, 16655.91672041632, 16786.992780433215, 16953.91523042377, 17205.139743012547, 17274.13629318554, 16587.17064146812, 16678.332866685196, 16722.33110675608, 16904.492865214062, 16975.236114374635, 17873.553161171076, 18037.729434058238, 18058.548536286697, 18154.364597239033, 18302.81697183011, 13327.0, 13445.126066805626, 13648.93175534116, 13724.45102195901, 13798.379072941541, 13414.0, 13506.0, 13583.660408489472, 13600.863991360355, 13655.86344136546], "value": 9910.100361570187, "unit": "score"}]}, {"extraOptions": ["e10s", "stylo_disabled"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1381.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 106.0, 104.0, 106.0, 106.0, 108.0, 109.0, 108.0, 106.0, 108.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 113.0, 115.0, 135.0, 114.0, 124.0, 112.0, 113.0, 114.0], "value": 116.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 163.0, 162.0, 162.0, 165.0, 162.0, 163.0, 163.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 73.0, 77.0, 76.0, 73.0, 73.0, 76.0, 75.0, 74.0], "value": 74.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 79.0, 80.0, 82.0, 82.0, 78.0, 79.0, 78.0, 78.0, 82.0], "value": 80.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 110.0, 113.0, 113.0, 114.0, 113.0, 116.0, 113.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 150.0, 150.0, 150.0, 151.0, 152.0, 150.0, 149.0, 152.0, 150.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 47.0, 43.0, 44.0, 45.0, 45.0, 45.0, 48.0, 49.0], "value": 45.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 39.0, 38.0, 38.0, 38.0, 37.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 71.0, 75.0, 76.0, 70.0, 77.0, 71.0, 75.0, 72.0], "value": 73.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 103.0, 113.0, 110.0, 106.0, 109.0, 106.0, 111.0, 105.0, 114.0], "value": 109.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 152.0, 160.0, 158.0, 150.0, 152.0, 153.0, 153.0, 151.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 56.0, 59.0, 59.0, 61.0, 61.0, 69.0, 61.0, 66.0, 60.0], "value": 61.3, "unit": "score"}]}]} 16:45:01 INFO - Return code: 0 16:45:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:45:01 INFO - # TBPL SUCCESS # 16:45:01 INFO - Running post-action listener: _package_coverage_data 16:45:01 INFO - Running post-action listener: _resource_record_post_action 16:45:01 INFO - [mozharness: 2017-09-18 23:45:01.468788Z] Finished run-tests step (success) 16:45:01 INFO - Running post-run listener: _resource_record_post_run 16:45:01 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 331362304; Read time: 0; Write time: 291188 16:45:01 INFO - TinderboxPrint: CPU usage
13.1% 16:45:01 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:45:01 INFO - TinderboxPrint: I/O write bytes / time
331,362,304 / 291,188 16:45:01 INFO - TinderboxPrint: CPU idle
8,227.2 (86.9%) 16:45:01 INFO - TinderboxPrint: CPU user
1,185.4 (12.5%) 16:45:01 INFO - TinderboxPrint: Swap in / out
0 / 0 16:45:01 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13045760; Read time: 0; Write time: 2204 16:45:01 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:45:01 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 0; Write bytes: 317747200; Read time: 0; Write time: 288872 16:45:02 INFO - Running post-run listener: _upload_blobber_files 16:45:02 INFO - Blob upload gear active. 16:45:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:45:02 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 16:45:02 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'] 16:45:02 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 16:45:02 INFO - (blobuploader) - INFO - Open directory for files ... 16:45:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:45:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:45:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:03 INFO - (blobuploader) - INFO - Done attempting. 16:45:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_raw.log ... 16:45:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_raw.log: uploaded 16:45:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:04 INFO - (blobuploader) - INFO - Done attempting. 16:45:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-stylo-disabled-e10s_errorsummary.log ... 16:45:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-stylo-disabled-e10s_errorsummary.log: uploaded 16:45:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:06 INFO - (blobuploader) - INFO - Done attempting. 16:45:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:45:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:45:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:45:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:45:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:45:13 INFO - (blobuploader) - INFO - Done attempting. 16:45:13 INFO - (blobuploader) - INFO - Iteration through files over. 16:45:13 INFO - Return code: 0 16:45:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:45:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:45:13 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d94ffecc62f738239687c5f2f5f663a39a7d54ab12484451183d78182a030cc41b075fa1bb2a5f819aaacb372ff8d1658bf49a38d5caa17ac02cacf5d035f7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71a539a0d53c611a96d7a95d1711a1c65fb1a1721c018382ac1b7d6d1111cf5f567e6378ce8f88b42b5d831c3b022e742cdf458f9ca1a9b9fdd21e5d8bf4bbe7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c434ccff82a46bbfe2b4782703f85b40f9e648e9c359a150b68790a0708ae4d41e1b365686335a86b4dffcca8d8ee5e8b124ee40ff9d1c1ecc50db927ef9491", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d617bedc96e048502ee1abc8d149af3fda5840c031dc7436d73e0e3502e0d7a5b3fa98a3132df832cdc49757010ed1adc02e193ed3ae9c18a7a5593c7111e181"} 16:45:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:45:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:45:13 INFO - Contents: 16:45:13 INFO - blobber_files:{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d94ffecc62f738239687c5f2f5f663a39a7d54ab12484451183d78182a030cc41b075fa1bb2a5f819aaacb372ff8d1658bf49a38d5caa17ac02cacf5d035f7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71a539a0d53c611a96d7a95d1711a1c65fb1a1721c018382ac1b7d6d1111cf5f567e6378ce8f88b42b5d831c3b022e742cdf458f9ca1a9b9fdd21e5d8bf4bbe7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c434ccff82a46bbfe2b4782703f85b40f9e648e9c359a150b68790a0708ae4d41e1b365686335a86b4dffcca8d8ee5e8b124ee40ff9d1c1ecc50db927ef9491", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d617bedc96e048502ee1abc8d149af3fda5840c031dc7436d73e0e3502e0d7a5b3fa98a3132df832cdc49757010ed1adc02e193ed3ae9c18a7a5593c7111e181"} 16:45:13 INFO - Running post-run listener: copy_logs_to_upload_dir 16:45:13 INFO - Copying logs to upload dir... 16:45:13 INFO - mkdir: /builds/slave/test/build/upload/logs 16:45:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.590555 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-09-18 16:45:13.425551) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 16:45:13.429735) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347 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/a7d94ffecc62f738239687c5f2f5f663a39a7d54ab12484451183d78182a030cc41b075fa1bb2a5f819aaacb372ff8d1658bf49a38d5caa17ac02cacf5d035f7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71a539a0d53c611a96d7a95d1711a1c65fb1a1721c018382ac1b7d6d1111cf5f567e6378ce8f88b42b5d831c3b022e742cdf458f9ca1a9b9fdd21e5d8bf4bbe7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c434ccff82a46bbfe2b4782703f85b40f9e648e9c359a150b68790a0708ae4d41e1b365686335a86b4dffcca8d8ee5e8b124ee40ff9d1c1ecc50db927ef9491", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d617bedc96e048502ee1abc8d149af3fda5840c031dc7436d73e0e3502e0d7a5b3fa98a3132df832cdc49757010ed1adc02e193ed3ae9c18a7a5593c7111e181"} build_url:https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/UqTWGDHrQViBxHcj81BZMg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a7d94ffecc62f738239687c5f2f5f663a39a7d54ab12484451183d78182a030cc41b075fa1bb2a5f819aaacb372ff8d1658bf49a38d5caa17ac02cacf5d035f7", "dromaeojs-stylo-disabled-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/71a539a0d53c611a96d7a95d1711a1c65fb1a1721c018382ac1b7d6d1111cf5f567e6378ce8f88b42b5d831c3b022e742cdf458f9ca1a9b9fdd21e5d8bf4bbe7", "dromaeojs-stylo-disabled-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5c434ccff82a46bbfe2b4782703f85b40f9e648e9c359a150b68790a0708ae4d41e1b365686335a86b4dffcca8d8ee5e8b124ee40ff9d1c1ecc50db927ef9491", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d617bedc96e048502ee1abc8d149af3fda5840c031dc7436d73e0e3502e0d7a5b3fa98a3132df832cdc49757010ed1adc02e193ed3ae9c18a7a5593c7111e181"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-09-18 16:45:13.460404) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:45:13.460714) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1505776214.50960-168291347 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-09-18 16:45:13.543148) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 16:45:13.546480) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-09-18 16:45:13.546795) ========= ========= Total master_lag: 0.35 =========