builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1501199564.04 results: success (0) revision: 0aab101edb50b91aa1c16b372fab382a60137482 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 16:52:44.041116) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 16:52:44.041514) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 16:52:44.041888) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 16:52:44.122996) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:52:44.123267) ========= 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=923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-27 16:52:44-- 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% 226M=0s 2017-07-27 16:52:44 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076598 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:52:44.213763) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:52:44.217113) ========= 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=923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015479 ========= master_lag: 0.14 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 16:52:44.367828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-27 16:52:44.368162) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0aab101edb50b91aa1c16b372fab382a60137482 --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 0aab101edb50b91aa1c16b372fab382a60137482 --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=923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-27 16:52:44,607 truncating revision to first 12 chars 2017-07-27 16:52:44,607 Setting DEBUG logging. 2017-07-27 16:52:44,607 attempt 1/10 2017-07-27 16:52:44,607 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0aab101edb50?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-27 16:52:45,735 unpacking tar archive at: mozilla-central-0aab101edb50/testing/mozharness/ program finished with exit code 0 elapsedTime=1.436421 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-27 16:52:45.843218) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 16:52:45.843519) ========= script_repo_revision: 0aab101edb50b91aa1c16b372fab382a60137482 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 16:52:45.843905) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 16:52:45.844172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 16:52:45.859320) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-27 16:52:45.859695) ========= /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=923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:52:46 INFO - MultiFileLogger online at 20170727 16:52:46 in /builds/slave/test 16:52:46 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 16:52:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:52:46 INFO - {'append_to_log': False, 16:52:46 INFO - 'base_work_dir': '/builds/slave/test', 16:52:46 INFO - 'blob_upload_branch': 'Firefox', 16:52:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:52:46 INFO - 'branch': 'Firefox', 16:52:46 INFO - 'buildbot_json_path': 'buildprops.json', 16:52:46 INFO - 'code_coverage': False, 16:52:46 INFO - 'config_files': ('talos/linux_config.py',), 16:52:46 INFO - 'default_actions': ('clobber', 16:52:46 INFO - 'read-buildbot-config', 16:52:46 INFO - 'download-and-extract', 16:52:46 INFO - 'populate-webroot', 16:52:46 INFO - 'create-virtualenv', 16:52:46 INFO - 'install', 16:52:46 INFO - 'setup-mitmproxy', 16:52:46 INFO - 'run-tests'), 16:52:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:52:46 INFO - 'disable_ccov_upload': False, 16:52:46 INFO - 'download_minidump_stackwalk': True, 16:52:46 INFO - 'download_symbols': 'ondemand', 16:52:46 INFO - 'enable_stylo': False, 16:52:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:52:46 INFO - 'tooltool.py': '/tools/tooltool.py', 16:52:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:52:46 INFO - '/tools/misc-python/virtualenv.py')}, 16:52:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:52:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:52:46 INFO - 'gecko_profile': False, 16:52:46 INFO - 'gecko_profile_interval': 0, 16:52:46 INFO - 'installer_path': 'installer.exe', 16:52:46 INFO - 'log_level': 'info', 16:52:46 INFO - 'log_name': 'talos', 16:52:46 INFO - 'log_to_console': True, 16:52:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:52:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:52:46 INFO - 'opt_config_files': (), 16:52:46 INFO - 'pip_index': False, 16:52:46 INFO - 'suite': 'dromaeojs-e10s', 16:52:46 INFO - 'system_bits': '32', 16:52:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:52:46 INFO - 'title': 'talos-linux64-ix-007', 16:52:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:52:46 INFO - 'use_talos_json': True, 16:52:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:52:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:52:46 INFO - 'work_dir': 'build'} 16:52:46 INFO - [mozharness: 2017-07-27 23:52:46.184041Z] Running clobber step. 16:52:46 INFO - Running pre-action listener: _resource_record_pre_action 16:52:46 INFO - Running main action method: clobber 16:52:46 INFO - rmtree: /builds/slave/test/build 16:52:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:52:47 INFO - Running post-action listener: _resource_record_post_action 16:52:47 INFO - [mozharness: 2017-07-27 23:52:47.719666Z] Finished clobber step (success) 16:52:47 INFO - [mozharness: 2017-07-27 23:52:47.719768Z] Running read-buildbot-config step. 16:52:47 INFO - Running pre-action listener: _resource_record_pre_action 16:52:47 INFO - Running main action method: read_buildbot_config 16:52:47 INFO - Using buildbot properties: 16:52:47 INFO - { 16:52:47 INFO - "project": "", 16:52:47 INFO - "product": "firefox", 16:52:47 INFO - "who": "kwierso@gmail.com", 16:52:47 INFO - "installer_path": "public/build/target.tar.bz2", 16:52:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:52:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:52:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 16:52:47 INFO - "stage_platform": "linux64-pgo", 16:52:47 INFO - "basedir": "/builds/slave/test", 16:52:47 INFO - "buildnumber": 96, 16:52:47 INFO - "platform": "ubuntu64_hw", 16:52:47 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:52:47 INFO - "slavebuilddir": "test", 16:52:47 INFO - "taskId": "ZYiUoIEnTIaZYQGLbMQ5ew", 16:52:47 INFO - "branch": "mozilla-central", 16:52:47 INFO - "script_repo_revision": "production", 16:52:47 INFO - "revision": "0aab101edb50b91aa1c16b372fab382a60137482", 16:52:47 INFO - "slavename": "talos-linux64-ix-007", 16:52:47 INFO - "repo_path": "mozilla-central" 16:52:47 INFO - } 16:52:47 INFO - Finding installer, test and symbols from parent task. 16:52:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYiUoIEnTIaZYQGLbMQ5ew'}, attempt #1 16:52:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZYiUoIEnTIaZYQGLbMQ5ew'}, attempt #1 16:52:48 INFO - Task dependencies: HDqwD3ttRVqDaEVaA2Dx2w 16:52:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w'}, attempt #1 16:52:49 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.tar.bz2 16:52:49 INFO - Set test_url: https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/test_packages.json 16:52:49 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.crashreporter-symbols.zip 16:52:49 INFO - Running post-action listener: _resource_record_post_action 16:52:49 INFO - [mozharness: 2017-07-27 23:52:49.067366Z] Finished read-buildbot-config step (success) 16:52:49 INFO - [mozharness: 2017-07-27 23:52:49.067592Z] Running download-and-extract step. 16:52:49 INFO - Running pre-action listener: _resource_record_pre_action 16:52:49 INFO - Running main action method: download_and_extract 16:52:49 INFO - mkdir: /builds/slave/test/build/tests 16:52:49 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')]} 16:52:49 INFO - trying https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.test_packages.json 16:52:49 INFO - Downloading https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:52:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:52:49 INFO - Downloaded 989 bytes. 16:52:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:52:49 INFO - Using the following test package requirements: 16:52:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:52:49 INFO - u'common': [u'target.common.tests.zip'], 16:52:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:52:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:52:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:52:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:52:49 INFO - u'mozbase': [u'target.common.tests.zip'], 16:52:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:52:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:52:49 INFO - u'web-platform': [u'target.common.tests.zip', 16:52:49 INFO - u'target.web-platform.tests.tar.gz'], 16:52:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:52:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:52:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.common.tests.zip 16:52:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:52:49 INFO - Fetch https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.common.tests.zip into memory 16:52:52 INFO - Content-Length response header: 73187433 16:52:52 INFO - Bytes received: 73187433 16:53:03 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:53:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.common.tests.zip 16:53:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:53:03 INFO - Fetch https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.common.tests.zip into memory 16:53:05 INFO - Content-Length response header: 73187433 16:53:05 INFO - Bytes received: 73187433 16:53:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.talos.tests.zip 16:53:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:53:17 INFO - Fetch https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.talos.tests.zip into memory 16:53:18 INFO - Content-Length response header: 14496465 16:53:18 INFO - Bytes received: 14496465 16:53:18 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')]} 16:53:18 INFO - trying https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.tar.bz2 16:53:18 INFO - Downloading https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:53:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:53:21 INFO - Downloaded 63052850 bytes. 16:53:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.tar.bz2 16:53:21 INFO - mkdir: /builds/slave/test/properties 16:53:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:53:21 INFO - Writing to file /builds/slave/test/properties/build_url 16:53:21 INFO - Contents: 16:53:21 INFO - build_url:https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.tar.bz2 16:53:21 INFO - Running post-action listener: _resource_record_post_action 16:53:21 INFO - Running post-action listener: set_extra_try_arguments 16:53:21 INFO - [mozharness: 2017-07-27 23:53:21.186539Z] Finished download-and-extract step (success) 16:53:21 INFO - [mozharness: 2017-07-27 23:53:21.186769Z] Running populate-webroot step. 16:53:21 INFO - Running pre-action listener: _resource_record_pre_action 16:53:21 INFO - Running main action method: populate_webroot 16:53:21 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:53:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:53:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:53:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:53:21 INFO - 'tests': ['damp', 'tps']}, 16:53:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:53:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:53:21 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:53:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:53:21 INFO - 'other-e10s': {'tests': ['a11yr', 16:53:21 INFO - 'ts_paint', 16:53:21 INFO - 'tpaint', 16:53:21 INFO - 'sessionrestore', 16:53:21 INFO - 'sessionrestore_many_windows', 16:53:21 INFO - 'sessionrestore_no_auto_restore', 16:53:21 INFO - 'tabpaint']}, 16:53:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:53:21 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:53:21 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:53:21 INFO - 'talos_options': ['--mitmproxy', 16:53:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:53:21 INFO - '--firstNonBlankPaint'], 16:53:21 INFO - 'tests': ['quantum_pageload_google', 16:53:21 INFO - 'quantum_pageload_youtube', 16:53:21 INFO - 'quantum_pageload_amazon', 16:53:21 INFO - 'quantum_pageload_facebook']}, 16:53:21 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:53:21 INFO - 'talos_options': ['--stylo', 16:53:21 INFO - '--mitmproxy', 16:53:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:53:21 INFO - '--firstNonBlankPaint'], 16:53:21 INFO - 'tests': ['quantum_pageload_google', 16:53:21 INFO - 'quantum_pageload_youtube', 16:53:21 INFO - 'quantum_pageload_amazon', 16:53:21 INFO - 'quantum_pageload_facebook']}, 16:53:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:53:21 INFO - 'tsvgr_opacity', 16:53:21 INFO - 'tart', 16:53:21 INFO - 'tscrollx', 16:53:21 INFO - 'cart', 16:53:21 INFO - 'tsvg_static']}, 16:53:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:53:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:53:21 INFO - 'talos_options': ['--xperf_path', 16:53:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:21 INFO - 'tests': ['tp5n']}}} 16:53:21 INFO - Running post-action listener: _resource_record_post_action 16:53:21 INFO - [mozharness: 2017-07-27 23:53:21.200552Z] Finished populate-webroot step (success) 16:53:21 INFO - [mozharness: 2017-07-27 23:53:21.200644Z] Running create-virtualenv step. 16:53:21 INFO - Running pre-action listener: _resource_record_pre_action 16:53:21 INFO - Running main action method: create_virtualenv 16:53:21 INFO - Creating virtualenv /builds/slave/test/build/venv 16:53:21 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 16:53:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:53:21 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:53:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:53:21 INFO - Using real prefix '/usr' 16:53:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:53:21 INFO - Installing distribute.............................................................................................................................................................................................done. 16:53:23 INFO - Installing pip.................done. 16:53:23 INFO - Return code: 0 16:53:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:53:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:53:23 INFO - Reading from file tmpfile_stdout 16:53:23 INFO - Output received: 16:53:23 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) 16:53:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:53:23 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')]} 16:53:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:23 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')]} 16:53:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:23 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 0x1a7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dead10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de7eb0>, '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 0x1de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9240>, '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': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', '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 16:53:23 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 16:53:23 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 16:53:23 INFO - Using env: {'DISPLAY': ':0', 16:53:23 INFO - 'HOME': '/home/cltbld', 16:53:23 INFO - 'LANG': 'en_US.UTF-8', 16:53:23 INFO - 'LANGUAGE': 'en_US:en', 16:53:23 INFO - 'LOGNAME': 'cltbld', 16:53:23 INFO - 'MAIL': '/var/mail/cltbld', 16:53:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:23 INFO - 'MOZ_NO_REMOTE': '1', 16:53:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:23 INFO - 'NO_EM_RESTART': '1', 16:53:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:23 INFO - 'PWD': '/builds/slave/test', 16:53:23 INFO - 'SHELL': '/bin/bash', 16:53:23 INFO - 'SHLVL': '1', 16:53:23 INFO - 'TERM': 'linux', 16:53:23 INFO - 'TMOUT': '86400', 16:53:23 INFO - 'USER': 'cltbld', 16:53:23 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', 16:53:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:23 INFO - '_': '/tools/buildbot/bin/python'} 16:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:24 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 16:53:24 INFO - Cleaning up... 16:53:24 INFO - Return code: 0 16:53:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:53: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')]} 16:53:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53: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')]} 16:53:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:24 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 0x1a7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dead10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de7eb0>, '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 0x1de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9240>, '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': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', '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 16:53:24 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 16:53:24 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 16:53:24 INFO - Using env: {'DISPLAY': ':0', 16:53:24 INFO - 'HOME': '/home/cltbld', 16:53:24 INFO - 'LANG': 'en_US.UTF-8', 16:53:24 INFO - 'LANGUAGE': 'en_US:en', 16:53:24 INFO - 'LOGNAME': 'cltbld', 16:53:24 INFO - 'MAIL': '/var/mail/cltbld', 16:53:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:24 INFO - 'MOZ_NO_REMOTE': '1', 16:53:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:24 INFO - 'NO_EM_RESTART': '1', 16:53:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:24 INFO - 'PWD': '/builds/slave/test', 16:53:24 INFO - 'SHELL': '/bin/bash', 16:53:24 INFO - 'SHLVL': '1', 16:53:24 INFO - 'TERM': 'linux', 16:53:24 INFO - 'TMOUT': '86400', 16:53:24 INFO - 'USER': 'cltbld', 16:53:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', 16:53:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:24 INFO - '_': '/tools/buildbot/bin/python'} 16:53:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:24 INFO - Downloading/unpacking psutil>=3.1.1 16:53:24 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 16:53:24 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 16:53:24 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 16:53:24 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 16:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:53:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:25 INFO - Installing collected packages: psutil 16:53:25 INFO - Running setup.py install for psutil 16:53:25 INFO - building 'psutil._psutil_linux' extension 16:53:25 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 16:53:25 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 16:53:25 INFO - building 'psutil._psutil_posix' extension 16:53:25 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 16:53:25 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 16:53:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:53:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:53:26 INFO - Successfully installed psutil 16:53:26 INFO - Cleaning up... 16:53:26 INFO - Return code: 0 16:53:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dead10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de7eb0>, '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 0x1de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9240>, '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': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', '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 16:53:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:53:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:53:26 INFO - Using env: {'DISPLAY': ':0', 16:53:26 INFO - 'HOME': '/home/cltbld', 16:53:26 INFO - 'LANG': 'en_US.UTF-8', 16:53:26 INFO - 'LANGUAGE': 'en_US:en', 16:53:26 INFO - 'LOGNAME': 'cltbld', 16:53:26 INFO - 'MAIL': '/var/mail/cltbld', 16:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:26 INFO - 'MOZ_NO_REMOTE': '1', 16:53:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:26 INFO - 'NO_EM_RESTART': '1', 16:53:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:26 INFO - 'PWD': '/builds/slave/test', 16:53:26 INFO - 'SHELL': '/bin/bash', 16:53:26 INFO - 'SHLVL': '1', 16:53:26 INFO - 'TERM': 'linux', 16:53:26 INFO - 'TMOUT': '86400', 16:53:26 INFO - 'USER': 'cltbld', 16:53:26 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', 16:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:26 INFO - '_': '/tools/buildbot/bin/python'} 16:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:53:26 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 16:53:26 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 16:53:26 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 16:53:26 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 16:53:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:53:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:53:27 INFO - Installing collected packages: mozsystemmonitor 16:53:27 INFO - Running setup.py install for mozsystemmonitor 16:53:27 INFO - Successfully installed mozsystemmonitor 16:53:27 INFO - Cleaning up... 16:53:27 INFO - Return code: 0 16:53:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dead10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de7eb0>, '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 0x1de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9240>, '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': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', '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 16:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:53:27 INFO - Using env: {'DISPLAY': ':0', 16:53:27 INFO - 'HOME': '/home/cltbld', 16:53:27 INFO - 'LANG': 'en_US.UTF-8', 16:53:27 INFO - 'LANGUAGE': 'en_US:en', 16:53:27 INFO - 'LOGNAME': 'cltbld', 16:53:27 INFO - 'MAIL': '/var/mail/cltbld', 16:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:27 INFO - 'MOZ_NO_REMOTE': '1', 16:53:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:27 INFO - 'NO_EM_RESTART': '1', 16:53:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:27 INFO - 'PWD': '/builds/slave/test', 16:53:27 INFO - 'SHELL': '/bin/bash', 16:53:27 INFO - 'SHLVL': '1', 16:53:27 INFO - 'TERM': 'linux', 16:53:27 INFO - 'TMOUT': '86400', 16:53:27 INFO - 'USER': 'cltbld', 16:53:27 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', 16:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:27 INFO - '_': '/tools/buildbot/bin/python'} 16:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:27 INFO - Downloading/unpacking jsonschema==2.5.1 16:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:53:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:53:28 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 16:53:28 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 16:53:28 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 16:53:28 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 16:53:29 INFO - Downloading functools32-3.2.3-2.tar.gz 16:53:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:53:29 INFO - warning: no files found matching '*.txt' 16:53:29 INFO - no previously-included directories found matching 'build' 16:53:29 INFO - no previously-included directories found matching 'dist' 16:53:29 INFO - no previously-included directories found matching '.git*' 16:53:29 INFO - Installing collected packages: jsonschema, functools32 16:53:29 INFO - Running setup.py install for functools32 16:53:29 INFO - warning: no files found matching '*.txt' 16:53:29 INFO - no previously-included directories found matching 'build' 16:53:29 INFO - no previously-included directories found matching 'dist' 16:53:29 INFO - no previously-included directories found matching '.git*' 16:53:29 INFO - Successfully installed jsonschema functools32 16:53:29 INFO - Cleaning up... 16:53:29 INFO - Return code: 0 16:53:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:53:29 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')]} 16:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:29 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')]} 16:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:29 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 0x1a7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dead10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de7eb0>, '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 0x1de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9240>, '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': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', '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 16:53:29 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 16:53:29 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 16:53:29 INFO - Using env: {'DISPLAY': ':0', 16:53:29 INFO - 'HOME': '/home/cltbld', 16:53:29 INFO - 'LANG': 'en_US.UTF-8', 16:53:29 INFO - 'LANGUAGE': 'en_US:en', 16:53:29 INFO - 'LOGNAME': 'cltbld', 16:53:29 INFO - 'MAIL': '/var/mail/cltbld', 16:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:29 INFO - 'MOZ_NO_REMOTE': '1', 16:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:29 INFO - 'NO_EM_RESTART': '1', 16:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:29 INFO - 'PWD': '/builds/slave/test', 16:53:29 INFO - 'SHELL': '/bin/bash', 16:53:29 INFO - 'SHLVL': '1', 16:53:29 INFO - 'TERM': 'linux', 16:53:29 INFO - 'TMOUT': '86400', 16:53:29 INFO - 'USER': 'cltbld', 16:53:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', 16:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:29 INFO - '_': '/tools/buildbot/bin/python'} 16:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:53:29 INFO - Cleaning up... 16:53:29 INFO - Return code: 0 16:53:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:53:29 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')]} 16:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:29 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')]} 16:53:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:29 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 0x1a7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dead10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de7eb0>, '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 0x1de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9240>, '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': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', '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 16:53:29 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 16:53:29 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 16:53:29 INFO - Using env: {'DISPLAY': ':0', 16:53:29 INFO - 'HOME': '/home/cltbld', 16:53:29 INFO - 'LANG': 'en_US.UTF-8', 16:53:29 INFO - 'LANGUAGE': 'en_US:en', 16:53:29 INFO - 'LOGNAME': 'cltbld', 16:53:29 INFO - 'MAIL': '/var/mail/cltbld', 16:53:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:29 INFO - 'MOZ_NO_REMOTE': '1', 16:53:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:29 INFO - 'NO_EM_RESTART': '1', 16:53:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:29 INFO - 'PWD': '/builds/slave/test', 16:53:29 INFO - 'SHELL': '/bin/bash', 16:53:29 INFO - 'SHLVL': '1', 16:53:29 INFO - 'TERM': 'linux', 16:53:29 INFO - 'TMOUT': '86400', 16:53:29 INFO - 'USER': 'cltbld', 16:53:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', 16:53:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:29 INFO - '_': '/tools/buildbot/bin/python'} 16:53:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:29 INFO - Downloading/unpacking blobuploader==1.2.4 16:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:30 INFO - Downloading blobuploader-1.2.4.tar.gz 16:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:53:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:53:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:31 INFO - Downloading docopt-0.6.1.tar.gz 16:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:53:31 INFO - Installing collected packages: blobuploader, requests, docopt 16:53:31 INFO - Running setup.py install for blobuploader 16:53:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:53:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:53:31 INFO - Running setup.py install for requests 16:53:31 INFO - Running setup.py install for docopt 16:53:31 INFO - Successfully installed blobuploader requests docopt 16:53:31 INFO - Cleaning up... 16:53:31 INFO - Return code: 0 16:53:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:31 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 0x1a7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dead10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de7eb0>, '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 0x1de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9240>, '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': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', '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 16:53:31 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 16:53:31 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 16:53:31 INFO - Using env: {'DISPLAY': ':0', 16:53:31 INFO - 'HOME': '/home/cltbld', 16:53:31 INFO - 'LANG': 'en_US.UTF-8', 16:53:31 INFO - 'LANGUAGE': 'en_US:en', 16:53:31 INFO - 'LOGNAME': 'cltbld', 16:53:31 INFO - 'MAIL': '/var/mail/cltbld', 16:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:31 INFO - 'MOZ_NO_REMOTE': '1', 16:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:31 INFO - 'NO_EM_RESTART': '1', 16:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:31 INFO - 'PWD': '/builds/slave/test', 16:53:31 INFO - 'SHELL': '/bin/bash', 16:53:31 INFO - 'SHLVL': '1', 16:53:31 INFO - 'TERM': 'linux', 16:53:31 INFO - 'TMOUT': '86400', 16:53:31 INFO - 'USER': 'cltbld', 16:53:31 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', 16:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:31 INFO - '_': '/tools/buildbot/bin/python'} 16:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:32 INFO - Running setup.py (path:/tmp/pip-IcYoJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:32 INFO - Running setup.py (path:/tmp/pip-CrDRrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:32 INFO - Running setup.py (path:/tmp/pip-Q0IJUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:32 INFO - Running setup.py (path:/tmp/pip-h0gJFz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:32 INFO - Running setup.py (path:/tmp/pip-xRRoRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:32 INFO - Running setup.py (path:/tmp/pip-N7dFV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:32 INFO - Running setup.py (path:/tmp/pip-VLMRjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:32 INFO - Running setup.py (path:/tmp/pip-4xzQhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:32 INFO - Running setup.py (path:/tmp/pip-RYQXel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:32 INFO - Running setup.py (path:/tmp/pip-38wsB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:32 INFO - Running setup.py (path:/tmp/pip-rtJvK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:32 INFO - Running setup.py (path:/tmp/pip-hLMews-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:33 INFO - Running setup.py (path:/tmp/pip-cHe27k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:33 INFO - Running setup.py (path:/tmp/pip-rmI8PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:33 INFO - Running setup.py (path:/tmp/pip-ar7CX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:33 INFO - Running setup.py (path:/tmp/pip-mpBuzX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:33 INFO - Running setup.py (path:/tmp/pip-ATI8cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:53:33 INFO - Running setup.py install for manifestparser 16:53:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:53:33 INFO - Running setup.py install for mozcrash 16:53:33 INFO - Running setup.py install for mozdebug 16:53:33 INFO - Running setup.py install for mozdevice 16:53:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:53:33 INFO - Running setup.py install for mozfile 16:53:33 INFO - Running setup.py install for mozhttpd 16:53:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:53:33 INFO - Running setup.py install for mozinfo 16:53:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:53:34 INFO - Running setup.py install for mozInstall 16:53:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:53:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:53:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:53:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:53:34 INFO - Running setup.py install for mozleak 16:53:34 INFO - Running setup.py install for mozlog 16:53:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:53:34 INFO - Running setup.py install for moznetwork 16:53:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:53:34 INFO - Running setup.py install for mozprocess 16:53:34 INFO - Running setup.py install for mozprofile 16:53:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:53:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:53:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:53:34 INFO - Running setup.py install for mozrunner 16:53:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:53:34 INFO - Running setup.py install for mozscreenshot 16:53:34 INFO - Running setup.py install for moztest 16:53:35 INFO - Running setup.py install for mozversion 16:53:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:53:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:53:35 INFO - Cleaning up... 16:53:35 INFO - Return code: 0 16:53:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:35 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 0x1a7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dead10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de7eb0>, '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 0x1de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9240>, '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': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', '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 16:53:35 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 16:53:35 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 16:53:35 INFO - Using env: {'DISPLAY': ':0', 16:53:35 INFO - 'HOME': '/home/cltbld', 16:53:35 INFO - 'LANG': 'en_US.UTF-8', 16:53:35 INFO - 'LANGUAGE': 'en_US:en', 16:53:35 INFO - 'LOGNAME': 'cltbld', 16:53:35 INFO - 'MAIL': '/var/mail/cltbld', 16:53:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:35 INFO - 'MOZ_NO_REMOTE': '1', 16:53:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:35 INFO - 'NO_EM_RESTART': '1', 16:53:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:35 INFO - 'PWD': '/builds/slave/test', 16:53:35 INFO - 'SHELL': '/bin/bash', 16:53:35 INFO - 'SHLVL': '1', 16:53:35 INFO - 'TERM': 'linux', 16:53:35 INFO - 'TMOUT': '86400', 16:53:35 INFO - 'USER': 'cltbld', 16:53:35 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', 16:53:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:35 INFO - '_': '/tools/buildbot/bin/python'} 16:53:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:53:35 INFO - Running setup.py (path:/tmp/pip-d2X0xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:53:35 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)) 16:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:53:35 INFO - Running setup.py (path:/tmp/pip-yry1iu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:53:35 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)) 16:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:53:35 INFO - Running setup.py (path:/tmp/pip-ql3Kd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:53:35 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)) 16:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:53:35 INFO - Running setup.py (path:/tmp/pip-7fmKym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:53:35 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)) 16:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:53:35 INFO - Running setup.py (path:/tmp/pip-crXFFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:53:35 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)) 16:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:53:35 INFO - Running setup.py (path:/tmp/pip-gLDaZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:53:35 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)) 16:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:53:35 INFO - Running setup.py (path:/tmp/pip-nyGbgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:53:35 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)) 16:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:53:35 INFO - Running setup.py (path:/tmp/pip-PDpPmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:53:35 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)) 16:53:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:53:35 INFO - Running setup.py (path:/tmp/pip-aigSeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:53:36 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)) 16:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:53:36 INFO - Running setup.py (path:/tmp/pip-_Y1WGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:53:36 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)) 16:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:53:36 INFO - Running setup.py (path:/tmp/pip-nWpOld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:53:36 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)) 16:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:53:36 INFO - Running setup.py (path:/tmp/pip-BKqiJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:53:36 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)) 16:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:53:36 INFO - Running setup.py (path:/tmp/pip-F3PtPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:53:36 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)) 16:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:53:36 INFO - Running setup.py (path:/tmp/pip-pLbmZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:53:36 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)) 16:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:36 INFO - Running setup.py (path:/tmp/pip-0SeRih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:53:36 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)) 16:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:53:36 INFO - Running setup.py (path:/tmp/pip-QPxvGZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:53:36 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)) 16:53:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:53:36 INFO - Running setup.py (path:/tmp/pip-oRcWGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:53:36 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)) 16:53:36 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)) 16:53:36 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)) 16:53:36 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)) 16:53:36 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)) 16:53:36 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)) 16:53:36 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)) 16:53:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:53:36 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 16:53:36 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 16:53:36 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 16:53:36 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 16:53:37 INFO - Downloading blessings-1.6.tar.gz 16:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:53:37 INFO - Installing collected packages: blessings 16:53:37 INFO - Running setup.py install for blessings 16:53:37 INFO - Successfully installed blessings 16:53:37 INFO - Cleaning up... 16:53:37 INFO - Return code: 0 16:53:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:53:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:38 INFO - Reading from file tmpfile_stdout 16:53:38 INFO - Current package versions: 16:53:38 INFO - argparse == 1.2.1 16:53:38 INFO - blessings == 1.6 16:53:38 INFO - blobuploader == 1.2.4 16:53:38 INFO - docopt == 0.6.1 16:53:38 INFO - functools32 == 3.2.3-2 16:53:38 INFO - jsonschema == 2.5.1 16:53:38 INFO - manifestparser == 1.1 16:53:38 INFO - mozInstall == 1.13 16:53:38 INFO - mozcrash == 1.0 16:53:38 INFO - mozdebug == 0.1 16:53:38 INFO - mozdevice == 0.51 16:53:38 INFO - mozfile == 1.2 16:53:38 INFO - mozhttpd == 0.7 16:53:38 INFO - mozinfo == 0.10 16:53:38 INFO - mozleak == 0.1 16:53:38 INFO - mozlog == 3.5 16:53:38 INFO - moznetwork == 0.27 16:53:38 INFO - mozprocess == 0.25 16:53:38 INFO - mozprofile == 0.28 16:53:38 INFO - mozrunner == 6.13 16:53:38 INFO - mozscreenshot == 0.1 16:53:38 INFO - mozsystemmonitor == 0.3 16:53:38 INFO - moztest == 0.8 16:53:38 INFO - mozversion == 1.4 16:53:38 INFO - psutil == 3.1.1 16:53:38 INFO - requests == 1.2.3 16:53:38 INFO - wsgiref == 0.1.2 16:53:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:38 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 0x1a7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dead10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de7eb0>, '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 0x1de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9240>, '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': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', '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 16:53:38 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 16:53:38 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 16:53:38 INFO - Using env: {'DISPLAY': ':0', 16:53:38 INFO - 'HOME': '/home/cltbld', 16:53:38 INFO - 'LANG': 'en_US.UTF-8', 16:53:38 INFO - 'LANGUAGE': 'en_US:en', 16:53:38 INFO - 'LOGNAME': 'cltbld', 16:53:38 INFO - 'MAIL': '/var/mail/cltbld', 16:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:38 INFO - 'MOZ_NO_REMOTE': '1', 16:53:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:38 INFO - 'NO_EM_RESTART': '1', 16:53:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:38 INFO - 'PWD': '/builds/slave/test', 16:53:38 INFO - 'SHELL': '/bin/bash', 16:53:38 INFO - 'SHLVL': '1', 16:53:38 INFO - 'TERM': 'linux', 16:53:38 INFO - 'TMOUT': '86400', 16:53:38 INFO - 'USER': 'cltbld', 16:53:38 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', 16:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:38 INFO - '_': '/tools/buildbot/bin/python'} 16:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:38 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)) 16:53:38 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)) 16:53:38 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)) 16:53:38 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)) 16:53:38 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)) 16:53:38 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)) 16:53:38 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)) 16:53:38 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)) 16:53:38 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)) 16:53:38 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:53:38 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 16:53:38 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 16:53:38 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 16:53:38 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 16:53:39 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:53:39 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 16:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:53:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:53:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:53:39 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)) 16:53:39 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)) 16:53:39 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)) 16:53:39 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)) 16:53:39 INFO - Installing collected packages: marionette-driver, simplejson 16:53:39 INFO - Running setup.py install for marionette-driver 16:53:39 INFO - Running setup.py install for simplejson 16:53:39 INFO - building 'simplejson._speedups' extension 16:53:39 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 16:53:40 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 16:53:40 INFO - Successfully installed marionette-driver simplejson 16:53:40 INFO - Cleaning up... 16:53:40 INFO - Return code: 0 16:53:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:40 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 0x1a7b1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c47a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dead10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1de7eb0>, '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 0x1de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9240>, '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': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', '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 16:53:40 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 16:53:40 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 16:53:40 INFO - Using env: {'DISPLAY': ':0', 16:53:40 INFO - 'HOME': '/home/cltbld', 16:53:40 INFO - 'LANG': 'en_US.UTF-8', 16:53:40 INFO - 'LANGUAGE': 'en_US:en', 16:53:40 INFO - 'LOGNAME': 'cltbld', 16:53:40 INFO - 'MAIL': '/var/mail/cltbld', 16:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:40 INFO - 'MOZ_NO_REMOTE': '1', 16:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:40 INFO - 'NO_EM_RESTART': '1', 16:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:40 INFO - 'PWD': '/builds/slave/test', 16:53:40 INFO - 'SHELL': '/bin/bash', 16:53:40 INFO - 'SHLVL': '1', 16:53:40 INFO - 'TERM': 'linux', 16:53:40 INFO - 'TMOUT': '86400', 16:53:40 INFO - 'USER': 'cltbld', 16:53:40 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', 16:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:40 INFO - '_': '/tools/buildbot/bin/python'} 16:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:53:41 INFO - Cleaning up... 16:53:41 INFO - Return code: 0 16:53:41 INFO - Running post-action listener: _resource_record_post_action 16:53:41 INFO - Running post-action listener: _start_resource_monitoring 16:53:41 INFO - Starting resource monitoring. 16:53:41 INFO - [mozharness: 2017-07-27 23:53:41.182780Z] Finished create-virtualenv step (success) 16:53:41 INFO - [mozharness: 2017-07-27 23:53:41.183252Z] Running install step. 16:53:41 INFO - Running pre-action listener: _resource_record_pre_action 16:53:41 INFO - Running main action method: install 16:53:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:53:41 INFO - Reading from file tmpfile_stdout 16:53:41 INFO - Detecting whether we're running mozinstall >=1.0... 16:53:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:53:41 INFO - Reading from file tmpfile_stdout 16:53:41 INFO - Output received: 16:53:41 INFO - Usage: mozinstall [options] installer 16:53:41 INFO - Options: 16:53:41 INFO - -h, --help show this help message and exit 16:53:41 INFO - -d DEST, --destination=DEST 16:53:41 INFO - Directory to install application into. [default: 16:53:41 INFO - "/builds/slave/test"] 16:53:41 INFO - --app=APP Application being installed. [default: firefox] 16:53:41 INFO - mkdir: /builds/slave/test/build/application 16:53:41 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'] 16:53:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:53:59 INFO - Reading from file tmpfile_stdout 16:53:59 INFO - Output received: 16:53:59 INFO - /builds/slave/test/build/application/firefox/firefox 16:53:59 INFO - Running post-action listener: _resource_record_post_action 16:53:59 INFO - [mozharness: 2017-07-27 23:53:59.359720Z] Finished install step (success) 16:53:59 INFO - [mozharness: 2017-07-27 23:53:59.360064Z] Running setup-mitmproxy step. 16:53:59 INFO - Running pre-action listener: _resource_record_pre_action 16:53:59 INFO - Running main action method: setup_mitmproxy 16:53:59 INFO - Skipping: mitmproxy is not required 16:53:59 INFO - Running post-action listener: _resource_record_post_action 16:53:59 INFO - [mozharness: 2017-07-27 23:53:59.361758Z] Finished setup-mitmproxy step (success) 16:53:59 INFO - [mozharness: 2017-07-27 23:53:59.362075Z] Running run-tests step. 16:53:59 INFO - Running pre-action listener: _resource_record_pre_action 16:53:59 INFO - Running pre-action listener: _set_gcov_prefix 16:53:59 INFO - Running main action method: run_tests 16:53:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:53:59 INFO - Python 2.7.3 16:53:59 INFO - Return code: 0 16:53:59 INFO - grabbing minidump binary from tooltool 16:53: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')]} 16:53:59 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 0x1de7eb0>, '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 0x1de8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1de9240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:53:59 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 16:53:59 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 16:53:59 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 16:53:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:53:59 INFO - Return code: 0 16:53:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:53:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:53:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:53:59 INFO - ENV: RUST_BACKTRACE is now 1 16:53:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:53:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:53:59 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/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 16:53:59 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/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 16:53:59 INFO - Using env: {'DISPLAY': ':0', 16:53:59 INFO - 'HOME': '/home/cltbld', 16:53:59 INFO - 'LANG': 'en_US.UTF-8', 16:53:59 INFO - 'LANGUAGE': 'en_US:en', 16:53:59 INFO - 'LOGNAME': 'cltbld', 16:53:59 INFO - 'MAIL': '/var/mail/cltbld', 16:53:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:53:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:59 INFO - 'MOZ_NO_REMOTE': '1', 16:53:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:59 INFO - 'NO_EM_RESTART': '1', 16:53:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:59 INFO - 'PWD': '/builds/slave/test', 16:53:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:53:59 INFO - 'RUST_BACKTRACE': '1', 16:53:59 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:53:59 INFO - 'SHELL': '/bin/bash', 16:53:59 INFO - 'SHLVL': '1', 16:53:59 INFO - 'TERM': 'linux', 16:53:59 INFO - 'TMOUT': '86400', 16:53:59 INFO - 'USER': 'cltbld', 16:53:59 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156', 16:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:59 INFO - '_': '/tools/buildbot/bin/python'} 16:53:59 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/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 16:53:59 INFO - mozversion application_buildid: 20170727224421 16:53:59 INFO - mozversion application_changeset: 0aab101edb50b91aa1c16b372fab382a60137482 16:53:59 INFO - mozversion application_display_name: Nightly 16:53:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:53:59 INFO - mozversion application_name: Firefox 16:53:59 INFO - mozversion application_remotingname: firefox 16:53:59 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:53:59 INFO - mozversion application_vendor: Mozilla 16:53:59 INFO - mozversion application_version: 56.0a1 16:53:59 INFO - mozversion platform_buildid: 20170727224421 16:53:59 INFO - mozversion platform_changeset: 0aab101edb50b91aa1c16b372fab382a60137482 16:53:59 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:53:59 INFO - mozversion platform_version: 56.0a1 16:53:59 INFO - using testdate: 1501199639 16:53:59 INFO - actual date: 1501199639 16:53:59 INFO - starting webserver on 'localhost:56959' 16:53:59 INFO - SUITE-START | Running 2 tests 16:53:59 INFO - TEST-START | dromaeo_css 16:53:59 INFO - Initialising browser for dromaeo_css test... 16:53:59 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56959/getInfo.html -profile /tmp/tmpxan03H/profile 16:53:59 INFO - TEST-INFO | started process 4078 (/builds/slave/test/build/application/firefox/firefox http://localhost:56959/getInfo.html) 16:54:05 INFO - TEST-INFO | 4078: exit 0 16:54:05 INFO - Browser initialized. 16:54:05 INFO - Running cycle 1/1 for dromaeo_css test... 16:54:05 INFO - TEST-INFO | started process 4291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxan03H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:54:06 INFO - PID 4291 | 16:54:06 INFO - PID 4291 | (/builds/slave/test/build/application/firefox/firefox:4340): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:54:06 INFO - PID 4291 | 16:54:16 INFO - PID 4291 | RSS: Main: 164102144 16:54:16 INFO - PID 4291 | 16:57:14 INFO - PID 4291 | Cycle 1(1): loaded http://localhost:56959/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56959/tests/dromaeo/cssquery-ext.html) 16:57:16 INFO - PID 4291 | RSS: Main: 165789696 16:57:16 INFO - PID 4291 | 17:00:17 INFO - PID 4291 | Cycle 1(1): loaded http://localhost:56959/tests/dromaeo/cssquery-ext.html (next: http://localhost:56959/tests/dromaeo/cssquery-jquery.html) 17:00:18 INFO - PID 4291 | RSS: Main: 163520512 17:00:18 INFO - PID 4291 | 17:03:20 INFO - PID 4291 | Cycle 1(1): loaded http://localhost:56959/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56959/tests/dromaeo/cssquery-mootools.html) 17:03:20 INFO - PID 4291 | RSS: Main: 165527552 17:03:20 INFO - PID 4291 | 17:06:22 INFO - PID 4291 | Cycle 1(1): loaded http://localhost:56959/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56959/tests/dromaeo/cssquery-prototype.html) 17:06:23 INFO - PID 4291 | RSS: Main: 164020224 17:06:23 INFO - PID 4291 | 17:09:26 INFO - PID 4291 | Cycle 1(1): loaded http://localhost:56959/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56959/tests/dromaeo/cssquery-yui.html) 17:09:27 INFO - PID 4291 | RSS: Main: 165146624 17:09:27 INFO - PID 4291 | 17:12:28 INFO - PID 4291 | Cycle 1(1): loaded http://localhost:56959/tests/dromaeo/cssquery-yui.html (next: http://localhost:56959/tests/dromaeo/cssquery-dojo.html) 17:12:28 INFO - PID 4291 | RSS: Main: 167964672 17:12:28 INFO - PID 4291 | 17:12:28 INFO - PID 4291 | __start_tp_report 17:12:28 INFO - PID 4291 | _x_x_mozilla_page_load 17:12:28 INFO - PID 4291 | _x_x_mozilla_page_load_details 17:12:28 INFO - PID 4291 | |i|pagename|runs| 17:12:28 INFO - PID 4291 | |0;dojo.html;3307.470804671253;3335.499675048744;3370.2585431205134;3374.460086386178;3413.1467133216697;6066.3630318816495;6143.416375444332;6152.630842149463;6152.630842149463;6160.26076870775;6250.8124756257275;6283.528735344845;6299.905501417483;6304.873902521947;6309.832680954015;5371.865703357428;5399.865003374908;5429.484199001088;5467.45325467452;5494.780208791643;5294.682319060868;5356.169793681966;5394.811181608645;5403.729813509329;5441.29263195786;5437.13005919053;5459.426760190182;5465.453454654523;5467;5479.123340265538;5414.269073675043;5427.158790387496;5431.864203394907;5498.45015498447;5504.6421982571;5344.198370244456;5353.946460535422;5355.7857685692525;5415.404305526428;5438.102713052342;6089.939100609025;6103.29812071613;6119.479844213247;6167.599106058092;6172.783952561639;6694.062831203635;6697.631630260334;6782.1861376635115;6788.558743681645;6790.287019862942;6733.192016957947;6748.6288254146;6751.961940591874;6767.255601883789;6790.083338749305;6244.531660125509;6296.370362963713;6302.621842689453;6324.209473815819;6324.841878953017;6865.382115609619;6892.689828957709;6953.756618518328;6958.234594194634;6972.058772065808;6512.706928188148;6568.146141001639;6579.605223686594;6582.24304205013;6609.3060228675295;6655.401013908771;6656.2345330287635;6658;6672.332766723289;6687.966560167168;6561.212654481493;6626.635535045619;6631.370019848203;6639.668016599151;6644.468442524683;6650.401463868178;6682.365175308338;6685.298043705438;6730.091437655951;6737.629430381278;4897.1674815281485;4897.314375987365;4907.018596280758;4910.533499317559;4912.656114072052;4285.185814695198;4297.119090586422;4344.47866256045;4359.084592235666;4367.45406824147;6317.684115794192;6404.423601875854;6412.5190610704385;6468.514861385415;6482.643454609947;6678.53250272486;6696.129503164655;6704.430123439464;6714.026466162379;6759.155105611799;6415.615063096229;6429.58207716497;6451.774187903495;6457.1605691260775;6479.967600161969;5519.558435325164;5520.503154716095;5584.888302233932;5595.272614560081;5596.552275817925;7051.576905385796;7074.92925070753;7092.574445533284;7169.89245161323;7186.7125314986815;6701.430378417694;6732.629705366252;6801.421879140131;6804.6257455840405;6808.5914845109455;7135.643217838983;7161.856762864818;7210.855782884418;7227.7108915644885;7246.7101315948885;6632.867342653023;6650.501212408992;6734.259231484631;6763.695633696594;6768.187817461936;6783.3555812197765;6783.966080169567;6874.9656251718425;6877.140357455318;6883.174019117738;6437.967810160919;6521.347865213441;6523.282438931808;6529.053287273224;6536.444402225674;6522.184726909137;6526.9020964686515;6603.669816509251;6608.471322294301;6620.271770105381;6570.244421891543;6574.638394888327;6579.736810527525;6591.835204119743;6595.604263744191;6501.739930402731;6567.277599464151;6633;6660.766873159416;6670.132882725215;6379.489640828815;6384.042393640991;6446.742130314735;6455;6457.741690332522 17:12:28 INFO - PID 4291 | |1;ext.html;846.7826835229821;896.3072142771778;903.345074820755;935.7567032571537;943.7829299261169;40478.79760601197;41141;41210;41220.79389603052;41268;39221.803890980504;39535;39572.802135989354;39574.60425395745;39596.20807583847;6516.413522782948;6573.704183311763;6574.2768295487695;6616.371444712769;6617.404433600975;6482.578632388903;6557.213134423852;6560.212774467071;6562.310957349481;6575.769848055319;6553.541252112354;7142.107236595426;7301.963490182568;7310.671019804095;7311.780646580611;7181.958616000651;7226.783196504113;7240.275972402744;7277.672504737299;7292.744753933587;6980.7905762827195;7096.893546596805;7112.608806515639;7126.643667816588;7161.641917904136;38161.42757858634;38494.230115397535;38520.229595408215;38587.22825543502;38624.80687596572;3377.5609170807884;3402.795832250073;3407.557017587698;3414.4878268259713;3414.6585341465902;30027.69972300271;30041.849790750908;30050.24874378136;30077.69922300771;30121.698783012107;4767.213409787381;4770.546798054179;4786.042791441726;4803.7357945313;4883.19427294496;190590;190974;193555.03222483938;194248;197616;49776.75111624419;49950;50119;50186.498135018184;50198;51396.22905656418;51549.74225128925;51583.48416515862;51620.48379516232;51666.74166629218;16096.356145754273;16155;16227.918860405622;16232.188390580424;16265.186740662919;13264.602061938158;13338.399772010283;13350.46598136083;13361.465541378237;13405.932970335087;14542.4910128145;14573.344199511048;14611.853881461262;14641.853581464262;14854.925725371304;5902.173695682608;5943.494802941712;5964.970175149097;5986.281646202484;6019.849503762441;1023.9162557899914;1052.5263631365763;1067.546292825546;1088.9945550272357;1092.186321190718;23485.825708714496;23915.40211494692;23949.640755388336;24267.39331516726;24277.393065173514;1139.8917102875214;1172.9941350293193;1174.653477224204;1179.7581495793343;1179.775842589905;16307.021578705315;16939.57651058709;17015.128335883044;17468.91265543664;17497.30010799554;254082;256413;258948;259472;259879;56679.71660141755;57147.714261428424;57584.424155758745;57614.42385576174;57769.711151443975;1434.8206474190727;1460.5107289058285;1490.7614781635102;1506.314626844805;1508.6228442889278;28650.713492864805;28955.855220723763;29082;29771.851140745024;29964.250893727833;51716.48283517117;52063;52137.47862521326;52137.7393113032;52200;226621;226701;228640;228977;229084;35294.64705352914;35437.291254174255;37365.81317093506;37611.81194094012;37683.81158094192;46073.53926460692;46081;46111.07777844492;46538.53461465342;46989.2951605733;32647.673523264464;33642;33747.493787593696;33901.81343652961;34420.65579344174;31002;33047.33905321928;33102.21625649531;33392.833035834665;33951.320973580885;39194.60805392024;39705;40163;40245.79877100596;40246.1950760989;32557;33558.49662255019;33954;33979.49030764491;34776;23458.530829383657;23562;23662.17182398608;23678.88160559186;23905.28284151478 17:12:28 INFO - PID 4291 | |2;jquery.html;568.4656422962418;574.5891687443477;585.3268740947908;586.8591538030871;593.5637306579663;22060.448488787788;22927.656085158716;23198.768012319873;23236.41908952279;23252.186173483933;25342.11302604409;27590.44819103617;27736.861315693393;27785.58321625172;27967.58048629267;6262.53031022674;6421.711023003976;6448.12950251717;6459.128017717619;6459.773907913224;6059.878802423971;6280.937190628104;6300.369963003709;6305.085762564426;6345.746170153211;6256;6257.593256438339;6259.937400625981;6262.624242545439;6266.6553339566535;6228.159198508189;6230.532710046765;6260.624362538262;6274.215723034644;6276.121343011982;5776.306843178803;5822.243108395882;5831;5841.707914604252;5846.123081537803;29687.10938671843;30493;31162;31349.84325078383;31377.686223137705;2097.2345094040716;2128.021110289269;2128.9787102128935;2131.9040643171093;2138.0485683870684;19259.90370048141;19848.503787405287;19885.105170267227;19942;19967.30114446002;2185.442712108418;2228.1755750372304;2229.487217939883;2256.537409830997;2281.885905704708;155327;159148;159222;159641.20179399144;159845;15343.386264549294;15790.210489475481;15986.680266394607;16041.278142483616;16377.91811040961;23895.52208955811;24883.377915551893;24925.252242432394;24975.5004899901;25032.624510632355;10438.425886576159;10742.462876856282;10767.3539587625;10858.619948301772;10902.890971090346;9823.950880245553;9893.653722119836;9989.60041598328;9994.950025249827;9997.300188986846;9527.237820974306;9852.655157069468;9877.012298770209;9971.152452041513;10018.3488073275;2774.403503246812;2825;2831.7734581233453;2848.3733578612673;2951.7343439090587;1025.620520407439;1035.295998720862;1042.2027149230844;1045.4720366215013;1058.9258751887294;20897.164113435596;21396.358109256747;21773.673394899088;25632.743672563407;27598.724012760016;1099.8680158381046;1103.823388257875;1121.0919155484085;1131.4399372310759;1146.7075895646724;11692.70768230801;13854.515091971733;14810.259487025605;15349.155796431303;15505.612359690873;570821;574678;575884;581565;588727;123262;129552.3522382382;139946;142267;143030;1295.4041141075022;1313.9145955513052;1333.1401246196149;1347.4475465059475;1360.326638314021;21443.67834482515;22015;22146;22294.888525557268;22529.549409012056;62132;62969;64212.678936606884;65110.67444662936;65495.34504654892;75825.62087189528;75989;76646;76802;77570;15437.15095669704;15916;15941.521754347388;15979.840201598301;16029.679406411573;25326.366840829127;25536.23391298264;25577;25808.09671661483;26026.73973260319;20736.96315184265;20834;21021.474463138544;21027.78972210258;21043.894780526;16881.493555193363;16898.23957921872;17481.388151414638;17954.281828727228;18396;20194.29319973794;20383.08276127548;20461.079251433424;20593.073311701308;20647.27734529284;15659.138747368548;15671.138087405303;15733.134677592841;15780.763288550452;15801.762973555637;19936;20785.688214677095;20830.479238019172;20953.37139885745;21073.89463052675 17:12:28 INFO - PID 4291 | |3;mootools.html;1398.6783039900822;1450.985490145099;1453.9636509087272;1461.4373466215504;1473.521105640667;13310.068295219338;14970.17664028478;15439.614009649764;15440.764738820895;15522.068675879455;13378.397972091256;13420.731585368287;14432.855671443282;15366.23168841559;15520.68958620827;2651.3106592285953;2709.078913169522;2711.986440067797;2712.0372267844928;2713.0639929224485;2572.6398304237423;2606.1790535981104;2688.569828827388;2690.313969937663;2696.339396847775;2729.5359788835844;2760.627315312437;2760.986195069032;2761.1716485054403;2761.2130542795308;2464.051340234005;2471.876406179693;2474.208253358926;2493.887775050127;2623.396618777692;2549.73227811079;2555.1823416506727;2574.2534664947143;2579.239124458289;2603.2840968733562;15350;15437;15442.691146177125;15458.76811847812;15492.5352239433;7456.254374562554;7669.6932122715025;7691.730789422343;7694.076710794685;7723.575203363813;5178.508041736067;5273.156294992821;5306.708131052829;5400.810971615974;5444.673319600797;1877.4649224970817;1881.4355693291957;1908.8759230650103;1925.1817977359706;1944.6596845552112;26656.60015099775;26707.73292267091;26771.19686409411;27052.188434347;27113.593296100575;7268.890966635505;7395.6671949762385;7554.811129721691;7590.278923502258;7620.047494063242;16793.496195114167;16890.324387024626;16902.492925212264;16935.068571228454;16953.83046169547;7846.9215307847335;7920.207979202034;7930.762077137695;7950.403719720928;7952.284294413531;7054.435645148375;7137.928620713727;7219.205887352387;7240.746573869889;7271.527350722186;5258.106121959276;5283.101872681654;5374.086405311106;5381;5403.13549832025;1403.747325481423;1459.8540145985528;1478.5416520878562;1511.9773203401958;1542.3907556515114;857.6226460357423;864.4165188497739;875.4834647557972;893.8614514750224;902.41794042842;7857.253560911704;8455.450395724258;8853.51305678194;8967.461952282883;9127.863082053775;964.3538828984597;972.0328273368044;974.4104816586005;980.7352014956065;994.5226291380178;4617.58441740245;4682.578567928903;5197.66215196011;5205.427402985669;5390.730463476811;20995.8950205248;21164.36506904795;21576;21715.891420542797;22532.549349012927;21963.670544941837;21981.560368792536;22191.778082219294;22313.219037333616;22344.88827555852;11338;11733.120015998664;11824.822627660593;11907.821382679267;12088.456019479321;8276.172382761675;8619.965604127545;8711.47731136134;8792.120787921156;8823.161799629024;18310.084495774892;19591.60816783685;19676.606467870275;19852.205911763944;19936;19779.10994005302;20156.193752249746;20484.79515204829;20641;20976;11552.768944620891;11852.644420667393;11882.16824822254;11882.28706277626;12559.560415385418;13553.796693049415;14039.719205616035;14150.929245353707;14158.646033848825;14219.289035548389;10948.726281843017;11231.38227397501;11231.775364492827;11270.267432616854;11395.829062564235;10929.890701092887;11056.668299950692;11114.333140011626;11219.439028048728;11400.087992960378;9176.403533770284;9662.13040826329;9872.605095796087;9872.753181170528;9876.259280554132;6520.510961677988;6727.293634168342;6803;6916.23921368639;7115.53749006313;7011.614361210182;7020.824479388056;7281.344678978918;7333.523320984119;7342.6695798688115 17:12:28 INFO - PID 4291 | |4;prototype.html;499.2561083984864;503.9496050394961;527.5542166868995;531.7128750474744;538.1631562919658;6123.63258204508;6143.938560614403;6217.735688763401;6226.43962043416;6265;5942.168096466498;6031.517478601712;6061.696915154247;6085.2089228400355;6120.632762034281;4663.903982564095;4756.262779269219;4781.6891902026255;4785.66500344976;4820.108279968217;4607.285870690049;4754;4771.6898401603785;4798.256270278112;4800.111979283826;4743.335932969387;4767.213409787381;4768.690035147704;4775;4805.711657300556;4725.527447255247;4726.952730472703;4729.196036673739;4770.236762118079;4785.688930219525;4304.397384366192;4309.741415515079;4313.892152696208;4315.870523884257;4333.848315308981;6014.548908831812;6085.5435842312;6099.085137229406;6123.4488895999575;6137.815865524041;5584.274044374246;5588.245586845765;5657.179708942181;5695.77216911323;5696.433480792815;6501.187351581052;6502.479801615859;6523.412892839668;6535.57518761279;6559.672016399161;4885.584725298354;4892.510748925115;4894.706317620954;4903.2645103234445;4914.729689867056;6676.165479315086;6741.056252124756;6769.323067693241;6770.221424536192;6820.897686534706;4937.925931111036;4999.75001249936;5002.1496345621335;5030.421501527371;5051.166557517969;5071.340725705634;5139.820106296336;5145.125328694131;5176.301199338116;5186.222066689951;5697.572682048863;5699.145128230799;5710.343310519261;5711.685857277889;5722.2561067061015;6338.8415289617205;6553.606783593;6568.540202185801;6568.80293591193;6582.473402127818;1703.761473393726;1713.9914300428418;1752.5706201980342;1768.1071059115066;1771.3357490940898;1213.1992884696058;1234.4321612058554;1244.570623135035;1249.5001999200392;1253.4547471849774;6206.565540412218;6240.693921194362;6242.0974246974465;6253.7185826637915;6257.9687101564205;6592.077109204715;6629.204495460575;6708.563943343667;6728.3271672832325;6759.932400676029;6285.622862628257;6299.653519056405;6315.305316415191;6352.821311917503;6356.332585078592;3491.965080349164;3524.54180956474;3546.29074185164;3564.215872508044;3623.221007483351;7155.856882862314;7184.533005354635;7195.280471952868;7217.711291548279;7226.168990566047;6789.694463749044;6895.689693963684;6908.171019477695;6957.199922008933;6981.616011119438;7033.261507541737;7104;7105.360517553341;7109.146902371748;7139.286071392819;6679.6994135265;6689.364510371507;6691.197056353269;6707.731690732511;6772.390484856386;6563.737450501926;6584.736610535525;6604.900926486011;6669.76609327276;6715.597064176165;7038.753643622448;7095.977646370759;7099.574025558483;7202.53183543068;7225.602591857288;4954.603631709382;5028.120078986236;5050.595952323879;5058.91233384824;5077.92383114261;6418.358164183544;6636.668166591748;6667.966660166668;6711.429528490133;6860.656967151723;6239.656818874824;6387.137736405526;6406.519511036784;6465.1595292611655;6554.738615177756;6398.296187419473;6414.711337989895;6457.225132984072;6473;6542.967285163544;6427.839304017437;6453.741850325934;6455.225372955276;6471.838204044937;6511.609303441809;6444.516661250519;6602.372774586406;6643.501737369813;6647.102641143577;6648.634325112165;6403.51973601991;6424.5865909499835;6439;6456.580322279036;6462 17:12:28 INFO - PID 4291 | |5;yui.html;937.353226273871;946.4132238012432;969.5733877094074;969.7963427680187;979.6718099436688;16782.076985765794;17258.568535786595;20238.6964195537;20539.691904621443;20592.8970355148;16551.751723724155;16580.66838663229;16621.50135495934;16710.24803883825;19400.611987760236;982.7395740128871;984.4536282363285;985.3939827006411;987.0327079462131;990.356268425522;1032.808930347888;1051.8211903976342;1057.9471026448684;1059.52321455345;1059.8198306287911;1119.451468780296;1119.9944000279986;1122.326604037575;1129.9717507062308;1132.184826924613;1124.3085502416036;1125.7692173104535;1126.9943650281696;1129.4973736687177;1131.8075927092414;830.4353039932844;830.8296799156159;831.2186544648011;831.5218749219223;832.5337810825957;18357.265709371608;18387.816121838743;18443.17005734745;19113.61772764551;20223.696644550342;20557.794422055886;21085.367438976857;21095;21128;21137.577248454945;16501.504954851374;16556.66886662272;16729.749053764204;16737;16818.915905420396;3618.3125206211;3647.288778688157;3653.415453527423;3659.79871107089;3661.780293182391;137609;143090;144907;145111;148805;15445;16075.919620401823;16287.185640717917;16380.26288817006;16454.341826326814;31448.685513144577;31775.364492710018;31851.20371990719;31954.20114497156;32150.517742233886;8944.68693595721;9002.86495702565;9117.225035872025;9180.6786762463;9212.263018958467;4346.043870348518;4425.845095421645;4429.468463784367;4444.955550444454;4460.977695111568;5321;5344.652597581145;5391.67903863556;5395.730213489388;5457.2359869618285;1008.7377281906611;1013.6198925402974;1025.8050970315617;1027.6146445083093;1028.2391030637275;646.2277578293988;653.7809833705667;682.8122266376786;685.530411667999;695.079020298107;11549.42252887369;11768.881956214145;11995.400229988465;12658.556950506872;12708.555200567936;620.3733658109512;654.3881470824699;661.0711949710665;672.6804767735384;677.695037233247;5490.972545137249;5492.5605951523785;5574.303212098488;5595.832125036255;5614.719264036782;115759;124014.37992809978;127439;128528;128617;107684;111412;117743.41128294304;118291;121695;92084.53957730302;95994;99413.50293248487;100268.49865750625;101420;13524.93237533806;13614;13737.175769453865;13841.377138029015;13874.375653095432;45427.77286113548;45860.770696146305;45894;46678.29982550332;47891.52108478871;80217.59891200741;82488.58755706184;84857.57571212105;85570.57214713887;86631;19012.809871901656;19620.215191392184;19631.803681962996;19712.60574788525;20007.799922000595;20468.38594842157;20654;20685.27601533939;20730.75019620944;20973.161073556887;20381.592368152258;20595.4851128723;20629.484262893548;20639.587208256053;20668.379948601567;19428.222871085;19681;19717.80282197217;19728.90135549313;19830.801691982895;17910.5522361942;18137.183826727563;18158.90920545389;19412.611747764684;19689.409317720492;14019.439222431396;14255.64360890986;14415.495457658932;14454.566363009126;14655.267236637912;14925.776113358092;15089.698206036037;15121.09273443597;15552.688946220786;15591.532254032398 17:12:28 INFO - PID 4291 | __end_tp_report 17:12:28 INFO - PID 4291 | __start_cc_report 17:12:28 INFO - PID 4291 | _x_x_mozilla_cycle_collect,345 17:12:28 INFO - PID 4291 | __end_cc_report 17:12:28 INFO - PID 4291 | __startTimestamp1501200748892__endTimestamp 17:12:28 INFO - PID 4291 | 17:12:28 INFO - PID 4291 | ------- Summary: start ------- 17:12:28 INFO - PID 4291 | Number of tests: 6 17:12:28 INFO - PID 4291 | 17:12:28 INFO - PID 4291 | [#0] dojo.html Cycles:165 Average:6182.41 Median:6512.71 stddev:827.44 (12.7%) stddev-sans-first:798.65 17:12:28 INFO - PID 4291 | Values: 3307.5 3335.5 3370.3 3374.5 3413.1 6066.4 6143.4 6152.6 6152.6 6160.3 6250.8 6283.5 6299.9 6304.9 6309.8 5371.9 5399.9 5429.5 5467.5 5494.8 5294.7 5356.2 5394.8 5403.7 5441.3 5437.1 5459.4 5465.5 5467.0 5479.1 5414.3 5427.2 5431.9 5498.5 5504.6 5344.2 5353.9 5355.8 5415.4 5438.1 6089.9 6103.3 6119.5 6167.6 6172.8 6694.1 6697.6 6782.2 6788.6 6790.3 6733.2 6748.6 6752.0 6767.3 6790.1 6244.5 6296.4 6302.6 6324.2 6324.8 6865.4 6892.7 6953.8 6958.2 6972.1 6512.7 6568.1 6579.6 6582.2 6609.3 6655.4 6656.2 6658.0 6672.3 6688.0 6561.2 6626.6 6631.4 6639.7 6644.5 6650.4 6682.4 6685.3 6730.1 6737.6 4897.2 4897.3 4907.0 4910.5 4912.7 4285.2 4297.1 4344.5 4359.1 4367.5 6317.7 6404.4 6412.5 6468.5 6482.6 6678.5 6696.1 6704.4 6714.0 6759.2 6415.6 6429.6 6451.8 6457.2 6480.0 5519.6 5520.5 5584.9 5595.3 5596.6 7051.6 7074.9 7092.6 7169.9 7186.7 6701.4 6732.6 6801.4 6804.6 6808.6 7135.6 7161.9 7210.9 7227.7 7246.7 6632.9 6650.5 6734.3 6763.7 6768.2 6783.4 6784.0 6875.0 6877.1 6883.2 6438.0 6521.3 6523.3 6529.1 6536.4 6522.2 6526.9 6603.7 6608.5 6620.3 6570.2 6574.6 6579.7 6591.8 6595.6 6501.7 6567.3 6633.0 6660.8 6670.1 6379.5 6384.0 6446.7 6455.0 6457.7 17:12:28 INFO - PID 4291 | 17:12:28 INFO - PID 4291 | [#1] ext.html Cycles:180 Average:40391.56 Median:35365.97 stddev:59231.98 (167.5%) stddev-sans-first:59323.71 17:12:28 INFO - PID 4291 | Values: 846.8 896.3 903.3 935.8 943.8 40478.8 41141.0 41210.0 41220.8 41268.0 39221.8 39535.0 39572.8 39574.6 39596.2 6516.4 6573.7 6574.3 6616.4 6617.4 6482.6 6557.2 6560.2 6562.3 6575.8 6553.5 7142.1 7302.0 7310.7 7311.8 7182.0 7226.8 7240.3 7277.7 7292.7 6980.8 7096.9 7112.6 7126.6 7161.6 38161.4 38494.2 38520.2 38587.2 38624.8 3377.6 3402.8 3407.6 3414.5 3414.7 30027.7 30041.8 30050.2 30077.7 30121.7 4767.2 4770.5 4786.0 4803.7 4883.2 190590.0 190974.0 193555.0 194248.0 197616.0 49776.8 49950.0 50119.0 50186.5 50198.0 51396.2 51549.7 51583.5 51620.5 51666.7 16096.4 16155.0 16227.9 16232.2 16265.2 13264.6 13338.4 13350.5 13361.5 13405.9 14542.5 14573.3 14611.9 14641.9 14854.9 5902.2 5943.5 5965.0 5986.3 6019.8 1023.9 1052.5 1067.5 1089.0 1092.2 23485.8 23915.4 23949.6 24267.4 24277.4 1139.9 1173.0 1174.7 1179.8 1179.8 16307.0 16939.6 17015.1 17468.9 17497.3 254082.0 256413.0 258948.0 259472.0 259879.0 56679.7 57147.7 57584.4 57614.4 57769.7 1434.8 1460.5 1490.8 1506.3 1508.6 28650.7 28955.9 29082.0 29771.9 29964.3 51716.5 52063.0 52137.5 52137.7 52200.0 226621.0 226701.0 228640.0 228977.0 229084.0 35294.6 35437.3 37365.8 37611.8 37683.8 46073.5 46081.0 46111.1 46538.5 46989.3 32647.7 33642.0 33747.5 33901.8 34420.7 31002.0 33047.3 33102.2 33392.8 33951.3 39194.6 39705.0 40163.0 40245.8 40246.2 32557.0 33558.5 33954.0 33979.5 34776.0 23458.5 23562.0 23662.2 23678.9 23905.3 17:12:28 INFO - PID 4291 | 17:12:28 INFO - PID 4291 | [#2] jquery.html Cycles:180 Average:39557.69 Median:12262.19 stddev:97419.33 (794.5%) stddev-sans-first:97648.63 17:12:28 INFO - PID 4291 | Values: 568.5 574.6 585.3 586.9 593.6 22060.4 22927.7 23198.8 23236.4 23252.2 25342.1 27590.4 27736.9 27785.6 27967.6 6262.5 6421.7 6448.1 6459.1 6459.8 6059.9 6280.9 6300.4 6305.1 6345.7 6256.0 6257.6 6259.9 6262.6 6266.7 6228.2 6230.5 6260.6 6274.2 6276.1 5776.3 5822.2 5831.0 5841.7 5846.1 29687.1 30493.0 31162.0 31349.8 31377.7 2097.2 2128.0 2129.0 2131.9 2138.0 19259.9 19848.5 19885.1 19942.0 19967.3 2185.4 2228.2 2229.5 2256.5 2281.9 155327.0 159148.0 159222.0 159641.2 159845.0 15343.4 15790.2 15986.7 16041.3 16377.9 23895.5 24883.4 24925.3 24975.5 25032.6 10438.4 10742.5 10767.4 10858.6 10902.9 9824.0 9893.7 9989.6 9995.0 9997.3 9527.2 9852.7 9877.0 9971.2 10018.3 2774.4 2825.0 2831.8 2848.4 2951.7 1025.6 1035.3 1042.2 1045.5 1058.9 20897.2 21396.4 21773.7 25632.7 27598.7 1099.9 1103.8 1121.1 1131.4 1146.7 11692.7 13854.5 14810.3 15349.2 15505.6 570821.0 574678.0 575884.0 581565.0 588727.0 123262.0 129552.4 139946.0 142267.0 143030.0 1295.4 1313.9 1333.1 1347.4 1360.3 21443.7 22015.0 22146.0 22294.9 22529.5 62132.0 62969.0 64212.7 65110.7 65495.3 75825.6 75989.0 76646.0 76802.0 77570.0 15437.2 15916.0 15941.5 15979.8 16029.7 25326.4 25536.2 25577.0 25808.1 26026.7 20737.0 20834.0 21021.5 21027.8 21043.9 16881.5 16898.2 17481.4 17954.3 18396.0 20194.3 20383.1 20461.1 20593.1 20647.3 15659.1 15671.1 15733.1 15780.8 15801.8 19936.0 20785.7 20830.5 20953.4 21073.9 17:12:28 INFO - PID 4291 | 17:12:28 INFO - PID 4291 | [#3] mootools.html Cycles:180 Average:9419.20 Median:2614.79 stddev:6817.55 (260.7%) stddev-sans-first:6810.05 17:12:28 INFO - PID 4291 | Values: 1398.7 1451.0 1454.0 1461.4 1473.5 13310.1 14970.2 15439.6 15440.8 15522.1 13378.4 13420.7 14432.9 15366.2 15520.7 2651.3 2709.1 2712.0 2712.0 2713.1 2572.6 2606.2 2688.6 2690.3 2696.3 2729.5 2760.6 2761.0 2761.2 2761.2 2464.1 2471.9 2474.2 2493.9 2623.4 2549.7 2555.2 2574.3 2579.2 2603.3 15350.0 15437.0 15442.7 15458.8 15492.5 7456.3 7669.7 7691.7 7694.1 7723.6 5178.5 5273.2 5306.7 5400.8 5444.7 1877.5 1881.4 1908.9 1925.2 1944.7 26656.6 26707.7 26771.2 27052.2 27113.6 7268.9 7395.7 7554.8 7590.3 7620.0 16793.5 16890.3 16902.5 16935.1 16953.8 7846.9 7920.2 7930.8 7950.4 7952.3 7054.4 7137.9 7219.2 7240.7 7271.5 5258.1 5283.1 5374.1 5381.0 5403.1 1403.7 1459.9 1478.5 1512.0 1542.4 857.6 864.4 875.5 893.9 902.4 7857.3 8455.5 8853.5 8967.5 9127.9 964.4 972.0 974.4 980.7 994.5 4617.6 4682.6 5197.7 5205.4 5390.7 20995.9 21164.4 21576.0 21715.9 22532.5 21963.7 21981.6 22191.8 22313.2 22344.9 11338.0 11733.1 11824.8 11907.8 12088.5 8276.2 8620.0 8711.5 8792.1 8823.2 18310.1 19591.6 19676.6 19852.2 19936.0 19779.1 20156.2 20484.8 20641.0 20976.0 11552.8 11852.6 11882.2 11882.3 12559.6 13553.8 14039.7 14150.9 14158.6 14219.3 10948.7 11231.4 11231.8 11270.3 11395.8 10929.9 11056.7 11114.3 11219.4 11400.1 9176.4 9662.1 9872.6 9872.8 9876.3 6520.5 6727.3 6803.0 6916.2 7115.5 7011.6 7020.8 7281.3 7333.5 7342.7 17:12:28 INFO - PID 4291 | 17:12:28 INFO - PID 4291 | [#4] prototype.html Cycles:180 Average:5552.92 Median:6240.18 stddev:1601.72 (25.7%) stddev-sans-first:1560.65 17:12:28 INFO - PID 4291 | Values: 499.3 503.9 527.6 531.7 538.2 6123.6 6143.9 6217.7 6226.4 6265.0 5942.2 6031.5 6061.7 6085.2 6120.6 4663.9 4756.3 4781.7 4785.7 4820.1 4607.3 4754.0 4771.7 4798.3 4800.1 4743.3 4767.2 4768.7 4775.0 4805.7 4725.5 4727.0 4729.2 4770.2 4785.7 4304.4 4309.7 4313.9 4315.9 4333.8 6014.5 6085.5 6099.1 6123.4 6137.8 5584.3 5588.2 5657.2 5695.8 5696.4 6501.2 6502.5 6523.4 6535.6 6559.7 4885.6 4892.5 4894.7 4903.3 4914.7 6676.2 6741.1 6769.3 6770.2 6820.9 4937.9 4999.8 5002.1 5030.4 5051.2 5071.3 5139.8 5145.1 5176.3 5186.2 5697.6 5699.1 5710.3 5711.7 5722.3 6338.8 6553.6 6568.5 6568.8 6582.5 1703.8 1714.0 1752.6 1768.1 1771.3 1213.2 1234.4 1244.6 1249.5 1253.5 6206.6 6240.7 6242.1 6253.7 6258.0 6592.1 6629.2 6708.6 6728.3 6759.9 6285.6 6299.7 6315.3 6352.8 6356.3 3492.0 3524.5 3546.3 3564.2 3623.2 7155.9 7184.5 7195.3 7217.7 7226.2 6789.7 6895.7 6908.2 6957.2 6981.6 7033.3 7104.0 7105.4 7109.1 7139.3 6679.7 6689.4 6691.2 6707.7 6772.4 6563.7 6584.7 6604.9 6669.8 6715.6 7038.8 7096.0 7099.6 7202.5 7225.6 4954.6 5028.1 5050.6 5058.9 5077.9 6418.4 6636.7 6668.0 6711.4 6860.7 6239.7 6387.1 6406.5 6465.2 6554.7 6398.3 6414.7 6457.2 6473.0 6543.0 6427.8 6453.7 6455.2 6471.8 6511.6 6444.5 6602.4 6643.5 6647.1 6648.6 6403.5 6424.6 6439.0 6456.6 6462.0 17:12:28 INFO - PID 4291 | 17:12:28 INFO - PID 4291 | [#5] yui.html Cycles:180 Average:26230.49 Median:19779.85 stddev:37234.88 (188.2%) stddev-sans-first:37290.90 17:12:28 INFO - PID 4291 | Values: 937.4 946.4 969.6 969.8 979.7 16782.1 17258.6 20238.7 20539.7 20592.9 16551.8 16580.7 16621.5 16710.2 19400.6 982.7 984.5 985.4 987.0 990.4 1032.8 1051.8 1057.9 1059.5 1059.8 1119.5 1120.0 1122.3 1130.0 1132.2 1124.3 1125.8 1127.0 1129.5 1131.8 830.4 830.8 831.2 831.5 832.5 18357.3 18387.8 18443.2 19113.6 20223.7 20557.8 21085.4 21095.0 21128.0 21137.6 16501.5 16556.7 16729.7 16737.0 16818.9 3618.3 3647.3 3653.4 3659.8 3661.8 137609.0 143090.0 144907.0 145111.0 148805.0 15445.0 16075.9 16287.2 16380.3 16454.3 31448.7 31775.4 31851.2 31954.2 32150.5 8944.7 9002.9 9117.2 9180.7 9212.3 4346.0 4425.8 4429.5 4445.0 4461.0 5321.0 5344.7 5391.7 5395.7 5457.2 1008.7 1013.6 1025.8 1027.6 1028.2 646.2 653.8 682.8 685.5 695.1 11549.4 11768.9 11995.4 12658.6 12708.6 620.4 654.4 661.1 672.7 677.7 5491.0 5492.6 5574.3 5595.8 5614.7 115759.0 124014.4 127439.0 128528.0 128617.0 107684.0 111412.0 117743.4 118291.0 121695.0 92084.5 95994.0 99413.5 100268.5 101420.0 13524.9 13614.0 13737.2 13841.4 13874.4 45427.8 45860.8 45894.0 46678.3 47891.5 80217.6 82488.6 84857.6 85570.6 86631.0 19012.8 19620.2 19631.8 19712.6 20007.8 20468.4 20654.0 20685.3 20730.8 20973.2 20381.6 20595.5 20629.5 20639.6 20668.4 19428.2 19681.0 19717.8 19728.9 19830.8 17910.6 18137.2 18158.9 19412.6 19689.4 14019.4 14255.6 14415.5 14454.6 14655.3 14925.8 15089.7 15121.1 15552.7 15591.5 17:12:28 INFO - PID 4291 | -------- Summary: end -------- 17:12:28 INFO - PID 4291 | 17:12:29 INFO - TEST-INFO | 4291: exit 0 17:12:29 INFO - TEST-OK | dromaeo_css | took 1109823ms 17:12:29 INFO - TEST-START | kraken 17:12:29 INFO - Initialising browser for kraken test... 17:12:29 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56959/getInfo.html -profile /tmp/tmpiMTQEL/profile 17:12:29 INFO - TEST-INFO | started process 4649 (/builds/slave/test/build/application/firefox/firefox http://localhost:56959/getInfo.html) 17:12:34 INFO - TEST-INFO | 4649: exit 0 17:12:34 INFO - Browser initialized. 17:12:34 INFO - Running cycle 1/1 for kraken test... 17:12:34 INFO - TEST-INFO | started process 4860 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiMTQEL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:12:35 INFO - PID 4860 | 17:12:35 INFO - PID 4860 | (/builds/slave/test/build/application/firefox/firefox:4911): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 17:12:35 INFO - PID 4860 | 17:12:45 INFO - PID 4860 | RSS: Main: 164007936 17:12:45 INFO - PID 4860 | 17:12:48 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56959/tests/kraken/driver.html?testName=audio-beat-detection) 17:12:49 INFO - PID 4860 | RSS: Main: 168828928 17:12:49 INFO - PID 4860 | 17:12:51 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56959/tests/kraken/driver.html?testName=audio-dft) 17:12:52 INFO - PID 4860 | RSS: Main: 170090496 17:12:52 INFO - PID 4860 | 17:12:55 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56959/tests/kraken/driver.html?testName=audio-fft) 17:12:56 INFO - PID 4860 | RSS: Main: 163352576 17:12:56 INFO - PID 4860 | 17:12:58 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56959/tests/kraken/driver.html?testName=audio-oscillator) 17:12:58 INFO - PID 4860 | RSS: Main: 165146624 17:12:58 INFO - PID 4860 | 17:13:00 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56959/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:13:01 INFO - PID 4860 | RSS: Main: 164982784 17:13:01 INFO - PID 4860 | 17:13:04 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56959/tests/kraken/driver.html?testName=imaging-darkroom) 17:13:05 INFO - PID 4860 | RSS: Main: 167596032 17:13:05 INFO - PID 4860 | 17:13:08 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56959/tests/kraken/driver.html?testName=imaging-desaturate) 17:13:09 INFO - PID 4860 | RSS: Main: 169369600 17:13:09 INFO - PID 4860 | 17:13:11 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56959/tests/kraken/driver.html?testName=json-parse-financial) 17:13:12 INFO - PID 4860 | RSS: Main: 167849984 17:13:12 INFO - PID 4860 | 17:13:14 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56959/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:13:14 INFO - PID 4860 | RSS: Main: 167854080 17:13:14 INFO - PID 4860 | 17:13:16 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56959/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:13:17 INFO - PID 4860 | RSS: Main: 167665664 17:13:17 INFO - PID 4860 | 17:13:19 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56959/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:13:19 INFO - PID 4860 | RSS: Main: 165130240 17:13:19 INFO - PID 4860 | 17:13:22 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:13:23 INFO - PID 4860 | RSS: Main: 165183488 17:13:23 INFO - PID 4860 | 17:13:26 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:13:26 INFO - PID 4860 | RSS: Main: 165670912 17:13:26 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | Cycle 1(1): loaded http://localhost:56959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56959/tests/kraken/driver.html?testName=ai-astar) 17:13:28 INFO - PID 4860 | RSS: Main: 167243776 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | __start_tp_report 17:13:28 INFO - PID 4860 | _x_x_mozilla_page_load 17:13:28 INFO - PID 4860 | _x_x_mozilla_page_load_details 17:13:28 INFO - PID 4860 | |i|pagename|runs| 17:13:28 INFO - PID 4860 | |0;ai-astar;97;107;101;107;107;108;114;101;109;107 17:13:28 INFO - PID 4860 | |1;audio-beat-detection;152;118;154;171;123;141;145;114;163;117 17:13:28 INFO - PID 4860 | |2;audio-dft;163;162;162;161;168;165;162;163;166;163 17:13:28 INFO - PID 4860 | |3;audio-fft;81;77;75;169;76;75;78;86;97;75 17:13:28 INFO - PID 4860 | |4;audio-oscillator;79;79;125;79;78;79;124;81;78;122 17:13:28 INFO - PID 4860 | |5;imaging-gaussian-blur;113;115;114;113;113;114;113;114;115;114 17:13:28 INFO - PID 4860 | |6;imaging-darkroom;149;148;149;150;149;148;148;148;152;151 17:13:28 INFO - PID 4860 | |7;imaging-desaturate;96;93;94;94;95;94;93;94;94;95 17:13:28 INFO - PID 4860 | |8;json-parse-financial;48;48;48;50;49;54;48;48;56;52 17:13:28 INFO - PID 4860 | |9;json-stringify-tinderbox;54;55;55;55;55;56;55;55;55;56 17:13:28 INFO - PID 4860 | |10;stanford-crypto-aes;76;76;83;76;84;77;75;76;78;77 17:13:28 INFO - PID 4860 | |11;stanford-crypto-ccm;132;136;117;116;119;125;125;129;118;175 17:13:28 INFO - PID 4860 | |12;stanford-crypto-pbkdf2;158;159;158;156;158;168;158;159;167;165 17:13:28 INFO - PID 4860 | |13;stanford-crypto-sha256-iterative;67;64;61;62;67;62;64;65;63;62 17:13:28 INFO - PID 4860 | __end_tp_report 17:13:28 INFO - PID 4860 | __start_cc_report 17:13:28 INFO - PID 4860 | _x_x_mozilla_cycle_collect,847 17:13:28 INFO - PID 4860 | __end_cc_report 17:13:28 INFO - PID 4860 | __startTimestamp1501200808614__endTimestamp 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | ------- Summary: start ------- 17:13:28 INFO - PID 4860 | Number of tests: 14 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#0] ai-astar Cycles:10 Average:105.80 Median:107.50 stddev:4.85 (4.5%) stddev-sans-first:3.96 17:13:28 INFO - PID 4860 | Values: 97.0 107.0 101.0 107.0 107.0 108.0 114.0 101.0 109.0 107.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:148.50 stddev:20.64 (13.9%) stddev-sans-first:21.41 17:13:28 INFO - PID 4860 | Values: 152.0 118.0 154.0 171.0 123.0 141.0 145.0 114.0 163.0 117.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.17 (1.3%) stddev-sans-first:2.30 17:13:28 INFO - PID 4860 | Values: 163.0 162.0 162.0 161.0 168.0 165.0 162.0 163.0 166.0 163.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#3] audio-fft Cycles:10 Average:88.90 Median:77.50 stddev:28.98 (37.4%) stddev-sans-first:30.60 17:13:28 INFO - PID 4860 | Values: 81.0 77.0 75.0 169.0 76.0 75.0 78.0 86.0 97.0 75.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:79.00 stddev:21.60 (27.3%) stddev-sans-first:22.36 17:13:28 INFO - PID 4860 | Values: 79.0 79.0 125.0 79.0 78.0 79.0 124.0 81.0 78.0 122.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 17:13:28 INFO - PID 4860 | Values: 113.0 115.0 114.0 113.0 113.0 114.0 113.0 114.0 115.0 114.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:149.00 stddev:1.40 (0.9%) stddev-sans-first:1.48 17:13:28 INFO - PID 4860 | Values: 149.0 148.0 149.0 150.0 149.0 148.0 148.0 148.0 152.0 151.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.71 17:13:28 INFO - PID 4860 | Values: 96.0 93.0 94.0 94.0 95.0 94.0 93.0 94.0 94.0 95.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:49.50 stddev:2.92 (5.9%) stddev-sans-first:3.00 17:13:28 INFO - PID 4860 | Values: 48.0 48.0 48.0 50.0 49.0 54.0 48.0 48.0 56.0 52.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:55.00 stddev:0.57 (1.0%) stddev-sans-first:0.44 17:13:28 INFO - PID 4860 | Values: 54.0 55.0 55.0 55.0 55.0 56.0 55.0 55.0 55.0 56.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:77.00 stddev:3.12 (4.1%) stddev-sans-first:3.24 17:13:28 INFO - PID 4860 | Values: 76.0 76.0 83.0 76.0 84.0 77.0 75.0 76.0 78.0 77.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:127.00 stddev:17.45 (13.7%) stddev-sans-first:18.48 17:13:28 INFO - PID 4860 | Values: 132.0 136.0 117.0 116.0 119.0 125.0 125.0 129.0 118.0 175.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.60 Median:159.00 stddev:4.33 (2.7%) stddev-sans-first:4.48 17:13:28 INFO - PID 4860 | Values: 158.0 159.0 158.0 156.0 158.0 168.0 158.0 159.0 167.0 165.0 17:13:28 INFO - PID 4860 | 17:13:28 INFO - PID 4860 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:2.11 (3.3%) stddev-sans-first:1.87 17:13:28 INFO - PID 4860 | Values: 67.0 64.0 61.0 62.0 67.0 62.0 64.0 65.0 63.0 62.0 17:13:28 INFO - PID 4860 | -------- Summary: end -------- 17:13:28 INFO - PID 4860 | 17:13:29 INFO - PID 4860 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:13:29 INFO - TEST-INFO | 4860: exit 0 17:13:29 INFO - TEST-OK | kraken | took 59775ms 17:13:29 INFO - SUITE-END | took 1169s 17:13:29 INFO - Completed test suite (00:19:30) 17:13:29 INFO - javascript benchmark 17:13:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8766.570762256337, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3307.470804671253, 3335.499675048744, 3370.2585431205134, 3374.460086386178, 3413.1467133216697, 6066.3630318816495, 6143.416375444332, 6152.630842149463, 6152.630842149463, 6160.26076870775, 6250.8124756257275, 6283.528735344845, 6299.905501417483, 6304.873902521947, 6309.832680954015, 5371.865703357428, 5399.865003374908, 5429.484199001088, 5467.45325467452, 5494.780208791643, 5294.682319060868, 5356.169793681966, 5394.811181608645, 5403.729813509329, 5441.29263195786, 5437.13005919053, 5459.426760190182, 5465.453454654523, 5467.0, 5479.123340265538, 5414.269073675043, 5427.158790387496, 5431.864203394907, 5498.45015498447, 5504.6421982571, 5344.198370244456, 5353.946460535422, 5355.7857685692525, 5415.404305526428, 5438.102713052342, 6089.939100609025, 6103.29812071613, 6119.479844213247, 6167.599106058092, 6172.783952561639, 6694.062831203635, 6697.631630260334, 6782.1861376635115, 6788.558743681645, 6790.287019862942, 6733.192016957947, 6748.6288254146, 6751.961940591874, 6767.255601883789, 6790.083338749305, 6244.531660125509, 6296.370362963713, 6302.621842689453, 6324.209473815819, 6324.841878953017, 6865.382115609619, 6892.689828957709, 6953.756618518328, 6958.234594194634, 6972.058772065808, 6512.706928188148, 6568.146141001639, 6579.605223686594, 6582.24304205013, 6609.3060228675295, 6655.401013908771, 6656.2345330287635, 6658.0, 6672.332766723289, 6687.966560167168, 6561.212654481493, 6626.635535045619, 6631.370019848203, 6639.668016599151, 6644.468442524683, 6650.401463868178, 6682.365175308338, 6685.298043705438, 6730.091437655951, 6737.629430381278, 4897.1674815281485, 4897.314375987365, 4907.018596280758, 4910.533499317559, 4912.656114072052, 4285.185814695198, 4297.119090586422, 4344.47866256045, 4359.084592235666, 4367.45406824147, 6317.684115794192, 6404.423601875854, 6412.5190610704385, 6468.514861385415, 6482.643454609947, 6678.53250272486, 6696.129503164655, 6704.430123439464, 6714.026466162379, 6759.155105611799, 6415.615063096229, 6429.58207716497, 6451.774187903495, 6457.1605691260775, 6479.967600161969, 5519.558435325164, 5520.503154716095, 5584.888302233932, 5595.272614560081, 5596.552275817925, 7051.576905385796, 7074.92925070753, 7092.574445533284, 7169.89245161323, 7186.7125314986815, 6701.430378417694, 6732.629705366252, 6801.421879140131, 6804.6257455840405, 6808.5914845109455, 7135.643217838983, 7161.856762864818, 7210.855782884418, 7227.7108915644885, 7246.7101315948885, 6632.867342653023, 6650.501212408992, 6734.259231484631, 6763.695633696594, 6768.187817461936, 6783.3555812197765, 6783.966080169567, 6874.9656251718425, 6877.140357455318, 6883.174019117738, 6437.967810160919, 6521.347865213441, 6523.282438931808, 6529.053287273224, 6536.444402225674, 6522.184726909137, 6526.9020964686515, 6603.669816509251, 6608.471322294301, 6620.271770105381, 6570.244421891543, 6574.638394888327, 6579.736810527525, 6591.835204119743, 6595.604263744191, 6501.739930402731, 6567.277599464151, 6633.0, 6660.766873159416, 6670.132882725215, 6379.489640828815, 6384.042393640991, 6446.742130314735, 6455.0, 6457.741690332522], "value": 6116.1287729424475, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [846.7826835229821, 896.3072142771778, 903.345074820755, 935.7567032571537, 943.7829299261169, 40478.79760601197, 41141.0, 41210.0, 41220.79389603052, 41268.0, 39221.803890980504, 39535.0, 39572.802135989354, 39574.60425395745, 39596.20807583847, 6516.413522782948, 6573.704183311763, 6574.2768295487695, 6616.371444712769, 6617.404433600975, 6482.578632388903, 6557.213134423852, 6560.212774467071, 6562.310957349481, 6575.769848055319, 6553.541252112354, 7142.107236595426, 7301.963490182568, 7310.671019804095, 7311.780646580611, 7181.958616000651, 7226.783196504113, 7240.275972402744, 7277.672504737299, 7292.744753933587, 6980.7905762827195, 7096.893546596805, 7112.608806515639, 7126.643667816588, 7161.641917904136, 38161.42757858634, 38494.230115397535, 38520.229595408215, 38587.22825543502, 38624.80687596572, 3377.5609170807884, 3402.795832250073, 3407.557017587698, 3414.4878268259713, 3414.6585341465902, 30027.69972300271, 30041.849790750908, 30050.24874378136, 30077.69922300771, 30121.698783012107, 4767.213409787381, 4770.546798054179, 4786.042791441726, 4803.7357945313, 4883.19427294496, 190590.0, 190974.0, 193555.03222483938, 194248.0, 197616.0, 49776.75111624419, 49950.0, 50119.0, 50186.498135018184, 50198.0, 51396.22905656418, 51549.74225128925, 51583.48416515862, 51620.48379516232, 51666.74166629218, 16096.356145754273, 16155.0, 16227.918860405622, 16232.188390580424, 16265.186740662919, 13264.602061938158, 13338.399772010283, 13350.46598136083, 13361.465541378237, 13405.932970335087, 14542.4910128145, 14573.344199511048, 14611.853881461262, 14641.853581464262, 14854.925725371304, 5902.173695682608, 5943.494802941712, 5964.970175149097, 5986.281646202484, 6019.849503762441, 1023.9162557899914, 1052.5263631365763, 1067.546292825546, 1088.9945550272357, 1092.186321190718, 23485.825708714496, 23915.40211494692, 23949.640755388336, 24267.39331516726, 24277.393065173514, 1139.8917102875214, 1172.9941350293193, 1174.653477224204, 1179.7581495793343, 1179.775842589905, 16307.021578705315, 16939.57651058709, 17015.128335883044, 17468.91265543664, 17497.30010799554, 254082.0, 256413.0, 258948.0, 259472.0, 259879.0, 56679.71660141755, 57147.714261428424, 57584.424155758745, 57614.42385576174, 57769.711151443975, 1434.8206474190727, 1460.5107289058285, 1490.7614781635102, 1506.314626844805, 1508.6228442889278, 28650.713492864805, 28955.855220723763, 29082.0, 29771.851140745024, 29964.250893727833, 51716.48283517117, 52063.0, 52137.47862521326, 52137.7393113032, 52200.0, 226621.0, 226701.0, 228640.0, 228977.0, 229084.0, 35294.64705352914, 35437.291254174255, 37365.81317093506, 37611.81194094012, 37683.81158094192, 46073.53926460692, 46081.0, 46111.07777844492, 46538.53461465342, 46989.2951605733, 32647.673523264464, 33642.0, 33747.493787593696, 33901.81343652961, 34420.65579344174, 31002.0, 33047.33905321928, 33102.21625649531, 33392.833035834665, 33951.320973580885, 39194.60805392024, 39705.0, 40163.0, 40245.79877100596, 40246.1950760989, 32557.0, 33558.49662255019, 33954.0, 33979.49030764491, 34776.0, 23458.530829383657, 23562.0, 23662.17182398608, 23678.88160559186, 23905.28284151478], "value": 17763.897568264845, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.4656422962418, 574.5891687443477, 585.3268740947908, 586.8591538030871, 593.5637306579663, 22060.448488787788, 22927.656085158716, 23198.768012319873, 23236.41908952279, 23252.186173483933, 25342.11302604409, 27590.44819103617, 27736.861315693393, 27785.58321625172, 27967.58048629267, 6262.53031022674, 6421.711023003976, 6448.12950251717, 6459.128017717619, 6459.773907913224, 6059.878802423971, 6280.937190628104, 6300.369963003709, 6305.085762564426, 6345.746170153211, 6256.0, 6257.593256438339, 6259.937400625981, 6262.624242545439, 6266.6553339566535, 6228.159198508189, 6230.532710046765, 6260.624362538262, 6274.215723034644, 6276.121343011982, 5776.306843178803, 5822.243108395882, 5831.0, 5841.707914604252, 5846.123081537803, 29687.10938671843, 30493.0, 31162.0, 31349.84325078383, 31377.686223137705, 2097.2345094040716, 2128.021110289269, 2128.9787102128935, 2131.9040643171093, 2138.0485683870684, 19259.90370048141, 19848.503787405287, 19885.105170267227, 19942.0, 19967.30114446002, 2185.442712108418, 2228.1755750372304, 2229.487217939883, 2256.537409830997, 2281.885905704708, 155327.0, 159148.0, 159222.0, 159641.20179399144, 159845.0, 15343.386264549294, 15790.210489475481, 15986.680266394607, 16041.278142483616, 16377.91811040961, 23895.52208955811, 24883.377915551893, 24925.252242432394, 24975.5004899901, 25032.624510632355, 10438.425886576159, 10742.462876856282, 10767.3539587625, 10858.619948301772, 10902.890971090346, 9823.950880245553, 9893.653722119836, 9989.60041598328, 9994.950025249827, 9997.300188986846, 9527.237820974306, 9852.655157069468, 9877.012298770209, 9971.152452041513, 10018.3488073275, 2774.403503246812, 2825.0, 2831.7734581233453, 2848.3733578612673, 2951.7343439090587, 1025.620520407439, 1035.295998720862, 1042.2027149230844, 1045.4720366215013, 1058.9258751887294, 20897.164113435596, 21396.358109256747, 21773.673394899088, 25632.743672563407, 27598.724012760016, 1099.8680158381046, 1103.823388257875, 1121.0919155484085, 1131.4399372310759, 1146.7075895646724, 11692.70768230801, 13854.515091971733, 14810.259487025605, 15349.155796431303, 15505.612359690873, 570821.0, 574678.0, 575884.0, 581565.0, 588727.0, 123262.0, 129552.3522382382, 139946.0, 142267.0, 143030.0, 1295.4041141075022, 1313.9145955513052, 1333.1401246196149, 1347.4475465059475, 1360.326638314021, 21443.67834482515, 22015.0, 22146.0, 22294.888525557268, 22529.549409012056, 62132.0, 62969.0, 64212.678936606884, 65110.67444662936, 65495.34504654892, 75825.62087189528, 75989.0, 76646.0, 76802.0, 77570.0, 15437.15095669704, 15916.0, 15941.521754347388, 15979.840201598301, 16029.679406411573, 25326.366840829127, 25536.23391298264, 25577.0, 25808.09671661483, 26026.73973260319, 20736.96315184265, 20834.0, 21021.474463138544, 21027.78972210258, 21043.894780526, 16881.493555193363, 16898.23957921872, 17481.388151414638, 17954.281828727228, 18396.0, 20194.29319973794, 20383.08276127548, 20461.079251433424, 20593.073311701308, 20647.27734529284, 15659.138747368548, 15671.138087405303, 15733.134677592841, 15780.763288550452, 15801.762973555637, 19936.0, 20785.688214677095, 20830.479238019172, 20953.37139885745, 21073.89463052675], "value": 12832.548749301994, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1398.6783039900822, 1450.985490145099, 1453.9636509087272, 1461.4373466215504, 1473.521105640667, 13310.068295219338, 14970.17664028478, 15439.614009649764, 15440.764738820895, 15522.068675879455, 13378.397972091256, 13420.731585368287, 14432.855671443282, 15366.23168841559, 15520.68958620827, 2651.3106592285953, 2709.078913169522, 2711.986440067797, 2712.0372267844928, 2713.0639929224485, 2572.6398304237423, 2606.1790535981104, 2688.569828827388, 2690.313969937663, 2696.339396847775, 2729.5359788835844, 2760.627315312437, 2760.986195069032, 2761.1716485054403, 2761.2130542795308, 2464.051340234005, 2471.876406179693, 2474.208253358926, 2493.887775050127, 2623.396618777692, 2549.73227811079, 2555.1823416506727, 2574.2534664947143, 2579.239124458289, 2603.2840968733562, 15350.0, 15437.0, 15442.691146177125, 15458.76811847812, 15492.5352239433, 7456.254374562554, 7669.6932122715025, 7691.730789422343, 7694.076710794685, 7723.575203363813, 5178.508041736067, 5273.156294992821, 5306.708131052829, 5400.810971615974, 5444.673319600797, 1877.4649224970817, 1881.4355693291957, 1908.8759230650103, 1925.1817977359706, 1944.6596845552112, 26656.60015099775, 26707.73292267091, 26771.19686409411, 27052.188434347, 27113.593296100575, 7268.890966635505, 7395.6671949762385, 7554.811129721691, 7590.278923502258, 7620.047494063242, 16793.496195114167, 16890.324387024626, 16902.492925212264, 16935.068571228454, 16953.83046169547, 7846.9215307847335, 7920.207979202034, 7930.762077137695, 7950.403719720928, 7952.284294413531, 7054.435645148375, 7137.928620713727, 7219.205887352387, 7240.746573869889, 7271.527350722186, 5258.106121959276, 5283.101872681654, 5374.086405311106, 5381.0, 5403.13549832025, 1403.747325481423, 1459.8540145985528, 1478.5416520878562, 1511.9773203401958, 1542.3907556515114, 857.6226460357423, 864.4165188497739, 875.4834647557972, 893.8614514750224, 902.41794042842, 7857.253560911704, 8455.450395724258, 8853.51305678194, 8967.461952282883, 9127.863082053775, 964.3538828984597, 972.0328273368044, 974.4104816586005, 980.7352014956065, 994.5226291380178, 4617.58441740245, 4682.578567928903, 5197.66215196011, 5205.427402985669, 5390.730463476811, 20995.8950205248, 21164.36506904795, 21576.0, 21715.891420542797, 22532.549349012927, 21963.670544941837, 21981.560368792536, 22191.778082219294, 22313.219037333616, 22344.88827555852, 11338.0, 11733.120015998664, 11824.822627660593, 11907.821382679267, 12088.456019479321, 8276.172382761675, 8619.965604127545, 8711.47731136134, 8792.120787921156, 8823.161799629024, 18310.084495774892, 19591.60816783685, 19676.606467870275, 19852.205911763944, 19936.0, 19779.10994005302, 20156.193752249746, 20484.79515204829, 20641.0, 20976.0, 11552.768944620891, 11852.644420667393, 11882.16824822254, 11882.28706277626, 12559.560415385418, 13553.796693049415, 14039.719205616035, 14150.929245353707, 14158.646033848825, 14219.289035548389, 10948.726281843017, 11231.38227397501, 11231.775364492827, 11270.267432616854, 11395.829062564235, 10929.890701092887, 11056.668299950692, 11114.333140011626, 11219.439028048728, 11400.087992960378, 9176.403533770284, 9662.13040826329, 9872.605095796087, 9872.753181170528, 9876.259280554132, 6520.510961677988, 6727.293634168342, 6803.0, 6916.23921368639, 7115.53749006313, 7011.614361210182, 7020.824479388056, 7281.344678978918, 7333.523320984119, 7342.6695798688115], "value": 6691.32701914027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.2561083984864, 503.9496050394961, 527.5542166868995, 531.7128750474744, 538.1631562919658, 6123.63258204508, 6143.938560614403, 6217.735688763401, 6226.43962043416, 6265.0, 5942.168096466498, 6031.517478601712, 6061.696915154247, 6085.2089228400355, 6120.632762034281, 4663.903982564095, 4756.262779269219, 4781.6891902026255, 4785.66500344976, 4820.108279968217, 4607.285870690049, 4754.0, 4771.6898401603785, 4798.256270278112, 4800.111979283826, 4743.335932969387, 4767.213409787381, 4768.690035147704, 4775.0, 4805.711657300556, 4725.527447255247, 4726.952730472703, 4729.196036673739, 4770.236762118079, 4785.688930219525, 4304.397384366192, 4309.741415515079, 4313.892152696208, 4315.870523884257, 4333.848315308981, 6014.548908831812, 6085.5435842312, 6099.085137229406, 6123.4488895999575, 6137.815865524041, 5584.274044374246, 5588.245586845765, 5657.179708942181, 5695.77216911323, 5696.433480792815, 6501.187351581052, 6502.479801615859, 6523.412892839668, 6535.57518761279, 6559.672016399161, 4885.584725298354, 4892.510748925115, 4894.706317620954, 4903.2645103234445, 4914.729689867056, 6676.165479315086, 6741.056252124756, 6769.323067693241, 6770.221424536192, 6820.897686534706, 4937.925931111036, 4999.75001249936, 5002.1496345621335, 5030.421501527371, 5051.166557517969, 5071.340725705634, 5139.820106296336, 5145.125328694131, 5176.301199338116, 5186.222066689951, 5697.572682048863, 5699.145128230799, 5710.343310519261, 5711.685857277889, 5722.2561067061015, 6338.8415289617205, 6553.606783593, 6568.540202185801, 6568.80293591193, 6582.473402127818, 1703.761473393726, 1713.9914300428418, 1752.5706201980342, 1768.1071059115066, 1771.3357490940898, 1213.1992884696058, 1234.4321612058554, 1244.570623135035, 1249.5001999200392, 1253.4547471849774, 6206.565540412218, 6240.693921194362, 6242.0974246974465, 6253.7185826637915, 6257.9687101564205, 6592.077109204715, 6629.204495460575, 6708.563943343667, 6728.3271672832325, 6759.932400676029, 6285.622862628257, 6299.653519056405, 6315.305316415191, 6352.821311917503, 6356.332585078592, 3491.965080349164, 3524.54180956474, 3546.29074185164, 3564.215872508044, 3623.221007483351, 7155.856882862314, 7184.533005354635, 7195.280471952868, 7217.711291548279, 7226.168990566047, 6789.694463749044, 6895.689693963684, 6908.171019477695, 6957.199922008933, 6981.616011119438, 7033.261507541737, 7104.0, 7105.360517553341, 7109.146902371748, 7139.286071392819, 6679.6994135265, 6689.364510371507, 6691.197056353269, 6707.731690732511, 6772.390484856386, 6563.737450501926, 6584.736610535525, 6604.900926486011, 6669.76609327276, 6715.597064176165, 7038.753643622448, 7095.977646370759, 7099.574025558483, 7202.53183543068, 7225.602591857288, 4954.603631709382, 5028.120078986236, 5050.595952323879, 5058.91233384824, 5077.92383114261, 6418.358164183544, 6636.668166591748, 6667.966660166668, 6711.429528490133, 6860.656967151723, 6239.656818874824, 6387.137736405526, 6406.519511036784, 6465.1595292611655, 6554.738615177756, 6398.296187419473, 6414.711337989895, 6457.225132984072, 6473.0, 6542.967285163544, 6427.839304017437, 6453.741850325934, 6455.225372955276, 6471.838204044937, 6511.609303441809, 6444.516661250519, 6602.372774586406, 6643.501737369813, 6647.102641143577, 6648.634325112165, 6403.51973601991, 6424.5865909499835, 6439.0, 6456.580322279036, 6462.0], "value": 5083.557454610521, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [937.353226273871, 946.4132238012432, 969.5733877094074, 969.7963427680187, 979.6718099436688, 16782.076985765794, 17258.568535786595, 20238.6964195537, 20539.691904621443, 20592.8970355148, 16551.751723724155, 16580.66838663229, 16621.50135495934, 16710.24803883825, 19400.611987760236, 982.7395740128871, 984.4536282363285, 985.3939827006411, 987.0327079462131, 990.356268425522, 1032.808930347888, 1051.8211903976342, 1057.9471026448684, 1059.52321455345, 1059.8198306287911, 1119.451468780296, 1119.9944000279986, 1122.326604037575, 1129.9717507062308, 1132.184826924613, 1124.3085502416036, 1125.7692173104535, 1126.9943650281696, 1129.4973736687177, 1131.8075927092414, 830.4353039932844, 830.8296799156159, 831.2186544648011, 831.5218749219223, 832.5337810825957, 18357.265709371608, 18387.816121838743, 18443.17005734745, 19113.61772764551, 20223.696644550342, 20557.794422055886, 21085.367438976857, 21095.0, 21128.0, 21137.577248454945, 16501.504954851374, 16556.66886662272, 16729.749053764204, 16737.0, 16818.915905420396, 3618.3125206211, 3647.288778688157, 3653.415453527423, 3659.79871107089, 3661.780293182391, 137609.0, 143090.0, 144907.0, 145111.0, 148805.0, 15445.0, 16075.919620401823, 16287.185640717917, 16380.26288817006, 16454.341826326814, 31448.685513144577, 31775.364492710018, 31851.20371990719, 31954.20114497156, 32150.517742233886, 8944.68693595721, 9002.86495702565, 9117.225035872025, 9180.6786762463, 9212.263018958467, 4346.043870348518, 4425.845095421645, 4429.468463784367, 4444.955550444454, 4460.977695111568, 5321.0, 5344.652597581145, 5391.67903863556, 5395.730213489388, 5457.2359869618285, 1008.7377281906611, 1013.6198925402974, 1025.8050970315617, 1027.6146445083093, 1028.2391030637275, 646.2277578293988, 653.7809833705667, 682.8122266376786, 685.530411667999, 695.079020298107, 11549.42252887369, 11768.881956214145, 11995.400229988465, 12658.556950506872, 12708.555200567936, 620.3733658109512, 654.3881470824699, 661.0711949710665, 672.6804767735384, 677.695037233247, 5490.972545137249, 5492.5605951523785, 5574.303212098488, 5595.832125036255, 5614.719264036782, 115759.0, 124014.37992809978, 127439.0, 128528.0, 128617.0, 107684.0, 111412.0, 117743.41128294304, 118291.0, 121695.0, 92084.53957730302, 95994.0, 99413.50293248487, 100268.49865750625, 101420.0, 13524.93237533806, 13614.0, 13737.175769453865, 13841.377138029015, 13874.375653095432, 45427.77286113548, 45860.770696146305, 45894.0, 46678.29982550332, 47891.52108478871, 80217.59891200741, 82488.58755706184, 84857.57571212105, 85570.57214713887, 86631.0, 19012.809871901656, 19620.215191392184, 19631.803681962996, 19712.60574788525, 20007.799922000595, 20468.38594842157, 20654.0, 20685.27601533939, 20730.75019620944, 20973.161073556887, 20381.592368152258, 20595.4851128723, 20629.484262893548, 20639.587208256053, 20668.379948601567, 19428.222871085, 19681.0, 19717.80282197217, 19728.90135549313, 19830.801691982895, 17910.5522361942, 18137.183826727563, 18158.90920545389, 19412.611747764684, 19689.409317720492, 14019.439222431396, 14255.64360890986, 14415.495457658932, 14454.566363009126, 14655.267236637912, 14925.776113358092, 15089.698206036037, 15121.09273443597, 15552.688946220786, 15591.532254032398], "value": 9570.6821687887, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1484.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 107.0, 101.0, 107.0, 107.0, 108.0, 114.0, 101.0, 109.0, 107.0], "value": 105.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 118.0, 154.0, 171.0, 123.0, 141.0, 145.0, 114.0, 163.0, 117.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 161.0, 168.0, 165.0, 162.0, 163.0, 166.0, 163.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 77.0, 75.0, 169.0, 76.0, 75.0, 78.0, 86.0, 97.0, 75.0], "value": 88.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 125.0, 79.0, 78.0, 79.0, 124.0, 81.0, 78.0, 122.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 115.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 149.0, 150.0, 149.0, 148.0, 148.0, 148.0, 152.0, 151.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 93.0, 94.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 48.0, 50.0, 49.0, 54.0, 48.0, 48.0, 56.0, 52.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 56.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 83.0, 76.0, 84.0, 77.0, 75.0, 76.0, 78.0, 77.0], "value": 77.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 136.0, 117.0, 116.0, 119.0, 125.0, 125.0, 129.0, 118.0, 175.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 159.0, 158.0, 156.0, 158.0, 168.0, 158.0, 159.0, 167.0, 165.0], "value": 160.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 61.0, 62.0, 67.0, 62.0, 64.0, 65.0, 63.0, 62.0], "value": 63.7, "unit": "score"}]}]} 17:13:29 INFO - Return code: 0 17:13:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:13:29 INFO - # TBPL SUCCESS # 17:13:29 INFO - Running post-action listener: _package_coverage_data 17:13:29 INFO - Running post-action listener: _resource_record_post_action 17:13:29 INFO - [mozharness: 2017-07-28 00:13:29.891141Z] Finished run-tests step (success) 17:13:29 INFO - Running post-run listener: _resource_record_post_run 17:13:29 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 429481984; Read time: 12; Write time: 298632 17:13:29 INFO - TinderboxPrint: CPU usage
13.1% 17:13:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:13:29 INFO - TinderboxPrint: I/O write bytes / time
429,481,984 / 298,632 17:13:29 INFO - TinderboxPrint: CPU idle
8,235.3 (86.9%) 17:13:29 INFO - TinderboxPrint: CPU user
1,190.9 (12.6%) 17:13:29 INFO - TinderboxPrint: Swap in / out
0 / 0 17:13:29 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108851200; Read time: 0; Write time: 93356 17:13:29 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:13:29 INFO - run-tests - Wall time: 1171s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320630784; Read time: 12; Write time: 205276 17:13:30 INFO - Running post-run listener: _upload_blobber_files 17:13:30 INFO - Blob upload gear active. 17:13:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:13:30 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 17:13:30 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'] 17:13:30 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 17:13:30 INFO - (blobuploader) - INFO - Open directory for files ... 17:13:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:13:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:13:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:32 INFO - (blobuploader) - INFO - Done attempting. 17:13:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:13:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:36 INFO - (blobuploader) - INFO - Done attempting. 17:13:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:13:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:13:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:37 INFO - (blobuploader) - INFO - Done attempting. 17:13:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:13:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:13:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:13:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:13:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:13:38 INFO - (blobuploader) - INFO - Done attempting. 17:13:38 INFO - (blobuploader) - INFO - Iteration through files over. 17:13:38 INFO - Return code: 0 17:13:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:13:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:13:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4e176808894690ea4ad1e79f7353c2ee8b1ef1eaaa5398985f1a100f4b961ab408aecce7963470d82ae648d28f6e3c845c121ec8821ed887208f72c97175e94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/934f8ee0f86bb88b21aad65456e23dd7015a3b0ef465a97093279190eceff7aa102a23ba31185b4e086cc598d487eedc12d88d3ae638b1eee68774c5e63b5ed6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/948e18ecd596d24320c8f04889ee210030ae078b40f930a4c97f1ef806e2f94ba763a39e6f375f81dded62a09a50645457b5ba4a2f3934b11e8034ca9f6d3cbb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6411cf288de6528dd3edafea5c6160771ce42bb5e637a59eab3ad5f32251e5efb01dd002276a5ecec796e4b8c00a59f483d04294c2803dfe1c4f87d7e4ea7e45"} 17:13:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:13:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:13:38 INFO - Contents: 17:13:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4e176808894690ea4ad1e79f7353c2ee8b1ef1eaaa5398985f1a100f4b961ab408aecce7963470d82ae648d28f6e3c845c121ec8821ed887208f72c97175e94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/934f8ee0f86bb88b21aad65456e23dd7015a3b0ef465a97093279190eceff7aa102a23ba31185b4e086cc598d487eedc12d88d3ae638b1eee68774c5e63b5ed6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/948e18ecd596d24320c8f04889ee210030ae078b40f930a4c97f1ef806e2f94ba763a39e6f375f81dded62a09a50645457b5ba4a2f3934b11e8034ca9f6d3cbb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6411cf288de6528dd3edafea5c6160771ce42bb5e637a59eab3ad5f32251e5efb01dd002276a5ecec796e4b8c00a59f483d04294c2803dfe1c4f87d7e4ea7e45"} 17:13:38 INFO - Running post-run listener: copy_logs_to_upload_dir 17:13:38 INFO - Copying logs to upload dir... 17:13:38 INFO - mkdir: /builds/slave/test/build/upload/logs 17:13:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.631891 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-27 17:13:38.500114) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 17:13:38.503163) ========= 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=923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4e176808894690ea4ad1e79f7353c2ee8b1ef1eaaa5398985f1a100f4b961ab408aecce7963470d82ae648d28f6e3c845c121ec8821ed887208f72c97175e94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/934f8ee0f86bb88b21aad65456e23dd7015a3b0ef465a97093279190eceff7aa102a23ba31185b4e086cc598d487eedc12d88d3ae638b1eee68774c5e63b5ed6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/948e18ecd596d24320c8f04889ee210030ae078b40f930a4c97f1ef806e2f94ba763a39e6f375f81dded62a09a50645457b5ba4a2f3934b11e8034ca9f6d3cbb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6411cf288de6528dd3edafea5c6160771ce42bb5e637a59eab3ad5f32251e5efb01dd002276a5ecec796e4b8c00a59f483d04294c2803dfe1c4f87d7e4ea7e45"} build_url:https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011163 build_url: 'https://queue.taskcluster.net/v1/task/HDqwD3ttRVqDaEVaA2Dx2w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d4e176808894690ea4ad1e79f7353c2ee8b1ef1eaaa5398985f1a100f4b961ab408aecce7963470d82ae648d28f6e3c845c121ec8821ed887208f72c97175e94", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/934f8ee0f86bb88b21aad65456e23dd7015a3b0ef465a97093279190eceff7aa102a23ba31185b4e086cc598d487eedc12d88d3ae638b1eee68774c5e63b5ed6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/948e18ecd596d24320c8f04889ee210030ae078b40f930a4c97f1ef806e2f94ba763a39e6f375f81dded62a09a50645457b5ba4a2f3934b11e8034ca9f6d3cbb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6411cf288de6528dd3edafea5c6160771ce42bb5e637a59eab3ad5f32251e5efb01dd002276a5ecec796e4b8c00a59f483d04294c2803dfe1c4f87d7e4ea7e45"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 17:13:38.527061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 17:13:38.527346) ========= 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=923d835db2ba3686ebe126b700000192-1501199550.871329-1560493156 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 17:13:38.610854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 17:13:38.611178) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 17:13:38.611478) ========= ========= Total master_lag: 0.29 =========