builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-013 starttime: 1502827943.6 results: success (0) revision: 7ff4c2f1fe11f6b98686f783294692893b1e1e8b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 13:12:23.596283) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 13:12:23.596696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 13:12:23.596971) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 13:12:23.624949) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 13:12:23.625240) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 13:12:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.3M=0s 2017-08-15 13:12:23 (36.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.128585 ========= master_lag: 0.70 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 13:12:24.455520) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 13:12:24.459882) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019800 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 13:12:24.493112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-15 13:12:24.493413) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7ff4c2f1fe11f6b98686f783294692893b1e1e8b --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 7ff4c2f1fe11f6b98686f783294692893b1e1e8b --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=9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 13:12:24,399 truncating revision to first 12 chars 2017-08-15 13:12:24,399 Setting DEBUG logging. 2017-08-15 13:12:24,399 attempt 1/10 2017-08-15 13:12:24,399 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7ff4c2f1fe11?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 13:12:25,163 unpacking tar archive at: mozilla-central-7ff4c2f1fe11/testing/mozharness/ program finished with exit code 0 elapsedTime=1.102115 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-15 13:12:25.613956) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 13:12:25.614276) ========= script_repo_revision: 7ff4c2f1fe11f6b98686f783294692893b1e1e8b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 13:12:25.614657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 13:12:25.614923) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 13:12:25.628431) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-15 13:12:25.628719) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:12:25 INFO - MultiFileLogger online at 20170815 13:12:25 in /builds/slave/test 13:12:25 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 13:12:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:12:25 INFO - {'append_to_log': False, 13:12:25 INFO - 'base_work_dir': '/builds/slave/test', 13:12:25 INFO - 'blob_upload_branch': 'Firefox', 13:12:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:12:25 INFO - 'branch': 'Firefox', 13:12:25 INFO - 'buildbot_json_path': 'buildprops.json', 13:12:25 INFO - 'code_coverage': False, 13:12:25 INFO - 'config_files': ('talos/linux_config.py',), 13:12:25 INFO - 'default_actions': ('clobber', 13:12:25 INFO - 'read-buildbot-config', 13:12:25 INFO - 'download-and-extract', 13:12:25 INFO - 'populate-webroot', 13:12:25 INFO - 'create-virtualenv', 13:12:25 INFO - 'install', 13:12:25 INFO - 'setup-mitmproxy', 13:12:25 INFO - 'run-tests'), 13:12:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:12:25 INFO - 'disable_ccov_upload': False, 13:12:25 INFO - 'download_minidump_stackwalk': True, 13:12:25 INFO - 'download_symbols': 'ondemand', 13:12:25 INFO - 'enable_stylo': False, 13:12:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:12:25 INFO - 'tooltool.py': '/tools/tooltool.py', 13:12:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:12:25 INFO - '/tools/misc-python/virtualenv.py')}, 13:12:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:12:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:12:25 INFO - 'gecko_profile': False, 13:12:25 INFO - 'gecko_profile_interval': 0, 13:12:25 INFO - 'installer_path': 'installer.exe', 13:12:25 INFO - 'log_level': 'info', 13:12:25 INFO - 'log_name': 'talos', 13:12:25 INFO - 'log_to_console': True, 13:12:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:12:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:12:25 INFO - 'opt_config_files': (), 13:12:25 INFO - 'pip_index': False, 13:12:25 INFO - 'suite': 'dromaeojs-e10s', 13:12:25 INFO - 'system_bits': '32', 13:12:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:12:25 INFO - 'title': 'talos-linux64-ix-013', 13:12:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:12:25 INFO - 'use_talos_json': True, 13:12:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:12:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:12:25 INFO - 'work_dir': 'build'} 13:12:25 INFO - [mozharness: 2017-08-15 20:12:25.640070Z] Running clobber step. 13:12:25 INFO - Running pre-action listener: _resource_record_pre_action 13:12:25 INFO - Running main action method: clobber 13:12:25 INFO - rmtree: /builds/slave/test/build 13:12:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:12:27 INFO - Running post-action listener: _resource_record_post_action 13:12:27 INFO - [mozharness: 2017-08-15 20:12:27.168825Z] Finished clobber step (success) 13:12:27 INFO - [mozharness: 2017-08-15 20:12:27.168927Z] Running read-buildbot-config step. 13:12:27 INFO - Running pre-action listener: _resource_record_pre_action 13:12:27 INFO - Running main action method: read_buildbot_config 13:12:27 INFO - Using buildbot properties: 13:12:27 INFO - { 13:12:27 INFO - "project": "", 13:12:27 INFO - "product": "firefox", 13:12:27 INFO - "who": "ryanvm@gmail.com", 13:12:27 INFO - "installer_path": "public/build/target.tar.bz2", 13:12:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 13:12:27 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:12:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 13:12:27 INFO - "stage_platform": "linux64-pgo", 13:12:27 INFO - "basedir": "/builds/slave/test", 13:12:27 INFO - "buildnumber": 115, 13:12:27 INFO - "platform": "ubuntu64_hw", 13:12:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:12:27 INFO - "slavebuilddir": "test", 13:12:27 INFO - "taskId": "N0ix4MBkT8WEt2cbkb5UVA", 13:12:27 INFO - "branch": "mozilla-central", 13:12:27 INFO - "script_repo_revision": "production", 13:12:27 INFO - "revision": "7ff4c2f1fe11f6b98686f783294692893b1e1e8b", 13:12:27 INFO - "slavename": "talos-linux64-ix-013", 13:12:27 INFO - "repo_path": "mozilla-central" 13:12:27 INFO - } 13:12:27 INFO - Finding installer, test and symbols from parent task. 13:12:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N0ix4MBkT8WEt2cbkb5UVA'}, attempt #1 13:12:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/N0ix4MBkT8WEt2cbkb5UVA'}, attempt #1 13:12:28 INFO - Task dependencies: fP_R9t15TcqIdTPlnrOVJA 13:12:28 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA'}, attempt #1 13:12:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.tar.bz2 13:12:28 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.test_packages.json 13:12:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.crashreporter-symbols.zip 13:12:28 INFO - Running post-action listener: _resource_record_post_action 13:12:28 INFO - [mozharness: 2017-08-15 20:12:28.549948Z] Finished read-buildbot-config step (success) 13:12:28 INFO - [mozharness: 2017-08-15 20:12:28.550169Z] Running download-and-extract step. 13:12:28 INFO - Running pre-action listener: _resource_record_pre_action 13:12:28 INFO - Running main action method: download_and_extract 13:12:28 INFO - mkdir: /builds/slave/test/build/tests 13:12: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')]} 13:12:28 INFO - trying https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.test_packages.json 13:12:28 INFO - Downloading https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:12:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:12:29 INFO - Downloaded 989 bytes. 13:12:29 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:12:29 INFO - Using the following test package requirements: 13:12:29 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:12:29 INFO - u'common': [u'target.common.tests.zip'], 13:12:29 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:12:29 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:12:29 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:12:29 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:12:29 INFO - u'mozbase': [u'target.common.tests.zip'], 13:12:29 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:12:29 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:12:29 INFO - u'web-platform': [u'target.common.tests.zip', 13:12:29 INFO - u'target.web-platform.tests.tar.gz'], 13:12:29 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:12:29 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:12:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.common.tests.zip 13:12:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:12:29 INFO - Fetch https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.common.tests.zip into memory 13:12:30 INFO - Content-Length response header: 54607565 13:12:30 INFO - Bytes received: 54607565 13:12:41 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:12:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.common.tests.zip 13:12:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:12:41 INFO - Fetch https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.common.tests.zip into memory 13:12:42 INFO - Content-Length response header: 54607565 13:12:42 INFO - Bytes received: 54607565 13:12:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.talos.tests.zip 13:12:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:12:55 INFO - Fetch https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.talos.tests.zip into memory 13:12:56 INFO - Content-Length response header: 14496050 13:12:56 INFO - Bytes received: 14496050 13:12:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:56 INFO - trying https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.tar.bz2 13:12:56 INFO - Downloading https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:12:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:12:57 INFO - Downloaded 62700464 bytes. 13:12:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.tar.bz2 13:12:57 INFO - mkdir: /builds/slave/test/properties 13:12:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:12:57 INFO - Writing to file /builds/slave/test/properties/build_url 13:12:57 INFO - Contents: 13:12:57 INFO - build_url:https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.tar.bz2 13:12:57 INFO - Running post-action listener: _resource_record_post_action 13:12:57 INFO - Running post-action listener: set_extra_try_arguments 13:12:57 INFO - [mozharness: 2017-08-15 20:12:57.553208Z] Finished download-and-extract step (success) 13:12:57 INFO - [mozharness: 2017-08-15 20:12:57.553307Z] Running populate-webroot step. 13:12:57 INFO - Running pre-action listener: _resource_record_pre_action 13:12:57 INFO - Running main action method: populate_webroot 13:12:57 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:12:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:12:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:12:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:12:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:12:57 INFO - 'tests': ['damp', 'tps']}, 13:12:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:12:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:12:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:12:57 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:12:57 INFO - 'other-e10s': {'tests': ['a11yr', 13:12:57 INFO - 'ts_paint', 13:12:57 INFO - 'tpaint', 13:12:57 INFO - 'sessionrestore', 13:12:57 INFO - 'sessionrestore_many_windows', 13:12:57 INFO - 'sessionrestore_no_auto_restore', 13:12:57 INFO - 'tabpaint']}, 13:12:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:12:57 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 13:12:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:12:57 INFO - 'tsvgr_opacity', 13:12:57 INFO - 'tart', 13:12:57 INFO - 'tscrollx', 13:12:57 INFO - 'tsvg_static']}, 13:12:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:12:57 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:12:57 INFO - 'talos_options': ['--mitmproxy', 13:12:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:12:57 INFO - '--firstNonBlankPaint'], 13:12:57 INFO - 'tests': ['tp6_google', 13:12:57 INFO - 'tp6_youtube', 13:12:57 INFO - 'tp6_amazon', 13:12:57 INFO - 'tp6_facebook']}, 13:12:57 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:12:57 INFO - 'talos_options': ['--stylo', 13:12:57 INFO - '--mitmproxy', 13:12:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:12:57 INFO - '--firstNonBlankPaint'], 13:12:57 INFO - 'tests': ['tp6_google', 13:12:57 INFO - 'tp6_youtube', 13:12:57 INFO - 'tp6_amazon', 13:12:57 INFO - 'tp6_facebook']}, 13:12:57 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:12:57 INFO - 'talos_options': ['--stylo', 13:12:57 INFO - '--stylo-threads=1', 13:12:57 INFO - '--mitmproxy', 13:12:57 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:12:57 INFO - '--firstNonBlankPaint'], 13:12:57 INFO - 'tests': ['tp6_google', 13:12:57 INFO - 'tp6_youtube', 13:12:57 INFO - 'tp6_amazon', 13:12:57 INFO - 'tp6_facebook']}, 13:12:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:12:57 INFO - 'talos_options': ['--xperf_path', 13:12:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:12:57 INFO - 'tests': ['tp5n']}}} 13:12:57 INFO - Running post-action listener: _resource_record_post_action 13:12:57 INFO - [mozharness: 2017-08-15 20:12:57.561817Z] Finished populate-webroot step (success) 13:12:57 INFO - [mozharness: 2017-08-15 20:12:57.561909Z] Running create-virtualenv step. 13:12:57 INFO - Running pre-action listener: _resource_record_pre_action 13:12:57 INFO - Running main action method: create_virtualenv 13:12:57 INFO - Creating virtualenv /builds/slave/test/build/venv 13:12:57 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 13:12:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:12:57 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:12:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:12:57 INFO - Using real prefix '/usr' 13:12:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:12:58 INFO - Installing distribute.............................................................................................................................................................................................done. 13:13:00 INFO - Installing pip.................done. 13:13:00 INFO - Return code: 0 13:13:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:13:00 INFO - Reading from file tmpfile_stdout 13:13:00 INFO - Output received: 13:13:00 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) 13:13:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2df00>, '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 0x1e28ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29050>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', '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 13:13:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:13:00 INFO - Using env: {'DISPLAY': ':0', 13:13:00 INFO - 'HOME': '/home/cltbld', 13:13:00 INFO - 'LANG': 'en_US.UTF-8', 13:13:00 INFO - 'LANGUAGE': 'en_US:en', 13:13:00 INFO - 'LOGNAME': 'cltbld', 13:13:00 INFO - 'MAIL': '/var/mail/cltbld', 13:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:00 INFO - 'MOZ_NO_REMOTE': '1', 13:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:00 INFO - 'NO_EM_RESTART': '1', 13:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:00 INFO - 'PWD': '/builds/slave/test', 13:13:00 INFO - 'SHELL': '/bin/bash', 13:13:00 INFO - 'SHLVL': '1', 13:13:00 INFO - 'TERM': 'linux', 13:13:00 INFO - 'TMOUT': '86400', 13:13:00 INFO - 'USER': 'cltbld', 13:13:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', 13:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:00 INFO - '_': '/tools/buildbot/bin/python'} 13:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:00 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 13:13:00 INFO - Cleaning up... 13:13:00 INFO - Return code: 0 13:13:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1abd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2df00>, '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 0x1e28ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29050>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', '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 13:13:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:13:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:13:00 INFO - Using env: {'DISPLAY': ':0', 13:13:00 INFO - 'HOME': '/home/cltbld', 13:13:00 INFO - 'LANG': 'en_US.UTF-8', 13:13:00 INFO - 'LANGUAGE': 'en_US:en', 13:13:00 INFO - 'LOGNAME': 'cltbld', 13:13:00 INFO - 'MAIL': '/var/mail/cltbld', 13:13:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:00 INFO - 'MOZ_NO_REMOTE': '1', 13:13:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:00 INFO - 'NO_EM_RESTART': '1', 13:13:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:00 INFO - 'PWD': '/builds/slave/test', 13:13:00 INFO - 'SHELL': '/bin/bash', 13:13:00 INFO - 'SHLVL': '1', 13:13:00 INFO - 'TERM': 'linux', 13:13:00 INFO - 'TMOUT': '86400', 13:13:00 INFO - 'USER': 'cltbld', 13:13:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', 13:13:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:00 INFO - '_': '/tools/buildbot/bin/python'} 13:13:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:00 INFO - Downloading/unpacking psutil>=3.1.1 13:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:13:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:13:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:13:01 INFO - Installing collected packages: psutil 13:13:01 INFO - Running setup.py install for psutil 13:13:02 INFO - building 'psutil._psutil_linux' extension 13:13:02 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 13:13:02 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 13:13:02 INFO - building 'psutil._psutil_posix' extension 13:13:02 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 13:13:02 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 13:13:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:13:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:13:02 INFO - Successfully installed psutil 13:13:02 INFO - Cleaning up... 13:13:02 INFO - Return code: 0 13:13:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:13: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')]} 13:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13: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')]} 13:13:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2df00>, '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 0x1e28ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29050>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', '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 13:13:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:13:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:13:02 INFO - Using env: {'DISPLAY': ':0', 13:13:02 INFO - 'HOME': '/home/cltbld', 13:13:02 INFO - 'LANG': 'en_US.UTF-8', 13:13:02 INFO - 'LANGUAGE': 'en_US:en', 13:13:02 INFO - 'LOGNAME': 'cltbld', 13:13:02 INFO - 'MAIL': '/var/mail/cltbld', 13:13:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:02 INFO - 'MOZ_NO_REMOTE': '1', 13:13:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:02 INFO - 'NO_EM_RESTART': '1', 13:13:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:02 INFO - 'PWD': '/builds/slave/test', 13:13:02 INFO - 'SHELL': '/bin/bash', 13:13:02 INFO - 'SHLVL': '1', 13:13:02 INFO - 'TERM': 'linux', 13:13:02 INFO - 'TMOUT': '86400', 13:13:02 INFO - 'USER': 'cltbld', 13:13:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', 13:13:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:02 INFO - '_': '/tools/buildbot/bin/python'} 13:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:13:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:13:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:13:03 INFO - Installing collected packages: mozsystemmonitor 13:13:03 INFO - Running setup.py install for mozsystemmonitor 13:13:03 INFO - Successfully installed mozsystemmonitor 13:13:03 INFO - Cleaning up... 13:13:04 INFO - Return code: 0 13:13:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1abd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2df00>, '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 0x1e28ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29050>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', '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 13:13:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:13:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:13:04 INFO - Using env: {'DISPLAY': ':0', 13:13:04 INFO - 'HOME': '/home/cltbld', 13:13:04 INFO - 'LANG': 'en_US.UTF-8', 13:13:04 INFO - 'LANGUAGE': 'en_US:en', 13:13:04 INFO - 'LOGNAME': 'cltbld', 13:13:04 INFO - 'MAIL': '/var/mail/cltbld', 13:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:04 INFO - 'MOZ_NO_REMOTE': '1', 13:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:04 INFO - 'NO_EM_RESTART': '1', 13:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:04 INFO - 'PWD': '/builds/slave/test', 13:13:04 INFO - 'SHELL': '/bin/bash', 13:13:04 INFO - 'SHLVL': '1', 13:13:04 INFO - 'TERM': 'linux', 13:13:04 INFO - 'TMOUT': '86400', 13:13:04 INFO - 'USER': 'cltbld', 13:13:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', 13:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:04 INFO - '_': '/tools/buildbot/bin/python'} 13:13:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:04 INFO - Downloading/unpacking jsonschema==2.5.1 13:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:13:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:13:05 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 13:13:05 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 13:13:05 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 13:13:05 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 13:13:05 INFO - Downloading functools32-3.2.3-2.tar.gz 13:13:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:13:05 INFO - warning: no files found matching '*.txt' 13:13:05 INFO - no previously-included directories found matching 'build' 13:13:05 INFO - no previously-included directories found matching 'dist' 13:13:05 INFO - no previously-included directories found matching '.git*' 13:13:05 INFO - Installing collected packages: jsonschema, functools32 13:13:05 INFO - Running setup.py install for functools32 13:13:05 INFO - warning: no files found matching '*.txt' 13:13:05 INFO - no previously-included directories found matching 'build' 13:13:05 INFO - no previously-included directories found matching 'dist' 13:13:05 INFO - no previously-included directories found matching '.git*' 13:13:05 INFO - Successfully installed jsonschema functools32 13:13:05 INFO - Cleaning up... 13:13:05 INFO - Return code: 0 13:13:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:05 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 0x1abd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2df00>, '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 0x1e28ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29050>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', '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 13:13:05 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 13:13:05 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 13:13:05 INFO - Using env: {'DISPLAY': ':0', 13:13:05 INFO - 'HOME': '/home/cltbld', 13:13:05 INFO - 'LANG': 'en_US.UTF-8', 13:13:05 INFO - 'LANGUAGE': 'en_US:en', 13:13:05 INFO - 'LOGNAME': 'cltbld', 13:13:05 INFO - 'MAIL': '/var/mail/cltbld', 13:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:05 INFO - 'MOZ_NO_REMOTE': '1', 13:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:05 INFO - 'NO_EM_RESTART': '1', 13:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:05 INFO - 'PWD': '/builds/slave/test', 13:13:05 INFO - 'SHELL': '/bin/bash', 13:13:05 INFO - 'SHLVL': '1', 13:13:05 INFO - 'TERM': 'linux', 13:13:05 INFO - 'TMOUT': '86400', 13:13:05 INFO - 'USER': 'cltbld', 13:13:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', 13:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:05 INFO - '_': '/tools/buildbot/bin/python'} 13:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:13:05 INFO - Cleaning up... 13:13:05 INFO - Return code: 0 13:13:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:05 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 0x1abd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2df00>, '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 0x1e28ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29050>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', '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 13:13:05 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 13:13:05 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 13:13:05 INFO - Using env: {'DISPLAY': ':0', 13:13:05 INFO - 'HOME': '/home/cltbld', 13:13:05 INFO - 'LANG': 'en_US.UTF-8', 13:13:05 INFO - 'LANGUAGE': 'en_US:en', 13:13:05 INFO - 'LOGNAME': 'cltbld', 13:13:05 INFO - 'MAIL': '/var/mail/cltbld', 13:13:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:05 INFO - 'MOZ_NO_REMOTE': '1', 13:13:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:05 INFO - 'NO_EM_RESTART': '1', 13:13:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:05 INFO - 'PWD': '/builds/slave/test', 13:13:05 INFO - 'SHELL': '/bin/bash', 13:13:05 INFO - 'SHLVL': '1', 13:13:05 INFO - 'TERM': 'linux', 13:13:05 INFO - 'TMOUT': '86400', 13:13:05 INFO - 'USER': 'cltbld', 13:13:05 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', 13:13:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:05 INFO - '_': '/tools/buildbot/bin/python'} 13:13:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:06 INFO - Downloading/unpacking blobuploader==1.2.4 13:13:06 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 13:13:06 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 13:13:06 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 13:13:06 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 13:13:07 INFO - Downloading blobuploader-1.2.4.tar.gz 13:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:13:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:13:07 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 13:13:07 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 13:13:07 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 13:13:07 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 13:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:13:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:13:07 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 13:13:07 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 13:13:07 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 13:13:07 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 13:13:07 INFO - Downloading docopt-0.6.1.tar.gz 13:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:13:07 INFO - Installing collected packages: blobuploader, requests, docopt 13:13:07 INFO - Running setup.py install for blobuploader 13:13:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:13:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:13:07 INFO - Running setup.py install for requests 13:13:08 INFO - Running setup.py install for docopt 13:13:08 INFO - Successfully installed blobuploader requests docopt 13:13:08 INFO - Cleaning up... 13:13:08 INFO - Return code: 0 13:13:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:08 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 0x1abd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2df00>, '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 0x1e28ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29050>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', '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 13:13:08 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 13:13:08 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 13:13:08 INFO - Using env: {'DISPLAY': ':0', 13:13:08 INFO - 'HOME': '/home/cltbld', 13:13:08 INFO - 'LANG': 'en_US.UTF-8', 13:13:08 INFO - 'LANGUAGE': 'en_US:en', 13:13:08 INFO - 'LOGNAME': 'cltbld', 13:13:08 INFO - 'MAIL': '/var/mail/cltbld', 13:13:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:08 INFO - 'MOZ_NO_REMOTE': '1', 13:13:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:08 INFO - 'NO_EM_RESTART': '1', 13:13:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:08 INFO - 'PWD': '/builds/slave/test', 13:13:08 INFO - 'SHELL': '/bin/bash', 13:13:08 INFO - 'SHLVL': '1', 13:13:08 INFO - 'TERM': 'linux', 13:13:08 INFO - 'TMOUT': '86400', 13:13:08 INFO - 'USER': 'cltbld', 13:13:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', 13:13:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:08 INFO - '_': '/tools/buildbot/bin/python'} 13:13:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:13:08 INFO - Running setup.py (path:/tmp/pip-9TEv_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:13:08 INFO - Running setup.py (path:/tmp/pip-qzgfe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:13:08 INFO - Running setup.py (path:/tmp/pip-NhCfPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:13:08 INFO - Running setup.py (path:/tmp/pip-fc9Df8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:13:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:13:08 INFO - Running setup.py (path:/tmp/pip-wjlHge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:13:09 INFO - Running setup.py (path:/tmp/pip-lAs4HL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:13:09 INFO - Running setup.py (path:/tmp/pip-O0Q4RB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:13:09 INFO - Running setup.py (path:/tmp/pip-049Qzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:13:09 INFO - Running setup.py (path:/tmp/pip-H4bDiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:13:09 INFO - Running setup.py (path:/tmp/pip-jDr1SS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:13:09 INFO - Running setup.py (path:/tmp/pip-s9PYjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:13:09 INFO - Running setup.py (path:/tmp/pip-ohu44E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:13:09 INFO - Running setup.py (path:/tmp/pip-Ac1dzw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:13:09 INFO - Running setup.py (path:/tmp/pip-dlLmG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:09 INFO - Running setup.py (path:/tmp/pip-AKk8Jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:13:09 INFO - Running setup.py (path:/tmp/pip-A6KADJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:13:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:13:09 INFO - Running setup.py (path:/tmp/pip-F2qDdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:13:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:13:09 INFO - Running setup.py install for manifestparser 13:13:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:13:09 INFO - Running setup.py install for mozcrash 13:13:10 INFO - Running setup.py install for mozdebug 13:13:10 INFO - Running setup.py install for mozdevice 13:13:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:13:10 INFO - Running setup.py install for mozfile 13:13:10 INFO - Running setup.py install for mozhttpd 13:13:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:13:10 INFO - Running setup.py install for mozinfo 13:13:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:13:10 INFO - Running setup.py install for mozInstall 13:13:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:13:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:13:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:13:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:13:10 INFO - Running setup.py install for mozleak 13:13:10 INFO - Running setup.py install for mozlog 13:13:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:13:10 INFO - Running setup.py install for moznetwork 13:13:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:13:10 INFO - Running setup.py install for mozprocess 13:13:11 INFO - Running setup.py install for mozprofile 13:13:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:13:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:13:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:13:11 INFO - Running setup.py install for mozrunner 13:13:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:13:11 INFO - Running setup.py install for mozscreenshot 13:13:11 INFO - Running setup.py install for moztest 13:13:11 INFO - Running setup.py install for mozversion 13:13:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:13:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:13:11 INFO - Cleaning up... 13:13:11 INFO - Return code: 0 13:13:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:11 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 0x1abd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2df00>, '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 0x1e28ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29050>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', '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 13:13:11 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 13:13:11 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 13:13:11 INFO - Using env: {'DISPLAY': ':0', 13:13:11 INFO - 'HOME': '/home/cltbld', 13:13:11 INFO - 'LANG': 'en_US.UTF-8', 13:13:11 INFO - 'LANGUAGE': 'en_US:en', 13:13:11 INFO - 'LOGNAME': 'cltbld', 13:13:11 INFO - 'MAIL': '/var/mail/cltbld', 13:13:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:11 INFO - 'MOZ_NO_REMOTE': '1', 13:13:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:11 INFO - 'NO_EM_RESTART': '1', 13:13:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:11 INFO - 'PWD': '/builds/slave/test', 13:13:11 INFO - 'SHELL': '/bin/bash', 13:13:11 INFO - 'SHLVL': '1', 13:13:11 INFO - 'TERM': 'linux', 13:13:11 INFO - 'TMOUT': '86400', 13:13:11 INFO - 'USER': 'cltbld', 13:13:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', 13:13:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:11 INFO - '_': '/tools/buildbot/bin/python'} 13:13:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:13:11 INFO - Running setup.py (path:/tmp/pip-3BR5qv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:13:11 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)) 13:13:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:13:11 INFO - Running setup.py (path:/tmp/pip-j2Gy_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:13:12 INFO - Running setup.py (path:/tmp/pip-dLbvce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:13:12 INFO - Running setup.py (path:/tmp/pip-S6fmVN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:13:12 INFO - Running setup.py (path:/tmp/pip-KZDdmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:13:12 INFO - Running setup.py (path:/tmp/pip-7Mn8tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:13:12 INFO - Running setup.py (path:/tmp/pip-hoD4B1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:13:12 INFO - Running setup.py (path:/tmp/pip-JhPdZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:13:12 INFO - Running setup.py (path:/tmp/pip-wLDKqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:13:12 INFO - Running setup.py (path:/tmp/pip-mUDIwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:13:12 INFO - Running setup.py (path:/tmp/pip-P66qs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:13:12 INFO - Running setup.py (path:/tmp/pip-mM8iNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:13:12 INFO - Running setup.py (path:/tmp/pip-xIdRxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:13:12 INFO - Running setup.py (path:/tmp/pip-sEeO9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:12 INFO - Running setup.py (path:/tmp/pip-9gQTwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:13:12 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)) 13:13:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:13:12 INFO - Running setup.py (path:/tmp/pip-4DTzqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:13:13 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)) 13:13:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:13:13 INFO - Running setup.py (path:/tmp/pip-vraVyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:13:13 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)) 13:13:13 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)) 13:13:13 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)) 13:13:13 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)) 13:13:13 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)) 13:13:13 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)) 13:13:13 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)) 13:13:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:13:13 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 13:13:13 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 13:13:13 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 13:13:13 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 13:13:14 INFO - Downloading blessings-1.6.tar.gz 13:13:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:13:14 INFO - Installing collected packages: blessings 13:13:14 INFO - Running setup.py install for blessings 13:13:14 INFO - Successfully installed blessings 13:13:14 INFO - Cleaning up... 13:13:14 INFO - Return code: 0 13:13:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:13:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:13:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:13:14 INFO - Reading from file tmpfile_stdout 13:13:14 INFO - Current package versions: 13:13:14 INFO - argparse == 1.2.1 13:13:14 INFO - blessings == 1.6 13:13:14 INFO - blobuploader == 1.2.4 13:13:14 INFO - docopt == 0.6.1 13:13:14 INFO - functools32 == 3.2.3-2 13:13:14 INFO - jsonschema == 2.5.1 13:13:14 INFO - manifestparser == 1.1 13:13:14 INFO - mozInstall == 1.13 13:13:14 INFO - mozcrash == 1.0 13:13:14 INFO - mozdebug == 0.1 13:13:14 INFO - mozdevice == 0.51 13:13:14 INFO - mozfile == 1.2 13:13:14 INFO - mozhttpd == 0.7 13:13:14 INFO - mozinfo == 0.10 13:13:14 INFO - mozleak == 0.1 13:13:14 INFO - mozlog == 3.5 13:13:14 INFO - moznetwork == 0.27 13:13:14 INFO - mozprocess == 0.25 13:13:14 INFO - mozprofile == 0.28 13:13:14 INFO - mozrunner == 6.13 13:13:14 INFO - mozscreenshot == 0.1 13:13:14 INFO - mozsystemmonitor == 0.3 13:13:14 INFO - moztest == 0.8 13:13:14 INFO - mozversion == 1.4 13:13:14 INFO - psutil == 3.1.1 13:13:14 INFO - requests == 1.2.3 13:13:14 INFO - wsgiref == 0.1.2 13:13:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:13:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:14 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 0x1abd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2df00>, '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 0x1e28ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29050>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', '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 13:13:14 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 13:13:14 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 13:13:14 INFO - Using env: {'DISPLAY': ':0', 13:13:14 INFO - 'HOME': '/home/cltbld', 13:13:14 INFO - 'LANG': 'en_US.UTF-8', 13:13:14 INFO - 'LANGUAGE': 'en_US:en', 13:13:14 INFO - 'LOGNAME': 'cltbld', 13:13:14 INFO - 'MAIL': '/var/mail/cltbld', 13:13:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:14 INFO - 'MOZ_NO_REMOTE': '1', 13:13:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:14 INFO - 'NO_EM_RESTART': '1', 13:13:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:14 INFO - 'PWD': '/builds/slave/test', 13:13:14 INFO - 'SHELL': '/bin/bash', 13:13:14 INFO - 'SHLVL': '1', 13:13:14 INFO - 'TERM': 'linux', 13:13:14 INFO - 'TMOUT': '86400', 13:13:14 INFO - 'USER': 'cltbld', 13:13:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', 13:13:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:14 INFO - '_': '/tools/buildbot/bin/python'} 13:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:14 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)) 13:13:14 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)) 13:13:14 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)) 13:13:14 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)) 13:13:14 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)) 13:13:14 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)) 13:13:14 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)) 13:13:14 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)) 13:13:14 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)) 13:13:14 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:13:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:13:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:13:16 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)) 13:13:16 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)) 13:13:16 INFO - Installing collected packages: simplejson 13:13:16 INFO - Running setup.py install for simplejson 13:13:16 INFO - building 'simplejson._speedups' extension 13:13:16 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 13:13:16 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 13:13:17 INFO - Successfully installed simplejson 13:13:17 INFO - Cleaning up... 13:13:17 INFO - Return code: 0 13:13:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:13:17 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')]} 13:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:13:17 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')]} 13:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:13:17 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 0x1abd1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c89a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2ab20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e2df00>, '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 0x1e28ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29050>, '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': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', '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 13:13:17 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 13:13:17 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 13:13:17 INFO - Using env: {'DISPLAY': ':0', 13:13:17 INFO - 'HOME': '/home/cltbld', 13:13:17 INFO - 'LANG': 'en_US.UTF-8', 13:13:17 INFO - 'LANGUAGE': 'en_US:en', 13:13:17 INFO - 'LOGNAME': 'cltbld', 13:13:17 INFO - 'MAIL': '/var/mail/cltbld', 13:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:17 INFO - 'MOZ_NO_REMOTE': '1', 13:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:17 INFO - 'NO_EM_RESTART': '1', 13:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:17 INFO - 'PWD': '/builds/slave/test', 13:13:17 INFO - 'SHELL': '/bin/bash', 13:13:17 INFO - 'SHLVL': '1', 13:13:17 INFO - 'TERM': 'linux', 13:13:17 INFO - 'TMOUT': '86400', 13:13:17 INFO - 'USER': 'cltbld', 13:13:17 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', 13:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:17 INFO - '_': '/tools/buildbot/bin/python'} 13:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:13:17 INFO - Cleaning up... 13:13:17 INFO - Return code: 0 13:13:17 INFO - Running post-action listener: _resource_record_post_action 13:13:17 INFO - Running post-action listener: _start_resource_monitoring 13:13:17 INFO - Starting resource monitoring. 13:13:17 INFO - [mozharness: 2017-08-15 20:13:17.374054Z] Finished create-virtualenv step (success) 13:13:17 INFO - [mozharness: 2017-08-15 20:13:17.374574Z] Running install step. 13:13:17 INFO - Running pre-action listener: _resource_record_pre_action 13:13:17 INFO - Running main action method: install 13:13:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:13:17 INFO - Reading from file tmpfile_stdout 13:13:17 INFO - Detecting whether we're running mozinstall >=1.0... 13:13:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:13:17 INFO - Reading from file tmpfile_stdout 13:13:17 INFO - Output received: 13:13:17 INFO - Usage: mozinstall [options] installer 13:13:17 INFO - Options: 13:13:17 INFO - -h, --help show this help message and exit 13:13:17 INFO - -d DEST, --destination=DEST 13:13:17 INFO - Directory to install application into. [default: 13:13:17 INFO - "/builds/slave/test"] 13:13:17 INFO - --app=APP Application being installed. [default: firefox] 13:13:17 INFO - mkdir: /builds/slave/test/build/application 13:13:17 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'] 13:13:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:13:35 INFO - Reading from file tmpfile_stdout 13:13:35 INFO - Output received: 13:13:35 INFO - /builds/slave/test/build/application/firefox/firefox 13:13:35 INFO - Running post-action listener: _resource_record_post_action 13:13:35 INFO - [mozharness: 2017-08-15 20:13:35.460029Z] Finished install step (success) 13:13:35 INFO - [mozharness: 2017-08-15 20:13:35.460375Z] Running setup-mitmproxy step. 13:13:35 INFO - Running pre-action listener: _resource_record_pre_action 13:13:35 INFO - Running main action method: setup_mitmproxy 13:13:35 INFO - Skipping: mitmproxy is not required 13:13:35 INFO - Running post-action listener: _resource_record_post_action 13:13:35 INFO - [mozharness: 2017-08-15 20:13:35.462073Z] Finished setup-mitmproxy step (success) 13:13:35 INFO - [mozharness: 2017-08-15 20:13:35.462385Z] Running run-tests step. 13:13:35 INFO - Running pre-action listener: _resource_record_pre_action 13:13:35 INFO - Running pre-action listener: _set_gcov_prefix 13:13:35 INFO - Running main action method: run_tests 13:13:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:13:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:13:35 INFO - Python 2.7.3 13:13:35 INFO - Return code: 0 13:13:35 INFO - grabbing minidump binary from tooltool 13:13:35 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')]} 13:13:35 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 0x1e2df00>, '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 0x1e28ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e29050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:13:35 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 13:13:35 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 13:13:35 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 13:13:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:13:35 INFO - Return code: 0 13:13:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:13:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:13:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:13:35 INFO - ENV: RUST_BACKTRACE is now full 13:13:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:13:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:13:35 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/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 13:13:35 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/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 13:13:35 INFO - Using env: {'DISPLAY': ':0', 13:13:35 INFO - 'HOME': '/home/cltbld', 13:13:35 INFO - 'LANG': 'en_US.UTF-8', 13:13:35 INFO - 'LANGUAGE': 'en_US:en', 13:13:35 INFO - 'LOGNAME': 'cltbld', 13:13:35 INFO - 'MAIL': '/var/mail/cltbld', 13:13:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:13:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:13:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:13:35 INFO - 'MOZ_NO_REMOTE': '1', 13:13:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:13:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:13:35 INFO - 'NO_EM_RESTART': '1', 13:13:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:13:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:13:35 INFO - 'PWD': '/builds/slave/test', 13:13:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:13:35 INFO - 'RUST_BACKTRACE': 'full', 13:13:35 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:13:35 INFO - 'SHELL': '/bin/bash', 13:13:35 INFO - 'SHLVL': '1', 13:13:35 INFO - 'TERM': 'linux', 13:13:35 INFO - 'TMOUT': '86400', 13:13:35 INFO - 'USER': 'cltbld', 13:13:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402', 13:13:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:13:35 INFO - '_': '/tools/buildbot/bin/python'} 13:13:35 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/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 13:13:35 INFO - mozversion application_buildid: 20170815185620 13:13:35 INFO - mozversion application_changeset: 7ff4c2f1fe11f6b98686f783294692893b1e1e8b 13:13:35 INFO - mozversion application_display_name: Nightly 13:13:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:13:35 INFO - mozversion application_name: Firefox 13:13:35 INFO - mozversion application_remotingname: firefox 13:13:35 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:13:35 INFO - mozversion application_vendor: Mozilla 13:13:35 INFO - mozversion application_version: 57.0a1 13:13:35 INFO - mozversion platform_buildid: 20170815185620 13:13:35 INFO - mozversion platform_changeset: 7ff4c2f1fe11f6b98686f783294692893b1e1e8b 13:13:35 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:13:35 INFO - mozversion platform_version: 57.0a1 13:13:35 INFO - using testdate: 1502828015 13:13:35 INFO - actual date: 1502828015 13:13:35 INFO - starting webserver on 'localhost:40322' 13:13:35 INFO - SUITE-START | Running 2 tests 13:13:35 INFO - TEST-START | dromaeo_css 13:13:35 INFO - Initialising browser for dromaeo_css test... 13:13:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40322/getInfo.html -profile /tmp/tmpnMgkGs/profile 13:13:35 INFO - TEST-INFO | started process 12203 (/builds/slave/test/build/application/firefox/firefox http://localhost:40322/getInfo.html) 13:13:41 INFO - TEST-INFO | 12203: exit 0 13:13:41 INFO - Browser initialized. 13:13:41 INFO - Running cycle 1/1 for dromaeo_css test... 13:13:41 INFO - TEST-INFO | started process 12416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnMgkGs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:42 INFO - PID 12416 | 13:13:42 INFO - PID 12416 | (/builds/slave/test/build/application/firefox/firefox:12465): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:13:42 INFO - PID 12416 | 13:13:52 INFO - PID 12416 | RSS: Main: 157429760 13:13:52 INFO - PID 12416 | 13:16:50 INFO - PID 12416 | Cycle 1(1): loaded http://localhost:40322/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40322/tests/dromaeo/cssquery-ext.html) 13:16:51 INFO - PID 12416 | RSS: Main: 165621760 13:16:51 INFO - PID 12416 | 13:19:53 INFO - PID 12416 | Cycle 1(1): loaded http://localhost:40322/tests/dromaeo/cssquery-ext.html (next: http://localhost:40322/tests/dromaeo/cssquery-jquery.html) 13:19:53 INFO - PID 12416 | RSS: Main: 162455552 13:19:53 INFO - PID 12416 | 13:22:55 INFO - PID 12416 | Cycle 1(1): loaded http://localhost:40322/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40322/tests/dromaeo/cssquery-mootools.html) 13:22:55 INFO - PID 12416 | RSS: Main: 165097472 13:22:55 INFO - PID 12416 | 13:25:57 INFO - PID 12416 | Cycle 1(1): loaded http://localhost:40322/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40322/tests/dromaeo/cssquery-prototype.html) 13:25:58 INFO - PID 12416 | RSS: Main: 163233792 13:25:58 INFO - PID 12416 | 13:29:01 INFO - PID 12416 | Cycle 1(1): loaded http://localhost:40322/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40322/tests/dromaeo/cssquery-yui.html) 13:29:01 INFO - PID 12416 | RSS: Main: 166793216 13:29:01 INFO - PID 12416 | 13:32:03 INFO - PID 12416 | Cycle 1(1): loaded http://localhost:40322/tests/dromaeo/cssquery-yui.html (next: http://localhost:40322/tests/dromaeo/cssquery-dojo.html) 13:32:03 INFO - PID 12416 | RSS: Main: 167092224 13:32:03 INFO - PID 12416 | 13:32:03 INFO - PID 12416 | __start_tp_report 13:32:03 INFO - PID 12416 | _x_x_mozilla_page_load 13:32:03 INFO - PID 12416 | _x_x_mozilla_page_load_details 13:32:03 INFO - PID 12416 | |i|pagename|runs| 13:32:03 INFO - PID 12416 | |0;dojo.html;3521.6654417830314;3531.523244362011;3541.451075083362;3553.4669799530084;3563.0557902155915;6156.353582873801;6234.625922444651;6251.593646412985;6278.529110316727;6316.842078948017;6051.394860513947;6114.480269177126;6118.96940515298;6236.594621349609;6325.841853953653;5445.700486473243;5470.206820011096;5544.140658197985;5550.972245138789;5581.916271255935;5381.408045115034;5415.13357862742;5430.456954304577;5448.128299472085;5497.780088796443;5493.478119578654;5507.256520369739;5539.778408863641;5553.750081246333;5581.10702287632;5371.838844834622;5505.697186654733;5557.444255574451;5558.221848941152;5570.749316280777;5404.648697834628;5460.34475862895;5502.614816962814;5514.0901751211;5531.612787104904;6149.477294429978;6160.353162917919;6189.288231853349;6198.690065496752;6223.657698826562;6533.705983230766;6604.537682362236;6713.899291510631;6757.425618822406;6770.424513916323;6681.064650948871;6729.461643068543;6741.325867413219;6747.257801641816;6751.42612877906;6286.245650521967;6288.088227207075;6322.810315690536;6333.145025421555;6350.745970161188;6832.180138383425;6847.452203823682;6863.519553631198;6930.306969303029;6937.375636192767;6686.431653309426;6689.431398331197;6691.866162676719;6716.126903502513;6725.092112564839;6756.425703815133;6762.560433571802;6838.760643377458;6840.623765692835;6840.726370945206;6711.194656641234;6723.764668236686;6725.192976842713;6725.63009034498;6796.490263230277;6733.764318248838;6738.056672065914;6744.0895479109695;6764.222114456802;6771.356721111487;4901.411830580282;4903.092927808367;4962.6774259673;4963.305137280783;4971.328870602495;4341.37050127736;4383.07955329378;4393.0994146199955;4394.252976993918;4394.692371533962;6239.78160764371;6346.30190679025;6357.396047375492;6487.35126487357;6494.090827284184;6772.796816095525;6792.388685018372;6801.353871382211;6808.659567021629;6810.31896810315;6434.163558737334;6437.0988061671405;6481.805545833632;6483.902741458882;6521.706523206467;5362.329708786402;5431.782728690887;5451.727413629303;5505.807296744595;5564.33228012641;6968.616726080013;7126.821829454305;7147.070880785464;7169.426445884421;7189.496735228484;6755.088063111417;6783.59298442095;6843.657817109224;6863.347981941708;6867.587944723333;6970.895436568354;7119.537230080028;7124.145102587722;7227.602481863548;7244.89132663;6576.046473261446;6579.374959378852;6605.735770569124;6610.471162306908;6625.204975402982;6815.591064536144;6855.725770969106;6862.210845752603;6868.862622747417;6879.6216208107035;6292.1505596743855;6342.556021078481;6342.7145778441;6360.650164240826;6420.7431702731365;6374.139491168633;6390.201224846895;6393.7122829471855;6405.679716014088;6408.263049749152;6378.043293506012;6396.648184349905;6397.26431460388;6397.552171348148;6398.5521013528605;6478.4169424752;6492.935070649233;6510;6513.250976137805;6595.901061483985;6195.628262304276;6321.936780632319;6334.841628959313;6409.903851442139;6424.807255782334 13:32:03 INFO - PID 12416 | |1;ext.html;895.8153763371217;897.2698745277206;903.9005709371969;939.0656296984502;944.3153713557672;42861.35707964379;43849.78075109624;43896.56103438965;43914;43947.56052439474;38894.22211555767;39090.413643795364;39103.60896391035;39398.212035759265;39462.210755784865;7009.474289428288;7135.3934915532245;7138.286171382872;7139.286071392845;7139.60732159731;6950.79147625572;7014.579125252476;7027.227005029443;7034.824129396755;7050.506464547484;6991.056207412011;7007.964960175192;7019.40335071517;7027.332403421692;7053.506254562183;6997.510174287802;7028.156621205462;7028.929710702904;7032.824179395505;7045.718171273143;6508.828410886039;6520.739170433177;6532.5753826001155;6543.672816359211;6575.901361479581;35488.29023419543;35676.64323356759;35684.821575892216;35706.82146589276;35724.464133038025;3391.084407210064;3427.160345715291;3428.6571342865514;3432.0733401981574;3432.3993301172195;28321.008764693343;28344.433111337865;28379.71620283812;28405.57391639127;28460.715392846014;4572.154151481986;4608.585227329523;4615.8615241542475;4627.745473998929;4641.373414589021;200421;204495;206506.9674651632;207325;209682;51308.23037654438;51408.74295628573;51937.7403112982;52022.21966670503;52038.47961520337;52627.47372526226;52742.47257527376;52843;52987;53007.20489192665;15357;15500.84499154994;15521.223938803014;15548.84451155474;15721.292541835644;12628.558000469939;12652.746945061048;12654.620361389174;12668.429920653592;12697.746045079231;13425.530106446227;13497.797533037012;13501.797473037912;13601.863981360259;13709.931450342685;5426.8914621707345;5443.265159203457;5495.670259784426;5507.339119305709;5559.694216818033;1061.5170097605571;1070.7537266428765;1079.3416016230094;1083.2092572422175;1089.9073578745738;24346.391340216636;24571.877140614182;32620.673793262238;32767.344653106804;33158.8342058293;1150.8273758936227;1202.6632542888005;1217.4156404925686;1234.5000274888685;1235.407004637779;13271.270080145685;13324.824378156512;13519.66200844967;13630.250336231404;13731.656708582166;277822;281085;281637;281987;282308;56372.43627563754;57306.426935730946;57480.71259643675;57540.42459575351;57737;1557.672888693387;1561.2896132259796;1579.2577488580348;1602.671452352265;1614.4026710117332;24727.38181545476;30068.69931300659;30443.54334685026;30473.390532189675;31098.53352199764;57486.7125664369;57820.421795781505;57841.4215857836;58022.12966805586;58120;233503;236557;236806;236880;236923;36944.63055369519;37711.05722356963;38041.809790950865;38051.42922856215;38057;45793;46464;47045.76477117593;48161;48511;34921.301573968885;35018.29963400667;35460.64539354573;35735.82132089323;35760.10599734923;35592.28815423625;36120.4581931266;36335.27329453449;36337.63662363343;36712.26575468529;41070.38394424146;41142.58857411507;41550.37674434826;41616.58383416127;42141;34655.13362165966;34743.65256347505;34934.30131397409;35050.474242885866;35127.82436087803;24754.381140470912;25900;25914.481710366064;26036.479270414864;26440.471190576467 13:32:03 INFO - PID 12416 | |2;jquery.html;559.3176324883643;567.9346875109363;576.5733357315586;579.9652020878748;584.4914924016106;23366.41583960402;23869.880650596722;23942.16202432915;24025.999999999956;24109.758902410947;25301.240962771146;27459.31351716208;27684.30789230265;27772.58341124885;28000.859995699993;6377.936220637781;6519.706613202417;6520.31536688648;6524.543281970264;6527.0209468579615;6193.194884665009;6366.458850997671;6467.870642587145;6478.578892372005;6486.383793539606;6384.329645387237;6420.229572451312;6426.325235850239;6433.035044743303;6434.549581529295;6378.585391949508;6423.903641445382;6425.8393540161405;6432;6435.259945106326;5941.465268125889;5980.551458640576;5981.371955944606;5983.072623743326;5988.19159413478;29578.408431831456;30197.245068873235;30342.84828575865;30455.086347409615;31012.37975240505;2253.6394176931776;2275.8520696154696;2283.5432913417217;2285.9771402285933;2293.7247530296304;20121.195152193894;20513.38459846207;20734.170633174654;20742.170313187453;20769.58460830775;2421.128393778238;2491.489244704831;2541.1106112860534;2543.300592337104;2546.6180072989014;145791;151098;151195;151327.24336378358;151468.24265878712;15079.54761357161;15123.773143402857;15297.158656274012;15706.607334816492;16040;23566.88216558906;23686.289411317688;24338;24363.390915226908;24375.878120609283;10140.898591013995;10319.638812641671;10327.225458090674;10424.061834434937;10438.321509101885;9173.54132293396;9212.94051184109;9244.8613270801;9274.90725092754;9373.156415922464;9814.754631134136;9828.705138845846;9859;10023.448710321003;10099.424646715188;2590.28767089052;2627.1461774923227;2639.8812053457254;2697.5009623219767;2716.7962402819867;1029.2743615750878;1029.3669393323053;1036.5750042482546;1048.2190767877828;1048.4286064095086;20813.06341214649;20857.374278771662;21045.89477052605;21051.78948210529;21086.789132108788;1114.5374669512223;1119.412308538024;1122.2705241592867;1132.92069555132;1141.1555448967704;11394.544218231344;11758.88241117595;11759;11768.705782355339;11804.40977951099;622497;637185;641735;644886;648783;131744.341278293;131855;132164;134132;136055.23806666918;1243.1360204657856;1258.4714419943646;1277.2974863824859;1279.315566172112;1282.39086433945;19371.128299226286;19454.319098831475;22150.77849221487;22235.555288893807;22368.328950131523;67074;68155.65922170358;69435;69442.65278673574;72979.63510182415;87844;88642.55678721823;90498.64252036093;90762.54618726864;90861.54569227112;21317.147314107264;21404.357869263946;21461.570768584228;22917.88541057284;23057.538849222587;25008;25468.363290917874;25696.743032569437;25719.971201151744;25777.226683199533;18188.81811181924;18279.634407312045;18296;19415.8058419414;20521.794782051988;17951.820481795537;18052.27790888402;18174.45476635703;18382.448526544224;18678.906605466887;19964.30124945678;20183;20316;20328.89835550813;20358.185672573523;20194;20451.466140039855;20584.176632934516;20613.690794637794;20707.8964605176;19708;19757.802421975597;19834.20663173457;19857.404277871687;20027.799722002594 13:32:03 INFO - PID 12416 | |3;mootools.html;1440.5174266620681;1504.443355958295;1518.165009244915;1533.1567637799214;1547.5898886794998;14816.999999999987;15455.30451129699;15483.303251353702;15489.535313940572;15491.457798977039;15871.920640396811;16825.83174168258;16877.071761053136;16886;16889.1555422229;2704.675438947324;2735.7674597659225;2738.1648597177855;2740.4245108527234;2741.8629068546593;2600.401907561262;2637.4197676511135;2647.3513989072703;2701.540738074532;2702.486527559767;2731.6312297839836;2736.3022429280604;2756.3109222694325;2760.4341110072387;2760.627315312427;2643.312738687936;2671.8263312884797;2687.704352521221;2696.1641891013846;2701.9054333098347;2679.1560658392546;2700.3114205877378;2712.4168303814777;2719.3473566344132;2720.415110751198;15977.520674379788;16064.678706425922;16304.347826086941;16311.755323670155;16313.102779347131;8290.751277461686;8581.871271930926;8589.570521473965;8590.441621294658;8598.957005214996;5149.845504634867;5292.259083728281;5320.042392369372;5380.704061276629;5432.293801805779;1819.0995457248746;1833.6149408624206;1849.3527265457117;1867.3837633580886;1874.297138573035;28930.855345723347;28963.275918102005;29781.702182978108;29834.403311933856;29843.253918652208;6668.533202675766;6758.05387245786;6987.7204911802955;7025.156981162293;7207.675654595556;18488.075596220406;18488.537786555175;18503.629927401376;18509;18525.722114168297;8259.83480330402;8339.708110216114;8345.582720863933;8346.290565301895;8350.916490835014;7483.738069167662;7602.163761986177;7641.350485208708;7674.731384401631;7730.033745781778;5231.3199284092825;5335.839924802262;5378.650387724785;5393.568514518829;5405.108157154025;1484.139199264424;1485.843986381436;1492.723846088477;1505.811773528309;1512.2060918017908;918.5958178401482;941.3128416256171;942.8915674697498;950.3917492804611;953.4946478366338;8029.197080291924;8045.15525869787;8054.355651547862;8081.757547273592;8087.514749115072;733.5158795195252;742.4654248940755;743.6467677853085;749.1534565940452;757.2541047068632;5293.947060529423;6035.124906888476;6063.029915213545;6399.776007839796;6538.836529086716;21933.232336868132;22360.440988975406;22378.440538986655;23455;24431.26706198817;23335.416614584432;23645.29064128079;23658.408539786644;23867.52264954691;23887.522249554913;11941.64175074749;12246.142770006192;12584.056195785353;12673.746525069631;12721.618351449471;9317.254619630277;9454.858177127486;9458.763530911783;9529.285303602119;9660.565274562801;20690.275840345515;21191.788082118983;21362.57274854525;21381.572368552854;21592.568148637252;21067.473313167295;21271.042803074208;21380.572388552453;21674.89162554177;21756.564868702855;13223.603291901258;13379.3979270935;13487.05590608648;13516.72966540644;13570.93214533921;14372.353244103831;14568.490102846774;14581;14687.118772873662;14705.779413309023;11943.820842687193;12065;12195.695107622381;12325.198862073936;12506.74986500283;11986.64040078799;12018.218815776947;12042.63872083839;12045.217060891015;12120.212186207867;10668;10710.946445267724;10732.67801965911;10765.946170269099;10780.568777248822;7688.231176882267;7980.321672657889;8107.4324797263625;8396.832063358821;8399.832003359776;8253.83492330138;8283.83432331362;8370.623321950405;8459.703910363107;8527.701530446404 13:32:03 INFO - PID 12416 | |4;prototype.html;496.77893337464843;509.1598861877902;513.3865031287613;516.720970675835;521.5280171444841;6150.938490615093;6181.505479561635;6189.13352130701;6200.534959878016;6219.160413344197;6099.390060993909;6100.633961962285;6106.419890110433;6109.5723299369065;6190.288116866562;4705.741184234866;4764.404449443819;4777.450593181794;4814.374131362935;4908.7300198489065;4812.013537224878;4821.373221481203;4834.444038935532;4842.467328593852;4867.123917694814;4769.141554520185;4795.952040479603;4799.784009719571;4802.327674125625;4828.855134345975;4792.832250871237;4797.160496913044;4802.087603355386;4811;4811.446683631375;4362.650987920959;4376.256036473807;4383.605475507188;4388.0034584264085;4389.517153113155;5824.854378640525;5984.431479009487;6015.639061656315;6076.696165191723;6171.814845554595;5709.400512946164;5754.625949313281;5760.135979603051;5781.71091445426;5819.505342045931;6572.441342485894;6595.10966019586;6606.537542372036;6643.6346000969925;6656.534042617019;4878.268259761029;4893.632977526664;4937.604991600663;4939.456659767423;4949.331840201563;6607.504437167232;6674.466042716571;6806.936878404787;6819.283975182584;6956.234814170488;4903.602473295094;5009.949900500948;5018.623603229772;5048.268001139814;5078.7460626968505;5066.6453348266;5077.949220507821;5135.922961155586;5139;5162.845114646567;5653.689047102449;5654.264945557051;5720.1991721159075;5738.626989245686;5779.075347944308;6581.506387020992;6591.242007169237;6594.307597702268;6610.752344202994;6652.434543063797;1754.3070487157502;1777.297967302908;1789.6689112514227;1789.8926064435916;1800.8559315254747;1172.372780562395;1207.9818802717966;1225.1607648760448;1238.4612693478366;1250.3810613746073;6264.906026409608;6293.842653933688;6387.147727159072;6444.0989907977255;6458.54790164684;6583.03763306514;6710.664466776641;6763.864722705518;6778;6817.352351526597;6320.841978950563;6321.683915804191;6328.46208072319;6398.712057957403;6399.680015999182;3563.1448452371246;3564.7682900611894;3577.982110089485;3595.5146055282726;3603;7091.468139889529;7114;7152.606606636581;7215.783526494109;7230.408690481582;6856.057766784119;6858.177018757781;6897.275786042494;6955.860882782417;7003.369696727319;7077.433805295564;7125.180604230476;7145.499815013107;7201.747938822116;7230.891536626955;6142.723577438936;6631.104800851823;6652.168478940132;6783.660816959231;6792.252852186157;6554.115194448688;6587.957733102753;6619.801405957829;6630.370114839083;6704.899426508704;6965.616891071039;7016.2636571738085;7020.824479388056;7114.786556403316;7170.390516805921;5015.272785446017;5017.989206476085;5028.195488721787;5068.467810879952;5077.873053173553;6533.052707357501;6710.0345744148;6727.510820996263;6851.07510486078;6922.342377474132;6332.715027823851;6414.166158399565;6429.485641148791;6479.2224933006455;6627.403533681992;6447.161868957193;6468.547201696025;6484.870302593828;6526.487302388519;6599.571027883172;6508.479321654351;6544.803655890331;6552;6592.868142637216;6618.404343609098;6489.221293444817;6533.314002029719;6612.041254018237;6616.90074648871;6669.266380698023;6391.6804159792755;6421.64680942534;6438.227412710505;6509.381608747161;6510.837229069121 13:32:03 INFO - PID 12416 | |5;yui.html;933.8085692433048;950.5722424908793;951.7864722478838;964.5548534465132;964.956576954037;17484.125793710326;18012.729809052875;18059.097045147722;18094.457166285018;21493.892530537327;20435.897820510876;20916.26793062243;21177.047032883518;21240.362789116352;21246.57506849862;1059.7456610413522;1080.200651517875;1081.2161183142236;1083.0956151613411;1083.6423980086593;1072.5388083124253;1073.3935326540518;1076.1821016027836;1082.783443311337;1102.1293178389103;1123.185690374476;1126.1159989408316;1129.9378584130932;1133.8639363276377;1137.3687603380122;1123.2249747674161;1125.9211855170101;1134.075728281448;1139.777743340049;1150.8906653867912;826.2233500509502;833.6165363932598;835.7033253195088;838.3335248477475;841.6927821345226;18676;18768.436946891616;18770.34303799374;18816.717749233772;19630.312939047064;21468.355949321547;21646.24238151657;21902.89048554763;22329;22353.217637382615;17215.913920430445;17230.913845430692;17271.3955011574;17361.305547778073;17406.56483587908;3681.9447708284397;3752.212035472554;3760.3795373763296;3775.7734535927934;3784.0161557994843;143562.28218858837;143716;144187.99999999895;144719;145164;14552.636184095481;15030.924845375703;15085.170315632526;15087.24563771829;15110.320035598425;27334.316642084108;27383.315417114733;27833.860830695718;27849.860750696116;28689.713102868704;8430.11483794205;8437.95781021091;8666.047047947595;8718.43330183536;8766;4594.770261486912;4666.486686464486;4669.4630117536235;4676.3686902267755;4682.297655351656;5335.5464785492895;5342.252084708144;5343.599230057761;5354.464553544614;5375.704336261465;1144.7481554058095;1162.593092417647;1166.4867458318313;1167.643868620079;1173.6244401791516;704.3379223529865;726.7202127181073;727.9963600182072;737.6606760889944;747.768191860525;12780;13212.405441754952;13419;14016.369263383172;14225.14649121056;731.6963460164079;742.0097009053522;751.7631945937012;753.7135888362387;754.2005474197368;5707.6290041147195;6873.759418420432;6937.615319403621;6989.685464154125;7064.823379415556;137015;138041;138807.30596347156;139867;144690;117272;117655.41172294255;118614;119344;123510.38244808899;104322;104611.4769426148;108334.45832770786;109139;112177;13392.531261406193;14092.154470731788;14422.42310307576;14453.421863125357;14468.565943021726;50631.49368506268;50949;50951.235731464796;51284.74357628188;52516.47483525269;62636.68681656563;65503.344966549725;65658.81413455856;65840.6707966457;66750;18669.626607468046;18745.90627046856;18774.906125469286;18816.529586759894;18846.151923163765;21134.894325528276;21778.89110554437;21934.670979934996;21996.120155193614;22094.116235350404;20395.4901127473;20434.080466378753;21037.053332599764;21038;21151.153953841673;20142.496437589176;20192.293269735488;20194.39416817498;20321.79678203199;21156.365309040753;19165.712514312574;19307;22134.66797997999;22220;22306;14435.92782036083;14811.703765924405;14864.405423782928;14865.925670371578;15141.697166056838;14618.561443156723;14663.719419398907;14666.046706964013;14740.926295368454;15877.729781617212 13:32:03 INFO - PID 12416 | __end_tp_report 13:32:03 INFO - PID 12416 | __start_cc_report 13:32:03 INFO - PID 12416 | _x_x_mozilla_cycle_collect,329 13:32:03 INFO - PID 12416 | __end_cc_report 13:32:03 INFO - PID 12416 | __startTimestamp1502829123710__endTimestamp 13:32:03 INFO - PID 12416 | 13:32:03 INFO - PID 12416 | ------- Summary: start ------- 13:32:03 INFO - PID 12416 | Number of tests: 6 13:32:03 INFO - PID 12416 | 13:32:03 INFO - PID 12416 | [#0] dojo.html Cycles:165 Average:6187.82 Median:6398.55 stddev:793.45 (12.4%) stddev-sans-first:767.82 13:32:03 INFO - PID 12416 | Values: 3521.7 3531.5 3541.5 3553.5 3563.1 6156.4 6234.6 6251.6 6278.5 6316.8 6051.4 6114.5 6119.0 6236.6 6325.8 5445.7 5470.2 5544.1 5551.0 5581.9 5381.4 5415.1 5430.5 5448.1 5497.8 5493.5 5507.3 5539.8 5553.8 5581.1 5371.8 5505.7 5557.4 5558.2 5570.7 5404.6 5460.3 5502.6 5514.1 5531.6 6149.5 6160.4 6189.3 6198.7 6223.7 6533.7 6604.5 6713.9 6757.4 6770.4 6681.1 6729.5 6741.3 6747.3 6751.4 6286.2 6288.1 6322.8 6333.1 6350.7 6832.2 6847.5 6863.5 6930.3 6937.4 6686.4 6689.4 6691.9 6716.1 6725.1 6756.4 6762.6 6838.8 6840.6 6840.7 6711.2 6723.8 6725.2 6725.6 6796.5 6733.8 6738.1 6744.1 6764.2 6771.4 4901.4 4903.1 4962.7 4963.3 4971.3 4341.4 4383.1 4393.1 4394.3 4394.7 6239.8 6346.3 6357.4 6487.4 6494.1 6772.8 6792.4 6801.4 6808.7 6810.3 6434.2 6437.1 6481.8 6483.9 6521.7 5362.3 5431.8 5451.7 5505.8 5564.3 6968.6 7126.8 7147.1 7169.4 7189.5 6755.1 6783.6 6843.7 6863.3 6867.6 6970.9 7119.5 7124.1 7227.6 7244.9 6576.0 6579.4 6605.7 6610.5 6625.2 6815.6 6855.7 6862.2 6868.9 6879.6 6292.2 6342.6 6342.7 6360.7 6420.7 6374.1 6390.2 6393.7 6405.7 6408.3 6378.0 6396.6 6397.3 6397.6 6398.6 6478.4 6492.9 6510.0 6513.3 6595.9 6195.6 6321.9 6334.8 6409.9 6424.8 13:32:03 INFO - PID 12416 | 13:32:03 INFO - PID 12416 | [#1] ext.html Cycles:180 Average:42092.11 Median:35940.28 stddev:63315.97 (176.2%) stddev-sans-first:63418.03 13:32:03 INFO - PID 12416 | Values: 895.8 897.3 903.9 939.1 944.3 42861.4 43849.8 43896.6 43914.0 43947.6 38894.2 39090.4 39103.6 39398.2 39462.2 7009.5 7135.4 7138.3 7139.3 7139.6 6950.8 7014.6 7027.2 7034.8 7050.5 6991.1 7008.0 7019.4 7027.3 7053.5 6997.5 7028.2 7028.9 7032.8 7045.7 6508.8 6520.7 6532.6 6543.7 6575.9 35488.3 35676.6 35684.8 35706.8 35724.5 3391.1 3427.2 3428.7 3432.1 3432.4 28321.0 28344.4 28379.7 28405.6 28460.7 4572.2 4608.6 4615.9 4627.7 4641.4 200421.0 204495.0 206507.0 207325.0 209682.0 51308.2 51408.7 51937.7 52022.2 52038.5 52627.5 52742.5 52843.0 52987.0 53007.2 15357.0 15500.8 15521.2 15548.8 15721.3 12628.6 12652.7 12654.6 12668.4 12697.7 13425.5 13497.8 13501.8 13601.9 13709.9 5426.9 5443.3 5495.7 5507.3 5559.7 1061.5 1070.8 1079.3 1083.2 1089.9 24346.4 24571.9 32620.7 32767.3 33158.8 1150.8 1202.7 1217.4 1234.5 1235.4 13271.3 13324.8 13519.7 13630.3 13731.7 277822.0 281085.0 281637.0 281987.0 282308.0 56372.4 57306.4 57480.7 57540.4 57737.0 1557.7 1561.3 1579.3 1602.7 1614.4 24727.4 30068.7 30443.5 30473.4 31098.5 57486.7 57820.4 57841.4 58022.1 58120.0 233503.0 236557.0 236806.0 236880.0 236923.0 36944.6 37711.1 38041.8 38051.4 38057.0 45793.0 46464.0 47045.8 48161.0 48511.0 34921.3 35018.3 35460.6 35735.8 35760.1 35592.3 36120.5 36335.3 36337.6 36712.3 41070.4 41142.6 41550.4 41616.6 42141.0 34655.1 34743.7 34934.3 35050.5 35127.8 24754.4 25900.0 25914.5 26036.5 26440.5 13:32:03 INFO - PID 12416 | 13:32:03 INFO - PID 12416 | [#2] jquery.html Cycles:180 Average:41522.73 Median:12675.63 stddev:106702.52 (841.8%) stddev-sans-first:106957.52 13:32:03 INFO - PID 12416 | Values: 559.3 567.9 576.6 580.0 584.5 23366.4 23869.9 23942.2 24026.0 24109.8 25301.2 27459.3 27684.3 27772.6 28000.9 6377.9 6519.7 6520.3 6524.5 6527.0 6193.2 6366.5 6467.9 6478.6 6486.4 6384.3 6420.2 6426.3 6433.0 6434.5 6378.6 6423.9 6425.8 6432.0 6435.3 5941.5 5980.6 5981.4 5983.1 5988.2 29578.4 30197.2 30342.8 30455.1 31012.4 2253.6 2275.9 2283.5 2286.0 2293.7 20121.2 20513.4 20734.2 20742.2 20769.6 2421.1 2491.5 2541.1 2543.3 2546.6 145791.0 151098.0 151195.0 151327.2 151468.2 15079.5 15123.8 15297.2 15706.6 16040.0 23566.9 23686.3 24338.0 24363.4 24375.9 10140.9 10319.6 10327.2 10424.1 10438.3 9173.5 9212.9 9244.9 9274.9 9373.2 9814.8 9828.7 9859.0 10023.4 10099.4 2590.3 2627.1 2639.9 2697.5 2716.8 1029.3 1029.4 1036.6 1048.2 1048.4 20813.1 20857.4 21045.9 21051.8 21086.8 1114.5 1119.4 1122.3 1132.9 1141.2 11394.5 11758.9 11759.0 11768.7 11804.4 622497.0 637185.0 641735.0 644886.0 648783.0 131744.3 131855.0 132164.0 134132.0 136055.2 1243.1 1258.5 1277.3 1279.3 1282.4 19371.1 19454.3 22150.8 22235.6 22368.3 67074.0 68155.7 69435.0 69442.7 72979.6 87844.0 88642.6 90498.6 90762.5 90861.5 21317.1 21404.4 21461.6 22917.9 23057.5 25008.0 25468.4 25696.7 25720.0 25777.2 18188.8 18279.6 18296.0 19415.8 20521.8 17951.8 18052.3 18174.5 18382.4 18678.9 19964.3 20183.0 20316.0 20328.9 20358.2 20194.0 20451.5 20584.2 20613.7 20707.9 19708.0 19757.8 19834.2 19857.4 20027.8 13:32:03 INFO - PID 12416 | 13:32:03 INFO - PID 12416 | [#3] mootools.html Cycles:180 Average:10086.97 Median:2683.43 stddev:7394.90 (275.6%) stddev-sans-first:7387.11 13:32:03 INFO - PID 12416 | Values: 1440.5 1504.4 1518.2 1533.2 1547.6 14817.0 15455.3 15483.3 15489.5 15491.5 15871.9 16825.8 16877.1 16886.0 16889.2 2704.7 2735.8 2738.2 2740.4 2741.9 2600.4 2637.4 2647.4 2701.5 2702.5 2731.6 2736.3 2756.3 2760.4 2760.6 2643.3 2671.8 2687.7 2696.2 2701.9 2679.2 2700.3 2712.4 2719.3 2720.4 15977.5 16064.7 16304.3 16311.8 16313.1 8290.8 8581.9 8589.6 8590.4 8599.0 5149.8 5292.3 5320.0 5380.7 5432.3 1819.1 1833.6 1849.4 1867.4 1874.3 28930.9 28963.3 29781.7 29834.4 29843.3 6668.5 6758.1 6987.7 7025.2 7207.7 18488.1 18488.5 18503.6 18509.0 18525.7 8259.8 8339.7 8345.6 8346.3 8350.9 7483.7 7602.2 7641.4 7674.7 7730.0 5231.3 5335.8 5378.7 5393.6 5405.1 1484.1 1485.8 1492.7 1505.8 1512.2 918.6 941.3 942.9 950.4 953.5 8029.2 8045.2 8054.4 8081.8 8087.5 733.5 742.5 743.6 749.2 757.3 5293.9 6035.1 6063.0 6399.8 6538.8 21933.2 22360.4 22378.4 23455.0 24431.3 23335.4 23645.3 23658.4 23867.5 23887.5 11941.6 12246.1 12584.1 12673.7 12721.6 9317.3 9454.9 9458.8 9529.3 9660.6 20690.3 21191.8 21362.6 21381.6 21592.6 21067.5 21271.0 21380.6 21674.9 21756.6 13223.6 13379.4 13487.1 13516.7 13570.9 14372.4 14568.5 14581.0 14687.1 14705.8 11943.8 12065.0 12195.7 12325.2 12506.7 11986.6 12018.2 12042.6 12045.2 12120.2 10668.0 10710.9 10732.7 10765.9 10780.6 7688.2 7980.3 8107.4 8396.8 8399.8 8253.8 8283.8 8370.6 8459.7 8527.7 13:32:03 INFO - PID 12416 | 13:32:03 INFO - PID 12416 | [#4] prototype.html Cycles:180 Average:5579.51 Median:6242.03 stddev:1604.68 (25.7%) stddev-sans-first:1563.17 13:32:03 INFO - PID 12416 | Values: 496.8 509.2 513.4 516.7 521.5 6150.9 6181.5 6189.1 6200.5 6219.2 6099.4 6100.6 6106.4 6109.6 6190.3 4705.7 4764.4 4777.5 4814.4 4908.7 4812.0 4821.4 4834.4 4842.5 4867.1 4769.1 4796.0 4799.8 4802.3 4828.9 4792.8 4797.2 4802.1 4811.0 4811.4 4362.7 4376.3 4383.6 4388.0 4389.5 5824.9 5984.4 6015.6 6076.7 6171.8 5709.4 5754.6 5760.1 5781.7 5819.5 6572.4 6595.1 6606.5 6643.6 6656.5 4878.3 4893.6 4937.6 4939.5 4949.3 6607.5 6674.5 6806.9 6819.3 6956.2 4903.6 5009.9 5018.6 5048.3 5078.7 5066.6 5077.9 5135.9 5139.0 5162.8 5653.7 5654.3 5720.2 5738.6 5779.1 6581.5 6591.2 6594.3 6610.8 6652.4 1754.3 1777.3 1789.7 1789.9 1800.9 1172.4 1208.0 1225.2 1238.5 1250.4 6264.9 6293.8 6387.1 6444.1 6458.5 6583.0 6710.7 6763.9 6778.0 6817.4 6320.8 6321.7 6328.5 6398.7 6399.7 3563.1 3564.8 3578.0 3595.5 3603.0 7091.5 7114.0 7152.6 7215.8 7230.4 6856.1 6858.2 6897.3 6955.9 7003.4 7077.4 7125.2 7145.5 7201.7 7230.9 6142.7 6631.1 6652.2 6783.7 6792.3 6554.1 6588.0 6619.8 6630.4 6704.9 6965.6 7016.3 7020.8 7114.8 7170.4 5015.3 5018.0 5028.2 5068.5 5077.9 6533.1 6710.0 6727.5 6851.1 6922.3 6332.7 6414.2 6429.5 6479.2 6627.4 6447.2 6468.5 6484.9 6526.5 6599.6 6508.5 6544.8 6552.0 6592.9 6618.4 6489.2 6533.3 6612.0 6616.9 6669.3 6391.7 6421.6 6438.2 6509.4 6510.8 13:32:03 INFO - PID 12416 | 13:32:03 INFO - PID 12416 | [#5] yui.html Cycles:180 Average:26840.19 Median:19886.40 stddev:38550.17 (193.9%) stddev-sans-first:38609.23 13:32:03 INFO - PID 12416 | Values: 933.8 950.6 951.8 964.6 965.0 17484.1 18012.7 18059.1 18094.5 21493.9 20435.9 20916.3 21177.0 21240.4 21246.6 1059.7 1080.2 1081.2 1083.1 1083.6 1072.5 1073.4 1076.2 1082.8 1102.1 1123.2 1126.1 1129.9 1133.9 1137.4 1123.2 1125.9 1134.1 1139.8 1150.9 826.2 833.6 835.7 838.3 841.7 18676.0 18768.4 18770.3 18816.7 19630.3 21468.4 21646.2 21902.9 22329.0 22353.2 17215.9 17230.9 17271.4 17361.3 17406.6 3681.9 3752.2 3760.4 3775.8 3784.0 143562.3 143716.0 144188.0 144719.0 145164.0 14552.6 15030.9 15085.2 15087.2 15110.3 27334.3 27383.3 27833.9 27849.9 28689.7 8430.1 8438.0 8666.0 8718.4 8766.0 4594.8 4666.5 4669.5 4676.4 4682.3 5335.5 5342.3 5343.6 5354.5 5375.7 1144.7 1162.6 1166.5 1167.6 1173.6 704.3 726.7 728.0 737.7 747.8 12780.0 13212.4 13419.0 14016.4 14225.1 731.7 742.0 751.8 753.7 754.2 5707.6 6873.8 6937.6 6989.7 7064.8 137015.0 138041.0 138807.3 139867.0 144690.0 117272.0 117655.4 118614.0 119344.0 123510.4 104322.0 104611.5 108334.5 109139.0 112177.0 13392.5 14092.2 14422.4 14453.4 14468.6 50631.5 50949.0 50951.2 51284.7 52516.5 62636.7 65503.3 65658.8 65840.7 66750.0 18669.6 18745.9 18774.9 18816.5 18846.2 21134.9 21778.9 21934.7 21996.1 22094.1 20395.5 20434.1 21037.1 21038.0 21151.2 20142.5 20192.3 20194.4 20321.8 21156.4 19165.7 19307.0 22134.7 22220.0 22306.0 14435.9 14811.7 14864.4 14865.9 15141.7 14618.6 14663.7 14666.0 14740.9 15877.7 13:32:03 INFO - PID 12416 | -------- Summary: end -------- 13:32:03 INFO - PID 12416 | 13:32:04 INFO - TEST-INFO | 12416: exit 0 13:32:04 INFO - TEST-OK | dromaeo_css | took 1108639ms 13:32:04 INFO - TEST-START | kraken 13:32:04 INFO - Initialising browser for kraken test... 13:32:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:40322/getInfo.html -profile /tmp/tmpH2d1uk/profile 13:32:04 INFO - TEST-INFO | started process 12785 (/builds/slave/test/build/application/firefox/firefox http://localhost:40322/getInfo.html) 13:32:09 INFO - TEST-INFO | 12785: exit 0 13:32:10 INFO - Browser initialized. 13:32:10 INFO - Running cycle 1/1 for kraken test... 13:32:10 INFO - TEST-INFO | started process 12999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpH2d1uk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:32:10 INFO - PID 12999 | 13:32:10 INFO - PID 12999 | (/builds/slave/test/build/application/firefox/firefox:13048): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:32:10 INFO - PID 12999 | 13:32:21 INFO - PID 12999 | RSS: Main: 157712384 13:32:21 INFO - PID 12999 | 13:32:23 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40322/tests/kraken/driver.html?testName=audio-beat-detection) 13:32:24 INFO - PID 12999 | RSS: Main: 163676160 13:32:24 INFO - PID 12999 | 13:32:27 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40322/tests/kraken/driver.html?testName=audio-dft) 13:32:27 INFO - PID 12999 | RSS: Main: 167915520 13:32:27 INFO - PID 12999 | 13:32:30 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40322/tests/kraken/driver.html?testName=audio-fft) 13:32:31 INFO - PID 12999 | RSS: Main: 161230848 13:32:31 INFO - PID 12999 | 13:32:33 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40322/tests/kraken/driver.html?testName=audio-oscillator) 13:32:34 INFO - PID 12999 | RSS: Main: 162885632 13:32:34 INFO - PID 12999 | 13:32:36 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40322/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:32:36 INFO - PID 12999 | RSS: Main: 162017280 13:32:36 INFO - PID 12999 | 13:32:39 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40322/tests/kraken/driver.html?testName=imaging-darkroom) 13:32:40 INFO - PID 12999 | RSS: Main: 162971648 13:32:40 INFO - PID 12999 | 13:32:43 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40322/tests/kraken/driver.html?testName=imaging-desaturate) 13:32:44 INFO - PID 12999 | RSS: Main: 164409344 13:32:44 INFO - PID 12999 | 13:32:47 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40322/tests/kraken/driver.html?testName=json-parse-financial) 13:32:47 INFO - PID 12999 | RSS: Main: 164917248 13:32:47 INFO - PID 12999 | 13:32:49 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40322/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:32:49 INFO - PID 12999 | RSS: Main: 164536320 13:32:49 INFO - PID 12999 | 13:32:51 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40322/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:32:52 INFO - PID 12999 | RSS: Main: 164642816 13:32:52 INFO - PID 12999 | 13:32:54 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40322/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:32:54 INFO - PID 12999 | RSS: Main: 164352000 13:32:54 INFO - PID 12999 | 13:32:57 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40322/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:32:58 INFO - PID 12999 | RSS: Main: 164384768 13:32:58 INFO - PID 12999 | 13:33:01 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40322/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:33:01 INFO - PID 12999 | RSS: Main: 164651008 13:33:01 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | Cycle 1(1): loaded http://localhost:40322/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40322/tests/kraken/driver.html?testName=ai-astar) 13:33:03 INFO - PID 12999 | RSS: Main: 166621184 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | __start_tp_report 13:33:03 INFO - PID 12999 | _x_x_mozilla_page_load 13:33:03 INFO - PID 12999 | _x_x_mozilla_page_load_details 13:33:03 INFO - PID 12999 | |i|pagename|runs| 13:33:03 INFO - PID 12999 | |0;ai-astar;98;107;98;106;108;108;108;99;106;107 13:33:03 INFO - PID 12999 | |1;audio-beat-detection;136;112;144;169;114;139;145;114;166;114 13:33:03 INFO - PID 12999 | |2;audio-dft;162;163;161;161;162;161;164;162;163;163 13:33:03 INFO - PID 12999 | |3;audio-fft;74;81;75;176;74;73;75;73;175;74 13:33:03 INFO - PID 12999 | |4;audio-oscillator;78;79;133;78;82;81;139;80;78;127 13:33:03 INFO - PID 12999 | |5;imaging-gaussian-blur;114;113;114;113;114;118;114;114;115;114 13:33:03 INFO - PID 12999 | |6;imaging-darkroom;148;148;148;148;149;147;148;148;149;148 13:33:03 INFO - PID 12999 | |7;imaging-desaturate;94;94;94;94;94;93;94;94;94;94 13:33:03 INFO - PID 12999 | |8;json-parse-financial;48;47;48;47;49;47;48;47;48;51 13:33:03 INFO - PID 12999 | |9;json-stringify-tinderbox;54;54;54;54;54;55;56;54;56;55 13:33:03 INFO - PID 12999 | |10;stanford-crypto-aes;80;75;76;75;81;73;73;72;75;75 13:33:03 INFO - PID 12999 | |11;stanford-crypto-ccm;122;130;115;116;116;125;118;120;121;164 13:33:03 INFO - PID 12999 | |12;stanford-crypto-pbkdf2;166;167;174;162;161;164;161;161;165;156 13:33:03 INFO - PID 12999 | |13;stanford-crypto-sha256-iterative;62;63;61;63;60;60;62;60;60;60 13:33:03 INFO - PID 12999 | __end_tp_report 13:33:03 INFO - PID 12999 | __start_cc_report 13:33:03 INFO - PID 12999 | _x_x_mozilla_cycle_collect,837 13:33:03 INFO - PID 12999 | __end_cc_report 13:33:03 INFO - PID 12999 | __startTimestamp1502829183617__endTimestamp 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | ------- Summary: start ------- 13:33:03 INFO - PID 12999 | Number of tests: 14 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#0] ai-astar Cycles:10 Average:104.50 Median:108.00 stddev:4.33 (4.0%) stddev-sans-first:3.90 13:33:03 INFO - PID 12999 | Values: 98.0 107.0 98.0 106.0 108.0 108.0 108.0 99.0 106.0 107.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:141.50 stddev:21.52 (15.2%) stddev-sans-first:22.82 13:33:03 INFO - PID 12999 | Values: 136.0 112.0 144.0 169.0 114.0 139.0 145.0 114.0 166.0 114.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.50 stddev:1.03 (0.6%) stddev-sans-first:1.09 13:33:03 INFO - PID 12999 | Values: 162.0 163.0 161.0 161.0 162.0 161.0 164.0 162.0 163.0 163.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#3] audio-fft Cycles:10 Average:95.00 Median:74.00 stddev:42.49 (57.4%) stddev-sans-first:44.38 13:33:03 INFO - PID 12999 | Values: 74.0 81.0 75.0 176.0 74.0 73.0 75.0 73.0 175.0 74.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:78.50 stddev:26.07 (33.2%) stddev-sans-first:26.87 13:33:03 INFO - PID 12999 | Values: 78.0 79.0 133.0 78.0 82.0 81.0 139.0 80.0 78.0 127.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:1.42 (1.2%) stddev-sans-first:1.50 13:33:03 INFO - PID 12999 | Values: 114.0 113.0 114.0 113.0 114.0 118.0 114.0 114.0 115.0 114.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 13:33:03 INFO - PID 12999 | Values: 148.0 148.0 148.0 148.0 149.0 147.0 148.0 148.0 149.0 148.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:33:03 INFO - PID 12999 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#8] json-parse-financial Cycles:10 Average:48.00 Median:48.00 stddev:1.25 (2.6%) stddev-sans-first:1.32 13:33:03 INFO - PID 12999 | Values: 48.0 47.0 48.0 47.0 49.0 47.0 48.0 47.0 48.0 51.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:54.50 stddev:0.84 (1.5%) stddev-sans-first:0.87 13:33:03 INFO - PID 12999 | Values: 54.0 54.0 54.0 54.0 54.0 55.0 56.0 54.0 56.0 55.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.00 stddev:2.92 (3.9%) stddev-sans-first:2.60 13:33:03 INFO - PID 12999 | Values: 80.0 75.0 76.0 75.0 81.0 73.0 73.0 72.0 75.0 75.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:121.50 stddev:14.55 (12.0%) stddev-sans-first:15.40 13:33:03 INFO - PID 12999 | Values: 122.0 130.0 115.0 116.0 116.0 125.0 118.0 120.0 121.0 164.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.70 Median:164.50 stddev:4.81 (2.9%) stddev-sans-first:5.03 13:33:03 INFO - PID 12999 | Values: 166.0 167.0 174.0 162.0 161.0 164.0 161.0 161.0 165.0 156.0 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.10 Median:61.50 stddev:1.29 (2.1%) stddev-sans-first:1.32 13:33:03 INFO - PID 12999 | Values: 62.0 63.0 61.0 63.0 60.0 60.0 62.0 60.0 60.0 60.0 13:33:03 INFO - PID 12999 | -------- Summary: end -------- 13:33:03 INFO - PID 12999 | 13:33:03 INFO - PID 12999 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:33:04 INFO - TEST-INFO | 12999: exit 0 13:33:04 INFO - TEST-OK | kraken | took 59780ms 13:33:04 INFO - SUITE-END | took 1168s 13:33:04 INFO - Completed test suite (00:19:28) 13:33:04 INFO - javascript benchmark 13:33:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8932.162692591884, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3521.6654417830314, 3531.523244362011, 3541.451075083362, 3553.4669799530084, 3563.0557902155915, 6156.353582873801, 6234.625922444651, 6251.593646412985, 6278.529110316727, 6316.842078948017, 6051.394860513947, 6114.480269177126, 6118.96940515298, 6236.594621349609, 6325.841853953653, 5445.700486473243, 5470.206820011096, 5544.140658197985, 5550.972245138789, 5581.916271255935, 5381.408045115034, 5415.13357862742, 5430.456954304577, 5448.128299472085, 5497.780088796443, 5493.478119578654, 5507.256520369739, 5539.778408863641, 5553.750081246333, 5581.10702287632, 5371.838844834622, 5505.697186654733, 5557.444255574451, 5558.221848941152, 5570.749316280777, 5404.648697834628, 5460.34475862895, 5502.614816962814, 5514.0901751211, 5531.612787104904, 6149.477294429978, 6160.353162917919, 6189.288231853349, 6198.690065496752, 6223.657698826562, 6533.705983230766, 6604.537682362236, 6713.899291510631, 6757.425618822406, 6770.424513916323, 6681.064650948871, 6729.461643068543, 6741.325867413219, 6747.257801641816, 6751.42612877906, 6286.245650521967, 6288.088227207075, 6322.810315690536, 6333.145025421555, 6350.745970161188, 6832.180138383425, 6847.452203823682, 6863.519553631198, 6930.306969303029, 6937.375636192767, 6686.431653309426, 6689.431398331197, 6691.866162676719, 6716.126903502513, 6725.092112564839, 6756.425703815133, 6762.560433571802, 6838.760643377458, 6840.623765692835, 6840.726370945206, 6711.194656641234, 6723.764668236686, 6725.192976842713, 6725.63009034498, 6796.490263230277, 6733.764318248838, 6738.056672065914, 6744.0895479109695, 6764.222114456802, 6771.356721111487, 4901.411830580282, 4903.092927808367, 4962.6774259673, 4963.305137280783, 4971.328870602495, 4341.37050127736, 4383.07955329378, 4393.0994146199955, 4394.252976993918, 4394.692371533962, 6239.78160764371, 6346.30190679025, 6357.396047375492, 6487.35126487357, 6494.090827284184, 6772.796816095525, 6792.388685018372, 6801.353871382211, 6808.659567021629, 6810.31896810315, 6434.163558737334, 6437.0988061671405, 6481.805545833632, 6483.902741458882, 6521.706523206467, 5362.329708786402, 5431.782728690887, 5451.727413629303, 5505.807296744595, 5564.33228012641, 6968.616726080013, 7126.821829454305, 7147.070880785464, 7169.426445884421, 7189.496735228484, 6755.088063111417, 6783.59298442095, 6843.657817109224, 6863.347981941708, 6867.587944723333, 6970.895436568354, 7119.537230080028, 7124.145102587722, 7227.602481863548, 7244.89132663, 6576.046473261446, 6579.374959378852, 6605.735770569124, 6610.471162306908, 6625.204975402982, 6815.591064536144, 6855.725770969106, 6862.210845752603, 6868.862622747417, 6879.6216208107035, 6292.1505596743855, 6342.556021078481, 6342.7145778441, 6360.650164240826, 6420.7431702731365, 6374.139491168633, 6390.201224846895, 6393.7122829471855, 6405.679716014088, 6408.263049749152, 6378.043293506012, 6396.648184349905, 6397.26431460388, 6397.552171348148, 6398.5521013528605, 6478.4169424752, 6492.935070649233, 6510.0, 6513.250976137805, 6595.901061483985, 6195.628262304276, 6321.936780632319, 6334.841628959313, 6409.903851442139, 6424.807255782334], "value": 6128.241962941151, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [895.8153763371217, 897.2698745277206, 903.9005709371969, 939.0656296984502, 944.3153713557672, 42861.35707964379, 43849.78075109624, 43896.56103438965, 43914.0, 43947.56052439474, 38894.22211555767, 39090.413643795364, 39103.60896391035, 39398.212035759265, 39462.210755784865, 7009.474289428288, 7135.3934915532245, 7138.286171382872, 7139.286071392845, 7139.60732159731, 6950.79147625572, 7014.579125252476, 7027.227005029443, 7034.824129396755, 7050.506464547484, 6991.056207412011, 7007.964960175192, 7019.40335071517, 7027.332403421692, 7053.506254562183, 6997.510174287802, 7028.156621205462, 7028.929710702904, 7032.824179395505, 7045.718171273143, 6508.828410886039, 6520.739170433177, 6532.5753826001155, 6543.672816359211, 6575.901361479581, 35488.29023419543, 35676.64323356759, 35684.821575892216, 35706.82146589276, 35724.464133038025, 3391.084407210064, 3427.160345715291, 3428.6571342865514, 3432.0733401981574, 3432.3993301172195, 28321.008764693343, 28344.433111337865, 28379.71620283812, 28405.57391639127, 28460.715392846014, 4572.154151481986, 4608.585227329523, 4615.8615241542475, 4627.745473998929, 4641.373414589021, 200421.0, 204495.0, 206506.9674651632, 207325.0, 209682.0, 51308.23037654438, 51408.74295628573, 51937.7403112982, 52022.21966670503, 52038.47961520337, 52627.47372526226, 52742.47257527376, 52843.0, 52987.0, 53007.20489192665, 15357.0, 15500.84499154994, 15521.223938803014, 15548.84451155474, 15721.292541835644, 12628.558000469939, 12652.746945061048, 12654.620361389174, 12668.429920653592, 12697.746045079231, 13425.530106446227, 13497.797533037012, 13501.797473037912, 13601.863981360259, 13709.931450342685, 5426.8914621707345, 5443.265159203457, 5495.670259784426, 5507.339119305709, 5559.694216818033, 1061.5170097605571, 1070.7537266428765, 1079.3416016230094, 1083.2092572422175, 1089.9073578745738, 24346.391340216636, 24571.877140614182, 32620.673793262238, 32767.344653106804, 33158.8342058293, 1150.8273758936227, 1202.6632542888005, 1217.4156404925686, 1234.5000274888685, 1235.407004637779, 13271.270080145685, 13324.824378156512, 13519.66200844967, 13630.250336231404, 13731.656708582166, 277822.0, 281085.0, 281637.0, 281987.0, 282308.0, 56372.43627563754, 57306.426935730946, 57480.71259643675, 57540.42459575351, 57737.0, 1557.672888693387, 1561.2896132259796, 1579.2577488580348, 1602.671452352265, 1614.4026710117332, 24727.38181545476, 30068.69931300659, 30443.54334685026, 30473.390532189675, 31098.53352199764, 57486.7125664369, 57820.421795781505, 57841.4215857836, 58022.12966805586, 58120.0, 233503.0, 236557.0, 236806.0, 236880.0, 236923.0, 36944.63055369519, 37711.05722356963, 38041.809790950865, 38051.42922856215, 38057.0, 45793.0, 46464.0, 47045.76477117593, 48161.0, 48511.0, 34921.301573968885, 35018.29963400667, 35460.64539354573, 35735.82132089323, 35760.10599734923, 35592.28815423625, 36120.4581931266, 36335.27329453449, 36337.63662363343, 36712.26575468529, 41070.38394424146, 41142.58857411507, 41550.37674434826, 41616.58383416127, 42141.0, 34655.13362165966, 34743.65256347505, 34934.30131397409, 35050.474242885866, 35127.82436087803, 24754.381140470912, 25900.0, 25914.481710366064, 26036.479270414864, 26440.471190576467], "value": 17985.256338415646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.3176324883643, 567.9346875109363, 576.5733357315586, 579.9652020878748, 584.4914924016106, 23366.41583960402, 23869.880650596722, 23942.16202432915, 24025.999999999956, 24109.758902410947, 25301.240962771146, 27459.31351716208, 27684.30789230265, 27772.58341124885, 28000.859995699993, 6377.936220637781, 6519.706613202417, 6520.31536688648, 6524.543281970264, 6527.0209468579615, 6193.194884665009, 6366.458850997671, 6467.870642587145, 6478.578892372005, 6486.383793539606, 6384.329645387237, 6420.229572451312, 6426.325235850239, 6433.035044743303, 6434.549581529295, 6378.585391949508, 6423.903641445382, 6425.8393540161405, 6432.0, 6435.259945106326, 5941.465268125889, 5980.551458640576, 5981.371955944606, 5983.072623743326, 5988.19159413478, 29578.408431831456, 30197.245068873235, 30342.84828575865, 30455.086347409615, 31012.37975240505, 2253.6394176931776, 2275.8520696154696, 2283.5432913417217, 2285.9771402285933, 2293.7247530296304, 20121.195152193894, 20513.38459846207, 20734.170633174654, 20742.170313187453, 20769.58460830775, 2421.128393778238, 2491.489244704831, 2541.1106112860534, 2543.300592337104, 2546.6180072989014, 145791.0, 151098.0, 151195.0, 151327.24336378358, 151468.24265878712, 15079.54761357161, 15123.773143402857, 15297.158656274012, 15706.607334816492, 16040.0, 23566.88216558906, 23686.289411317688, 24338.0, 24363.390915226908, 24375.878120609283, 10140.898591013995, 10319.638812641671, 10327.225458090674, 10424.061834434937, 10438.321509101885, 9173.54132293396, 9212.94051184109, 9244.8613270801, 9274.90725092754, 9373.156415922464, 9814.754631134136, 9828.705138845846, 9859.0, 10023.448710321003, 10099.424646715188, 2590.28767089052, 2627.1461774923227, 2639.8812053457254, 2697.5009623219767, 2716.7962402819867, 1029.2743615750878, 1029.3669393323053, 1036.5750042482546, 1048.2190767877828, 1048.4286064095086, 20813.06341214649, 20857.374278771662, 21045.89477052605, 21051.78948210529, 21086.789132108788, 1114.5374669512223, 1119.412308538024, 1122.2705241592867, 1132.92069555132, 1141.1555448967704, 11394.544218231344, 11758.88241117595, 11759.0, 11768.705782355339, 11804.40977951099, 622497.0, 637185.0, 641735.0, 644886.0, 648783.0, 131744.341278293, 131855.0, 132164.0, 134132.0, 136055.23806666918, 1243.1360204657856, 1258.4714419943646, 1277.2974863824859, 1279.315566172112, 1282.39086433945, 19371.128299226286, 19454.319098831475, 22150.77849221487, 22235.555288893807, 22368.328950131523, 67074.0, 68155.65922170358, 69435.0, 69442.65278673574, 72979.63510182415, 87844.0, 88642.55678721823, 90498.64252036093, 90762.54618726864, 90861.54569227112, 21317.147314107264, 21404.357869263946, 21461.570768584228, 22917.88541057284, 23057.538849222587, 25008.0, 25468.363290917874, 25696.743032569437, 25719.971201151744, 25777.226683199533, 18188.81811181924, 18279.634407312045, 18296.0, 19415.8058419414, 20521.794782051988, 17951.820481795537, 18052.27790888402, 18174.45476635703, 18382.448526544224, 18678.906605466887, 19964.30124945678, 20183.0, 20316.0, 20328.89835550813, 20358.185672573523, 20194.0, 20451.466140039855, 20584.176632934516, 20613.690794637794, 20707.8964605176, 19708.0, 19757.802421975597, 19834.20663173457, 19857.404277871687, 20027.799722002594], "value": 12996.58237014208, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.5174266620681, 1504.443355958295, 1518.165009244915, 1533.1567637799214, 1547.5898886794998, 14816.999999999987, 15455.30451129699, 15483.303251353702, 15489.535313940572, 15491.457798977039, 15871.920640396811, 16825.83174168258, 16877.071761053136, 16886.0, 16889.1555422229, 2704.675438947324, 2735.7674597659225, 2738.1648597177855, 2740.4245108527234, 2741.8629068546593, 2600.401907561262, 2637.4197676511135, 2647.3513989072703, 2701.540738074532, 2702.486527559767, 2731.6312297839836, 2736.3022429280604, 2756.3109222694325, 2760.4341110072387, 2760.627315312427, 2643.312738687936, 2671.8263312884797, 2687.704352521221, 2696.1641891013846, 2701.9054333098347, 2679.1560658392546, 2700.3114205877378, 2712.4168303814777, 2719.3473566344132, 2720.415110751198, 15977.520674379788, 16064.678706425922, 16304.347826086941, 16311.755323670155, 16313.102779347131, 8290.751277461686, 8581.871271930926, 8589.570521473965, 8590.441621294658, 8598.957005214996, 5149.845504634867, 5292.259083728281, 5320.042392369372, 5380.704061276629, 5432.293801805779, 1819.0995457248746, 1833.6149408624206, 1849.3527265457117, 1867.3837633580886, 1874.297138573035, 28930.855345723347, 28963.275918102005, 29781.702182978108, 29834.403311933856, 29843.253918652208, 6668.533202675766, 6758.05387245786, 6987.7204911802955, 7025.156981162293, 7207.675654595556, 18488.075596220406, 18488.537786555175, 18503.629927401376, 18509.0, 18525.722114168297, 8259.83480330402, 8339.708110216114, 8345.582720863933, 8346.290565301895, 8350.916490835014, 7483.738069167662, 7602.163761986177, 7641.350485208708, 7674.731384401631, 7730.033745781778, 5231.3199284092825, 5335.839924802262, 5378.650387724785, 5393.568514518829, 5405.108157154025, 1484.139199264424, 1485.843986381436, 1492.723846088477, 1505.811773528309, 1512.2060918017908, 918.5958178401482, 941.3128416256171, 942.8915674697498, 950.3917492804611, 953.4946478366338, 8029.197080291924, 8045.15525869787, 8054.355651547862, 8081.757547273592, 8087.514749115072, 733.5158795195252, 742.4654248940755, 743.6467677853085, 749.1534565940452, 757.2541047068632, 5293.947060529423, 6035.124906888476, 6063.029915213545, 6399.776007839796, 6538.836529086716, 21933.232336868132, 22360.440988975406, 22378.440538986655, 23455.0, 24431.26706198817, 23335.416614584432, 23645.29064128079, 23658.408539786644, 23867.52264954691, 23887.522249554913, 11941.64175074749, 12246.142770006192, 12584.056195785353, 12673.746525069631, 12721.618351449471, 9317.254619630277, 9454.858177127486, 9458.763530911783, 9529.285303602119, 9660.565274562801, 20690.275840345515, 21191.788082118983, 21362.57274854525, 21381.572368552854, 21592.568148637252, 21067.473313167295, 21271.042803074208, 21380.572388552453, 21674.89162554177, 21756.564868702855, 13223.603291901258, 13379.3979270935, 13487.05590608648, 13516.72966540644, 13570.93214533921, 14372.353244103831, 14568.490102846774, 14581.0, 14687.118772873662, 14705.779413309023, 11943.820842687193, 12065.0, 12195.695107622381, 12325.198862073936, 12506.74986500283, 11986.64040078799, 12018.218815776947, 12042.63872083839, 12045.217060891015, 12120.212186207867, 10668.0, 10710.946445267724, 10732.67801965911, 10765.946170269099, 10780.568777248822, 7688.231176882267, 7980.321672657889, 8107.4324797263625, 8396.832063358821, 8399.832003359776, 8253.83492330138, 8283.83432331362, 8370.623321950405, 8459.703910363107, 8527.701530446404], "value": 7028.522320189562, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.77893337464843, 509.1598861877902, 513.3865031287613, 516.720970675835, 521.5280171444841, 6150.938490615093, 6181.505479561635, 6189.13352130701, 6200.534959878016, 6219.160413344197, 6099.390060993909, 6100.633961962285, 6106.419890110433, 6109.5723299369065, 6190.288116866562, 4705.741184234866, 4764.404449443819, 4777.450593181794, 4814.374131362935, 4908.7300198489065, 4812.013537224878, 4821.373221481203, 4834.444038935532, 4842.467328593852, 4867.123917694814, 4769.141554520185, 4795.952040479603, 4799.784009719571, 4802.327674125625, 4828.855134345975, 4792.832250871237, 4797.160496913044, 4802.087603355386, 4811.0, 4811.446683631375, 4362.650987920959, 4376.256036473807, 4383.605475507188, 4388.0034584264085, 4389.517153113155, 5824.854378640525, 5984.431479009487, 6015.639061656315, 6076.696165191723, 6171.814845554595, 5709.400512946164, 5754.625949313281, 5760.135979603051, 5781.71091445426, 5819.505342045931, 6572.441342485894, 6595.10966019586, 6606.537542372036, 6643.6346000969925, 6656.534042617019, 4878.268259761029, 4893.632977526664, 4937.604991600663, 4939.456659767423, 4949.331840201563, 6607.504437167232, 6674.466042716571, 6806.936878404787, 6819.283975182584, 6956.234814170488, 4903.602473295094, 5009.949900500948, 5018.623603229772, 5048.268001139814, 5078.7460626968505, 5066.6453348266, 5077.949220507821, 5135.922961155586, 5139.0, 5162.845114646567, 5653.689047102449, 5654.264945557051, 5720.1991721159075, 5738.626989245686, 5779.075347944308, 6581.506387020992, 6591.242007169237, 6594.307597702268, 6610.752344202994, 6652.434543063797, 1754.3070487157502, 1777.297967302908, 1789.6689112514227, 1789.8926064435916, 1800.8559315254747, 1172.372780562395, 1207.9818802717966, 1225.1607648760448, 1238.4612693478366, 1250.3810613746073, 6264.906026409608, 6293.842653933688, 6387.147727159072, 6444.0989907977255, 6458.54790164684, 6583.03763306514, 6710.664466776641, 6763.864722705518, 6778.0, 6817.352351526597, 6320.841978950563, 6321.683915804191, 6328.46208072319, 6398.712057957403, 6399.680015999182, 3563.1448452371246, 3564.7682900611894, 3577.982110089485, 3595.5146055282726, 3603.0, 7091.468139889529, 7114.0, 7152.606606636581, 7215.783526494109, 7230.408690481582, 6856.057766784119, 6858.177018757781, 6897.275786042494, 6955.860882782417, 7003.369696727319, 7077.433805295564, 7125.180604230476, 7145.499815013107, 7201.747938822116, 7230.891536626955, 6142.723577438936, 6631.104800851823, 6652.168478940132, 6783.660816959231, 6792.252852186157, 6554.115194448688, 6587.957733102753, 6619.801405957829, 6630.370114839083, 6704.899426508704, 6965.616891071039, 7016.2636571738085, 7020.824479388056, 7114.786556403316, 7170.390516805921, 5015.272785446017, 5017.989206476085, 5028.195488721787, 5068.467810879952, 5077.873053173553, 6533.052707357501, 6710.0345744148, 6727.510820996263, 6851.07510486078, 6922.342377474132, 6332.715027823851, 6414.166158399565, 6429.485641148791, 6479.2224933006455, 6627.403533681992, 6447.161868957193, 6468.547201696025, 6484.870302593828, 6526.487302388519, 6599.571027883172, 6508.479321654351, 6544.803655890331, 6552.0, 6592.868142637216, 6618.404343609098, 6489.221293444817, 6533.314002029719, 6612.041254018237, 6616.90074648871, 6669.266380698023, 6391.6804159792755, 6421.64680942534, 6438.227412710505, 6509.381608747161, 6510.837229069121], "value": 5106.120977090251, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [933.8085692433048, 950.5722424908793, 951.7864722478838, 964.5548534465132, 964.956576954037, 17484.125793710326, 18012.729809052875, 18059.097045147722, 18094.457166285018, 21493.892530537327, 20435.897820510876, 20916.26793062243, 21177.047032883518, 21240.362789116352, 21246.57506849862, 1059.7456610413522, 1080.200651517875, 1081.2161183142236, 1083.0956151613411, 1083.6423980086593, 1072.5388083124253, 1073.3935326540518, 1076.1821016027836, 1082.783443311337, 1102.1293178389103, 1123.185690374476, 1126.1159989408316, 1129.9378584130932, 1133.8639363276377, 1137.3687603380122, 1123.2249747674161, 1125.9211855170101, 1134.075728281448, 1139.777743340049, 1150.8906653867912, 826.2233500509502, 833.6165363932598, 835.7033253195088, 838.3335248477475, 841.6927821345226, 18676.0, 18768.436946891616, 18770.34303799374, 18816.717749233772, 19630.312939047064, 21468.355949321547, 21646.24238151657, 21902.89048554763, 22329.0, 22353.217637382615, 17215.913920430445, 17230.913845430692, 17271.3955011574, 17361.305547778073, 17406.56483587908, 3681.9447708284397, 3752.212035472554, 3760.3795373763296, 3775.7734535927934, 3784.0161557994843, 143562.28218858837, 143716.0, 144187.99999999895, 144719.0, 145164.0, 14552.636184095481, 15030.924845375703, 15085.170315632526, 15087.24563771829, 15110.320035598425, 27334.316642084108, 27383.315417114733, 27833.860830695718, 27849.860750696116, 28689.713102868704, 8430.11483794205, 8437.95781021091, 8666.047047947595, 8718.43330183536, 8766.0, 4594.770261486912, 4666.486686464486, 4669.4630117536235, 4676.3686902267755, 4682.297655351656, 5335.5464785492895, 5342.252084708144, 5343.599230057761, 5354.464553544614, 5375.704336261465, 1144.7481554058095, 1162.593092417647, 1166.4867458318313, 1167.643868620079, 1173.6244401791516, 704.3379223529865, 726.7202127181073, 727.9963600182072, 737.6606760889944, 747.768191860525, 12780.0, 13212.405441754952, 13419.0, 14016.369263383172, 14225.14649121056, 731.6963460164079, 742.0097009053522, 751.7631945937012, 753.7135888362387, 754.2005474197368, 5707.6290041147195, 6873.759418420432, 6937.615319403621, 6989.685464154125, 7064.823379415556, 137015.0, 138041.0, 138807.30596347156, 139867.0, 144690.0, 117272.0, 117655.41172294255, 118614.0, 119344.0, 123510.38244808899, 104322.0, 104611.4769426148, 108334.45832770786, 109139.0, 112177.0, 13392.531261406193, 14092.154470731788, 14422.42310307576, 14453.421863125357, 14468.565943021726, 50631.49368506268, 50949.0, 50951.235731464796, 51284.74357628188, 52516.47483525269, 62636.68681656563, 65503.344966549725, 65658.81413455856, 65840.6707966457, 66750.0, 18669.626607468046, 18745.90627046856, 18774.906125469286, 18816.529586759894, 18846.151923163765, 21134.894325528276, 21778.89110554437, 21934.670979934996, 21996.120155193614, 22094.116235350404, 20395.4901127473, 20434.080466378753, 21037.053332599764, 21038.0, 21151.153953841673, 20142.496437589176, 20192.293269735488, 20194.39416817498, 20321.79678203199, 21156.365309040753, 19165.712514312574, 19307.0, 22134.66797997999, 22220.0, 22306.0, 14435.92782036083, 14811.703765924405, 14864.405423782928, 14865.925670371578, 15141.697166056838, 14618.561443156723, 14663.719419398907, 14666.046706964013, 14740.926295368454, 15877.729781617212], "value": 9878.145416279234, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1476.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 107.0, 98.0, 106.0, 108.0, 108.0, 108.0, 99.0, 106.0, 107.0], "value": 104.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 112.0, 144.0, 169.0, 114.0, 139.0, 145.0, 114.0, 166.0, 114.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 161.0, 162.0, 161.0, 164.0, 162.0, 163.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 75.0, 176.0, 74.0, 73.0, 75.0, 73.0, 175.0, 74.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 133.0, 78.0, 82.0, 81.0, 139.0, 80.0, 78.0, 127.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 113.0, 114.0, 118.0, 114.0, 114.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 149.0, 147.0, 148.0, 148.0, 149.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 48.0, 47.0, 49.0, 47.0, 48.0, 47.0, 48.0, 51.0], "value": 48.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 56.0, 54.0, 56.0, 55.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 76.0, 75.0, 81.0, 73.0, 73.0, 72.0, 75.0, 75.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 130.0, 115.0, 116.0, 116.0, 125.0, 118.0, 120.0, 121.0, 164.0], "value": 124.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 174.0, 162.0, 161.0, 164.0, 161.0, 161.0, 165.0, 156.0], "value": 163.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 61.0, 63.0, 60.0, 60.0, 62.0, 60.0, 60.0, 60.0], "value": 61.1, "unit": "score"}]}]} 13:33:04 INFO - Return code: 0 13:33:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:33:04 INFO - # TBPL SUCCESS # 13:33:04 INFO - Running post-action listener: _package_coverage_data 13:33:04 INFO - Running post-action listener: _resource_record_post_action 13:33:04 INFO - [mozharness: 2017-08-15 20:33:04.427775Z] Finished run-tests step (success) 13:33:04 INFO - Running post-run listener: _resource_record_post_run 13:33:04 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 45056; Write bytes: 439930880; Read time: 56; Write time: 349964 13:33:04 INFO - TinderboxPrint: CPU usage
13.0% 13:33:04 INFO - TinderboxPrint: I/O read bytes / time
45,056 / 56 13:33:04 INFO - TinderboxPrint: I/O write bytes / time
439,930,880 / 349,964 13:33:04 INFO - TinderboxPrint: CPU idle
8,230.4 (86.9%) 13:33:04 INFO - TinderboxPrint: CPU user
1,187.7 (12.5%) 13:33:04 INFO - TinderboxPrint: Swap in / out
0 / 0 13:33:04 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118198272; Read time: 0; Write time: 113956 13:33:04 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:33:04 INFO - run-tests - Wall time: 1169s; CPU: 13.0%; Read bytes: 45056; Write bytes: 320221184; Read time: 56; Write time: 235972 13:33:05 INFO - Running post-run listener: _upload_blobber_files 13:33:05 INFO - Blob upload gear active. 13:33:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:33:05 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 13:33:05 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'] 13:33:05 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 13:33:05 INFO - (blobuploader) - INFO - Open directory for files ... 13:33:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:33:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:33:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:06 INFO - (blobuploader) - INFO - Done attempting. 13:33:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:33:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:33:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:07 INFO - (blobuploader) - INFO - Done attempting. 13:33:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:33:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:33:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:13 INFO - (blobuploader) - INFO - Done attempting. 13:33:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:33:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:33:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:33:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:33:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:33:14 INFO - (blobuploader) - INFO - Done attempting. 13:33:14 INFO - (blobuploader) - INFO - Iteration through files over. 13:33:14 INFO - Return code: 0 13:33:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:33:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:33:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c81bc1a2ff01597b3f19959d8fc7760ef6b4227a611862e9bfb97298ecac6e62fb5b289ca661280c94b0c9b6927f2843e67e579cc13bfd257182a262a3a23cf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98811dad520d3ea693e9ca9e9136e88168f8c69fb75fa7ba38a8ac786b89b8277c95b99e2b70a075bd91968672ad40ac64877bd1d2b1ffb80e51f177c56af3df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43f4ddaa883e351bc69ed81ab6af39b40297a6311bf075da0d624f6b369ce781437f8c7d4ec4e49159c9ec5e0e66ab695dd998f4c1001b4318b5b744819abf64", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3167f887039e115806c1215f0538b0069ae543386d9725d06afaea4151a38c772a061d410e99fea2da4713d7abb5057fd4571c72d3b989d7f212f1490b79c409"} 13:33:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:33:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:33:14 INFO - Contents: 13:33:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c81bc1a2ff01597b3f19959d8fc7760ef6b4227a611862e9bfb97298ecac6e62fb5b289ca661280c94b0c9b6927f2843e67e579cc13bfd257182a262a3a23cf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98811dad520d3ea693e9ca9e9136e88168f8c69fb75fa7ba38a8ac786b89b8277c95b99e2b70a075bd91968672ad40ac64877bd1d2b1ffb80e51f177c56af3df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43f4ddaa883e351bc69ed81ab6af39b40297a6311bf075da0d624f6b369ce781437f8c7d4ec4e49159c9ec5e0e66ab695dd998f4c1001b4318b5b744819abf64", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3167f887039e115806c1215f0538b0069ae543386d9725d06afaea4151a38c772a061d410e99fea2da4713d7abb5057fd4571c72d3b989d7f212f1490b79c409"} 13:33:14 INFO - Running post-run listener: copy_logs_to_upload_dir 13:33:14 INFO - Copying logs to upload dir... 13:33:14 INFO - mkdir: /builds/slave/test/build/upload/logs 13:33:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.306470 ========= master_lag: -0.09 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-08-15 13:33:14.845068) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 13:33:14.853021) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c81bc1a2ff01597b3f19959d8fc7760ef6b4227a611862e9bfb97298ecac6e62fb5b289ca661280c94b0c9b6927f2843e67e579cc13bfd257182a262a3a23cf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98811dad520d3ea693e9ca9e9136e88168f8c69fb75fa7ba38a8ac786b89b8277c95b99e2b70a075bd91968672ad40ac64877bd1d2b1ffb80e51f177c56af3df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43f4ddaa883e351bc69ed81ab6af39b40297a6311bf075da0d624f6b369ce781437f8c7d4ec4e49159c9ec5e0e66ab695dd998f4c1001b4318b5b744819abf64", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3167f887039e115806c1215f0538b0069ae543386d9725d06afaea4151a38c772a061d410e99fea2da4713d7abb5057fd4571c72d3b989d7f212f1490b79c409"} build_url:https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011268 build_url: 'https://queue.taskcluster.net/v1/task/fP_R9t15TcqIdTPlnrOVJA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c81bc1a2ff01597b3f19959d8fc7760ef6b4227a611862e9bfb97298ecac6e62fb5b289ca661280c94b0c9b6927f2843e67e579cc13bfd257182a262a3a23cf1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/98811dad520d3ea693e9ca9e9136e88168f8c69fb75fa7ba38a8ac786b89b8277c95b99e2b70a075bd91968672ad40ac64877bd1d2b1ffb80e51f177c56af3df", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43f4ddaa883e351bc69ed81ab6af39b40297a6311bf075da0d624f6b369ce781437f8c7d4ec4e49159c9ec5e0e66ab695dd998f4c1001b4318b5b744819abf64", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3167f887039e115806c1215f0538b0069ae543386d9725d06afaea4151a38c772a061d410e99fea2da4713d7abb5057fd4571c72d3b989d7f212f1490b79c409"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 13:33:14.879019) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 13:33:14.879311) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1502827942.506023-2017402402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 13:33:14.963240) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 13:33:14.963536) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 13:33:14.966813) ========= ========= Total master_lag: 0.74 =========