builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-069 starttime: 1502879231.83 results: success (0) revision: 0aa944d3ac94757842143a13fe66f6534817383f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:11.831677) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:11.832136) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:11.832409) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:11.847353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:11.847629) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 03:27:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.9M=0s 2017-08-16 03:27:12 (49.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127733 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:11.992964) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:11.993274) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021255 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:12.042220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:12.042526) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0aa944d3ac94757842143a13fe66f6534817383f --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 0aa944d3ac94757842143a13fe66f6534817383f --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=05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 03:27:12,676 truncating revision to first 12 chars 2017-08-16 03:27:12,676 Setting DEBUG logging. 2017-08-16 03:27:12,676 attempt 1/10 2017-08-16 03:27:12,676 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0aa944d3ac94?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 03:27:13,128 unpacking tar archive at: mozilla-central-0aa944d3ac94/testing/mozharness/ program finished with exit code 0 elapsedTime=0.787757 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:12.845972) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:12.846284) ========= script_repo_revision: 0aa944d3ac94757842143a13fe66f6534817383f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:12.849650) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:12.849914) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:12.860932) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-16 03:27:12.861199) ========= /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=05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:13 INFO - MultiFileLogger online at 20170816 03:27:13 in /builds/slave/test 03:27:13 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:27:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:13 INFO - {'append_to_log': False, 03:27:13 INFO - 'base_work_dir': '/builds/slave/test', 03:27:13 INFO - 'blob_upload_branch': 'Firefox', 03:27:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:13 INFO - 'branch': 'Firefox', 03:27:13 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:13 INFO - 'code_coverage': False, 03:27:13 INFO - 'config_files': ('talos/linux_config.py',), 03:27:13 INFO - 'default_actions': ('clobber', 03:27:13 INFO - 'read-buildbot-config', 03:27:13 INFO - 'download-and-extract', 03:27:13 INFO - 'populate-webroot', 03:27:13 INFO - 'create-virtualenv', 03:27:13 INFO - 'install', 03:27:13 INFO - 'setup-mitmproxy', 03:27:13 INFO - 'run-tests'), 03:27:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:13 INFO - 'disable_ccov_upload': False, 03:27:13 INFO - 'download_minidump_stackwalk': True, 03:27:13 INFO - 'download_symbols': 'ondemand', 03:27:13 INFO - 'enable_stylo': False, 03:27:13 INFO - 'enable_webrender': False, 03:27:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:13 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:13 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:13 INFO - 'gecko_profile': False, 03:27:13 INFO - 'gecko_profile_interval': 0, 03:27:13 INFO - 'installer_path': 'installer.exe', 03:27:13 INFO - 'log_level': 'info', 03:27:13 INFO - 'log_name': 'talos', 03:27:13 INFO - 'log_to_console': True, 03:27:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:13 INFO - 'opt_config_files': (), 03:27:13 INFO - 'pip_index': False, 03:27:13 INFO - 'suite': 'dromaeojs-e10s', 03:27:13 INFO - 'system_bits': '32', 03:27:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:13 INFO - 'title': 'talos-linux64-ix-069', 03:27:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:13 INFO - 'use_talos_json': True, 03:27:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:13 INFO - 'work_dir': 'build'} 03:27:13 INFO - [mozharness: 2017-08-16 10:27:13.597876Z] Running clobber step. 03:27:13 INFO - Running pre-action listener: _resource_record_pre_action 03:27:13 INFO - Running main action method: clobber 03:27:13 INFO - rmtree: /builds/slave/test/build 03:27:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:14 INFO - Running post-action listener: _resource_record_post_action 03:27:14 INFO - [mozharness: 2017-08-16 10:27:14.808590Z] Finished clobber step (success) 03:27:14 INFO - [mozharness: 2017-08-16 10:27:14.808692Z] Running read-buildbot-config step. 03:27:14 INFO - Running pre-action listener: _resource_record_pre_action 03:27:14 INFO - Running main action method: read_buildbot_config 03:27:14 INFO - Using buildbot properties: 03:27:14 INFO - { 03:27:14 INFO - "project": "", 03:27:14 INFO - "product": "firefox", 03:27:14 INFO - "who": "cbook@mozilla.com", 03:27:14 INFO - "installer_path": "public/build/target.tar.bz2", 03:27:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:27:14 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:27:14 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:27:14 INFO - "stage_platform": "linux64-qr", 03:27:14 INFO - "basedir": "/builds/slave/test", 03:27:14 INFO - "buildnumber": 3, 03:27:14 INFO - "platform": "ubuntu64_hw_qr", 03:27:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:27:14 INFO - "slavebuilddir": "test", 03:27:14 INFO - "taskId": "Z45xN-uYRzywHttCboCI_A", 03:27:14 INFO - "branch": "mozilla-central", 03:27:14 INFO - "script_repo_revision": "production", 03:27:14 INFO - "revision": "0aa944d3ac94757842143a13fe66f6534817383f", 03:27:14 INFO - "slavename": "talos-linux64-ix-069", 03:27:14 INFO - "repo_path": "mozilla-central" 03:27:14 INFO - } 03:27:14 INFO - Finding installer, test and symbols from parent task. 03:27:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z45xN-uYRzywHttCboCI_A'}, attempt #1 03:27:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z45xN-uYRzywHttCboCI_A'}, attempt #1 03:27:15 INFO - Task dependencies: AhttepjMRduMG8XVM9dp6A 03:27:15 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A'}, attempt #1 03:27:16 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2 03:27:16 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.test_packages.json 03:27:16 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.crashreporter-symbols.zip 03:27:16 INFO - Running post-action listener: _resource_record_post_action 03:27:16 INFO - [mozharness: 2017-08-16 10:27:16.196912Z] Finished read-buildbot-config step (success) 03:27:16 INFO - [mozharness: 2017-08-16 10:27:16.197133Z] Running download-and-extract step. 03:27:16 INFO - Running pre-action listener: _resource_record_pre_action 03:27:16 INFO - Running main action method: download_and_extract 03:27:16 INFO - mkdir: /builds/slave/test/build/tests 03:27:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:16 INFO - trying https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.test_packages.json 03:27:16 INFO - Downloading https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:27:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:27:16 INFO - Downloaded 989 bytes. 03:27:16 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:27:16 INFO - Using the following test package requirements: 03:27:16 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:27:16 INFO - u'common': [u'target.common.tests.zip'], 03:27:16 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:27:16 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:27:16 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:27:16 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:27:16 INFO - u'mozbase': [u'target.common.tests.zip'], 03:27:16 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:27:16 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:27:16 INFO - u'web-platform': [u'target.common.tests.zip', 03:27:16 INFO - u'target.web-platform.tests.tar.gz'], 03:27:16 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:27:16 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:27:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.common.tests.zip 03:27:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:27:16 INFO - Fetch https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.common.tests.zip into memory 03:27:17 INFO - Content-Length response header: 54003731 03:27:17 INFO - Bytes received: 54003731 03:27:28 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:27:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.common.tests.zip 03:27:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:27:28 INFO - Fetch https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.common.tests.zip into memory 03:27:29 INFO - Content-Length response header: 54003731 03:27:29 INFO - Bytes received: 54003731 03:27:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.talos.tests.zip 03:27:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:27:41 INFO - Fetch https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.talos.tests.zip into memory 03:27:42 INFO - Content-Length response header: 14496050 03:27:42 INFO - Bytes received: 14496050 03:27:42 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:27:42 INFO - trying https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2 03:27:42 INFO - Downloading https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:27:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:27:43 INFO - Downloaded 61888398 bytes. 03:27:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2 03:27:43 INFO - mkdir: /builds/slave/test/properties 03:27:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:27:43 INFO - Writing to file /builds/slave/test/properties/build_url 03:27:43 INFO - Contents: 03:27:43 INFO - build_url:https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2 03:27:43 INFO - Running post-action listener: _resource_record_post_action 03:27:43 INFO - Running post-action listener: set_extra_try_arguments 03:27:43 INFO - [mozharness: 2017-08-16 10:27:43.589633Z] Finished download-and-extract step (success) 03:27:43 INFO - [mozharness: 2017-08-16 10:27:43.589729Z] Running populate-webroot step. 03:27:43 INFO - Running pre-action listener: _resource_record_pre_action 03:27:43 INFO - Running main action method: populate_webroot 03:27:43 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:27:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:27:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:27:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:27:43 INFO - 'tests': ['damp', 'tps']}, 03:27:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:27:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:27:43 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:27:43 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:27:43 INFO - 'other-e10s': {'tests': ['a11yr', 03:27:43 INFO - 'ts_paint', 03:27:43 INFO - 'tpaint', 03:27:43 INFO - 'sessionrestore', 03:27:43 INFO - 'sessionrestore_many_windows', 03:27:43 INFO - 'sessionrestore_no_auto_restore', 03:27:43 INFO - 'tabpaint']}, 03:27:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:27:43 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:27:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:27:43 INFO - 'tsvgr_opacity', 03:27:43 INFO - 'tart', 03:27:43 INFO - 'tscrollx', 03:27:43 INFO - 'tsvg_static']}, 03:27:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:27:43 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:27:43 INFO - 'talos_options': ['--mitmproxy', 03:27:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:27:43 INFO - '--firstNonBlankPaint'], 03:27:43 INFO - 'tests': ['tp6_google', 03:27:43 INFO - 'tp6_youtube', 03:27:43 INFO - 'tp6_amazon', 03:27:43 INFO - 'tp6_facebook']}, 03:27:43 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:27:43 INFO - 'talos_options': ['--stylo', 03:27:43 INFO - '--mitmproxy', 03:27:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:27:43 INFO - '--firstNonBlankPaint'], 03:27:43 INFO - 'tests': ['tp6_google', 03:27:43 INFO - 'tp6_youtube', 03:27:43 INFO - 'tp6_amazon', 03:27:43 INFO - 'tp6_facebook']}, 03:27:43 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:27:43 INFO - 'talos_options': ['--stylo', 03:27:43 INFO - '--stylo-threads=1', 03:27:43 INFO - '--mitmproxy', 03:27:43 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:27:43 INFO - '--firstNonBlankPaint'], 03:27:43 INFO - 'tests': ['tp6_google', 03:27:43 INFO - 'tp6_youtube', 03:27:43 INFO - 'tp6_amazon', 03:27:43 INFO - 'tp6_facebook']}, 03:27:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:27:43 INFO - 'talos_options': ['--xperf_path', 03:27:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:43 INFO - 'tests': ['tp5n']}}} 03:27:43 INFO - Running post-action listener: _resource_record_post_action 03:27:43 INFO - [mozharness: 2017-08-16 10:27:43.598118Z] Finished populate-webroot step (success) 03:27:43 INFO - [mozharness: 2017-08-16 10:27:43.598208Z] Running create-virtualenv step. 03:27:43 INFO - Running pre-action listener: _resource_record_pre_action 03:27:43 INFO - Running main action method: create_virtualenv 03:27:43 INFO - Creating virtualenv /builds/slave/test/build/venv 03:27:43 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:27:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:27:43 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:27:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:27:43 INFO - Using real prefix '/usr' 03:27:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:27:44 INFO - Installing distribute.............................................................................................................................................................................................done. 03:27:46 INFO - Installing pip.................done. 03:27:46 INFO - Return code: 0 03:27:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:27:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:27:46 INFO - Reading from file tmpfile_stdout 03:27:46 INFO - Output received: 03:27:46 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:27:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:27:46 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:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:46 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:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:46 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 0xea11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11460b0>, '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 0x1146fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1147440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', '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:27:46 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:27:46 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:27:46 INFO - Using env: {'DISPLAY': ':0', 03:27:46 INFO - 'HOME': '/home/cltbld', 03:27:46 INFO - 'LANG': 'en_US.UTF-8', 03:27:46 INFO - 'LANGUAGE': 'en_US:en', 03:27:46 INFO - 'LOGNAME': 'cltbld', 03:27:46 INFO - 'MAIL': '/var/mail/cltbld', 03:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:46 INFO - 'MOZ_NO_REMOTE': '1', 03:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:46 INFO - 'NO_EM_RESTART': '1', 03:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:46 INFO - 'PWD': '/builds/slave/test', 03:27:46 INFO - 'SHELL': '/bin/bash', 03:27:46 INFO - 'SHLVL': '1', 03:27:46 INFO - 'TERM': 'linux', 03:27:46 INFO - 'TMOUT': '86400', 03:27:46 INFO - 'USER': 'cltbld', 03:27:46 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', 03:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:46 INFO - '_': '/tools/buildbot/bin/python'} 03:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:46 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:27:46 INFO - Cleaning up... 03:27:46 INFO - Return code: 0 03:27:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:27:46 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:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:46 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:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:46 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 0xea11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11460b0>, '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 0x1146fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1147440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', '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:27:46 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:27:46 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:27:46 INFO - Using env: {'DISPLAY': ':0', 03:27:46 INFO - 'HOME': '/home/cltbld', 03:27:46 INFO - 'LANG': 'en_US.UTF-8', 03:27:46 INFO - 'LANGUAGE': 'en_US:en', 03:27:46 INFO - 'LOGNAME': 'cltbld', 03:27:46 INFO - 'MAIL': '/var/mail/cltbld', 03:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:46 INFO - 'MOZ_NO_REMOTE': '1', 03:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:46 INFO - 'NO_EM_RESTART': '1', 03:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:46 INFO - 'PWD': '/builds/slave/test', 03:27:46 INFO - 'SHELL': '/bin/bash', 03:27:46 INFO - 'SHLVL': '1', 03:27:46 INFO - 'TERM': 'linux', 03:27:46 INFO - 'TMOUT': '86400', 03:27:46 INFO - 'USER': 'cltbld', 03:27:46 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', 03:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:46 INFO - '_': '/tools/buildbot/bin/python'} 03:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:46 INFO - Downloading/unpacking psutil>=3.1.1 03:27:46 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:27:46 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:27:46 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:27:46 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:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:27:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:48 INFO - Installing collected packages: psutil 03:27:48 INFO - Running setup.py install for psutil 03:27:48 INFO - building 'psutil._psutil_linux' extension 03:27:48 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:27:48 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:27:48 INFO - building 'psutil._psutil_posix' extension 03:27:48 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:27:48 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:27:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:48 INFO - Successfully installed psutil 03:27:48 INFO - Cleaning up... 03:27:48 INFO - Return code: 0 03:27:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:27:48 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:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:48 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:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:48 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 0xea11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11460b0>, '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 0x1146fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1147440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', '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:27:48 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:27:48 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:27:48 INFO - Using env: {'DISPLAY': ':0', 03:27:48 INFO - 'HOME': '/home/cltbld', 03:27:48 INFO - 'LANG': 'en_US.UTF-8', 03:27:48 INFO - 'LANGUAGE': 'en_US:en', 03:27:48 INFO - 'LOGNAME': 'cltbld', 03:27:48 INFO - 'MAIL': '/var/mail/cltbld', 03:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:48 INFO - 'MOZ_NO_REMOTE': '1', 03:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:48 INFO - 'NO_EM_RESTART': '1', 03:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:48 INFO - 'PWD': '/builds/slave/test', 03:27:48 INFO - 'SHELL': '/bin/bash', 03:27:48 INFO - 'SHLVL': '1', 03:27:48 INFO - 'TERM': 'linux', 03:27:48 INFO - 'TMOUT': '86400', 03:27:48 INFO - 'USER': 'cltbld', 03:27:48 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', 03:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:48 INFO - '_': '/tools/buildbot/bin/python'} 03:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:27:48 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:27:48 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:27:48 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:27:48 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:27:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:27:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:27:50 INFO - Installing collected packages: mozsystemmonitor 03:27:50 INFO - Running setup.py install for mozsystemmonitor 03:27:51 INFO - Successfully installed mozsystemmonitor 03:27:51 INFO - Cleaning up... 03:27:51 INFO - Return code: 0 03:27:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:27: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:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27: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:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:51 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 0xea11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11460b0>, '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 0x1146fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1147440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', '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:27:51 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:27:51 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:27:51 INFO - Using env: {'DISPLAY': ':0', 03:27:51 INFO - 'HOME': '/home/cltbld', 03:27:51 INFO - 'LANG': 'en_US.UTF-8', 03:27:51 INFO - 'LANGUAGE': 'en_US:en', 03:27:51 INFO - 'LOGNAME': 'cltbld', 03:27:51 INFO - 'MAIL': '/var/mail/cltbld', 03:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:51 INFO - 'MOZ_NO_REMOTE': '1', 03:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:51 INFO - 'NO_EM_RESTART': '1', 03:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:51 INFO - 'PWD': '/builds/slave/test', 03:27:51 INFO - 'SHELL': '/bin/bash', 03:27:51 INFO - 'SHLVL': '1', 03:27:51 INFO - 'TERM': 'linux', 03:27:51 INFO - 'TMOUT': '86400', 03:27:51 INFO - 'USER': 'cltbld', 03:27:51 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', 03:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:51 INFO - '_': '/tools/buildbot/bin/python'} 03:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:51 INFO - Downloading/unpacking jsonschema==2.5.1 03:27:51 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:27:51 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:27:51 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:27:51 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:27:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:27:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:52 INFO - Downloading functools32-3.2.3-2.tar.gz 03:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:27:52 INFO - warning: no files found matching '*.txt' 03:27:52 INFO - no previously-included directories found matching 'build' 03:27:52 INFO - no previously-included directories found matching 'dist' 03:27:52 INFO - no previously-included directories found matching '.git*' 03:27:52 INFO - Installing collected packages: jsonschema, functools32 03:27:52 INFO - Running setup.py install for functools32 03:27:52 INFO - warning: no files found matching '*.txt' 03:27:52 INFO - no previously-included directories found matching 'build' 03:27:52 INFO - no previously-included directories found matching 'dist' 03:27:52 INFO - no previously-included directories found matching '.git*' 03:27:52 INFO - Successfully installed jsonschema functools32 03:27:52 INFO - Cleaning up... 03:27:52 INFO - Return code: 0 03:27:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xea11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11460b0>, '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 0x1146fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1147440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', '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:27:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:27:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:27:52 INFO - Using env: {'DISPLAY': ':0', 03:27:52 INFO - 'HOME': '/home/cltbld', 03:27:52 INFO - 'LANG': 'en_US.UTF-8', 03:27:52 INFO - 'LANGUAGE': 'en_US:en', 03:27:52 INFO - 'LOGNAME': 'cltbld', 03:27:52 INFO - 'MAIL': '/var/mail/cltbld', 03:27:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:52 INFO - 'MOZ_NO_REMOTE': '1', 03:27:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:52 INFO - 'NO_EM_RESTART': '1', 03:27:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:52 INFO - 'PWD': '/builds/slave/test', 03:27:52 INFO - 'SHELL': '/bin/bash', 03:27:52 INFO - 'SHLVL': '1', 03:27:52 INFO - 'TERM': 'linux', 03:27:52 INFO - 'TMOUT': '86400', 03:27:52 INFO - 'USER': 'cltbld', 03:27:52 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', 03:27:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:52 INFO - '_': '/tools/buildbot/bin/python'} 03:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:27:53 INFO - Cleaning up... 03:27:53 INFO - Return code: 0 03:27:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:27:53 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:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:53 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:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:53 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 0xea11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11460b0>, '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 0x1146fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1147440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', '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:27:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:27:53 INFO - Using env: {'DISPLAY': ':0', 03:27:53 INFO - 'HOME': '/home/cltbld', 03:27:53 INFO - 'LANG': 'en_US.UTF-8', 03:27:53 INFO - 'LANGUAGE': 'en_US:en', 03:27:53 INFO - 'LOGNAME': 'cltbld', 03:27:53 INFO - 'MAIL': '/var/mail/cltbld', 03:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:53 INFO - 'MOZ_NO_REMOTE': '1', 03:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:53 INFO - 'NO_EM_RESTART': '1', 03:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:53 INFO - 'PWD': '/builds/slave/test', 03:27:53 INFO - 'SHELL': '/bin/bash', 03:27:53 INFO - 'SHLVL': '1', 03:27:53 INFO - 'TERM': 'linux', 03:27:53 INFO - 'TMOUT': '86400', 03:27:53 INFO - 'USER': 'cltbld', 03:27:53 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', 03:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:53 INFO - '_': '/tools/buildbot/bin/python'} 03:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:53 INFO - Downloading/unpacking blobuploader==1.2.4 03:27:53 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:27:53 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:27:53 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:27:53 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:27:54 INFO - Downloading blobuploader-1.2.4.tar.gz 03:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:27:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:27:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:54 INFO - Downloading docopt-0.6.1.tar.gz 03:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:27:54 INFO - Installing collected packages: blobuploader, requests, docopt 03:27:54 INFO - Running setup.py install for blobuploader 03:27:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:27:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:27:55 INFO - Running setup.py install for requests 03:27:55 INFO - Running setup.py install for docopt 03:27:55 INFO - Successfully installed blobuploader requests docopt 03:27:55 INFO - Cleaning up... 03:27:55 INFO - Return code: 0 03:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27: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:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27: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:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:55 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 0xea11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11460b0>, '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 0x1146fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1147440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', '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:27:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:27:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:27:55 INFO - Using env: {'DISPLAY': ':0', 03:27:55 INFO - 'HOME': '/home/cltbld', 03:27:55 INFO - 'LANG': 'en_US.UTF-8', 03:27:55 INFO - 'LANGUAGE': 'en_US:en', 03:27:55 INFO - 'LOGNAME': 'cltbld', 03:27:55 INFO - 'MAIL': '/var/mail/cltbld', 03:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:55 INFO - 'MOZ_NO_REMOTE': '1', 03:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:55 INFO - 'NO_EM_RESTART': '1', 03:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:55 INFO - 'PWD': '/builds/slave/test', 03:27:55 INFO - 'SHELL': '/bin/bash', 03:27:55 INFO - 'SHLVL': '1', 03:27:55 INFO - 'TERM': 'linux', 03:27:55 INFO - 'TMOUT': '86400', 03:27:55 INFO - 'USER': 'cltbld', 03:27:55 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', 03:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:55 INFO - '_': '/tools/buildbot/bin/python'} 03:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:55 INFO - Running setup.py (path:/tmp/pip-ygJ1JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:55 INFO - Running setup.py (path:/tmp/pip-XQiTcE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:55 INFO - Running setup.py (path:/tmp/pip-MOEGdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:55 INFO - Running setup.py (path:/tmp/pip-lUZBEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:56 INFO - Running setup.py (path:/tmp/pip-pmY4R_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:56 INFO - Running setup.py (path:/tmp/pip-M6BzLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:56 INFO - Running setup.py (path:/tmp/pip-esl7_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:56 INFO - Running setup.py (path:/tmp/pip-hZgAj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:56 INFO - Running setup.py (path:/tmp/pip-w4tcGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:56 INFO - Running setup.py (path:/tmp/pip-ZZ32Qy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:56 INFO - Running setup.py (path:/tmp/pip-aYCzF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:56 INFO - Running setup.py (path:/tmp/pip-dwN9ao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:56 INFO - Running setup.py (path:/tmp/pip-XKJhkU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:56 INFO - Running setup.py (path:/tmp/pip-zmWHEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:56 INFO - Running setup.py (path:/tmp/pip-k30kex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:56 INFO - Running setup.py (path:/tmp/pip-T2CKTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:56 INFO - Running setup.py (path:/tmp/pip-UaiD8D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:56 INFO - Running setup.py install for manifestparser 03:27:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozcrash 03:27:57 INFO - Running setup.py install for mozdebug 03:27:57 INFO - Running setup.py install for mozdevice 03:27:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozfile 03:27:57 INFO - Running setup.py install for mozhttpd 03:27:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozinfo 03:27:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozInstall 03:27:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for mozleak 03:27:57 INFO - Running setup.py install for mozlog 03:27:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:57 INFO - Running setup.py install for moznetwork 03:27:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:58 INFO - Running setup.py install for mozprocess 03:27:58 INFO - Running setup.py install for mozprofile 03:27:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:58 INFO - Running setup.py install for mozrunner 03:27:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:58 INFO - Running setup.py install for mozscreenshot 03:27:58 INFO - Running setup.py install for moztest 03:27:58 INFO - Running setup.py install for mozversion 03:27:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:58 INFO - Cleaning up... 03:27:58 INFO - Return code: 0 03:27:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27: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:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27: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:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:58 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 0xea11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11460b0>, '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 0x1146fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1147440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', '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:27:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:27:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:27:58 INFO - Using env: {'DISPLAY': ':0', 03:27:58 INFO - 'HOME': '/home/cltbld', 03:27:58 INFO - 'LANG': 'en_US.UTF-8', 03:27:58 INFO - 'LANGUAGE': 'en_US:en', 03:27:58 INFO - 'LOGNAME': 'cltbld', 03:27:58 INFO - 'MAIL': '/var/mail/cltbld', 03:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:58 INFO - 'MOZ_NO_REMOTE': '1', 03:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:58 INFO - 'NO_EM_RESTART': '1', 03:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:58 INFO - 'PWD': '/builds/slave/test', 03:27:58 INFO - 'SHELL': '/bin/bash', 03:27:58 INFO - 'SHLVL': '1', 03:27:58 INFO - 'TERM': 'linux', 03:27:58 INFO - 'TMOUT': '86400', 03:27:58 INFO - 'USER': 'cltbld', 03:27:58 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', 03:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:58 INFO - '_': '/tools/buildbot/bin/python'} 03:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:58 INFO - Running setup.py (path:/tmp/pip-XQE5R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:59 INFO - Running setup.py (path:/tmp/pip-RzHnlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:59 INFO - Running setup.py (path:/tmp/pip-q7dggj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:59 INFO - Running setup.py (path:/tmp/pip-g5e4eR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:59 INFO - Running setup.py (path:/tmp/pip-OJO6aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:59 INFO - Running setup.py (path:/tmp/pip-z7Sm1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:59 INFO - Running setup.py (path:/tmp/pip-J0R03d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:59 INFO - Running setup.py (path:/tmp/pip-E6_kIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:59 INFO - Running setup.py (path:/tmp/pip-q1VzyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:59 INFO - Running setup.py (path:/tmp/pip-5iHJXm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:59 INFO - Running setup.py (path:/tmp/pip-UTK0f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:59 INFO - Running setup.py (path:/tmp/pip-fap_qY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:59 INFO - Running setup.py (path:/tmp/pip-zf3nwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:59 INFO - Running setup.py (path:/tmp/pip-7nPgOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:59 INFO - Running setup.py (path:/tmp/pip-dSxFbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:28:00 INFO - Running setup.py (path:/tmp/pip-mtdPf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:28:00 INFO - Running setup.py (path:/tmp/pip-DERq0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:28:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:28: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 03:28: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 03:28: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 03:28: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 03:28:01 INFO - Downloading blessings-1.6.tar.gz 03:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:28:01 INFO - Installing collected packages: blessings 03:28:01 INFO - Running setup.py install for blessings 03:28:01 INFO - Successfully installed blessings 03:28:01 INFO - Cleaning up... 03:28:01 INFO - Return code: 0 03:28:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:28:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:01 INFO - Reading from file tmpfile_stdout 03:28:01 INFO - Current package versions: 03:28:01 INFO - argparse == 1.2.1 03:28:01 INFO - blessings == 1.6 03:28:01 INFO - blobuploader == 1.2.4 03:28:01 INFO - docopt == 0.6.1 03:28:01 INFO - functools32 == 3.2.3-2 03:28:01 INFO - jsonschema == 2.5.1 03:28:01 INFO - manifestparser == 1.1 03:28:01 INFO - mozInstall == 1.13 03:28:01 INFO - mozcrash == 1.0 03:28:01 INFO - mozdebug == 0.1 03:28:01 INFO - mozdevice == 0.51 03:28:01 INFO - mozfile == 1.2 03:28:01 INFO - mozhttpd == 0.7 03:28:01 INFO - mozinfo == 0.10 03:28:01 INFO - mozleak == 0.1 03:28:01 INFO - mozlog == 3.5 03:28:01 INFO - moznetwork == 0.27 03:28:01 INFO - mozprocess == 0.25 03:28:01 INFO - mozprofile == 0.28 03:28:01 INFO - mozrunner == 6.13 03:28:01 INFO - mozscreenshot == 0.1 03:28:01 INFO - mozsystemmonitor == 0.3 03:28:01 INFO - moztest == 0.8 03:28:01 INFO - mozversion == 1.4 03:28:01 INFO - psutil == 3.1.1 03:28:01 INFO - requests == 1.2.3 03:28:01 INFO - wsgiref == 0.1.2 03:28:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:28:01 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:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:01 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:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:01 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 0xea11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11460b0>, '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 0x1146fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1147440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', '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:28:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:28:01 INFO - Using env: {'DISPLAY': ':0', 03:28:01 INFO - 'HOME': '/home/cltbld', 03:28:01 INFO - 'LANG': 'en_US.UTF-8', 03:28:01 INFO - 'LANGUAGE': 'en_US:en', 03:28:01 INFO - 'LOGNAME': 'cltbld', 03:28:01 INFO - 'MAIL': '/var/mail/cltbld', 03:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:01 INFO - 'MOZ_NO_REMOTE': '1', 03:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:01 INFO - 'NO_EM_RESTART': '1', 03:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:01 INFO - 'PWD': '/builds/slave/test', 03:28:01 INFO - 'SHELL': '/bin/bash', 03:28:01 INFO - 'SHLVL': '1', 03:28:01 INFO - 'TERM': 'linux', 03:28:01 INFO - 'TMOUT': '86400', 03:28:01 INFO - 'USER': 'cltbld', 03:28:01 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', 03:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:01 INFO - '_': '/tools/buildbot/bin/python'} 03:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:28:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:28: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 03:28: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 03:28: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 03:28: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 03:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:28:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:28:03 INFO - Installing collected packages: simplejson 03:28:03 INFO - Running setup.py install for simplejson 03:28:03 INFO - building 'simplejson._speedups' extension 03:28:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:28:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:28:04 INFO - Successfully installed simplejson 03:28:04 INFO - Cleaning up... 03:28:04 INFO - Return code: 0 03:28:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:28:04 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:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:04 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:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:04 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 0xea11f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa5a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1148ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11460b0>, '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 0x1146fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1147440>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', '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:28:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:28:04 INFO - Using env: {'DISPLAY': ':0', 03:28:04 INFO - 'HOME': '/home/cltbld', 03:28:04 INFO - 'LANG': 'en_US.UTF-8', 03:28:04 INFO - 'LANGUAGE': 'en_US:en', 03:28:04 INFO - 'LOGNAME': 'cltbld', 03:28:04 INFO - 'MAIL': '/var/mail/cltbld', 03:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:04 INFO - 'MOZ_NO_REMOTE': '1', 03:28:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:04 INFO - 'NO_EM_RESTART': '1', 03:28:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:04 INFO - 'PWD': '/builds/slave/test', 03:28:04 INFO - 'SHELL': '/bin/bash', 03:28:04 INFO - 'SHLVL': '1', 03:28:04 INFO - 'TERM': 'linux', 03:28:04 INFO - 'TMOUT': '86400', 03:28:04 INFO - 'USER': 'cltbld', 03:28:04 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', 03:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:04 INFO - '_': '/tools/buildbot/bin/python'} 03:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:28:04 INFO - Cleaning up... 03:28:04 INFO - Return code: 0 03:28:04 INFO - Running post-action listener: _resource_record_post_action 03:28:04 INFO - Running post-action listener: _start_resource_monitoring 03:28:04 INFO - Starting resource monitoring. 03:28:04 INFO - [mozharness: 2017-08-16 10:28:04.458678Z] Finished create-virtualenv step (success) 03:28:04 INFO - [mozharness: 2017-08-16 10:28:04.459191Z] Running install step. 03:28:04 INFO - Running pre-action listener: _resource_record_pre_action 03:28:04 INFO - Running main action method: install 03:28:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:28:04 INFO - Reading from file tmpfile_stdout 03:28:04 INFO - Detecting whether we're running mozinstall >=1.0... 03:28:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:28:04 INFO - Reading from file tmpfile_stdout 03:28:04 INFO - Output received: 03:28:04 INFO - Usage: mozinstall [options] installer 03:28:04 INFO - Options: 03:28:04 INFO - -h, --help show this help message and exit 03:28:04 INFO - -d DEST, --destination=DEST 03:28:04 INFO - Directory to install application into. [default: 03:28:04 INFO - "/builds/slave/test"] 03:28:04 INFO - --app=APP Application being installed. [default: firefox] 03:28:04 INFO - mkdir: /builds/slave/test/build/application 03:28:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:28:22 INFO - Reading from file tmpfile_stdout 03:28:22 INFO - Output received: 03:28:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:22 INFO - Running post-action listener: _resource_record_post_action 03:28:22 INFO - [mozharness: 2017-08-16 10:28:22.808640Z] Finished install step (success) 03:28:22 INFO - [mozharness: 2017-08-16 10:28:22.808927Z] Running setup-mitmproxy step. 03:28:22 INFO - Running pre-action listener: _resource_record_pre_action 03:28:22 INFO - Running main action method: setup_mitmproxy 03:28:22 INFO - Skipping: mitmproxy is not required 03:28:22 INFO - Running post-action listener: _resource_record_post_action 03:28:22 INFO - [mozharness: 2017-08-16 10:28:22.810124Z] Finished setup-mitmproxy step (success) 03:28:22 INFO - [mozharness: 2017-08-16 10:28:22.810346Z] Running run-tests step. 03:28:22 INFO - Running pre-action listener: _resource_record_pre_action 03:28:22 INFO - Running pre-action listener: _set_gcov_prefix 03:28:22 INFO - Running main action method: run_tests 03:28:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:22 INFO - Python 2.7.3 03:28:22 INFO - Return code: 0 03:28:22 INFO - grabbing minidump binary from tooltool 03:28: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:28:22 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 0x11460b0>, '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 0x1146fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1147440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:22 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 03:28:22 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 03:28:22 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 03:28:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:22 INFO - Return code: 0 03:28:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:22 INFO - ENV: RUST_BACKTRACE is now full 03:28:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:22 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/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:28:22 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/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:28:22 INFO - Using env: {'DISPLAY': ':0', 03:28:22 INFO - 'HOME': '/home/cltbld', 03:28:22 INFO - 'LANG': 'en_US.UTF-8', 03:28:22 INFO - 'LANGUAGE': 'en_US:en', 03:28:22 INFO - 'LOGNAME': 'cltbld', 03:28:22 INFO - 'MAIL': '/var/mail/cltbld', 03:28:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:22 INFO - 'MOZ_ACCELERATED': '1', 03:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:22 INFO - 'MOZ_NO_REMOTE': '1', 03:28:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:22 INFO - 'MOZ_WEBRENDER': '1', 03:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:22 INFO - 'NO_EM_RESTART': '1', 03:28:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:22 INFO - 'PWD': '/builds/slave/test', 03:28:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:22 INFO - 'RUST_BACKTRACE': 'full', 03:28:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:28:22 INFO - 'SHELL': '/bin/bash', 03:28:22 INFO - 'SHLVL': '1', 03:28:22 INFO - 'TERM': 'linux', 03:28:22 INFO - 'TMOUT': '86400', 03:28:22 INFO - 'USER': 'cltbld', 03:28:22 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921', 03:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:22 INFO - '_': '/tools/buildbot/bin/python'} 03:28:22 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/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:28:23 INFO - mozversion application_buildid: 20170816092056 03:28:23 INFO - mozversion application_changeset: 0aa944d3ac94757842143a13fe66f6534817383f 03:28:23 INFO - mozversion application_display_name: Nightly 03:28:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:23 INFO - mozversion application_name: Firefox 03:28:23 INFO - mozversion application_remotingname: firefox 03:28:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:28:23 INFO - mozversion application_vendor: Mozilla 03:28:23 INFO - mozversion application_version: 57.0a1 03:28:23 INFO - mozversion platform_buildid: 20170816092056 03:28:23 INFO - mozversion platform_changeset: 0aa944d3ac94757842143a13fe66f6534817383f 03:28:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:28:23 INFO - mozversion platform_version: 57.0a1 03:28:23 INFO - using testdate: 1502879303 03:28:23 INFO - actual date: 1502879303 03:28:23 INFO - starting webserver on 'localhost:36262' 03:28:23 INFO - SUITE-START | Running 2 tests 03:28:23 INFO - TEST-START | dromaeo_css 03:28:23 INFO - Initialising browser for dromaeo_css test... 03:28:23 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36262/getInfo.html -profile /tmp/tmp_bvD5Z/profile 03:28:23 INFO - TEST-INFO | started process 2221 (/builds/slave/test/build/application/firefox/firefox http://localhost:36262/getInfo.html) 03:28:30 INFO - TEST-INFO | 2221: exit 0 03:28:30 INFO - Browser initialized. 03:28:30 INFO - Running cycle 1/1 for dromaeo_css test... 03:28:30 INFO - TEST-INFO | started process 2530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_bvD5Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:31 INFO - PID 2530 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:28:31 INFO - PID 2530 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:28:31 INFO - PID 2530 | 03:28:31 INFO - PID 2530 | (/builds/slave/test/build/application/firefox/firefox:2589): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:28:31 INFO - PID 2530 | 03:28:41 INFO - PID 2530 | RSS: Main: 196030464 03:28:41 INFO - PID 2530 | 03:28:45 INFO - PID 2530 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:31:42 INFO - PID 2530 | Cycle 1(1): loaded http://localhost:36262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36262/tests/dromaeo/cssquery-ext.html) 03:31:43 INFO - PID 2530 | RSS: Main: 225157120 03:31:43 INFO - PID 2530 | 03:34:45 INFO - PID 2530 | Cycle 1(1): loaded http://localhost:36262/tests/dromaeo/cssquery-ext.html (next: http://localhost:36262/tests/dromaeo/cssquery-jquery.html) 03:34:45 INFO - PID 2530 | RSS: Main: 276492288 03:34:45 INFO - PID 2530 | 03:37:47 INFO - PID 2530 | Cycle 1(1): loaded http://localhost:36262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36262/tests/dromaeo/cssquery-mootools.html) 03:37:48 INFO - PID 2530 | RSS: Main: 278097920 03:37:48 INFO - PID 2530 | 03:40:50 INFO - PID 2530 | Cycle 1(1): loaded http://localhost:36262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36262/tests/dromaeo/cssquery-prototype.html) 03:40:51 INFO - PID 2530 | RSS: Main: 276348928 03:40:51 INFO - PID 2530 | 03:43:55 INFO - PID 2530 | Cycle 1(1): loaded http://localhost:36262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36262/tests/dromaeo/cssquery-yui.html) 03:43:55 INFO - PID 2530 | RSS: Main: 280301568 03:43:55 INFO - PID 2530 | 03:46:58 INFO - PID 2530 | Cycle 1(1): loaded http://localhost:36262/tests/dromaeo/cssquery-yui.html (next: http://localhost:36262/tests/dromaeo/cssquery-dojo.html) 03:46:58 INFO - PID 2530 | RSS: Main: 280784896 03:46:58 INFO - PID 2530 | 03:46:58 INFO - PID 2530 | __start_tp_report 03:46:58 INFO - PID 2530 | _x_x_mozilla_page_load 03:46:58 INFO - PID 2530 | _x_x_mozilla_page_load_details 03:46:58 INFO - PID 2530 | |i|pagename|runs| 03:46:58 INFO - PID 2530 | |0;dojo.html;3164.0982320038793;3171.0645359618925;3189.681031896809;3196.760242981776;3224.9193770155744;5963.821085367446;6059.212302400692;6073.48375388092;6113.847153821145;6131.877362452754;6039.788607398742;6156.507479401637;6157.107219453176;6168.290646575645;6186.041163619635;5616.073347897592;5645.407232240617;5650.802221922234;5656.717164141787;5690.573207009491;5680.147977803321;5687.943120568803;5689.6586204827845;5710.7715691372505;5717.914231286534;5641.774329026834;5665.1785491103765;5676.716164191774;5678.48893599576;5687.459691329317;5634.577406694514;5651.9152212716635;5686.118651609007;5715.485606295411;5757.65454072757;5572.247746554204;5642.238297829823;5664;5703.600747947646;5706.087026075808;6021.397860213988;6049.395060493959;6067.453929146354;6095.847603809896;6180.567360284782;6473.83815404614;6537.117489138953;6607.438367738748;6620.106285651472;6620.735170593171;6606.8017959461295;6643;6710.966445167792;6728.428083612899;6817.113775209241;6175.2898416681755;6199.442050215503;6203.2556093268195;6260.280067792217;6270.372962703739;6574.934250657528;6730.798076057726;6746.392824645707;6747.932520674829;6841;6506.707198176094;6512.41388275048;6559.47524198063;6560.770373036921;6573.04690819838;6534.575252608565;6638.502112341594;6654.13496245485;6654.933450665529;6660.533762636665;5678.772849086073;6565.901511477332;6577.3422657733845;6613.404793568602;6677.699503522354;6609.966950165314;6613.570117942319;6671.299513551105;6719.496037797185;6721.193456785119;5318.9202161967605;5359.517643412111;5408.972955135199;5441.292631957899;5442.401335853053;4577.3362862384765;4646.4191976003;4668.253079507263;4680.438347398266;4717.457492388351;5741.62679425836;5750.022496175577;5811.3026436827;5830.038043722823;5831.7667293307795;6477.1579694639395;6643.269240383554;6645.2025756908515;6735.831604209934;6754.425873800782;5632.690202038845;5645.858853528694;5684.77260909559;5758.424157584292;5792.768289268466;5899.967505686488;5971.671558064349;6013.819585412444;6019.067044608093;6023.819285421444;6429.067785171124;6452.838679033061;6540.182477190351;6542.0186971953635;6548.672566371567;6548.116004339353;6644.069830223676;6657.167854018247;6664.766733164316;6670.166229221348;6406.967965160145;6414.486841052798;6436.742530298736;6437.903431448438;6439.549231553746;6452.774152904626;6517.250516190509;6552.312007239171;6563.442107420923;6563.474922006132;6582.572132811543;6641.734330626914;6665.33346665349;6672.366125218096;6681.09805176295;6463.482921366373;6513.609183449008;6545.869082618226;6558.147440832852;6576.736930522726;6462.773802916875;6487.481001519773;6548.672566371758;6577.079208910852;6582.078509008838;6393.328700486382;6420.6468644225015;6460.063290822898;6492.448141907991;6501.512386570931;6442.516811239082;6546.083548303337;6560.475161987125;6602.40578347951;6640.701168447528;6204.81385558434;6250.937490625036;6269.153664255267;6285.465735412358;6309.463695585927 03:46:58 INFO - PID 2530 | |1;ext.html;823.201494550286;833.0420016980476;864.2178828160514;886.8935727712671;891.0643823984816;40397.596024039754;41223.79388103055;41281.58718412815;41309;41444.37833432501;36992.44511332332;37139.62860371396;37228.069298267554;37291.25417491649;37409.81295093527;6652.733890644393;6652.833679158023;6679.532432729711;6755.628440435774;6768.661566921659;6594.274629790719;6613.503987200979;6641.435477984353;6686.699098540553;6713.462922966151;6686;6762.289959554249;7283.7086516539275;7505.249475052506;7518.661660225275;7363.521371110861;7409.333160015598;7437.293457121592;7478.588677622729;7484.887726684104;7147.964260178718;7246.565206087652;7431.665575049135;7443.925560744432;7474;37499.62500374988;37914.810425947966;37960.24079518394;38000.80999595012;38088.23823523514;3438.1404648837793;3478.339115568034;3479.1823921378455;3484.8780292689635;3504.8247587620517;30644.233894152603;30671.233219169477;30725.231869203224;30741;30955;4751.857444276678;5017.54842064216;5029.823956161554;5041.6722913010535;5059.797608095671;180864;182154;184641;188900;190899;45101.548984510395;46023.539764602596;46030.07939841251;46175.5382446178;46250.5374946253;48344.27483587749;48833;48965.755171223915;49124.508754912706;49133.26300105501;15092.698146037017;15487.5353739388;15504.457343992906;15578.143202123765;15675.686486270211;12884.80672789909;13007.089503734647;13009.21944683322;13017.284049377186;13029.15310504814;12951.740965180643;13058.608241752763;13134.60596182116;13150.60548183537;13272.800907986388;5392.433794451605;5441.183822426668;5452.40023597404;5512.947983232321;5546.944530554642;956.9665061722807;982.6855406270068;998.3061772068488;1003.4029752297372;1023.7338292043974;22620.886895565418;23354.64968025481;28869.71130288712;29707;29940;1052.2949623752104;1078.132103656564;1086.7554800169898;1094.9761972555686;1099.6371197504805;12652.987760979284;12727.554535591209;12754.61736147917;12836.229826210458;12995.545155919686;235512;236811;238649;238928;240020;52744;52924;53052.20421693601;53161.202581961305;53181.2022819658;1396.11346794784;1470.272215253435;1477.8152730908637;1480.370842391979;1482.888783341232;23008.309750707507;23290.53418931646;23377.88311058434;23420.648690269318;23422.180223692772;38284.61715382922;38573.22853542857;38689.80655096706;38786.4182037264;38816.02959926025;216937;217350;218035;218096;219192;33560;33962;34001.48997764986;34376.48435273423;34447;43213.567864320954;43617.78191109024;43776.781116094215;45977.54022459866;47200.29199562078;34554.13614659654;34738.131546711535;34760.304793904485;34837;35047.64952350546;33446.498302525;33716.42916722783;33802.66197337995;33968;34151.487727683605;37432.625673742914;37510;37710.43434348432;37796.24407511889;37801.62198378091;32536.83731581327;33212;33510.83244583859;33648.83175584106;33803.492947605315;22789.658155128018;24054.63918041196;24223.152189673983;24366.51266974686;24841.25476235716 03:46:58 INFO - PID 2530 | |2;jquery.html;558.9664620122793;568.5139205978891;570.4837122404223;574.893644675735;585.8886811505813;21710.674339884914;22438.43903902401;22440.102395904185;22440.438989025282;22544.098236070557;25684.486310273784;28416.573751393746;28489.287767805814;28533.42933141336;28762.568561471595;6965.477589180807;7024.473164512682;7115.252898445667;7129;7131.037309963166;6102.176206212172;6754.729810807562;6957.860842783141;7028.683709233097;7043.36609705129;6736.494762892778;6741.089952856375;6743.527953043289;6750.898736518956;6780.186377634691;6715;6722.731090756364;6730.5625134366355;6738.427233685143;6745;6583.07836902834;6625.768098116543;6639.838028345021;6643.568168069109;6658.633775142365;30982.84508577443;32067;32230.838845805854;32606.6739332606;32747;1974.4372853736759;2000.649886269897;2008.839292856568;2010.5878294949646;2016.7176595276674;20012.69980950287;20680.276190333265;20722.378328650164;20900.686489702668;20942.5811483771;2392.234484964812;2425.9757402426103;2517.8669598680485;2521.8865151068244;2522.8107891908;140745.296273519;143014;145662.27168864195;145924;145996.27001865028;20353.031158924165;21258.78741212599;21409.57180856374;21730.78269217319;22606.66090008651;43879.12241755147;44237.557624423345;44322.55677443184;44408;44503.55496445059;9901.60393584263;10117.672935224793;10287.537060832281;10393.636222732168;10530.684079477474;9509.33434659581;9527.90472095284;9544.809103817885;9617.23062155026;9657.631883496417;9077.818443631222;9375.156235938799;9467.242620590336;9491.288153388385;9737.610495580238;2654.6283520307175;2699.163259389556;2705.1884434669914;2751.7798576114265;2797.538406163001;957.6887511558771;970.9514524273899;988.8071825994006;992.4739887859446;997.3915911294105;20297.28959486411;20368.69446958297;20505.2823151192;20635.58728825445;20840;1009.2027298434155;1018.5314755212537;1024.3700124423426;1029.8661174047327;1031.1544533482622;11321.547138114547;11410.315381077162;11499;11536.192466527431;11539.307641541534;435426;440233.1137479089;449690;451046;456773;102836;105145;105840.47079764552;106481;109764.4511777436;1146.8337091121741;1161.1175506615034;1179.6520026592175;1195.6771671648605;1208.3958020989505;17663.470095897144;17936.372226971995;18125.818741812414;18148.092595370443;18488.445346639623;54036;54633.72683136559;54706.90586188174;55282.17076743772;56611.43388566226;71332;71699.28300716926;71803;72084.63957680178;72787;13582.320883955565;14477.420903163755;14520.636984075483;14546.418143274574;14582.562523124323;22953.540929181658;23338.416539586648;23362.182323618592;23382.76617233806;23913.16303929354;18288.359907403177;18367.448976530726;18387.356442524448;18453.16960736797;18632.627347453246;16303;17101;17132.057736824594;17162.570935726708;17501.21244544024;18937.621247575247;19274;19341.806581934;19368.612627747083;19385.709214361515;14565;14589;14607.92696036513;14651.633709157357;14659.70680586361;17297.481075567754;18013.369532066314;18182.545436363667;18444.538886527946;18446.815531845048 03:46:58 INFO - PID 2530 | |3;mootools.html;1315.4343632238138;1352.5130952856969;1371.0402718097334;1375.938082786274;1385.4250486048288;14103.929480352597;14738.263086845654;14788.704225915475;14797.186154761484;14810;14123.152610843357;15434.459793907215;15461.30424130914;15477.303521341539;15544;2686.7716244119274;2752;2753.105240796739;2755.3249453883827;2755.3249453883827;2541.453587478701;2627.4745050989877;2685.0602289198723;2722.904698335549;2729.6314997475283;2633.47330533894;2652.4827658606578;2656.282803643015;2680.437108207269;2682.1953413975825;2489.601663733803;2541.733118022609;2609.20419272121;2663.2676014096087;2663.387420893205;2548.967668094425;2573.1508602161243;2580.045383208206;2593.4164812917134;2600.8959641614315;14083.436662533486;14280.785788213081;14325.068870523382;14398.568042958728;14487.275636218146;7350.4854660173805;7570.810729731746;7632.236776322379;7635.236476352376;7652.655630496641;4977.1538838397555;5265.631405801595;5419.051665958442;5456.836294911159;5477.890442191174;1873.8875667459995;1889.0743535667561;1892.2147308866804;1938.9127489262876;1970.330087770165;24120.396990075213;24271.029158833626;24283.392915177086;24315.513689726282;24348.147814826574;6937.410320122745;7256.310650488195;7263.745768898063;7273.23631018746;7278.927210727825;16357.509274721777;16499.257533411026;16556.172191390622;16669.66660666804;16690.83309166917;7408.814779630445;7484.775456736198;7501.699932002768;7524.699012039458;7944.920550794418;6805;6972.058772065706;7024.26245244242;7041.859162816715;7099.183593886666;5317.335333083364;5362.973185134049;5420.186971954159;5424.918626220609;5459.645123066988;1507.5652820694718;1515.7499012662788;1529.9235038248044;1536.5236776599068;1541.306412114553;865.5499140446932;898.3666515106834;904.6697955246419;911.2846415563884;918.3479729392072;7530.510516816389;7644.6942122315595;7678.385729141767;7733.613319334123;7796.766097016985;727.5271073801965;728.4463807506334;732.809469537924;745.1244787374922;746.6266866566716;5054.566341183243;5298.417174110845;5351.117065684196;5477.4248703886315;5528.253685752452;19978.10098545569;20694.896525517277;20842.89578552128;20900.059497322658;20912;20128.29550965709;20531.897340513202;20778.688319675217;20794.27220047291;20835.374938751862;11272.985431311221;11283.323000619988;11286.774264514665;11316.094712422986;11319.717007074889;7829.765107046797;8330.125336839787;8389.244967952669;8401.243888049861;8425.578721064045;17435.738463922797;17712.202950866984;17783.644327113125;18146.909265454116;18325.54186145357;18327.17527711283;18338.174782135102;18355.35756248525;18434.446966591022;18753.812461875208;10560.577576896838;10785.352878827296;10797.082248009006;10798.946005269923;10830.350178989285;13313.134646247963;13329.333533323488;13573.321333933462;13583.252921089435;13657.317134143055;10768.407737574194;11152.219344645797;11343.602973895873;11398.031167350537;11499.19505634631;10965;11050.668479945614;11112.055475284691;11142.331460112418;11206.663800086011;9703.12671859536;9806.21550275962;9822.410655360702;9925;9928.702138935843;7052.188998265266;7151.356377926011;7188.928110718826;7254.600996945219;7371.152317483344;7084.433245340258;7266.273372662691;7428.145763237297;7438.256174382518;7470.8505829882015 03:46:58 INFO - PID 2530 | |4;prototype.html;505.2043032224243;507.66494113884846;516.0298638559509;530.7478947499935;538.8706710389507;6136.601120927136;6173.413525715056;6218.906716399252;6230.688465576725;6258.780942667007;6049.697515124249;6050.485708714754;6058.939410605893;6081.78713745019;6124.744427392385;4784.545468180535;5010.2964991902745;5028.647994640377;5086.287919691246;5091;4878.804847806084;4928.43323017854;4931.975340123295;4958.603311735071;4979.128652485819;4846.297286893398;4859.246816743411;4900.471660404503;4901.509849015088;4926.778294976734;4789.491310237281;4831.22700367943;4868.951310486886;4922.95697285626;4924.901501969976;4404.735715857027;4434.933475997863;4442.111577684476;4444.511103778582;4454.175977444183;6034.702538954146;6036.245469316335;6044.219658956885;6045.458408105905;6089.756409743605;5600.383957764642;5604.3835178130785;5626.493615574618;5677.858053548653;5686.971565142189;6447.2263328400895;6487.772927947499;6504.089427480157;6560.737570497175;6595.340465953366;4851.927221091686;4858.149823780859;4877.829275975324;4887.3402090717655;4895.388076490439;6515.934840651627;6563.737450501974;6625.97907638175;6811.148606424197;6957.304269573002;4924.679895806833;4949.257611358325;4951.628627852925;4961.479044700327;4997.9750101249265;5025.517472345667;5077.1876499759865;5092.745362731848;5116.616253780981;5130.48695130484;5607.663540187602;5619.157126431068;5633.2395126657375;5670.432956704297;5683.403242659461;6602.73589056442;6623.4701223901975;6627;6629.469642428594;6677;1774.97337539937;1775.5916139288036;1778.0309731196528;1783.2064731194494;1786.8481179099922;1166.7783121206944;1213.7026428525069;1219.987410449325;1224.1430998301225;1267.075035224273;5563.415841336682;5763.077907534775;5794.62334948227;5795.217645617788;5809.912851307234;6671.266160722316;6702.296258892844;6719.529632925648;6756.324367563205;6759.459243260528;5703.62926409782;5778.855528611818;5787.739551720183;5794.478496935296;5804.94195058044;3535.398982173037;3584.874529391459;3587.121155316964;3589.371859924555;3606.945895811565;6510.47916166715;6520.217573891068;6547;6609.173853268341;6629.701663425158;6794.490413219029;6835.069834844984;6881.931180688129;6883.414909732729;6900;6386.690728400667;6427.807165785034;6473.514486413444;6486.189226346707;6510.283868774431;6117.593746459663;6619.106420633153;6662.933370666231;6668.799296232135;6690.19717633887;6551.737930482918;6627.536072474881;6646.734130634721;6664.83337916556;6683.365080317362;6422.454091402283;6445.709943052668;6451.387118223761;6530.08578798978;6554.4756419487285;4898.632602554751;4983.900321993612;4993.700377977188;5001.473960857659;5014.874628134326;6394.26465956421;6602;6661.533692641468;6715.630640314829;6727.159105111861;6421.71102300407;6514.934850651623;6547.574407663677;6571.244306904767;6575.342465753386;6366.090172948005;6496.252930912817;6511.34886511364;6525.2169739631545;6596.80209593713;6450;6454.773593017312;6487.307767276528;6508.381703738138;6542.771003014872;6503.707333169924;6515.804525864231;6600.966995164993;6619.3380661933425;6624.317151553629;6298.984469831392;6338.904916426165;6361.713722882574;6376.840578985562;6384.297727249906 03:46:58 INFO - PID 2530 | |5;yui.html;880.9515476648786;896.5248418338281;899.6401439424234;904.6471875968374;925.2228128372166;18207.635847283047;18805.90597047016;18855;18989;18992.905035474836;17785.11074446279;18684.906575467103;21928.122875084977;22030.11879524821;22295.21966731165;1037.891021442749;1067.7117178361837;1068.2575609951086;1069.0645685025602;1072.1904961753864;1059.1738444013681;1063.2079101069676;1065.733566608348;1069.3904474449566;1074.5809134437575;999.9000099990016;1087.4508373271487;1095.1731442760704;1097.9066779323766;1125.94370281486;1098.56606640377;1101.4547798839546;1105.011015141444;1107.0092267420653;1109.8612673415823;798.59271771397;799.4963173200904;804.0311424733183;804.8269622031291;805.5690205739901;19528.414147575597;19774.90112549428;19782.604347913104;19787.109580068933;20811.895940520353;20794;20891.791082089137;21172.470688232763;21398.35804925839;21426.357209283746;15412.22938853064;15424.383024678998;15739;15745.685086298325;15746.2126893656;3559.519464872235;3592.7305452091196;3595.424732042861;3602.5496812898386;3611.819409029538;119573;122545;124372;126160;129055.35472322672;17331.480055598353;17562.20970056325;17611.911940440215;17966.101694915204;17969.910150449425;30193.245168870955;31331.686683132877;31571.36857262842;31605.051848444582;31876.840615796773;9148.085191480932;9150.7646467726;9210.171084602418;9229.446233226028;9237.30720195988;4232.047789247395;4268.103698223345;4321.351797230441;4326.502452217972;4327.37253098299;5256.737163141827;5318.095923692981;5350.812721554805;5374.35507739066;5402.972985135128;1037.8443233515034;1057.1278695076592;1075.408525311076;1078.5200585739428;1079.3200283821143;634.429013887505;651.3388910256094;652.5399593286721;664.4916638771343;675.5777638975641;11700.94149529264;12054.638360849189;12167.391630418444;12209.877901220874;12491.625251242478;652.846581053452;654.1561385812344;665.8934570468701;669.8358902069024;673.017394603874;5344.198370244494;5348.171033489815;5381.596380271495;5400.351957765093;5462.8361149165585;114381;115949;116128.41935790436;116394.41802790931;120738;101066;101881;102724;103028;107304.46347768212;86584;88237.55881220553;89593;91237;92295.5385223083;10264.127549158406;10273.332233404804;10303.639372621923;10409.011143941616;10537.209709271989;39194.60805392024;39297;40302.39546406748;41153;41168.38247426351;51007.48992510027;51815.481845181064;52036.73981630067;52230;52318.21522677239;16010.9199454002;16114.67770644604;16141.838581614034;16199.43301984425;16272.267747951608;17491.12544372751;17764.822351776318;17833;17843.37548185807;17923.37268195607;16305.347786088423;16376.344946202018;16405.58986025359;16455;16523.504294871174;16513.83486165123;16583.91708041452;16653.3338666452;16656.750148747535;16855.747163792308;15061.397544098114;15063.246837658293;15379.231038448257;15465.304061317493;15550.455734049254;11718;11807.881921180679;11968.341741204318;12044.397780110785;14396.496122635657;14467.131972081708;14746.262686865828;15277.236138193268;15523.456679016632;15735.842641573438 03:46:58 INFO - PID 2530 | __end_tp_report 03:46:58 INFO - PID 2530 | __start_cc_report 03:46:58 INFO - PID 2530 | _x_x_mozilla_cycle_collect,377 03:46:58 INFO - PID 2530 | __end_cc_report 03:46:58 INFO - PID 2530 | __startTimestamp1502880418342__endTimestamp 03:46:58 INFO - PID 2530 | 03:46:58 INFO - PID 2530 | ------- Summary: start ------- 03:46:58 INFO - PID 2530 | Number of tests: 6 03:46:58 INFO - PID 2530 | 03:46:58 INFO - PID 2530 | [#0] dojo.html Cycles:165 Average:6109.12 Median:6406.97 stddev:707.58 (11.0%) stddev-sans-first:670.97 03:46:58 INFO - PID 2530 | Values: 3164.1 3171.1 3189.7 3196.8 3224.9 5963.8 6059.2 6073.5 6113.8 6131.9 6039.8 6156.5 6157.1 6168.3 6186.0 5616.1 5645.4 5650.8 5656.7 5690.6 5680.1 5687.9 5689.7 5710.8 5717.9 5641.8 5665.2 5676.7 5678.5 5687.5 5634.6 5651.9 5686.1 5715.5 5757.7 5572.2 5642.2 5664.0 5703.6 5706.1 6021.4 6049.4 6067.5 6095.8 6180.6 6473.8 6537.1 6607.4 6620.1 6620.7 6606.8 6643.0 6711.0 6728.4 6817.1 6175.3 6199.4 6203.3 6260.3 6270.4 6574.9 6730.8 6746.4 6747.9 6841.0 6506.7 6512.4 6559.5 6560.8 6573.0 6534.6 6638.5 6654.1 6654.9 6660.5 5678.8 6565.9 6577.3 6613.4 6677.7 6610.0 6613.6 6671.3 6719.5 6721.2 5318.9 5359.5 5409.0 5441.3 5442.4 4577.3 4646.4 4668.3 4680.4 4717.5 5741.6 5750.0 5811.3 5830.0 5831.8 6477.2 6643.3 6645.2 6735.8 6754.4 5632.7 5645.9 5684.8 5758.4 5792.8 5900.0 5971.7 6013.8 6019.1 6023.8 6429.1 6452.8 6540.2 6542.0 6548.7 6548.1 6644.1 6657.2 6664.8 6670.2 6407.0 6414.5 6436.7 6437.9 6439.5 6452.8 6517.3 6552.3 6563.4 6563.5 6582.6 6641.7 6665.3 6672.4 6681.1 6463.5 6513.6 6545.9 6558.1 6576.7 6462.8 6487.5 6548.7 6577.1 6582.1 6393.3 6420.6 6460.1 6492.4 6501.5 6442.5 6546.1 6560.5 6602.4 6640.7 6204.8 6250.9 6269.2 6285.5 6309.5 03:46:58 INFO - PID 2530 | 03:46:58 INFO - PID 2530 | [#1] ext.html Cycles:180 Average:38207.64 Median:19276.24 stddev:55739.70 (289.2%) stddev-sans-first:55825.38 03:46:58 INFO - PID 2530 | Values: 823.2 833.0 864.2 886.9 891.1 40397.6 41223.8 41281.6 41309.0 41444.4 36992.4 37139.6 37228.1 37291.3 37409.8 6652.7 6652.8 6679.5 6755.6 6768.7 6594.3 6613.5 6641.4 6686.7 6713.5 6686.0 6762.3 7283.7 7505.2 7518.7 7363.5 7409.3 7437.3 7478.6 7484.9 7148.0 7246.6 7431.7 7443.9 7474.0 37499.6 37914.8 37960.2 38000.8 38088.2 3438.1 3478.3 3479.2 3484.9 3504.8 30644.2 30671.2 30725.2 30741.0 30955.0 4751.9 5017.5 5029.8 5041.7 5059.8 180864.0 182154.0 184641.0 188900.0 190899.0 45101.5 46023.5 46030.1 46175.5 46250.5 48344.3 48833.0 48965.8 49124.5 49133.3 15092.7 15487.5 15504.5 15578.1 15675.7 12884.8 13007.1 13009.2 13017.3 13029.2 12951.7 13058.6 13134.6 13150.6 13272.8 5392.4 5441.2 5452.4 5512.9 5546.9 957.0 982.7 998.3 1003.4 1023.7 22620.9 23354.6 28869.7 29707.0 29940.0 1052.3 1078.1 1086.8 1095.0 1099.6 12653.0 12727.6 12754.6 12836.2 12995.5 235512.0 236811.0 238649.0 238928.0 240020.0 52744.0 52924.0 53052.2 53161.2 53181.2 1396.1 1470.3 1477.8 1480.4 1482.9 23008.3 23290.5 23377.9 23420.6 23422.2 38284.6 38573.2 38689.8 38786.4 38816.0 216937.0 217350.0 218035.0 218096.0 219192.0 33560.0 33962.0 34001.5 34376.5 34447.0 43213.6 43617.8 43776.8 45977.5 47200.3 34554.1 34738.1 34760.3 34837.0 35047.6 33446.5 33716.4 33802.7 33968.0 34151.5 37432.6 37510.0 37710.4 37796.2 37801.6 32536.8 33212.0 33510.8 33648.8 33803.5 22789.7 24054.6 24223.2 24366.5 24841.3 03:46:58 INFO - PID 2530 | 03:46:58 INFO - PID 2530 | [#2] jquery.html Cycles:180 Average:34502.78 Median:23350.30 stddev:75824.90 (324.7%) stddev-sans-first:75994.78 03:46:58 INFO - PID 2530 | Values: 559.0 568.5 570.5 574.9 585.9 21710.7 22438.4 22440.1 22440.4 22544.1 25684.5 28416.6 28489.3 28533.4 28762.6 6965.5 7024.5 7115.3 7129.0 7131.0 6102.2 6754.7 6957.9 7028.7 7043.4 6736.5 6741.1 6743.5 6750.9 6780.2 6715.0 6722.7 6730.6 6738.4 6745.0 6583.1 6625.8 6639.8 6643.6 6658.6 30982.8 32067.0 32230.8 32606.7 32747.0 1974.4 2000.6 2008.8 2010.6 2016.7 20012.7 20680.3 20722.4 20900.7 20942.6 2392.2 2426.0 2517.9 2521.9 2522.8 140745.3 143014.0 145662.3 145924.0 145996.3 20353.0 21258.8 21409.6 21730.8 22606.7 43879.1 44237.6 44322.6 44408.0 44503.6 9901.6 10117.7 10287.5 10393.6 10530.7 9509.3 9527.9 9544.8 9617.2 9657.6 9077.8 9375.2 9467.2 9491.3 9737.6 2654.6 2699.2 2705.2 2751.8 2797.5 957.7 971.0 988.8 992.5 997.4 20297.3 20368.7 20505.3 20635.6 20840.0 1009.2 1018.5 1024.4 1029.9 1031.2 11321.5 11410.3 11499.0 11536.2 11539.3 435426.0 440233.1 449690.0 451046.0 456773.0 102836.0 105145.0 105840.5 106481.0 109764.5 1146.8 1161.1 1179.7 1195.7 1208.4 17663.5 17936.4 18125.8 18148.1 18488.4 54036.0 54633.7 54706.9 55282.2 56611.4 71332.0 71699.3 71803.0 72084.6 72787.0 13582.3 14477.4 14520.6 14546.4 14582.6 22953.5 23338.4 23362.2 23382.8 23913.2 18288.4 18367.4 18387.4 18453.2 18632.6 16303.0 17101.0 17132.1 17162.6 17501.2 18937.6 19274.0 19341.8 19368.6 19385.7 14565.0 14589.0 14607.9 14651.6 14659.7 17297.5 18013.4 18182.5 18444.5 18446.8 03:46:58 INFO - PID 2530 | 03:46:58 INFO - PID 2530 | [#3] mootools.html Cycles:180 Average:9051.52 Median:2586.73 stddev:6313.82 (244.1%) stddev-sans-first:6304.77 03:46:58 INFO - PID 2530 | Values: 1315.4 1352.5 1371.0 1375.9 1385.4 14103.9 14738.3 14788.7 14797.2 14810.0 14123.2 15434.5 15461.3 15477.3 15544.0 2686.8 2752.0 2753.1 2755.3 2755.3 2541.5 2627.5 2685.1 2722.9 2729.6 2633.5 2652.5 2656.3 2680.4 2682.2 2489.6 2541.7 2609.2 2663.3 2663.4 2549.0 2573.2 2580.0 2593.4 2600.9 14083.4 14280.8 14325.1 14398.6 14487.3 7350.5 7570.8 7632.2 7635.2 7652.7 4977.2 5265.6 5419.1 5456.8 5477.9 1873.9 1889.1 1892.2 1938.9 1970.3 24120.4 24271.0 24283.4 24315.5 24348.1 6937.4 7256.3 7263.7 7273.2 7278.9 16357.5 16499.3 16556.2 16669.7 16690.8 7408.8 7484.8 7501.7 7524.7 7944.9 6805.0 6972.1 7024.3 7041.9 7099.2 5317.3 5363.0 5420.2 5424.9 5459.6 1507.6 1515.7 1529.9 1536.5 1541.3 865.5 898.4 904.7 911.3 918.3 7530.5 7644.7 7678.4 7733.6 7796.8 727.5 728.4 732.8 745.1 746.6 5054.6 5298.4 5351.1 5477.4 5528.3 19978.1 20694.9 20842.9 20900.1 20912.0 20128.3 20531.9 20778.7 20794.3 20835.4 11273.0 11283.3 11286.8 11316.1 11319.7 7829.8 8330.1 8389.2 8401.2 8425.6 17435.7 17712.2 17783.6 18146.9 18325.5 18327.2 18338.2 18355.4 18434.4 18753.8 10560.6 10785.4 10797.1 10798.9 10830.4 13313.1 13329.3 13573.3 13583.3 13657.3 10768.4 11152.2 11343.6 11398.0 11499.2 10965.0 11050.7 11112.1 11142.3 11206.7 9703.1 9806.2 9822.4 9925.0 9928.7 7052.2 7151.4 7188.9 7254.6 7371.2 7084.4 7266.3 7428.1 7438.3 7470.9 03:46:58 INFO - PID 2530 | 03:46:58 INFO - PID 2530 | [#4] prototype.html Cycles:180 Average:5484.00 Median:6054.71 stddev:1535.09 (25.4%) stddev-sans-first:1493.22 03:46:58 INFO - PID 2530 | Values: 505.2 507.7 516.0 530.7 538.9 6136.6 6173.4 6218.9 6230.7 6258.8 6049.7 6050.5 6058.9 6081.8 6124.7 4784.5 5010.3 5028.6 5086.3 5091.0 4878.8 4928.4 4932.0 4958.6 4979.1 4846.3 4859.2 4900.5 4901.5 4926.8 4789.5 4831.2 4869.0 4923.0 4924.9 4404.7 4434.9 4442.1 4444.5 4454.2 6034.7 6036.2 6044.2 6045.5 6089.8 5600.4 5604.4 5626.5 5677.9 5687.0 6447.2 6487.8 6504.1 6560.7 6595.3 4851.9 4858.1 4877.8 4887.3 4895.4 6515.9 6563.7 6626.0 6811.1 6957.3 4924.7 4949.3 4951.6 4961.5 4998.0 5025.5 5077.2 5092.7 5116.6 5130.5 5607.7 5619.2 5633.2 5670.4 5683.4 6602.7 6623.5 6627.0 6629.5 6677.0 1775.0 1775.6 1778.0 1783.2 1786.8 1166.8 1213.7 1220.0 1224.1 1267.1 5563.4 5763.1 5794.6 5795.2 5809.9 6671.3 6702.3 6719.5 6756.3 6759.5 5703.6 5778.9 5787.7 5794.5 5804.9 3535.4 3584.9 3587.1 3589.4 3606.9 6510.5 6520.2 6547.0 6609.2 6629.7 6794.5 6835.1 6881.9 6883.4 6900.0 6386.7 6427.8 6473.5 6486.2 6510.3 6117.6 6619.1 6662.9 6668.8 6690.2 6551.7 6627.5 6646.7 6664.8 6683.4 6422.5 6445.7 6451.4 6530.1 6554.5 4898.6 4983.9 4993.7 5001.5 5014.9 6394.3 6602.0 6661.5 6715.6 6727.2 6421.7 6514.9 6547.6 6571.2 6575.3 6366.1 6496.3 6511.3 6525.2 6596.8 6450.0 6454.8 6487.3 6508.4 6542.8 6503.7 6515.8 6601.0 6619.3 6624.3 6299.0 6338.9 6361.7 6376.8 6384.3 03:46:58 INFO - PID 2530 | 03:46:58 INFO - PID 2530 | [#5] yui.html Cycles:180 Average:23318.95 Median:17838.19 stddev:32518.58 (182.3%) stddev-sans-first:32566.16 03:46:58 INFO - PID 2530 | Values: 881.0 896.5 899.6 904.6 925.2 18207.6 18805.9 18855.0 18989.0 18992.9 17785.1 18684.9 21928.1 22030.1 22295.2 1037.9 1067.7 1068.3 1069.1 1072.2 1059.2 1063.2 1065.7 1069.4 1074.6 999.9 1087.5 1095.2 1097.9 1125.9 1098.6 1101.5 1105.0 1107.0 1109.9 798.6 799.5 804.0 804.8 805.6 19528.4 19774.9 19782.6 19787.1 20811.9 20794.0 20891.8 21172.5 21398.4 21426.4 15412.2 15424.4 15739.0 15745.7 15746.2 3559.5 3592.7 3595.4 3602.5 3611.8 119573.0 122545.0 124372.0 126160.0 129055.4 17331.5 17562.2 17611.9 17966.1 17969.9 30193.2 31331.7 31571.4 31605.1 31876.8 9148.1 9150.8 9210.2 9229.4 9237.3 4232.0 4268.1 4321.4 4326.5 4327.4 5256.7 5318.1 5350.8 5374.4 5403.0 1037.8 1057.1 1075.4 1078.5 1079.3 634.4 651.3 652.5 664.5 675.6 11700.9 12054.6 12167.4 12209.9 12491.6 652.8 654.2 665.9 669.8 673.0 5344.2 5348.2 5381.6 5400.4 5462.8 114381.0 115949.0 116128.4 116394.4 120738.0 101066.0 101881.0 102724.0 103028.0 107304.5 86584.0 88237.6 89593.0 91237.0 92295.5 10264.1 10273.3 10303.6 10409.0 10537.2 39194.6 39297.0 40302.4 41153.0 41168.4 51007.5 51815.5 52036.7 52230.0 52318.2 16010.9 16114.7 16141.8 16199.4 16272.3 17491.1 17764.8 17833.0 17843.4 17923.4 16305.3 16376.3 16405.6 16455.0 16523.5 16513.8 16583.9 16653.3 16656.8 16855.7 15061.4 15063.2 15379.2 15465.3 15550.5 11718.0 11807.9 11968.3 12044.4 14396.5 14467.1 14746.3 15277.2 15523.5 15735.8 03:46:58 INFO - PID 2530 | -------- Summary: end -------- 03:46:58 INFO - PID 2530 | 03:46:59 INFO - TEST-INFO | 2530: exit 0 03:46:59 INFO - TEST-OK | dromaeo_css | took 1116114ms 03:46:59 INFO - TEST-START | kraken 03:46:59 INFO - Initialising browser for kraken test... 03:46:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36262/getInfo.html -profile /tmp/tmpLk68yk/profile 03:46:59 INFO - TEST-INFO | started process 3014 (/builds/slave/test/build/application/firefox/firefox http://localhost:36262/getInfo.html) 03:47:05 INFO - TEST-INFO | 3014: exit 0 03:47:05 INFO - Browser initialized. 03:47:05 INFO - Running cycle 1/1 for kraken test... 03:47:05 INFO - TEST-INFO | started process 3237 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLk68yk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:06 INFO - PID 3237 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:47:06 INFO - PID 3237 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:47:06 INFO - PID 3237 | 03:47:06 INFO - PID 3237 | (/builds/slave/test/build/application/firefox/firefox:3297): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:47:06 INFO - PID 3237 | 03:47:17 INFO - PID 3237 | RSS: Main: 196001792 03:47:17 INFO - PID 3237 | 03:47:19 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36262/tests/kraken/driver.html?testName=audio-beat-detection) 03:47:20 INFO - PID 3237 | RSS: Main: 205713408 03:47:20 INFO - PID 3237 | 03:47:23 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36262/tests/kraken/driver.html?testName=audio-dft) 03:47:24 INFO - PID 3237 | RSS: Main: 206749696 03:47:24 INFO - PID 3237 | 03:47:27 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36262/tests/kraken/driver.html?testName=audio-fft) 03:47:27 INFO - PID 3237 | RSS: Main: 201068544 03:47:27 INFO - PID 3237 | 03:47:30 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36262/tests/kraken/driver.html?testName=audio-oscillator) 03:47:30 INFO - PID 3237 | RSS: Main: 201510912 03:47:30 INFO - PID 3237 | 03:47:33 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:33 INFO - PID 3237 | RSS: Main: 212754432 03:47:33 INFO - PID 3237 | 03:47:36 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36262/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:37 INFO - PID 3237 | RSS: Main: 217120768 03:47:37 INFO - PID 3237 | 03:47:41 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36262/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:41 INFO - PID 3237 | RSS: Main: 217436160 03:47:41 INFO - PID 3237 | 03:47:44 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36262/tests/kraken/driver.html?testName=json-parse-financial) 03:47:45 INFO - PID 3237 | RSS: Main: 218497024 03:47:45 INFO - PID 3237 | 03:47:46 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:47:47 INFO - PID 3237 | RSS: Main: 218132480 03:47:47 INFO - PID 3237 | 03:47:49 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:50 INFO - PID 3237 | RSS: Main: 218013696 03:47:50 INFO - PID 3237 | 03:47:52 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:52 INFO - PID 3237 | RSS: Main: 218120192 03:47:52 INFO - PID 3237 | 03:47:55 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:56 INFO - PID 3237 | RSS: Main: 218640384 03:47:56 INFO - PID 3237 | 03:47:59 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:59 INFO - PID 3237 | RSS: Main: 218423296 03:47:59 INFO - PID 3237 | 03:48:01 INFO - PID 3237 | Cycle 1(1): loaded http://localhost:36262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36262/tests/kraken/driver.html?testName=ai-astar) 03:48:02 INFO - PID 3237 | RSS: Main: 219930624 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | __start_tp_report 03:48:02 INFO - PID 3237 | _x_x_mozilla_page_load 03:48:02 INFO - PID 3237 | _x_x_mozilla_page_load_details 03:48:02 INFO - PID 3237 | |i|pagename|runs| 03:48:02 INFO - PID 3237 | |0;ai-astar;106;108;103;108;108;111;121;101;108;112 03:48:02 INFO - PID 3237 | |1;audio-beat-detection;149;116;143;175;128;143;154;133;175;128 03:48:02 INFO - PID 3237 | |2;audio-dft;169;167;169;162;170;173;168;165;175;164 03:48:02 INFO - PID 3237 | |3;audio-fft;75;78;76;190;78;81;85;76;165;78 03:48:02 INFO - PID 3237 | |4;audio-oscillator;83;79;136;87;79;83;137;86;90;126 03:48:02 INFO - PID 3237 | |5;imaging-gaussian-blur;117;115;115;121;124;114;124;117;114;116 03:48:02 INFO - PID 3237 | |6;imaging-darkroom;157;151;149;158;160;154;160;159;152;154 03:48:02 INFO - PID 3237 | |7;imaging-desaturate;99;101;101;94;97;95;94;104;94;98 03:48:02 INFO - PID 3237 | |8;json-parse-financial;55;62;61;56;55;56;56;55;55;56 03:48:02 INFO - PID 3237 | |9;json-stringify-tinderbox;62;56;59;55;59;60;61;56;60;72 03:48:02 INFO - PID 3237 | |10;stanford-crypto-aes;80;77;80;82;80;81;79;76;77;78 03:48:02 INFO - PID 3237 | |11;stanford-crypto-ccm;129;129;137;132;122;132;123;132;119;157 03:48:02 INFO - PID 3237 | |12;stanford-crypto-pbkdf2;178;180;182;180;192;172;177;178;175;174 03:48:02 INFO - PID 3237 | |13;stanford-crypto-sha256-iterative;75;67;70;72;68;70;69;81;67;66 03:48:02 INFO - PID 3237 | __end_tp_report 03:48:02 INFO - PID 3237 | __start_cc_report 03:48:02 INFO - PID 3237 | _x_x_mozilla_cycle_collect,953 03:48:02 INFO - PID 3237 | __end_cc_report 03:48:02 INFO - PID 3237 | __startTimestamp1502880482075__endTimestamp 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | ------- Summary: start ------- 03:48:02 INFO - PID 3237 | Number of tests: 14 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#0] ai-astar Cycles:10 Average:108.60 Median:108.00 stddev:5.46 (5.1%) stddev-sans-first:5.71 03:48:02 INFO - PID 3237 | Values: 106.0 108.0 103.0 108.0 108.0 111.0 121.0 101.0 108.0 112.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:146.00 stddev:19.62 (13.4%) stddev-sans-first:20.74 03:48:02 INFO - PID 3237 | Values: 149.0 116.0 143.0 175.0 128.0 143.0 154.0 133.0 175.0 128.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#2] audio-dft Cycles:10 Average:168.20 Median:169.00 stddev:3.97 (2.3%) stddev-sans-first:4.20 03:48:02 INFO - PID 3237 | Values: 169.0 167.0 169.0 162.0 170.0 173.0 168.0 165.0 175.0 164.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#3] audio-fft Cycles:10 Average:98.20 Median:78.00 stddev:42.31 (54.2%) stddev-sans-first:44.03 03:48:02 INFO - PID 3237 | Values: 75.0 78.0 76.0 190.0 78.0 81.0 85.0 76.0 165.0 78.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#4] audio-oscillator Cycles:10 Average:98.60 Median:83.00 stddev:24.14 (29.1%) stddev-sans-first:24.94 03:48:02 INFO - PID 3237 | Values: 83.0 79.0 136.0 87.0 79.0 83.0 137.0 86.0 90.0 126.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:117.00 stddev:3.89 (3.3%) stddev-sans-first:4.12 03:48:02 INFO - PID 3237 | Values: 117.0 115.0 115.0 121.0 124.0 114.0 124.0 117.0 114.0 116.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#6] imaging-darkroom Cycles:10 Average:155.40 Median:157.50 stddev:3.95 (2.5%) stddev-sans-first:4.15 03:48:02 INFO - PID 3237 | Values: 157.0 151.0 149.0 158.0 160.0 154.0 160.0 159.0 152.0 154.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#7] imaging-desaturate Cycles:10 Average:97.70 Median:94.50 stddev:3.53 (3.7%) stddev-sans-first:3.71 03:48:02 INFO - PID 3237 | Values: 99.0 101.0 101.0 94.0 97.0 95.0 94.0 104.0 94.0 98.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:2.58 (4.6%) stddev-sans-first:2.67 03:48:02 INFO - PID 3237 | Values: 55.0 62.0 61.0 56.0 55.0 56.0 56.0 55.0 55.0 56.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:4.81 (8.0%) stddev-sans-first:5.04 03:48:02 INFO - PID 3237 | Values: 62.0 56.0 59.0 55.0 59.0 60.0 61.0 56.0 60.0 72.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#10] stanford-crypto-aes Cycles:10 Average:79.00 Median:80.00 stddev:1.94 (2.4%) stddev-sans-first:2.03 03:48:02 INFO - PID 3237 | Values: 80.0 77.0 80.0 82.0 80.0 81.0 79.0 76.0 77.0 78.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:132.00 stddev:10.60 (8.0%) stddev-sans-first:11.22 03:48:02 INFO - PID 3237 | Values: 129.0 129.0 137.0 132.0 122.0 132.0 123.0 132.0 119.0 157.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:179.00 stddev:5.53 (3.1%) stddev-sans-first:5.86 03:48:02 INFO - PID 3237 | Values: 178.0 180.0 182.0 180.0 192.0 172.0 177.0 178.0 175.0 174.0 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:4.55 (6.5%) stddev-sans-first:4.53 03:48:02 INFO - PID 3237 | Values: 75.0 67.0 70.0 72.0 68.0 70.0 69.0 81.0 67.0 66.0 03:48:02 INFO - PID 3237 | -------- Summary: end -------- 03:48:02 INFO - PID 3237 | 03:48:02 INFO - PID 3237 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:48:02 INFO - TEST-INFO | 3237: exit 0 03:48:02 INFO - TEST-OK | kraken | took 63637ms 03:48:02 INFO - SUITE-END | took 1179s 03:48:03 INFO - Completed test suite (00:19:40) 03:48:03 INFO - javascript benchmark 03:48:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8503.984163307803, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3164.0982320038793, 3171.0645359618925, 3189.681031896809, 3196.760242981776, 3224.9193770155744, 5963.821085367446, 6059.212302400692, 6073.48375388092, 6113.847153821145, 6131.877362452754, 6039.788607398742, 6156.507479401637, 6157.107219453176, 6168.290646575645, 6186.041163619635, 5616.073347897592, 5645.407232240617, 5650.802221922234, 5656.717164141787, 5690.573207009491, 5680.147977803321, 5687.943120568803, 5689.6586204827845, 5710.7715691372505, 5717.914231286534, 5641.774329026834, 5665.1785491103765, 5676.716164191774, 5678.48893599576, 5687.459691329317, 5634.577406694514, 5651.9152212716635, 5686.118651609007, 5715.485606295411, 5757.65454072757, 5572.247746554204, 5642.238297829823, 5664.0, 5703.600747947646, 5706.087026075808, 6021.397860213988, 6049.395060493959, 6067.453929146354, 6095.847603809896, 6180.567360284782, 6473.83815404614, 6537.117489138953, 6607.438367738748, 6620.106285651472, 6620.735170593171, 6606.8017959461295, 6643.0, 6710.966445167792, 6728.428083612899, 6817.113775209241, 6175.2898416681755, 6199.442050215503, 6203.2556093268195, 6260.280067792217, 6270.372962703739, 6574.934250657528, 6730.798076057726, 6746.392824645707, 6747.932520674829, 6841.0, 6506.707198176094, 6512.41388275048, 6559.47524198063, 6560.770373036921, 6573.04690819838, 6534.575252608565, 6638.502112341594, 6654.13496245485, 6654.933450665529, 6660.533762636665, 5678.772849086073, 6565.901511477332, 6577.3422657733845, 6613.404793568602, 6677.699503522354, 6609.966950165314, 6613.570117942319, 6671.299513551105, 6719.496037797185, 6721.193456785119, 5318.9202161967605, 5359.517643412111, 5408.972955135199, 5441.292631957899, 5442.401335853053, 4577.3362862384765, 4646.4191976003, 4668.253079507263, 4680.438347398266, 4717.457492388351, 5741.62679425836, 5750.022496175577, 5811.3026436827, 5830.038043722823, 5831.7667293307795, 6477.1579694639395, 6643.269240383554, 6645.2025756908515, 6735.831604209934, 6754.425873800782, 5632.690202038845, 5645.858853528694, 5684.77260909559, 5758.424157584292, 5792.768289268466, 5899.967505686488, 5971.671558064349, 6013.819585412444, 6019.067044608093, 6023.819285421444, 6429.067785171124, 6452.838679033061, 6540.182477190351, 6542.0186971953635, 6548.672566371567, 6548.116004339353, 6644.069830223676, 6657.167854018247, 6664.766733164316, 6670.166229221348, 6406.967965160145, 6414.486841052798, 6436.742530298736, 6437.903431448438, 6439.549231553746, 6452.774152904626, 6517.250516190509, 6552.312007239171, 6563.442107420923, 6563.474922006132, 6582.572132811543, 6641.734330626914, 6665.33346665349, 6672.366125218096, 6681.09805176295, 6463.482921366373, 6513.609183449008, 6545.869082618226, 6558.147440832852, 6576.736930522726, 6462.773802916875, 6487.481001519773, 6548.672566371758, 6577.079208910852, 6582.078509008838, 6393.328700486382, 6420.6468644225015, 6460.063290822898, 6492.448141907991, 6501.512386570931, 6442.516811239082, 6546.083548303337, 6560.475161987125, 6602.40578347951, 6640.701168447528, 6204.81385558434, 6250.937490625036, 6269.153664255267, 6285.465735412358, 6309.463695585927], "value": 6057.676798327639, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.201494550286, 833.0420016980476, 864.2178828160514, 886.8935727712671, 891.0643823984816, 40397.596024039754, 41223.79388103055, 41281.58718412815, 41309.0, 41444.37833432501, 36992.44511332332, 37139.62860371396, 37228.069298267554, 37291.25417491649, 37409.81295093527, 6652.733890644393, 6652.833679158023, 6679.532432729711, 6755.628440435774, 6768.661566921659, 6594.274629790719, 6613.503987200979, 6641.435477984353, 6686.699098540553, 6713.462922966151, 6686.0, 6762.289959554249, 7283.7086516539275, 7505.249475052506, 7518.661660225275, 7363.521371110861, 7409.333160015598, 7437.293457121592, 7478.588677622729, 7484.887726684104, 7147.964260178718, 7246.565206087652, 7431.665575049135, 7443.925560744432, 7474.0, 37499.62500374988, 37914.810425947966, 37960.24079518394, 38000.80999595012, 38088.23823523514, 3438.1404648837793, 3478.339115568034, 3479.1823921378455, 3484.8780292689635, 3504.8247587620517, 30644.233894152603, 30671.233219169477, 30725.231869203224, 30741.0, 30955.0, 4751.857444276678, 5017.54842064216, 5029.823956161554, 5041.6722913010535, 5059.797608095671, 180864.0, 182154.0, 184641.0, 188900.0, 190899.0, 45101.548984510395, 46023.539764602596, 46030.07939841251, 46175.5382446178, 46250.5374946253, 48344.27483587749, 48833.0, 48965.755171223915, 49124.508754912706, 49133.26300105501, 15092.698146037017, 15487.5353739388, 15504.457343992906, 15578.143202123765, 15675.686486270211, 12884.80672789909, 13007.089503734647, 13009.21944683322, 13017.284049377186, 13029.15310504814, 12951.740965180643, 13058.608241752763, 13134.60596182116, 13150.60548183537, 13272.800907986388, 5392.433794451605, 5441.183822426668, 5452.40023597404, 5512.947983232321, 5546.944530554642, 956.9665061722807, 982.6855406270068, 998.3061772068488, 1003.4029752297372, 1023.7338292043974, 22620.886895565418, 23354.64968025481, 28869.71130288712, 29707.0, 29940.0, 1052.2949623752104, 1078.132103656564, 1086.7554800169898, 1094.9761972555686, 1099.6371197504805, 12652.987760979284, 12727.554535591209, 12754.61736147917, 12836.229826210458, 12995.545155919686, 235512.0, 236811.0, 238649.0, 238928.0, 240020.0, 52744.0, 52924.0, 53052.20421693601, 53161.202581961305, 53181.2022819658, 1396.11346794784, 1470.272215253435, 1477.8152730908637, 1480.370842391979, 1482.888783341232, 23008.309750707507, 23290.53418931646, 23377.88311058434, 23420.648690269318, 23422.180223692772, 38284.61715382922, 38573.22853542857, 38689.80655096706, 38786.4182037264, 38816.02959926025, 216937.0, 217350.0, 218035.0, 218096.0, 219192.0, 33560.0, 33962.0, 34001.48997764986, 34376.48435273423, 34447.0, 43213.567864320954, 43617.78191109024, 43776.781116094215, 45977.54022459866, 47200.29199562078, 34554.13614659654, 34738.131546711535, 34760.304793904485, 34837.0, 35047.64952350546, 33446.498302525, 33716.42916722783, 33802.66197337995, 33968.0, 34151.487727683605, 37432.625673742914, 37510.0, 37710.43434348432, 37796.24407511889, 37801.62198378091, 32536.83731581327, 33212.0, 33510.83244583859, 33648.83175584106, 33803.492947605315, 22789.658155128018, 24054.63918041196, 24223.152189673983, 24366.51266974686, 24841.25476235716], "value": 17009.412902091728, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.9664620122793, 568.5139205978891, 570.4837122404223, 574.893644675735, 585.8886811505813, 21710.674339884914, 22438.43903902401, 22440.102395904185, 22440.438989025282, 22544.098236070557, 25684.486310273784, 28416.573751393746, 28489.287767805814, 28533.42933141336, 28762.568561471595, 6965.477589180807, 7024.473164512682, 7115.252898445667, 7129.0, 7131.037309963166, 6102.176206212172, 6754.729810807562, 6957.860842783141, 7028.683709233097, 7043.36609705129, 6736.494762892778, 6741.089952856375, 6743.527953043289, 6750.898736518956, 6780.186377634691, 6715.0, 6722.731090756364, 6730.5625134366355, 6738.427233685143, 6745.0, 6583.07836902834, 6625.768098116543, 6639.838028345021, 6643.568168069109, 6658.633775142365, 30982.84508577443, 32067.0, 32230.838845805854, 32606.6739332606, 32747.0, 1974.4372853736759, 2000.649886269897, 2008.839292856568, 2010.5878294949646, 2016.7176595276674, 20012.69980950287, 20680.276190333265, 20722.378328650164, 20900.686489702668, 20942.5811483771, 2392.234484964812, 2425.9757402426103, 2517.8669598680485, 2521.8865151068244, 2522.8107891908, 140745.296273519, 143014.0, 145662.27168864195, 145924.0, 145996.27001865028, 20353.031158924165, 21258.78741212599, 21409.57180856374, 21730.78269217319, 22606.66090008651, 43879.12241755147, 44237.557624423345, 44322.55677443184, 44408.0, 44503.55496445059, 9901.60393584263, 10117.672935224793, 10287.537060832281, 10393.636222732168, 10530.684079477474, 9509.33434659581, 9527.90472095284, 9544.809103817885, 9617.23062155026, 9657.631883496417, 9077.818443631222, 9375.156235938799, 9467.242620590336, 9491.288153388385, 9737.610495580238, 2654.6283520307175, 2699.163259389556, 2705.1884434669914, 2751.7798576114265, 2797.538406163001, 957.6887511558771, 970.9514524273899, 988.8071825994006, 992.4739887859446, 997.3915911294105, 20297.28959486411, 20368.69446958297, 20505.2823151192, 20635.58728825445, 20840.0, 1009.2027298434155, 1018.5314755212537, 1024.3700124423426, 1029.8661174047327, 1031.1544533482622, 11321.547138114547, 11410.315381077162, 11499.0, 11536.192466527431, 11539.307641541534, 435426.0, 440233.1137479089, 449690.0, 451046.0, 456773.0, 102836.0, 105145.0, 105840.47079764552, 106481.0, 109764.4511777436, 1146.8337091121741, 1161.1175506615034, 1179.6520026592175, 1195.6771671648605, 1208.3958020989505, 17663.470095897144, 17936.372226971995, 18125.818741812414, 18148.092595370443, 18488.445346639623, 54036.0, 54633.72683136559, 54706.90586188174, 55282.17076743772, 56611.43388566226, 71332.0, 71699.28300716926, 71803.0, 72084.63957680178, 72787.0, 13582.320883955565, 14477.420903163755, 14520.636984075483, 14546.418143274574, 14582.562523124323, 22953.540929181658, 23338.416539586648, 23362.182323618592, 23382.76617233806, 23913.16303929354, 18288.359907403177, 18367.448976530726, 18387.356442524448, 18453.16960736797, 18632.627347453246, 16303.0, 17101.0, 17132.057736824594, 17162.570935726708, 17501.21244544024, 18937.621247575247, 19274.0, 19341.806581934, 19368.612627747083, 19385.709214361515, 14565.0, 14589.0, 14607.92696036513, 14651.633709157357, 14659.70680586361, 17297.481075567754, 18013.369532066314, 18182.545436363667, 18444.538886527946, 18446.815531845048], "value": 12487.514844008452, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.4343632238138, 1352.5130952856969, 1371.0402718097334, 1375.938082786274, 1385.4250486048288, 14103.929480352597, 14738.263086845654, 14788.704225915475, 14797.186154761484, 14810.0, 14123.152610843357, 15434.459793907215, 15461.30424130914, 15477.303521341539, 15544.0, 2686.7716244119274, 2752.0, 2753.105240796739, 2755.3249453883827, 2755.3249453883827, 2541.453587478701, 2627.4745050989877, 2685.0602289198723, 2722.904698335549, 2729.6314997475283, 2633.47330533894, 2652.4827658606578, 2656.282803643015, 2680.437108207269, 2682.1953413975825, 2489.601663733803, 2541.733118022609, 2609.20419272121, 2663.2676014096087, 2663.387420893205, 2548.967668094425, 2573.1508602161243, 2580.045383208206, 2593.4164812917134, 2600.8959641614315, 14083.436662533486, 14280.785788213081, 14325.068870523382, 14398.568042958728, 14487.275636218146, 7350.4854660173805, 7570.810729731746, 7632.236776322379, 7635.236476352376, 7652.655630496641, 4977.1538838397555, 5265.631405801595, 5419.051665958442, 5456.836294911159, 5477.890442191174, 1873.8875667459995, 1889.0743535667561, 1892.2147308866804, 1938.9127489262876, 1970.330087770165, 24120.396990075213, 24271.029158833626, 24283.392915177086, 24315.513689726282, 24348.147814826574, 6937.410320122745, 7256.310650488195, 7263.745768898063, 7273.23631018746, 7278.927210727825, 16357.509274721777, 16499.257533411026, 16556.172191390622, 16669.66660666804, 16690.83309166917, 7408.814779630445, 7484.775456736198, 7501.699932002768, 7524.699012039458, 7944.920550794418, 6805.0, 6972.058772065706, 7024.26245244242, 7041.859162816715, 7099.183593886666, 5317.335333083364, 5362.973185134049, 5420.186971954159, 5424.918626220609, 5459.645123066988, 1507.5652820694718, 1515.7499012662788, 1529.9235038248044, 1536.5236776599068, 1541.306412114553, 865.5499140446932, 898.3666515106834, 904.6697955246419, 911.2846415563884, 918.3479729392072, 7530.510516816389, 7644.6942122315595, 7678.385729141767, 7733.613319334123, 7796.766097016985, 727.5271073801965, 728.4463807506334, 732.809469537924, 745.1244787374922, 746.6266866566716, 5054.566341183243, 5298.417174110845, 5351.117065684196, 5477.4248703886315, 5528.253685752452, 19978.10098545569, 20694.896525517277, 20842.89578552128, 20900.059497322658, 20912.0, 20128.29550965709, 20531.897340513202, 20778.688319675217, 20794.27220047291, 20835.374938751862, 11272.985431311221, 11283.323000619988, 11286.774264514665, 11316.094712422986, 11319.717007074889, 7829.765107046797, 8330.125336839787, 8389.244967952669, 8401.243888049861, 8425.578721064045, 17435.738463922797, 17712.202950866984, 17783.644327113125, 18146.909265454116, 18325.54186145357, 18327.17527711283, 18338.174782135102, 18355.35756248525, 18434.446966591022, 18753.812461875208, 10560.577576896838, 10785.352878827296, 10797.082248009006, 10798.946005269923, 10830.350178989285, 13313.134646247963, 13329.333533323488, 13573.321333933462, 13583.252921089435, 13657.317134143055, 10768.407737574194, 11152.219344645797, 11343.602973895873, 11398.031167350537, 11499.19505634631, 10965.0, 11050.668479945614, 11112.055475284691, 11142.331460112418, 11206.663800086011, 9703.12671859536, 9806.21550275962, 9822.410655360702, 9925.0, 9928.702138935843, 7052.188998265266, 7151.356377926011, 7188.928110718826, 7254.600996945219, 7371.152317483344, 7084.433245340258, 7266.273372662691, 7428.145763237297, 7438.256174382518, 7470.8505829882015], "value": 6499.958322991034, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.2043032224243, 507.66494113884846, 516.0298638559509, 530.7478947499935, 538.8706710389507, 6136.601120927136, 6173.413525715056, 6218.906716399252, 6230.688465576725, 6258.780942667007, 6049.697515124249, 6050.485708714754, 6058.939410605893, 6081.78713745019, 6124.744427392385, 4784.545468180535, 5010.2964991902745, 5028.647994640377, 5086.287919691246, 5091.0, 4878.804847806084, 4928.43323017854, 4931.975340123295, 4958.603311735071, 4979.128652485819, 4846.297286893398, 4859.246816743411, 4900.471660404503, 4901.509849015088, 4926.778294976734, 4789.491310237281, 4831.22700367943, 4868.951310486886, 4922.95697285626, 4924.901501969976, 4404.735715857027, 4434.933475997863, 4442.111577684476, 4444.511103778582, 4454.175977444183, 6034.702538954146, 6036.245469316335, 6044.219658956885, 6045.458408105905, 6089.756409743605, 5600.383957764642, 5604.3835178130785, 5626.493615574618, 5677.858053548653, 5686.971565142189, 6447.2263328400895, 6487.772927947499, 6504.089427480157, 6560.737570497175, 6595.340465953366, 4851.927221091686, 4858.149823780859, 4877.829275975324, 4887.3402090717655, 4895.388076490439, 6515.934840651627, 6563.737450501974, 6625.97907638175, 6811.148606424197, 6957.304269573002, 4924.679895806833, 4949.257611358325, 4951.628627852925, 4961.479044700327, 4997.9750101249265, 5025.517472345667, 5077.1876499759865, 5092.745362731848, 5116.616253780981, 5130.48695130484, 5607.663540187602, 5619.157126431068, 5633.2395126657375, 5670.432956704297, 5683.403242659461, 6602.73589056442, 6623.4701223901975, 6627.0, 6629.469642428594, 6677.0, 1774.97337539937, 1775.5916139288036, 1778.0309731196528, 1783.2064731194494, 1786.8481179099922, 1166.7783121206944, 1213.7026428525069, 1219.987410449325, 1224.1430998301225, 1267.075035224273, 5563.415841336682, 5763.077907534775, 5794.62334948227, 5795.217645617788, 5809.912851307234, 6671.266160722316, 6702.296258892844, 6719.529632925648, 6756.324367563205, 6759.459243260528, 5703.62926409782, 5778.855528611818, 5787.739551720183, 5794.478496935296, 5804.94195058044, 3535.398982173037, 3584.874529391459, 3587.121155316964, 3589.371859924555, 3606.945895811565, 6510.47916166715, 6520.217573891068, 6547.0, 6609.173853268341, 6629.701663425158, 6794.490413219029, 6835.069834844984, 6881.931180688129, 6883.414909732729, 6900.0, 6386.690728400667, 6427.807165785034, 6473.514486413444, 6486.189226346707, 6510.283868774431, 6117.593746459663, 6619.106420633153, 6662.933370666231, 6668.799296232135, 6690.19717633887, 6551.737930482918, 6627.536072474881, 6646.734130634721, 6664.83337916556, 6683.365080317362, 6422.454091402283, 6445.709943052668, 6451.387118223761, 6530.08578798978, 6554.4756419487285, 4898.632602554751, 4983.900321993612, 4993.700377977188, 5001.473960857659, 5014.874628134326, 6394.26465956421, 6602.0, 6661.533692641468, 6715.630640314829, 6727.159105111861, 6421.71102300407, 6514.934850651623, 6547.574407663677, 6571.244306904767, 6575.342465753386, 6366.090172948005, 6496.252930912817, 6511.34886511364, 6525.2169739631545, 6596.80209593713, 6450.0, 6454.773593017312, 6487.307767276528, 6508.381703738138, 6542.771003014872, 6503.707333169924, 6515.804525864231, 6600.966995164993, 6619.3380661933425, 6624.317151553629, 6298.984469831392, 6338.904916426165, 6361.713722882574, 6376.840578985562, 6384.297727249906], "value": 5035.623692005379, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [880.9515476648786, 896.5248418338281, 899.6401439424234, 904.6471875968374, 925.2228128372166, 18207.635847283047, 18805.90597047016, 18855.0, 18989.0, 18992.905035474836, 17785.11074446279, 18684.906575467103, 21928.122875084977, 22030.11879524821, 22295.21966731165, 1037.891021442749, 1067.7117178361837, 1068.2575609951086, 1069.0645685025602, 1072.1904961753864, 1059.1738444013681, 1063.2079101069676, 1065.733566608348, 1069.3904474449566, 1074.5809134437575, 999.9000099990016, 1087.4508373271487, 1095.1731442760704, 1097.9066779323766, 1125.94370281486, 1098.56606640377, 1101.4547798839546, 1105.011015141444, 1107.0092267420653, 1109.8612673415823, 798.59271771397, 799.4963173200904, 804.0311424733183, 804.8269622031291, 805.5690205739901, 19528.414147575597, 19774.90112549428, 19782.604347913104, 19787.109580068933, 20811.895940520353, 20794.0, 20891.791082089137, 21172.470688232763, 21398.35804925839, 21426.357209283746, 15412.22938853064, 15424.383024678998, 15739.0, 15745.685086298325, 15746.2126893656, 3559.519464872235, 3592.7305452091196, 3595.424732042861, 3602.5496812898386, 3611.819409029538, 119573.0, 122545.0, 124372.0, 126160.0, 129055.35472322672, 17331.480055598353, 17562.20970056325, 17611.911940440215, 17966.101694915204, 17969.910150449425, 30193.245168870955, 31331.686683132877, 31571.36857262842, 31605.051848444582, 31876.840615796773, 9148.085191480932, 9150.7646467726, 9210.171084602418, 9229.446233226028, 9237.30720195988, 4232.047789247395, 4268.103698223345, 4321.351797230441, 4326.502452217972, 4327.37253098299, 5256.737163141827, 5318.095923692981, 5350.812721554805, 5374.35507739066, 5402.972985135128, 1037.8443233515034, 1057.1278695076592, 1075.408525311076, 1078.5200585739428, 1079.3200283821143, 634.429013887505, 651.3388910256094, 652.5399593286721, 664.4916638771343, 675.5777638975641, 11700.94149529264, 12054.638360849189, 12167.391630418444, 12209.877901220874, 12491.625251242478, 652.846581053452, 654.1561385812344, 665.8934570468701, 669.8358902069024, 673.017394603874, 5344.198370244494, 5348.171033489815, 5381.596380271495, 5400.351957765093, 5462.8361149165585, 114381.0, 115949.0, 116128.41935790436, 116394.41802790931, 120738.0, 101066.0, 101881.0, 102724.0, 103028.0, 107304.46347768212, 86584.0, 88237.55881220553, 89593.0, 91237.0, 92295.5385223083, 10264.127549158406, 10273.332233404804, 10303.639372621923, 10409.011143941616, 10537.209709271989, 39194.60805392024, 39297.0, 40302.39546406748, 41153.0, 41168.38247426351, 51007.48992510027, 51815.481845181064, 52036.73981630067, 52230.0, 52318.21522677239, 16010.9199454002, 16114.67770644604, 16141.838581614034, 16199.43301984425, 16272.267747951608, 17491.12544372751, 17764.822351776318, 17833.0, 17843.37548185807, 17923.37268195607, 16305.347786088423, 16376.344946202018, 16405.58986025359, 16455.0, 16523.504294871174, 16513.83486165123, 16583.91708041452, 16653.3338666452, 16656.750148747535, 16855.747163792308, 15061.397544098114, 15063.246837658293, 15379.231038448257, 15465.304061317493, 15550.455734049254, 11718.0, 11807.881921180679, 11968.341741204318, 12044.397780110785, 14396.496122635657, 14467.131972081708, 14746.262686865828, 15277.236138193268, 15523.456679016632, 15735.842641573438], "value": 8979.9180646989, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1565.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 108.0, 103.0, 108.0, 108.0, 111.0, 121.0, 101.0, 108.0, 112.0], "value": 108.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 143.0, 175.0, 128.0, 143.0, 154.0, 133.0, 175.0, 128.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 169.0, 162.0, 170.0, 173.0, 168.0, 165.0, 175.0, 164.0], "value": 168.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 190.0, 78.0, 81.0, 85.0, 76.0, 165.0, 78.0], "value": 98.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 136.0, 87.0, 79.0, 83.0, 137.0, 86.0, 90.0, 126.0], "value": 98.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 115.0, 121.0, 124.0, 114.0, 124.0, 117.0, 114.0, 116.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 151.0, 149.0, 158.0, 160.0, 154.0, 160.0, 159.0, 152.0, 154.0], "value": 155.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 101.0, 101.0, 94.0, 97.0, 95.0, 94.0, 104.0, 94.0, 98.0], "value": 97.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 62.0, 61.0, 56.0, 55.0, 56.0, 56.0, 55.0, 55.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 56.0, 59.0, 55.0, 59.0, 60.0, 61.0, 56.0, 60.0, 72.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 80.0, 82.0, 80.0, 81.0, 79.0, 76.0, 77.0, 78.0], "value": 79.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 137.0, 132.0, 122.0, 132.0, 123.0, 132.0, 119.0, 157.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 180.0, 182.0, 180.0, 192.0, 172.0, 177.0, 178.0, 175.0, 174.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 67.0, 70.0, 72.0, 68.0, 70.0, 69.0, 81.0, 67.0, 66.0], "value": 70.5, "unit": "score"}]}]} 03:48:03 INFO - Return code: 0 03:48:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:48:03 INFO - # TBPL SUCCESS # 03:48:03 INFO - Running post-action listener: _package_coverage_data 03:48:03 INFO - Running post-action listener: _resource_record_post_action 03:48:03 INFO - [mozharness: 2017-08-16 10:48:03.343824Z] Finished run-tests step (success) 03:48:03 INFO - Running post-run listener: _resource_record_post_run 03:48:03 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 3616768; Write bytes: 429965312; Read time: 816; Write time: 421212 03:48:03 INFO - TinderboxPrint: CPU usage
13.3% 03:48:03 INFO - TinderboxPrint: I/O read bytes / time
3,616,768 / 816 03:48:03 INFO - TinderboxPrint: I/O write bytes / time
429,965,312 / 421,212 03:48:03 INFO - TinderboxPrint: CPU idle
8,279.5 (86.7%) 03:48:03 INFO - TinderboxPrint: CPU user
1,209.8 (12.7%) 03:48:03 INFO - TinderboxPrint: Swap in / out
0 / 0 03:48:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107376640; Read time: 0; Write time: 151192 03:48:03 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:48:03 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 3612672; Write bytes: 322588672; Read time: 808; Write time: 270020 03:48:03 INFO - Running post-run listener: _upload_blobber_files 03:48:03 INFO - Blob upload gear active. 03:48:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:48:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:48:03 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'] 03:48:03 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 03:48:04 INFO - (blobuploader) - INFO - Open directory for files ... 03:48:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:48:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:48:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:05 INFO - (blobuploader) - INFO - Done attempting. 03:48:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:48:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:48:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:13 INFO - (blobuploader) - INFO - Done attempting. 03:48:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:48:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:48:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:14 INFO - (blobuploader) - INFO - Done attempting. 03:48:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:48:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:48:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:48:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:48:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:48:15 INFO - (blobuploader) - INFO - Done attempting. 03:48:15 INFO - (blobuploader) - INFO - Iteration through files over. 03:48:15 INFO - Return code: 0 03:48:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:48:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:48:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/900865b427c61a47f9d7b3f0bd2ffee0d10d84eecef44b68921e10e0d9cf024770b65ec03fbf8674c8dd6d34f7868c260ebc46fde51cc042190f86769ffbadc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0aa3e1d9479dd65a7c3347e3da225b0d2bc66c0746e5c804a947c0425547c2a252b220afc0ab85dcbebdafff84444499316d20051a655eb90ec5f592f6e7818", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1e6d8ab98042466ec26b8b8740c973bc59194095e65b0e3027d72f3c38d45071692251ff0b00360ddb54cd7ad600cea8288fbee15b7feabcb4c789778fdcf84", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea4f1e5215b4d897e324e0eb304018a397aea71f38b38ec24ac3b5ca68a09fc114f688800ad7ecef7770976495e2a5d5d5ff530869035d6f133efce10a7c7c07"} 03:48:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:48:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:48:15 INFO - Contents: 03:48:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/900865b427c61a47f9d7b3f0bd2ffee0d10d84eecef44b68921e10e0d9cf024770b65ec03fbf8674c8dd6d34f7868c260ebc46fde51cc042190f86769ffbadc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0aa3e1d9479dd65a7c3347e3da225b0d2bc66c0746e5c804a947c0425547c2a252b220afc0ab85dcbebdafff84444499316d20051a655eb90ec5f592f6e7818", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1e6d8ab98042466ec26b8b8740c973bc59194095e65b0e3027d72f3c38d45071692251ff0b00360ddb54cd7ad600cea8288fbee15b7feabcb4c789778fdcf84", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea4f1e5215b4d897e324e0eb304018a397aea71f38b38ec24ac3b5ca68a09fc114f688800ad7ecef7770976495e2a5d5d5ff530869035d6f133efce10a7c7c07"} 03:48:15 INFO - Running post-run listener: copy_logs_to_upload_dir 03:48:15 INFO - Copying logs to upload dir... 03:48:15 INFO - mkdir: /builds/slave/test/build/upload/logs 03:48:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.601406 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-16 03:48:14.474176) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:48:14.482031) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921 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/900865b427c61a47f9d7b3f0bd2ffee0d10d84eecef44b68921e10e0d9cf024770b65ec03fbf8674c8dd6d34f7868c260ebc46fde51cc042190f86769ffbadc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0aa3e1d9479dd65a7c3347e3da225b0d2bc66c0746e5c804a947c0425547c2a252b220afc0ab85dcbebdafff84444499316d20051a655eb90ec5f592f6e7818", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1e6d8ab98042466ec26b8b8740c973bc59194095e65b0e3027d72f3c38d45071692251ff0b00360ddb54cd7ad600cea8288fbee15b7feabcb4c789778fdcf84", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea4f1e5215b4d897e324e0eb304018a397aea71f38b38ec24ac3b5ca68a09fc114f688800ad7ecef7770976495e2a5d5d5ff530869035d6f133efce10a7c7c07"} build_url:https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011419 build_url: 'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/900865b427c61a47f9d7b3f0bd2ffee0d10d84eecef44b68921e10e0d9cf024770b65ec03fbf8674c8dd6d34f7868c260ebc46fde51cc042190f86769ffbadc9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c0aa3e1d9479dd65a7c3347e3da225b0d2bc66c0746e5c804a947c0425547c2a252b220afc0ab85dcbebdafff84444499316d20051a655eb90ec5f592f6e7818", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1e6d8ab98042466ec26b8b8740c973bc59194095e65b0e3027d72f3c38d45071692251ff0b00360ddb54cd7ad600cea8288fbee15b7feabcb4c789778fdcf84", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ea4f1e5215b4d897e324e0eb304018a397aea71f38b38ec24ac3b5ca68a09fc114f688800ad7ecef7770976495e2a5d5d5ff530869035d6f133efce10a7c7c07"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:48:14.512065) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:48:14.512395) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1502879231.342172-1657539921 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004425 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:48:14.594398) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:48:14.597726) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:48:14.598009) ========= ========= Total master_lag: 0.17 =========