builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-075 starttime: 1501621731.78 results: success (0) revision: a3e675a3b10a0ea289c301bedc31866f3daf7875 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:51.775543) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:51.776013) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:51.776287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:51.791716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:51.791981) ========= 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=fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-01 14:08:52-- 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% 43.0M=0s 2017-08-01 14:08:52 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.084285 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:51.892669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:51.892988) ========= 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=fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013897 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:51.942277) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:51.945632) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a3e675a3b10a0ea289c301bedc31866f3daf7875 --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 a3e675a3b10a0ea289c301bedc31866f3daf7875 --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=fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-01 14:08:52,216 truncating revision to first 12 chars 2017-08-01 14:08:52,216 Setting DEBUG logging. 2017-08-01 14:08:52,216 attempt 1/10 2017-08-01 14:08:52,216 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a3e675a3b10a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-01 14:08:52,548 unpacking tar archive at: mozilla-central-a3e675a3b10a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.636590 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:52.597611) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:52.597929) ========= script_repo_revision: a3e675a3b10a0ea289c301bedc31866f3daf7875 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:52.598301) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:52.598574) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-01 14:08:52.607994) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-01 14:08:52.608285) ========= /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=fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:08:52 INFO - MultiFileLogger online at 20170801 14:08:52 in /builds/slave/test 14:08:52 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 14:08:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:08:52 INFO - {'append_to_log': False, 14:08:52 INFO - 'base_work_dir': '/builds/slave/test', 14:08:52 INFO - 'blob_upload_branch': 'Firefox', 14:08:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:08:52 INFO - 'branch': 'Firefox', 14:08:52 INFO - 'buildbot_json_path': 'buildprops.json', 14:08:52 INFO - 'code_coverage': False, 14:08:52 INFO - 'config_files': ('talos/linux_config.py',), 14:08:52 INFO - 'default_actions': ('clobber', 14:08:52 INFO - 'read-buildbot-config', 14:08:52 INFO - 'download-and-extract', 14:08:52 INFO - 'populate-webroot', 14:08:52 INFO - 'create-virtualenv', 14:08:52 INFO - 'install', 14:08:52 INFO - 'setup-mitmproxy', 14:08:52 INFO - 'run-tests'), 14:08:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:08:52 INFO - 'disable_ccov_upload': False, 14:08:52 INFO - 'download_minidump_stackwalk': True, 14:08:52 INFO - 'download_symbols': 'ondemand', 14:08:52 INFO - 'enable_stylo': False, 14:08:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:08:52 INFO - 'tooltool.py': '/tools/tooltool.py', 14:08:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:08:52 INFO - '/tools/misc-python/virtualenv.py')}, 14:08:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:08:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:08:52 INFO - 'gecko_profile': False, 14:08:52 INFO - 'gecko_profile_interval': 0, 14:08:52 INFO - 'installer_path': 'installer.exe', 14:08:52 INFO - 'log_level': 'info', 14:08:52 INFO - 'log_name': 'talos', 14:08:52 INFO - 'log_to_console': True, 14:08:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:08:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:08:52 INFO - 'opt_config_files': (), 14:08:52 INFO - 'pip_index': False, 14:08:52 INFO - 'suite': 'dromaeojs-e10s', 14:08:52 INFO - 'system_bits': '32', 14:08:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:08:52 INFO - 'title': 'talos-linux64-ix-075', 14:08:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:08:52 INFO - 'use_talos_json': True, 14:08:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:08:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:08:52 INFO - 'work_dir': 'build'} 14:08:52 INFO - [mozharness: 2017-08-01 21:08:52.979137Z] Running clobber step. 14:08:52 INFO - Running pre-action listener: _resource_record_pre_action 14:08:52 INFO - Running main action method: clobber 14:08:52 INFO - rmtree: /builds/slave/test/build 14:08:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:08:54 INFO - Running post-action listener: _resource_record_post_action 14:08:54 INFO - [mozharness: 2017-08-01 21:08:54.007319Z] Finished clobber step (success) 14:08:54 INFO - [mozharness: 2017-08-01 21:08:54.007423Z] Running read-buildbot-config step. 14:08:54 INFO - Running pre-action listener: _resource_record_pre_action 14:08:54 INFO - Running main action method: read_buildbot_config 14:08:54 INFO - Using buildbot properties: 14:08:54 INFO - { 14:08:54 INFO - "project": "", 14:08:54 INFO - "product": "firefox", 14:08:54 INFO - "who": "kwierso@gmail.com", 14:08:54 INFO - "installer_path": "public/build/target.tar.bz2", 14:08:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 14:08:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 14:08:54 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 14:08:54 INFO - "stage_platform": "linux64-stylo", 14:08:54 INFO - "basedir": "/builds/slave/test", 14:08:54 INFO - "buildnumber": 12, 14:08:54 INFO - "platform": "ubuntu64_hw_stylo", 14:08:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:08:54 INFO - "slavebuilddir": "test", 14:08:54 INFO - "taskId": "Xc2y9JcHRJS3bQEt-81Cag", 14:08:54 INFO - "branch": "mozilla-central", 14:08:54 INFO - "script_repo_revision": "production", 14:08:54 INFO - "revision": "a3e675a3b10a0ea289c301bedc31866f3daf7875", 14:08:54 INFO - "slavename": "talos-linux64-ix-075", 14:08:54 INFO - "repo_path": "mozilla-central" 14:08:54 INFO - } 14:08:54 INFO - Finding installer, test and symbols from parent task. 14:08:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xc2y9JcHRJS3bQEt-81Cag'}, attempt #1 14:08:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xc2y9JcHRJS3bQEt-81Cag'}, attempt #1 14:08:54 INFO - Task dependencies: Q3D2GEEATdOj72Ov3q5KTg 14:08:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg'}, attempt #1 14:08:55 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2 14:08:55 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.test_packages.json 14:08:55 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.crashreporter-symbols.zip 14:08:55 INFO - Running post-action listener: _resource_record_post_action 14:08:55 INFO - [mozharness: 2017-08-01 21:08:55.376685Z] Finished read-buildbot-config step (success) 14:08:55 INFO - [mozharness: 2017-08-01 21:08:55.376910Z] Running download-and-extract step. 14:08:55 INFO - Running pre-action listener: _resource_record_pre_action 14:08:55 INFO - Running main action method: download_and_extract 14:08:55 INFO - mkdir: /builds/slave/test/build/tests 14:08: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')]} 14:08:55 INFO - trying https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.test_packages.json 14:08:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:08:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:08:55 INFO - Downloaded 989 bytes. 14:08:55 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:08:55 INFO - Using the following test package requirements: 14:08:55 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:08:55 INFO - u'common': [u'target.common.tests.zip'], 14:08:55 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:08:55 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:08:55 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:08:55 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:08:55 INFO - u'mozbase': [u'target.common.tests.zip'], 14:08:55 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:08:55 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:08:55 INFO - u'web-platform': [u'target.common.tests.zip', 14:08:55 INFO - u'target.web-platform.tests.tar.gz'], 14:08:55 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:08:55 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:08:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.common.tests.zip 14:08:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:08:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.common.tests.zip into memory 14:08:57 INFO - Content-Length response header: 72390510 14:08:57 INFO - Bytes received: 72390510 14:09:08 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:09:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.common.tests.zip 14:09:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:09:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.common.tests.zip into memory 14:09:09 INFO - Content-Length response header: 72390510 14:09:09 INFO - Bytes received: 72390510 14:09:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.talos.tests.zip 14:09:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:09:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.talos.tests.zip into memory 14:09:22 INFO - Content-Length response header: 14496467 14:09:22 INFO - Bytes received: 14496467 14:09: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')]} 14:09:22 INFO - trying https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2 14:09:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:09:23 INFO - Downloaded 62159884 bytes. 14:09:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2 14:09:23 INFO - mkdir: /builds/slave/test/properties 14:09:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:09:23 INFO - Writing to file /builds/slave/test/properties/build_url 14:09:23 INFO - Contents: 14:09:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2 14:09:23 INFO - Running post-action listener: _resource_record_post_action 14:09:23 INFO - Running post-action listener: set_extra_try_arguments 14:09:23 INFO - [mozharness: 2017-08-01 21:09:23.991989Z] Finished download-and-extract step (success) 14:09:23 INFO - [mozharness: 2017-08-01 21:09:23.992086Z] Running populate-webroot step. 14:09:23 INFO - Running pre-action listener: _resource_record_pre_action 14:09:23 INFO - Running main action method: populate_webroot 14:09:23 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:09:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:09:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:09:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:09:23 INFO - 'tests': ['damp', 'tps']}, 14:09:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:09:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:09:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:09:23 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 14:09:23 INFO - 'other-e10s': {'tests': ['a11yr', 14:09:23 INFO - 'ts_paint', 14:09:23 INFO - 'tpaint', 14:09:23 INFO - 'sessionrestore', 14:09:23 INFO - 'sessionrestore_many_windows', 14:09:23 INFO - 'sessionrestore_no_auto_restore', 14:09:23 INFO - 'tabpaint']}, 14:09:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 14:09:23 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 14:09:23 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:09:23 INFO - 'talos_options': ['--mitmproxy', 14:09:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:09:23 INFO - '--firstNonBlankPaint'], 14:09:23 INFO - 'tests': ['quantum_pageload_google', 14:09:23 INFO - 'quantum_pageload_youtube', 14:09:23 INFO - 'quantum_pageload_amazon', 14:09:23 INFO - 'quantum_pageload_facebook']}, 14:09:23 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:09:23 INFO - 'talos_options': ['--stylo', 14:09:23 INFO - '--mitmproxy', 14:09:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:09:23 INFO - '--firstNonBlankPaint'], 14:09:23 INFO - 'tests': ['quantum_pageload_google', 14:09:23 INFO - 'quantum_pageload_youtube', 14:09:23 INFO - 'quantum_pageload_amazon', 14:09:23 INFO - 'quantum_pageload_facebook']}, 14:09:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:09:23 INFO - 'tsvgr_opacity', 14:09:23 INFO - 'tart', 14:09:23 INFO - 'tscrollx', 14:09:23 INFO - 'cart', 14:09:23 INFO - 'tsvg_static']}, 14:09:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:09:23 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 14:09:23 INFO - 'talos_options': ['--stylo', 14:09:23 INFO - '--stylo-threads=1', 14:09:23 INFO - '--mitmproxy', 14:09:23 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 14:09:23 INFO - '--firstNonBlankPaint'], 14:09:24 INFO - 'tests': ['tp6_google', 14:09:24 INFO - 'tp6_youtube', 14:09:24 INFO - 'tp6_amazon', 14:09:24 INFO - 'tp6_facebook']}, 14:09:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:09:24 INFO - 'talos_options': ['--xperf_path', 14:09:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:24 INFO - 'tests': ['tp5n']}}} 14:09:24 INFO - Running post-action listener: _resource_record_post_action 14:09:24 INFO - [mozharness: 2017-08-01 21:09:24.000725Z] Finished populate-webroot step (success) 14:09:24 INFO - [mozharness: 2017-08-01 21:09:24.000817Z] Running create-virtualenv step. 14:09:24 INFO - Running pre-action listener: _resource_record_pre_action 14:09:24 INFO - Running main action method: create_virtualenv 14:09:24 INFO - Creating virtualenv /builds/slave/test/build/venv 14:09:24 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 14:09:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:09:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 14:09:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:09:24 INFO - Using real prefix '/usr' 14:09:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:09:24 INFO - Installing distribute.............................................................................................................................................................................................done. 14:09:26 INFO - Installing pip.................done. 14:09:26 INFO - Return code: 0 14:09:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:09:26 INFO - Reading from file tmpfile_stdout 14:09:26 INFO - Output received: 14:09:26 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) 14:09:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:09:26 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')]} 14:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:26 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')]} 14:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:26 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 0x23d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ceb0>, '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 0x273ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', '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 14:09:26 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 14:09:26 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 14:09:26 INFO - Using env: {'DISPLAY': ':0', 14:09:26 INFO - 'HOME': '/home/cltbld', 14:09:26 INFO - 'LANG': 'en_US.UTF-8', 14:09:26 INFO - 'LANGUAGE': 'en_US:en', 14:09:26 INFO - 'LOGNAME': 'cltbld', 14:09:26 INFO - 'MAIL': '/var/mail/cltbld', 14:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:26 INFO - 'MOZ_NO_REMOTE': '1', 14:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:26 INFO - 'NO_EM_RESTART': '1', 14:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:26 INFO - 'PWD': '/builds/slave/test', 14:09:26 INFO - 'SHELL': '/bin/bash', 14:09:26 INFO - 'SHLVL': '1', 14:09:26 INFO - 'TERM': 'linux', 14:09:26 INFO - 'TMOUT': '86400', 14:09:26 INFO - 'USER': 'cltbld', 14:09:26 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', 14:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:26 INFO - '_': '/tools/buildbot/bin/python'} 14:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:27 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 14:09:27 INFO - Cleaning up... 14:09:27 INFO - Return code: 0 14:09:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:09:27 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')]} 14:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:27 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')]} 14:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:27 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 0x23d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ceb0>, '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 0x273ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', '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 14:09:27 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 14:09:27 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 14:09:27 INFO - Using env: {'DISPLAY': ':0', 14:09:27 INFO - 'HOME': '/home/cltbld', 14:09:27 INFO - 'LANG': 'en_US.UTF-8', 14:09:27 INFO - 'LANGUAGE': 'en_US:en', 14:09:27 INFO - 'LOGNAME': 'cltbld', 14:09:27 INFO - 'MAIL': '/var/mail/cltbld', 14:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:27 INFO - 'MOZ_NO_REMOTE': '1', 14:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:27 INFO - 'NO_EM_RESTART': '1', 14:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:27 INFO - 'PWD': '/builds/slave/test', 14:09:27 INFO - 'SHELL': '/bin/bash', 14:09:27 INFO - 'SHLVL': '1', 14:09:27 INFO - 'TERM': 'linux', 14:09:27 INFO - 'TMOUT': '86400', 14:09:27 INFO - 'USER': 'cltbld', 14:09:27 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', 14:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:27 INFO - '_': '/tools/buildbot/bin/python'} 14:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:27 INFO - Downloading/unpacking psutil>=3.1.1 14:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:09:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:28 INFO - Installing collected packages: psutil 14:09:28 INFO - Running setup.py install for psutil 14:09:28 INFO - building 'psutil._psutil_linux' extension 14:09:28 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 14:09:28 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 14:09:28 INFO - building 'psutil._psutil_posix' extension 14:09:28 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 14:09:28 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 14:09:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:28 INFO - Successfully installed psutil 14:09:28 INFO - Cleaning up... 14:09:28 INFO - Return code: 0 14:09:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:28 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 0x23d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ceb0>, '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 0x273ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', '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 14:09:28 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 14:09:28 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 14:09:28 INFO - Using env: {'DISPLAY': ':0', 14:09:28 INFO - 'HOME': '/home/cltbld', 14:09:28 INFO - 'LANG': 'en_US.UTF-8', 14:09:28 INFO - 'LANGUAGE': 'en_US:en', 14:09:28 INFO - 'LOGNAME': 'cltbld', 14:09:28 INFO - 'MAIL': '/var/mail/cltbld', 14:09:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:28 INFO - 'MOZ_NO_REMOTE': '1', 14:09:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:28 INFO - 'NO_EM_RESTART': '1', 14:09:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:28 INFO - 'PWD': '/builds/slave/test', 14:09:28 INFO - 'SHELL': '/bin/bash', 14:09:28 INFO - 'SHLVL': '1', 14:09:28 INFO - 'TERM': 'linux', 14:09:28 INFO - 'TMOUT': '86400', 14:09:28 INFO - 'USER': 'cltbld', 14:09:28 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', 14:09:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:28 INFO - '_': '/tools/buildbot/bin/python'} 14:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:09:29 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 14:09:29 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 14:09:29 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 14:09:29 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 14:09:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:09:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:09:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:09:30 INFO - Installing collected packages: mozsystemmonitor 14:09:30 INFO - Running setup.py install for mozsystemmonitor 14:09:30 INFO - Successfully installed mozsystemmonitor 14:09:30 INFO - Cleaning up... 14:09:30 INFO - Return code: 0 14:09:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:09:30 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')]} 14:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:30 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')]} 14:09:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:30 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 0x23d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ceb0>, '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 0x273ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', '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 14:09:30 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 14:09:30 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 14:09:30 INFO - Using env: {'DISPLAY': ':0', 14:09:30 INFO - 'HOME': '/home/cltbld', 14:09:30 INFO - 'LANG': 'en_US.UTF-8', 14:09:30 INFO - 'LANGUAGE': 'en_US:en', 14:09:30 INFO - 'LOGNAME': 'cltbld', 14:09:30 INFO - 'MAIL': '/var/mail/cltbld', 14:09:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:30 INFO - 'MOZ_NO_REMOTE': '1', 14:09:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:30 INFO - 'NO_EM_RESTART': '1', 14:09:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:30 INFO - 'PWD': '/builds/slave/test', 14:09:30 INFO - 'SHELL': '/bin/bash', 14:09:30 INFO - 'SHLVL': '1', 14:09:30 INFO - 'TERM': 'linux', 14:09:30 INFO - 'TMOUT': '86400', 14:09:30 INFO - 'USER': 'cltbld', 14:09:30 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', 14:09:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:30 INFO - '_': '/tools/buildbot/bin/python'} 14:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:30 INFO - Downloading/unpacking jsonschema==2.5.1 14:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:31 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:31 INFO - warning: no files found matching '*.txt' 14:09:31 INFO - no previously-included directories found matching 'build' 14:09:31 INFO - no previously-included directories found matching 'dist' 14:09:31 INFO - no previously-included directories found matching '.git*' 14:09:31 INFO - Installing collected packages: jsonschema, functools32 14:09:31 INFO - Running setup.py install for functools32 14:09:32 INFO - warning: no files found matching '*.txt' 14:09:32 INFO - no previously-included directories found matching 'build' 14:09:32 INFO - no previously-included directories found matching 'dist' 14:09:32 INFO - no previously-included directories found matching '.git*' 14:09:32 INFO - Successfully installed jsonschema functools32 14:09:32 INFO - Cleaning up... 14:09:32 INFO - Return code: 0 14:09:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:32 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 0x23d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ceb0>, '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 0x273ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', '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 14:09:32 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 14:09:32 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 14:09:32 INFO - Using env: {'DISPLAY': ':0', 14:09:32 INFO - 'HOME': '/home/cltbld', 14:09:32 INFO - 'LANG': 'en_US.UTF-8', 14:09:32 INFO - 'LANGUAGE': 'en_US:en', 14:09:32 INFO - 'LOGNAME': 'cltbld', 14:09:32 INFO - 'MAIL': '/var/mail/cltbld', 14:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:32 INFO - 'MOZ_NO_REMOTE': '1', 14:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:32 INFO - 'NO_EM_RESTART': '1', 14:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:32 INFO - 'PWD': '/builds/slave/test', 14:09:32 INFO - 'SHELL': '/bin/bash', 14:09:32 INFO - 'SHLVL': '1', 14:09:32 INFO - 'TERM': 'linux', 14:09:32 INFO - 'TMOUT': '86400', 14:09:32 INFO - 'USER': 'cltbld', 14:09:32 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', 14:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:32 INFO - '_': '/tools/buildbot/bin/python'} 14:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:09:32 INFO - Cleaning up... 14:09:32 INFO - Return code: 0 14:09:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:32 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 0x23d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ceb0>, '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 0x273ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', '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 14:09:32 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 14:09:32 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 14:09:32 INFO - Using env: {'DISPLAY': ':0', 14:09:32 INFO - 'HOME': '/home/cltbld', 14:09:32 INFO - 'LANG': 'en_US.UTF-8', 14:09:32 INFO - 'LANGUAGE': 'en_US:en', 14:09:32 INFO - 'LOGNAME': 'cltbld', 14:09:32 INFO - 'MAIL': '/var/mail/cltbld', 14:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:32 INFO - 'MOZ_NO_REMOTE': '1', 14:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:32 INFO - 'NO_EM_RESTART': '1', 14:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:32 INFO - 'PWD': '/builds/slave/test', 14:09:32 INFO - 'SHELL': '/bin/bash', 14:09:32 INFO - 'SHLVL': '1', 14:09:32 INFO - 'TERM': 'linux', 14:09:32 INFO - 'TMOUT': '86400', 14:09:32 INFO - 'USER': 'cltbld', 14:09:32 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', 14:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:32 INFO - '_': '/tools/buildbot/bin/python'} 14:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:32 INFO - Downloading/unpacking blobuploader==1.2.4 14:09:32 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 14:09:32 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 14:09:32 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 14:09:32 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 14:09:33 INFO - Downloading blobuploader-1.2.4.tar.gz 14:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:09:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:09:33 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 14:09:33 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 14:09:33 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 14:09:33 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 14:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:09:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:09:33 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 14:09:33 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 14:09:33 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 14:09:33 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 14:09:34 INFO - Downloading docopt-0.6.1.tar.gz 14:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:09:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:09:34 INFO - Running setup.py install for blobuploader 14:09:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:09:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:09:34 INFO - Running setup.py install for requests 14:09:34 INFO - Running setup.py install for docopt 14:09:34 INFO - Successfully installed blobuploader requests docopt 14:09:34 INFO - Cleaning up... 14:09:34 INFO - Return code: 0 14:09:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:34 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')]} 14:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:34 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')]} 14:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:34 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 0x23d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ceb0>, '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 0x273ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', '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 14:09:34 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 14:09:34 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 14:09:34 INFO - Using env: {'DISPLAY': ':0', 14:09:34 INFO - 'HOME': '/home/cltbld', 14:09:34 INFO - 'LANG': 'en_US.UTF-8', 14:09:34 INFO - 'LANGUAGE': 'en_US:en', 14:09:34 INFO - 'LOGNAME': 'cltbld', 14:09:34 INFO - 'MAIL': '/var/mail/cltbld', 14:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:34 INFO - 'MOZ_NO_REMOTE': '1', 14:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:34 INFO - 'NO_EM_RESTART': '1', 14:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:34 INFO - 'PWD': '/builds/slave/test', 14:09:34 INFO - 'SHELL': '/bin/bash', 14:09:34 INFO - 'SHLVL': '1', 14:09:34 INFO - 'TERM': 'linux', 14:09:34 INFO - 'TMOUT': '86400', 14:09:34 INFO - 'USER': 'cltbld', 14:09:34 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', 14:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:34 INFO - '_': '/tools/buildbot/bin/python'} 14:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:35 INFO - Running setup.py (path:/tmp/pip-9VVn3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:35 INFO - Running setup.py (path:/tmp/pip-oPQQGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:35 INFO - Running setup.py (path:/tmp/pip-YNuKkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:35 INFO - Running setup.py (path:/tmp/pip-mXITwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:35 INFO - Running setup.py (path:/tmp/pip-s18vRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:35 INFO - Running setup.py (path:/tmp/pip-04K137-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:35 INFO - Running setup.py (path:/tmp/pip-cUQE1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:35 INFO - Running setup.py (path:/tmp/pip-8i4lSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:35 INFO - Running setup.py (path:/tmp/pip-yngF_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:35 INFO - Running setup.py (path:/tmp/pip-68FACE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:35 INFO - Running setup.py (path:/tmp/pip-Yg6id6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:35 INFO - Running setup.py (path:/tmp/pip-fc3idm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:35 INFO - Running setup.py (path:/tmp/pip-2gfxEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:35 INFO - Running setup.py (path:/tmp/pip-k4wXS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:35 INFO - Running setup.py (path:/tmp/pip-mJm_tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:36 INFO - Running setup.py (path:/tmp/pip-jszVXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:36 INFO - Running setup.py (path:/tmp/pip-6fqri1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:36 INFO - Running setup.py install for manifestparser 14:09:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:09:36 INFO - Running setup.py install for mozcrash 14:09:36 INFO - Running setup.py install for mozdebug 14:09:36 INFO - Running setup.py install for mozdevice 14:09:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:09:36 INFO - Running setup.py install for mozfile 14:09:36 INFO - Running setup.py install for mozhttpd 14:09:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:09:36 INFO - Running setup.py install for mozinfo 14:09:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:09:36 INFO - Running setup.py install for mozInstall 14:09:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:09:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:09:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:09:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:09:36 INFO - Running setup.py install for mozleak 14:09:37 INFO - Running setup.py install for mozlog 14:09:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:09:37 INFO - Running setup.py install for moznetwork 14:09:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:09:37 INFO - Running setup.py install for mozprocess 14:09:37 INFO - Running setup.py install for mozprofile 14:09:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:09:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:09:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:09:37 INFO - Running setup.py install for mozrunner 14:09:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:09:37 INFO - Running setup.py install for mozscreenshot 14:09:37 INFO - Running setup.py install for moztest 14:09:37 INFO - Running setup.py install for mozversion 14:09:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:09:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:09:37 INFO - Cleaning up... 14:09:38 INFO - Return code: 0 14:09:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:38 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')]} 14:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:38 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')]} 14:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:38 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 0x23d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ceb0>, '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 0x273ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', '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 14:09:38 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 14:09:38 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 14:09:38 INFO - Using env: {'DISPLAY': ':0', 14:09:38 INFO - 'HOME': '/home/cltbld', 14:09:38 INFO - 'LANG': 'en_US.UTF-8', 14:09:38 INFO - 'LANGUAGE': 'en_US:en', 14:09:38 INFO - 'LOGNAME': 'cltbld', 14:09:38 INFO - 'MAIL': '/var/mail/cltbld', 14:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:38 INFO - 'MOZ_NO_REMOTE': '1', 14:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:38 INFO - 'NO_EM_RESTART': '1', 14:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:38 INFO - 'PWD': '/builds/slave/test', 14:09:38 INFO - 'SHELL': '/bin/bash', 14:09:38 INFO - 'SHLVL': '1', 14:09:38 INFO - 'TERM': 'linux', 14:09:38 INFO - 'TMOUT': '86400', 14:09:38 INFO - 'USER': 'cltbld', 14:09:38 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', 14:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:38 INFO - '_': '/tools/buildbot/bin/python'} 14:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:38 INFO - Running setup.py (path:/tmp/pip-ejcOqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:38 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)) 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:38 INFO - Running setup.py (path:/tmp/pip-nUDbBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:38 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)) 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:38 INFO - Running setup.py (path:/tmp/pip-YFOEBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:38 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)) 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:38 INFO - Running setup.py (path:/tmp/pip-fdyOyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:38 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)) 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:38 INFO - Running setup.py (path:/tmp/pip-ZRWKuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:38 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)) 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:38 INFO - Running setup.py (path:/tmp/pip-Nkd02E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:38 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)) 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:38 INFO - Running setup.py (path:/tmp/pip-t6XlTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:38 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)) 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:38 INFO - Running setup.py (path:/tmp/pip-axm8Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:38 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)) 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:38 INFO - Running setup.py (path:/tmp/pip-87cJPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:38 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)) 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:38 INFO - Running setup.py (path:/tmp/pip-0kF342-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:38 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)) 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:38 INFO - Running setup.py (path:/tmp/pip-TVi8oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:38 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)) 14:09:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:39 INFO - Running setup.py (path:/tmp/pip-itMSs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:39 INFO - Running setup.py (path:/tmp/pip-LEJb2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:39 INFO - Running setup.py (path:/tmp/pip-DmYZsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:39 INFO - Running setup.py (path:/tmp/pip-mz_f3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:39 INFO - Running setup.py (path:/tmp/pip-9aQgvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:39 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)) 14:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:39 INFO - Running setup.py (path:/tmp/pip-QoipwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:39 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)) 14:09:39 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)) 14:09:39 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)) 14:09:39 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)) 14:09:39 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)) 14:09:39 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)) 14:09:39 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)) 14:09:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:09:39 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 14:09:39 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 14:09:39 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 14:09:39 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 14:09:40 INFO - Downloading blessings-1.6.tar.gz 14:09:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:09:40 INFO - Installing collected packages: blessings 14:09:40 INFO - Running setup.py install for blessings 14:09:40 INFO - Successfully installed blessings 14:09:40 INFO - Cleaning up... 14:09:40 INFO - Return code: 0 14:09:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:09:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:40 INFO - Reading from file tmpfile_stdout 14:09:40 INFO - Current package versions: 14:09:40 INFO - argparse == 1.2.1 14:09:40 INFO - blessings == 1.6 14:09:40 INFO - blobuploader == 1.2.4 14:09:40 INFO - docopt == 0.6.1 14:09:40 INFO - functools32 == 3.2.3-2 14:09:40 INFO - jsonschema == 2.5.1 14:09:40 INFO - manifestparser == 1.1 14:09:40 INFO - mozInstall == 1.13 14:09:40 INFO - mozcrash == 1.0 14:09:40 INFO - mozdebug == 0.1 14:09:40 INFO - mozdevice == 0.51 14:09:40 INFO - mozfile == 1.2 14:09:40 INFO - mozhttpd == 0.7 14:09:40 INFO - mozinfo == 0.10 14:09:40 INFO - mozleak == 0.1 14:09:40 INFO - mozlog == 3.5 14:09:40 INFO - moznetwork == 0.27 14:09:40 INFO - mozprocess == 0.25 14:09:40 INFO - mozprofile == 0.28 14:09:40 INFO - mozrunner == 6.13 14:09:40 INFO - mozscreenshot == 0.1 14:09:40 INFO - mozsystemmonitor == 0.3 14:09:40 INFO - moztest == 0.8 14:09:40 INFO - mozversion == 1.4 14:09:40 INFO - psutil == 3.1.1 14:09:40 INFO - requests == 1.2.3 14:09:40 INFO - wsgiref == 0.1.2 14:09:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:40 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')]} 14:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:40 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')]} 14:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:40 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 0x23d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ceb0>, '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 0x273ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', '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 14:09:40 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 14:09:40 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 14:09:40 INFO - Using env: {'DISPLAY': ':0', 14:09:40 INFO - 'HOME': '/home/cltbld', 14:09:40 INFO - 'LANG': 'en_US.UTF-8', 14:09:40 INFO - 'LANGUAGE': 'en_US:en', 14:09:40 INFO - 'LOGNAME': 'cltbld', 14:09:40 INFO - 'MAIL': '/var/mail/cltbld', 14:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:40 INFO - 'MOZ_NO_REMOTE': '1', 14:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:40 INFO - 'NO_EM_RESTART': '1', 14:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:40 INFO - 'PWD': '/builds/slave/test', 14:09:40 INFO - 'SHELL': '/bin/bash', 14:09:40 INFO - 'SHLVL': '1', 14:09:40 INFO - 'TERM': 'linux', 14:09:40 INFO - 'TMOUT': '86400', 14:09:40 INFO - 'USER': 'cltbld', 14:09:40 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', 14:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:40 INFO - '_': '/tools/buildbot/bin/python'} 14:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:41 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)) 14:09:41 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)) 14:09:41 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)) 14:09:41 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)) 14:09:41 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)) 14:09:41 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)) 14:09:41 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)) 14:09:41 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)) 14:09:41 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)) 14:09:41 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 14:09:41 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 14:09:41 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 14:09:41 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 14:09:41 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 14:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 14:09:42 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)) 14:09:42 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)) 14:09:42 INFO - Installing collected packages: simplejson 14:09:42 INFO - Running setup.py install for simplejson 14:09:42 INFO - building 'simplejson._speedups' extension 14:09:42 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 14:09:43 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 14:09:43 INFO - Successfully installed simplejson 14:09:43 INFO - Cleaning up... 14:09:43 INFO - Return code: 0 14:09:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:09:43 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')]} 14:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:43 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')]} 14:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:43 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 0x23d01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x259ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273ceb0>, '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 0x273ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e240>, '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': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', '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 14:09:43 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 14:09:43 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 14:09:43 INFO - Using env: {'DISPLAY': ':0', 14:09:43 INFO - 'HOME': '/home/cltbld', 14:09:43 INFO - 'LANG': 'en_US.UTF-8', 14:09:43 INFO - 'LANGUAGE': 'en_US:en', 14:09:43 INFO - 'LOGNAME': 'cltbld', 14:09:43 INFO - 'MAIL': '/var/mail/cltbld', 14:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:43 INFO - 'MOZ_NO_REMOTE': '1', 14:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:43 INFO - 'NO_EM_RESTART': '1', 14:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:43 INFO - 'PWD': '/builds/slave/test', 14:09:43 INFO - 'SHELL': '/bin/bash', 14:09:43 INFO - 'SHLVL': '1', 14:09:43 INFO - 'TERM': 'linux', 14:09:43 INFO - 'TMOUT': '86400', 14:09:43 INFO - 'USER': 'cltbld', 14:09:43 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', 14:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:43 INFO - '_': '/tools/buildbot/bin/python'} 14:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:09:43 INFO - Cleaning up... 14:09:43 INFO - Return code: 0 14:09:43 INFO - Running post-action listener: _resource_record_post_action 14:09:43 INFO - Running post-action listener: _start_resource_monitoring 14:09:43 INFO - Starting resource monitoring. 14:09:43 INFO - [mozharness: 2017-08-01 21:09:43.678366Z] Finished create-virtualenv step (success) 14:09:43 INFO - [mozharness: 2017-08-01 21:09:43.678880Z] Running install step. 14:09:43 INFO - Running pre-action listener: _resource_record_pre_action 14:09:43 INFO - Running main action method: install 14:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:43 INFO - Reading from file tmpfile_stdout 14:09:43 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:09:44 INFO - Reading from file tmpfile_stdout 14:09:44 INFO - Output received: 14:09:44 INFO - Usage: mozinstall [options] installer 14:09:44 INFO - Options: 14:09:44 INFO - -h, --help show this help message and exit 14:09:44 INFO - -d DEST, --destination=DEST 14:09:44 INFO - Directory to install application into. [default: 14:09:44 INFO - "/builds/slave/test"] 14:09:44 INFO - --app=APP Application being installed. [default: firefox] 14:09:44 INFO - mkdir: /builds/slave/test/build/application 14:09:44 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'] 14:09:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:10:02 INFO - Reading from file tmpfile_stdout 14:10:02 INFO - Output received: 14:10:02 INFO - /builds/slave/test/build/application/firefox/firefox 14:10:02 INFO - Running post-action listener: _resource_record_post_action 14:10:02 INFO - [mozharness: 2017-08-01 21:10:02.028951Z] Finished install step (success) 14:10:02 INFO - [mozharness: 2017-08-01 21:10:02.029095Z] Running setup-mitmproxy step. 14:10:02 INFO - Running pre-action listener: _resource_record_pre_action 14:10:02 INFO - Running main action method: setup_mitmproxy 14:10:02 INFO - Skipping: mitmproxy is not required 14:10:02 INFO - Running post-action listener: _resource_record_post_action 14:10:02 INFO - [mozharness: 2017-08-01 21:10:02.030019Z] Finished setup-mitmproxy step (success) 14:10:02 INFO - [mozharness: 2017-08-01 21:10:02.030242Z] Running run-tests step. 14:10:02 INFO - Running pre-action listener: _resource_record_pre_action 14:10:02 INFO - Running pre-action listener: _set_gcov_prefix 14:10:02 INFO - Running main action method: run_tests 14:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:10:02 INFO - Python 2.7.3 14:10:02 INFO - Return code: 0 14:10:02 INFO - grabbing minidump binary from tooltool 14:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:10:02 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 0x273ceb0>, '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 0x273ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x273e240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:10:02 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 14:10:02 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 14:10:02 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 14:10:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:10:02 INFO - Return code: 0 14:10:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:10:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:10:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:10:02 INFO - ENV: RUST_BACKTRACE is now 1 14:10:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:10:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:10:02 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/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 14:10:02 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/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --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 14:10:02 INFO - Using env: {'DISPLAY': ':0', 14:10:02 INFO - 'HOME': '/home/cltbld', 14:10:02 INFO - 'LANG': 'en_US.UTF-8', 14:10:02 INFO - 'LANGUAGE': 'en_US:en', 14:10:02 INFO - 'LOGNAME': 'cltbld', 14:10:02 INFO - 'MAIL': '/var/mail/cltbld', 14:10:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:10:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:10:02 INFO - 'MOZ_NO_REMOTE': '1', 14:10:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:10:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:10:02 INFO - 'NO_EM_RESTART': '1', 14:10:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:10:02 INFO - 'PWD': '/builds/slave/test', 14:10:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:10:02 INFO - 'RUST_BACKTRACE': '1', 14:10:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 14:10:02 INFO - 'SHELL': '/bin/bash', 14:10:02 INFO - 'SHLVL': '1', 14:10:02 INFO - 'STYLO_FORCE_ENABLED': '1', 14:10:02 INFO - 'TERM': 'linux', 14:10:02 INFO - 'TMOUT': '86400', 14:10:02 INFO - 'USER': 'cltbld', 14:10:02 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694', 14:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:10:02 INFO - '_': '/tools/buildbot/bin/python'} 14:10:02 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/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--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 14:10:02 INFO - mozversion application_buildid: 20170801201729 14:10:02 INFO - mozversion application_changeset: a3e675a3b10a0ea289c301bedc31866f3daf7875 14:10:02 INFO - mozversion application_display_name: Nightly 14:10:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:10:02 INFO - mozversion application_name: Firefox 14:10:02 INFO - mozversion application_remotingname: firefox 14:10:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:10:02 INFO - mozversion application_vendor: Mozilla 14:10:02 INFO - mozversion application_version: 56.0a1 14:10:02 INFO - mozversion platform_buildid: 20170801201729 14:10:02 INFO - mozversion platform_changeset: a3e675a3b10a0ea289c301bedc31866f3daf7875 14:10:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:10:02 INFO - mozversion platform_version: 56.0a1 14:10:02 INFO - using testdate: 1501621802 14:10:02 INFO - actual date: 1501621802 14:10:02 INFO - starting webserver on 'localhost:49537' 14:10:02 INFO - SUITE-START | Running 2 tests 14:10:02 INFO - TEST-START | dromaeo_css 14:10:02 INFO - Initialising browser for dromaeo_css test... 14:10:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49537/getInfo.html -profile /tmp/tmpyIHTv7/profile 14:10:02 INFO - TEST-INFO | started process 23238 (/builds/slave/test/build/application/firefox/firefox http://localhost:49537/getInfo.html) 14:10:08 INFO - TEST-INFO | 23238: exit 0 14:10:08 INFO - Browser initialized. 14:10:08 INFO - Running cycle 1/1 for dromaeo_css test... 14:10:08 INFO - TEST-INFO | started process 23464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyIHTv7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:09 INFO - PID 23464 | 14:10:09 INFO - PID 23464 | (/builds/slave/test/build/application/firefox/firefox:23519): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:10:09 INFO - PID 23464 | 14:10:20 INFO - PID 23464 | RSS: Main: 173920256 14:10:20 INFO - PID 23464 | 14:13:19 INFO - PID 23464 | Cycle 1(1): loaded http://localhost:49537/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49537/tests/dromaeo/cssquery-ext.html) 14:13:21 INFO - PID 23464 | RSS: Main: 176222208 14:13:21 INFO - PID 23464 | 14:16:23 INFO - PID 23464 | Cycle 1(1): loaded http://localhost:49537/tests/dromaeo/cssquery-ext.html (next: http://localhost:49537/tests/dromaeo/cssquery-jquery.html) 14:16:23 INFO - PID 23464 | RSS: Main: 173678592 14:16:23 INFO - PID 23464 | 14:19:25 INFO - PID 23464 | Cycle 1(1): loaded http://localhost:49537/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49537/tests/dromaeo/cssquery-mootools.html) 14:19:26 INFO - PID 23464 | RSS: Main: 175075328 14:19:26 INFO - PID 23464 | 14:22:28 INFO - PID 23464 | Cycle 1(1): loaded http://localhost:49537/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49537/tests/dromaeo/cssquery-prototype.html) 14:22:28 INFO - PID 23464 | RSS: Main: 174432256 14:22:28 INFO - PID 23464 | 14:25:32 INFO - PID 23464 | Cycle 1(1): loaded http://localhost:49537/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49537/tests/dromaeo/cssquery-yui.html) 14:25:33 INFO - PID 23464 | RSS: Main: 177627136 14:25:33 INFO - PID 23464 | 14:28:35 INFO - PID 23464 | Cycle 1(1): loaded http://localhost:49537/tests/dromaeo/cssquery-yui.html (next: http://localhost:49537/tests/dromaeo/cssquery-dojo.html) 14:28:35 INFO - PID 23464 | RSS: Main: 176627712 14:28:35 INFO - PID 23464 | 14:28:35 INFO - PID 23464 | __start_tp_report 14:28:35 INFO - PID 23464 | _x_x_mozilla_page_load 14:28:35 INFO - PID 23464 | _x_x_mozilla_page_load_details 14:28:35 INFO - PID 23464 | |i|pagename|runs| 14:28:35 INFO - PID 23464 | |0;dojo.html;3118.064580625813;3164.8259345735987;3167.572377729006;3188.394205101031;3239.433099207638;6105.389461053893;6261.186045814044;6296.748130074803;6310.905336419952;6340.587861788992;6097.756089756404;6211.813645590628;6248.562600617958;6270.028145637433;6278.121063051177;5666.546676265889;5671.886562268763;5707.3721890592005;5723.627964182315;5728.16941543476;5756.280464941882;5785.566082543805;5830.912536311958;5848.035074212749;5862.677552734598;5752.971235143818;5805.158252053449;5815.5638327125425;5836.9785287574505;5891.764329426818;5560;5763.596548241625;5773.2494775679315;5853.912191317134;5864.501517371007;5137.51193636604;5616.719164041781;5649.49154576086;5728.742206600713;5737.2254745609225;6113.877722445571;6160.722767475474;6177.474914632262;6212.316645169028;6260.499160067229;6518.511111666644;6599.977003564455;6613.966930165367;6627.701753421107;6814.965925170342;6706.094677218611;6744.93255067448;6747.460203183734;6751.628660423675;6757.020232066323;6219.875602487925;6221.782237621662;6222.408871157233;6223.284322302902;6234.594751341148;6891.620960847202;6894.207166175854;6894.24163342032;6894.931050689529;6896.310368963063;6478.805635830839;6541.542092053605;6562.868742625121;6572.14562106923;6572.671366431659;6569.737210511622;6607.636579988147;6612.23959244693;6641.833954151185;6731.124953756078;6673.9332606673315;6675.399214070757;6696.59820410777;6731.562448440835;6790.558613690193;6679.7662081827875;6734.326567343324;6787.355201255873;6833.248342682301;6844.041834143224;5296.3909150447425;5374.193870919394;5381.9461805382225;5393.083175860113;5397.78408863641;4643.674942753974;4681.789319480631;4698;4705.905881882411;4725.102230576248;5760.654360738369;5807.361190269067;5840.912386314124;5841.853953651108;5847.327557330961;6730.226024007204;6737.52837301394;6738.59568425896;6750.088738020305;6835.555688880307;5706.315242170883;5765.394633563499;5791.565632577489;5811.82564523065;5844;5891.793787217427;5897.882042359129;5977.910331345033;5982;5983.0128028875615;6566.474682025522;6584.11114499546;6608.207015158116;6631.104800851823;6659.167604049494;6799.796006119825;6803.625800581016;6873.5875847449315;6882.311768823078;6899.551529150589;6376.075469057054;6558.1802274715665;6561.934380656132;6580.5064620152725;6635.1374321339845;6545.770898018546;6546.967265163644;6549.148610680581;6556.8360790980605;6572.178477690289;6629.966850165718;6707.061011458497;6810.6594670265295;6825.863482730417;6828.624425656637;6607.702653380513;6628.138342015507;6634.104395906491;6635;6640.169978752656;6527.804165875032;6532.608043517404;6539.019147127969;6622.503312251504;6626.337366263335;6388.68056597159;6459.128017717548;6460.483161346987;6473.902891456538;6539.803805885831;6465.515086368635;6540.803775886731;6559.7376104955265;6662.367075127855;6662.766803161866;6465.903011454926;6474.611523308617;6490.675466226764;6492.123563318892;6518.152640156749 14:28:35 INFO - PID 23464 | |1;ext.html;812.5977641067673;858.3305022082776;890.7951171230621;900.1673452056848;1159.7912375772357;30136.698633013664;30767.538486922713;40907;41663;41708.37437438433;41787.79106104465;42176.578234217726;42366;42392.36411453831;42434.57565424345;7658.6553605087765;7693.692252309901;7807.6876924922935;7809.921900781004;7830.765077047698;7679.6928122875015;7779.183185765498;7794.142644309121;7798.103218129902;7802.570858602775;7741.148473667892;7806.375489960789;7807.492512986638;7809.453338266324;7834.0990786059765;7759.45683802134;7777.494462859924;7799.571023593729;7835.764927052198;7845.882311765271;7702.422318326092;7703.576303303316;7708.653110610036;7715.344195743369;7717.961410192913;36957.44563831545;37284.81357593195;37361.439578406345;37386.06534836651;37392.813035934916;3536.3457760314423;3543.061088811467;3555.768875023141;3568.3933731265747;3579.8926032219074;30733.231669208224;30845.845770771004;30866.84566577175;30877.69122308793;30915.22711932197;4760.666753327268;4778.952210477885;4808.374911261549;4831.396075490564;4858.587020103296;188987;189109.05445472823;189321;189908;190192;46919.296210556866;46975;46995;47030.76484617555;47320.763396182796;53916.46083539193;54855.725721371135;55018.449815501335;55213.72393138089;55263.447365526634;16552.42066527666;16557.337706491606;16618.58453538647;16621.66756664884;16699.83300167007;12168.81746773799;12194.39028048594;13459.730805383837;13807.654808629864;13836;14353.354099065567;14363.56909292702;14402.495912643217;14485.92757036208;14602.853971460361;5551.777928882881;5765.394633563499;5828.88342233153;5851.531877449794;5979.252593425822;961.4711908450324;968.5254225429488;975.1223898491272;1019.6686077024997;1021.5147804792664;22191.66712499314;22229.555408892054;22541.88729056377;23027.309180724606;23305.417364566023;1084.4089970965842;1102.1458369763336;1103.1064837481506;1106.7106820554125;1122.4836575175348;11768.76462470763;11834.289942603471;11912.344821034927;12032.27806331623;12133.878661213275;245318;245706;245880;247587;248658;51995.74002130041;52350.47649523456;52371.47628523742;52384.21423678648;52435.73782131065;1448.2541491132076;1460.8173978252505;1466.5820241231197;1475.0264825215306;1485.68057867559;21429.89285053565;21595.2441664541;22230.333090007327;22466.887665561568;23081.65377519372;48499.51500485091;49937.25094123519;50103;50245.74877125591;50286;211626;215371;215388;215911;216186;31525;32102.19744506406;32144.357112857146;32154;35176.82411587926;43826;44028;44099.559004409544;44494;44519.332210016226;29163.562546562243;30963.535546967265;32171.67828321687;32218.19454513656;32242;30977.845110774302;31325;31725.682743173194;32242.677573223966;32475.67524324821;34018;34111.82944085363;34296.31407371889;34400.82799585986;34408.13979650529;29075.563866541597;29764.255893602833;30412;31022.37955240928;31335.84332078325;21208.787912121297;22770.43073923099;22895.656565151203;22920;23406.414839629146 14:28:35 INFO - PID 23464 | |2;jquery.html;567.1719289836838;581.8545363659085;584.9999999999998;598.5600583571074;603.5986069263939;22006.229781957616;22920.312390628267;22954.655680164768;23036.078556857705;23069.423264418376;26692.466150676973;27157;27346.45307093857;27367.315817104583;27467.725322746817;6538.999999999988;6704.664766761667;6705.32946705328;6708.262091169968;6721.294264102272;6380.808575742712;6580.012998050307;6647.833804154887;7011.544249623784;7033.613151276678;7031.085958825345;7045.401140903029;7051;7054.435645148375;7056.576605403667;7060.82347941303;7060.858782824341;7092.042574252488;7095.254998225164;7096.042034325404;6942.271061538516;6942.409895158918;6948.200956889972;6950.061741664861;6951.409130223937;31311.53032704511;32298;32332;32344.353112937846;32570.511442328385;1953.599512100016;2013.0840467587213;2013.6979453082008;2014.4359579317668;2014.7078673592393;20448;20887.8955605221;21002.579948400948;21080.789192108037;21102;2405;2433.3065076453126;2513.7863281621085;2529.620556916459;2535.8605276709773;144543;148628;149100;150876;150942.24528877286;19510.024943639564;21686.783132168475;21901.99136276408;22244.55510889773;22462.77537224607;45633;45683;45772;45850.312245316345;46293.30560041602;11580.88419115798;11597.130215233723;11780.410979450993;11804.70488237801;11840.28958262507;9619.374740641835;9625.855612165824;9738.220942324597;9833.360831545926;9927.453990030617;9164.816703665889;11113.83329250062;11128.443577821077;11627.53489860413;11860.983632782447;4084.9795751021647;4175.728577642443;4231.830726770895;4441.955580444154;4524.773761311987;947.7677968897664;960.6847497530916;964.6430820596283;981.4503877828439;995.1640621877513;19467.50586942382;19566.510837229183;19883.508736844793;19912.90043549802;20373.898130509253;1012.9189664826796;1033.565902321027;1036.5646428500047;1037.2169012395743;1040.1990467340106;10460;10594.788104238027;10825.891741082645;11175.273607215668;11243.775124497464;520941;535884;536777;539920;542501;120494;130222.34888825496;130722;131936.3403182978;134694;1235.178606226867;1247.9438425270703;1285.2866659004155;1288.407332627002;1288.4910460368103;19983.500412489804;20969.475763106046;21082.78917210808;22108.115675372806;22232.666510002688;58672.4132758684;59177;59438.70280648742;60519.39480605138;63256.68371658112;71046;71630;71693.641531792;72093.63953180201;72231.63884180546;15150.090994540364;15398.769018464507;15515.612109697347;15584;15605.141717205208;24032.39919002039;24162;24372.51254974926;24497.877510612332;24951.251462456155;18823.34118305853;19142.330018449844;19153.329633462763;19223.90388048051;19275.132619032458;16241.51275461738;16539.66920661604;17083.316667333664;17260.91369543144;17592.472225833244;19338.709919351502;19384.32154874629;19785.505362366057;19787;19872.105755241337;15216.695666086838;15221.315040822969;15350.539483815503;15395.61510962235;15398.384064637288;18263.81736182621;19193.52016199606;19234.326798561982;19252.518687032374;19380.612387752448 14:28:35 INFO - PID 23464 | |3;mootools.html;1366.9658258543536;1396.6298930783344;1441.0921119694594;1448.254149113207;1453.5784622459487;13695.24676142813;14364.640883977892;14458.855411445882;14461.855381446183;14482.131072135679;13438.5296514622;14089.788653170212;14474.710505789877;14488.85511144891;14585.635359116028;2716.5381885079532;2765.6681198256238;2776.5141100307465;2778.6804517480546;2780.471710375022;2502.637117617953;2623;2629.618705287732;2671.3722275265295;2755.256080858167;2736.9178924632292;2773.5423655096884;2774.1122840690987;2778.6804517480546;2783.2902609834464;2652.787776977837;2684.852333121668;2690.367763575558;2699.284689557269;2702.8648567571545;2582.5093232285994;2620.685517737884;2644.6033095035705;2651.363672718553;2661.3878807874103;13810.37853296594;14055.718885622333;14119.223442710647;14134.293285335794;14138.575842724631;7459.664315105779;7777.766666999999;7779.416543759184;7780.8832867507035;7788.493747906368;5061.2661164131;5186.7147306898105;5321.3348331458565;5376.11294136467;5418.458154184589;1856.8421684156863;1876.4370688793308;1877.3189323426034;1891.7824450188266;1918.3669389101563;23925.760742392526;24197.758022419726;24259;24276.150334738377;24285;6615.536912416181;6620.5034622402545;6707;6749.055132281386;6817.9659101705165;16229.107399092927;16286.918565407097;16323.755143672854;16339;16363.509094727176;7648.502847314907;7686.807829804299;7764.805879853049;7765.029371328584;7822.022247219098;6971.54684945487;7068.646567671596;7087.574745515182;7095.184053833772;7207.207207207203;4862.878428039327;5062.240663900445;5062.316587260746;5113.769880355393;5159.406668233201;1392.463901397969;1400.4888215801159;1475.2623688155923;1475.8671719545293;1493.7834014068117;867.1458613265928;869.0744357259498;901.2654686430539;916.8578870275118;933.5192375926404;7988.760337189894;8104.797380065545;8158.388120890957;8214.671413143407;8267.751967440987;952.8808898887639;960.3279168496477;1009.7847747116509;1012.0031768707817;1034.1054987435814;4892.461829198785;5029.67307125043;5035.924461133086;5090.2364645303505;5293.523582877559;19399.8060019398;20237.08933098014;20344.287949921978;20358.28745993883;20377.694334584994;19236.422907312804;19645.214191432184;19958.30145944914;19967.900160499394;19990;10640.361578305326;11157;11223;11231.21381503287;11232.887671123348;7529.962350188214;7971.1630278819885;8166.183381661786;8370.204830541088;8390.496570205807;16790.832091678927;16867.493975180765;17198.398056067977;17403.56491087733;17687.64624707473;17426.128693565017;17468.47594572165;17674.823251767833;17779.555511112325;17806.198721057324;11219.326840389604;11626.244294120856;11646.592369267373;11654.766904662029;11660.941695291469;12845;12868.742625147257;12895.484180633044;13133.868661313265;13291.20252784836;9876.901230987885;10007.249456290661;10792.568297268335;10849.783004340026;10850.78298434011;10182.89817101849;10717;10755.677329680122;10761.354318740901;11041.00630943219;9402.38884472507;9528.094830991045;9596.23230141573;9601.279904007368;9633.951830241085;6661.2006559213205;6802.367431816428;6948.965255173692;7002.8949565757575;7032.12098487689;7128.786136415916;7254.668372724717;7290.3438690518105;7347.302006309392;7486.8876966844455 14:28:35 INFO - PID 23464 | |4;prototype.html;473.4484325760489;486.84420985284703;506.89608630230794;508.9262057001735;518.6939705573714;6183.907241391383;6232.130360891737;6277.278113016999;6296.1814964054665;6354.841128971772;5887.175795388649;6032.66820324882;6052.757889684407;6071.753451223042;6074.969625151868;4916.877078073059;4917.803287868481;4932.728699921512;4941.234108713137;4948.084604348207;4750.691205071676;4876.536729010738;4890.853274401774;4945.752712364385;4993.975030124844;4778.78495467703;4812.518748125177;4885.267209918505;4886.096072226632;4901;4802.574699776608;4835.395575553056;4844;4872.805087796466;4884.780184891689;4313.331433627793;4327.0913108247305;4338.327559228324;4353.303471444586;4353.390525326457;5975.133605627203;5986.670733109677;6018.3981601839905;6034.607750496248;6052.001419765734;5550.805721799758;5552.305961754781;5590.888182236333;5617.9438205618235;5652.406497317764;6230.292975679464;6368.777092801776;6452.225732912034;6469;6493.577917435398;4696.436427628706;4701.600363969067;4716.985848042653;4742.9525704742855;4757.785899634525;6799.7280108795585;6861.965690171567;6917.273686262971;6937.583744975318;6971.361729993448;4822.807087716522;4843.95156048435;4854.393200849894;4867.488913664014;4880.6095512358925;4851.854444366674;4908.705477671279;4915.48387419323;4935.876603084952;4946.233333833262;5501.5323697486165;5536.889262214733;5552.056150454432;5579.6652200868075;5635.267415235993;6429;6548.443382312462;6585.6707164641575;6593.6703164841565;6658.933410665928;1661.7424299233637;1685.3511398111816;1691.8918108638861;1739.1825841854309;1750.737389391576;1188.7860185166753;1201.165190192825;1206.879312068786;1213.0901823632275;1225.9203151795105;5637.126245431965;5643.887122257532;5645.915311270334;5690.374058853523;5705.857353566111;6579.947208446722;6594.142761441078;6708.496862735315;6759.526833121733;6793;5794.536437085023;5810.709464526757;5860.736266868002;5867.207926929896;5896.469317761336;3561.5370001900105;3584.175639602906;3608.440691692792;3640.3447379471418;3649.708023358125;6664;6671.666416679147;6682.131322927989;6682.3317668232785;6697.7655782047395;6947.201071876698;6966.233714291424;6970.41023872706;6997.335253150943;7033.5887094759;6555.704993275314;6563.901541476977;6583.407493325528;6620.801375958729;6628.767993120314;6780.762673306411;6781.152355955505;6816.386525212754;6833.58998460094;6842.24735279109;6620.668966551557;6633.734650613921;6723.663816809238;6751;6772.25505194438;6543.640099794557;6571.934280657132;6606.645637644176;6650.20197576294;6659.53383263167;4962.578180854668;4974.5771609413605;4983.127952608352;4992.375953005874;5011.949880501148;6682.83292917681;6686.364795344434;6736.191657001191;6781.186257649114;6857.862842743217;6484.513661475314;6499.545031847725;6518.706658200487;6539.6403197824575;6580.703868325841;6286.874262514815;6427.678616069272;6557.704903279459;6626.807174708406;6633.933660663524;6279.215098112736;6380.393862583047;6455.257645370654;6497.945965396256;6567.704453299518;6491.156149700509;6515.8597245480905;6638.800835974928;6681.46548276127;6704.899426508508;6368.649724265025;6391.904121438275;6440.6135631862235;6458.160439142881;6484.416402523607 14:28:35 INFO - PID 23464 | |5;yui.html;907.2877790934118;916.4867674102501;931.2736065868622;932.44519510891;936.344558808834;16833.747493787603;17284.395046173388;17288.91355543222;17300;18427.53931151722;20506.794932050674;21360.786392136073;21484.677729834064;21530.569388612217;21565.784342156574;976.3068221562681;983.7147227304073;986.4623780039859;991.459654488302;998.6354980432126;1009.8033829911542;1066.184368957748;1068.6580294305825;1070.288258308228;1071.2394200117926;1120.8150655141933;1127.7518945831903;1129.2377645089573;1130.028175768838;1130.073339861314;1112.410422476085;1112.855328807258;1114.2534501883758;1115.5259014918627;1121.8205087186052;802.7912742686885;804.6901942752082;810.849992751337;812.25272749071;813.0893399392659;18239.908800456047;19260.807391926042;19488.70766938497;19530.609387812307;19550;19492;20398.28605998783;20674.586508269902;20813.479663008395;20833.89583052075;15754.842451575452;15881.047137171807;15920.681586368324;15948.122853243067;16000.199990000454;3496.143444856001;3568.839402226906;3589.0847833802213;3589.4795254688183;3590.299891521154;117125.4143729276;120310.39844800807;123658.9999999991;129931.35034324862;136550.31724841413;15918.522444326689;16574.254158562893;16620.501384958472;16626.916865415595;16628.58428539272;28642.85678571594;29909.70090299069;29971.850140749157;30018;30114.69885301119;7348.375388092072;7584.393248540104;8883.333749968779;8921.598528066253;8925.642974281085;4129.772862492532;4282.9785851071165;4288.871333859989;4289.957100429018;4290.420793192879;5157.793688252428;5265.368155821249;5265.657732247391;5272.92090618641;5593.133064375028;1138.1805100327751;1156.439127023393;1161.7269941563725;1162.151629310591;1165.1319766773638;692.7609974558769;696.9581825090511;707.1302298173275;708.9680964356617;726.9927300727031;11692.824607630891;11772.823407648892;12506.81239781404;12556.246625202517;12879.871201288055;652.797632733854;664.6563457367282;695.7147569496583;713.564725517434;718.4719231365048;5199.272101905736;6016.488598469179;6629.635370054693;6671.366220209073;6671.799846004627;103663;104912;105596;107042;108383;90284;90787.42002882189;90825.54587227022;91961.5401922986;93196.53401732948;83793.58103209567;86585;87758.56120719356;90771;91220.54389728142;11822.881771182178;12599.93412581964;12743.808842867178;12758.808617870554;12773.872261277269;36220.51159645212;36941.815290923376;37248.44127338038;37411.10028237934;38319.42520862134;46990.53009469862;47253.76373118113;47966;48279.51720482891;69657;19184;19398.90300548488;19480.318188863323;19668.213271469554;19718.40844774659;18328.725069123706;19173.32893348726;21533.676994845402;21633.675494867275;22453;16370.263338150051;17125.05812180342;17997.010164441082;19205.231790728216;20791.68812467784;20456.69314960247;20623.79376206219;20817.375478735663;20909.26817561378;21322.78677213208;18692;18959;19040.238390464227;20033.499162521053;20924.47688807792;13196.670083247996;13848.792268115785;13945.442182312594;14177.716445671234;14202.502912398017;14740.410383584536;14818.77771833445;15231.390744370101;15351.61620959485;15423 14:28:35 INFO - PID 23464 | __end_tp_report 14:28:35 INFO - PID 23464 | __start_cc_report 14:28:35 INFO - PID 23464 | _x_x_mozilla_cycle_collect,359 14:28:35 INFO - PID 23464 | __end_cc_report 14:28:35 INFO - PID 23464 | __startTimestamp1501622915511__endTimestamp 14:28:35 INFO - PID 23464 | 14:28:35 INFO - PID 23464 | ------- Summary: start ------- 14:28:35 INFO - PID 23464 | Number of tests: 6 14:28:35 INFO - PID 23464 | 14:28:35 INFO - PID 23464 | [#0] dojo.html Cycles:165 Average:6184.76 Median:6474.61 stddev:734.61 (11.3%) stddev-sans-first:696.35 14:28:35 INFO - PID 23464 | Values: 3118.1 3164.8 3167.6 3188.4 3239.4 6105.4 6261.2 6296.7 6310.9 6340.6 6097.8 6211.8 6248.6 6270.0 6278.1 5666.5 5671.9 5707.4 5723.6 5728.2 5756.3 5785.6 5830.9 5848.0 5862.7 5753.0 5805.2 5815.6 5837.0 5891.8 5560.0 5763.6 5773.2 5853.9 5864.5 5137.5 5616.7 5649.5 5728.7 5737.2 6113.9 6160.7 6177.5 6212.3 6260.5 6518.5 6600.0 6614.0 6627.7 6815.0 6706.1 6744.9 6747.5 6751.6 6757.0 6219.9 6221.8 6222.4 6223.3 6234.6 6891.6 6894.2 6894.2 6894.9 6896.3 6478.8 6541.5 6562.9 6572.1 6572.7 6569.7 6607.6 6612.2 6641.8 6731.1 6673.9 6675.4 6696.6 6731.6 6790.6 6679.8 6734.3 6787.4 6833.2 6844.0 5296.4 5374.2 5381.9 5393.1 5397.8 4643.7 4681.8 4698.0 4705.9 4725.1 5760.7 5807.4 5840.9 5841.9 5847.3 6730.2 6737.5 6738.6 6750.1 6835.6 5706.3 5765.4 5791.6 5811.8 5844.0 5891.8 5897.9 5977.9 5982.0 5983.0 6566.5 6584.1 6608.2 6631.1 6659.2 6799.8 6803.6 6873.6 6882.3 6899.6 6376.1 6558.2 6561.9 6580.5 6635.1 6545.8 6547.0 6549.1 6556.8 6572.2 6630.0 6707.1 6810.7 6825.9 6828.6 6607.7 6628.1 6634.1 6635.0 6640.2 6527.8 6532.6 6539.0 6622.5 6626.3 6388.7 6459.1 6460.5 6473.9 6539.8 6465.5 6540.8 6559.7 6662.4 6662.8 6465.9 6474.6 6490.7 6492.1 6518.2 14:28:35 INFO - PID 23464 | 14:28:35 INFO - PID 23464 | [#1] ext.html Cycles:180 Average:38554.42 Median:34204.07 stddev:56720.24 (165.8%) stddev-sans-first:56808.56 14:28:35 INFO - PID 23464 | Values: 812.6 858.3 890.8 900.2 1159.8 30136.7 30767.5 40907.0 41663.0 41708.4 41787.8 42176.6 42366.0 42392.4 42434.6 7658.7 7693.7 7807.7 7809.9 7830.8 7679.7 7779.2 7794.1 7798.1 7802.6 7741.1 7806.4 7807.5 7809.5 7834.1 7759.5 7777.5 7799.6 7835.8 7845.9 7702.4 7703.6 7708.7 7715.3 7718.0 36957.4 37284.8 37361.4 37386.1 37392.8 3536.3 3543.1 3555.8 3568.4 3579.9 30733.2 30845.8 30866.8 30877.7 30915.2 4760.7 4779.0 4808.4 4831.4 4858.6 188987.0 189109.1 189321.0 189908.0 190192.0 46919.3 46975.0 46995.0 47030.8 47320.8 53916.5 54855.7 55018.4 55213.7 55263.4 16552.4 16557.3 16618.6 16621.7 16699.8 12168.8 12194.4 13459.7 13807.7 13836.0 14353.4 14363.6 14402.5 14485.9 14602.9 5551.8 5765.4 5828.9 5851.5 5979.3 961.5 968.5 975.1 1019.7 1021.5 22191.7 22229.6 22541.9 23027.3 23305.4 1084.4 1102.1 1103.1 1106.7 1122.5 11768.8 11834.3 11912.3 12032.3 12133.9 245318.0 245706.0 245880.0 247587.0 248658.0 51995.7 52350.5 52371.5 52384.2 52435.7 1448.3 1460.8 1466.6 1475.0 1485.7 21429.9 21595.2 22230.3 22466.9 23081.7 48499.5 49937.3 50103.0 50245.7 50286.0 211626.0 215371.0 215388.0 215911.0 216186.0 31525.0 32102.2 32144.4 32154.0 35176.8 43826.0 44028.0 44099.6 44494.0 44519.3 29163.6 30963.5 32171.7 32218.2 32242.0 30977.8 31325.0 31725.7 32242.7 32475.7 34018.0 34111.8 34296.3 34400.8 34408.1 29075.6 29764.3 30412.0 31022.4 31335.8 21208.8 22770.4 22895.7 22920.0 23406.4 14:28:35 INFO - PID 23464 | 14:28:35 INFO - PID 23464 | [#2] jquery.html Cycles:180 Average:38265.37 Median:22937.48 stddev:90142.48 (393.0%) stddev-sans-first:90350.92 14:28:35 INFO - PID 23464 | Values: 567.2 581.9 585.0 598.6 603.6 22006.2 22920.3 22954.7 23036.1 23069.4 26692.5 27157.0 27346.5 27367.3 27467.7 6539.0 6704.7 6705.3 6708.3 6721.3 6380.8 6580.0 6647.8 7011.5 7033.6 7031.1 7045.4 7051.0 7054.4 7056.6 7060.8 7060.9 7092.0 7095.3 7096.0 6942.3 6942.4 6948.2 6950.1 6951.4 31311.5 32298.0 32332.0 32344.4 32570.5 1953.6 2013.1 2013.7 2014.4 2014.7 20448.0 20887.9 21002.6 21080.8 21102.0 2405.0 2433.3 2513.8 2529.6 2535.9 144543.0 148628.0 149100.0 150876.0 150942.2 19510.0 21686.8 21902.0 22244.6 22462.8 45633.0 45683.0 45772.0 45850.3 46293.3 11580.9 11597.1 11780.4 11804.7 11840.3 9619.4 9625.9 9738.2 9833.4 9927.5 9164.8 11113.8 11128.4 11627.5 11861.0 4085.0 4175.7 4231.8 4442.0 4524.8 947.8 960.7 964.6 981.5 995.2 19467.5 19566.5 19883.5 19912.9 20373.9 1012.9 1033.6 1036.6 1037.2 1040.2 10460.0 10594.8 10825.9 11175.3 11243.8 520941.0 535884.0 536777.0 539920.0 542501.0 120494.0 130222.3 130722.0 131936.3 134694.0 1235.2 1247.9 1285.3 1288.4 1288.5 19983.5 20969.5 21082.8 22108.1 22232.7 58672.4 59177.0 59438.7 60519.4 63256.7 71046.0 71630.0 71693.6 72093.6 72231.6 15150.1 15398.8 15515.6 15584.0 15605.1 24032.4 24162.0 24372.5 24497.9 24951.3 18823.3 19142.3 19153.3 19223.9 19275.1 16241.5 16539.7 17083.3 17260.9 17592.5 19338.7 19384.3 19785.5 19787.0 19872.1 15216.7 15221.3 15350.5 15395.6 15398.4 18263.8 19193.5 19234.3 19252.5 19380.6 14:28:35 INFO - PID 23464 | 14:28:35 INFO - PID 23464 | [#3] mootools.html Cycles:180 Average:8871.02 Median:2626.31 stddev:6115.53 (232.9%) stddev-sans-first:6106.69 14:28:35 INFO - PID 23464 | Values: 1367.0 1396.6 1441.1 1448.3 1453.6 13695.2 14364.6 14458.9 14461.9 14482.1 13438.5 14089.8 14474.7 14488.9 14585.6 2716.5 2765.7 2776.5 2778.7 2780.5 2502.6 2623.0 2629.6 2671.4 2755.3 2736.9 2773.5 2774.1 2778.7 2783.3 2652.8 2684.9 2690.4 2699.3 2702.9 2582.5 2620.7 2644.6 2651.4 2661.4 13810.4 14055.7 14119.2 14134.3 14138.6 7459.7 7777.8 7779.4 7780.9 7788.5 5061.3 5186.7 5321.3 5376.1 5418.5 1856.8 1876.4 1877.3 1891.8 1918.4 23925.8 24197.8 24259.0 24276.2 24285.0 6615.5 6620.5 6707.0 6749.1 6818.0 16229.1 16286.9 16323.8 16339.0 16363.5 7648.5 7686.8 7764.8 7765.0 7822.0 6971.5 7068.6 7087.6 7095.2 7207.2 4862.9 5062.2 5062.3 5113.8 5159.4 1392.5 1400.5 1475.3 1475.9 1493.8 867.1 869.1 901.3 916.9 933.5 7988.8 8104.8 8158.4 8214.7 8267.8 952.9 960.3 1009.8 1012.0 1034.1 4892.5 5029.7 5035.9 5090.2 5293.5 19399.8 20237.1 20344.3 20358.3 20377.7 19236.4 19645.2 19958.3 19967.9 19990.0 10640.4 11157.0 11223.0 11231.2 11232.9 7530.0 7971.2 8166.2 8370.2 8390.5 16790.8 16867.5 17198.4 17403.6 17687.6 17426.1 17468.5 17674.8 17779.6 17806.2 11219.3 11626.2 11646.6 11654.8 11660.9 12845.0 12868.7 12895.5 13133.9 13291.2 9876.9 10007.2 10792.6 10849.8 10850.8 10182.9 10717.0 10755.7 10761.4 11041.0 9402.4 9528.1 9596.2 9601.3 9634.0 6661.2 6802.4 6949.0 7002.9 7032.1 7128.8 7254.7 7290.3 7347.3 7486.9 14:28:35 INFO - PID 23464 | 14:28:35 INFO - PID 23464 | [#4] prototype.html Cycles:180 Average:5486.06 Median:6043.30 stddev:1571.20 (26.0%) stddev-sans-first:1529.90 14:28:35 INFO - PID 23464 | Values: 473.4 486.8 506.9 508.9 518.7 6183.9 6232.1 6277.3 6296.2 6354.8 5887.2 6032.7 6052.8 6071.8 6075.0 4916.9 4917.8 4932.7 4941.2 4948.1 4750.7 4876.5 4890.9 4945.8 4994.0 4778.8 4812.5 4885.3 4886.1 4901.0 4802.6 4835.4 4844.0 4872.8 4884.8 4313.3 4327.1 4338.3 4353.3 4353.4 5975.1 5986.7 6018.4 6034.6 6052.0 5550.8 5552.3 5590.9 5617.9 5652.4 6230.3 6368.8 6452.2 6469.0 6493.6 4696.4 4701.6 4717.0 4743.0 4757.8 6799.7 6862.0 6917.3 6937.6 6971.4 4822.8 4844.0 4854.4 4867.5 4880.6 4851.9 4908.7 4915.5 4935.9 4946.2 5501.5 5536.9 5552.1 5579.7 5635.3 6429.0 6548.4 6585.7 6593.7 6658.9 1661.7 1685.4 1691.9 1739.2 1750.7 1188.8 1201.2 1206.9 1213.1 1225.9 5637.1 5643.9 5645.9 5690.4 5705.9 6579.9 6594.1 6708.5 6759.5 6793.0 5794.5 5810.7 5860.7 5867.2 5896.5 3561.5 3584.2 3608.4 3640.3 3649.7 6664.0 6671.7 6682.1 6682.3 6697.8 6947.2 6966.2 6970.4 6997.3 7033.6 6555.7 6563.9 6583.4 6620.8 6628.8 6780.8 6781.2 6816.4 6833.6 6842.2 6620.7 6633.7 6723.7 6751.0 6772.3 6543.6 6571.9 6606.6 6650.2 6659.5 4962.6 4974.6 4983.1 4992.4 5011.9 6682.8 6686.4 6736.2 6781.2 6857.9 6484.5 6499.5 6518.7 6539.6 6580.7 6286.9 6427.7 6557.7 6626.8 6633.9 6279.2 6380.4 6455.3 6497.9 6567.7 6491.2 6515.9 6638.8 6681.5 6704.9 6368.6 6391.9 6440.6 6458.2 6484.4 14:28:35 INFO - PID 23464 | 14:28:35 INFO - PID 23464 | [#5] yui.html Cycles:180 Average:23040.64 Median:20733.14 stddev:30825.69 (148.7%) stddev-sans-first:30867.36 14:28:35 INFO - PID 23464 | Values: 907.3 916.5 931.3 932.4 936.3 16833.7 17284.4 17288.9 17300.0 18427.5 20506.8 21360.8 21484.7 21530.6 21565.8 976.3 983.7 986.5 991.5 998.6 1009.8 1066.2 1068.7 1070.3 1071.2 1120.8 1127.8 1129.2 1130.0 1130.1 1112.4 1112.9 1114.3 1115.5 1121.8 802.8 804.7 810.8 812.3 813.1 18239.9 19260.8 19488.7 19530.6 19550.0 19492.0 20398.3 20674.6 20813.5 20833.9 15754.8 15881.0 15920.7 15948.1 16000.2 3496.1 3568.8 3589.1 3589.5 3590.3 117125.4 120310.4 123659.0 129931.4 136550.3 15918.5 16574.3 16620.5 16626.9 16628.6 28642.9 29909.7 29971.9 30018.0 30114.7 7348.4 7584.4 8883.3 8921.6 8925.6 4129.8 4283.0 4288.9 4290.0 4290.4 5157.8 5265.4 5265.7 5272.9 5593.1 1138.2 1156.4 1161.7 1162.2 1165.1 692.8 697.0 707.1 709.0 727.0 11692.8 11772.8 12506.8 12556.2 12879.9 652.8 664.7 695.7 713.6 718.5 5199.3 6016.5 6629.6 6671.4 6671.8 103663.0 104912.0 105596.0 107042.0 108383.0 90284.0 90787.4 90825.5 91961.5 93196.5 83793.6 86585.0 87758.6 90771.0 91220.5 11822.9 12599.9 12743.8 12758.8 12773.9 36220.5 36941.8 37248.4 37411.1 38319.4 46990.5 47253.8 47966.0 48279.5 69657.0 19184.0 19398.9 19480.3 19668.2 19718.4 18328.7 19173.3 21533.7 21633.7 22453.0 16370.3 17125.1 17997.0 19205.2 20791.7 20456.7 20623.8 20817.4 20909.3 21322.8 18692.0 18959.0 19040.2 20033.5 20924.5 13196.7 13848.8 13945.4 14177.7 14202.5 14740.4 14818.8 15231.4 15351.6 15423.0 14:28:35 INFO - PID 23464 | -------- Summary: end -------- 14:28:35 INFO - PID 23464 | 14:28:36 INFO - TEST-INFO | 23464: exit 0 14:28:36 INFO - TEST-OK | dromaeo_css | took 1113902ms 14:28:36 INFO - TEST-START | kraken 14:28:36 INFO - Initialising browser for kraken test... 14:28:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49537/getInfo.html -profile /tmp/tmpHzMuFZ/profile 14:28:36 INFO - TEST-INFO | started process 23842 (/builds/slave/test/build/application/firefox/firefox http://localhost:49537/getInfo.html) 14:28:42 INFO - TEST-INFO | 23842: exit 0 14:28:42 INFO - Browser initialized. 14:28:42 INFO - Running cycle 1/1 for kraken test... 14:28:42 INFO - TEST-INFO | started process 24068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHzMuFZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:43 INFO - PID 24068 | 14:28:43 INFO - PID 24068 | (/builds/slave/test/build/application/firefox/firefox:24122): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 14:28:43 INFO - PID 24068 | 14:28:53 INFO - PID 24068 | RSS: Main: 174694400 14:28:53 INFO - PID 24068 | 14:28:56 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49537/tests/kraken/driver.html?testName=audio-beat-detection) 14:28:57 INFO - PID 24068 | RSS: Main: 179658752 14:28:57 INFO - PID 24068 | 14:29:00 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49537/tests/kraken/driver.html?testName=audio-dft) 14:29:00 INFO - PID 24068 | RSS: Main: 179888128 14:29:00 INFO - PID 24068 | 14:29:03 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49537/tests/kraken/driver.html?testName=audio-fft) 14:29:04 INFO - PID 24068 | RSS: Main: 174772224 14:29:04 INFO - PID 24068 | 14:29:06 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49537/tests/kraken/driver.html?testName=audio-oscillator) 14:29:07 INFO - PID 24068 | RSS: Main: 175284224 14:29:07 INFO - PID 24068 | 14:29:09 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49537/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:29:10 INFO - PID 24068 | RSS: Main: 175337472 14:29:10 INFO - PID 24068 | 14:29:13 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49537/tests/kraken/driver.html?testName=imaging-darkroom) 14:29:14 INFO - PID 24068 | RSS: Main: 177475584 14:29:14 INFO - PID 24068 | 14:29:17 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49537/tests/kraken/driver.html?testName=imaging-desaturate) 14:29:18 INFO - PID 24068 | RSS: Main: 177176576 14:29:18 INFO - PID 24068 | 14:29:21 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49537/tests/kraken/driver.html?testName=json-parse-financial) 14:29:21 INFO - PID 24068 | RSS: Main: 178216960 14:29:21 INFO - PID 24068 | 14:29:23 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49537/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:29:24 INFO - PID 24068 | RSS: Main: 178102272 14:29:24 INFO - PID 24068 | 14:29:26 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49537/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:29:26 INFO - PID 24068 | RSS: Main: 175136768 14:29:26 INFO - PID 24068 | 14:29:29 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49537/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:29:29 INFO - PID 24068 | RSS: Main: 175263744 14:29:29 INFO - PID 24068 | 14:29:32 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:29:33 INFO - PID 24068 | RSS: Main: 175706112 14:29:33 INFO - PID 24068 | 14:29:36 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:29:36 INFO - PID 24068 | RSS: Main: 175779840 14:29:36 INFO - PID 24068 | 14:29:38 INFO - PID 24068 | Cycle 1(1): loaded http://localhost:49537/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49537/tests/kraken/driver.html?testName=ai-astar) 14:29:39 INFO - PID 24068 | RSS: Main: 177041408 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | __start_tp_report 14:29:39 INFO - PID 24068 | _x_x_mozilla_page_load 14:29:39 INFO - PID 24068 | _x_x_mozilla_page_load_details 14:29:39 INFO - PID 24068 | |i|pagename|runs| 14:29:39 INFO - PID 24068 | |0;ai-astar;108;111;101;107;113;111;112;98;112;107 14:29:39 INFO - PID 24068 | |1;audio-beat-detection;143;123;156;182;120;152;149;123;184;123 14:29:39 INFO - PID 24068 | |2;audio-dft;170;168;162;164;166;165;167;166;166;165 14:29:39 INFO - PID 24068 | |3;audio-fft;73;77;81;172;76;79;76;83;100;75 14:29:39 INFO - PID 24068 | |4;audio-oscillator;83;78;135;78;79;78;130;78;78;130 14:29:39 INFO - PID 24068 | |5;imaging-gaussian-blur;114;114;116;114;113;114;114;117;116;113 14:29:39 INFO - PID 24068 | |6;imaging-darkroom;157;154;151;156;152;152;150;154;151;150 14:29:39 INFO - PID 24068 | |7;imaging-desaturate;101;99;98;93;94;94;98;95;93;94 14:29:39 INFO - PID 24068 | |8;json-parse-financial;58;60;54;56;62;53;54;54;54;57 14:29:39 INFO - PID 24068 | |9;json-stringify-tinderbox;56;64;54;54;60;59;59;54;54;57 14:29:39 INFO - PID 24068 | |10;stanford-crypto-aes;79;78;78;77;77;78;86;82;105;83 14:29:39 INFO - PID 24068 | |11;stanford-crypto-ccm;147;129;125;143;133;137;132;131;128;168 14:29:39 INFO - PID 24068 | |12;stanford-crypto-pbkdf2;176;183;173;175;171;180;187;184;178;170 14:29:39 INFO - PID 24068 | |13;stanford-crypto-sha256-iterative;67;66;69;66;65;65;68;67;69;66 14:29:39 INFO - PID 24068 | __end_tp_report 14:29:39 INFO - PID 24068 | __start_cc_report 14:29:39 INFO - PID 24068 | _x_x_mozilla_cycle_collect,971 14:29:39 INFO - PID 24068 | __end_cc_report 14:29:39 INFO - PID 24068 | __startTimestamp1501622979019__endTimestamp 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | ------- Summary: start ------- 14:29:39 INFO - PID 24068 | Number of tests: 14 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#0] ai-astar Cycles:10 Average:108.00 Median:111.50 stddev:5.01 (4.5%) stddev-sans-first:5.32 14:29:39 INFO - PID 24068 | Values: 108.0 111.0 101.0 107.0 113.0 111.0 112.0 98.0 112.0 107.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#1] audio-beat-detection Cycles:10 Average:145.50 Median:150.50 stddev:23.93 (15.9%) stddev-sans-first:25.37 14:29:39 INFO - PID 24068 | Values: 143.0 123.0 156.0 182.0 120.0 152.0 149.0 123.0 184.0 123.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.00 stddev:2.18 (1.3%) stddev-sans-first:1.74 14:29:39 INFO - PID 24068 | Values: 170.0 168.0 162.0 164.0 166.0 165.0 167.0 166.0 166.0 165.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#3] audio-fft Cycles:10 Average:89.20 Median:76.50 stddev:30.08 (39.3%) stddev-sans-first:31.33 14:29:39 INFO - PID 24068 | Values: 73.0 77.0 81.0 172.0 76.0 79.0 76.0 83.0 100.0 75.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:78.00 stddev:25.59 (32.8%) stddev-sans-first:26.79 14:29:39 INFO - PID 24068 | Values: 83.0 78.0 135.0 78.0 79.0 78.0 130.0 78.0 78.0 130.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 14:29:39 INFO - PID 24068 | Values: 114.0 114.0 116.0 114.0 113.0 114.0 114.0 117.0 116.0 113.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#6] imaging-darkroom Cycles:10 Average:152.70 Median:153.00 stddev:2.45 (1.6%) stddev-sans-first:2.05 14:29:39 INFO - PID 24068 | Values: 157.0 154.0 151.0 156.0 152.0 152.0 150.0 154.0 151.0 150.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:94.50 stddev:2.85 (3.0%) stddev-sans-first:2.35 14:29:39 INFO - PID 24068 | Values: 101.0 99.0 98.0 93.0 94.0 94.0 98.0 95.0 93.0 94.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:3.01 (5.3%) stddev-sans-first:3.12 14:29:39 INFO - PID 24068 | Values: 58.0 60.0 54.0 56.0 62.0 53.0 54.0 54.0 54.0 57.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:58.00 stddev:3.38 (5.8%) stddev-sans-first:3.56 14:29:39 INFO - PID 24068 | Values: 56.0 64.0 54.0 54.0 60.0 59.0 59.0 54.0 54.0 57.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:78.50 stddev:8.51 (10.8%) stddev-sans-first:8.94 14:29:39 INFO - PID 24068 | Values: 79.0 78.0 78.0 77.0 77.0 78.0 86.0 82.0 105.0 83.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:135.00 stddev:12.75 (9.4%) stddev-sans-first:13.03 14:29:39 INFO - PID 24068 | Values: 147.0 129.0 125.0 143.0 133.0 137.0 132.0 131.0 128.0 168.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.70 Median:179.00 stddev:5.74 (3.2%) stddev-sans-first:6.05 14:29:39 INFO - PID 24068 | Values: 176.0 183.0 173.0 175.0 171.0 180.0 187.0 184.0 178.0 170.0 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.48 (2.2%) stddev-sans-first:1.56 14:29:39 INFO - PID 24068 | Values: 67.0 66.0 69.0 66.0 65.0 65.0 68.0 67.0 69.0 66.0 14:29:39 INFO - PID 24068 | -------- Summary: end -------- 14:29:39 INFO - PID 24068 | 14:29:39 INFO - PID 24068 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 14:29:39 INFO - TEST-INFO | 24068: exit 0 14:29:39 INFO - TEST-OK | kraken | took 63407ms 14:29:39 INFO - SUITE-END | took 1177s 14:29:40 INFO - Completed test suite (00:19:37) 14:29:40 INFO - javascript benchmark 14:29:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8637.216459047433, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3118.064580625813, 3164.8259345735987, 3167.572377729006, 3188.394205101031, 3239.433099207638, 6105.389461053893, 6261.186045814044, 6296.748130074803, 6310.905336419952, 6340.587861788992, 6097.756089756404, 6211.813645590628, 6248.562600617958, 6270.028145637433, 6278.121063051177, 5666.546676265889, 5671.886562268763, 5707.3721890592005, 5723.627964182315, 5728.16941543476, 5756.280464941882, 5785.566082543805, 5830.912536311958, 5848.035074212749, 5862.677552734598, 5752.971235143818, 5805.158252053449, 5815.5638327125425, 5836.9785287574505, 5891.764329426818, 5560.0, 5763.596548241625, 5773.2494775679315, 5853.912191317134, 5864.501517371007, 5137.51193636604, 5616.719164041781, 5649.49154576086, 5728.742206600713, 5737.2254745609225, 6113.877722445571, 6160.722767475474, 6177.474914632262, 6212.316645169028, 6260.499160067229, 6518.511111666644, 6599.977003564455, 6613.966930165367, 6627.701753421107, 6814.965925170342, 6706.094677218611, 6744.93255067448, 6747.460203183734, 6751.628660423675, 6757.020232066323, 6219.875602487925, 6221.782237621662, 6222.408871157233, 6223.284322302902, 6234.594751341148, 6891.620960847202, 6894.207166175854, 6894.24163342032, 6894.931050689529, 6896.310368963063, 6478.805635830839, 6541.542092053605, 6562.868742625121, 6572.14562106923, 6572.671366431659, 6569.737210511622, 6607.636579988147, 6612.23959244693, 6641.833954151185, 6731.124953756078, 6673.9332606673315, 6675.399214070757, 6696.59820410777, 6731.562448440835, 6790.558613690193, 6679.7662081827875, 6734.326567343324, 6787.355201255873, 6833.248342682301, 6844.041834143224, 5296.3909150447425, 5374.193870919394, 5381.9461805382225, 5393.083175860113, 5397.78408863641, 4643.674942753974, 4681.789319480631, 4698.0, 4705.905881882411, 4725.102230576248, 5760.654360738369, 5807.361190269067, 5840.912386314124, 5841.853953651108, 5847.327557330961, 6730.226024007204, 6737.52837301394, 6738.59568425896, 6750.088738020305, 6835.555688880307, 5706.315242170883, 5765.394633563499, 5791.565632577489, 5811.82564523065, 5844.0, 5891.793787217427, 5897.882042359129, 5977.910331345033, 5982.0, 5983.0128028875615, 6566.474682025522, 6584.11114499546, 6608.207015158116, 6631.104800851823, 6659.167604049494, 6799.796006119825, 6803.625800581016, 6873.5875847449315, 6882.311768823078, 6899.551529150589, 6376.075469057054, 6558.1802274715665, 6561.934380656132, 6580.5064620152725, 6635.1374321339845, 6545.770898018546, 6546.967265163644, 6549.148610680581, 6556.8360790980605, 6572.178477690289, 6629.966850165718, 6707.061011458497, 6810.6594670265295, 6825.863482730417, 6828.624425656637, 6607.702653380513, 6628.138342015507, 6634.104395906491, 6635.0, 6640.169978752656, 6527.804165875032, 6532.608043517404, 6539.019147127969, 6622.503312251504, 6626.337366263335, 6388.68056597159, 6459.128017717548, 6460.483161346987, 6473.902891456538, 6539.803805885831, 6465.515086368635, 6540.803775886731, 6559.7376104955265, 6662.367075127855, 6662.766803161866, 6465.903011454926, 6474.611523308617, 6490.675466226764, 6492.123563318892, 6518.152640156749], "value": 6129.5685530838755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [812.5977641067673, 858.3305022082776, 890.7951171230621, 900.1673452056848, 1159.7912375772357, 30136.698633013664, 30767.538486922713, 40907.0, 41663.0, 41708.37437438433, 41787.79106104465, 42176.578234217726, 42366.0, 42392.36411453831, 42434.57565424345, 7658.6553605087765, 7693.692252309901, 7807.6876924922935, 7809.921900781004, 7830.765077047698, 7679.6928122875015, 7779.183185765498, 7794.142644309121, 7798.103218129902, 7802.570858602775, 7741.148473667892, 7806.375489960789, 7807.492512986638, 7809.453338266324, 7834.0990786059765, 7759.45683802134, 7777.494462859924, 7799.571023593729, 7835.764927052198, 7845.882311765271, 7702.422318326092, 7703.576303303316, 7708.653110610036, 7715.344195743369, 7717.961410192913, 36957.44563831545, 37284.81357593195, 37361.439578406345, 37386.06534836651, 37392.813035934916, 3536.3457760314423, 3543.061088811467, 3555.768875023141, 3568.3933731265747, 3579.8926032219074, 30733.231669208224, 30845.845770771004, 30866.84566577175, 30877.69122308793, 30915.22711932197, 4760.666753327268, 4778.952210477885, 4808.374911261549, 4831.396075490564, 4858.587020103296, 188987.0, 189109.05445472823, 189321.0, 189908.0, 190192.0, 46919.296210556866, 46975.0, 46995.0, 47030.76484617555, 47320.763396182796, 53916.46083539193, 54855.725721371135, 55018.449815501335, 55213.72393138089, 55263.447365526634, 16552.42066527666, 16557.337706491606, 16618.58453538647, 16621.66756664884, 16699.83300167007, 12168.81746773799, 12194.39028048594, 13459.730805383837, 13807.654808629864, 13836.0, 14353.354099065567, 14363.56909292702, 14402.495912643217, 14485.92757036208, 14602.853971460361, 5551.777928882881, 5765.394633563499, 5828.88342233153, 5851.531877449794, 5979.252593425822, 961.4711908450324, 968.5254225429488, 975.1223898491272, 1019.6686077024997, 1021.5147804792664, 22191.66712499314, 22229.555408892054, 22541.88729056377, 23027.309180724606, 23305.417364566023, 1084.4089970965842, 1102.1458369763336, 1103.1064837481506, 1106.7106820554125, 1122.4836575175348, 11768.76462470763, 11834.289942603471, 11912.344821034927, 12032.27806331623, 12133.878661213275, 245318.0, 245706.0, 245880.0, 247587.0, 248658.0, 51995.74002130041, 52350.47649523456, 52371.47628523742, 52384.21423678648, 52435.73782131065, 1448.2541491132076, 1460.8173978252505, 1466.5820241231197, 1475.0264825215306, 1485.68057867559, 21429.89285053565, 21595.2441664541, 22230.333090007327, 22466.887665561568, 23081.65377519372, 48499.51500485091, 49937.25094123519, 50103.0, 50245.74877125591, 50286.0, 211626.0, 215371.0, 215388.0, 215911.0, 216186.0, 31525.0, 32102.19744506406, 32144.357112857146, 32154.0, 35176.82411587926, 43826.0, 44028.0, 44099.559004409544, 44494.0, 44519.332210016226, 29163.562546562243, 30963.535546967265, 32171.67828321687, 32218.19454513656, 32242.0, 30977.845110774302, 31325.0, 31725.682743173194, 32242.677573223966, 32475.67524324821, 34018.0, 34111.82944085363, 34296.31407371889, 34400.82799585986, 34408.13979650529, 29075.563866541597, 29764.255893602833, 30412.0, 31022.37955240928, 31335.84332078325, 21208.787912121297, 22770.43073923099, 22895.656565151203, 22920.0, 23406.414839629146], "value": 17231.086504550934, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.1719289836838, 581.8545363659085, 584.9999999999998, 598.5600583571074, 603.5986069263939, 22006.229781957616, 22920.312390628267, 22954.655680164768, 23036.078556857705, 23069.423264418376, 26692.466150676973, 27157.0, 27346.45307093857, 27367.315817104583, 27467.725322746817, 6538.999999999988, 6704.664766761667, 6705.32946705328, 6708.262091169968, 6721.294264102272, 6380.808575742712, 6580.012998050307, 6647.833804154887, 7011.544249623784, 7033.613151276678, 7031.085958825345, 7045.401140903029, 7051.0, 7054.435645148375, 7056.576605403667, 7060.82347941303, 7060.858782824341, 7092.042574252488, 7095.254998225164, 7096.042034325404, 6942.271061538516, 6942.409895158918, 6948.200956889972, 6950.061741664861, 6951.409130223937, 31311.53032704511, 32298.0, 32332.0, 32344.353112937846, 32570.511442328385, 1953.599512100016, 2013.0840467587213, 2013.6979453082008, 2014.4359579317668, 2014.7078673592393, 20448.0, 20887.8955605221, 21002.579948400948, 21080.789192108037, 21102.0, 2405.0, 2433.3065076453126, 2513.7863281621085, 2529.620556916459, 2535.8605276709773, 144543.0, 148628.0, 149100.0, 150876.0, 150942.24528877286, 19510.024943639564, 21686.783132168475, 21901.99136276408, 22244.55510889773, 22462.77537224607, 45633.0, 45683.0, 45772.0, 45850.312245316345, 46293.30560041602, 11580.88419115798, 11597.130215233723, 11780.410979450993, 11804.70488237801, 11840.28958262507, 9619.374740641835, 9625.855612165824, 9738.220942324597, 9833.360831545926, 9927.453990030617, 9164.816703665889, 11113.83329250062, 11128.443577821077, 11627.53489860413, 11860.983632782447, 4084.9795751021647, 4175.728577642443, 4231.830726770895, 4441.955580444154, 4524.773761311987, 947.7677968897664, 960.6847497530916, 964.6430820596283, 981.4503877828439, 995.1640621877513, 19467.50586942382, 19566.510837229183, 19883.508736844793, 19912.90043549802, 20373.898130509253, 1012.9189664826796, 1033.565902321027, 1036.5646428500047, 1037.2169012395743, 1040.1990467340106, 10460.0, 10594.788104238027, 10825.891741082645, 11175.273607215668, 11243.775124497464, 520941.0, 535884.0, 536777.0, 539920.0, 542501.0, 120494.0, 130222.34888825496, 130722.0, 131936.3403182978, 134694.0, 1235.178606226867, 1247.9438425270703, 1285.2866659004155, 1288.407332627002, 1288.4910460368103, 19983.500412489804, 20969.475763106046, 21082.78917210808, 22108.115675372806, 22232.666510002688, 58672.4132758684, 59177.0, 59438.70280648742, 60519.39480605138, 63256.68371658112, 71046.0, 71630.0, 71693.641531792, 72093.63953180201, 72231.63884180546, 15150.090994540364, 15398.769018464507, 15515.612109697347, 15584.0, 15605.141717205208, 24032.39919002039, 24162.0, 24372.51254974926, 24497.877510612332, 24951.251462456155, 18823.34118305853, 19142.330018449844, 19153.329633462763, 19223.90388048051, 19275.132619032458, 16241.51275461738, 16539.66920661604, 17083.316667333664, 17260.91369543144, 17592.472225833244, 19338.709919351502, 19384.32154874629, 19785.505362366057, 19787.0, 19872.105755241337, 15216.695666086838, 15221.315040822969, 15350.539483815503, 15395.61510962235, 15398.384064637288, 18263.81736182621, 19193.52016199606, 19234.326798561982, 19252.518687032374, 19380.612387752448], "value": 13137.175707938846, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.9658258543536, 1396.6298930783344, 1441.0921119694594, 1448.254149113207, 1453.5784622459487, 13695.24676142813, 14364.640883977892, 14458.855411445882, 14461.855381446183, 14482.131072135679, 13438.5296514622, 14089.788653170212, 14474.710505789877, 14488.85511144891, 14585.635359116028, 2716.5381885079532, 2765.6681198256238, 2776.5141100307465, 2778.6804517480546, 2780.471710375022, 2502.637117617953, 2623.0, 2629.618705287732, 2671.3722275265295, 2755.256080858167, 2736.9178924632292, 2773.5423655096884, 2774.1122840690987, 2778.6804517480546, 2783.2902609834464, 2652.787776977837, 2684.852333121668, 2690.367763575558, 2699.284689557269, 2702.8648567571545, 2582.5093232285994, 2620.685517737884, 2644.6033095035705, 2651.363672718553, 2661.3878807874103, 13810.37853296594, 14055.718885622333, 14119.223442710647, 14134.293285335794, 14138.575842724631, 7459.664315105779, 7777.766666999999, 7779.416543759184, 7780.8832867507035, 7788.493747906368, 5061.2661164131, 5186.7147306898105, 5321.3348331458565, 5376.11294136467, 5418.458154184589, 1856.8421684156863, 1876.4370688793308, 1877.3189323426034, 1891.7824450188266, 1918.3669389101563, 23925.760742392526, 24197.758022419726, 24259.0, 24276.150334738377, 24285.0, 6615.536912416181, 6620.5034622402545, 6707.0, 6749.055132281386, 6817.9659101705165, 16229.107399092927, 16286.918565407097, 16323.755143672854, 16339.0, 16363.509094727176, 7648.502847314907, 7686.807829804299, 7764.805879853049, 7765.029371328584, 7822.022247219098, 6971.54684945487, 7068.646567671596, 7087.574745515182, 7095.184053833772, 7207.207207207203, 4862.878428039327, 5062.240663900445, 5062.316587260746, 5113.769880355393, 5159.406668233201, 1392.463901397969, 1400.4888215801159, 1475.2623688155923, 1475.8671719545293, 1493.7834014068117, 867.1458613265928, 869.0744357259498, 901.2654686430539, 916.8578870275118, 933.5192375926404, 7988.760337189894, 8104.797380065545, 8158.388120890957, 8214.671413143407, 8267.751967440987, 952.8808898887639, 960.3279168496477, 1009.7847747116509, 1012.0031768707817, 1034.1054987435814, 4892.461829198785, 5029.67307125043, 5035.924461133086, 5090.2364645303505, 5293.523582877559, 19399.8060019398, 20237.08933098014, 20344.287949921978, 20358.28745993883, 20377.694334584994, 19236.422907312804, 19645.214191432184, 19958.30145944914, 19967.900160499394, 19990.0, 10640.361578305326, 11157.0, 11223.0, 11231.21381503287, 11232.887671123348, 7529.962350188214, 7971.1630278819885, 8166.183381661786, 8370.204830541088, 8390.496570205807, 16790.832091678927, 16867.493975180765, 17198.398056067977, 17403.56491087733, 17687.64624707473, 17426.128693565017, 17468.47594572165, 17674.823251767833, 17779.555511112325, 17806.198721057324, 11219.326840389604, 11626.244294120856, 11646.592369267373, 11654.766904662029, 11660.941695291469, 12845.0, 12868.742625147257, 12895.484180633044, 13133.868661313265, 13291.20252784836, 9876.901230987885, 10007.249456290661, 10792.568297268335, 10849.783004340026, 10850.78298434011, 10182.89817101849, 10717.0, 10755.677329680122, 10761.354318740901, 11041.00630943219, 9402.38884472507, 9528.094830991045, 9596.23230141573, 9601.279904007368, 9633.951830241085, 6661.2006559213205, 6802.367431816428, 6948.965255173692, 7002.8949565757575, 7032.12098487689, 7128.786136415916, 7254.668372724717, 7290.3438690518105, 7347.302006309392, 7486.8876966844455], "value": 6465.871229067692, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.4484325760489, 486.84420985284703, 506.89608630230794, 508.9262057001735, 518.6939705573714, 6183.907241391383, 6232.130360891737, 6277.278113016999, 6296.1814964054665, 6354.841128971772, 5887.175795388649, 6032.66820324882, 6052.757889684407, 6071.753451223042, 6074.969625151868, 4916.877078073059, 4917.803287868481, 4932.728699921512, 4941.234108713137, 4948.084604348207, 4750.691205071676, 4876.536729010738, 4890.853274401774, 4945.752712364385, 4993.975030124844, 4778.78495467703, 4812.518748125177, 4885.267209918505, 4886.096072226632, 4901.0, 4802.574699776608, 4835.395575553056, 4844.0, 4872.805087796466, 4884.780184891689, 4313.331433627793, 4327.0913108247305, 4338.327559228324, 4353.303471444586, 4353.390525326457, 5975.133605627203, 5986.670733109677, 6018.3981601839905, 6034.607750496248, 6052.001419765734, 5550.805721799758, 5552.305961754781, 5590.888182236333, 5617.9438205618235, 5652.406497317764, 6230.292975679464, 6368.777092801776, 6452.225732912034, 6469.0, 6493.577917435398, 4696.436427628706, 4701.600363969067, 4716.985848042653, 4742.9525704742855, 4757.785899634525, 6799.7280108795585, 6861.965690171567, 6917.273686262971, 6937.583744975318, 6971.361729993448, 4822.807087716522, 4843.95156048435, 4854.393200849894, 4867.488913664014, 4880.6095512358925, 4851.854444366674, 4908.705477671279, 4915.48387419323, 4935.876603084952, 4946.233333833262, 5501.5323697486165, 5536.889262214733, 5552.056150454432, 5579.6652200868075, 5635.267415235993, 6429.0, 6548.443382312462, 6585.6707164641575, 6593.6703164841565, 6658.933410665928, 1661.7424299233637, 1685.3511398111816, 1691.8918108638861, 1739.1825841854309, 1750.737389391576, 1188.7860185166753, 1201.165190192825, 1206.879312068786, 1213.0901823632275, 1225.9203151795105, 5637.126245431965, 5643.887122257532, 5645.915311270334, 5690.374058853523, 5705.857353566111, 6579.947208446722, 6594.142761441078, 6708.496862735315, 6759.526833121733, 6793.0, 5794.536437085023, 5810.709464526757, 5860.736266868002, 5867.207926929896, 5896.469317761336, 3561.5370001900105, 3584.175639602906, 3608.440691692792, 3640.3447379471418, 3649.708023358125, 6664.0, 6671.666416679147, 6682.131322927989, 6682.3317668232785, 6697.7655782047395, 6947.201071876698, 6966.233714291424, 6970.41023872706, 6997.335253150943, 7033.5887094759, 6555.704993275314, 6563.901541476977, 6583.407493325528, 6620.801375958729, 6628.767993120314, 6780.762673306411, 6781.152355955505, 6816.386525212754, 6833.58998460094, 6842.24735279109, 6620.668966551557, 6633.734650613921, 6723.663816809238, 6751.0, 6772.25505194438, 6543.640099794557, 6571.934280657132, 6606.645637644176, 6650.20197576294, 6659.53383263167, 4962.578180854668, 4974.5771609413605, 4983.127952608352, 4992.375953005874, 5011.949880501148, 6682.83292917681, 6686.364795344434, 6736.191657001191, 6781.186257649114, 6857.862842743217, 6484.513661475314, 6499.545031847725, 6518.706658200487, 6539.6403197824575, 6580.703868325841, 6286.874262514815, 6427.678616069272, 6557.704903279459, 6626.807174708406, 6633.933660663524, 6279.215098112736, 6380.393862583047, 6455.257645370654, 6497.945965396256, 6567.704453299518, 6491.156149700509, 6515.8597245480905, 6638.800835974928, 6681.46548276127, 6704.899426508508, 6368.649724265025, 6391.904121438275, 6440.6135631862235, 6458.160439142881, 6484.416402523607], "value": 5020.722966823679, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.2877790934118, 916.4867674102501, 931.2736065868622, 932.44519510891, 936.344558808834, 16833.747493787603, 17284.395046173388, 17288.91355543222, 17300.0, 18427.53931151722, 20506.794932050674, 21360.786392136073, 21484.677729834064, 21530.569388612217, 21565.784342156574, 976.3068221562681, 983.7147227304073, 986.4623780039859, 991.459654488302, 998.6354980432126, 1009.8033829911542, 1066.184368957748, 1068.6580294305825, 1070.288258308228, 1071.2394200117926, 1120.8150655141933, 1127.7518945831903, 1129.2377645089573, 1130.028175768838, 1130.073339861314, 1112.410422476085, 1112.855328807258, 1114.2534501883758, 1115.5259014918627, 1121.8205087186052, 802.7912742686885, 804.6901942752082, 810.849992751337, 812.25272749071, 813.0893399392659, 18239.908800456047, 19260.807391926042, 19488.70766938497, 19530.609387812307, 19550.0, 19492.0, 20398.28605998783, 20674.586508269902, 20813.479663008395, 20833.89583052075, 15754.842451575452, 15881.047137171807, 15920.681586368324, 15948.122853243067, 16000.199990000454, 3496.143444856001, 3568.839402226906, 3589.0847833802213, 3589.4795254688183, 3590.299891521154, 117125.4143729276, 120310.39844800807, 123658.9999999991, 129931.35034324862, 136550.31724841413, 15918.522444326689, 16574.254158562893, 16620.501384958472, 16626.916865415595, 16628.58428539272, 28642.85678571594, 29909.70090299069, 29971.850140749157, 30018.0, 30114.69885301119, 7348.375388092072, 7584.393248540104, 8883.333749968779, 8921.598528066253, 8925.642974281085, 4129.772862492532, 4282.9785851071165, 4288.871333859989, 4289.957100429018, 4290.420793192879, 5157.793688252428, 5265.368155821249, 5265.657732247391, 5272.92090618641, 5593.133064375028, 1138.1805100327751, 1156.439127023393, 1161.7269941563725, 1162.151629310591, 1165.1319766773638, 692.7609974558769, 696.9581825090511, 707.1302298173275, 708.9680964356617, 726.9927300727031, 11692.824607630891, 11772.823407648892, 12506.81239781404, 12556.246625202517, 12879.871201288055, 652.797632733854, 664.6563457367282, 695.7147569496583, 713.564725517434, 718.4719231365048, 5199.272101905736, 6016.488598469179, 6629.635370054693, 6671.366220209073, 6671.799846004627, 103663.0, 104912.0, 105596.0, 107042.0, 108383.0, 90284.0, 90787.42002882189, 90825.54587227022, 91961.5401922986, 93196.53401732948, 83793.58103209567, 86585.0, 87758.56120719356, 90771.0, 91220.54389728142, 11822.881771182178, 12599.93412581964, 12743.808842867178, 12758.808617870554, 12773.872261277269, 36220.51159645212, 36941.815290923376, 37248.44127338038, 37411.10028237934, 38319.42520862134, 46990.53009469862, 47253.76373118113, 47966.0, 48279.51720482891, 69657.0, 19184.0, 19398.90300548488, 19480.318188863323, 19668.213271469554, 19718.40844774659, 18328.725069123706, 19173.32893348726, 21533.676994845402, 21633.675494867275, 22453.0, 16370.263338150051, 17125.05812180342, 17997.010164441082, 19205.231790728216, 20791.68812467784, 20456.69314960247, 20623.79376206219, 20817.375478735663, 20909.26817561378, 21322.78677213208, 18692.0, 18959.0, 19040.238390464227, 20033.499162521053, 20924.47688807792, 13196.670083247996, 13848.792268115785, 13945.442182312594, 14177.716445671234, 14202.502912398017, 14740.410383584536, 14818.77771833445, 15231.390744370101, 15351.61620959485, 15423.0], "value": 9216.72710833493, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 101.0, 107.0, 113.0, 111.0, 112.0, 98.0, 112.0, 107.0], "value": 108.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 123.0, 156.0, 182.0, 120.0, 152.0, 149.0, 123.0, 184.0, 123.0], "value": 145.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 162.0, 164.0, 166.0, 165.0, 167.0, 166.0, 166.0, 165.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 77.0, 81.0, 172.0, 76.0, 79.0, 76.0, 83.0, 100.0, 75.0], "value": 89.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 135.0, 78.0, 79.0, 78.0, 130.0, 78.0, 78.0, 130.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 116.0, 114.0, 113.0, 114.0, 114.0, 117.0, 116.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 154.0, 151.0, 156.0, 152.0, 152.0, 150.0, 154.0, 151.0, 150.0], "value": 152.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 99.0, 98.0, 93.0, 94.0, 94.0, 98.0, 95.0, 93.0, 94.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 54.0, 56.0, 62.0, 53.0, 54.0, 54.0, 54.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 64.0, 54.0, 54.0, 60.0, 59.0, 59.0, 54.0, 54.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 78.0, 77.0, 77.0, 78.0, 86.0, 82.0, 105.0, 83.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 129.0, 125.0, 143.0, 133.0, 137.0, 132.0, 131.0, 128.0, 168.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 183.0, 173.0, 175.0, 171.0, 180.0, 187.0, 184.0, 178.0, 170.0], "value": 177.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 69.0, 66.0, 65.0, 65.0, 68.0, 67.0, 69.0, 66.0], "value": 66.8, "unit": "score"}]}]} 14:29:40 INFO - Return code: 0 14:29:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:29:40 INFO - # TBPL SUCCESS # 14:29:40 INFO - Running post-action listener: _package_coverage_data 14:29:40 INFO - Running post-action listener: _resource_record_post_action 14:29:40 INFO - [mozharness: 2017-08-01 21:29:40.295041Z] Finished run-tests step (success) 14:29:40 INFO - Running post-run listener: _resource_record_post_run 14:29:40 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 430768128; Read time: 16; Write time: 296920 14:29:40 INFO - TinderboxPrint: CPU usage
13.2% 14:29:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 14:29:40 INFO - TinderboxPrint: I/O write bytes / time
430,768,128 / 296,920 14:29:40 INFO - TinderboxPrint: CPU idle
8,277.8 (86.8%) 14:29:40 INFO - TinderboxPrint: CPU user
1,206.3 (12.6%) 14:29:40 INFO - TinderboxPrint: Swap in / out
0 / 0 14:29:40 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107585536; Read time: 0; Write time: 94596 14:29:40 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 14:29:40 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 323182592; Read time: 0; Write time: 202324 14:29:40 INFO - Running post-run listener: _upload_blobber_files 14:29:40 INFO - Blob upload gear active. 14:29:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:29:40 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 14:29:40 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'] 14:29:40 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 14:29:41 INFO - (blobuploader) - INFO - Open directory for files ... 14:29:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:29:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:42 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:29:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:42 INFO - (blobuploader) - INFO - Done attempting. 14:29:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:29:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:29:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:43 INFO - (blobuploader) - INFO - Done attempting. 14:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:29:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:50 INFO - (blobuploader) - INFO - Done attempting. 14:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:29:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:51 INFO - (blobuploader) - INFO - Done attempting. 14:29:51 INFO - (blobuploader) - INFO - Iteration through files over. 14:29:51 INFO - Return code: 0 14:29:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:29:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:29:51 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50f7451239ae4eb4e1850e8ff72a3adc7c131295ec5016f7de6a2031009f3a0f72e3d91a389ef6769b8a23407c3337a5290bd0c61c5611eaed6989cf420936ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f23ea8097794c511f9e0fe51ef2f5ae9841bb9edff34e55a54c4680533ab4f7ada2ca3578428d4e0079e7a542f32391996fb46b35d74bb4ba1b952b77ad9e23d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adac29eb5c51d83537f976a71d8965469de5da263d5b6c0961bc86600275a31554bf577b937cdad62d9bd7bcca52cbcb5e6748f222eee6df7a1ba54df759f166", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cec36642090bade761fe34c7c0368c8511ca8860b30726b28d710c4af422bbaf5ff1c00da401632c1f88317d0af802785812de4339a2afde75bfb1a78c36ddd"} 14:29:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:29:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:29:51 INFO - Contents: 14:29:51 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50f7451239ae4eb4e1850e8ff72a3adc7c131295ec5016f7de6a2031009f3a0f72e3d91a389ef6769b8a23407c3337a5290bd0c61c5611eaed6989cf420936ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f23ea8097794c511f9e0fe51ef2f5ae9841bb9edff34e55a54c4680533ab4f7ada2ca3578428d4e0079e7a542f32391996fb46b35d74bb4ba1b952b77ad9e23d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adac29eb5c51d83537f976a71d8965469de5da263d5b6c0961bc86600275a31554bf577b937cdad62d9bd7bcca52cbcb5e6748f222eee6df7a1ba54df759f166", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cec36642090bade761fe34c7c0368c8511ca8860b30726b28d710c4af422bbaf5ff1c00da401632c1f88317d0af802785812de4339a2afde75bfb1a78c36ddd"} 14:29:51 INFO - Running post-run listener: copy_logs_to_upload_dir 14:29:51 INFO - Copying logs to upload dir... 14:29:51 INFO - mkdir: /builds/slave/test/build/upload/logs 14:29:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.507199 ========= master_lag: -0.30 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-08-01 14:29:50.812145) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 14:29:50.819781) ========= 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=fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50f7451239ae4eb4e1850e8ff72a3adc7c131295ec5016f7de6a2031009f3a0f72e3d91a389ef6769b8a23407c3337a5290bd0c61c5611eaed6989cf420936ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f23ea8097794c511f9e0fe51ef2f5ae9841bb9edff34e55a54c4680533ab4f7ada2ca3578428d4e0079e7a542f32391996fb46b35d74bb4ba1b952b77ad9e23d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adac29eb5c51d83537f976a71d8965469de5da263d5b6c0961bc86600275a31554bf577b937cdad62d9bd7bcca52cbcb5e6748f222eee6df7a1ba54df759f166", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cec36642090bade761fe34c7c0368c8511ca8860b30726b28d710c4af422bbaf5ff1c00da401632c1f88317d0af802785812de4339a2afde75bfb1a78c36ddd"} build_url:https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011171 build_url: 'https://queue.taskcluster.net/v1/task/Q3D2GEEATdOj72Ov3q5KTg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/50f7451239ae4eb4e1850e8ff72a3adc7c131295ec5016f7de6a2031009f3a0f72e3d91a389ef6769b8a23407c3337a5290bd0c61c5611eaed6989cf420936ec", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f23ea8097794c511f9e0fe51ef2f5ae9841bb9edff34e55a54c4680533ab4f7ada2ca3578428d4e0079e7a542f32391996fb46b35d74bb4ba1b952b77ad9e23d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/adac29eb5c51d83537f976a71d8965469de5da263d5b6c0961bc86600275a31554bf577b937cdad62d9bd7bcca52cbcb5e6748f222eee6df7a1ba54df759f166", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3cec36642090bade761fe34c7c0368c8511ca8860b30726b28d710c4af422bbaf5ff1c00da401632c1f88317d0af802785812de4339a2afde75bfb1a78c36ddd"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-01 14:29:50.846792) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:29:50.847127) ========= 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=fcadb68e09dcf59683000ff6000001dc-1501621731.405852-271810694 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004502 ========= master_lag: 0.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-01 14:29:51.008678) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 14:29:51.008967) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-01 14:29:51.009523) ========= ========= Total master_lag: -0.06 =========