builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-059 starttime: 1501757957.51 results: success (0) revision: 681a2489f6a92a09f87336c4ebfcd55030ffcda1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 03:59:17.513426) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 03:59:17.513798) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 03:59:17.514065) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 03:59:17.538229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:59:17.538619) ========= 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=3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-03 03:59:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2017-08-03 03:59:17 (102 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106971 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:59:17.658686) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:59:17.658972) ========= 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=3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020866 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 03:59:17.708309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-03 03:59:17.708614) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 681a2489f6a92a09f87336c4ebfcd55030ffcda1 --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 681a2489f6a92a09f87336c4ebfcd55030ffcda1 --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=3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-03 03:59:17,795 truncating revision to first 12 chars 2017-08-03 03:59:17,796 Setting DEBUG logging. 2017-08-03 03:59:17,796 attempt 1/10 2017-08-03 03:59:17,796 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/681a2489f6a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-03 03:59:19,173 unpacking tar archive at: mozilla-central-681a2489f6a9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.780821 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-03 03:59:19.506390) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 03:59:19.507151) ========= script_repo_revision: 681a2489f6a92a09f87336c4ebfcd55030ffcda1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 03:59:19.508068) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 03:59:19.508758) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 03:59:19.521177) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-03 03:59:19.521477) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:19 INFO - MultiFileLogger online at 20170803 03:59:19 in /builds/slave/test 03:59:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:59:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:59:19 INFO - {'append_to_log': False, 03:59:19 INFO - 'base_work_dir': '/builds/slave/test', 03:59:19 INFO - 'blob_upload_branch': 'Firefox', 03:59:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:59:19 INFO - 'branch': 'Firefox', 03:59:19 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:19 INFO - 'code_coverage': False, 03:59:19 INFO - 'config_files': ('talos/linux_config.py',), 03:59:19 INFO - 'default_actions': ('clobber', 03:59:19 INFO - 'read-buildbot-config', 03:59:19 INFO - 'download-and-extract', 03:59:19 INFO - 'populate-webroot', 03:59:19 INFO - 'create-virtualenv', 03:59:19 INFO - 'install', 03:59:19 INFO - 'setup-mitmproxy', 03:59:19 INFO - 'run-tests'), 03:59:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:19 INFO - 'disable_ccov_upload': False, 03:59:19 INFO - 'download_minidump_stackwalk': True, 03:59:19 INFO - 'download_symbols': 'ondemand', 03:59:19 INFO - 'enable_stylo': False, 03:59:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:59:19 INFO - 'tooltool.py': '/tools/tooltool.py', 03:59:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:59:19 INFO - '/tools/misc-python/virtualenv.py')}, 03:59:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:19 INFO - 'gecko_profile': False, 03:59:19 INFO - 'gecko_profile_interval': 0, 03:59:19 INFO - 'installer_path': 'installer.exe', 03:59:19 INFO - 'log_level': 'info', 03:59:19 INFO - 'log_name': 'talos', 03:59:19 INFO - 'log_to_console': True, 03:59:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:19 INFO - 'opt_config_files': (), 03:59:19 INFO - 'pip_index': False, 03:59:19 INFO - 'suite': 'dromaeojs-e10s', 03:59:19 INFO - 'system_bits': '32', 03:59:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:19 INFO - 'title': 'talos-linux64-ix-059', 03:59:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:19 INFO - 'use_talos_json': True, 03:59:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:59:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:19 INFO - 'work_dir': 'build'} 03:59:19 INFO - [mozharness: 2017-08-03 10:59:19.712198Z] Running clobber step. 03:59:19 INFO - Running pre-action listener: _resource_record_pre_action 03:59:19 INFO - Running main action method: clobber 03:59:19 INFO - rmtree: /builds/slave/test/build 03:59:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:59:21 INFO - Running post-action listener: _resource_record_post_action 03:59:21 INFO - [mozharness: 2017-08-03 10:59:21.284428Z] Finished clobber step (success) 03:59:21 INFO - [mozharness: 2017-08-03 10:59:21.284529Z] Running read-buildbot-config step. 03:59:21 INFO - Running pre-action listener: _resource_record_pre_action 03:59:21 INFO - Running main action method: read_buildbot_config 03:59:21 INFO - Using buildbot properties: 03:59:21 INFO - { 03:59:21 INFO - "project": "", 03:59:21 INFO - "product": "firefox", 03:59:21 INFO - "who": "archaeopteryx@coole-files.de", 03:59:21 INFO - "installer_path": "public/build/target.tar.bz2", 03:59:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:59:21 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:59:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:59:21 INFO - "stage_platform": "linux64-pgo", 03:59:21 INFO - "basedir": "/builds/slave/test", 03:59:21 INFO - "buildnumber": 108, 03:59:21 INFO - "platform": "ubuntu64_hw", 03:59:21 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:59:21 INFO - "slavebuilddir": "test", 03:59:21 INFO - "taskId": "GlByfbQxSnOYzhpaF09_aA", 03:59:21 INFO - "branch": "mozilla-central", 03:59:21 INFO - "script_repo_revision": "production", 03:59:21 INFO - "revision": "681a2489f6a92a09f87336c4ebfcd55030ffcda1", 03:59:21 INFO - "slavename": "talos-linux64-ix-059", 03:59:21 INFO - "repo_path": "mozilla-central" 03:59:21 INFO - } 03:59:21 INFO - Finding installer, test and symbols from parent task. 03:59:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GlByfbQxSnOYzhpaF09_aA'}, attempt #1 03:59:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GlByfbQxSnOYzhpaF09_aA'}, attempt #1 03:59:22 INFO - Task dependencies: amWLZQNcQzCE_pLsYcu_6w 03:59:22 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w'}, attempt #1 03:59:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.tar.bz2 03:59:22 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.test_packages.json 03:59:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.crashreporter-symbols.zip 03:59:22 INFO - Running post-action listener: _resource_record_post_action 03:59:22 INFO - [mozharness: 2017-08-03 10:59:22.629990Z] Finished read-buildbot-config step (success) 03:59:22 INFO - [mozharness: 2017-08-03 10:59:22.630301Z] Running download-and-extract step. 03:59:22 INFO - Running pre-action listener: _resource_record_pre_action 03:59:22 INFO - Running main action method: download_and_extract 03:59:22 INFO - mkdir: /builds/slave/test/build/tests 03:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:22 INFO - trying https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.test_packages.json 03:59:22 INFO - Downloading https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:59:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:59:23 INFO - Downloaded 989 bytes. 03:59:23 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:59:23 INFO - Using the following test package requirements: 03:59:23 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:59:23 INFO - u'common': [u'target.common.tests.zip'], 03:59:23 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:59:23 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:59:23 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:59:23 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:59:23 INFO - u'mozbase': [u'target.common.tests.zip'], 03:59:23 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:59:23 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:59:23 INFO - u'web-platform': [u'target.common.tests.zip', 03:59:23 INFO - u'target.web-platform.tests.tar.gz'], 03:59:23 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:59:23 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:59:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.common.tests.zip 03:59:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:59:23 INFO - Fetch https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.common.tests.zip into memory 03:59:24 INFO - Content-Length response header: 54894549 03:59:24 INFO - Bytes received: 54894549 03:59:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:59:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.common.tests.zip 03:59:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:59:35 INFO - Fetch https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.common.tests.zip into memory 03:59:36 INFO - Content-Length response header: 54894549 03:59:36 INFO - Bytes received: 54894549 03:59:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.talos.tests.zip 03:59:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:59:50 INFO - Fetch https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.talos.tests.zip into memory 03:59:50 INFO - Content-Length response header: 14496464 03:59:50 INFO - Bytes received: 14496464 03:59:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:51 INFO - trying https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.tar.bz2 03:59:51 INFO - Downloading https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:59:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:59:52 INFO - Downloaded 63114343 bytes. 03:59:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.tar.bz2 03:59:52 INFO - mkdir: /builds/slave/test/properties 03:59:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:59:52 INFO - Writing to file /builds/slave/test/properties/build_url 03:59:52 INFO - Contents: 03:59:52 INFO - build_url:https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.tar.bz2 03:59:52 INFO - Running post-action listener: _resource_record_post_action 03:59:52 INFO - Running post-action listener: set_extra_try_arguments 03:59:52 INFO - [mozharness: 2017-08-03 10:59:52.263302Z] Finished download-and-extract step (success) 03:59:52 INFO - [mozharness: 2017-08-03 10:59:52.263400Z] Running populate-webroot step. 03:59:52 INFO - Running pre-action listener: _resource_record_pre_action 03:59:52 INFO - Running main action method: populate_webroot 03:59:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:59:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:59:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:59:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:59:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:59:52 INFO - 'tests': ['damp', 'tps']}, 03:59:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:59:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:59:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:59:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:59:52 INFO - 'other-e10s': {'tests': ['a11yr', 03:59:52 INFO - 'ts_paint', 03:59:52 INFO - 'tpaint', 03:59:52 INFO - 'sessionrestore', 03:59:52 INFO - 'sessionrestore_many_windows', 03:59:52 INFO - 'sessionrestore_no_auto_restore', 03:59:52 INFO - 'tabpaint']}, 03:59:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:59:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:59:52 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:59:52 INFO - 'talos_options': ['--mitmproxy', 03:59:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:59:52 INFO - '--firstNonBlankPaint'], 03:59:52 INFO - 'tests': ['quantum_pageload_google', 03:59:52 INFO - 'quantum_pageload_youtube', 03:59:52 INFO - 'quantum_pageload_amazon', 03:59:52 INFO - 'quantum_pageload_facebook']}, 03:59:52 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:59:52 INFO - 'talos_options': ['--stylo', 03:59:52 INFO - '--mitmproxy', 03:59:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:59:52 INFO - '--firstNonBlankPaint'], 03:59:52 INFO - 'tests': ['quantum_pageload_google', 03:59:52 INFO - 'quantum_pageload_youtube', 03:59:52 INFO - 'quantum_pageload_amazon', 03:59:52 INFO - 'quantum_pageload_facebook']}, 03:59:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:59:52 INFO - 'tsvgr_opacity', 03:59:52 INFO - 'tart', 03:59:52 INFO - 'tscrollx', 03:59:52 INFO - 'cart', 03:59:52 INFO - 'tsvg_static']}, 03:59:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:59:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:59:52 INFO - 'talos_options': ['--stylo', 03:59:52 INFO - '--stylo-threads=1', 03:59:52 INFO - '--mitmproxy', 03:59:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:59:52 INFO - '--firstNonBlankPaint'], 03:59:52 INFO - 'tests': ['tp6_google', 03:59:52 INFO - 'tp6_youtube', 03:59:52 INFO - 'tp6_amazon', 03:59:52 INFO - 'tp6_facebook']}, 03:59:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:59:52 INFO - 'talos_options': ['--xperf_path', 03:59:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:59:52 INFO - 'tests': ['tp5n']}}} 03:59:52 INFO - Running post-action listener: _resource_record_post_action 03:59:52 INFO - [mozharness: 2017-08-03 10:59:52.271968Z] Finished populate-webroot step (success) 03:59:52 INFO - [mozharness: 2017-08-03 10:59:52.272059Z] Running create-virtualenv step. 03:59:52 INFO - Running pre-action listener: _resource_record_pre_action 03:59:52 INFO - Running main action method: create_virtualenv 03:59:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:59:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:59:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:59:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:59:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:59:52 INFO - Using real prefix '/usr' 03:59:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:59:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:59:54 INFO - Installing pip.................done. 03:59:54 INFO - Return code: 0 03:59:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:59:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:59:55 INFO - Reading from file tmpfile_stdout 03:59:55 INFO - Output received: 03:59:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:59:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2202a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2eb0>, '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 0x23a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:59:55 INFO - Using env: {'DISPLAY': ':0', 03:59:55 INFO - 'HOME': '/home/cltbld', 03:59:55 INFO - 'LANG': 'en_US.UTF-8', 03:59:55 INFO - 'LANGUAGE': 'en_US:en', 03:59:55 INFO - 'LOGNAME': 'cltbld', 03:59:55 INFO - 'MAIL': '/var/mail/cltbld', 03:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:55 INFO - 'MOZ_NO_REMOTE': '1', 03:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:55 INFO - 'NO_EM_RESTART': '1', 03:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:55 INFO - 'PWD': '/builds/slave/test', 03:59:55 INFO - 'SHELL': '/bin/bash', 03:59:55 INFO - 'SHLVL': '1', 03:59:55 INFO - 'TERM': 'linux', 03:59:55 INFO - 'TMOUT': '86400', 03:59:55 INFO - 'USER': 'cltbld', 03:59:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 03:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:55 INFO - '_': '/tools/buildbot/bin/python'} 03:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:59:55 INFO - Cleaning up... 03:59:55 INFO - Return code: 0 03:59:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2202a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2eb0>, '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 0x23a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:59:55 INFO - Using env: {'DISPLAY': ':0', 03:59:55 INFO - 'HOME': '/home/cltbld', 03:59:55 INFO - 'LANG': 'en_US.UTF-8', 03:59:55 INFO - 'LANGUAGE': 'en_US:en', 03:59:55 INFO - 'LOGNAME': 'cltbld', 03:59:55 INFO - 'MAIL': '/var/mail/cltbld', 03:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:55 INFO - 'MOZ_NO_REMOTE': '1', 03:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:55 INFO - 'NO_EM_RESTART': '1', 03:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:55 INFO - 'PWD': '/builds/slave/test', 03:59:55 INFO - 'SHELL': '/bin/bash', 03:59:55 INFO - 'SHLVL': '1', 03:59:55 INFO - 'TERM': 'linux', 03:59:55 INFO - 'TMOUT': '86400', 03:59:55 INFO - 'USER': 'cltbld', 03:59:55 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 03:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:55 INFO - '_': '/tools/buildbot/bin/python'} 03:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:55 INFO - Downloading/unpacking psutil>=3.1.1 03:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:59:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:56 INFO - Installing collected packages: psutil 03:59:56 INFO - Running setup.py install for psutil 03:59:57 INFO - building 'psutil._psutil_linux' extension 03:59:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:59:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:59:57 INFO - building 'psutil._psutil_posix' extension 03:59:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:59:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:59:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:59:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:59:57 INFO - Successfully installed psutil 03:59:57 INFO - Cleaning up... 03:59:57 INFO - Return code: 0 03:59:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:57 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 0x20361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2202a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2eb0>, '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 0x23a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:59:57 INFO - Using env: {'DISPLAY': ':0', 03:59:57 INFO - 'HOME': '/home/cltbld', 03:59:57 INFO - 'LANG': 'en_US.UTF-8', 03:59:57 INFO - 'LANGUAGE': 'en_US:en', 03:59:57 INFO - 'LOGNAME': 'cltbld', 03:59:57 INFO - 'MAIL': '/var/mail/cltbld', 03:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:57 INFO - 'MOZ_NO_REMOTE': '1', 03:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:57 INFO - 'NO_EM_RESTART': '1', 03:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:57 INFO - 'PWD': '/builds/slave/test', 03:59:57 INFO - 'SHELL': '/bin/bash', 03:59:57 INFO - 'SHLVL': '1', 03:59:57 INFO - 'TERM': 'linux', 03:59:57 INFO - 'TMOUT': '86400', 03:59:57 INFO - 'USER': 'cltbld', 03:59:57 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 03:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:57 INFO - '_': '/tools/buildbot/bin/python'} 03:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:59: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 03:59: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 03:59: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 03:59: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 03:59:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:59:58 INFO - Installing collected packages: mozsystemmonitor 03:59:58 INFO - Running setup.py install for mozsystemmonitor 03:59:58 INFO - Successfully installed mozsystemmonitor 03:59:58 INFO - Cleaning up... 03:59:58 INFO - Return code: 0 03:59:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:59:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2202a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2eb0>, '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 0x23a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:59:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:59:58 INFO - Using env: {'DISPLAY': ':0', 03:59:58 INFO - 'HOME': '/home/cltbld', 03:59:58 INFO - 'LANG': 'en_US.UTF-8', 03:59:58 INFO - 'LANGUAGE': 'en_US:en', 03:59:58 INFO - 'LOGNAME': 'cltbld', 03:59:58 INFO - 'MAIL': '/var/mail/cltbld', 03:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:58 INFO - 'MOZ_NO_REMOTE': '1', 03:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:59:58 INFO - 'NO_EM_RESTART': '1', 03:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:58 INFO - 'PWD': '/builds/slave/test', 03:59:58 INFO - 'SHELL': '/bin/bash', 03:59:58 INFO - 'SHLVL': '1', 03:59:58 INFO - 'TERM': 'linux', 03:59:58 INFO - 'TMOUT': '86400', 03:59:58 INFO - 'USER': 'cltbld', 03:59:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 03:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:58 INFO - '_': '/tools/buildbot/bin/python'} 03:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:59:59 INFO - Downloading/unpacking jsonschema==2.5.1 03:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:59:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:59:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:00:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:00 INFO - Downloading functools32-3.2.3-2.tar.gz 04:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:00:00 INFO - warning: no files found matching '*.txt' 04:00:00 INFO - no previously-included directories found matching 'build' 04:00:00 INFO - no previously-included directories found matching 'dist' 04:00:00 INFO - no previously-included directories found matching '.git*' 04:00:00 INFO - Installing collected packages: jsonschema, functools32 04:00:00 INFO - Running setup.py install for functools32 04:00:00 INFO - warning: no files found matching '*.txt' 04:00:00 INFO - no previously-included directories found matching 'build' 04:00:00 INFO - no previously-included directories found matching 'dist' 04:00:00 INFO - no previously-included directories found matching '.git*' 04:00:00 INFO - Successfully installed jsonschema functools32 04:00:00 INFO - Cleaning up... 04:00:00 INFO - Return code: 0 04:00:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:00:00 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')]} 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:00 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')]} 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:00 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 0x20361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2202a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2eb0>, '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 0x23a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', '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 04:00:00 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 04:00:00 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 04:00:00 INFO - Using env: {'DISPLAY': ':0', 04:00:00 INFO - 'HOME': '/home/cltbld', 04:00:00 INFO - 'LANG': 'en_US.UTF-8', 04:00:00 INFO - 'LANGUAGE': 'en_US:en', 04:00:00 INFO - 'LOGNAME': 'cltbld', 04:00:00 INFO - 'MAIL': '/var/mail/cltbld', 04:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:00 INFO - 'MOZ_NO_REMOTE': '1', 04:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:00 INFO - 'NO_EM_RESTART': '1', 04:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:00 INFO - 'PWD': '/builds/slave/test', 04:00:00 INFO - 'SHELL': '/bin/bash', 04:00:00 INFO - 'SHLVL': '1', 04:00:00 INFO - 'TERM': 'linux', 04:00:00 INFO - 'TMOUT': '86400', 04:00:00 INFO - 'USER': 'cltbld', 04:00:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 04:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:00 INFO - '_': '/tools/buildbot/bin/python'} 04:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:00:00 INFO - Cleaning up... 04:00:00 INFO - Return code: 0 04:00:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:00:00 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')]} 04:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:00 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')]} 04:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:00 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 0x20361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2202a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2eb0>, '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 0x23a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', '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 04:00:00 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 04:00:00 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 04:00:00 INFO - Using env: {'DISPLAY': ':0', 04:00:00 INFO - 'HOME': '/home/cltbld', 04:00:00 INFO - 'LANG': 'en_US.UTF-8', 04:00:00 INFO - 'LANGUAGE': 'en_US:en', 04:00:00 INFO - 'LOGNAME': 'cltbld', 04:00:00 INFO - 'MAIL': '/var/mail/cltbld', 04:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:00 INFO - 'MOZ_NO_REMOTE': '1', 04:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:00 INFO - 'NO_EM_RESTART': '1', 04:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:00 INFO - 'PWD': '/builds/slave/test', 04:00:00 INFO - 'SHELL': '/bin/bash', 04:00:00 INFO - 'SHLVL': '1', 04:00:00 INFO - 'TERM': 'linux', 04:00:00 INFO - 'TMOUT': '86400', 04:00:00 INFO - 'USER': 'cltbld', 04:00:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 04:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:00 INFO - '_': '/tools/buildbot/bin/python'} 04:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:02 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:00:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:02 INFO - Downloading docopt-0.6.1.tar.gz 04:00:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:02 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:02 INFO - Running setup.py install for blobuploader 04:00:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:00:02 INFO - Running setup.py install for requests 04:00:03 INFO - Running setup.py install for docopt 04:00:03 INFO - Successfully installed blobuploader requests docopt 04:00:03 INFO - Cleaning up... 04:00:03 INFO - Return code: 0 04:00:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:03 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')]} 04:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:03 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')]} 04:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:03 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 0x20361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2202a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2eb0>, '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 0x23a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', '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 04:00:03 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 04:00:03 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 04:00:03 INFO - Using env: {'DISPLAY': ':0', 04:00:03 INFO - 'HOME': '/home/cltbld', 04:00:03 INFO - 'LANG': 'en_US.UTF-8', 04:00:03 INFO - 'LANGUAGE': 'en_US:en', 04:00:03 INFO - 'LOGNAME': 'cltbld', 04:00:03 INFO - 'MAIL': '/var/mail/cltbld', 04:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:03 INFO - 'MOZ_NO_REMOTE': '1', 04:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:03 INFO - 'NO_EM_RESTART': '1', 04:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:03 INFO - 'PWD': '/builds/slave/test', 04:00:03 INFO - 'SHELL': '/bin/bash', 04:00:03 INFO - 'SHLVL': '1', 04:00:03 INFO - 'TERM': 'linux', 04:00:03 INFO - 'TMOUT': '86400', 04:00:03 INFO - 'USER': 'cltbld', 04:00:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 04:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:03 INFO - '_': '/tools/buildbot/bin/python'} 04:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:03 INFO - Running setup.py (path:/tmp/pip-BzVynq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:03 INFO - Running setup.py (path:/tmp/pip-OVjrod-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:03 INFO - Running setup.py (path:/tmp/pip-yIfrM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:03 INFO - Running setup.py (path:/tmp/pip-FabzBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:03 INFO - Running setup.py (path:/tmp/pip-GROjm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:03 INFO - Running setup.py (path:/tmp/pip-0HUyou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:04 INFO - Running setup.py (path:/tmp/pip-KqJb5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:04 INFO - Running setup.py (path:/tmp/pip-AiEVeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:04 INFO - Running setup.py (path:/tmp/pip-erxg5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:04 INFO - Running setup.py (path:/tmp/pip-JclSLz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:04 INFO - Running setup.py (path:/tmp/pip-QMyztY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:04 INFO - Running setup.py (path:/tmp/pip-Y0WAYg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:04 INFO - Running setup.py (path:/tmp/pip-wAAZQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:04 INFO - Running setup.py (path:/tmp/pip-D3Rqyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:04 INFO - Running setup.py (path:/tmp/pip-8Wadc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:04 INFO - Running setup.py (path:/tmp/pip-aBJF4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:04 INFO - Running setup.py (path:/tmp/pip-VVhSBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:04 INFO - Running setup.py install for manifestparser 04:00:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:00:04 INFO - Running setup.py install for mozcrash 04:00:05 INFO - Running setup.py install for mozdebug 04:00:05 INFO - Running setup.py install for mozdevice 04:00:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:00:05 INFO - Running setup.py install for mozfile 04:00:05 INFO - Running setup.py install for mozhttpd 04:00:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:00:05 INFO - Running setup.py install for mozinfo 04:00:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:00:05 INFO - Running setup.py install for mozInstall 04:00:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:00:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:00:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:00:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:00:05 INFO - Running setup.py install for mozleak 04:00:05 INFO - Running setup.py install for mozlog 04:00:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:00:05 INFO - Running setup.py install for moznetwork 04:00:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:00:05 INFO - Running setup.py install for mozprocess 04:00:06 INFO - Running setup.py install for mozprofile 04:00:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:00:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:00:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:00:06 INFO - Running setup.py install for mozrunner 04:00:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:00:06 INFO - Running setup.py install for mozscreenshot 04:00:06 INFO - Running setup.py install for moztest 04:00:06 INFO - Running setup.py install for mozversion 04:00:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:00:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:00:06 INFO - Cleaning up... 04:00:06 INFO - Return code: 0 04:00:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:06 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')]} 04:00:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:06 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')]} 04:00:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:06 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 0x20361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2202a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2eb0>, '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 0x23a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', '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 04:00:06 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 04:00:06 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 04:00:06 INFO - Using env: {'DISPLAY': ':0', 04:00:06 INFO - 'HOME': '/home/cltbld', 04:00:06 INFO - 'LANG': 'en_US.UTF-8', 04:00:06 INFO - 'LANGUAGE': 'en_US:en', 04:00:06 INFO - 'LOGNAME': 'cltbld', 04:00:06 INFO - 'MAIL': '/var/mail/cltbld', 04:00:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:06 INFO - 'MOZ_NO_REMOTE': '1', 04:00:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:06 INFO - 'NO_EM_RESTART': '1', 04:00:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:06 INFO - 'PWD': '/builds/slave/test', 04:00:06 INFO - 'SHELL': '/bin/bash', 04:00:06 INFO - 'SHLVL': '1', 04:00:06 INFO - 'TERM': 'linux', 04:00:06 INFO - 'TMOUT': '86400', 04:00:06 INFO - 'USER': 'cltbld', 04:00:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 04:00:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:06 INFO - '_': '/tools/buildbot/bin/python'} 04:00:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:06 INFO - Running setup.py (path:/tmp/pip-AFfJFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:06 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)) 04:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:06 INFO - Running setup.py (path:/tmp/pip-aZDlfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:07 INFO - Running setup.py (path:/tmp/pip-CGLkS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:07 INFO - Running setup.py (path:/tmp/pip-kOSggD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:07 INFO - Running setup.py (path:/tmp/pip-n26fOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:07 INFO - Running setup.py (path:/tmp/pip-7KJVaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:07 INFO - Running setup.py (path:/tmp/pip-c26I4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:07 INFO - Running setup.py (path:/tmp/pip-FLA2ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:07 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)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:07 INFO - Running setup.py (path:/tmp/pip-sZv7TS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:07 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)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:07 INFO - Running setup.py (path:/tmp/pip-xG9Z4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:07 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)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:07 INFO - Running setup.py (path:/tmp/pip-TZ2wy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:07 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)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:07 INFO - Running setup.py (path:/tmp/pip-4MGCa3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:07 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)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:07 INFO - Running setup.py (path:/tmp/pip-GYQpFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:07 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)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:07 INFO - Running setup.py (path:/tmp/pip-COGuC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:07 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)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:07 INFO - Running setup.py (path:/tmp/pip-fBpgI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:07 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)) 04:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:07 INFO - Running setup.py (path:/tmp/pip-FSXoEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:00:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:08 INFO - Running setup.py (path:/tmp/pip-bA7etd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:00:08 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:00:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:09 INFO - Downloading blessings-1.6.tar.gz 04:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:00:09 INFO - Installing collected packages: blessings 04:00:09 INFO - Running setup.py install for blessings 04:00:09 INFO - Successfully installed blessings 04:00:09 INFO - Cleaning up... 04:00:09 INFO - Return code: 0 04:00:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:00:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:09 INFO - Reading from file tmpfile_stdout 04:00:09 INFO - Current package versions: 04:00:09 INFO - argparse == 1.2.1 04:00:09 INFO - blessings == 1.6 04:00:09 INFO - blobuploader == 1.2.4 04:00:09 INFO - docopt == 0.6.1 04:00:09 INFO - functools32 == 3.2.3-2 04:00:09 INFO - jsonschema == 2.5.1 04:00:09 INFO - manifestparser == 1.1 04:00:09 INFO - mozInstall == 1.13 04:00:09 INFO - mozcrash == 1.0 04:00:09 INFO - mozdebug == 0.1 04:00:09 INFO - mozdevice == 0.51 04:00:09 INFO - mozfile == 1.2 04:00:09 INFO - mozhttpd == 0.7 04:00:09 INFO - mozinfo == 0.10 04:00:09 INFO - mozleak == 0.1 04:00:09 INFO - mozlog == 3.5 04:00:09 INFO - moznetwork == 0.27 04:00:09 INFO - mozprocess == 0.25 04:00:09 INFO - mozprofile == 0.28 04:00:09 INFO - mozrunner == 6.13 04:00:09 INFO - mozscreenshot == 0.1 04:00:09 INFO - mozsystemmonitor == 0.3 04:00:09 INFO - moztest == 0.8 04:00:09 INFO - mozversion == 1.4 04:00:09 INFO - psutil == 3.1.1 04:00:09 INFO - requests == 1.2.3 04:00:09 INFO - wsgiref == 0.1.2 04:00:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:09 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')]} 04:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:09 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')]} 04:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:09 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 0x20361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2202a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2eb0>, '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 0x23a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', '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 04:00:09 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 04:00:09 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 04:00:09 INFO - Using env: {'DISPLAY': ':0', 04:00:09 INFO - 'HOME': '/home/cltbld', 04:00:09 INFO - 'LANG': 'en_US.UTF-8', 04:00:09 INFO - 'LANGUAGE': 'en_US:en', 04:00:09 INFO - 'LOGNAME': 'cltbld', 04:00:09 INFO - 'MAIL': '/var/mail/cltbld', 04:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:09 INFO - 'MOZ_NO_REMOTE': '1', 04:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:09 INFO - 'NO_EM_RESTART': '1', 04:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:09 INFO - 'PWD': '/builds/slave/test', 04:00:09 INFO - 'SHELL': '/bin/bash', 04:00:09 INFO - 'SHLVL': '1', 04:00:09 INFO - 'TERM': 'linux', 04:00:09 INFO - 'TMOUT': '86400', 04:00:09 INFO - 'USER': 'cltbld', 04:00:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 04:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:09 INFO - '_': '/tools/buildbot/bin/python'} 04:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:09 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)) 04:00:09 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)) 04:00:09 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)) 04:00:09 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)) 04:00:09 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)) 04:00:09 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)) 04:00:09 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)) 04:00:09 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)) 04:00:09 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)) 04:00:09 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:00: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 04:00: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 04:00: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 04:00: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 04:00:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:00:11 INFO - Installing collected packages: simplejson 04:00:11 INFO - Running setup.py install for simplejson 04:00:11 INFO - building 'simplejson._speedups' extension 04:00:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 04:00:11 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 04:00:12 INFO - Successfully installed simplejson 04:00:12 INFO - Cleaning up... 04:00:12 INFO - Return code: 0 04:00:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2202a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2eb0>, '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 0x23a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', '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 04:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:00:12 INFO - Using env: {'DISPLAY': ':0', 04:00:12 INFO - 'HOME': '/home/cltbld', 04:00:12 INFO - 'LANG': 'en_US.UTF-8', 04:00:12 INFO - 'LANGUAGE': 'en_US:en', 04:00:12 INFO - 'LOGNAME': 'cltbld', 04:00:12 INFO - 'MAIL': '/var/mail/cltbld', 04:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:12 INFO - 'MOZ_NO_REMOTE': '1', 04:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:12 INFO - 'NO_EM_RESTART': '1', 04:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:12 INFO - 'PWD': '/builds/slave/test', 04:00:12 INFO - 'SHELL': '/bin/bash', 04:00:12 INFO - 'SHLVL': '1', 04:00:12 INFO - 'TERM': 'linux', 04:00:12 INFO - 'TMOUT': '86400', 04:00:12 INFO - 'USER': 'cltbld', 04:00:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 04:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:12 INFO - '_': '/tools/buildbot/bin/python'} 04:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:00:12 INFO - Cleaning up... 04:00:12 INFO - Return code: 0 04:00:12 INFO - Running post-action listener: _resource_record_post_action 04:00:12 INFO - Running post-action listener: _start_resource_monitoring 04:00:12 INFO - Starting resource monitoring. 04:00:12 INFO - [mozharness: 2017-08-03 11:00:12.413855Z] Finished create-virtualenv step (success) 04:00:12 INFO - [mozharness: 2017-08-03 11:00:12.414369Z] Running install step. 04:00:12 INFO - Running pre-action listener: _resource_record_pre_action 04:00:12 INFO - Running main action method: install 04:00:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:12 INFO - Reading from file tmpfile_stdout 04:00:12 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:00:12 INFO - Reading from file tmpfile_stdout 04:00:12 INFO - Output received: 04:00:12 INFO - Usage: mozinstall [options] installer 04:00:12 INFO - Options: 04:00:12 INFO - -h, --help show this help message and exit 04:00:12 INFO - -d DEST, --destination=DEST 04:00:12 INFO - Directory to install application into. [default: 04:00:12 INFO - "/builds/slave/test"] 04:00:12 INFO - --app=APP Application being installed. [default: firefox] 04:00:12 INFO - mkdir: /builds/slave/test/build/application 04:00:12 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'] 04:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:00:31 INFO - Reading from file tmpfile_stdout 04:00:31 INFO - Output received: 04:00:31 INFO - /builds/slave/test/build/application/firefox/firefox 04:00:31 INFO - Running post-action listener: _resource_record_post_action 04:00:31 INFO - [mozharness: 2017-08-03 11:00:31.004024Z] Finished install step (success) 04:00:31 INFO - [mozharness: 2017-08-03 11:00:31.004302Z] Running setup-mitmproxy step. 04:00:31 INFO - Running pre-action listener: _resource_record_pre_action 04:00:31 INFO - Running main action method: setup_mitmproxy 04:00:31 INFO - Skipping: mitmproxy is not required 04:00:31 INFO - Running post-action listener: _resource_record_post_action 04:00:31 INFO - [mozharness: 2017-08-03 11:00:31.005531Z] Finished setup-mitmproxy step (success) 04:00:31 INFO - [mozharness: 2017-08-03 11:00:31.005754Z] Running run-tests step. 04:00:31 INFO - Running pre-action listener: _resource_record_pre_action 04:00:31 INFO - Running pre-action listener: _set_gcov_prefix 04:00:31 INFO - Running main action method: run_tests 04:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:00:31 INFO - Python 2.7.3 04:00:31 INFO - Return code: 0 04:00:31 INFO - grabbing minidump binary from tooltool 04:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:31 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a2eb0>, '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 0x23a3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a4240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:00:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:00:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:00:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:00:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:31 INFO - Return code: 0 04:00:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:00:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:00:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:00:31 INFO - ENV: RUST_BACKTRACE is now 1 04:00:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:00:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:00:31 INFO - Using env: {'DISPLAY': ':0', 04:00:31 INFO - 'HOME': '/home/cltbld', 04:00:31 INFO - 'LANG': 'en_US.UTF-8', 04:00:31 INFO - 'LANGUAGE': 'en_US:en', 04:00:31 INFO - 'LOGNAME': 'cltbld', 04:00:31 INFO - 'MAIL': '/var/mail/cltbld', 04:00:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:00:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:31 INFO - 'MOZ_NO_REMOTE': '1', 04:00:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:31 INFO - 'NO_EM_RESTART': '1', 04:00:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:31 INFO - 'PWD': '/builds/slave/test', 04:00:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:00:31 INFO - 'RUST_BACKTRACE': '1', 04:00:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:00:31 INFO - 'SHELL': '/bin/bash', 04:00:31 INFO - 'SHLVL': '1', 04:00:31 INFO - 'TERM': 'linux', 04:00:31 INFO - 'TMOUT': '86400', 04:00:31 INFO - 'USER': 'cltbld', 04:00:31 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740', 04:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:31 INFO - '_': '/tools/buildbot/bin/python'} 04:00:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:00:31 INFO - mozversion application_buildid: 20170803094416 04:00:31 INFO - mozversion application_changeset: 681a2489f6a92a09f87336c4ebfcd55030ffcda1 04:00:31 INFO - mozversion application_display_name: Nightly 04:00:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:31 INFO - mozversion application_name: Firefox 04:00:31 INFO - mozversion application_remotingname: firefox 04:00:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:00:31 INFO - mozversion application_vendor: Mozilla 04:00:31 INFO - mozversion application_version: 57.0a1 04:00:31 INFO - mozversion platform_buildid: 20170803094416 04:00:31 INFO - mozversion platform_changeset: 681a2489f6a92a09f87336c4ebfcd55030ffcda1 04:00:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:00:31 INFO - mozversion platform_version: 57.0a1 04:00:31 INFO - using testdate: 1501758031 04:00:31 INFO - actual date: 1501758031 04:00:31 INFO - starting webserver on 'localhost:40423' 04:00:31 INFO - SUITE-START | Running 2 tests 04:00:31 INFO - TEST-START | dromaeo_css 04:00:31 INFO - Initialising browser for dromaeo_css test... 04:00:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40423/getInfo.html -profile /tmp/tmpPmNBUr/profile 04:00:31 INFO - TEST-INFO | started process 10785 (/builds/slave/test/build/application/firefox/firefox http://localhost:40423/getInfo.html) 04:00:36 INFO - TEST-INFO | 10785: exit 0 04:00:36 INFO - Browser initialized. 04:00:36 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:36 INFO - TEST-INFO | started process 10991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPmNBUr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:37 INFO - PID 10991 | 04:00:37 INFO - PID 10991 | (/builds/slave/test/build/application/firefox/firefox:11040): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:00:37 INFO - PID 10991 | 04:00:48 INFO - PID 10991 | RSS: Main: 164798464 04:00:48 INFO - PID 10991 | 04:03:46 INFO - PID 10991 | Cycle 1(1): loaded http://localhost:40423/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40423/tests/dromaeo/cssquery-ext.html) 04:03:47 INFO - PID 10991 | RSS: Main: 167096320 04:03:47 INFO - PID 10991 | 04:06:48 INFO - PID 10991 | Cycle 1(1): loaded http://localhost:40423/tests/dromaeo/cssquery-ext.html (next: http://localhost:40423/tests/dromaeo/cssquery-jquery.html) 04:06:49 INFO - PID 10991 | RSS: Main: 164225024 04:06:49 INFO - PID 10991 | 04:09:51 INFO - PID 10991 | Cycle 1(1): loaded http://localhost:40423/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40423/tests/dromaeo/cssquery-mootools.html) 04:09:51 INFO - PID 10991 | RSS: Main: 166100992 04:09:51 INFO - PID 10991 | 04:12:53 INFO - PID 10991 | Cycle 1(1): loaded http://localhost:40423/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40423/tests/dromaeo/cssquery-prototype.html) 04:12:53 INFO - PID 10991 | RSS: Main: 165203968 04:12:53 INFO - PID 10991 | 04:15:57 INFO - PID 10991 | Cycle 1(1): loaded http://localhost:40423/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40423/tests/dromaeo/cssquery-yui.html) 04:15:57 INFO - PID 10991 | RSS: Main: 168349696 04:15:57 INFO - PID 10991 | 04:18:59 INFO - PID 10991 | Cycle 1(1): loaded http://localhost:40423/tests/dromaeo/cssquery-yui.html (next: http://localhost:40423/tests/dromaeo/cssquery-dojo.html) 04:18:59 INFO - PID 10991 | RSS: Main: 168722432 04:18:59 INFO - PID 10991 | 04:18:59 INFO - PID 10991 | __start_tp_report 04:18:59 INFO - PID 10991 | _x_x_mozilla_page_load 04:18:59 INFO - PID 10991 | _x_x_mozilla_page_load_details 04:18:59 INFO - PID 10991 | |i|pagename|runs| 04:18:59 INFO - PID 10991 | |0;dojo.html;3452.430348992415;3479.7912125272483;3487.9302413951727;3491.8952431427033;3508.280802435501;6158.137860699506;6223.875522489548;6249.875002499953;6286.654234017127;6302.180716506859;6145.170401995741;6223.875522489548;6227.43953044226;6255.4370106690385;6273.905891411621;5456.208849716789;5468.562514998801;5543.417941116165;5563.054280772279;5608.971955140239;5047.64666473347;5390.649607775502;5440.510354068133;5461.208124821898;5511.118221084627;5373.9731301343245;5420.593455490814;5456.017916774979;5466.34403871538;5474.863128421802;5397.811076612339;5420.051490989061;5497.780088796443;5510.889782204334;5511.118221084607;5410.756515956791;5413.702246376448;5425.13197888336;5430.5384042356445;5435.320584926884;6087.939120608826;6192.411720886554;6202.782902598387;6220.315765265817;6221.720022598994;6653.933460665428;6699.129113215251;6713.060171575983;6780.220274668378;6787.151606049244;6742.966285168592;6771.356721111487;6808.421284190849;6859.2454829968665;6860.0738900248325;6248.094026366151;6322.272938612026;6329.841753956188;6334.5249106317215;6336.398042185985;6895.034695142684;6909.896351554731;6922.134733158356;6987.545809522365;7020.508564400545;6575.769848055295;6584.9012264816065;6604.438622717123;6616.437602803816;6619.238787539494;6681.966590167115;6727.394534491919;6742.696578653972;6759.155105611799;6763.053172555846;6551.934480655228;6609.6364699941005;6611.669416529155;6693.765718199839;6696.86606267872;6655.600663960178;6691.197056353171;6691.9962005699535;6751.122354094035;6778.118844550177;4905.264210368473;4956.677815941952;4982.576480999156;4983.476734942778;4983.875403114878;4353.869383918487;4376.840137363602;4405.889852753643;4412.757298348622;4428.55714428561;6286.151369565142;6417.903731443938;6419.935800642027;6458.38645328693;6498.870022599522;6800.4219641330055;6829.897551536731;6844.349786770249;6858.142732158481;6859.965700171467;6403.231612206565;6412.871742565216;6425.228972523327;6491.7078731457195;6498.187726534184;5448.073827449343;5543.805966791224;5587.106063029977;5653.547716182696;5654.6889921054735;7038.472114591426;7149.356557909813;7156.355927966508;7162.212156662763;7182.497225194186;6737.427318677967;6759.729610815512;6818.352256535622;6846.383825455534;6851.2121106071445;7039.472039596948;7049.647517624201;7060.364567188978;7146.892231704094;7156.534825236343;6467;6551.115599394211;6566.146400968035;6629.635370054693;6647.6676166192465;6783.830404239933;6785.89821152693;6788.626625535446;6788.694508747217;6833.145856767904;6420.6147631142285;6434.4852411806005;6510.958246680509;6558.967205163944;6586.0450234714735;6556;6559.442447391834;6568.211814582281;6571.868562628816;6574.737010519526;6438.645874476949;6471.996840489732;6517.283098859027;6542.313057128933;6545.607263564201;6510.3489651034515;6551.181102362205;6603.9009414859775;6627.635480048643;6632.4694024478895;6326.557141000086;6416.101745755691;6497.480201583768;6497.577657452251;6507.154069971063 04:18:59 INFO - PID 10991 | |1;ext.html;856.9057403685593;882.3558802074484;907.1563445995226;1208.2206976500158;1238.4798384678434;34961.300773984534;44894;45694.54305456945;45854.312185317205;45914.54085459145;44902.10195796082;45546.77226613862;45962.54037459625;46096.308555371696;46183.76908115455;7511.286427789379;7599.658015389293;7681.769546913573;7682.884756728654;7683.193264707209;7606.125295590995;7684.308412242897;7695.230476952316;7700.4224683148705;7707.113681926594;7140.107486564179;7771.883421748678;7806.414518911076;7813.76558703237;7824;7629.542227466342;7693.999780028616;7696.538207707527;7697.114831794359;7705.922940770577;7602.239776022354;7603.0496187976505;7657.4639775215755;7688.6924523019015;7712.305892469649;40214.59785402138;40533.18933621341;40560.391594126115;40604.59395406038;40691.7965410171;3354.630990591033;3405.3529829332347;3406.931861362759;3408.880689175892;3409.113630456099;32232.677673223203;32233.6776632233;32407;32419;32439;4958.454569997298;5087.8982420351385;5094.465081166498;5105.106606343912;5170.327857378555;206121;206221;206603;206735.9999999985;207803.96098019564;52809.73595132076;52854;52874.73562632162;52992;54929;56586.71706641523;56813.715931420906;57437;57486.7125664369;57574.71212643994;16242.944208626637;16433.09617970999;16468.752968705478;16482;16853;13829.585112446643;13834.446622135001;13850.584482465541;13856.168629882239;13883.791743123658;13997.580072597839;14241.50154744579;15324.233788310763;15326.233688315762;15759.527214183592;6022.69886505673;6109.175261339662;6120.571559990758;6180.536459765445;6308.905366419507;1082.0856376361962;1089.809283375406;1097.1168209591197;1102.327580176092;1106.5960924262586;24805.5038899221;24880.12919547807;24979.62530562043;25047.749522504542;25082.87458562732;1201.147185498306;1204.777116233482;1211.4427363412929;1212.5210541835925;1226.3622916083586;13178.60464186076;13225.933870330588;13349.733005339838;13363.799543006862;17505.38731144404;299685;303472;303969;304667;305237;63322;63719.681401592694;63779;63928.68035659792;63955;1504.180221779133;1524.4588171199064;1552.6817002514458;1555.4400415850284;1577.83432739563;29528.85235573894;30017.69982300149;30139.698603014567;30313;30530.23674408069;41286;41440.3783943235;41557;41830.79084604557;41904.79047604743;250844;252101;253518;253608;254946;35843.64156358507;35993.46009809907;36206.456903147;36219;36338.27323453569;45326.54673453223;49917.25124123214;50427.74786126046;50617.24074138964;50733.492665072874;35597.64402356047;36287;36406.63593364138;36653.63346366502;37293.25413491769;36814.26371472609;37013.44479832751;37129.443058354685;37251.62748372481;37303.44044839384;42229;42299;43552.56447435485;44635.77682111569;44673.10653786841;35735.64264357323;36126;36209;36793.26413471769;37366.626333737404;26723.866380667972;27783.30541736473;27945.72054279431;27965.72034279631;27992.160235192976 04:18:59 INFO - PID 10991 | |2;jquery.html;582.7581553655233;585.3093349847179;588.6144575303176;591.5031373646136;596.6539407143857;23052.19317323894;23911.641325380133;23938.76061239387;23966.520669586618;23975.520489590243;23542;25903.611445828326;25912.611310830307;25982;26085.608715869275;6261.436470717635;6398.808035758934;6418.807435776934;6426.967865160667;6428.132202152719;4258.297380932143;4458.4872739634875;6109.083637454395;6169.290531588857;6182.72177752;6305.495560355161;6325.051242313643;6341.365863413645;6353.0788035734795;6355.1420558224745;6281.780137695158;6319.8104056878365;6347.61914285142;6355.046742988566;6361.586496877734;5862.97068514659;5930.970345148246;5934.525237980951;5937.406259374071;5944.851378715523;30052.098437046923;31248;31290.843545782354;31503.84248078745;31734.365312693848;2206.4263291544153;2265.750767415583;2267.501149747053;2268.0247493577754;2268.7844654757773;19937.800621993738;20418.5916281675;20471.5905681887;20511.4872128198;20569.58860822775;2386.9184981231533;2411.481531470742;2451.031842422251;2461.4092617771785;2462.125945289414;148546;154482.22758886247;154951;155674;156253;15459.371906775876;15835;16209.675806483805;16327.428540001043;16724.58188545296;25009;25064.12275570346;25068.874655626605;25079.87460062688;25099.37251568689;10939.83590246147;10970.890291096986;11029.558817647205;11076.11391088711;11087.667369978913;10173.44046077473;10210;10244.743881403025;10261.333013354108;10282.537285822156;9424.246060315296;9824.852627210597;9881.703548893545;10191.388516689023;10257.948410317966;2978.657454392729;2993.7546839870097;3003.2642002709476;3029.909102726922;3119.2201949512623;1032.9070383665505;1033.9247182929819;1043.2488608202082;1043.6138628707274;1054.9683509494728;20831.791682083287;20876.269330573356;21084.578308433745;21481.67777483339;21746;1107.0811226681835;1113.1261959362023;1113.3431275547466;1136.5113001409309;1138.7494751154732;11629.53481860716;11707.824382634268;11821.763564728657;11897.524099036114;11996.520139194508;585378;595894;615492;628633;636037;126668;130570;133948;134652;135842;1315.5921664284103;1323.6624660711457;1374.4845682868925;1376.39438646995;1384.2248340928911;22235.555288893807;22631.773682262967;22632.66051009269;22721.772782271964;22878.199263025715;63394.68302658457;64348.67825661029;64823;65573.67213163903;65973.67013164904;80366.5981670088;83097.16902830894;83230.58384708037;83529;84836.57581712052;13173.670658233621;13725.725485490433;14522.636934076732;14878.776818347516;15209.543713688607;23917.880410597834;25308.873455632605;25370.619440708775;25391.238262852145;25701;18674.439766807016;19340.323088691828;19988;20135.093920773306;20199.79800201979;17156.656866862344;17161.485155445356;18440.907795461473;18875.339363122224;19362.70955935634;19697.113629886404;19766.50583735418;19766.604667906275;19819.504512387306;19844.60310793805;22477.550448991256;22891.542169156855;23189.42026449285;23194.3041708749;23371.649425258296;20317.593648126658;20653.58692826105;20784.27255046066;20902.790972090086;21036 04:18:59 INFO - PID 10991 | |3;mootools.html;1405.156905856486;1434.7847822826575;1454.599985004123;1464.6045567696722;1473.7641977283631;15139;15197.54407367778;15781.526554203378;15791.842081579181;15794.684106317867;15951.760723589156;16223.351065957348;16226.350945962176;16250.674986500262;16307.592310192222;2699.5140874642607;2751.408447183855;2752.545829938058;2753.848538330391;2758.0760445250867;2635.064552084011;2691.717369676185;2707.796915231356;2729.959050614242;2730.59041143828;2687.865606719666;2709.7561219490244;2715.67411910571;2734.4667789781;2735.042735042739;2597.921862427081;2640.4323070539735;2643.444876575921;2667.1598446489293;2669.706332303455;2638.9604155937677;2661.4677064586967;2672.706002339741;2679.0355472030055;2684.8523331216775;15124.243787810565;15330.310136043905;15406.768898466533;15496.070235785888;15519.767203491956;7913.683452661887;8196.508209507449;8234.876476852853;8247.21651443118;8250.051244106944;5123.897522049539;5302.231176479428;5314.787408503656;5337.439568845254;5403.7027963462;1945.5816999345209;1967.6359873423462;1971.2903354792263;1998.5902889907534;2014.4258886217503;26509.46981060368;26682.733172668413;26881;26927;26963.460730785275;6398.200224971879;6714.362135597111;6772.119624448888;6896.793096207121;6903.585784852825;18232.90883545574;18288;18312.267509299745;18383.90808045951;18389.5402614933;7806.6096695165015;8084.070331911906;8101.837963240702;8102.189781021851;8106.837863242702;7234.204237533867;7339.633018349061;7400.5189662671755;7428.071491063617;7481.9251807482315;5294.867628309323;5450.155225939986;5524.392316845144;5590.804321848797;5677.318721753416;1479.7262506436343;1522.4823559989657;1522.6878489909543;1537.3235776258412;1544.629288970639;854.2226573817796;901.693424235763;909.0364213933252;916.0335845682736;927.2396634759433;8399.538025408661;8461;8494.490330580185;8549.316054715608;8605;738.9741359052407;740.4076738609091;751.2112282103878;753.4236309223448;816.7917181118777;5013.949860501349;5158.74206289684;5170.353705786777;5191.299174611455;5197.818076367309;22245.66631500529;22694.886525567268;22791.430214244778;22796.2021329256;22902.198423055113;21675.34973950784;21745.34763957084;21827.23604673829;22282;22307.776922230896;10629.574817007233;10889.782204355868;11029.779404411867;11032.944835275934;12076.275423474619;8876.334274929277;9287.860682089638;9452.149306562442;9520.571914212924;9579.856302155335;18678.626427471645;19342.4197274082;19777.307794227134;19855.305064322678;20042;19850.50373740668;19935.700964485255;20017;20086.296979605642;20091.19635214575;12465.563705270271;12951.870481295067;12954.676133096747;12957.611271661865;12964.870351296744;14389.712205756035;14435.566932992027;14522.636934076732;14536.127832330094;14547.49083782105;11762.117841161777;11810.173287869766;11919.642410727693;12062.51749929993;12248.69378265515;11618.94190529042;11675.591354302558;11690.649280521598;11842.703932401759;11917.642470725892;9967.25245606597;10084.848727269244;10091.949540252252;10092.949535252277;10094.697159085239;7662.398672623858;7711.3830893527265;7711.9614401929875;7782.533048017137;7814.492058016211;8066.475679080841;8139;8206.138355472589;8300.294474969694;8346.33229341639 04:18:59 INFO - PID 10991 | |4;prototype.html;513.7508308470391;522.9947700522996;544.812039846253;553.3387601815829;553.8476918847314;5947.464728174464;6065.545084118698;6084.330723620398;6091.553166188685;6124.908126378103;5783;5897.380775018625;5962.403759624035;5991.520678345732;6003.909941350872;4711.528847115278;4730.787114579835;4732.272720457043;4735.573798358147;4767.261074533453;4659;4707.199776038065;4749.548792864673;4804.5916097131785;4808.5618782570455;4664;4679.251319788835;4703.529647035286;4756.28655701644;4760.976195119019;4613.354130421727;4727.05458908218;4735.644826638016;4758.500357462452;4769.952300476985;4246.490421149451;4313.956860431418;4325.762083085429;4344.587264209895;4349.869503914888;5767.5962682612235;5821.478005806511;5894.646321220697;5965.3139888912465;5992.520598352121;5641.464060914206;5650.434956504358;5671.574631902583;5685.147227915804;5712.542996560265;6481.578697384655;6506.869862602769;6515.218173819125;6520.576162549419;6521;4837.7339246341435;4855.927161092586;4882.583121354916;4884.3650325457465;4906.386701662293;6709.161354830646;6797.116374871284;6811.148606424197;6813.7955861324235;6821.294676330917;5040.84877453677;5044.2937988681615;5061.746912654353;5073.949260507421;5103.055934652101;5105.2342148678;5157.9684063187515;5161.948380516222;5181.404138524118;5200.297959775382;5623.184638227516;5660.349059858169;5698.0398622956645;5707.6575405475805;5711.343195532567;6245.344238854946;6299.653519056405;6421.967890160519;6463.289038205794;6574.342565743387;1697.702901992171;1733.4366330942494;1757.4464043826154;1766.4259115787163;1775.8224177582138;1233.901287896966;1250.8311377963857;1260.1745856463847;1260.4139075330015;1266.1643315411784;6168.722407491674;6194.5044396448175;6254.280757712831;6268.49852011838;6297.1813664223355;6644.4020038196795;6689.464842812563;6696.46428285736;6704.5250044990025;6713.429358504582;6311.747530098744;6323.652199129092;6334.3032266450655;6344.6827658616885;6345.873082538324;3496.8950931472095;3513.7364697647777;3522.788632682047;3525.5593050868642;3549.5917969433845;7004.4396448284015;7018.438524917994;7018.964905175441;7042.260562640951;7043.330883566053;6766.5263431559315;6865.485088618374;6887.862242755117;6889.311068893071;6911.861762764716;6964.781163296301;6977.7208911642965;6996.985437111591;7058.964705176441;7066.293370662996;6593.670316484061;6595.967020164869;6663.5002374821115;6701.497387695845;6747.433367471954;6588.8023359299295;6598.670066496752;6615.956659936483;6618.172728408949;6623.735050597922;6873.347032031949;6897.206821215424;6908.758193463204;6958.478114141359;6976.720931162899;4964.280179373898;5012.498750124958;5043;5049.924251136163;5078.5175408336145;6444.742210311535;6631.204255489372;6678.7328506859185;6690.83272918181;6720.764773232913;6266.248050234001;6405.135306733718;6415.6471394071905;6462.741490340334;6482.902756458562;6415.582987105823;6453.290138084901;6458.38645328693;6494.415502604788;6496.967515162394;6302.464290535356;6388.137601423934;6389.904151437825;6406.487481001415;6454.612723236621;6462.321456247027;6502.577332473374;6502.837429064311;6520.315366886409;6541.901871471837;6251.531135164972;6269.087928181766;6284.937150628435;6304.306526282014;6361 04:18:59 INFO - PID 10991 | |5;yui.html;872.0451106038887;889.3463304471212;913.2374467319788;932.6595792535727;933.4492649336894;19207.807921920776;19975.800241997575;19984.200631974723;19993.500162495908;22959.885200573975;21520.784792152073;21910;22142.778572214273;22143.667844982298;22179;1046.691226088304;1060.8939106089406;1076.165971372185;1077.1867240233612;1077.219016213243;1030.8196065688512;1079.913606911449;1084.1868598551087;1084.9783004339909;1085.6742977106837;1132.9037031852301;1148.9597864074758;1152.6945359479744;1155.0240047160137;1155.2433156282607;1142.194752699345;1149.8562679665042;1152.9250598711058;1155.4858088150777;1156.1271240213628;833.5873742497442;837.7151768398774;838.7986883148001;839.7816567692383;841.3395484544603;20249.696254556195;20555.794442055536;20718.689219661715;20752.584948300948;20871.58256834855;21333.786662133334;21445.249416270355;21679.67480487794;22055;22107;16766.245518951677;17032.2335494903;17199.742003869953;17257.223424945907;17398.39105631297;3600.0999750062483;3600.891973240807;3601;3606.8196590170387;3608.4587311903424;151166;153293.2335338316;154339;154906.22546887308;155307.2234638831;16143.677126457405;16852.57868553296;16877.40929067477;16902.985820850787;16930;31897;32048;32101;32188.034358969267;32481.35037299241;8098.635561399751;8299.253067223979;8409;8458;8830.249428798625;4363;4512.593866552026;4517.2094883395275;4518.367428560005;4523.140603285366;5350.411454739976;5425.321834770653;5443.401225865152;5461.590380721462;5496.0931446310915;1111.9332840029624;1139.0602752729033;1146.9541218351173;1146.9885301147049;1150.6433005768072;705.982350441243;710.0556260173956;724.6159535446222;734.4124700239787;736.7237286017744;12383.380830958597;12401.875981240071;12554.686132846751;12915.935420323027;13567.932160339134;718.8023293594304;731.6926890705917;740.0749063670412;744.9366803821736;750.53091817614;5818.243628328375;5854.151148083504;5898.557608179403;6087.299960504599;6189.597676151126;125348.37325813313;131598;131995;133386;134538;115089;116495;117936;118195.40902295605;121387;98434;99342;100266.4986675062;100636.4968175169;102307;12747.745045099231;12840.110975030544;12994.090413670952;13108.344582770633;13350.706925473032;44860;45267.32099018452;45482;45561.31658025066;47070.05859882715;82520.58739706263;83958;84738.15261847549;85272.14727852642;86042.56978715317;20113.79886201178;20229.291974780812;20801.791982079987;20811.687824682944;21004.159833607097;21954.34136975893;22420.663690044337;22523.887380562992;22646.094156233565;22797.088116475155;18038.90980545089;18149.909250453664;18234;18307.816921831145;18438.35465758692;17842.732359014884;17900.820991789915;17999;18738.156782944527;18818.717719233948;20369.79630203679;20624.896875516126;20751.8962405187;21056.68414973746;21067.789322107197;14307.856921431068;14370.425182992563;14431.85568144347;14515.346809393814;14519.346629401913;13932.373043212878;13944.442222310994;14037.087589306662;14096.647583810487;14125.717485650435 04:18:59 INFO - PID 10991 | __end_tp_report 04:18:59 INFO - PID 10991 | __start_cc_report 04:18:59 INFO - PID 10991 | _x_x_mozilla_cycle_collect,341 04:18:59 INFO - PID 10991 | __end_cc_report 04:18:59 INFO - PID 10991 | __startTimestamp1501759139416__endTimestamp 04:18:59 INFO - PID 10991 | 04:18:59 INFO - PID 10991 | ------- Summary: start ------- 04:18:59 INFO - PID 10991 | Number of tests: 6 04:18:59 INFO - PID 10991 | 04:18:59 INFO - PID 10991 | [#0] dojo.html Cycles:165 Average:6196.51 Median:6498.19 stddev:803.93 (12.4%) stddev-sans-first:777.04 04:18:59 INFO - PID 10991 | Values: 3452.4 3479.8 3487.9 3491.9 3508.3 6158.1 6223.9 6249.9 6286.7 6302.2 6145.2 6223.9 6227.4 6255.4 6273.9 5456.2 5468.6 5543.4 5563.1 5609.0 5047.6 5390.6 5440.5 5461.2 5511.1 5374.0 5420.6 5456.0 5466.3 5474.9 5397.8 5420.1 5497.8 5510.9 5511.1 5410.8 5413.7 5425.1 5430.5 5435.3 6087.9 6192.4 6202.8 6220.3 6221.7 6653.9 6699.1 6713.1 6780.2 6787.2 6743.0 6771.4 6808.4 6859.2 6860.1 6248.1 6322.3 6329.8 6334.5 6336.4 6895.0 6909.9 6922.1 6987.5 7020.5 6575.8 6584.9 6604.4 6616.4 6619.2 6682.0 6727.4 6742.7 6759.2 6763.1 6551.9 6609.6 6611.7 6693.8 6696.9 6655.6 6691.2 6692.0 6751.1 6778.1 4905.3 4956.7 4982.6 4983.5 4983.9 4353.9 4376.8 4405.9 4412.8 4428.6 6286.2 6417.9 6419.9 6458.4 6498.9 6800.4 6829.9 6844.3 6858.1 6860.0 6403.2 6412.9 6425.2 6491.7 6498.2 5448.1 5543.8 5587.1 5653.5 5654.7 7038.5 7149.4 7156.4 7162.2 7182.5 6737.4 6759.7 6818.4 6846.4 6851.2 7039.5 7049.6 7060.4 7146.9 7156.5 6467.0 6551.1 6566.1 6629.6 6647.7 6783.8 6785.9 6788.6 6788.7 6833.1 6420.6 6434.5 6511.0 6559.0 6586.0 6556.0 6559.4 6568.2 6571.9 6574.7 6438.6 6472.0 6517.3 6542.3 6545.6 6510.3 6551.2 6603.9 6627.6 6632.5 6326.6 6416.1 6497.5 6497.6 6507.2 04:18:59 INFO - PID 10991 | 04:18:59 INFO - PID 10991 | [#1] ext.html Cycles:180 Average:43887.65 Median:36803.76 stddev:67120.18 (182.4%) stddev-sans-first:67230.70 04:18:59 INFO - PID 10991 | Values: 856.9 882.4 907.2 1208.2 1238.5 34961.3 44894.0 45694.5 45854.3 45914.5 44902.1 45546.8 45962.5 46096.3 46183.8 7511.3 7599.7 7681.8 7682.9 7683.2 7606.1 7684.3 7695.2 7700.4 7707.1 7140.1 7771.9 7806.4 7813.8 7824.0 7629.5 7694.0 7696.5 7697.1 7705.9 7602.2 7603.0 7657.5 7688.7 7712.3 40214.6 40533.2 40560.4 40604.6 40691.8 3354.6 3405.4 3406.9 3408.9 3409.1 32232.7 32233.7 32407.0 32419.0 32439.0 4958.5 5087.9 5094.5 5105.1 5170.3 206121.0 206221.0 206603.0 206736.0 207804.0 52809.7 52854.0 52874.7 52992.0 54929.0 56586.7 56813.7 57437.0 57486.7 57574.7 16242.9 16433.1 16468.8 16482.0 16853.0 13829.6 13834.4 13850.6 13856.2 13883.8 13997.6 14241.5 15324.2 15326.2 15759.5 6022.7 6109.2 6120.6 6180.5 6308.9 1082.1 1089.8 1097.1 1102.3 1106.6 24805.5 24880.1 24979.6 25047.7 25082.9 1201.1 1204.8 1211.4 1212.5 1226.4 13178.6 13225.9 13349.7 13363.8 17505.4 299685.0 303472.0 303969.0 304667.0 305237.0 63322.0 63719.7 63779.0 63928.7 63955.0 1504.2 1524.5 1552.7 1555.4 1577.8 29528.9 30017.7 30139.7 30313.0 30530.2 41286.0 41440.4 41557.0 41830.8 41904.8 250844.0 252101.0 253518.0 253608.0 254946.0 35843.6 35993.5 36206.5 36219.0 36338.3 45326.5 49917.3 50427.7 50617.2 50733.5 35597.6 36287.0 36406.6 36653.6 37293.3 36814.3 37013.4 37129.4 37251.6 37303.4 42229.0 42299.0 43552.6 44635.8 44673.1 35735.6 36126.0 36209.0 36793.3 37366.6 26723.9 27783.3 27945.7 27965.7 27992.2 04:18:59 INFO - PID 10991 | 04:18:59 INFO - PID 10991 | [#2] jquery.html Cycles:180 Average:40508.54 Median:12495.28 stddev:102559.63 (820.8%) stddev-sans-first:102803.52 04:18:59 INFO - PID 10991 | Values: 582.8 585.3 588.6 591.5 596.7 23052.2 23911.6 23938.8 23966.5 23975.5 23542.0 25903.6 25912.6 25982.0 26085.6 6261.4 6398.8 6418.8 6427.0 6428.1 4258.3 4458.5 6109.1 6169.3 6182.7 6305.5 6325.1 6341.4 6353.1 6355.1 6281.8 6319.8 6347.6 6355.0 6361.6 5863.0 5931.0 5934.5 5937.4 5944.9 30052.1 31248.0 31290.8 31503.8 31734.4 2206.4 2265.8 2267.5 2268.0 2268.8 19937.8 20418.6 20471.6 20511.5 20569.6 2386.9 2411.5 2451.0 2461.4 2462.1 148546.0 154482.2 154951.0 155674.0 156253.0 15459.4 15835.0 16209.7 16327.4 16724.6 25009.0 25064.1 25068.9 25079.9 25099.4 10939.8 10970.9 11029.6 11076.1 11087.7 10173.4 10210.0 10244.7 10261.3 10282.5 9424.2 9824.9 9881.7 10191.4 10257.9 2978.7 2993.8 3003.3 3029.9 3119.2 1032.9 1033.9 1043.2 1043.6 1055.0 20831.8 20876.3 21084.6 21481.7 21746.0 1107.1 1113.1 1113.3 1136.5 1138.7 11629.5 11707.8 11821.8 11897.5 11996.5 585378.0 595894.0 615492.0 628633.0 636037.0 126668.0 130570.0 133948.0 134652.0 135842.0 1315.6 1323.7 1374.5 1376.4 1384.2 22235.6 22631.8 22632.7 22721.8 22878.2 63394.7 64348.7 64823.0 65573.7 65973.7 80366.6 83097.2 83230.6 83529.0 84836.6 13173.7 13725.7 14522.6 14878.8 15209.5 23917.9 25308.9 25370.6 25391.2 25701.0 18674.4 19340.3 19988.0 20135.1 20199.8 17156.7 17161.5 18440.9 18875.3 19362.7 19697.1 19766.5 19766.6 19819.5 19844.6 22477.6 22891.5 23189.4 23194.3 23371.6 20317.6 20653.6 20784.3 20902.8 21036.0 04:18:59 INFO - PID 10991 | 04:18:59 INFO - PID 10991 | [#3] mootools.html Cycles:180 Average:9689.16 Median:2664.31 stddev:6940.16 (260.5%) stddev-sans-first:6931.71 04:18:59 INFO - PID 10991 | Values: 1405.2 1434.8 1454.6 1464.6 1473.8 15139.0 15197.5 15781.5 15791.8 15794.7 15951.8 16223.4 16226.4 16250.7 16307.6 2699.5 2751.4 2752.5 2753.8 2758.1 2635.1 2691.7 2707.8 2730.0 2730.6 2687.9 2709.8 2715.7 2734.5 2735.0 2597.9 2640.4 2643.4 2667.2 2669.7 2639.0 2661.5 2672.7 2679.0 2684.9 15124.2 15330.3 15406.8 15496.1 15519.8 7913.7 8196.5 8234.9 8247.2 8250.1 5123.9 5302.2 5314.8 5337.4 5403.7 1945.6 1967.6 1971.3 1998.6 2014.4 26509.5 26682.7 26881.0 26927.0 26963.5 6398.2 6714.4 6772.1 6896.8 6903.6 18232.9 18288.0 18312.3 18383.9 18389.5 7806.6 8084.1 8101.8 8102.2 8106.8 7234.2 7339.6 7400.5 7428.1 7481.9 5294.9 5450.2 5524.4 5590.8 5677.3 1479.7 1522.5 1522.7 1537.3 1544.6 854.2 901.7 909.0 916.0 927.2 8399.5 8461.0 8494.5 8549.3 8605.0 739.0 740.4 751.2 753.4 816.8 5013.9 5158.7 5170.4 5191.3 5197.8 22245.7 22694.9 22791.4 22796.2 22902.2 21675.3 21745.3 21827.2 22282.0 22307.8 10629.6 10889.8 11029.8 11032.9 12076.3 8876.3 9287.9 9452.1 9520.6 9579.9 18678.6 19342.4 19777.3 19855.3 20042.0 19850.5 19935.7 20017.0 20086.3 20091.2 12465.6 12951.9 12954.7 12957.6 12964.9 14389.7 14435.6 14522.6 14536.1 14547.5 11762.1 11810.2 11919.6 12062.5 12248.7 11618.9 11675.6 11690.6 11842.7 11917.6 9967.3 10084.8 10091.9 10092.9 10094.7 7662.4 7711.4 7712.0 7782.5 7814.5 8066.5 8139.0 8206.1 8300.3 8346.3 04:18:59 INFO - PID 10991 | 04:18:59 INFO - PID 10991 | [#4] prototype.html Cycles:180 Average:5511.03 Median:6181.61 stddev:1575.27 (25.5%) stddev-sans-first:1534.38 04:18:59 INFO - PID 10991 | Values: 513.8 523.0 544.8 553.3 553.8 5947.5 6065.5 6084.3 6091.6 6124.9 5783.0 5897.4 5962.4 5991.5 6003.9 4711.5 4730.8 4732.3 4735.6 4767.3 4659.0 4707.2 4749.5 4804.6 4808.6 4664.0 4679.3 4703.5 4756.3 4761.0 4613.4 4727.1 4735.6 4758.5 4770.0 4246.5 4314.0 4325.8 4344.6 4349.9 5767.6 5821.5 5894.6 5965.3 5992.5 5641.5 5650.4 5671.6 5685.1 5712.5 6481.6 6506.9 6515.2 6520.6 6521.0 4837.7 4855.9 4882.6 4884.4 4906.4 6709.2 6797.1 6811.1 6813.8 6821.3 5040.8 5044.3 5061.7 5073.9 5103.1 5105.2 5158.0 5161.9 5181.4 5200.3 5623.2 5660.3 5698.0 5707.7 5711.3 6245.3 6299.7 6422.0 6463.3 6574.3 1697.7 1733.4 1757.4 1766.4 1775.8 1233.9 1250.8 1260.2 1260.4 1266.2 6168.7 6194.5 6254.3 6268.5 6297.2 6644.4 6689.5 6696.5 6704.5 6713.4 6311.7 6323.7 6334.3 6344.7 6345.9 3496.9 3513.7 3522.8 3525.6 3549.6 7004.4 7018.4 7019.0 7042.3 7043.3 6766.5 6865.5 6887.9 6889.3 6911.9 6964.8 6977.7 6997.0 7059.0 7066.3 6593.7 6596.0 6663.5 6701.5 6747.4 6588.8 6598.7 6616.0 6618.2 6623.7 6873.3 6897.2 6908.8 6958.5 6976.7 4964.3 5012.5 5043.0 5049.9 5078.5 6444.7 6631.2 6678.7 6690.8 6720.8 6266.2 6405.1 6415.6 6462.7 6482.9 6415.6 6453.3 6458.4 6494.4 6497.0 6302.5 6388.1 6389.9 6406.5 6454.6 6462.3 6502.6 6502.8 6520.3 6541.9 6251.5 6269.1 6284.9 6304.3 6361.0 04:18:59 INFO - PID 10991 | 04:18:59 INFO - PID 10991 | [#5] yui.html Cycles:180 Average:27093.83 Median:20462.80 stddev:38838.95 (189.8%) stddev-sans-first:38898.00 04:18:59 INFO - PID 10991 | Values: 872.0 889.3 913.2 932.7 933.4 19207.8 19975.8 19984.2 19993.5 22959.9 21520.8 21910.0 22142.8 22143.7 22179.0 1046.7 1060.9 1076.2 1077.2 1077.2 1030.8 1079.9 1084.2 1085.0 1085.7 1132.9 1149.0 1152.7 1155.0 1155.2 1142.2 1149.9 1152.9 1155.5 1156.1 833.6 837.7 838.8 839.8 841.3 20249.7 20555.8 20718.7 20752.6 20871.6 21333.8 21445.2 21679.7 22055.0 22107.0 16766.2 17032.2 17199.7 17257.2 17398.4 3600.1 3600.9 3601.0 3606.8 3608.5 151166.0 153293.2 154339.0 154906.2 155307.2 16143.7 16852.6 16877.4 16903.0 16930.0 31897.0 32048.0 32101.0 32188.0 32481.4 8098.6 8299.3 8409.0 8458.0 8830.2 4363.0 4512.6 4517.2 4518.4 4523.1 5350.4 5425.3 5443.4 5461.6 5496.1 1111.9 1139.1 1147.0 1147.0 1150.6 706.0 710.1 724.6 734.4 736.7 12383.4 12401.9 12554.7 12915.9 13567.9 718.8 731.7 740.1 744.9 750.5 5818.2 5854.2 5898.6 6087.3 6189.6 125348.4 131598.0 131995.0 133386.0 134538.0 115089.0 116495.0 117936.0 118195.4 121387.0 98434.0 99342.0 100266.5 100636.5 102307.0 12747.7 12840.1 12994.1 13108.3 13350.7 44860.0 45267.3 45482.0 45561.3 47070.1 82520.6 83958.0 84738.2 85272.1 86042.6 20113.8 20229.3 20801.8 20811.7 21004.2 21954.3 22420.7 22523.9 22646.1 22797.1 18038.9 18149.9 18234.0 18307.8 18438.4 17842.7 17900.8 17999.0 18738.2 18818.7 20369.8 20624.9 20751.9 21056.7 21067.8 14307.9 14370.4 14431.9 14515.3 14519.3 13932.4 13944.4 14037.1 14096.6 14125.7 04:18:59 INFO - PID 10991 | -------- Summary: end -------- 04:18:59 INFO - PID 10991 | 04:19:00 INFO - TEST-INFO | 10991: exit 0 04:19:00 INFO - TEST-OK | dromaeo_css | took 1108687ms 04:19:00 INFO - TEST-START | kraken 04:19:00 INFO - Initialising browser for kraken test... 04:19:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40423/getInfo.html -profile /tmp/tmp258kaQ/profile 04:19:00 INFO - TEST-INFO | started process 11358 (/builds/slave/test/build/application/firefox/firefox http://localhost:40423/getInfo.html) 04:19:05 INFO - TEST-INFO | 11358: exit 0 04:19:05 INFO - Browser initialized. 04:19:05 INFO - Running cycle 1/1 for kraken test... 04:19:05 INFO - TEST-INFO | started process 11569 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp258kaQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:06 INFO - PID 11569 | 04:19:06 INFO - PID 11569 | (/builds/slave/test/build/application/firefox/firefox:11618): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:19:06 INFO - PID 11569 | 04:19:16 INFO - PID 11569 | RSS: Main: 164655104 04:19:16 INFO - PID 11569 | 04:19:19 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40423/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:19 INFO - PID 11569 | RSS: Main: 169095168 04:19:19 INFO - PID 11569 | 04:19:22 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40423/tests/kraken/driver.html?testName=audio-dft) 04:19:23 INFO - PID 11569 | RSS: Main: 169840640 04:19:23 INFO - PID 11569 | 04:19:26 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40423/tests/kraken/driver.html?testName=audio-fft) 04:19:26 INFO - PID 11569 | RSS: Main: 164319232 04:19:26 INFO - PID 11569 | 04:19:28 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40423/tests/kraken/driver.html?testName=audio-oscillator) 04:19:29 INFO - PID 11569 | RSS: Main: 165625856 04:19:29 INFO - PID 11569 | 04:19:31 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40423/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:19:32 INFO - PID 11569 | RSS: Main: 165462016 04:19:32 INFO - PID 11569 | 04:19:35 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40423/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:35 INFO - PID 11569 | RSS: Main: 168620032 04:19:35 INFO - PID 11569 | 04:19:39 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40423/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:39 INFO - PID 11569 | RSS: Main: 170418176 04:19:39 INFO - PID 11569 | 04:19:42 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40423/tests/kraken/driver.html?testName=json-parse-financial) 04:19:43 INFO - PID 11569 | RSS: Main: 169078784 04:19:43 INFO - PID 11569 | 04:19:44 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40423/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:19:45 INFO - PID 11569 | RSS: Main: 168935424 04:19:45 INFO - PID 11569 | 04:19:47 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40423/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:19:47 INFO - PID 11569 | RSS: Main: 168914944 04:19:47 INFO - PID 11569 | 04:19:49 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40423/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:19:50 INFO - PID 11569 | RSS: Main: 166010880 04:19:50 INFO - PID 11569 | 04:19:53 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:19:53 INFO - PID 11569 | RSS: Main: 166178816 04:19:53 INFO - PID 11569 | 04:19:56 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:19:57 INFO - PID 11569 | RSS: Main: 166354944 04:19:57 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | Cycle 1(1): loaded http://localhost:40423/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40423/tests/kraken/driver.html?testName=ai-astar) 04:19:59 INFO - PID 11569 | RSS: Main: 167694336 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | __start_tp_report 04:19:59 INFO - PID 11569 | _x_x_mozilla_page_load 04:19:59 INFO - PID 11569 | _x_x_mozilla_page_load_details 04:19:59 INFO - PID 11569 | |i|pagename|runs| 04:19:59 INFO - PID 11569 | |0;ai-astar;102;106;94;106;107;107;111;107;108;109 04:19:59 INFO - PID 11569 | |1;audio-beat-detection;141;117;140;182;116;143;144;114;160;116 04:19:59 INFO - PID 11569 | |2;audio-dft;162;165;163;164;163;163;162;162;164;164 04:19:59 INFO - PID 11569 | |3;audio-fft;76;76;75;181;75;76;76;76;160;75 04:19:59 INFO - PID 11569 | |4;audio-oscillator;77;78;146;80;78;79;125;79;79;130 04:19:59 INFO - PID 11569 | |5;imaging-gaussian-blur;114;114;114;114;114;114;117;115;114;115 04:19:59 INFO - PID 11569 | |6;imaging-darkroom;148;150;150;150;148;148;148;150;148;149 04:19:59 INFO - PID 11569 | |7;imaging-desaturate;96;94;93;94;94;94;94;94;94;94 04:19:59 INFO - PID 11569 | |8;json-parse-financial;49;49;52;48;50;49;52;57;48;47 04:19:59 INFO - PID 11569 | |9;json-stringify-tinderbox;54;53;54;53;53;54;54;54;53;53 04:19:59 INFO - PID 11569 | |10;stanford-crypto-aes;83;76;74;75;74;75;76;75;76;77 04:19:59 INFO - PID 11569 | |11;stanford-crypto-ccm;119;116;134;118;115;116;123;128;116;153 04:19:59 INFO - PID 11569 | |12;stanford-crypto-pbkdf2;165;168;164;172;163;164;166;172;171;175 04:19:59 INFO - PID 11569 | |13;stanford-crypto-sha256-iterative;62;61;63;61;61;61;60;61;61;60 04:19:59 INFO - PID 11569 | __end_tp_report 04:19:59 INFO - PID 11569 | __start_cc_report 04:19:59 INFO - PID 11569 | _x_x_mozilla_cycle_collect,862 04:19:59 INFO - PID 11569 | __end_cc_report 04:19:59 INFO - PID 11569 | __startTimestamp1501759199306__endTimestamp 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | ------- Summary: start ------- 04:19:59 INFO - PID 11569 | Number of tests: 14 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#0] ai-astar Cycles:10 Average:105.70 Median:107.50 stddev:4.72 (4.4%) stddev-sans-first:4.81 04:19:59 INFO - PID 11569 | Values: 102.0 106.0 94.0 106.0 107.0 107.0 111.0 107.0 108.0 109.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:142.00 stddev:22.30 (15.7%) stddev-sans-first:23.61 04:19:59 INFO - PID 11569 | Values: 141.0 117.0 140.0 182.0 116.0 143.0 144.0 114.0 160.0 116.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 04:19:59 INFO - PID 11569 | Values: 162.0 165.0 163.0 164.0 163.0 163.0 162.0 162.0 164.0 164.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#3] audio-fft Cycles:10 Average:94.60 Median:76.00 stddev:40.31 (53.0%) stddev-sans-first:42.19 04:19:59 INFO - PID 11569 | Values: 76.0 76.0 75.0 181.0 75.0 76.0 76.0 76.0 160.0 75.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:78.50 stddev:27.12 (34.6%) stddev-sans-first:27.97 04:19:59 INFO - PID 11569 | Values: 77.0 78.0 146.0 80.0 78.0 79.0 125.0 79.0 79.0 130.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 04:19:59 INFO - PID 11569 | Values: 114.0 114.0 114.0 114.0 114.0 114.0 117.0 115.0 114.0 115.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.50 stddev:0.99 (0.7%) stddev-sans-first:1.00 04:19:59 INFO - PID 11569 | Values: 148.0 150.0 150.0 150.0 148.0 148.0 148.0 150.0 148.0 149.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.33 04:19:59 INFO - PID 11569 | Values: 96.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:49.50 stddev:2.92 (5.9%) stddev-sans-first:3.07 04:19:59 INFO - PID 11569 | Values: 49.0 49.0 52.0 48.0 50.0 49.0 52.0 57.0 48.0 47.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#9] json-stringify-tinderbox Cycles:10 Average:53.50 Median:54.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 04:19:59 INFO - PID 11569 | Values: 54.0 53.0 54.0 53.0 53.0 54.0 54.0 54.0 53.0 53.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#10] stanford-crypto-aes Cycles:10 Average:76.10 Median:76.00 stddev:2.60 (3.4%) stddev-sans-first:1.00 04:19:59 INFO - PID 11569 | Values: 83.0 76.0 74.0 75.0 74.0 75.0 76.0 75.0 76.0 77.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#11] stanford-crypto-ccm Cycles:10 Average:123.80 Median:121.00 stddev:11.98 (9.9%) stddev-sans-first:12.58 04:19:59 INFO - PID 11569 | Values: 119.0 116.0 134.0 118.0 115.0 116.0 123.0 128.0 116.0 153.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:169.50 stddev:4.22 (2.5%) stddev-sans-first:4.33 04:19:59 INFO - PID 11569 | Values: 165.0 168.0 164.0 172.0 163.0 164.0 166.0 172.0 171.0 175.0 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 04:19:59 INFO - PID 11569 | Values: 62.0 61.0 63.0 61.0 61.0 61.0 60.0 61.0 61.0 60.0 04:19:59 INFO - PID 11569 | -------- Summary: end -------- 04:19:59 INFO - PID 11569 | 04:19:59 INFO - PID 11569 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:19:59 INFO - TEST-INFO | 11569: exit 0 04:19:59 INFO - TEST-OK | kraken | took 59864ms 04:19:59 INFO - SUITE-END | took 1168s 04:19:59 INFO - Completed test suite (00:19:28) 04:19:59 INFO - javascript benchmark 04:19:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8931.733669941315, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3452.430348992415, 3479.7912125272483, 3487.9302413951727, 3491.8952431427033, 3508.280802435501, 6158.137860699506, 6223.875522489548, 6249.875002499953, 6286.654234017127, 6302.180716506859, 6145.170401995741, 6223.875522489548, 6227.43953044226, 6255.4370106690385, 6273.905891411621, 5456.208849716789, 5468.562514998801, 5543.417941116165, 5563.054280772279, 5608.971955140239, 5047.64666473347, 5390.649607775502, 5440.510354068133, 5461.208124821898, 5511.118221084627, 5373.9731301343245, 5420.593455490814, 5456.017916774979, 5466.34403871538, 5474.863128421802, 5397.811076612339, 5420.051490989061, 5497.780088796443, 5510.889782204334, 5511.118221084607, 5410.756515956791, 5413.702246376448, 5425.13197888336, 5430.5384042356445, 5435.320584926884, 6087.939120608826, 6192.411720886554, 6202.782902598387, 6220.315765265817, 6221.720022598994, 6653.933460665428, 6699.129113215251, 6713.060171575983, 6780.220274668378, 6787.151606049244, 6742.966285168592, 6771.356721111487, 6808.421284190849, 6859.2454829968665, 6860.0738900248325, 6248.094026366151, 6322.272938612026, 6329.841753956188, 6334.5249106317215, 6336.398042185985, 6895.034695142684, 6909.896351554731, 6922.134733158356, 6987.545809522365, 7020.508564400545, 6575.769848055295, 6584.9012264816065, 6604.438622717123, 6616.437602803816, 6619.238787539494, 6681.966590167115, 6727.394534491919, 6742.696578653972, 6759.155105611799, 6763.053172555846, 6551.934480655228, 6609.6364699941005, 6611.669416529155, 6693.765718199839, 6696.86606267872, 6655.600663960178, 6691.197056353171, 6691.9962005699535, 6751.122354094035, 6778.118844550177, 4905.264210368473, 4956.677815941952, 4982.576480999156, 4983.476734942778, 4983.875403114878, 4353.869383918487, 4376.840137363602, 4405.889852753643, 4412.757298348622, 4428.55714428561, 6286.151369565142, 6417.903731443938, 6419.935800642027, 6458.38645328693, 6498.870022599522, 6800.4219641330055, 6829.897551536731, 6844.349786770249, 6858.142732158481, 6859.965700171467, 6403.231612206565, 6412.871742565216, 6425.228972523327, 6491.7078731457195, 6498.187726534184, 5448.073827449343, 5543.805966791224, 5587.106063029977, 5653.547716182696, 5654.6889921054735, 7038.472114591426, 7149.356557909813, 7156.355927966508, 7162.212156662763, 7182.497225194186, 6737.427318677967, 6759.729610815512, 6818.352256535622, 6846.383825455534, 6851.2121106071445, 7039.472039596948, 7049.647517624201, 7060.364567188978, 7146.892231704094, 7156.534825236343, 6467.0, 6551.115599394211, 6566.146400968035, 6629.635370054693, 6647.6676166192465, 6783.830404239933, 6785.89821152693, 6788.626625535446, 6788.694508747217, 6833.145856767904, 6420.6147631142285, 6434.4852411806005, 6510.958246680509, 6558.967205163944, 6586.0450234714735, 6556.0, 6559.442447391834, 6568.211814582281, 6571.868562628816, 6574.737010519526, 6438.645874476949, 6471.996840489732, 6517.283098859027, 6542.313057128933, 6545.607263564201, 6510.3489651034515, 6551.181102362205, 6603.9009414859775, 6627.635480048643, 6632.4694024478895, 6326.557141000086, 6416.101745755691, 6497.480201583768, 6497.577657452251, 6507.154069971063], "value": 6134.9587517870195, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [856.9057403685593, 882.3558802074484, 907.1563445995226, 1208.2206976500158, 1238.4798384678434, 34961.300773984534, 44894.0, 45694.54305456945, 45854.312185317205, 45914.54085459145, 44902.10195796082, 45546.77226613862, 45962.54037459625, 46096.308555371696, 46183.76908115455, 7511.286427789379, 7599.658015389293, 7681.769546913573, 7682.884756728654, 7683.193264707209, 7606.125295590995, 7684.308412242897, 7695.230476952316, 7700.4224683148705, 7707.113681926594, 7140.107486564179, 7771.883421748678, 7806.414518911076, 7813.76558703237, 7824.0, 7629.542227466342, 7693.999780028616, 7696.538207707527, 7697.114831794359, 7705.922940770577, 7602.239776022354, 7603.0496187976505, 7657.4639775215755, 7688.6924523019015, 7712.305892469649, 40214.59785402138, 40533.18933621341, 40560.391594126115, 40604.59395406038, 40691.7965410171, 3354.630990591033, 3405.3529829332347, 3406.931861362759, 3408.880689175892, 3409.113630456099, 32232.677673223203, 32233.6776632233, 32407.0, 32419.0, 32439.0, 4958.454569997298, 5087.8982420351385, 5094.465081166498, 5105.106606343912, 5170.327857378555, 206121.0, 206221.0, 206603.0, 206735.9999999985, 207803.96098019564, 52809.73595132076, 52854.0, 52874.73562632162, 52992.0, 54929.0, 56586.71706641523, 56813.715931420906, 57437.0, 57486.7125664369, 57574.71212643994, 16242.944208626637, 16433.09617970999, 16468.752968705478, 16482.0, 16853.0, 13829.585112446643, 13834.446622135001, 13850.584482465541, 13856.168629882239, 13883.791743123658, 13997.580072597839, 14241.50154744579, 15324.233788310763, 15326.233688315762, 15759.527214183592, 6022.69886505673, 6109.175261339662, 6120.571559990758, 6180.536459765445, 6308.905366419507, 1082.0856376361962, 1089.809283375406, 1097.1168209591197, 1102.327580176092, 1106.5960924262586, 24805.5038899221, 24880.12919547807, 24979.62530562043, 25047.749522504542, 25082.87458562732, 1201.147185498306, 1204.777116233482, 1211.4427363412929, 1212.5210541835925, 1226.3622916083586, 13178.60464186076, 13225.933870330588, 13349.733005339838, 13363.799543006862, 17505.38731144404, 299685.0, 303472.0, 303969.0, 304667.0, 305237.0, 63322.0, 63719.681401592694, 63779.0, 63928.68035659792, 63955.0, 1504.180221779133, 1524.4588171199064, 1552.6817002514458, 1555.4400415850284, 1577.83432739563, 29528.85235573894, 30017.69982300149, 30139.698603014567, 30313.0, 30530.23674408069, 41286.0, 41440.3783943235, 41557.0, 41830.79084604557, 41904.79047604743, 250844.0, 252101.0, 253518.0, 253608.0, 254946.0, 35843.64156358507, 35993.46009809907, 36206.456903147, 36219.0, 36338.27323453569, 45326.54673453223, 49917.25124123214, 50427.74786126046, 50617.24074138964, 50733.492665072874, 35597.64402356047, 36287.0, 36406.63593364138, 36653.63346366502, 37293.25413491769, 36814.26371472609, 37013.44479832751, 37129.443058354685, 37251.62748372481, 37303.44044839384, 42229.0, 42299.0, 43552.56447435485, 44635.77682111569, 44673.10653786841, 35735.64264357323, 36126.0, 36209.0, 36793.26413471769, 37366.626333737404, 26723.866380667972, 27783.30541736473, 27945.72054279431, 27965.72034279631, 27992.160235192976], "value": 18807.94297205252, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.7581553655233, 585.3093349847179, 588.6144575303176, 591.5031373646136, 596.6539407143857, 23052.19317323894, 23911.641325380133, 23938.76061239387, 23966.520669586618, 23975.520489590243, 23542.0, 25903.611445828326, 25912.611310830307, 25982.0, 26085.608715869275, 6261.436470717635, 6398.808035758934, 6418.807435776934, 6426.967865160667, 6428.132202152719, 4258.297380932143, 4458.4872739634875, 6109.083637454395, 6169.290531588857, 6182.72177752, 6305.495560355161, 6325.051242313643, 6341.365863413645, 6353.0788035734795, 6355.1420558224745, 6281.780137695158, 6319.8104056878365, 6347.61914285142, 6355.046742988566, 6361.586496877734, 5862.97068514659, 5930.970345148246, 5934.525237980951, 5937.406259374071, 5944.851378715523, 30052.098437046923, 31248.0, 31290.843545782354, 31503.84248078745, 31734.365312693848, 2206.4263291544153, 2265.750767415583, 2267.501149747053, 2268.0247493577754, 2268.7844654757773, 19937.800621993738, 20418.5916281675, 20471.5905681887, 20511.4872128198, 20569.58860822775, 2386.9184981231533, 2411.481531470742, 2451.031842422251, 2461.4092617771785, 2462.125945289414, 148546.0, 154482.22758886247, 154951.0, 155674.0, 156253.0, 15459.371906775876, 15835.0, 16209.675806483805, 16327.428540001043, 16724.58188545296, 25009.0, 25064.12275570346, 25068.874655626605, 25079.87460062688, 25099.37251568689, 10939.83590246147, 10970.890291096986, 11029.558817647205, 11076.11391088711, 11087.667369978913, 10173.44046077473, 10210.0, 10244.743881403025, 10261.333013354108, 10282.537285822156, 9424.246060315296, 9824.852627210597, 9881.703548893545, 10191.388516689023, 10257.948410317966, 2978.657454392729, 2993.7546839870097, 3003.2642002709476, 3029.909102726922, 3119.2201949512623, 1032.9070383665505, 1033.9247182929819, 1043.2488608202082, 1043.6138628707274, 1054.9683509494728, 20831.791682083287, 20876.269330573356, 21084.578308433745, 21481.67777483339, 21746.0, 1107.0811226681835, 1113.1261959362023, 1113.3431275547466, 1136.5113001409309, 1138.7494751154732, 11629.53481860716, 11707.824382634268, 11821.763564728657, 11897.524099036114, 11996.520139194508, 585378.0, 595894.0, 615492.0, 628633.0, 636037.0, 126668.0, 130570.0, 133948.0, 134652.0, 135842.0, 1315.5921664284103, 1323.6624660711457, 1374.4845682868925, 1376.39438646995, 1384.2248340928911, 22235.555288893807, 22631.773682262967, 22632.66051009269, 22721.772782271964, 22878.199263025715, 63394.68302658457, 64348.67825661029, 64823.0, 65573.67213163903, 65973.67013164904, 80366.5981670088, 83097.16902830894, 83230.58384708037, 83529.0, 84836.57581712052, 13173.670658233621, 13725.725485490433, 14522.636934076732, 14878.776818347516, 15209.543713688607, 23917.880410597834, 25308.873455632605, 25370.619440708775, 25391.238262852145, 25701.0, 18674.439766807016, 19340.323088691828, 19988.0, 20135.093920773306, 20199.79800201979, 17156.656866862344, 17161.485155445356, 18440.907795461473, 18875.339363122224, 19362.70955935634, 19697.113629886404, 19766.50583735418, 19766.604667906275, 19819.504512387306, 19844.60310793805, 22477.550448991256, 22891.542169156855, 23189.42026449285, 23194.3041708749, 23371.649425258296, 20317.593648126658, 20653.58692826105, 20784.27255046066, 20902.790972090086, 21036.0], "value": 12926.528524104095, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1405.156905856486, 1434.7847822826575, 1454.599985004123, 1464.6045567696722, 1473.7641977283631, 15139.0, 15197.54407367778, 15781.526554203378, 15791.842081579181, 15794.684106317867, 15951.760723589156, 16223.351065957348, 16226.350945962176, 16250.674986500262, 16307.592310192222, 2699.5140874642607, 2751.408447183855, 2752.545829938058, 2753.848538330391, 2758.0760445250867, 2635.064552084011, 2691.717369676185, 2707.796915231356, 2729.959050614242, 2730.59041143828, 2687.865606719666, 2709.7561219490244, 2715.67411910571, 2734.4667789781, 2735.042735042739, 2597.921862427081, 2640.4323070539735, 2643.444876575921, 2667.1598446489293, 2669.706332303455, 2638.9604155937677, 2661.4677064586967, 2672.706002339741, 2679.0355472030055, 2684.8523331216775, 15124.243787810565, 15330.310136043905, 15406.768898466533, 15496.070235785888, 15519.767203491956, 7913.683452661887, 8196.508209507449, 8234.876476852853, 8247.21651443118, 8250.051244106944, 5123.897522049539, 5302.231176479428, 5314.787408503656, 5337.439568845254, 5403.7027963462, 1945.5816999345209, 1967.6359873423462, 1971.2903354792263, 1998.5902889907534, 2014.4258886217503, 26509.46981060368, 26682.733172668413, 26881.0, 26927.0, 26963.460730785275, 6398.200224971879, 6714.362135597111, 6772.119624448888, 6896.793096207121, 6903.585784852825, 18232.90883545574, 18288.0, 18312.267509299745, 18383.90808045951, 18389.5402614933, 7806.6096695165015, 8084.070331911906, 8101.837963240702, 8102.189781021851, 8106.837863242702, 7234.204237533867, 7339.633018349061, 7400.5189662671755, 7428.071491063617, 7481.9251807482315, 5294.867628309323, 5450.155225939986, 5524.392316845144, 5590.804321848797, 5677.318721753416, 1479.7262506436343, 1522.4823559989657, 1522.6878489909543, 1537.3235776258412, 1544.629288970639, 854.2226573817796, 901.693424235763, 909.0364213933252, 916.0335845682736, 927.2396634759433, 8399.538025408661, 8461.0, 8494.490330580185, 8549.316054715608, 8605.0, 738.9741359052407, 740.4076738609091, 751.2112282103878, 753.4236309223448, 816.7917181118777, 5013.949860501349, 5158.74206289684, 5170.353705786777, 5191.299174611455, 5197.818076367309, 22245.66631500529, 22694.886525567268, 22791.430214244778, 22796.2021329256, 22902.198423055113, 21675.34973950784, 21745.34763957084, 21827.23604673829, 22282.0, 22307.776922230896, 10629.574817007233, 10889.782204355868, 11029.779404411867, 11032.944835275934, 12076.275423474619, 8876.334274929277, 9287.860682089638, 9452.149306562442, 9520.571914212924, 9579.856302155335, 18678.626427471645, 19342.4197274082, 19777.307794227134, 19855.305064322678, 20042.0, 19850.50373740668, 19935.700964485255, 20017.0, 20086.296979605642, 20091.19635214575, 12465.563705270271, 12951.870481295067, 12954.676133096747, 12957.611271661865, 12964.870351296744, 14389.712205756035, 14435.566932992027, 14522.636934076732, 14536.127832330094, 14547.49083782105, 11762.117841161777, 11810.173287869766, 11919.642410727693, 12062.51749929993, 12248.69378265515, 11618.94190529042, 11675.591354302558, 11690.649280521598, 11842.703932401759, 11917.642470725892, 9967.25245606597, 10084.848727269244, 10091.949540252252, 10092.949535252277, 10094.697159085239, 7662.398672623858, 7711.3830893527265, 7711.9614401929875, 7782.533048017137, 7814.492058016211, 8066.475679080841, 8139.0, 8206.138355472589, 8300.294474969694, 8346.33229341639], "value": 6837.7363321632565, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.7508308470391, 522.9947700522996, 544.812039846253, 553.3387601815829, 553.8476918847314, 5947.464728174464, 6065.545084118698, 6084.330723620398, 6091.553166188685, 6124.908126378103, 5783.0, 5897.380775018625, 5962.403759624035, 5991.520678345732, 6003.909941350872, 4711.528847115278, 4730.787114579835, 4732.272720457043, 4735.573798358147, 4767.261074533453, 4659.0, 4707.199776038065, 4749.548792864673, 4804.5916097131785, 4808.5618782570455, 4664.0, 4679.251319788835, 4703.529647035286, 4756.28655701644, 4760.976195119019, 4613.354130421727, 4727.05458908218, 4735.644826638016, 4758.500357462452, 4769.952300476985, 4246.490421149451, 4313.956860431418, 4325.762083085429, 4344.587264209895, 4349.869503914888, 5767.5962682612235, 5821.478005806511, 5894.646321220697, 5965.3139888912465, 5992.520598352121, 5641.464060914206, 5650.434956504358, 5671.574631902583, 5685.147227915804, 5712.542996560265, 6481.578697384655, 6506.869862602769, 6515.218173819125, 6520.576162549419, 6521.0, 4837.7339246341435, 4855.927161092586, 4882.583121354916, 4884.3650325457465, 4906.386701662293, 6709.161354830646, 6797.116374871284, 6811.148606424197, 6813.7955861324235, 6821.294676330917, 5040.84877453677, 5044.2937988681615, 5061.746912654353, 5073.949260507421, 5103.055934652101, 5105.2342148678, 5157.9684063187515, 5161.948380516222, 5181.404138524118, 5200.297959775382, 5623.184638227516, 5660.349059858169, 5698.0398622956645, 5707.6575405475805, 5711.343195532567, 6245.344238854946, 6299.653519056405, 6421.967890160519, 6463.289038205794, 6574.342565743387, 1697.702901992171, 1733.4366330942494, 1757.4464043826154, 1766.4259115787163, 1775.8224177582138, 1233.901287896966, 1250.8311377963857, 1260.1745856463847, 1260.4139075330015, 1266.1643315411784, 6168.722407491674, 6194.5044396448175, 6254.280757712831, 6268.49852011838, 6297.1813664223355, 6644.4020038196795, 6689.464842812563, 6696.46428285736, 6704.5250044990025, 6713.429358504582, 6311.747530098744, 6323.652199129092, 6334.3032266450655, 6344.6827658616885, 6345.873082538324, 3496.8950931472095, 3513.7364697647777, 3522.788632682047, 3525.5593050868642, 3549.5917969433845, 7004.4396448284015, 7018.438524917994, 7018.964905175441, 7042.260562640951, 7043.330883566053, 6766.5263431559315, 6865.485088618374, 6887.862242755117, 6889.311068893071, 6911.861762764716, 6964.781163296301, 6977.7208911642965, 6996.985437111591, 7058.964705176441, 7066.293370662996, 6593.670316484061, 6595.967020164869, 6663.5002374821115, 6701.497387695845, 6747.433367471954, 6588.8023359299295, 6598.670066496752, 6615.956659936483, 6618.172728408949, 6623.735050597922, 6873.347032031949, 6897.206821215424, 6908.758193463204, 6958.478114141359, 6976.720931162899, 4964.280179373898, 5012.498750124958, 5043.0, 5049.924251136163, 5078.5175408336145, 6444.742210311535, 6631.204255489372, 6678.7328506859185, 6690.83272918181, 6720.764773232913, 6266.248050234001, 6405.135306733718, 6415.6471394071905, 6462.741490340334, 6482.902756458562, 6415.582987105823, 6453.290138084901, 6458.38645328693, 6494.415502604788, 6496.967515162394, 6302.464290535356, 6388.137601423934, 6389.904151437825, 6406.487481001415, 6454.612723236621, 6462.321456247027, 6502.577332473374, 6502.837429064311, 6520.315366886409, 6541.901871471837, 6251.531135164972, 6269.087928181766, 6284.937150628435, 6304.306526282014, 6361.0], "value": 5055.715421266799, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [872.0451106038887, 889.3463304471212, 913.2374467319788, 932.6595792535727, 933.4492649336894, 19207.807921920776, 19975.800241997575, 19984.200631974723, 19993.500162495908, 22959.885200573975, 21520.784792152073, 21910.0, 22142.778572214273, 22143.667844982298, 22179.0, 1046.691226088304, 1060.8939106089406, 1076.165971372185, 1077.1867240233612, 1077.219016213243, 1030.8196065688512, 1079.913606911449, 1084.1868598551087, 1084.9783004339909, 1085.6742977106837, 1132.9037031852301, 1148.9597864074758, 1152.6945359479744, 1155.0240047160137, 1155.2433156282607, 1142.194752699345, 1149.8562679665042, 1152.9250598711058, 1155.4858088150777, 1156.1271240213628, 833.5873742497442, 837.7151768398774, 838.7986883148001, 839.7816567692383, 841.3395484544603, 20249.696254556195, 20555.794442055536, 20718.689219661715, 20752.584948300948, 20871.58256834855, 21333.786662133334, 21445.249416270355, 21679.67480487794, 22055.0, 22107.0, 16766.245518951677, 17032.2335494903, 17199.742003869953, 17257.223424945907, 17398.39105631297, 3600.0999750062483, 3600.891973240807, 3601.0, 3606.8196590170387, 3608.4587311903424, 151166.0, 153293.2335338316, 154339.0, 154906.22546887308, 155307.2234638831, 16143.677126457405, 16852.57868553296, 16877.40929067477, 16902.985820850787, 16930.0, 31897.0, 32048.0, 32101.0, 32188.034358969267, 32481.35037299241, 8098.635561399751, 8299.253067223979, 8409.0, 8458.0, 8830.249428798625, 4363.0, 4512.593866552026, 4517.2094883395275, 4518.367428560005, 4523.140603285366, 5350.411454739976, 5425.321834770653, 5443.401225865152, 5461.590380721462, 5496.0931446310915, 1111.9332840029624, 1139.0602752729033, 1146.9541218351173, 1146.9885301147049, 1150.6433005768072, 705.982350441243, 710.0556260173956, 724.6159535446222, 734.4124700239787, 736.7237286017744, 12383.380830958597, 12401.875981240071, 12554.686132846751, 12915.935420323027, 13567.932160339134, 718.8023293594304, 731.6926890705917, 740.0749063670412, 744.9366803821736, 750.53091817614, 5818.243628328375, 5854.151148083504, 5898.557608179403, 6087.299960504599, 6189.597676151126, 125348.37325813313, 131598.0, 131995.0, 133386.0, 134538.0, 115089.0, 116495.0, 117936.0, 118195.40902295605, 121387.0, 98434.0, 99342.0, 100266.4986675062, 100636.4968175169, 102307.0, 12747.745045099231, 12840.110975030544, 12994.090413670952, 13108.344582770633, 13350.706925473032, 44860.0, 45267.32099018452, 45482.0, 45561.31658025066, 47070.05859882715, 82520.58739706263, 83958.0, 84738.15261847549, 85272.14727852642, 86042.56978715317, 20113.79886201178, 20229.291974780812, 20801.791982079987, 20811.687824682944, 21004.159833607097, 21954.34136975893, 22420.663690044337, 22523.887380562992, 22646.094156233565, 22797.088116475155, 18038.90980545089, 18149.909250453664, 18234.0, 18307.816921831145, 18438.35465758692, 17842.732359014884, 17900.820991789915, 17999.0, 18738.156782944527, 18818.717719233948, 20369.79630203679, 20624.896875516126, 20751.8962405187, 21056.68414973746, 21067.789322107197, 14307.856921431068, 14370.425182992563, 14431.85568144347, 14515.346809393814, 14519.346629401913, 13932.373043212878, 13944.442222310994, 14037.087589306662, 14096.647583810487, 14125.717485650435], "value": 9845.901983573858, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1485.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 106.0, 94.0, 106.0, 107.0, 107.0, 111.0, 107.0, 108.0, 109.0], "value": 105.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 117.0, 140.0, 182.0, 116.0, 143.0, 144.0, 114.0, 160.0, 116.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 163.0, 164.0, 163.0, 163.0, 162.0, 162.0, 164.0, 164.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 181.0, 75.0, 76.0, 76.0, 76.0, 160.0, 75.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 146.0, 80.0, 78.0, 79.0, 125.0, 79.0, 79.0, 130.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 117.0, 115.0, 114.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 150.0, 150.0, 148.0, 148.0, 148.0, 150.0, 148.0, 149.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 49.0, 52.0, 48.0, 50.0, 49.0, 52.0, 57.0, 48.0, 47.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 53.0, 53.0, 54.0, 54.0, 54.0, 53.0, 53.0], "value": 53.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 74.0, 75.0, 74.0, 75.0, 76.0, 75.0, 76.0, 77.0], "value": 76.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 116.0, 134.0, 118.0, 115.0, 116.0, 123.0, 128.0, 116.0, 153.0], "value": 123.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 164.0, 172.0, 163.0, 164.0, 166.0, 172.0, 171.0, 175.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 63.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 60.0], "value": 61.1, "unit": "score"}]}]} 04:20:00 INFO - Return code: 0 04:20:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:20:00 INFO - # TBPL SUCCESS # 04:20:00 INFO - Running post-action listener: _package_coverage_data 04:20:00 INFO - Running post-action listener: _resource_record_post_action 04:20:00 INFO - [mozharness: 2017-08-03 11:20:00.088228Z] Finished run-tests step (success) 04:20:00 INFO - Running post-run listener: _resource_record_post_run 04:20:00 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 24576; Write bytes: 434987008; Read time: 452; Write time: 330316 04:20:00 INFO - TinderboxPrint: CPU usage
13.1% 04:20:00 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 452 04:20:00 INFO - TinderboxPrint: I/O write bytes / time
434,987,008 / 330,316 04:20:00 INFO - TinderboxPrint: CPU idle
8,228.2 (86.9%) 04:20:00 INFO - TinderboxPrint: CPU user
1,190.7 (12.6%) 04:20:00 INFO - TinderboxPrint: Swap in / out
0 / 0 04:20:00 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 8192; Write bytes: 116219904; Read time: 224; Write time: 119612 04:20:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:20:00 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 12288; Write bytes: 318377984; Read time: 216; Write time: 210676 04:20:00 INFO - Running post-run listener: _upload_blobber_files 04:20:00 INFO - Blob upload gear active. 04:20:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:20:00 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 04:20:00 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'] 04:20:00 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 04:20:01 INFO - (blobuploader) - INFO - Open directory for files ... 04:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:01 INFO - (blobuploader) - INFO - Done attempting. 04:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:20:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:06 INFO - (blobuploader) - INFO - Done attempting. 04:20:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:20:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:20:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:07 INFO - (blobuploader) - INFO - Done attempting. 04:20:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:20:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:08 INFO - (blobuploader) - INFO - Done attempting. 04:20:08 INFO - (blobuploader) - INFO - Iteration through files over. 04:20:08 INFO - Return code: 0 04:20:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:20:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:20:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1723ad0e8474edca6c294a6f6bb1b707dac7b53f10c44323888481e357b8defb0f45956d24029c143c5dc811ef69dd82ada79863fbe57a8aa0788b8fa8c1f4c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0918a69aae1862bb319f3ac647666f7a61aab6e51e350e62e1806e7f1154e9d0ff9d8c0ac6d1b86346b61ad29d25440af84b1b9bdf0fa346c93d1a544c9bd4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52deffa7f11c16bc2fd08029a22d0e4aec44a21f594e0b19b1b556d14b2a4e062b6bcc10e1c9bb16dc031bd21f350415736ad43e1e8f84fe5e7a4c4ece9349d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a67fd805dc3a167f5d53d55a559229e78db9f33712aa680ee4dcde917abde8ec33b23a13e959fd9d76b821883d3e65f275e533ecd0bcb6e44b9664240736e639"} 04:20:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:20:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:20:08 INFO - Contents: 04:20:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1723ad0e8474edca6c294a6f6bb1b707dac7b53f10c44323888481e357b8defb0f45956d24029c143c5dc811ef69dd82ada79863fbe57a8aa0788b8fa8c1f4c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0918a69aae1862bb319f3ac647666f7a61aab6e51e350e62e1806e7f1154e9d0ff9d8c0ac6d1b86346b61ad29d25440af84b1b9bdf0fa346c93d1a544c9bd4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52deffa7f11c16bc2fd08029a22d0e4aec44a21f594e0b19b1b556d14b2a4e062b6bcc10e1c9bb16dc031bd21f350415736ad43e1e8f84fe5e7a4c4ece9349d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a67fd805dc3a167f5d53d55a559229e78db9f33712aa680ee4dcde917abde8ec33b23a13e959fd9d76b821883d3e65f275e533ecd0bcb6e44b9664240736e639"} 04:20:08 INFO - Running post-run listener: copy_logs_to_upload_dir 04:20:08 INFO - Copying logs to upload dir... 04:20:08 INFO - mkdir: /builds/slave/test/build/upload/logs 04:20:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.041558 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-03 04:20:08.564742) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 04:20:08.568135) ========= 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=3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1723ad0e8474edca6c294a6f6bb1b707dac7b53f10c44323888481e357b8defb0f45956d24029c143c5dc811ef69dd82ada79863fbe57a8aa0788b8fa8c1f4c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0918a69aae1862bb319f3ac647666f7a61aab6e51e350e62e1806e7f1154e9d0ff9d8c0ac6d1b86346b61ad29d25440af84b1b9bdf0fa346c93d1a544c9bd4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52deffa7f11c16bc2fd08029a22d0e4aec44a21f594e0b19b1b556d14b2a4e062b6bcc10e1c9bb16dc031bd21f350415736ad43e1e8f84fe5e7a4c4ece9349d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a67fd805dc3a167f5d53d55a559229e78db9f33712aa680ee4dcde917abde8ec33b23a13e959fd9d76b821883d3e65f275e533ecd0bcb6e44b9664240736e639"} build_url:https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/amWLZQNcQzCE_pLsYcu_6w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1723ad0e8474edca6c294a6f6bb1b707dac7b53f10c44323888481e357b8defb0f45956d24029c143c5dc811ef69dd82ada79863fbe57a8aa0788b8fa8c1f4c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0918a69aae1862bb319f3ac647666f7a61aab6e51e350e62e1806e7f1154e9d0ff9d8c0ac6d1b86346b61ad29d25440af84b1b9bdf0fa346c93d1a544c9bd4a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/52deffa7f11c16bc2fd08029a22d0e4aec44a21f594e0b19b1b556d14b2a4e062b6bcc10e1c9bb16dc031bd21f350415736ad43e1e8f84fe5e7a4c4ece9349d6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a67fd805dc3a167f5d53d55a559229e78db9f33712aa680ee4dcde917abde8ec33b23a13e959fd9d76b821883d3e65f275e533ecd0bcb6e44b9664240736e639"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 04:20:08.594827) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 04:20:08.595620) ========= 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=3a3620fb28aea1604ab609ef000001d2-1501757415.245232-1236120740 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004365 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 04:20:08.679747) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 04:20:08.680499) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 04:20:08.680816) ========= ========= Total master_lag: 0.16 =========