builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-084 starttime: 1501151300.39 results: success (0) revision: c1ed71da57073d0f5fdbd279c9ad6037f9ae2d06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:20.390411) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:20.390810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:20.391112) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:20.415160) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:20.415420) ========= 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=ea65d483da93c827905c2090000001f5-1501151083.670985-891645176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-27 03:28:20-- 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% 98.8M=0s 2017-07-27 03:28:20 (98.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122094 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:20.550935) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:20.551218) ========= 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=ea65d483da93c827905c2090000001f5-1501151083.670985-891645176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018729 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:20.602638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:20.602948) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c1ed71da57073d0f5fdbd279c9ad6037f9ae2d06 --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 c1ed71da57073d0f5fdbd279c9ad6037f9ae2d06 --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=ea65d483da93c827905c2090000001f5-1501151083.670985-891645176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-27 03:28:20,910 truncating revision to first 12 chars 2017-07-27 03:28:20,910 Setting DEBUG logging. 2017-07-27 03:28:20,910 attempt 1/10 2017-07-27 03:28:20,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c1ed71da5707?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-27 03:28:21,394 unpacking tar archive at: mozilla-central-c1ed71da5707/testing/mozharness/ program finished with exit code 0 elapsedTime=0.798101 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:21.413202) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:21.413479) ========= script_repo_revision: c1ed71da57073d0f5fdbd279c9ad6037f9ae2d06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:21.413849) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:21.414149) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 03:28:21.426938) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-27 03:28:21.427199) ========= /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=ea65d483da93c827905c2090000001f5-1501151083.670985-891645176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:21 INFO - MultiFileLogger online at 20170727 03:28:21 in /builds/slave/test 03:28:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:28:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:21 INFO - {'append_to_log': False, 03:28:21 INFO - 'base_work_dir': '/builds/slave/test', 03:28:21 INFO - 'blob_upload_branch': 'Firefox', 03:28:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:21 INFO - 'branch': 'Firefox', 03:28:21 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:21 INFO - 'code_coverage': False, 03:28:21 INFO - 'config_files': ('talos/linux_config.py',), 03:28:21 INFO - 'default_actions': ('clobber', 03:28:21 INFO - 'read-buildbot-config', 03:28:21 INFO - 'download-and-extract', 03:28:21 INFO - 'populate-webroot', 03:28:21 INFO - 'create-virtualenv', 03:28:21 INFO - 'install', 03:28:21 INFO - 'setup-mitmproxy', 03:28:21 INFO - 'run-tests'), 03:28:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:21 INFO - 'disable_ccov_upload': False, 03:28:21 INFO - 'download_minidump_stackwalk': True, 03:28:21 INFO - 'download_symbols': 'ondemand', 03:28:21 INFO - 'enable_stylo': False, 03:28:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:21 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:21 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:21 INFO - 'gecko_profile': False, 03:28:21 INFO - 'gecko_profile_interval': 0, 03:28:21 INFO - 'installer_path': 'installer.exe', 03:28:21 INFO - 'log_level': 'info', 03:28:21 INFO - 'log_name': 'talos', 03:28:21 INFO - 'log_to_console': True, 03:28:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:21 INFO - 'opt_config_files': (), 03:28:21 INFO - 'pip_index': False, 03:28:21 INFO - 'suite': 'dromaeojs-e10s', 03:28:21 INFO - 'system_bits': '32', 03:28:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:21 INFO - 'title': 'talos-linux64-ix-084', 03:28:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:21 INFO - 'use_talos_json': True, 03:28:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:21 INFO - 'work_dir': 'build'} 03:28:21 INFO - [mozharness: 2017-07-27 10:28:21.846823Z] Running clobber step. 03:28:21 INFO - Running pre-action listener: _resource_record_pre_action 03:28:21 INFO - Running main action method: clobber 03:28:21 INFO - rmtree: /builds/slave/test/build 03:28:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:23 INFO - Running post-action listener: _resource_record_post_action 03:28:23 INFO - [mozharness: 2017-07-27 10:28:23.392902Z] Finished clobber step (success) 03:28:23 INFO - [mozharness: 2017-07-27 10:28:23.393003Z] Running read-buildbot-config step. 03:28:23 INFO - Running pre-action listener: _resource_record_pre_action 03:28:23 INFO - Running main action method: read_buildbot_config 03:28:23 INFO - Using buildbot properties: 03:28:23 INFO - { 03:28:23 INFO - "project": "", 03:28:23 INFO - "product": "firefox", 03:28:23 INFO - "who": "cbook@mozilla.com", 03:28:23 INFO - "installer_path": "public/build/target.tar.bz2", 03:28:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:28:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:28:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:28:23 INFO - "stage_platform": "linux64-pgo", 03:28:23 INFO - "basedir": "/builds/slave/test", 03:28:23 INFO - "buildnumber": 95, 03:28:23 INFO - "platform": "ubuntu64_hw", 03:28:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:28:23 INFO - "slavebuilddir": "test", 03:28:23 INFO - "taskId": "TBJjVwtWQYuf1viSoyjztg", 03:28:23 INFO - "branch": "mozilla-central", 03:28:23 INFO - "script_repo_revision": "production", 03:28:23 INFO - "revision": "c1ed71da57073d0f5fdbd279c9ad6037f9ae2d06", 03:28:23 INFO - "slavename": "talos-linux64-ix-084", 03:28:23 INFO - "repo_path": "mozilla-central" 03:28:23 INFO - } 03:28:23 INFO - Finding installer, test and symbols from parent task. 03:28:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TBJjVwtWQYuf1viSoyjztg'}, attempt #1 03:28:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TBJjVwtWQYuf1viSoyjztg'}, attempt #1 03:28:24 INFO - Task dependencies: Zk7GsjBISvCpcBODtgZIjg 03:28:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg'}, attempt #1 03:28:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.tar.bz2 03:28:24 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/test_packages.json 03:28:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.crashreporter-symbols.zip 03:28:24 INFO - Running post-action listener: _resource_record_post_action 03:28:24 INFO - [mozharness: 2017-07-27 10:28:24.773057Z] Finished read-buildbot-config step (success) 03:28:24 INFO - [mozharness: 2017-07-27 10:28:24.773277Z] Running download-and-extract step. 03:28:24 INFO - Running pre-action listener: _resource_record_pre_action 03:28:24 INFO - Running main action method: download_and_extract 03:28:24 INFO - mkdir: /builds/slave/test/build/tests 03:28:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:24 INFO - trying https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.test_packages.json 03:28:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:28:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:28:25 INFO - Downloaded 989 bytes. 03:28:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:28:25 INFO - Using the following test package requirements: 03:28:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:28:25 INFO - u'common': [u'target.common.tests.zip'], 03:28:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:28:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:28:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:28:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:28:25 INFO - u'mozbase': [u'target.common.tests.zip'], 03:28:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:28:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:28:25 INFO - u'web-platform': [u'target.common.tests.zip', 03:28:25 INFO - u'target.web-platform.tests.tar.gz'], 03:28:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:28:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:28:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.common.tests.zip 03:28:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:28:25 INFO - Fetch https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.common.tests.zip into memory 03:28:27 INFO - Content-Length response header: 73175221 03:28:27 INFO - Bytes received: 73175221 03:28:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:28:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.common.tests.zip 03:28:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:28:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.common.tests.zip into memory 03:28:39 INFO - Content-Length response header: 73175221 03:28:39 INFO - Bytes received: 73175221 03:28:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.talos.tests.zip 03:28:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:28:51 INFO - Fetch https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.talos.tests.zip into memory 03:28:52 INFO - Content-Length response header: 14496465 03:28:52 INFO - Bytes received: 14496465 03:28:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:52 INFO - trying https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.tar.bz2 03:28:52 INFO - Downloading https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:28:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:28:54 INFO - Downloaded 63024226 bytes. 03:28:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.tar.bz2 03:28:54 INFO - mkdir: /builds/slave/test/properties 03:28:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:28:54 INFO - Writing to file /builds/slave/test/properties/build_url 03:28:54 INFO - Contents: 03:28:54 INFO - build_url:https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.tar.bz2 03:28:54 INFO - Running post-action listener: _resource_record_post_action 03:28:54 INFO - Running post-action listener: set_extra_try_arguments 03:28:54 INFO - [mozharness: 2017-07-27 10:28:54.361499Z] Finished download-and-extract step (success) 03:28:54 INFO - [mozharness: 2017-07-27 10:28:54.361631Z] Running populate-webroot step. 03:28:54 INFO - Running pre-action listener: _resource_record_pre_action 03:28:54 INFO - Running main action method: populate_webroot 03:28:54 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:28:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:28:54 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:28:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:28:54 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:28:54 INFO - 'tests': ['damp', 'tps']}, 03:28:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:28:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:28:54 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:28:54 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:28:54 INFO - 'other-e10s': {'tests': ['a11yr', 03:28:54 INFO - 'ts_paint', 03:28:54 INFO - 'tpaint', 03:28:54 INFO - 'sessionrestore', 03:28:54 INFO - 'sessionrestore_many_windows', 03:28:54 INFO - 'sessionrestore_no_auto_restore', 03:28:54 INFO - 'tabpaint']}, 03:28:54 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:28:54 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:28:54 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:28:54 INFO - 'talos_options': ['--mitmproxy', 03:28:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:28:54 INFO - '--firstNonBlankPaint'], 03:28:54 INFO - 'tests': ['quantum_pageload_google', 03:28:54 INFO - 'quantum_pageload_youtube', 03:28:54 INFO - 'quantum_pageload_amazon', 03:28:54 INFO - 'quantum_pageload_facebook']}, 03:28:54 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:28:54 INFO - 'talos_options': ['--stylo', 03:28:54 INFO - '--mitmproxy', 03:28:54 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:28:54 INFO - '--firstNonBlankPaint'], 03:28:54 INFO - 'tests': ['quantum_pageload_google', 03:28:54 INFO - 'quantum_pageload_youtube', 03:28:54 INFO - 'quantum_pageload_amazon', 03:28:54 INFO - 'quantum_pageload_facebook']}, 03:28:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:28:54 INFO - 'tsvgr_opacity', 03:28:54 INFO - 'tart', 03:28:54 INFO - 'tscrollx', 03:28:54 INFO - 'cart', 03:28:54 INFO - 'tsvg_static']}, 03:28:54 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:28:54 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:28:54 INFO - 'talos_options': ['--xperf_path', 03:28:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:28:54 INFO - 'tests': ['tp5n']}}} 03:28:54 INFO - Running post-action listener: _resource_record_post_action 03:28:54 INFO - [mozharness: 2017-07-27 10:28:54.370646Z] Finished populate-webroot step (success) 03:28:54 INFO - [mozharness: 2017-07-27 10:28:54.370755Z] Running create-virtualenv step. 03:28:54 INFO - Running pre-action listener: _resource_record_pre_action 03:28:54 INFO - Running main action method: create_virtualenv 03:28:54 INFO - Creating virtualenv /builds/slave/test/build/venv 03:28:54 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:28:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:28:54 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:28:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:28:54 INFO - Using real prefix '/usr' 03:28:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:28:54 INFO - Installing distribute.............................................................................................................................................................................................done. 03:28:56 INFO - Installing pip.................done. 03:28:56 INFO - Return code: 0 03:28:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:28:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:28:57 INFO - Reading from file tmpfile_stdout 03:28:57 INFO - Output received: 03:28:57 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:28:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5eb0>, '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 0x16a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7240>, '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': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:28:57 INFO - Using env: {'DISPLAY': ':0', 03:28:57 INFO - 'HOME': '/home/cltbld', 03:28:57 INFO - 'LANG': 'en_US.UTF-8', 03:28:57 INFO - 'LANGUAGE': 'en_US:en', 03:28:57 INFO - 'LOGNAME': 'cltbld', 03:28:57 INFO - 'MAIL': '/var/mail/cltbld', 03:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:57 INFO - 'MOZ_NO_REMOTE': '1', 03:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:57 INFO - 'NO_EM_RESTART': '1', 03:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:57 INFO - 'PWD': '/builds/slave/test', 03:28:57 INFO - 'SHELL': '/bin/bash', 03:28:57 INFO - 'SHLVL': '1', 03:28:57 INFO - 'TERM': 'linux', 03:28:57 INFO - 'TMOUT': '86400', 03:28:57 INFO - 'USER': 'cltbld', 03:28:57 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 03:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:57 INFO - '_': '/tools/buildbot/bin/python'} 03:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:28:57 INFO - Cleaning up... 03:28:57 INFO - Return code: 0 03:28:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5eb0>, '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 0x16a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7240>, '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': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:28:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:28:57 INFO - Using env: {'DISPLAY': ':0', 03:28:57 INFO - 'HOME': '/home/cltbld', 03:28:57 INFO - 'LANG': 'en_US.UTF-8', 03:28:57 INFO - 'LANGUAGE': 'en_US:en', 03:28:57 INFO - 'LOGNAME': 'cltbld', 03:28:57 INFO - 'MAIL': '/var/mail/cltbld', 03:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:57 INFO - 'MOZ_NO_REMOTE': '1', 03:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:57 INFO - 'NO_EM_RESTART': '1', 03:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:57 INFO - 'PWD': '/builds/slave/test', 03:28:57 INFO - 'SHELL': '/bin/bash', 03:28:57 INFO - 'SHLVL': '1', 03:28:57 INFO - 'TERM': 'linux', 03:28:57 INFO - 'TMOUT': '86400', 03:28:57 INFO - 'USER': 'cltbld', 03:28:57 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 03:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:57 INFO - '_': '/tools/buildbot/bin/python'} 03:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:57 INFO - Downloading/unpacking psutil>=3.1.1 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:28:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:58 INFO - Installing collected packages: psutil 03:28:58 INFO - Running setup.py install for psutil 03:28:58 INFO - building 'psutil._psutil_linux' extension 03:28:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:28:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:28:59 INFO - building 'psutil._psutil_posix' extension 03:28:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:28:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:28:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:28:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:28:59 INFO - Successfully installed psutil 03:28:59 INFO - Cleaning up... 03:28:59 INFO - Return code: 0 03:28:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:28:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:28:59 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 0x13391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5eb0>, '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 0x16a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7240>, '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': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:28:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:28:59 INFO - Using env: {'DISPLAY': ':0', 03:28:59 INFO - 'HOME': '/home/cltbld', 03:28:59 INFO - 'LANG': 'en_US.UTF-8', 03:28:59 INFO - 'LANGUAGE': 'en_US:en', 03:28:59 INFO - 'LOGNAME': 'cltbld', 03:28:59 INFO - 'MAIL': '/var/mail/cltbld', 03:28:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:59 INFO - 'MOZ_NO_REMOTE': '1', 03:28:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:59 INFO - 'NO_EM_RESTART': '1', 03:28:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:59 INFO - 'PWD': '/builds/slave/test', 03:28:59 INFO - 'SHELL': '/bin/bash', 03:28:59 INFO - 'SHLVL': '1', 03:28:59 INFO - 'TERM': 'linux', 03:28:59 INFO - 'TMOUT': '86400', 03:28:59 INFO - 'USER': 'cltbld', 03:28:59 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 03:28:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:59 INFO - '_': '/tools/buildbot/bin/python'} 03:28:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:28:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:29:00 INFO - Installing collected packages: mozsystemmonitor 03:29:00 INFO - Running setup.py install for mozsystemmonitor 03:29:00 INFO - Successfully installed mozsystemmonitor 03:29:00 INFO - Cleaning up... 03:29:00 INFO - Return code: 0 03:29:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29: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', '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 0x13391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5eb0>, '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 0x16a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7240>, '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': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:29: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 jsonschema==2.5.1 03:29:00 INFO - Using env: {'DISPLAY': ':0', 03:29:00 INFO - 'HOME': '/home/cltbld', 03:29:00 INFO - 'LANG': 'en_US.UTF-8', 03:29:00 INFO - 'LANGUAGE': 'en_US:en', 03:29:00 INFO - 'LOGNAME': 'cltbld', 03:29:00 INFO - 'MAIL': '/var/mail/cltbld', 03:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:00 INFO - 'MOZ_NO_REMOTE': '1', 03:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:00 INFO - 'NO_EM_RESTART': '1', 03:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:00 INFO - 'PWD': '/builds/slave/test', 03:29:00 INFO - 'SHELL': '/bin/bash', 03:29:00 INFO - 'SHLVL': '1', 03:29:00 INFO - 'TERM': 'linux', 03:29:00 INFO - 'TMOUT': '86400', 03:29:00 INFO - 'USER': 'cltbld', 03:29:00 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 03:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:00 INFO - '_': '/tools/buildbot/bin/python'} 03:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:01 INFO - Downloading/unpacking jsonschema==2.5.1 03:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:29:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:29: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 03:29: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 03:29: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 03:29: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 03:29:02 INFO - Downloading functools32-3.2.3-2.tar.gz 03:29:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:29:02 INFO - warning: no files found matching '*.txt' 03:29:02 INFO - no previously-included directories found matching 'build' 03:29:02 INFO - no previously-included directories found matching 'dist' 03:29:02 INFO - no previously-included directories found matching '.git*' 03:29:02 INFO - Installing collected packages: jsonschema, functools32 03:29:02 INFO - Running setup.py install for functools32 03:29:02 INFO - warning: no files found matching '*.txt' 03:29:02 INFO - no previously-included directories found matching 'build' 03:29:02 INFO - no previously-included directories found matching 'dist' 03:29:02 INFO - no previously-included directories found matching '.git*' 03:29:02 INFO - Successfully installed jsonschema functools32 03:29:02 INFO - Cleaning up... 03:29:02 INFO - Return code: 0 03:29:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5eb0>, '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 0x16a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7240>, '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': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:29:02 INFO - Using env: {'DISPLAY': ':0', 03:29:02 INFO - 'HOME': '/home/cltbld', 03:29:02 INFO - 'LANG': 'en_US.UTF-8', 03:29:02 INFO - 'LANGUAGE': 'en_US:en', 03:29:02 INFO - 'LOGNAME': 'cltbld', 03:29:02 INFO - 'MAIL': '/var/mail/cltbld', 03:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:02 INFO - 'MOZ_NO_REMOTE': '1', 03:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:02 INFO - 'NO_EM_RESTART': '1', 03:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:02 INFO - 'PWD': '/builds/slave/test', 03:29:02 INFO - 'SHELL': '/bin/bash', 03:29:02 INFO - 'SHLVL': '1', 03:29:02 INFO - 'TERM': 'linux', 03:29:02 INFO - 'TMOUT': '86400', 03:29:02 INFO - 'USER': 'cltbld', 03:29:02 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 03:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:02 INFO - '_': '/tools/buildbot/bin/python'} 03:29:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:29:02 INFO - Cleaning up... 03:29:02 INFO - Return code: 0 03:29:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5eb0>, '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 0x16a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7240>, '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': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:29:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:29:02 INFO - Using env: {'DISPLAY': ':0', 03:29:02 INFO - 'HOME': '/home/cltbld', 03:29:02 INFO - 'LANG': 'en_US.UTF-8', 03:29:02 INFO - 'LANGUAGE': 'en_US:en', 03:29:02 INFO - 'LOGNAME': 'cltbld', 03:29:02 INFO - 'MAIL': '/var/mail/cltbld', 03:29:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:02 INFO - 'MOZ_NO_REMOTE': '1', 03:29:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:02 INFO - 'NO_EM_RESTART': '1', 03:29:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:02 INFO - 'PWD': '/builds/slave/test', 03:29:02 INFO - 'SHELL': '/bin/bash', 03:29:02 INFO - 'SHLVL': '1', 03:29:02 INFO - 'TERM': 'linux', 03:29:02 INFO - 'TMOUT': '86400', 03:29:02 INFO - 'USER': 'cltbld', 03:29:02 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 03:29:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:02 INFO - '_': '/tools/buildbot/bin/python'} 03:29:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:03 INFO - Downloading/unpacking blobuploader==1.2.4 03:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:04 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29: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 03:29: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 03:29: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 03:29: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 03:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:29:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29: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 03:29: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 03:29: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 03:29: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 03:29:04 INFO - Downloading docopt-0.6.1.tar.gz 03:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:04 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:04 INFO - Running setup.py install for blobuploader 03:29:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:29:04 INFO - Running setup.py install for requests 03:29:05 INFO - Running setup.py install for docopt 03:29:05 INFO - Successfully installed blobuploader requests docopt 03:29:05 INFO - Cleaning up... 03:29:05 INFO - Return code: 0 03:29:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5eb0>, '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 0x16a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7240>, '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': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:05 INFO - Using env: {'DISPLAY': ':0', 03:29:05 INFO - 'HOME': '/home/cltbld', 03:29:05 INFO - 'LANG': 'en_US.UTF-8', 03:29:05 INFO - 'LANGUAGE': 'en_US:en', 03:29:05 INFO - 'LOGNAME': 'cltbld', 03:29:05 INFO - 'MAIL': '/var/mail/cltbld', 03:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:05 INFO - 'MOZ_NO_REMOTE': '1', 03:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:05 INFO - 'NO_EM_RESTART': '1', 03:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:05 INFO - 'PWD': '/builds/slave/test', 03:29:05 INFO - 'SHELL': '/bin/bash', 03:29:05 INFO - 'SHLVL': '1', 03:29:05 INFO - 'TERM': 'linux', 03:29:05 INFO - 'TMOUT': '86400', 03:29:05 INFO - 'USER': 'cltbld', 03:29:05 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 03:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:05 INFO - '_': '/tools/buildbot/bin/python'} 03:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:05 INFO - Running setup.py (path:/tmp/pip-Uj1tZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:05 INFO - Running setup.py (path:/tmp/pip-ArYSIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:05 INFO - Running setup.py (path:/tmp/pip-Ca4knT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:05 INFO - Running setup.py (path:/tmp/pip-RhDNz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:05 INFO - Running setup.py (path:/tmp/pip-6HMLKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:05 INFO - Running setup.py (path:/tmp/pip-KbB3Cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:05 INFO - Running setup.py (path:/tmp/pip-8yFH03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:06 INFO - Running setup.py (path:/tmp/pip-ApD_Sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:06 INFO - Running setup.py (path:/tmp/pip-7IBnJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:06 INFO - Running setup.py (path:/tmp/pip-v1JIvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:06 INFO - Running setup.py (path:/tmp/pip-9NLgtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:06 INFO - Running setup.py (path:/tmp/pip-Hx_XR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:06 INFO - Running setup.py (path:/tmp/pip-jDJVbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:06 INFO - Running setup.py (path:/tmp/pip-GppWpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:06 INFO - Running setup.py (path:/tmp/pip-gURGiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:06 INFO - Running setup.py (path:/tmp/pip-dt_5sA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:06 INFO - Running setup.py (path:/tmp/pip-OxoOfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:29:06 INFO - Running setup.py install for manifestparser 03:29:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:29:06 INFO - Running setup.py install for mozcrash 03:29:06 INFO - Running setup.py install for mozdebug 03:29:07 INFO - Running setup.py install for mozdevice 03:29:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:29:07 INFO - Running setup.py install for mozfile 03:29:07 INFO - Running setup.py install for mozhttpd 03:29:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:29:07 INFO - Running setup.py install for mozinfo 03:29:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:29:07 INFO - Running setup.py install for mozInstall 03:29:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:29:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:29:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:29:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:29:07 INFO - Running setup.py install for mozleak 03:29:07 INFO - Running setup.py install for mozlog 03:29:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:29:07 INFO - Running setup.py install for moznetwork 03:29:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:29:07 INFO - Running setup.py install for mozprocess 03:29:07 INFO - Running setup.py install for mozprofile 03:29:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:29:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:29:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:29:08 INFO - Running setup.py install for mozrunner 03:29:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:29:08 INFO - Running setup.py install for mozscreenshot 03:29:08 INFO - Running setup.py install for moztest 03:29:08 INFO - Running setup.py install for mozversion 03:29:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:29:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:29:08 INFO - Cleaning up... 03:29:08 INFO - Return code: 0 03:29:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5eb0>, '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 0x16a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7240>, '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': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:08 INFO - Using env: {'DISPLAY': ':0', 03:29:08 INFO - 'HOME': '/home/cltbld', 03:29:08 INFO - 'LANG': 'en_US.UTF-8', 03:29:08 INFO - 'LANGUAGE': 'en_US:en', 03:29:08 INFO - 'LOGNAME': 'cltbld', 03:29:08 INFO - 'MAIL': '/var/mail/cltbld', 03:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:08 INFO - 'MOZ_NO_REMOTE': '1', 03:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:08 INFO - 'NO_EM_RESTART': '1', 03:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:08 INFO - 'PWD': '/builds/slave/test', 03:29:08 INFO - 'SHELL': '/bin/bash', 03:29:08 INFO - 'SHLVL': '1', 03:29:08 INFO - 'TERM': 'linux', 03:29:08 INFO - 'TMOUT': '86400', 03:29:08 INFO - 'USER': 'cltbld', 03:29:08 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 03:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:08 INFO - '_': '/tools/buildbot/bin/python'} 03:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:08 INFO - Running setup.py (path:/tmp/pip-NSvDZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:08 INFO - Running setup.py (path:/tmp/pip-8ZikQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:08 INFO - Running setup.py (path:/tmp/pip-n_AU3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:08 INFO - Running setup.py (path:/tmp/pip-GPEIdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:09 INFO - Running setup.py (path:/tmp/pip-tJ9xPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:09 INFO - Running setup.py (path:/tmp/pip-YErAPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:09 INFO - Running setup.py (path:/tmp/pip-PkwQxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:09 INFO - Running setup.py (path:/tmp/pip-VbwQw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:09 INFO - Running setup.py (path:/tmp/pip-zsjK0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:09 INFO - Running setup.py (path:/tmp/pip-ijWOPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:09 INFO - Running setup.py (path:/tmp/pip-l4Ckvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:09 INFO - Running setup.py (path:/tmp/pip-pqNGKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:09 INFO - Running setup.py (path:/tmp/pip-dbDUJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:09 INFO - Running setup.py (path:/tmp/pip-v5Wt3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:09 INFO - Running setup.py (path:/tmp/pip-AQvldb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:09 INFO - Running setup.py (path:/tmp/pip-dD7vjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:29:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:09 INFO - Running setup.py (path:/tmp/pip-MM2fKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:29:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:11 INFO - Downloading blessings-1.6.tar.gz 03:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:29:11 INFO - Installing collected packages: blessings 03:29:11 INFO - Running setup.py install for blessings 03:29:11 INFO - Successfully installed blessings 03:29:11 INFO - Cleaning up... 03:29:11 INFO - Return code: 0 03:29:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:29:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:11 INFO - Reading from file tmpfile_stdout 03:29:11 INFO - Current package versions: 03:29:11 INFO - argparse == 1.2.1 03:29:11 INFO - blessings == 1.6 03:29:11 INFO - blobuploader == 1.2.4 03:29:11 INFO - docopt == 0.6.1 03:29:11 INFO - functools32 == 3.2.3-2 03:29:11 INFO - jsonschema == 2.5.1 03:29:11 INFO - manifestparser == 1.1 03:29:11 INFO - mozInstall == 1.13 03:29:11 INFO - mozcrash == 1.0 03:29:11 INFO - mozdebug == 0.1 03:29:11 INFO - mozdevice == 0.51 03:29:11 INFO - mozfile == 1.2 03:29:11 INFO - mozhttpd == 0.7 03:29:11 INFO - mozinfo == 0.10 03:29:11 INFO - mozleak == 0.1 03:29:11 INFO - mozlog == 3.5 03:29:11 INFO - moznetwork == 0.27 03:29:11 INFO - mozprocess == 0.25 03:29:11 INFO - mozprofile == 0.28 03:29:11 INFO - mozrunner == 6.13 03:29:11 INFO - mozscreenshot == 0.1 03:29:11 INFO - mozsystemmonitor == 0.3 03:29:11 INFO - moztest == 0.8 03:29:11 INFO - mozversion == 1.4 03:29:11 INFO - psutil == 3.1.1 03:29:11 INFO - requests == 1.2.3 03:29:11 INFO - wsgiref == 0.1.2 03:29:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5eb0>, '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 0x16a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7240>, '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': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:11 INFO - Using env: {'DISPLAY': ':0', 03:29:11 INFO - 'HOME': '/home/cltbld', 03:29:11 INFO - 'LANG': 'en_US.UTF-8', 03:29:11 INFO - 'LANGUAGE': 'en_US:en', 03:29:11 INFO - 'LOGNAME': 'cltbld', 03:29:11 INFO - 'MAIL': '/var/mail/cltbld', 03:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:11 INFO - 'MOZ_NO_REMOTE': '1', 03:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:11 INFO - 'NO_EM_RESTART': '1', 03:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:11 INFO - 'PWD': '/builds/slave/test', 03:29:11 INFO - 'SHELL': '/bin/bash', 03:29:11 INFO - 'SHLVL': '1', 03:29:11 INFO - 'TERM': 'linux', 03:29:11 INFO - 'TMOUT': '86400', 03:29:11 INFO - 'USER': 'cltbld', 03:29:11 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 03:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:11 INFO - '_': '/tools/buildbot/bin/python'} 03:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:29:11 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:12 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:29:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:29:12 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:29:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:29:13 INFO - Installing collected packages: marionette-driver, simplejson 03:29:13 INFO - Running setup.py install for marionette-driver 03:29:13 INFO - Running setup.py install for simplejson 03:29:13 INFO - building 'simplejson._speedups' extension 03:29:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:29:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:29:14 INFO - Successfully installed marionette-driver simplejson 03:29:14 INFO - Cleaning up... 03:29:14 INFO - Return code: 0 03:29:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:29: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')]} 03:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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')]} 03:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:14 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 0x13391f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1505a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a8d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16a5eb0>, '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 0x16a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7240>, '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': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:29:14 INFO - Using env: {'DISPLAY': ':0', 03:29:14 INFO - 'HOME': '/home/cltbld', 03:29:14 INFO - 'LANG': 'en_US.UTF-8', 03:29:14 INFO - 'LANGUAGE': 'en_US:en', 03:29:14 INFO - 'LOGNAME': 'cltbld', 03:29:14 INFO - 'MAIL': '/var/mail/cltbld', 03:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:14 INFO - 'MOZ_NO_REMOTE': '1', 03:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:14 INFO - 'NO_EM_RESTART': '1', 03:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:14 INFO - 'PWD': '/builds/slave/test', 03:29:14 INFO - 'SHELL': '/bin/bash', 03:29:14 INFO - 'SHLVL': '1', 03:29:14 INFO - 'TERM': 'linux', 03:29:14 INFO - 'TMOUT': '86400', 03:29:14 INFO - 'USER': 'cltbld', 03:29:14 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 03:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:14 INFO - '_': '/tools/buildbot/bin/python'} 03:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:29:14 INFO - Cleaning up... 03:29:14 INFO - Return code: 0 03:29:14 INFO - Running post-action listener: _resource_record_post_action 03:29:14 INFO - Running post-action listener: _start_resource_monitoring 03:29:14 INFO - Starting resource monitoring. 03:29:14 INFO - [mozharness: 2017-07-27 10:29:14.649069Z] Finished create-virtualenv step (success) 03:29:14 INFO - [mozharness: 2017-07-27 10:29:14.649654Z] Running install step. 03:29:14 INFO - Running pre-action listener: _resource_record_pre_action 03:29:14 INFO - Running main action method: install 03:29:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:14 INFO - Reading from file tmpfile_stdout 03:29:14 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:29:15 INFO - Reading from file tmpfile_stdout 03:29:15 INFO - Output received: 03:29:15 INFO - Usage: mozinstall [options] installer 03:29:15 INFO - Options: 03:29:15 INFO - -h, --help show this help message and exit 03:29:15 INFO - -d DEST, --destination=DEST 03:29:15 INFO - Directory to install application into. [default: 03:29:15 INFO - "/builds/slave/test"] 03:29:15 INFO - --app=APP Application being installed. [default: firefox] 03:29:15 INFO - mkdir: /builds/slave/test/build/application 03:29:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:29:32 INFO - Reading from file tmpfile_stdout 03:29:32 INFO - Output received: 03:29:32 INFO - /builds/slave/test/build/application/firefox/firefox 03:29:32 INFO - Running post-action listener: _resource_record_post_action 03:29:32 INFO - [mozharness: 2017-07-27 10:29:32.859612Z] Finished install step (success) 03:29:32 INFO - [mozharness: 2017-07-27 10:29:32.859866Z] Running setup-mitmproxy step. 03:29:32 INFO - Running pre-action listener: _resource_record_pre_action 03:29:32 INFO - Running main action method: setup_mitmproxy 03:29:32 INFO - Skipping: mitmproxy is not required 03:29:32 INFO - Running post-action listener: _resource_record_post_action 03:29:32 INFO - [mozharness: 2017-07-27 10:29:32.860998Z] Finished setup-mitmproxy step (success) 03:29:32 INFO - [mozharness: 2017-07-27 10:29:32.861219Z] Running run-tests step. 03:29:32 INFO - Running pre-action listener: _resource_record_pre_action 03:29:32 INFO - Running pre-action listener: _set_gcov_prefix 03:29:32 INFO - Running main action method: run_tests 03:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:32 INFO - Python 2.7.3 03:29:32 INFO - Return code: 0 03:29:32 INFO - grabbing minidump binary from tooltool 03:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:32 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 0x16a5eb0>, '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 0x16a6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16a7240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:29:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:29:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:29:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:32 INFO - Return code: 0 03:29:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:29:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:32 INFO - ENV: RUST_BACKTRACE is now 1 03:29:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:29:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-084 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:29:32 INFO - Using env: {'DISPLAY': ':0', 03:29:32 INFO - 'HOME': '/home/cltbld', 03:29:32 INFO - 'LANG': 'en_US.UTF-8', 03:29:32 INFO - 'LANGUAGE': 'en_US:en', 03:29:32 INFO - 'LOGNAME': 'cltbld', 03:29:32 INFO - 'MAIL': '/var/mail/cltbld', 03:29:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:32 INFO - 'MOZ_NO_REMOTE': '1', 03:29:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:32 INFO - 'NO_EM_RESTART': '1', 03:29:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:32 INFO - 'PWD': '/builds/slave/test', 03:29:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:32 INFO - 'RUST_BACKTRACE': '1', 03:29:32 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:29:32 INFO - 'SHELL': '/bin/bash', 03:29:32 INFO - 'SHLVL': '1', 03:29:32 INFO - 'TERM': 'linux', 03:29:32 INFO - 'TMOUT': '86400', 03:29:32 INFO - 'USER': 'cltbld', 03:29:32 INFO - 'XDG_SESSION_COOKIE': 'ea65d483da93c827905c2090000001f5-1501151083.670985-891645176', 03:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:33 INFO - '_': '/tools/buildbot/bin/python'} 03:29:33 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/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:29:33 INFO - mozversion application_buildid: 20170727085605 03:29:33 INFO - mozversion application_changeset: c1ed71da57073d0f5fdbd279c9ad6037f9ae2d06 03:29:33 INFO - mozversion application_display_name: Nightly 03:29:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:33 INFO - mozversion application_name: Firefox 03:29:33 INFO - mozversion application_remotingname: firefox 03:29:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:29:33 INFO - mozversion application_vendor: Mozilla 03:29:33 INFO - mozversion application_version: 56.0a1 03:29:33 INFO - mozversion platform_buildid: 20170727085605 03:29:33 INFO - mozversion platform_changeset: c1ed71da57073d0f5fdbd279c9ad6037f9ae2d06 03:29:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:29:33 INFO - mozversion platform_version: 56.0a1 03:29:33 INFO - using testdate: 1501151373 03:29:33 INFO - actual date: 1501151373 03:29:33 INFO - starting webserver on 'localhost:38549' 03:29:33 INFO - SUITE-START | Running 2 tests 03:29:33 INFO - TEST-START | dromaeo_css 03:29:33 INFO - Initialising browser for dromaeo_css test... 03:29:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38549/getInfo.html -profile /tmp/tmpK2yvji/profile 03:29:33 INFO - TEST-INFO | started process 7337 (/builds/slave/test/build/application/firefox/firefox http://localhost:38549/getInfo.html) 03:29:39 INFO - TEST-INFO | 7337: exit 0 03:29:39 INFO - Browser initialized. 03:29:39 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:39 INFO - TEST-INFO | started process 7548 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK2yvji/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:40 INFO - PID 7548 | 03:29:40 INFO - PID 7548 | (/builds/slave/test/build/application/firefox/firefox:7597): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:29:40 INFO - PID 7548 | 03:29:50 INFO - PID 7548 | RSS: Main: 164212736 03:29:50 INFO - PID 7548 | 03:32:49 INFO - PID 7548 | Cycle 1(1): loaded http://localhost:38549/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38549/tests/dromaeo/cssquery-ext.html) 03:32:50 INFO - PID 7548 | RSS: Main: 166387712 03:32:50 INFO - PID 7548 | 03:35:52 INFO - PID 7548 | Cycle 1(1): loaded http://localhost:38549/tests/dromaeo/cssquery-ext.html (next: http://localhost:38549/tests/dromaeo/cssquery-jquery.html) 03:35:53 INFO - PID 7548 | RSS: Main: 163635200 03:35:53 INFO - PID 7548 | 03:38:54 INFO - PID 7548 | Cycle 1(1): loaded http://localhost:38549/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38549/tests/dromaeo/cssquery-mootools.html) 03:38:55 INFO - PID 7548 | RSS: Main: 165384192 03:38:55 INFO - PID 7548 | 03:41:57 INFO - PID 7548 | Cycle 1(1): loaded http://localhost:38549/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38549/tests/dromaeo/cssquery-prototype.html) 03:41:57 INFO - PID 7548 | RSS: Main: 163606528 03:41:57 INFO - PID 7548 | 03:45:01 INFO - PID 7548 | Cycle 1(1): loaded http://localhost:38549/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38549/tests/dromaeo/cssquery-yui.html) 03:45:01 INFO - PID 7548 | RSS: Main: 163328000 03:45:01 INFO - PID 7548 | 03:48:03 INFO - PID 7548 | Cycle 1(1): loaded http://localhost:38549/tests/dromaeo/cssquery-yui.html (next: http://localhost:38549/tests/dromaeo/cssquery-dojo.html) 03:48:03 INFO - PID 7548 | RSS: Main: 167514112 03:48:03 INFO - PID 7548 | 03:48:03 INFO - PID 7548 | __start_tp_report 03:48:03 INFO - PID 7548 | _x_x_mozilla_page_load 03:48:03 INFO - PID 7548 | _x_x_mozilla_page_load_details 03:48:03 INFO - PID 7548 | |i|pagename|runs| 03:48:03 INFO - PID 7548 | |0;dojo.html;3392.7964322140656;3417.9316413671722;3437.776544524606;3440.690337869591;3452.4476083826585;6254.781082662108;6263.561550691454;6286.088517165008;6313.6211827290335;6334.588251763644;6149.754009839601;6235.438810507054;6248.750049998006;6291.622502649844;6320.4943604511645;5430.75561599728;5455.672659640434;5497.120460726284;5498.120300751881;5600.103983362663;5540.556755459554;5561.4716601922755;5572.972135139318;5583.8604034899045;5622.212890195376;5292.52367286946;5465.9726701366635;5499.7250137493165;5577.247071645337;5591.161325801122;5462.5083742462975;5513.696746678931;5555.749991250404;5559.11054231321;5560.332760068777;5457.181422786613;5500.762328476101;5505.917411238835;5526.253955715967;5533.474319939599;6164.599301045418;6167.629942203482;6223.190985171898;6244.219472565929;6277.591956522857;6836.692348844264;6892;6908.620025898574;6910.3089691031;6925.930740692579;6929.72281108755;6942.618156001418;7005.754798582026;7011.228764835864;7020.262872398427;6211.565190436671;6318.4313411793155;6361.427471527585;6393.9680301598655;6469.870602587922;6874.346937040973;6988.650567471606;7009.509334346649;7018.543794653331;7020.403265722369;6522.739090436425;6608.372204640552;6687.866242675119;6688.598684078971;6695;6742.42689371409;6757.594544327356;6780.084688566981;6835.487338449636;6837.384635382839;6649.468042556584;6708.228553716288;6814.284500127515;6816.318368163244;6820.795376138723;6788.219354774165;6828.760993365208;6863.965680171667;6864.7940561783225;6872.244053154149;4858.78135483904;4867.123917694778;4971.726555039508;4987.451380348159;4987.875303117451;4350.978245108754;4353.477582690098;4365.738055716667;4379.956200437955;4384.956150438455;6379.170707808048;6425.710843012076;6434.549581529342;6442.098106265126;6461.838454038592;6854.931450685529;6911.03245545624;6912.343327383891;6920.757773477904;6923.515353925177;6360.84097897547;6435.967820160869;6469.967650161813;6539.574927629689;6545.639989800607;5455.236266922634;5544.584156188302;5605.747741351649;5662.886742265132;5680.0627896397455;7213.567185968858;7218.67515961783;7222.783316500513;7225.566466011951;7259.310365515267;6781.864362712817;6791.932080679328;6855.5886646801355;6878.27778083314;6888.896666549906;7138.286171382821;7161.069061022034;7169.892451613335;7255.274472552703;7267.164276108315;6645.468362531083;6714.563553369016;6715.496337774589;6716.992451132369;6845.657717114024;6806.217285012287;6815.93184068153;6845.178578570603;6846.691898864663;6858.279880612663;6519.478441724746;6568.47452203813;6593.076969224217;6612.140421745143;6618.867622647424;6525.2822189558165;6527.608343499405;6592.967035164986;6599.868002640016;6600.306967768315;6543.149390579194;6568.638724870178;6613.702383392662;6642.501812363996;6694.330566943267;6677.499187560855;6690.364415380531;6696.1629796275465;6752.561083529555;6785.2536221016635;6397.0724244983285;6478.838029049311;6479.384458476437;6485.643289618927;6595.1096601958125 03:48:03 INFO - PID 7548 | |1;ext.html;773.8723110686738;861.5433820075359;883.0815951410538;884.1732979664017;1180.545489986355;41096.58903410965;42161.36757948633;42216.788916055455;42219;42335.36496952548;39001.609983900154;42108;42349.36475952855;42615.36076958848;42685.7865710671;7028.578285302885;7074.115735533032;7084.256153103927;7090.432765378758;7092.858142837166;7479.065116860393;7542.886856697127;7576.886346704776;7597.050368703912;7598.0502437195355;7574.734884279052;7618.047744031996;7627;7639.961800190991;7665.961670191641;7590.696372145135;7610.885836712454;7612.809679757995;7615.466917315763;7620.352270057024;7466.514676546007;7523.548587084792;7523.811904702371;7525.4355923305975;7527.623618819037;39629.20741585181;39777.80111099455;39785.80107099446;39804.60195398038;39824.60175398238;3328.3010567780793;3344.147242453159;3357.0600231935096;3359.0090923177722;3362.495625656147;30637.234069148228;30680;30753.38493230123;30779.692203077906;30798.53802192969;4951.702897826106;5038.219076043182;5082.034413461431;5087.3386459759995;5127.9230811537855;214035;214276;215261.99999999843;215457;215708;49694.75152624214;50299;50316.49683503191;50361.74819125881;50407.49592504028;52334.73832630813;52557.73721131447;52677.209841852404;52941;52947;15136.621584460256;15371.61570960735;16405.343786248417;16667.083310417802;16675.66648667044;12199.51201951912;12361;12374.13381063317;12391.75216495683;12393.876061239273;13127.934360328329;13232.603021909357;13262.93368533151;13275.601731948056;13346.933265333611;5145.897082058413;5221.686698798084;5228.947710522846;5362.839114826484;5393.568514518829;1084.7938891610727;1092.6285063078592;1100.741325788439;1105.8894110588876;1112.1714322829382;24019.51960960771;24430.755692443203;24797.25608231756;24832.751672483406;25005.12482063119;1198.0890479684888;1209.9697507562205;1211.9878801211876;1220.6076090861832;1226.1171956191529;12865.228086314852;12895.806562901564;13046.217226966412;13354.732905341838;13366.532171373956;257570;259054;260125;260937;261801;52458.73770631122;52466;52546.73726631419;52864.471355286725;52877.2068418974;1480.8371079181281;1490.470882836599;1534.087218105248;1557.166915700095;1563.796706428157;23277.3016809496;23466.178683745988;23706.762932370457;23753.64369534424;23814.523709525365;38623;38961.220775583766;39089;39125.6087439122;39141.80429097836;210158;210404;210793;211114;211436;33712.15719606931;33822.83088584541;35590.8220458896;37458;37764.81117594394;46428.30357544707;47220.52779472162;47397;47544.2868356968;47739.28391074206;32711.836440817642;34292.314153717285;34667.4799877997;35132;35611.82194089013;34094.82952585221;34758.13104672403;34767.47848782321;34923.825380872935;35257.64742352646;38784;40142.19715605613;40348;40742.38886416765;41300.793496032325;32122.67877321197;32652.673473264964;32973.22266760017;33433;33567;25475.363115921507;26473.735262647126;26723.732762672902;26865.731342687104;27367.589486157325 03:48:03 INFO - PID 7548 | |2;jquery.html;577.1976952036667;578.647025314558;584.4389386189258;584.8420926349883;597.4742226840381;22426.88786556069;22508.43728906778;23327.533449331004;23437.76562234377;23488.8825555872;26229.73770262297;27151.728482715167;27246.863765681195;27278;27323.726762732367;6145.2625684917875;6270.31026587075;6277.811665650015;6281.654509002003;6293.056041593774;5755.309362876461;6065.666388348661;6084.665343406111;6352.904706429407;6416.069669897862;6055.545834062441;6057.878842423149;6062.514998800108;6068.362821903703;6069.726862291208;5974.910376344358;6049.455549000589;6050.092486127072;6052.21321228242;6054.0918862170365;5627.409122042209;5636.971815140898;5640.915386269209;5653.462921022497;5663.716814159276;29519.85240073786;30061.398772024437;30263.243418914484;30263.394732105455;31172.064838054896;2225.343523660524;2280.441291883483;2284.8400611957168;2291.2897001929455;2292.1519037955895;19285;19324;19454.416367509;19512.80487195124;20211.393658190278;2389.056322752503;2394.4133687246563;2445.0708730682404;2451.2156110044793;2452.4604586991013;152593;158331;158701;159128.20435897863;159154;15372.61568460775;15466.9226653866;15484.690306193814;15768.76346854798;16092.436764713178;24521.754782451946;24683;24692;24752.5049499009;24787.380315492257;10545.578176872992;10835.349879007126;10907.83638245427;10913.454327283764;11094;10039.34744241622;10103.797924041479;10139.188864890792;10148.08667219939;10271.691849244535;8350.57833228369;9577.569009394594;9625.422474651403;9720.562574684156;9783.951080244553;2652.2838833514843;2658.641083453748;2715.470483255786;2827.5051865923383;2909.85450727467;1036.404067661098;1051.5688567687364;1053.5627714498398;1090.0734375780523;1090.1442367741286;20979.580408391746;21663.891680541496;21786.346409607737;21835.235766748086;21960.560788784136;1145.1640302579165;1145.3414286784966;1159.1654009113424;1161.2509931094396;1163.6101905861462;11997.820032699516;14174.433022679184;14698.412063517553;15147.469838555598;15378.538643840702;615800;624844;632425;636937;650181;135428;138369;138945.30527347297;138972;141710;1327.9269640169884;1354.0724603646534;1356.2811709793825;1379.889608831291;1394.4561620967831;22148.778512215315;23528.29415117549;23904.88047559751;23918.52162956766;23946.64080038766;67487.66256168688;67537;67874.58517014333;67890;70660;86188.56905715431;86363;88238.55880720555;88249.55875220583;88664;18197.727034094765;18982.335618253295;19396.903015484833;21981.67027494621;22913.312600622008;20570.177192912117;22544.210952617235;24603.50792984166;24914.252572422858;25111.372215694024;20000.599987999867;20106.396808095782;20276.695849562562;20370.898145509178;20534.383968480968;17099.572510687332;17777.55556111056;17977.550561236072;18240.908795455936;18364.26542938321;20888.164473420893;20964.68552971737;20996.370108896757;21002.789972100083;21035.579288414454;21762.564748705256;22913.312600622008;22988.540229194987;23013.194538191085;23107.306780796604;19198.904005480443;20297.79702202959;20380.082896269407;20492.282770102975;20548.486287842923 03:48:03 INFO - PID 7548 | |3;mootools.html;1425.2731107135362;1471.1026273972882;1492.7387707151245;1499.2953311943384;1504.7742838574209;15022.774658380133;15560.221988900552;15590.142542160205;15636.530904072883;15637;15155.54533363998;15530.53408397747;16141.91929040356;16161.83838161618;16167.595810104753;2513.0576033987254;2575.639410482534;2576.36878964653;2576.8453892766493;2577.497388009339;2446.7920226780743;2448.26552034389;2484.838485498446;2504.060977133575;2582.3156863431204;2540.7586279303437;2568.6403903453534;2570.1261571065834;2570.344562136662;2571.8842652080702;2480.6031035034307;2503.5118151960373;2517.3706573356662;2533.949321013579;2539.3270783242456;2489.9128530501343;2491.426971796497;2519.143491212996;2524.684414448194;2535.1127105512924;15013.549593512213;15604.453844115402;15735.527934161993;15761;15771.605709857231;7839.568823714693;8158.75523734283;8173.918260817375;8177.509349438993;8197.590120494011;4942.332785074005;5072.0870243356185;5072.239164125411;5082.898342033139;5154.355705536808;1778.2839559824702;1780.643871225747;1795.9012254326008;1831.5054935167564;1834.257125864027;26313.736862631322;26397.73602263991;26576.202713918614;26593.867030664722;26601.201963941112;6476.158099447041;6683.331666833375;6750.83122921921;6776.424003959719;6804.761833335909;18160.727589086175;18201.45395638133;18323.725144122847;18323.725144122847;18332;7626.237376262329;7944.44388892772;8111.553864537507;8161.306288965505;8162;7270.491065625355;7537.773866784005;7546.886796698054;7560.168381478033;7565;5296.364436267672;5351.03681337363;5374.27447294618;5402.243685883979;5415.702136382458;1424.4971555009565;1461.203644014015;1506.3823832228734;1525.5728396049124;1534.5933327667954;920.7836158502746;947.8815148106487;968.9612415503301;970.7039352997404;983.3362480325751;8572.185642363966;8772.649094036295;8851.203391694778;8869.512176830207;9380.24958003358;1006.3861044762689;1053.6101642392211;1058.4072919165292;1068.1721665709138;1077.9465118948415;4848.781804818792;4964.652474326835;5418.783248670009;5658.575606829504;5773.845230953826;21357.359279221648;22286.665700014513;22370.55258894813;22413;22477.4380640482;21900.342989710334;22059.448513787283;22525.098996040302;22644.207452739076;22656.773432265465;12205.084618653636;12267.447964841604;12269.93865030669;12339.93830030844;12365.196262242926;7969.960150199444;8659.48043117415;8713.869291960498;8812.383133180616;8951.194392504705;18609.53476163107;19035.238590456225;19237.615247694688;19682.50793730168;20033.198672052953;19050.714239286146;19846.801531984496;19857.304994325128;19861;20085;12852.614421566994;12918.741625167257;13172.538961136313;13181.209127452383;13185.670358241121;14434.133951962916;14543.20012399286;14595.489157879423;14597.270136493345;14607.269636518344;11152.776944461228;11615.245009074382;11737.647870563897;11868.347240901834;11912;10596.20528460384;11232.438378081226;11289.71775705614;11352.375619340684;11681.591144309908;9991.400515969066;10163;10187.032231937954;10190.235732319958;10219.080282774288;7630.236976302547;7777.377809775091;7892.4080693947035;7942.44402891792;8062.475939063942;8209.425340226127;8228.958855205925;8230.62962166716;8291.046529649167;8310.335173186251 03:48:03 INFO - PID 7548 | |4;prototype.html;517.9249008893711;519.8102692517227;530.1835173832299;534.4335004894812;535.2078923193674;6085.878282434349;6094.177286066385;6108.320211941718;6166.475849552782;6173.660448675327;5983.88032239356;6019.699015049241;6038.758449662019;6070.937585922468;6078.787242446515;4876.634252431064;4879.731614761186;4886.828960986366;4894.657373983822;4899.338589290436;4614.953850461503;4708.741019243957;4781.282807578857;4786.606696651675;4868.610511159099;4689.835855745049;4693.953060469403;4700.083483720676;4715.929261061086;4718.900089460191;4663.300504924255;4675.812967481296;4698.107359601682;4698.91924857283;4713.811447542094;4207.495100587918;4247.00195454068;4261.957380426187;4270.572942705736;4314.180305741899;5794.97102514489;5833.38749431312;5842.013715336763;5853.88292234153;5898.8230353089475;5627.774889004435;5652.208690783253;5671.291088613923;5675.20547123399;5690.7439165237665;6405.29541750407;6409.711562979677;6427.61434313938;6443.971333473307;6453.83865403364;4860.854174374775;4878.56092951636;4883.340748998875;4909.361782968227;4939.728314942677;6460.773872914426;6578.276389597188;6668.433183179387;6708.19501659804;6773.322667733237;4958.9504104959215;4969.577585905166;5015.27278544609;5046.419661738947;5051.343325367752;5028.924566131511;5070.239464080344;5093.312402825645;5128.25640282157;5169.974150129226;5526.756479792015;5550.417206193372;5572.3034620672415;5662.886742265132;5673.404292549306;6427.646479443675;6446.484281257488;6462.224533056064;6485.805425837232;6504;1721.0706218641794;1754.5525890897738;1759.9560010999571;1765.7198531064876;1795.0127429913496;1190.4880901212389;1214.8481439820023;1226.9141160118884;1252.8809763072493;1256.9874301257053;6359.427651511386;6360.745570177233;6371.33101024395;6372.84067898297;6386.36136386367;6623.20521537409;6689.966550167315;6706.195256569145;6713.429358504484;6723.865522689519;6145.4161854623735;6244.37556244381;6255;6259.780907668301;6262.311145774052;3486.8430920608125;3490.7207423406066;3495.4407294832704;3516.49010893419;3543.858245670196;6905.205901321312;6941.30586941312;6963.268856769966;7018.824529386704;7062.1878483975;6757.952517359817;6763.628000459924;6780.796576102724;6835.7949261522235;6839.589624622538;6338.271098823694;6840.384365407038;6847.452203823782;6917.515773895779;6963;6456.580322279036;6551.868962620625;6556.213254409501;6559.7376104957175;6624.8343791405605;6422.325655806073;6497.350264973465;6510.479161666961;6511.283758786624;6546.149000629887;6890.689918953559;6918.238993710788;6990.8890543709595;7025.859482810213;7110.288971102848;5046.747662616928;5051.267566202953;5066.113430149635;5077.339945807022;5082.517160869711;6504.707288172138;6541.6402097885075;6643.867122657616;6686.665666716742;6688.966555167193;6316;6448.580842245239;6488.12410324619;6493;6530.47756179514;6401.167848179707;6436.742530298736;6466.838329041811;6486.156799616019;6502.934970650422;6384.936150638434;6386.393292637192;6392.776252831129;6449.3550644937;6507.869842603216;6429.324920883427;6519.608823470607;6550.8362290943105;6595.538312318092;6598.472122230306;6335.461485773761;6381.9047761834545;6402.03969404593;6406.327335629878;6437.420632143129 03:48:03 INFO - PID 7548 | |5;yui.html;927.9814403711925;940.5652349173645;957.2581249531612;960.4813400763588;979.539616380301;18632.534186645342;19474;19509.707354389695;19561.804381956175;21215.6817647735;18617.81382186178;20061.59876802467;22303;22474.66288005677;22631.773682263174;1055.651634960463;1086.2016417932814;1086.239632257419;1087.2443651662059;1087.7606926476203;1049.790041991601;1090.6346373964732;1091.5851976249014;1095.5398732532356;1095.5672509358799;1133.9036181924546;1141.61185197033;1142.6457798082622;1142.8342890280903;1148.1733152130453;1126.763379690266;1127.3968426891615;1129.1813435259453;1132.1395739238237;1136.8522092128053;835.678263868409;836.477201748907;839.0393000014949;840.995795021021;846.0820010288844;19635.901820490948;20217.797822021737;20225.190992360287;20356.18575256988;20576.279830206022;21181.68227476589;21318.14727410902;21583;21618;21862.23482178132;14710.926445367704;14939.70120597582;15083.396664133421;15102.924485377613;15189.468368607157;3672.6143754905884;3711.758735682172;3717.237966216946;3719.758215715997;3720.739548231598;105815.94184058138;135306;138011.30994344965;138311;143013.28493357467;14514.782278265835;14805.703885922221;16868.746968795476;17126.657466850593;17534.210960506807;30938.69061309403;31532.36935261282;31917.68082319147;32018;32078.518822217684;9225.723228303028;9294.581743821544;9377.249820014382;9379.906200937903;9388.718338449857;4199.916001680011;4204.201201771653;4206.053637931502;4208.9789551052045;4214.030772922184;5217.139172036647;5412.56699464042;5438.320209973754;5442.510174084272;5472.72636368188;1048.4076496779296;1071.8124328242527;1086.4839201379439;1090.8472813806075;1090.929089609173;626.708580510065;640.7789312687115;696.5646470955653;711.4521818199958;712.1560950273941;10989.263306063143;11974.341411222467;12088.637340879788;12232.143749937419;12590.937045314899;546.6747285365201;600.1807532717896;660.1978596005875;693.1924308180912;694.8992396102637;5209.765560549784;5277.472252774769;5357.517823395835;5407.026735187704;5582.720863956786;119865;123962;124119.37940310422;127152.36423817821;130161.34919325342;98100;99926.41575100739;101197.49401253094;103469.48265258626;105083;87070;91523.08476915279;93033;94171.52914235384;94377.528112359;10680.89319106799;11187.608433704781;11356.488957996744;11982.760344793229;12595.181313214613;44909.32636010397;46359.536404635524;48337.516624833304;49709;51093.48906511036;80513;82598.58700706458;82682.17317826745;84069.57965210135;85721;17687.911560442117;17872.821271787634;18164.364247251284;18167.45497635073;18183.4544963646;18305.450836474927;18659.626807463505;18735.063246837875;18887.055647217858;19347.322843700404;18225.54436139054;18371.90814045921;18457.077146142372;18617.53456163607;18620.720689189944;16418.097004664858;16740.246688898784;16920.069396183328;17021;17345;16408.26162822652;16603.66792664116;18821.623567528848;19050.428487145407;19101.90449047746;11086.445677716243;11240.718982025188;11677.649670509898;12025;12156.513739450324;13763.587092387244;14037.5086871959;14584.781228281796;14720.852791471949;14809 03:48:03 INFO - PID 7548 | __end_tp_report 03:48:03 INFO - PID 7548 | __start_cc_report 03:48:03 INFO - PID 7548 | _x_x_mozilla_cycle_collect,325 03:48:03 INFO - PID 7548 | __end_cc_report 03:48:03 INFO - PID 7548 | __startTimestamp1501152483699__endTimestamp 03:48:03 INFO - PID 7548 | 03:48:03 INFO - PID 7548 | ------- Summary: start ------- 03:48:03 INFO - PID 7548 | Number of tests: 6 03:48:03 INFO - PID 7548 | 03:48:03 INFO - PID 7548 | [#0] dojo.html Cycles:165 Average:6258.10 Median:6543.15 stddev:835.58 (12.8%) stddev-sans-first:807.34 03:48:03 INFO - PID 7548 | Values: 3392.8 3417.9 3437.8 3440.7 3452.4 6254.8 6263.6 6286.1 6313.6 6334.6 6149.8 6235.4 6248.8 6291.6 6320.5 5430.8 5455.7 5497.1 5498.1 5600.1 5540.6 5561.5 5573.0 5583.9 5622.2 5292.5 5466.0 5499.7 5577.2 5591.2 5462.5 5513.7 5555.7 5559.1 5560.3 5457.2 5500.8 5505.9 5526.3 5533.5 6164.6 6167.6 6223.2 6244.2 6277.6 6836.7 6892.0 6908.6 6910.3 6925.9 6929.7 6942.6 7005.8 7011.2 7020.3 6211.6 6318.4 6361.4 6394.0 6469.9 6874.3 6988.7 7009.5 7018.5 7020.4 6522.7 6608.4 6687.9 6688.6 6695.0 6742.4 6757.6 6780.1 6835.5 6837.4 6649.5 6708.2 6814.3 6816.3 6820.8 6788.2 6828.8 6864.0 6864.8 6872.2 4858.8 4867.1 4971.7 4987.5 4987.9 4351.0 4353.5 4365.7 4380.0 4385.0 6379.2 6425.7 6434.5 6442.1 6461.8 6854.9 6911.0 6912.3 6920.8 6923.5 6360.8 6436.0 6470.0 6539.6 6545.6 5455.2 5544.6 5605.7 5662.9 5680.1 7213.6 7218.7 7222.8 7225.6 7259.3 6781.9 6791.9 6855.6 6878.3 6888.9 7138.3 7161.1 7169.9 7255.3 7267.2 6645.5 6714.6 6715.5 6717.0 6845.7 6806.2 6815.9 6845.2 6846.7 6858.3 6519.5 6568.5 6593.1 6612.1 6618.9 6525.3 6527.6 6593.0 6599.9 6600.3 6543.1 6568.6 6613.7 6642.5 6694.3 6677.5 6690.4 6696.2 6752.6 6785.3 6397.1 6478.8 6479.4 6485.6 6595.1 03:48:03 INFO - PID 7548 | 03:48:03 INFO - PID 7548 | [#1] ext.html Cycles:180 Average:40143.75 Median:35194.82 stddev:59650.96 (169.5%) stddev-sans-first:59745.05 03:48:03 INFO - PID 7548 | Values: 773.9 861.5 883.1 884.2 1180.5 41096.6 42161.4 42216.8 42219.0 42335.4 39001.6 42108.0 42349.4 42615.4 42685.8 7028.6 7074.1 7084.3 7090.4 7092.9 7479.1 7542.9 7576.9 7597.1 7598.1 7574.7 7618.0 7627.0 7640.0 7666.0 7590.7 7610.9 7612.8 7615.5 7620.4 7466.5 7523.5 7523.8 7525.4 7527.6 39629.2 39777.8 39785.8 39804.6 39824.6 3328.3 3344.1 3357.1 3359.0 3362.5 30637.2 30680.0 30753.4 30779.7 30798.5 4951.7 5038.2 5082.0 5087.3 5127.9 214035.0 214276.0 215262.0 215457.0 215708.0 49694.8 50299.0 50316.5 50361.7 50407.5 52334.7 52557.7 52677.2 52941.0 52947.0 15136.6 15371.6 16405.3 16667.1 16675.7 12199.5 12361.0 12374.1 12391.8 12393.9 13127.9 13232.6 13262.9 13275.6 13346.9 5145.9 5221.7 5228.9 5362.8 5393.6 1084.8 1092.6 1100.7 1105.9 1112.2 24019.5 24430.8 24797.3 24832.8 25005.1 1198.1 1210.0 1212.0 1220.6 1226.1 12865.2 12895.8 13046.2 13354.7 13366.5 257570.0 259054.0 260125.0 260937.0 261801.0 52458.7 52466.0 52546.7 52864.5 52877.2 1480.8 1490.5 1534.1 1557.2 1563.8 23277.3 23466.2 23706.8 23753.6 23814.5 38623.0 38961.2 39089.0 39125.6 39141.8 210158.0 210404.0 210793.0 211114.0 211436.0 33712.2 33822.8 35590.8 37458.0 37764.8 46428.3 47220.5 47397.0 47544.3 47739.3 32711.8 34292.3 34667.5 35132.0 35611.8 34094.8 34758.1 34767.5 34923.8 35257.6 38784.0 40142.2 40348.0 40742.4 41300.8 32122.7 32652.7 32973.2 33433.0 33567.0 25475.4 26473.7 26723.7 26865.7 27367.6 03:48:03 INFO - PID 7548 | 03:48:03 INFO - PID 7548 | [#2] jquery.html Cycles:180 Average:41717.90 Median:12602.73 stddev:105912.07 (840.4%) stddev-sans-first:106164.14 03:48:03 INFO - PID 7548 | Values: 577.2 578.6 584.4 584.8 597.5 22426.9 22508.4 23327.5 23437.8 23488.9 26229.7 27151.7 27246.9 27278.0 27323.7 6145.3 6270.3 6277.8 6281.7 6293.1 5755.3 6065.7 6084.7 6352.9 6416.1 6055.5 6057.9 6062.5 6068.4 6069.7 5974.9 6049.5 6050.1 6052.2 6054.1 5627.4 5637.0 5640.9 5653.5 5663.7 29519.9 30061.4 30263.2 30263.4 31172.1 2225.3 2280.4 2284.8 2291.3 2292.2 19285.0 19324.0 19454.4 19512.8 20211.4 2389.1 2394.4 2445.1 2451.2 2452.5 152593.0 158331.0 158701.0 159128.2 159154.0 15372.6 15466.9 15484.7 15768.8 16092.4 24521.8 24683.0 24692.0 24752.5 24787.4 10545.6 10835.3 10907.8 10913.5 11094.0 10039.3 10103.8 10139.2 10148.1 10271.7 8350.6 9577.6 9625.4 9720.6 9784.0 2652.3 2658.6 2715.5 2827.5 2909.9 1036.4 1051.6 1053.6 1090.1 1090.1 20979.6 21663.9 21786.3 21835.2 21960.6 1145.2 1145.3 1159.2 1161.3 1163.6 11997.8 14174.4 14698.4 15147.5 15378.5 615800.0 624844.0 632425.0 636937.0 650181.0 135428.0 138369.0 138945.3 138972.0 141710.0 1327.9 1354.1 1356.3 1379.9 1394.5 22148.8 23528.3 23904.9 23918.5 23946.6 67487.7 67537.0 67874.6 67890.0 70660.0 86188.6 86363.0 88238.6 88249.6 88664.0 18197.7 18982.3 19396.9 21981.7 22913.3 20570.2 22544.2 24603.5 24914.3 25111.4 20000.6 20106.4 20276.7 20370.9 20534.4 17099.6 17777.6 17977.6 18240.9 18364.3 20888.2 20964.7 20996.4 21002.8 21035.6 21762.6 22913.3 22988.5 23013.2 23107.3 19198.9 20297.8 20380.1 20492.3 20548.5 03:48:03 INFO - PID 7548 | 03:48:03 INFO - PID 7548 | [#3] mootools.html Cycles:180 Average:9648.19 Median:2464.43 stddev:6914.34 (280.6%) stddev-sans-first:6906.14 03:48:03 INFO - PID 7548 | Values: 1425.3 1471.1 1492.7 1499.3 1504.8 15022.8 15560.2 15590.1 15636.5 15637.0 15155.5 15530.5 16141.9 16161.8 16167.6 2513.1 2575.6 2576.4 2576.8 2577.5 2446.8 2448.3 2484.8 2504.1 2582.3 2540.8 2568.6 2570.1 2570.3 2571.9 2480.6 2503.5 2517.4 2533.9 2539.3 2489.9 2491.4 2519.1 2524.7 2535.1 15013.5 15604.5 15735.5 15761.0 15771.6 7839.6 8158.8 8173.9 8177.5 8197.6 4942.3 5072.1 5072.2 5082.9 5154.4 1778.3 1780.6 1795.9 1831.5 1834.3 26313.7 26397.7 26576.2 26593.9 26601.2 6476.2 6683.3 6750.8 6776.4 6804.8 18160.7 18201.5 18323.7 18323.7 18332.0 7626.2 7944.4 8111.6 8161.3 8162.0 7270.5 7537.8 7546.9 7560.2 7565.0 5296.4 5351.0 5374.3 5402.2 5415.7 1424.5 1461.2 1506.4 1525.6 1534.6 920.8 947.9 969.0 970.7 983.3 8572.2 8772.6 8851.2 8869.5 9380.2 1006.4 1053.6 1058.4 1068.2 1077.9 4848.8 4964.7 5418.8 5658.6 5773.8 21357.4 22286.7 22370.6 22413.0 22477.4 21900.3 22059.4 22525.1 22644.2 22656.8 12205.1 12267.4 12269.9 12339.9 12365.2 7970.0 8659.5 8713.9 8812.4 8951.2 18609.5 19035.2 19237.6 19682.5 20033.2 19050.7 19846.8 19857.3 19861.0 20085.0 12852.6 12918.7 13172.5 13181.2 13185.7 14434.1 14543.2 14595.5 14597.3 14607.3 11152.8 11615.2 11737.6 11868.3 11912.0 10596.2 11232.4 11289.7 11352.4 11681.6 9991.4 10163.0 10187.0 10190.2 10219.1 7630.2 7777.4 7892.4 7942.4 8062.5 8209.4 8229.0 8230.6 8291.0 8310.3 03:48:03 INFO - PID 7548 | 03:48:03 INFO - PID 7548 | [#4] prototype.html Cycles:180 Average:5498.57 Median:6209.02 stddev:1568.18 (25.3%) stddev-sans-first:1527.37 03:48:03 INFO - PID 7548 | Values: 517.9 519.8 530.2 534.4 535.2 6085.9 6094.2 6108.3 6166.5 6173.7 5983.9 6019.7 6038.8 6070.9 6078.8 4876.6 4879.7 4886.8 4894.7 4899.3 4615.0 4708.7 4781.3 4786.6 4868.6 4689.8 4694.0 4700.1 4715.9 4718.9 4663.3 4675.8 4698.1 4698.9 4713.8 4207.5 4247.0 4262.0 4270.6 4314.2 5795.0 5833.4 5842.0 5853.9 5898.8 5627.8 5652.2 5671.3 5675.2 5690.7 6405.3 6409.7 6427.6 6444.0 6453.8 4860.9 4878.6 4883.3 4909.4 4939.7 6460.8 6578.3 6668.4 6708.2 6773.3 4959.0 4969.6 5015.3 5046.4 5051.3 5028.9 5070.2 5093.3 5128.3 5170.0 5526.8 5550.4 5572.3 5662.9 5673.4 6427.6 6446.5 6462.2 6485.8 6504.0 1721.1 1754.6 1760.0 1765.7 1795.0 1190.5 1214.8 1226.9 1252.9 1257.0 6359.4 6360.7 6371.3 6372.8 6386.4 6623.2 6690.0 6706.2 6713.4 6723.9 6145.4 6244.4 6255.0 6259.8 6262.3 3486.8 3490.7 3495.4 3516.5 3543.9 6905.2 6941.3 6963.3 7018.8 7062.2 6758.0 6763.6 6780.8 6835.8 6839.6 6338.3 6840.4 6847.5 6917.5 6963.0 6456.6 6551.9 6556.2 6559.7 6624.8 6422.3 6497.4 6510.5 6511.3 6546.1 6890.7 6918.2 6990.9 7025.9 7110.3 5046.7 5051.3 5066.1 5077.3 5082.5 6504.7 6541.6 6643.9 6686.7 6689.0 6316.0 6448.6 6488.1 6493.0 6530.5 6401.2 6436.7 6466.8 6486.2 6502.9 6384.9 6386.4 6392.8 6449.4 6507.9 6429.3 6519.6 6550.8 6595.5 6598.5 6335.5 6381.9 6402.0 6406.3 6437.4 03:48:03 INFO - PID 7548 | 03:48:03 INFO - PID 7548 | [#5] yui.html Cycles:180 Average:25104.32 Median:18854.34 stddev:35158.73 (186.5%) stddev-sans-first:35210.50 03:48:03 INFO - PID 7548 | Values: 928.0 940.6 957.3 960.5 979.5 18632.5 19474.0 19509.7 19561.8 21215.7 18617.8 20061.6 22303.0 22474.7 22631.8 1055.7 1086.2 1086.2 1087.2 1087.8 1049.8 1090.6 1091.6 1095.5 1095.6 1133.9 1141.6 1142.6 1142.8 1148.2 1126.8 1127.4 1129.2 1132.1 1136.9 835.7 836.5 839.0 841.0 846.1 19635.9 20217.8 20225.2 20356.2 20576.3 21181.7 21318.1 21583.0 21618.0 21862.2 14710.9 14939.7 15083.4 15102.9 15189.5 3672.6 3711.8 3717.2 3719.8 3720.7 105815.9 135306.0 138011.3 138311.0 143013.3 14514.8 14805.7 16868.7 17126.7 17534.2 30938.7 31532.4 31917.7 32018.0 32078.5 9225.7 9294.6 9377.2 9379.9 9388.7 4199.9 4204.2 4206.1 4209.0 4214.0 5217.1 5412.6 5438.3 5442.5 5472.7 1048.4 1071.8 1086.5 1090.8 1090.9 626.7 640.8 696.6 711.5 712.2 10989.3 11974.3 12088.6 12232.1 12590.9 546.7 600.2 660.2 693.2 694.9 5209.8 5277.5 5357.5 5407.0 5582.7 119865.0 123962.0 124119.4 127152.4 130161.3 98100.0 99926.4 101197.5 103469.5 105083.0 87070.0 91523.1 93033.0 94171.5 94377.5 10680.9 11187.6 11356.5 11982.8 12595.2 44909.3 46359.5 48337.5 49709.0 51093.5 80513.0 82598.6 82682.2 84069.6 85721.0 17687.9 17872.8 18164.4 18167.5 18183.5 18305.5 18659.6 18735.1 18887.1 19347.3 18225.5 18371.9 18457.1 18617.5 18620.7 16418.1 16740.2 16920.1 17021.0 17345.0 16408.3 16603.7 18821.6 19050.4 19101.9 11086.4 11240.7 11677.6 12025.0 12156.5 13763.6 14037.5 14584.8 14720.9 14809.0 03:48:03 INFO - PID 7548 | -------- Summary: end -------- 03:48:03 INFO - PID 7548 | 03:48:04 INFO - TEST-INFO | 7548: exit 0 03:48:04 INFO - TEST-OK | dromaeo_css | took 1111186ms 03:48:04 INFO - TEST-START | kraken 03:48:04 INFO - Initialising browser for kraken test... 03:48:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38549/getInfo.html -profile /tmp/tmpfpoVL5/profile 03:48:04 INFO - TEST-INFO | started process 7900 (/builds/slave/test/build/application/firefox/firefox http://localhost:38549/getInfo.html) 03:48:10 INFO - TEST-INFO | 7900: exit 0 03:48:10 INFO - Browser initialized. 03:48:10 INFO - Running cycle 1/1 for kraken test... 03:48:10 INFO - TEST-INFO | started process 8110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfpoVL5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:11 INFO - PID 8110 | 03:48:11 INFO - PID 8110 | (/builds/slave/test/build/application/firefox/firefox:8158): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:48:11 INFO - PID 8110 | 03:48:21 INFO - PID 8110 | RSS: Main: 163835904 03:48:21 INFO - PID 8110 | 03:48:24 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38549/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:25 INFO - PID 8110 | RSS: Main: 168644608 03:48:25 INFO - PID 8110 | 03:48:27 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38549/tests/kraken/driver.html?testName=audio-dft) 03:48:28 INFO - PID 8110 | RSS: Main: 169132032 03:48:28 INFO - PID 8110 | 03:48:31 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38549/tests/kraken/driver.html?testName=audio-fft) 03:48:31 INFO - PID 8110 | RSS: Main: 163475456 03:48:31 INFO - PID 8110 | 03:48:33 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38549/tests/kraken/driver.html?testName=audio-oscillator) 03:48:34 INFO - PID 8110 | RSS: Main: 165048320 03:48:34 INFO - PID 8110 | 03:48:36 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38549/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:37 INFO - PID 8110 | RSS: Main: 165273600 03:48:37 INFO - PID 8110 | 03:48:40 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38549/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:40 INFO - PID 8110 | RSS: Main: 168505344 03:48:40 INFO - PID 8110 | 03:48:44 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38549/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:45 INFO - PID 8110 | RSS: Main: 170217472 03:48:45 INFO - PID 8110 | 03:48:47 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38549/tests/kraken/driver.html?testName=json-parse-financial) 03:48:48 INFO - PID 8110 | RSS: Main: 168333312 03:48:48 INFO - PID 8110 | 03:48:49 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38549/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:48:50 INFO - PID 8110 | RSS: Main: 167989248 03:48:50 INFO - PID 8110 | 03:48:52 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38549/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:48:52 INFO - PID 8110 | RSS: Main: 168034304 03:48:52 INFO - PID 8110 | 03:48:54 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38549/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:48:55 INFO - PID 8110 | RSS: Main: 164986880 03:48:55 INFO - PID 8110 | 03:48:58 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:48:58 INFO - PID 8110 | RSS: Main: 164974592 03:48:58 INFO - PID 8110 | 03:49:01 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:02 INFO - PID 8110 | RSS: Main: 165535744 03:49:02 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | Cycle 1(1): loaded http://localhost:38549/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38549/tests/kraken/driver.html?testName=ai-astar) 03:49:04 INFO - PID 8110 | RSS: Main: 167374848 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | __start_tp_report 03:49:04 INFO - PID 8110 | _x_x_mozilla_page_load 03:49:04 INFO - PID 8110 | _x_x_mozilla_page_load_details 03:49:04 INFO - PID 8110 | |i|pagename|runs| 03:49:04 INFO - PID 8110 | |0;ai-astar;98;115;102;107;107;109;117;99;106;109 03:49:04 INFO - PID 8110 | |1;audio-beat-detection;138;116;144;173;120;148;142;115;166;116 03:49:04 INFO - PID 8110 | |2;audio-dft;162;165;164;165;161;163;161;162;165;173 03:49:04 INFO - PID 8110 | |3;audio-fft;74;75;74;155;74;76;74;90;105;75 03:49:04 INFO - PID 8110 | |4;audio-oscillator;78;77;128;78;78;79;126;78;78;126 03:49:04 INFO - PID 8110 | |5;imaging-gaussian-blur;117;114;114;114;114;114;114;113;114;114 03:49:04 INFO - PID 8110 | |6;imaging-darkroom;149;149;149;150;148;148;147;148;158;148 03:49:04 INFO - PID 8110 | |7;imaging-desaturate;95;94;103;96;94;94;94;94;94;94 03:49:04 INFO - PID 8110 | |8;json-parse-financial;48;48;47;47;49;48;48;48;48;48 03:49:04 INFO - PID 8110 | |9;json-stringify-tinderbox;57;57;57;57;57;56;57;57;56;56 03:49:04 INFO - PID 8110 | |10;stanford-crypto-aes;77;76;77;74;75;83;80;75;83;74 03:49:04 INFO - PID 8110 | |11;stanford-crypto-ccm;121;122;140;124;123;119;121;115;125;169 03:49:04 INFO - PID 8110 | |12;stanford-crypto-pbkdf2;164;178;164;171;163;163;164;166;164;167 03:49:04 INFO - PID 8110 | |13;stanford-crypto-sha256-iterative;63;70;66;68;64;62;62;60;65;62 03:49:04 INFO - PID 8110 | __end_tp_report 03:49:04 INFO - PID 8110 | __start_cc_report 03:49:04 INFO - PID 8110 | _x_x_mozilla_cycle_collect,860 03:49:04 INFO - PID 8110 | __end_cc_report 03:49:04 INFO - PID 8110 | __startTimestamp1501152544380__endTimestamp 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | ------- Summary: start ------- 03:49:04 INFO - PID 8110 | Number of tests: 14 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#0] ai-astar Cycles:10 Average:106.90 Median:112.00 stddev:6.17 (5.5%) stddev-sans-first:5.64 03:49:04 INFO - PID 8110 | Values: 98.0 115.0 102.0 107.0 107.0 109.0 117.0 99.0 106.0 109.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:143.00 stddev:21.03 (14.7%) stddev-sans-first:22.31 03:49:04 INFO - PID 8110 | Values: 138.0 116.0 144.0 173.0 120.0 148.0 142.0 115.0 166.0 116.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.50 stddev:3.51 (2.1%) stddev-sans-first:3.64 03:49:04 INFO - PID 8110 | Values: 162.0 165.0 164.0 165.0 161.0 163.0 161.0 162.0 165.0 173.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#3] audio-fft Cycles:10 Average:87.20 Median:74.50 stddev:25.91 (34.8%) stddev-sans-first:27.04 03:49:04 INFO - PID 8110 | Values: 74.0 75.0 74.0 155.0 74.0 76.0 74.0 90.0 105.0 75.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:78.00 stddev:23.52 (30.2%) stddev-sans-first:24.35 03:49:04 INFO - PID 8110 | Values: 78.0 77.0 128.0 78.0 78.0 79.0 126.0 78.0 78.0 126.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:1.03 (0.9%) stddev-sans-first:0.33 03:49:04 INFO - PID 8110 | Values: 117.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:149.00 stddev:3.13 (2.1%) stddev-sans-first:3.32 03:49:04 INFO - PID 8110 | Values: 149.0 149.0 149.0 150.0 148.0 148.0 147.0 148.0 158.0 148.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:94.00 stddev:2.82 (3.0%) stddev-sans-first:2.99 03:49:04 INFO - PID 8110 | Values: 95.0 94.0 103.0 96.0 94.0 94.0 94.0 94.0 94.0 94.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#8] json-parse-financial Cycles:10 Average:47.90 Median:48.00 stddev:0.57 (1.2%) stddev-sans-first:0.60 03:49:04 INFO - PID 8110 | Values: 48.0 48.0 47.0 47.0 49.0 48.0 48.0 48.0 48.0 48.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:57.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 03:49:04 INFO - PID 8110 | Values: 57.0 57.0 57.0 57.0 57.0 56.0 57.0 57.0 56.0 56.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:77.00 stddev:3.44 (4.5%) stddev-sans-first:3.64 03:49:04 INFO - PID 8110 | Values: 77.0 76.0 77.0 74.0 75.0 83.0 80.0 75.0 83.0 74.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#11] stanford-crypto-ccm Cycles:10 Average:127.90 Median:123.50 stddev:15.84 (12.8%) stddev-sans-first:16.61 03:49:04 INFO - PID 8110 | Values: 121.0 122.0 140.0 124.0 123.0 119.0 121.0 115.0 125.0 169.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:165.00 stddev:4.74 (2.9%) stddev-sans-first:4.95 03:49:04 INFO - PID 8110 | Values: 164.0 178.0 164.0 171.0 163.0 163.0 164.0 166.0 164.0 167.0 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:3.08 (4.8%) stddev-sans-first:3.24 03:49:04 INFO - PID 8110 | Values: 63.0 70.0 66.0 68.0 64.0 62.0 62.0 60.0 65.0 62.0 03:49:04 INFO - PID 8110 | -------- Summary: end -------- 03:49:04 INFO - PID 8110 | 03:49:04 INFO - PID 8110 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:49:04 INFO - TEST-INFO | 8110: exit 0 03:49:05 INFO - TEST-OK | kraken | took 60599ms 03:49:05 INFO - SUITE-END | took 1171s 03:49:05 INFO - Completed test suite (00:19:31) 03:49:05 INFO - javascript benchmark 03:49:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8790.711321843632, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3392.7964322140656, 3417.9316413671722, 3437.776544524606, 3440.690337869591, 3452.4476083826585, 6254.781082662108, 6263.561550691454, 6286.088517165008, 6313.6211827290335, 6334.588251763644, 6149.754009839601, 6235.438810507054, 6248.750049998006, 6291.622502649844, 6320.4943604511645, 5430.75561599728, 5455.672659640434, 5497.120460726284, 5498.120300751881, 5600.103983362663, 5540.556755459554, 5561.4716601922755, 5572.972135139318, 5583.8604034899045, 5622.212890195376, 5292.52367286946, 5465.9726701366635, 5499.7250137493165, 5577.247071645337, 5591.161325801122, 5462.5083742462975, 5513.696746678931, 5555.749991250404, 5559.11054231321, 5560.332760068777, 5457.181422786613, 5500.762328476101, 5505.917411238835, 5526.253955715967, 5533.474319939599, 6164.599301045418, 6167.629942203482, 6223.190985171898, 6244.219472565929, 6277.591956522857, 6836.692348844264, 6892.0, 6908.620025898574, 6910.3089691031, 6925.930740692579, 6929.72281108755, 6942.618156001418, 7005.754798582026, 7011.228764835864, 7020.262872398427, 6211.565190436671, 6318.4313411793155, 6361.427471527585, 6393.9680301598655, 6469.870602587922, 6874.346937040973, 6988.650567471606, 7009.509334346649, 7018.543794653331, 7020.403265722369, 6522.739090436425, 6608.372204640552, 6687.866242675119, 6688.598684078971, 6695.0, 6742.42689371409, 6757.594544327356, 6780.084688566981, 6835.487338449636, 6837.384635382839, 6649.468042556584, 6708.228553716288, 6814.284500127515, 6816.318368163244, 6820.795376138723, 6788.219354774165, 6828.760993365208, 6863.965680171667, 6864.7940561783225, 6872.244053154149, 4858.78135483904, 4867.123917694778, 4971.726555039508, 4987.451380348159, 4987.875303117451, 4350.978245108754, 4353.477582690098, 4365.738055716667, 4379.956200437955, 4384.956150438455, 6379.170707808048, 6425.710843012076, 6434.549581529342, 6442.098106265126, 6461.838454038592, 6854.931450685529, 6911.03245545624, 6912.343327383891, 6920.757773477904, 6923.515353925177, 6360.84097897547, 6435.967820160869, 6469.967650161813, 6539.574927629689, 6545.639989800607, 5455.236266922634, 5544.584156188302, 5605.747741351649, 5662.886742265132, 5680.0627896397455, 7213.567185968858, 7218.67515961783, 7222.783316500513, 7225.566466011951, 7259.310365515267, 6781.864362712817, 6791.932080679328, 6855.5886646801355, 6878.27778083314, 6888.896666549906, 7138.286171382821, 7161.069061022034, 7169.892451613335, 7255.274472552703, 7267.164276108315, 6645.468362531083, 6714.563553369016, 6715.496337774589, 6716.992451132369, 6845.657717114024, 6806.217285012287, 6815.93184068153, 6845.178578570603, 6846.691898864663, 6858.279880612663, 6519.478441724746, 6568.47452203813, 6593.076969224217, 6612.140421745143, 6618.867622647424, 6525.2822189558165, 6527.608343499405, 6592.967035164986, 6599.868002640016, 6600.306967768315, 6543.149390579194, 6568.638724870178, 6613.702383392662, 6642.501812363996, 6694.330566943267, 6677.499187560855, 6690.364415380531, 6696.1629796275465, 6752.561083529555, 6785.2536221016635, 6397.0724244983285, 6478.838029049311, 6479.384458476437, 6485.643289618927, 6595.1096601958125], "value": 6191.619227308219, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.8723110686738, 861.5433820075359, 883.0815951410538, 884.1732979664017, 1180.545489986355, 41096.58903410965, 42161.36757948633, 42216.788916055455, 42219.0, 42335.36496952548, 39001.609983900154, 42108.0, 42349.36475952855, 42615.36076958848, 42685.7865710671, 7028.578285302885, 7074.115735533032, 7084.256153103927, 7090.432765378758, 7092.858142837166, 7479.065116860393, 7542.886856697127, 7576.886346704776, 7597.050368703912, 7598.0502437195355, 7574.734884279052, 7618.047744031996, 7627.0, 7639.961800190991, 7665.961670191641, 7590.696372145135, 7610.885836712454, 7612.809679757995, 7615.466917315763, 7620.352270057024, 7466.514676546007, 7523.548587084792, 7523.811904702371, 7525.4355923305975, 7527.623618819037, 39629.20741585181, 39777.80111099455, 39785.80107099446, 39804.60195398038, 39824.60175398238, 3328.3010567780793, 3344.147242453159, 3357.0600231935096, 3359.0090923177722, 3362.495625656147, 30637.234069148228, 30680.0, 30753.38493230123, 30779.692203077906, 30798.53802192969, 4951.702897826106, 5038.219076043182, 5082.034413461431, 5087.3386459759995, 5127.9230811537855, 214035.0, 214276.0, 215261.99999999843, 215457.0, 215708.0, 49694.75152624214, 50299.0, 50316.49683503191, 50361.74819125881, 50407.49592504028, 52334.73832630813, 52557.73721131447, 52677.209841852404, 52941.0, 52947.0, 15136.621584460256, 15371.61570960735, 16405.343786248417, 16667.083310417802, 16675.66648667044, 12199.51201951912, 12361.0, 12374.13381063317, 12391.75216495683, 12393.876061239273, 13127.934360328329, 13232.603021909357, 13262.93368533151, 13275.601731948056, 13346.933265333611, 5145.897082058413, 5221.686698798084, 5228.947710522846, 5362.839114826484, 5393.568514518829, 1084.7938891610727, 1092.6285063078592, 1100.741325788439, 1105.8894110588876, 1112.1714322829382, 24019.51960960771, 24430.755692443203, 24797.25608231756, 24832.751672483406, 25005.12482063119, 1198.0890479684888, 1209.9697507562205, 1211.9878801211876, 1220.6076090861832, 1226.1171956191529, 12865.228086314852, 12895.806562901564, 13046.217226966412, 13354.732905341838, 13366.532171373956, 257570.0, 259054.0, 260125.0, 260937.0, 261801.0, 52458.73770631122, 52466.0, 52546.73726631419, 52864.471355286725, 52877.2068418974, 1480.8371079181281, 1490.470882836599, 1534.087218105248, 1557.166915700095, 1563.796706428157, 23277.3016809496, 23466.178683745988, 23706.762932370457, 23753.64369534424, 23814.523709525365, 38623.0, 38961.220775583766, 39089.0, 39125.6087439122, 39141.80429097836, 210158.0, 210404.0, 210793.0, 211114.0, 211436.0, 33712.15719606931, 33822.83088584541, 35590.8220458896, 37458.0, 37764.81117594394, 46428.30357544707, 47220.52779472162, 47397.0, 47544.2868356968, 47739.28391074206, 32711.836440817642, 34292.314153717285, 34667.4799877997, 35132.0, 35611.82194089013, 34094.82952585221, 34758.13104672403, 34767.47848782321, 34923.825380872935, 35257.64742352646, 38784.0, 40142.19715605613, 40348.0, 40742.38886416765, 41300.793496032325, 32122.67877321197, 32652.673473264964, 32973.22266760017, 33433.0, 33567.0, 25475.363115921507, 26473.735262647126, 26723.732762672902, 26865.731342687104, 27367.589486157325], "value": 17648.185957094654, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.1976952036667, 578.647025314558, 584.4389386189258, 584.8420926349883, 597.4742226840381, 22426.88786556069, 22508.43728906778, 23327.533449331004, 23437.76562234377, 23488.8825555872, 26229.73770262297, 27151.728482715167, 27246.863765681195, 27278.0, 27323.726762732367, 6145.2625684917875, 6270.31026587075, 6277.811665650015, 6281.654509002003, 6293.056041593774, 5755.309362876461, 6065.666388348661, 6084.665343406111, 6352.904706429407, 6416.069669897862, 6055.545834062441, 6057.878842423149, 6062.514998800108, 6068.362821903703, 6069.726862291208, 5974.910376344358, 6049.455549000589, 6050.092486127072, 6052.21321228242, 6054.0918862170365, 5627.409122042209, 5636.971815140898, 5640.915386269209, 5653.462921022497, 5663.716814159276, 29519.85240073786, 30061.398772024437, 30263.243418914484, 30263.394732105455, 31172.064838054896, 2225.343523660524, 2280.441291883483, 2284.8400611957168, 2291.2897001929455, 2292.1519037955895, 19285.0, 19324.0, 19454.416367509, 19512.80487195124, 20211.393658190278, 2389.056322752503, 2394.4133687246563, 2445.0708730682404, 2451.2156110044793, 2452.4604586991013, 152593.0, 158331.0, 158701.0, 159128.20435897863, 159154.0, 15372.61568460775, 15466.9226653866, 15484.690306193814, 15768.76346854798, 16092.436764713178, 24521.754782451946, 24683.0, 24692.0, 24752.5049499009, 24787.380315492257, 10545.578176872992, 10835.349879007126, 10907.83638245427, 10913.454327283764, 11094.0, 10039.34744241622, 10103.797924041479, 10139.188864890792, 10148.08667219939, 10271.691849244535, 8350.57833228369, 9577.569009394594, 9625.422474651403, 9720.562574684156, 9783.951080244553, 2652.2838833514843, 2658.641083453748, 2715.470483255786, 2827.5051865923383, 2909.85450727467, 1036.404067661098, 1051.5688567687364, 1053.5627714498398, 1090.0734375780523, 1090.1442367741286, 20979.580408391746, 21663.891680541496, 21786.346409607737, 21835.235766748086, 21960.560788784136, 1145.1640302579165, 1145.3414286784966, 1159.1654009113424, 1161.2509931094396, 1163.6101905861462, 11997.820032699516, 14174.433022679184, 14698.412063517553, 15147.469838555598, 15378.538643840702, 615800.0, 624844.0, 632425.0, 636937.0, 650181.0, 135428.0, 138369.0, 138945.30527347297, 138972.0, 141710.0, 1327.9269640169884, 1354.0724603646534, 1356.2811709793825, 1379.889608831291, 1394.4561620967831, 22148.778512215315, 23528.29415117549, 23904.88047559751, 23918.52162956766, 23946.64080038766, 67487.66256168688, 67537.0, 67874.58517014333, 67890.0, 70660.0, 86188.56905715431, 86363.0, 88238.55880720555, 88249.55875220583, 88664.0, 18197.727034094765, 18982.335618253295, 19396.903015484833, 21981.67027494621, 22913.312600622008, 20570.177192912117, 22544.210952617235, 24603.50792984166, 24914.252572422858, 25111.372215694024, 20000.599987999867, 20106.396808095782, 20276.695849562562, 20370.898145509178, 20534.383968480968, 17099.572510687332, 17777.55556111056, 17977.550561236072, 18240.908795455936, 18364.26542938321, 20888.164473420893, 20964.68552971737, 20996.370108896757, 21002.789972100083, 21035.579288414454, 21762.564748705256, 22913.312600622008, 22988.540229194987, 23013.194538191085, 23107.306780796604, 19198.904005480443, 20297.79702202959, 20380.082896269407, 20492.282770102975, 20548.486287842923], "value": 13117.419051126342, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1425.2731107135362, 1471.1026273972882, 1492.7387707151245, 1499.2953311943384, 1504.7742838574209, 15022.774658380133, 15560.221988900552, 15590.142542160205, 15636.530904072883, 15637.0, 15155.54533363998, 15530.53408397747, 16141.91929040356, 16161.83838161618, 16167.595810104753, 2513.0576033987254, 2575.639410482534, 2576.36878964653, 2576.8453892766493, 2577.497388009339, 2446.7920226780743, 2448.26552034389, 2484.838485498446, 2504.060977133575, 2582.3156863431204, 2540.7586279303437, 2568.6403903453534, 2570.1261571065834, 2570.344562136662, 2571.8842652080702, 2480.6031035034307, 2503.5118151960373, 2517.3706573356662, 2533.949321013579, 2539.3270783242456, 2489.9128530501343, 2491.426971796497, 2519.143491212996, 2524.684414448194, 2535.1127105512924, 15013.549593512213, 15604.453844115402, 15735.527934161993, 15761.0, 15771.605709857231, 7839.568823714693, 8158.75523734283, 8173.918260817375, 8177.509349438993, 8197.590120494011, 4942.332785074005, 5072.0870243356185, 5072.239164125411, 5082.898342033139, 5154.355705536808, 1778.2839559824702, 1780.643871225747, 1795.9012254326008, 1831.5054935167564, 1834.257125864027, 26313.736862631322, 26397.73602263991, 26576.202713918614, 26593.867030664722, 26601.201963941112, 6476.158099447041, 6683.331666833375, 6750.83122921921, 6776.424003959719, 6804.761833335909, 18160.727589086175, 18201.45395638133, 18323.725144122847, 18323.725144122847, 18332.0, 7626.237376262329, 7944.44388892772, 8111.553864537507, 8161.306288965505, 8162.0, 7270.491065625355, 7537.773866784005, 7546.886796698054, 7560.168381478033, 7565.0, 5296.364436267672, 5351.03681337363, 5374.27447294618, 5402.243685883979, 5415.702136382458, 1424.4971555009565, 1461.203644014015, 1506.3823832228734, 1525.5728396049124, 1534.5933327667954, 920.7836158502746, 947.8815148106487, 968.9612415503301, 970.7039352997404, 983.3362480325751, 8572.185642363966, 8772.649094036295, 8851.203391694778, 8869.512176830207, 9380.24958003358, 1006.3861044762689, 1053.6101642392211, 1058.4072919165292, 1068.1721665709138, 1077.9465118948415, 4848.781804818792, 4964.652474326835, 5418.783248670009, 5658.575606829504, 5773.845230953826, 21357.359279221648, 22286.665700014513, 22370.55258894813, 22413.0, 22477.4380640482, 21900.342989710334, 22059.448513787283, 22525.098996040302, 22644.207452739076, 22656.773432265465, 12205.084618653636, 12267.447964841604, 12269.93865030669, 12339.93830030844, 12365.196262242926, 7969.960150199444, 8659.48043117415, 8713.869291960498, 8812.383133180616, 8951.194392504705, 18609.53476163107, 19035.238590456225, 19237.615247694688, 19682.50793730168, 20033.198672052953, 19050.714239286146, 19846.801531984496, 19857.304994325128, 19861.0, 20085.0, 12852.614421566994, 12918.741625167257, 13172.538961136313, 13181.209127452383, 13185.670358241121, 14434.133951962916, 14543.20012399286, 14595.489157879423, 14597.270136493345, 14607.269636518344, 11152.776944461228, 11615.245009074382, 11737.647870563897, 11868.347240901834, 11912.0, 10596.20528460384, 11232.438378081226, 11289.71775705614, 11352.375619340684, 11681.591144309908, 9991.400515969066, 10163.0, 10187.032231937954, 10190.235732319958, 10219.080282774288, 7630.236976302547, 7777.377809775091, 7892.4080693947035, 7942.44402891792, 8062.475939063942, 8209.425340226127, 8228.958855205925, 8230.62962166716, 8291.046529649167, 8310.335173186251], "value": 6824.476405355603, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.9249008893711, 519.8102692517227, 530.1835173832299, 534.4335004894812, 535.2078923193674, 6085.878282434349, 6094.177286066385, 6108.320211941718, 6166.475849552782, 6173.660448675327, 5983.88032239356, 6019.699015049241, 6038.758449662019, 6070.937585922468, 6078.787242446515, 4876.634252431064, 4879.731614761186, 4886.828960986366, 4894.657373983822, 4899.338589290436, 4614.953850461503, 4708.741019243957, 4781.282807578857, 4786.606696651675, 4868.610511159099, 4689.835855745049, 4693.953060469403, 4700.083483720676, 4715.929261061086, 4718.900089460191, 4663.300504924255, 4675.812967481296, 4698.107359601682, 4698.91924857283, 4713.811447542094, 4207.495100587918, 4247.00195454068, 4261.957380426187, 4270.572942705736, 4314.180305741899, 5794.97102514489, 5833.38749431312, 5842.013715336763, 5853.88292234153, 5898.8230353089475, 5627.774889004435, 5652.208690783253, 5671.291088613923, 5675.20547123399, 5690.7439165237665, 6405.29541750407, 6409.711562979677, 6427.61434313938, 6443.971333473307, 6453.83865403364, 4860.854174374775, 4878.56092951636, 4883.340748998875, 4909.361782968227, 4939.728314942677, 6460.773872914426, 6578.276389597188, 6668.433183179387, 6708.19501659804, 6773.322667733237, 4958.9504104959215, 4969.577585905166, 5015.27278544609, 5046.419661738947, 5051.343325367752, 5028.924566131511, 5070.239464080344, 5093.312402825645, 5128.25640282157, 5169.974150129226, 5526.756479792015, 5550.417206193372, 5572.3034620672415, 5662.886742265132, 5673.404292549306, 6427.646479443675, 6446.484281257488, 6462.224533056064, 6485.805425837232, 6504.0, 1721.0706218641794, 1754.5525890897738, 1759.9560010999571, 1765.7198531064876, 1795.0127429913496, 1190.4880901212389, 1214.8481439820023, 1226.9141160118884, 1252.8809763072493, 1256.9874301257053, 6359.427651511386, 6360.745570177233, 6371.33101024395, 6372.84067898297, 6386.36136386367, 6623.20521537409, 6689.966550167315, 6706.195256569145, 6713.429358504484, 6723.865522689519, 6145.4161854623735, 6244.37556244381, 6255.0, 6259.780907668301, 6262.311145774052, 3486.8430920608125, 3490.7207423406066, 3495.4407294832704, 3516.49010893419, 3543.858245670196, 6905.205901321312, 6941.30586941312, 6963.268856769966, 7018.824529386704, 7062.1878483975, 6757.952517359817, 6763.628000459924, 6780.796576102724, 6835.7949261522235, 6839.589624622538, 6338.271098823694, 6840.384365407038, 6847.452203823782, 6917.515773895779, 6963.0, 6456.580322279036, 6551.868962620625, 6556.213254409501, 6559.7376104957175, 6624.8343791405605, 6422.325655806073, 6497.350264973465, 6510.479161666961, 6511.283758786624, 6546.149000629887, 6890.689918953559, 6918.238993710788, 6990.8890543709595, 7025.859482810213, 7110.288971102848, 5046.747662616928, 5051.267566202953, 5066.113430149635, 5077.339945807022, 5082.517160869711, 6504.707288172138, 6541.6402097885075, 6643.867122657616, 6686.665666716742, 6688.966555167193, 6316.0, 6448.580842245239, 6488.12410324619, 6493.0, 6530.47756179514, 6401.167848179707, 6436.742530298736, 6466.838329041811, 6486.156799616019, 6502.934970650422, 6384.936150638434, 6386.393292637192, 6392.776252831129, 6449.3550644937, 6507.869842603216, 6429.324920883427, 6519.608823470607, 6550.8362290943105, 6595.538312318092, 6598.472122230306, 6335.461485773761, 6381.9047761834545, 6402.03969404593, 6406.327335629878, 6437.420632143129], "value": 5042.092508221024, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [927.9814403711925, 940.5652349173645, 957.2581249531612, 960.4813400763588, 979.539616380301, 18632.534186645342, 19474.0, 19509.707354389695, 19561.804381956175, 21215.6817647735, 18617.81382186178, 20061.59876802467, 22303.0, 22474.66288005677, 22631.773682263174, 1055.651634960463, 1086.2016417932814, 1086.239632257419, 1087.2443651662059, 1087.7606926476203, 1049.790041991601, 1090.6346373964732, 1091.5851976249014, 1095.5398732532356, 1095.5672509358799, 1133.9036181924546, 1141.61185197033, 1142.6457798082622, 1142.8342890280903, 1148.1733152130453, 1126.763379690266, 1127.3968426891615, 1129.1813435259453, 1132.1395739238237, 1136.8522092128053, 835.678263868409, 836.477201748907, 839.0393000014949, 840.995795021021, 846.0820010288844, 19635.901820490948, 20217.797822021737, 20225.190992360287, 20356.18575256988, 20576.279830206022, 21181.68227476589, 21318.14727410902, 21583.0, 21618.0, 21862.23482178132, 14710.926445367704, 14939.70120597582, 15083.396664133421, 15102.924485377613, 15189.468368607157, 3672.6143754905884, 3711.758735682172, 3717.237966216946, 3719.758215715997, 3720.739548231598, 105815.94184058138, 135306.0, 138011.30994344965, 138311.0, 143013.28493357467, 14514.782278265835, 14805.703885922221, 16868.746968795476, 17126.657466850593, 17534.210960506807, 30938.69061309403, 31532.36935261282, 31917.68082319147, 32018.0, 32078.518822217684, 9225.723228303028, 9294.581743821544, 9377.249820014382, 9379.906200937903, 9388.718338449857, 4199.916001680011, 4204.201201771653, 4206.053637931502, 4208.9789551052045, 4214.030772922184, 5217.139172036647, 5412.56699464042, 5438.320209973754, 5442.510174084272, 5472.72636368188, 1048.4076496779296, 1071.8124328242527, 1086.4839201379439, 1090.8472813806075, 1090.929089609173, 626.708580510065, 640.7789312687115, 696.5646470955653, 711.4521818199958, 712.1560950273941, 10989.263306063143, 11974.341411222467, 12088.637340879788, 12232.143749937419, 12590.937045314899, 546.6747285365201, 600.1807532717896, 660.1978596005875, 693.1924308180912, 694.8992396102637, 5209.765560549784, 5277.472252774769, 5357.517823395835, 5407.026735187704, 5582.720863956786, 119865.0, 123962.0, 124119.37940310422, 127152.36423817821, 130161.34919325342, 98100.0, 99926.41575100739, 101197.49401253094, 103469.48265258626, 105083.0, 87070.0, 91523.08476915279, 93033.0, 94171.52914235384, 94377.528112359, 10680.89319106799, 11187.608433704781, 11356.488957996744, 11982.760344793229, 12595.181313214613, 44909.32636010397, 46359.536404635524, 48337.516624833304, 49709.0, 51093.48906511036, 80513.0, 82598.58700706458, 82682.17317826745, 84069.57965210135, 85721.0, 17687.911560442117, 17872.821271787634, 18164.364247251284, 18167.45497635073, 18183.4544963646, 18305.450836474927, 18659.626807463505, 18735.063246837875, 18887.055647217858, 19347.322843700404, 18225.54436139054, 18371.90814045921, 18457.077146142372, 18617.53456163607, 18620.720689189944, 16418.097004664858, 16740.246688898784, 16920.069396183328, 17021.0, 17345.0, 16408.26162822652, 16603.66792664116, 18821.623567528848, 19050.428487145407, 19101.90449047746, 11086.445677716243, 11240.718982025188, 11677.649670509898, 12025.0, 12156.513739450324, 13763.587092387244, 14037.5086871959, 14584.781228281796, 14720.852791471949, 14809.0], "value": 9355.858390666006, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1487.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 115.0, 102.0, 107.0, 107.0, 109.0, 117.0, 99.0, 106.0, 109.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 116.0, 144.0, 173.0, 120.0, 148.0, 142.0, 115.0, 166.0, 116.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 164.0, 165.0, 161.0, 163.0, 161.0, 162.0, 165.0, 173.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 155.0, 74.0, 76.0, 74.0, 90.0, 105.0, 75.0], "value": 87.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 128.0, 78.0, 78.0, 79.0, 126.0, 78.0, 78.0, 126.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 149.0, 150.0, 148.0, 148.0, 147.0, 148.0, 158.0, 148.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 103.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 47.0, 47.0, 49.0, 48.0, 48.0, 48.0, 48.0, 48.0], "value": 47.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 57.0, 57.0, 56.0, 57.0, 57.0, 56.0, 56.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 74.0, 75.0, 83.0, 80.0, 75.0, 83.0, 74.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 140.0, 124.0, 123.0, 119.0, 121.0, 115.0, 125.0, 169.0], "value": 127.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 178.0, 164.0, 171.0, 163.0, 163.0, 164.0, 166.0, 164.0, 167.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 66.0, 68.0, 64.0, 62.0, 62.0, 60.0, 65.0, 62.0], "value": 64.2, "unit": "score"}]}]} 03:49:05 INFO - Return code: 0 03:49:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:49:05 INFO - # TBPL SUCCESS # 03:49:05 INFO - Running post-action listener: _package_coverage_data 03:49:05 INFO - Running post-action listener: _resource_record_post_action 03:49:05 INFO - [mozharness: 2017-07-27 10:49:05.205993Z] Finished run-tests step (success) 03:49:05 INFO - Running post-run listener: _resource_record_post_run 03:49:05 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 426586112; Read time: 24; Write time: 451264 03:49:05 INFO - TinderboxPrint: CPU usage
13.1% 03:49:05 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 03:49:05 INFO - TinderboxPrint: I/O write bytes / time
426,586,112 / 451,264 03:49:05 INFO - TinderboxPrint: CPU idle
8,249.0 (86.9%) 03:49:05 INFO - TinderboxPrint: CPU user
1,190.8 (12.5%) 03:49:05 INFO - TinderboxPrint: Swap in / out
0 / 0 03:49:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108498944; Read time: 0; Write time: 134816 03:49:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:49:05 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 318087168; Read time: 0; Write time: 316448 03:49:05 INFO - Running post-run listener: _upload_blobber_files 03:49:05 INFO - Blob upload gear active. 03:49:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49: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 03:49: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'] 03:49: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 03:49:06 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:49:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:49:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:07 INFO - (blobuploader) - INFO - Done attempting. 03:49:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:15 INFO - (blobuploader) - INFO - Done attempting. 03:49:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:49:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:49:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:16 INFO - (blobuploader) - INFO - Done attempting. 03:49:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:49:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:49:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:17 INFO - (blobuploader) - INFO - Done attempting. 03:49:17 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:17 INFO - Return code: 0 03:49:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8041dd18c0869bf13e987f13bb425da1526413a49e2cba4d0fa38db486836347ffaef5a4db65e016460f7d9b95f4d467202ec7e47e3b416caddb0175037a9177", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee23e6b04e2e93c498c86e93a2a4475ff515b516bb0408e4f6cfc3d711e7d5f9135eeb55fee6d2ebfdd8c649c8b38ac41f3c268dfa06a5c34909e46ee44338d7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/665f9a9d6296d41128549eb71a3ffa5597eb929a0a2a805bb64abb544e718bdeac01d7a8df99b1918e73aa27bcf45e447706fa70ec230093363832d8e926d8a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8a3286f89545927d5508fe76c13e1d240936e1f80f3252ecee82e9995acd83aeb42dd4514074c8988b1dc20a240ff033cb84738ef2e924821364d59984c9423"} 03:49:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:17 INFO - Contents: 03:49:17 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8041dd18c0869bf13e987f13bb425da1526413a49e2cba4d0fa38db486836347ffaef5a4db65e016460f7d9b95f4d467202ec7e47e3b416caddb0175037a9177", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee23e6b04e2e93c498c86e93a2a4475ff515b516bb0408e4f6cfc3d711e7d5f9135eeb55fee6d2ebfdd8c649c8b38ac41f3c268dfa06a5c34909e46ee44338d7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/665f9a9d6296d41128549eb71a3ffa5597eb929a0a2a805bb64abb544e718bdeac01d7a8df99b1918e73aa27bcf45e447706fa70ec230093363832d8e926d8a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8a3286f89545927d5508fe76c13e1d240936e1f80f3252ecee82e9995acd83aeb42dd4514074c8988b1dc20a240ff033cb84738ef2e924821364d59984c9423"} 03:49:17 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:17 INFO - Copying logs to upload dir... 03:49:17 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.462567 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-07-27 03:49:16.884666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 03:49:16.888225) ========= 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=ea65d483da93c827905c2090000001f5-1501151083.670985-891645176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8041dd18c0869bf13e987f13bb425da1526413a49e2cba4d0fa38db486836347ffaef5a4db65e016460f7d9b95f4d467202ec7e47e3b416caddb0175037a9177", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee23e6b04e2e93c498c86e93a2a4475ff515b516bb0408e4f6cfc3d711e7d5f9135eeb55fee6d2ebfdd8c649c8b38ac41f3c268dfa06a5c34909e46ee44338d7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/665f9a9d6296d41128549eb71a3ffa5597eb929a0a2a805bb64abb544e718bdeac01d7a8df99b1918e73aa27bcf45e447706fa70ec230093363832d8e926d8a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8a3286f89545927d5508fe76c13e1d240936e1f80f3252ecee82e9995acd83aeb42dd4514074c8988b1dc20a240ff033cb84738ef2e924821364d59984c9423"} build_url:https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/Zk7GsjBISvCpcBODtgZIjg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8041dd18c0869bf13e987f13bb425da1526413a49e2cba4d0fa38db486836347ffaef5a4db65e016460f7d9b95f4d467202ec7e47e3b416caddb0175037a9177", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ee23e6b04e2e93c498c86e93a2a4475ff515b516bb0408e4f6cfc3d711e7d5f9135eeb55fee6d2ebfdd8c649c8b38ac41f3c268dfa06a5c34909e46ee44338d7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/665f9a9d6296d41128549eb71a3ffa5597eb929a0a2a805bb64abb544e718bdeac01d7a8df99b1918e73aa27bcf45e447706fa70ec230093363832d8e926d8a3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8a3286f89545927d5508fe76c13e1d240936e1f80f3252ecee82e9995acd83aeb42dd4514074c8988b1dc20a240ff033cb84738ef2e924821364d59984c9423"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 03:49:16.912378) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 03:49:16.912676) ========= 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=ea65d483da93c827905c2090000001f5-1501151083.670985-891645176 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004576 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 03:49:16.996724) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 03:49:16.997055) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 03:49:16.997348) ========= ========= Total master_lag: 0.15 =========