builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1501786300.87 results: success (0) revision: 36ad88e6b7b248c2f2ae59b80477e5474dd653dc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 11:51:40.866420) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-03 11:51:40.866922) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 11:51:40.867207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-03 11:51:40.960995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 11:51:40.964286) ========= 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=745a4373a2a16df560f216e000000264-1501785076.404841-901956869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-03 11:51:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.8M=0s 2017-08-03 11:51:41 (36.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154873 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 11:51:41.132656) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 11:51:41.132959) ========= 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=745a4373a2a16df560f216e000000264-1501785076.404841-901956869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018713 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 11:51:41.186035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-03 11:51:41.186377) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 36ad88e6b7b248c2f2ae59b80477e5474dd653dc --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 36ad88e6b7b248c2f2ae59b80477e5474dd653dc --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=745a4373a2a16df560f216e000000264-1501785076.404841-901956869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-03 11:51:41,425 truncating revision to first 12 chars 2017-08-03 11:51:41,425 Setting DEBUG logging. 2017-08-03 11:51:41,425 attempt 1/10 2017-08-03 11:51:41,425 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/36ad88e6b7b2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-03 11:51:42,620 unpacking tar archive at: mozilla-central-36ad88e6b7b2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.576196 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-03 11:51:42.774952) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 11:51:42.778346) ========= script_repo_revision: 36ad88e6b7b248c2f2ae59b80477e5474dd653dc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-03 11:51:42.778751) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 11:51:42.779042) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-03 11:51:42.787839) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-08-03 11:51:42.788159) ========= /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=745a4373a2a16df560f216e000000264-1501785076.404841-901956869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:51:43 INFO - MultiFileLogger online at 20170803 11:51:43 in /builds/slave/test 11:51:43 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 11:51:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:51:43 INFO - {'append_to_log': False, 11:51:43 INFO - 'base_work_dir': '/builds/slave/test', 11:51:43 INFO - 'blob_upload_branch': 'Firefox', 11:51:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:51:43 INFO - 'branch': 'Firefox', 11:51:43 INFO - 'buildbot_json_path': 'buildprops.json', 11:51:43 INFO - 'code_coverage': False, 11:51:43 INFO - 'config_files': ('talos/linux_config.py',), 11:51:43 INFO - 'default_actions': ('clobber', 11:51:43 INFO - 'read-buildbot-config', 11:51:43 INFO - 'download-and-extract', 11:51:43 INFO - 'populate-webroot', 11:51:43 INFO - 'create-virtualenv', 11:51:43 INFO - 'install', 11:51:43 INFO - 'setup-mitmproxy', 11:51:43 INFO - 'run-tests'), 11:51:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:51:43 INFO - 'disable_ccov_upload': False, 11:51:43 INFO - 'download_minidump_stackwalk': True, 11:51:43 INFO - 'download_symbols': 'ondemand', 11:51:43 INFO - 'enable_stylo': False, 11:51:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:51:43 INFO - 'tooltool.py': '/tools/tooltool.py', 11:51:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:51:43 INFO - '/tools/misc-python/virtualenv.py')}, 11:51:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:51:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:51:43 INFO - 'gecko_profile': False, 11:51:43 INFO - 'gecko_profile_interval': 0, 11:51:43 INFO - 'installer_path': 'installer.exe', 11:51:43 INFO - 'log_level': 'info', 11:51:43 INFO - 'log_name': 'talos', 11:51:43 INFO - 'log_to_console': True, 11:51:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:51:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:51:43 INFO - 'opt_config_files': (), 11:51:43 INFO - 'pip_index': False, 11:51:43 INFO - 'suite': 'dromaeojs-e10s', 11:51:43 INFO - 'system_bits': '32', 11:51:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:51:43 INFO - 'title': 'talos-linux64-ix-032', 11:51:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:51:43 INFO - 'use_talos_json': True, 11:51:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:51:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:51:43 INFO - 'work_dir': 'build'} 11:51:43 INFO - [mozharness: 2017-08-03 18:51:43.134631Z] Running clobber step. 11:51:43 INFO - Running pre-action listener: _resource_record_pre_action 11:51:43 INFO - Running main action method: clobber 11:51:43 INFO - rmtree: /builds/slave/test/build 11:51:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:51:44 INFO - Running post-action listener: _resource_record_post_action 11:51:44 INFO - [mozharness: 2017-08-03 18:51:44.665877Z] Finished clobber step (success) 11:51:44 INFO - [mozharness: 2017-08-03 18:51:44.665978Z] Running read-buildbot-config step. 11:51:44 INFO - Running pre-action listener: _resource_record_pre_action 11:51:44 INFO - Running main action method: read_buildbot_config 11:51:44 INFO - Using buildbot properties: 11:51:44 INFO - { 11:51:44 INFO - "project": "", 11:51:44 INFO - "product": "firefox", 11:51:44 INFO - "who": "gszorc@mozilla.com", 11:51:44 INFO - "installer_path": "public/build/target.tar.bz2", 11:51:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 11:51:44 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:51:44 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 11:51:44 INFO - "stage_platform": "linux64-stylo", 11:51:44 INFO - "basedir": "/builds/slave/test", 11:51:44 INFO - "buildnumber": 65, 11:51:44 INFO - "platform": "ubuntu64_hw_stylo", 11:51:44 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:51:44 INFO - "slavebuilddir": "test", 11:51:44 INFO - "taskId": "OhTuFUx7RuCp5jk9o43E8w", 11:51:44 INFO - "branch": "mozilla-central", 11:51:44 INFO - "script_repo_revision": "production", 11:51:44 INFO - "revision": "36ad88e6b7b248c2f2ae59b80477e5474dd653dc", 11:51:44 INFO - "slavename": "talos-linux64-ix-032", 11:51:44 INFO - "repo_path": "mozilla-central" 11:51:44 INFO - } 11:51:44 INFO - Finding installer, test and symbols from parent task. 11:51:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OhTuFUx7RuCp5jk9o43E8w'}, attempt #1 11:51:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OhTuFUx7RuCp5jk9o43E8w'}, attempt #1 11:51:45 INFO - Task dependencies: cLOXij6DRK-49sIx-uH2bw 11:51:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw'}, attempt #1 11:51:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.tar.bz2 11:51:46 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.test_packages.json 11:51:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.crashreporter-symbols.zip 11:51:46 INFO - Running post-action listener: _resource_record_post_action 11:51:46 INFO - [mozharness: 2017-08-03 18:51:46.023588Z] Finished read-buildbot-config step (success) 11:51:46 INFO - [mozharness: 2017-08-03 18:51:46.023811Z] Running download-and-extract step. 11:51:46 INFO - Running pre-action listener: _resource_record_pre_action 11:51:46 INFO - Running main action method: download_and_extract 11:51:46 INFO - mkdir: /builds/slave/test/build/tests 11:51:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:51:46 INFO - trying https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.test_packages.json 11:51:46 INFO - Downloading https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:51:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:51:46 INFO - Downloaded 989 bytes. 11:51:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:51:46 INFO - Using the following test package requirements: 11:51:46 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:51:46 INFO - u'common': [u'target.common.tests.zip'], 11:51:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:51:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:51:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:51:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:51:46 INFO - u'mozbase': [u'target.common.tests.zip'], 11:51:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:51:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:51:46 INFO - u'web-platform': [u'target.common.tests.zip', 11:51:46 INFO - u'target.web-platform.tests.tar.gz'], 11:51:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:51:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:51:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.common.tests.zip 11:51:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:51:46 INFO - Fetch https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.common.tests.zip into memory 11:51:47 INFO - Content-Length response header: 54278471 11:51:47 INFO - Bytes received: 54278471 11:51:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:51:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.common.tests.zip 11:51:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:51:58 INFO - Fetch https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.common.tests.zip into memory 11:51:59 INFO - Content-Length response header: 54278471 11:51:59 INFO - Bytes received: 54278471 11:52:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.talos.tests.zip 11:52:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:52:17 INFO - Fetch https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.talos.tests.zip into memory 11:52:17 INFO - Content-Length response header: 14496464 11:52:17 INFO - Bytes received: 14496464 11:52: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')]} 11:52:18 INFO - trying https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.tar.bz2 11:52:18 INFO - Downloading https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:52:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:52:19 INFO - Downloaded 62214486 bytes. 11:52:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.tar.bz2 11:52:19 INFO - mkdir: /builds/slave/test/properties 11:52:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:52:19 INFO - Writing to file /builds/slave/test/properties/build_url 11:52:19 INFO - Contents: 11:52:19 INFO - build_url:https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.tar.bz2 11:52:19 INFO - Running post-action listener: _resource_record_post_action 11:52:19 INFO - Running post-action listener: set_extra_try_arguments 11:52:19 INFO - [mozharness: 2017-08-03 18:52:19.141070Z] Finished download-and-extract step (success) 11:52:19 INFO - [mozharness: 2017-08-03 18:52:19.141169Z] Running populate-webroot step. 11:52:19 INFO - Running pre-action listener: _resource_record_pre_action 11:52:19 INFO - Running main action method: populate_webroot 11:52:19 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:52:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:52:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:52:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:52:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:52:19 INFO - 'tests': ['damp', 'tps']}, 11:52:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:52:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:52:19 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:52:19 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:52:19 INFO - 'other-e10s': {'tests': ['a11yr', 11:52:19 INFO - 'ts_paint', 11:52:19 INFO - 'tpaint', 11:52:19 INFO - 'sessionrestore', 11:52:19 INFO - 'sessionrestore_many_windows', 11:52:19 INFO - 'sessionrestore_no_auto_restore', 11:52:19 INFO - 'tabpaint']}, 11:52:19 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:52:19 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:52:19 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:52:19 INFO - 'talos_options': ['--mitmproxy', 11:52:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:52:19 INFO - '--firstNonBlankPaint'], 11:52:19 INFO - 'tests': ['quantum_pageload_google', 11:52:19 INFO - 'quantum_pageload_youtube', 11:52:19 INFO - 'quantum_pageload_amazon', 11:52:19 INFO - 'quantum_pageload_facebook']}, 11:52:19 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:52:19 INFO - 'talos_options': ['--stylo', 11:52:19 INFO - '--mitmproxy', 11:52:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:52:19 INFO - '--firstNonBlankPaint'], 11:52:19 INFO - 'tests': ['quantum_pageload_google', 11:52:19 INFO - 'quantum_pageload_youtube', 11:52:19 INFO - 'quantum_pageload_amazon', 11:52:19 INFO - 'quantum_pageload_facebook']}, 11:52:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:52:19 INFO - 'tsvgr_opacity', 11:52:19 INFO - 'tart', 11:52:19 INFO - 'tscrollx', 11:52:19 INFO - 'cart', 11:52:19 INFO - 'tsvg_static']}, 11:52:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:52:19 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:52:19 INFO - 'talos_options': ['--stylo', 11:52:19 INFO - '--stylo-threads=1', 11:52:19 INFO - '--mitmproxy', 11:52:19 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:52:19 INFO - '--firstNonBlankPaint'], 11:52:19 INFO - 'tests': ['tp6_google', 11:52:19 INFO - 'tp6_youtube', 11:52:19 INFO - 'tp6_amazon', 11:52:19 INFO - 'tp6_facebook']}, 11:52:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:52:19 INFO - 'talos_options': ['--xperf_path', 11:52:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:52:19 INFO - 'tests': ['tp5n']}}} 11:52:19 INFO - Running post-action listener: _resource_record_post_action 11:52:19 INFO - [mozharness: 2017-08-03 18:52:19.150409Z] Finished populate-webroot step (success) 11:52:19 INFO - [mozharness: 2017-08-03 18:52:19.150510Z] Running create-virtualenv step. 11:52:19 INFO - Running pre-action listener: _resource_record_pre_action 11:52:19 INFO - Running main action method: create_virtualenv 11:52:19 INFO - Creating virtualenv /builds/slave/test/build/venv 11:52:19 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 11:52:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:52:19 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:52:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:52:19 INFO - Using real prefix '/usr' 11:52:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:52:19 INFO - Installing distribute.............................................................................................................................................................................................done. 11:52:21 INFO - Installing pip.................done. 11:52:21 INFO - Return code: 0 11:52:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:52:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:52:21 INFO - Reading from file tmpfile_stdout 11:52:21 INFO - Output received: 11:52:21 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) 11:52:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:52:21 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')]} 11:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:21 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')]} 11:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:21 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 0x1f951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2161a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2301eb0>, '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 0x2302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2303240>, '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': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', '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 11:52:21 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 11:52:21 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 11:52:21 INFO - Using env: {'DISPLAY': ':0', 11:52:21 INFO - 'HOME': '/home/cltbld', 11:52:21 INFO - 'LANG': 'en_US.UTF-8', 11:52:21 INFO - 'LANGUAGE': 'en_US:en', 11:52:21 INFO - 'LOGNAME': 'cltbld', 11:52:21 INFO - 'MAIL': '/var/mail/cltbld', 11:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:21 INFO - 'MOZ_NO_REMOTE': '1', 11:52:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:21 INFO - 'NO_EM_RESTART': '1', 11:52:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:21 INFO - 'PWD': '/builds/slave/test', 11:52:21 INFO - 'SHELL': '/bin/bash', 11:52:21 INFO - 'SHLVL': '1', 11:52:21 INFO - 'TERM': 'linux', 11:52:21 INFO - 'TMOUT': '86400', 11:52:21 INFO - 'USER': 'cltbld', 11:52:21 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', 11:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:21 INFO - '_': '/tools/buildbot/bin/python'} 11:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:22 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 11:52:22 INFO - Cleaning up... 11:52:22 INFO - Return code: 0 11:52:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:22 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 0x1f951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2161a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2301eb0>, '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 0x2302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2303240>, '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': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', '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 11:52:22 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 11:52:22 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 11:52:22 INFO - Using env: {'DISPLAY': ':0', 11:52:22 INFO - 'HOME': '/home/cltbld', 11:52:22 INFO - 'LANG': 'en_US.UTF-8', 11:52:22 INFO - 'LANGUAGE': 'en_US:en', 11:52:22 INFO - 'LOGNAME': 'cltbld', 11:52:22 INFO - 'MAIL': '/var/mail/cltbld', 11:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:22 INFO - 'MOZ_NO_REMOTE': '1', 11:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:22 INFO - 'NO_EM_RESTART': '1', 11:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:22 INFO - 'PWD': '/builds/slave/test', 11:52:22 INFO - 'SHELL': '/bin/bash', 11:52:22 INFO - 'SHLVL': '1', 11:52:22 INFO - 'TERM': 'linux', 11:52:22 INFO - 'TMOUT': '86400', 11:52:22 INFO - 'USER': 'cltbld', 11:52:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', 11:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:22 INFO - '_': '/tools/buildbot/bin/python'} 11:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:22 INFO - Downloading/unpacking psutil>=3.1.1 11:52:22 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 11:52:22 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 11:52:22 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 11:52:22 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 11:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:52:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:52:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:52:23 INFO - Installing collected packages: psutil 11:52:23 INFO - Running setup.py install for psutil 11:52:23 INFO - building 'psutil._psutil_linux' extension 11:52:23 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 11:52:23 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 11:52:23 INFO - building 'psutil._psutil_posix' extension 11:52:23 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 11:52:23 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 11:52:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:52:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:52:24 INFO - Successfully installed psutil 11:52:24 INFO - Cleaning up... 11:52:24 INFO - Return code: 0 11:52:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:52: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')]} 11:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52: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')]} 11:52:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2161a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2301eb0>, '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 0x2302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2303240>, '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': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', '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 11:52: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:52: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 mozsystemmonitor==0.3 11:52:24 INFO - Using env: {'DISPLAY': ':0', 11:52:24 INFO - 'HOME': '/home/cltbld', 11:52:24 INFO - 'LANG': 'en_US.UTF-8', 11:52:24 INFO - 'LANGUAGE': 'en_US:en', 11:52:24 INFO - 'LOGNAME': 'cltbld', 11:52:24 INFO - 'MAIL': '/var/mail/cltbld', 11:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:24 INFO - 'MOZ_NO_REMOTE': '1', 11:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:24 INFO - 'NO_EM_RESTART': '1', 11:52:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:24 INFO - 'PWD': '/builds/slave/test', 11:52:24 INFO - 'SHELL': '/bin/bash', 11:52:24 INFO - 'SHLVL': '1', 11:52:24 INFO - 'TERM': 'linux', 11:52:24 INFO - 'TMOUT': '86400', 11:52:24 INFO - 'USER': 'cltbld', 11:52:24 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', 11:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:24 INFO - '_': '/tools/buildbot/bin/python'} 11:52:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:52: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 11:52: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 11:52: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 11:52: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 11:52:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:52:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:52:25 INFO - Installing collected packages: mozsystemmonitor 11:52:25 INFO - Running setup.py install for mozsystemmonitor 11:52:25 INFO - Successfully installed mozsystemmonitor 11:52:25 INFO - Cleaning up... 11:52:25 INFO - Return code: 0 11:52:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:52:25 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')]} 11:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:25 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')]} 11:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:25 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 0x1f951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2161a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2301eb0>, '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 0x2302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2303240>, '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': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', '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 11:52:25 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 11:52:25 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 11:52:25 INFO - Using env: {'DISPLAY': ':0', 11:52:25 INFO - 'HOME': '/home/cltbld', 11:52:25 INFO - 'LANG': 'en_US.UTF-8', 11:52:25 INFO - 'LANGUAGE': 'en_US:en', 11:52:25 INFO - 'LOGNAME': 'cltbld', 11:52:25 INFO - 'MAIL': '/var/mail/cltbld', 11:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:25 INFO - 'MOZ_NO_REMOTE': '1', 11:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:25 INFO - 'NO_EM_RESTART': '1', 11:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:25 INFO - 'PWD': '/builds/slave/test', 11:52:25 INFO - 'SHELL': '/bin/bash', 11:52:25 INFO - 'SHLVL': '1', 11:52:25 INFO - 'TERM': 'linux', 11:52:25 INFO - 'TMOUT': '86400', 11:52:25 INFO - 'USER': 'cltbld', 11:52:25 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', 11:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:25 INFO - '_': '/tools/buildbot/bin/python'} 11:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:25 INFO - Downloading/unpacking jsonschema==2.5.1 11:52:25 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 11:52:25 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 11:52:25 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 11:52:25 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 11:52:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:52:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:52: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 11:52: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 11:52: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 11:52: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 11:52:26 INFO - Downloading functools32-3.2.3-2.tar.gz 11:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:52:27 INFO - warning: no files found matching '*.txt' 11:52:27 INFO - no previously-included directories found matching 'build' 11:52:27 INFO - no previously-included directories found matching 'dist' 11:52:27 INFO - no previously-included directories found matching '.git*' 11:52:27 INFO - Installing collected packages: jsonschema, functools32 11:52:27 INFO - Running setup.py install for functools32 11:52:27 INFO - warning: no files found matching '*.txt' 11:52:27 INFO - no previously-included directories found matching 'build' 11:52:27 INFO - no previously-included directories found matching 'dist' 11:52:27 INFO - no previously-included directories found matching '.git*' 11:52:27 INFO - Successfully installed jsonschema functools32 11:52:27 INFO - Cleaning up... 11:52:27 INFO - Return code: 0 11:52:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:52: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')]} 11:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52: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')]} 11:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52: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', '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 0x1f951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2161a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2301eb0>, '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 0x2302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2303240>, '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': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', '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 11:52: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:52: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 functools32==3.2.3-2 11:52:27 INFO - Using env: {'DISPLAY': ':0', 11:52:27 INFO - 'HOME': '/home/cltbld', 11:52:27 INFO - 'LANG': 'en_US.UTF-8', 11:52:27 INFO - 'LANGUAGE': 'en_US:en', 11:52:27 INFO - 'LOGNAME': 'cltbld', 11:52:27 INFO - 'MAIL': '/var/mail/cltbld', 11:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:27 INFO - 'MOZ_NO_REMOTE': '1', 11:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:27 INFO - 'NO_EM_RESTART': '1', 11:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:27 INFO - 'PWD': '/builds/slave/test', 11:52:27 INFO - 'SHELL': '/bin/bash', 11:52:27 INFO - 'SHLVL': '1', 11:52:27 INFO - 'TERM': 'linux', 11:52:27 INFO - 'TMOUT': '86400', 11:52:27 INFO - 'USER': 'cltbld', 11:52:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', 11:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:27 INFO - '_': '/tools/buildbot/bin/python'} 11:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:52:27 INFO - Cleaning up... 11:52:27 INFO - Return code: 0 11:52:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:52: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')]} 11:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52: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')]} 11:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52: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', '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 0x1f951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2161a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2301eb0>, '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 0x2302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2303240>, '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': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', '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 11:52: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:52: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 blobuploader==1.2.4 11:52:27 INFO - Using env: {'DISPLAY': ':0', 11:52:27 INFO - 'HOME': '/home/cltbld', 11:52:27 INFO - 'LANG': 'en_US.UTF-8', 11:52:27 INFO - 'LANGUAGE': 'en_US:en', 11:52:27 INFO - 'LOGNAME': 'cltbld', 11:52:27 INFO - 'MAIL': '/var/mail/cltbld', 11:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:27 INFO - 'MOZ_NO_REMOTE': '1', 11:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:27 INFO - 'NO_EM_RESTART': '1', 11:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:27 INFO - 'PWD': '/builds/slave/test', 11:52:27 INFO - 'SHELL': '/bin/bash', 11:52:27 INFO - 'SHLVL': '1', 11:52:27 INFO - 'TERM': 'linux', 11:52:27 INFO - 'TMOUT': '86400', 11:52:27 INFO - 'USER': 'cltbld', 11:52:27 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', 11:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:27 INFO - '_': '/tools/buildbot/bin/python'} 11:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:27 INFO - Downloading/unpacking blobuploader==1.2.4 11:52: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 11:52: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 11:52: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 11:52: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 11:52:28 INFO - Downloading blobuploader-1.2.4.tar.gz 11:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:52:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:52: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 11:52: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 11:52: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 11:52: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 11:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:52:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:52: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 11:52: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 11:52: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 11:52: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 11:52:29 INFO - Downloading docopt-0.6.1.tar.gz 11:52:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:52:29 INFO - Installing collected packages: blobuploader, requests, docopt 11:52:29 INFO - Running setup.py install for blobuploader 11:52:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:52:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:52:29 INFO - Running setup.py install for requests 11:52:29 INFO - Running setup.py install for docopt 11:52:29 INFO - Successfully installed blobuploader requests docopt 11:52:29 INFO - Cleaning up... 11:52:29 INFO - Return code: 0 11:52:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52: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')]} 11:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52: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')]} 11:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:29 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 0x1f951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2161a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2301eb0>, '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 0x2302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2303240>, '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': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', '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 11:52:29 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 11:52:29 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 11:52:29 INFO - Using env: {'DISPLAY': ':0', 11:52:29 INFO - 'HOME': '/home/cltbld', 11:52:29 INFO - 'LANG': 'en_US.UTF-8', 11:52:29 INFO - 'LANGUAGE': 'en_US:en', 11:52:29 INFO - 'LOGNAME': 'cltbld', 11:52:29 INFO - 'MAIL': '/var/mail/cltbld', 11:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:29 INFO - 'MOZ_NO_REMOTE': '1', 11:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:29 INFO - 'NO_EM_RESTART': '1', 11:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:29 INFO - 'PWD': '/builds/slave/test', 11:52:29 INFO - 'SHELL': '/bin/bash', 11:52:29 INFO - 'SHLVL': '1', 11:52:29 INFO - 'TERM': 'linux', 11:52:29 INFO - 'TMOUT': '86400', 11:52:29 INFO - 'USER': 'cltbld', 11:52:29 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', 11:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:29 INFO - '_': '/tools/buildbot/bin/python'} 11:52:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:52:30 INFO - Running setup.py (path:/tmp/pip-N6PH9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:52:30 INFO - Running setup.py (path:/tmp/pip-GKSTBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:52:30 INFO - Running setup.py (path:/tmp/pip-wkuQrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:52:30 INFO - Running setup.py (path:/tmp/pip-xLM_Xs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:52:30 INFO - Running setup.py (path:/tmp/pip-S2zs4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:52:30 INFO - Running setup.py (path:/tmp/pip-i3wIOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:52:30 INFO - Running setup.py (path:/tmp/pip-udOu2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:52:30 INFO - Running setup.py (path:/tmp/pip-Tiw3mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:52:30 INFO - Running setup.py (path:/tmp/pip-GRf1Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:52:30 INFO - Running setup.py (path:/tmp/pip-zHf_p2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:52:30 INFO - Running setup.py (path:/tmp/pip-3M5ZXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:52:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:52:30 INFO - Running setup.py (path:/tmp/pip-lj4wMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:52:31 INFO - Running setup.py (path:/tmp/pip-SOrBZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:52:31 INFO - Running setup.py (path:/tmp/pip-OOkErG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:31 INFO - Running setup.py (path:/tmp/pip-IKodjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:52:31 INFO - Running setup.py (path:/tmp/pip-_Fu37j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:52:31 INFO - Running setup.py (path:/tmp/pip-Zd9221-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:52:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:52:31 INFO - Running setup.py install for manifestparser 11:52:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:52:31 INFO - Running setup.py install for mozcrash 11:52:31 INFO - Running setup.py install for mozdebug 11:52:31 INFO - Running setup.py install for mozdevice 11:52:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:52:31 INFO - Running setup.py install for mozfile 11:52:31 INFO - Running setup.py install for mozhttpd 11:52:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:52:31 INFO - Running setup.py install for mozinfo 11:52:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:52:32 INFO - Running setup.py install for mozInstall 11:52:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:52:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:52:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:52:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:52:32 INFO - Running setup.py install for mozleak 11:52:32 INFO - Running setup.py install for mozlog 11:52:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:52:32 INFO - Running setup.py install for moznetwork 11:52:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:52:32 INFO - Running setup.py install for mozprocess 11:52:32 INFO - Running setup.py install for mozprofile 11:52:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:52:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:52:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:52:32 INFO - Running setup.py install for mozrunner 11:52:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:52:32 INFO - Running setup.py install for mozscreenshot 11:52:32 INFO - Running setup.py install for moztest 11:52:33 INFO - Running setup.py install for mozversion 11:52:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:52:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:52:33 INFO - Cleaning up... 11:52:33 INFO - Return code: 0 11:52:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52:33 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')]} 11:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:33 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')]} 11:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:33 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 0x1f951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2161a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2301eb0>, '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 0x2302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2303240>, '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': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', '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 11:52:33 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 11:52:33 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 11:52:33 INFO - Using env: {'DISPLAY': ':0', 11:52:33 INFO - 'HOME': '/home/cltbld', 11:52:33 INFO - 'LANG': 'en_US.UTF-8', 11:52:33 INFO - 'LANGUAGE': 'en_US:en', 11:52:33 INFO - 'LOGNAME': 'cltbld', 11:52:33 INFO - 'MAIL': '/var/mail/cltbld', 11:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:33 INFO - 'MOZ_NO_REMOTE': '1', 11:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:33 INFO - 'NO_EM_RESTART': '1', 11:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:33 INFO - 'PWD': '/builds/slave/test', 11:52:33 INFO - 'SHELL': '/bin/bash', 11:52:33 INFO - 'SHLVL': '1', 11:52:33 INFO - 'TERM': 'linux', 11:52:33 INFO - 'TMOUT': '86400', 11:52:33 INFO - 'USER': 'cltbld', 11:52:33 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', 11:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:33 INFO - '_': '/tools/buildbot/bin/python'} 11:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:52:33 INFO - Running setup.py (path:/tmp/pip-60nE_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:52:33 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)) 11:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:52:33 INFO - Running setup.py (path:/tmp/pip-Xurrsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:52:33 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)) 11:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:52:33 INFO - Running setup.py (path:/tmp/pip-tjXtyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:52:33 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)) 11:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:52:33 INFO - Running setup.py (path:/tmp/pip-_mOYI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:52:33 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)) 11:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:52:33 INFO - Running setup.py (path:/tmp/pip-5Be7Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:52:33 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)) 11:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:52:33 INFO - Running setup.py (path:/tmp/pip-iL6sWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:52:33 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)) 11:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:52:33 INFO - Running setup.py (path:/tmp/pip-PEIXoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:52:33 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)) 11:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:52:33 INFO - Running setup.py (path:/tmp/pip-rdYuwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:52:33 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)) 11:52:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:52:33 INFO - Running setup.py (path:/tmp/pip-Pe7WtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:52:34 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)) 11:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:52:34 INFO - Running setup.py (path:/tmp/pip-u53qfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:52:34 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)) 11:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:52:34 INFO - Running setup.py (path:/tmp/pip-kMB0IS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:52:34 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)) 11:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:52:34 INFO - Running setup.py (path:/tmp/pip-51xbVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:52:34 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)) 11:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:52:34 INFO - Running setup.py (path:/tmp/pip-xXkfsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:52:34 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)) 11:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:52:34 INFO - Running setup.py (path:/tmp/pip-siY_0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:52:34 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)) 11:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:34 INFO - Running setup.py (path:/tmp/pip-V690As-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:52:34 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)) 11:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:52:34 INFO - Running setup.py (path:/tmp/pip-0R_MiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:52:34 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)) 11:52:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:52:34 INFO - Running setup.py (path:/tmp/pip-7C282E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:52:34 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)) 11:52:34 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)) 11:52:34 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)) 11:52:34 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)) 11:52:34 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)) 11:52:34 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)) 11:52:34 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)) 11:52:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:52:34 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 11:52:34 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 11:52:34 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 11:52:34 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 11:52:35 INFO - Downloading blessings-1.6.tar.gz 11:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:52:35 INFO - Installing collected packages: blessings 11:52:35 INFO - Running setup.py install for blessings 11:52:35 INFO - Successfully installed blessings 11:52:35 INFO - Cleaning up... 11:52:35 INFO - Return code: 0 11:52:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:52:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:52:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:52:36 INFO - Reading from file tmpfile_stdout 11:52:36 INFO - Current package versions: 11:52:36 INFO - argparse == 1.2.1 11:52:36 INFO - blessings == 1.6 11:52:36 INFO - blobuploader == 1.2.4 11:52:36 INFO - docopt == 0.6.1 11:52:36 INFO - functools32 == 3.2.3-2 11:52:36 INFO - jsonschema == 2.5.1 11:52:36 INFO - manifestparser == 1.1 11:52:36 INFO - mozInstall == 1.13 11:52:36 INFO - mozcrash == 1.0 11:52:36 INFO - mozdebug == 0.1 11:52:36 INFO - mozdevice == 0.51 11:52:36 INFO - mozfile == 1.2 11:52:36 INFO - mozhttpd == 0.7 11:52:36 INFO - mozinfo == 0.10 11:52:36 INFO - mozleak == 0.1 11:52:36 INFO - mozlog == 3.5 11:52:36 INFO - moznetwork == 0.27 11:52:36 INFO - mozprocess == 0.25 11:52:36 INFO - mozprofile == 0.28 11:52:36 INFO - mozrunner == 6.13 11:52:36 INFO - mozscreenshot == 0.1 11:52:36 INFO - mozsystemmonitor == 0.3 11:52:36 INFO - moztest == 0.8 11:52:36 INFO - mozversion == 1.4 11:52:36 INFO - psutil == 3.1.1 11:52:36 INFO - requests == 1.2.3 11:52:36 INFO - wsgiref == 0.1.2 11:52:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:52:36 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')]} 11:52:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52:36 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')]} 11:52:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:36 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 0x1f951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2161a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2301eb0>, '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 0x2302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2303240>, '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': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', '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 11:52:36 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 11:52:36 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 11:52:36 INFO - Using env: {'DISPLAY': ':0', 11:52:36 INFO - 'HOME': '/home/cltbld', 11:52:36 INFO - 'LANG': 'en_US.UTF-8', 11:52:36 INFO - 'LANGUAGE': 'en_US:en', 11:52:36 INFO - 'LOGNAME': 'cltbld', 11:52:36 INFO - 'MAIL': '/var/mail/cltbld', 11:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:36 INFO - 'MOZ_NO_REMOTE': '1', 11:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:36 INFO - 'NO_EM_RESTART': '1', 11:52:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:36 INFO - 'PWD': '/builds/slave/test', 11:52:36 INFO - 'SHELL': '/bin/bash', 11:52:36 INFO - 'SHLVL': '1', 11:52:36 INFO - 'TERM': 'linux', 11:52:36 INFO - 'TMOUT': '86400', 11:52:36 INFO - 'USER': 'cltbld', 11:52:36 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', 11:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:36 INFO - '_': '/tools/buildbot/bin/python'} 11:52:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:36 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)) 11:52:36 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)) 11:52:36 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)) 11:52:36 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)) 11:52:36 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)) 11:52:36 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)) 11:52:36 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)) 11:52:36 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)) 11:52:36 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)) 11:52:36 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:52: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 11:52: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 11:52: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 11:52: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 11:52:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:52:37 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)) 11:52:37 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)) 11:52:37 INFO - Installing collected packages: simplejson 11:52:37 INFO - Running setup.py install for simplejson 11:52:37 INFO - building 'simplejson._speedups' extension 11:52:37 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 11:52:38 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 11:52:38 INFO - Successfully installed simplejson 11:52:38 INFO - Cleaning up... 11:52:38 INFO - Return code: 0 11:52:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:52: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')]} 11:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:52: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')]} 11:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:52:38 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 0x1f951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2161a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2304d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2301eb0>, '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 0x2302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2303240>, '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': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', '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 11:52:38 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 11:52:38 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 11:52:38 INFO - Using env: {'DISPLAY': ':0', 11:52:38 INFO - 'HOME': '/home/cltbld', 11:52:38 INFO - 'LANG': 'en_US.UTF-8', 11:52:38 INFO - 'LANGUAGE': 'en_US:en', 11:52:38 INFO - 'LOGNAME': 'cltbld', 11:52:38 INFO - 'MAIL': '/var/mail/cltbld', 11:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:38 INFO - 'MOZ_NO_REMOTE': '1', 11:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:38 INFO - 'NO_EM_RESTART': '1', 11:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:38 INFO - 'PWD': '/builds/slave/test', 11:52:38 INFO - 'SHELL': '/bin/bash', 11:52:38 INFO - 'SHLVL': '1', 11:52:38 INFO - 'TERM': 'linux', 11:52:38 INFO - 'TMOUT': '86400', 11:52:38 INFO - 'USER': 'cltbld', 11:52:38 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', 11:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:38 INFO - '_': '/tools/buildbot/bin/python'} 11:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:52:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:52:38 INFO - Cleaning up... 11:52:38 INFO - Return code: 0 11:52:38 INFO - Running post-action listener: _resource_record_post_action 11:52:38 INFO - Running post-action listener: _start_resource_monitoring 11:52:38 INFO - Starting resource monitoring. 11:52:38 INFO - [mozharness: 2017-08-03 18:52:38.846894Z] Finished create-virtualenv step (success) 11:52:38 INFO - [mozharness: 2017-08-03 18:52:38.847399Z] Running install step. 11:52:38 INFO - Running pre-action listener: _resource_record_pre_action 11:52:38 INFO - Running main action method: install 11:52:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:52:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:52:39 INFO - Reading from file tmpfile_stdout 11:52:39 INFO - Detecting whether we're running mozinstall >=1.0... 11:52:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:52:39 INFO - Reading from file tmpfile_stdout 11:52:39 INFO - Output received: 11:52:39 INFO - Usage: mozinstall [options] installer 11:52:39 INFO - Options: 11:52:39 INFO - -h, --help show this help message and exit 11:52:39 INFO - -d DEST, --destination=DEST 11:52:39 INFO - Directory to install application into. [default: 11:52:39 INFO - "/builds/slave/test"] 11:52:39 INFO - --app=APP Application being installed. [default: firefox] 11:52:39 INFO - mkdir: /builds/slave/test/build/application 11:52:39 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'] 11:52:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:52:57 INFO - Reading from file tmpfile_stdout 11:52:57 INFO - Output received: 11:52:57 INFO - /builds/slave/test/build/application/firefox/firefox 11:52:57 INFO - Running post-action listener: _resource_record_post_action 11:52:57 INFO - [mozharness: 2017-08-03 18:52:57.263472Z] Finished install step (success) 11:52:57 INFO - [mozharness: 2017-08-03 18:52:57.263816Z] Running setup-mitmproxy step. 11:52:57 INFO - Running pre-action listener: _resource_record_pre_action 11:52:57 INFO - Running main action method: setup_mitmproxy 11:52:57 INFO - Skipping: mitmproxy is not required 11:52:57 INFO - Running post-action listener: _resource_record_post_action 11:52:57 INFO - [mozharness: 2017-08-03 18:52:57.265490Z] Finished setup-mitmproxy step (success) 11:52:57 INFO - [mozharness: 2017-08-03 18:52:57.265818Z] Running run-tests step. 11:52:57 INFO - Running pre-action listener: _resource_record_pre_action 11:52:57 INFO - Running pre-action listener: _set_gcov_prefix 11:52:57 INFO - Running main action method: run_tests 11:52:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:52:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:52:57 INFO - Python 2.7.3 11:52:57 INFO - Return code: 0 11:52:57 INFO - grabbing minidump binary from tooltool 11:52:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:52:57 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 0x2301eb0>, '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 0x2302db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2303240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:52:57 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 11:52:57 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 11:52:57 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 11:52:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:52:57 INFO - Return code: 0 11:52:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:52:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:52:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:52:57 INFO - ENV: RUST_BACKTRACE is now 1 11:52:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:52:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:52:57 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/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 11:52:57 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/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 11:52:57 INFO - Using env: {'DISPLAY': ':0', 11:52:57 INFO - 'HOME': '/home/cltbld', 11:52:57 INFO - 'LANG': 'en_US.UTF-8', 11:52:57 INFO - 'LANGUAGE': 'en_US:en', 11:52:57 INFO - 'LOGNAME': 'cltbld', 11:52:57 INFO - 'MAIL': '/var/mail/cltbld', 11:52:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:52:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:52:57 INFO - 'MOZ_NO_REMOTE': '1', 11:52:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:52:57 INFO - 'NO_EM_RESTART': '1', 11:52:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:52:57 INFO - 'PWD': '/builds/slave/test', 11:52:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:52:57 INFO - 'RUST_BACKTRACE': '1', 11:52:57 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:52:57 INFO - 'SHELL': '/bin/bash', 11:52:57 INFO - 'SHLVL': '1', 11:52:57 INFO - 'STYLO_FORCE_ENABLED': '1', 11:52:57 INFO - 'TERM': 'linux', 11:52:57 INFO - 'TMOUT': '86400', 11:52:57 INFO - 'USER': 'cltbld', 11:52:57 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1501785076.404841-901956869', 11:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:52:57 INFO - '_': '/tools/buildbot/bin/python'} 11:52:57 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/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 11:52:57 INFO - mozversion application_buildid: 20170803181106 11:52:57 INFO - mozversion application_changeset: 36ad88e6b7b248c2f2ae59b80477e5474dd653dc 11:52:57 INFO - mozversion application_display_name: Nightly 11:52:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:52:57 INFO - mozversion application_name: Firefox 11:52:57 INFO - mozversion application_remotingname: firefox 11:52:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:52:57 INFO - mozversion application_vendor: Mozilla 11:52:57 INFO - mozversion application_version: 57.0a1 11:52:57 INFO - mozversion platform_buildid: 20170803181106 11:52:57 INFO - mozversion platform_changeset: 36ad88e6b7b248c2f2ae59b80477e5474dd653dc 11:52:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:52:57 INFO - mozversion platform_version: 57.0a1 11:52:57 INFO - using testdate: 1501786377 11:52:57 INFO - actual date: 1501786377 11:52:57 INFO - starting webserver on 'localhost:58081' 11:52:57 INFO - SUITE-START | Running 2 tests 11:52:57 INFO - TEST-START | dromaeo_css 11:52:57 INFO - Initialising browser for dromaeo_css test... 11:52:57 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58081/getInfo.html -profile /tmp/tmpXoO_aM/profile 11:52:57 INFO - TEST-INFO | started process 10908 (/builds/slave/test/build/application/firefox/firefox http://localhost:58081/getInfo.html) 11:53:04 INFO - TEST-INFO | 10908: exit 0 11:53:04 INFO - Browser initialized. 11:53:04 INFO - Running cycle 1/1 for dromaeo_css test... 11:53:04 INFO - TEST-INFO | started process 11132 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXoO_aM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:53:05 INFO - PID 11132 | 11:53:05 INFO - PID 11132 | (/builds/slave/test/build/application/firefox/firefox:11186): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:53:05 INFO - PID 11132 | 11:53:15 INFO - PID 11132 | RSS: Main: 174391296 11:53:15 INFO - PID 11132 | 11:56:14 INFO - PID 11132 | Cycle 1(1): loaded http://localhost:58081/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58081/tests/dromaeo/cssquery-ext.html) 11:56:15 INFO - PID 11132 | RSS: Main: 176111616 11:56:15 INFO - PID 11132 | 11:59:17 INFO - PID 11132 | Cycle 1(1): loaded http://localhost:58081/tests/dromaeo/cssquery-ext.html (next: http://localhost:58081/tests/dromaeo/cssquery-jquery.html) 11:59:18 INFO - PID 11132 | RSS: Main: 173809664 11:59:18 INFO - PID 11132 | 12:02:20 INFO - PID 11132 | Cycle 1(1): loaded http://localhost:58081/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58081/tests/dromaeo/cssquery-mootools.html) 12:02:20 INFO - PID 11132 | RSS: Main: 175702016 12:02:20 INFO - PID 11132 | 12:05:22 INFO - PID 11132 | Cycle 1(1): loaded http://localhost:58081/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58081/tests/dromaeo/cssquery-prototype.html) 12:05:23 INFO - PID 11132 | RSS: Main: 174370816 12:05:23 INFO - PID 11132 | 12:08:26 INFO - PID 11132 | Cycle 1(1): loaded http://localhost:58081/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58081/tests/dromaeo/cssquery-yui.html) 12:08:27 INFO - PID 11132 | RSS: Main: 177418240 12:08:27 INFO - PID 11132 | 12:11:29 INFO - PID 11132 | Cycle 1(1): loaded http://localhost:58081/tests/dromaeo/cssquery-yui.html (next: http://localhost:58081/tests/dromaeo/cssquery-dojo.html) 12:11:29 INFO - PID 11132 | RSS: Main: 178167808 12:11:29 INFO - PID 11132 | 12:11:29 INFO - PID 11132 | __start_tp_report 12:11:29 INFO - PID 11132 | _x_x_mozilla_page_load 12:11:29 INFO - PID 11132 | _x_x_mozilla_page_load_details 12:11:29 INFO - PID 11132 | |i|pagename|runs| 12:11:29 INFO - PID 11132 | |0;dojo.html;3103.5344698295266;3129.139486641172;3138.529220616908;3159.6998285162913;3163.5571020057196;6076.270847498296;6315.589486683362;6325.209348831396;6334.651594162319;6342.46089082428;6149.723262453189;6262.0919966604815;6262.185915830947;6273.56085074045;6293.748250070003;5675.801346952858;5730.828075157741;5753.913691294634;5758.481736643701;5862.296524417055;5757.337906140806;5813.040848260032;5837.066069428893;5843.415658434144;5848.561357898154;129.27315162212338;5685.573581981347;5750.281214848144;5781.739821708013;5805.216295800055;5639.436056394369;5641.435856414367;5651;5709.514691251248;5712;5577.2191893135;5591.916121258144;5661.547076233891;5667.829965101054;5701.945140149086;5978.970105149447;6089.8173054807985;6150.96924515379;6179.907301390483;6189.690515474208;6565.606063636197;6610.9669451652435;6616.933830661728;6653.401193892573;6708.12794336738;6673.199216094051;6685.298043705438;6766.729330826761;6781.762638307685;6788.558743681645;6145.78489752861;6220.098085777582;6264.310925798159;6328.968355158195;6343.587666801689;6964.825879352956;6967.8606427871155;6970.093887794555;6976.127984002;6983.266756990544;6609.504287178481;6659.6670166491485;6672.666366681647;6688.39804417595;6697.799066028027;6604.1084453599115;6686.13080299558;6774.593524388552;6785.253622101565;6794.388505034571;6592.571482853599;6667.733290668416;6688.765893193715;6689.598624082473;6707.0610114584;6617.900731489031;6676.6327851967635;6677.599344039373;6700.899486507707;6707.899381509281;5315.707636079976;5346.679199248058;5346.732663366894;5348.224507446398;5385.461453854583;4577.679562430598;4589.586937175603;4602.493725690171;4606.170889239902;4609.838655647036;5123.129068058439;5777.913331300034;5850.765969361178;5900.085486749561;5901.380355062743;6733.6296503692765;6743.393094621508;6843.520953533304;6860.828479288058;6865.210500792373;5715.114157305541;5777.133429985536;5778.508826749689;5792.102224155263;5796;5880.558958078162;5887.234659494324;5889.852753681193;5890.322612899486;5910.202122713465;6445.709943052574;6480;6508.479321654351;6526.902096468557;6535.607863528204;6705.094812200486;6724.630145342053;6733.225679046972;6779.322067793379;6823;6492.870142597028;6499.5125365598715;6500;6594.307597702172;6626.337366263528;6529.053287273414;6580.407763301326;6585.341465853377;6586.571872828251;6595.736170553124;6674.299198584079;6687.63218022994;6692.899606505809;6710.765123220664;6725.293844146294;6403.903941440789;6432.163818703539;6443.259025212161;6454.967725161344;6535.117759102461;6425.357464253537;6431.453326467303;6482;6531.771388001397;6532.967335163484;6262.749490020348;6352.237731472253;6371.808845734636;6371.936280637135;6464.256610489854;6482.708278127401;6508.967455162694;6527.694461107702;6558.1802274715665;6616.66916654175;6265.342139075514;6324.146240257506;6328.588641738273;6365.045243213555;6461.515386345949 12:11:29 INFO - PID 11132 | |1;ext.html;830.5265998380921;850.6894983331078;880.2693764175734;888.8622263549148;893.4773157702746;43957.340639890426;44513.55486445135;44904.55095449045;44931.10137797242;45194.774026129824;39222.80388598053;39794.40308395369;39842.601573984255;39961;39985.800070999605;6915.273896240885;7038.824029399255;7041.366277035066;7055.682494287769;7062.717491300342;7145.499815012951;7232.529885557422;7233.855322893539;7234.819129521751;7242.529235599669;7733.381329493627;7924.247196516321;7927.088384835732;7947.761567152995;7965.840683186333;7802.33680137189;7853.685852565891;7889.723859664884;7903.723369682033;7916.287534121928;7596.08846938371;7671.156172820985;7800.843983120306;7837.725679601243;7845.450818442711;41153.79423102895;41282.38076428856;41345.1730965379;41476.37785433221;41517.58482415167;3604.5854726706502;3663.8351274192723;3672.57765356982;3682.263547290526;3688.6680198782237;31842.36315273705;32103;32323.51514727281;32358.676413236037;32362;4979.203327467588;4989.476105008958;5003.899142188713;5018.949810501885;5028.899422011576;230365;232195;232367;232482;234361;52649.473505265225;52838.73580632072;52846.73576632169;52946.73526632342;53084;54285;54697.72651136798;56245.156322655195;57321.42678573161;57369;17321.7401738974;17414.564635884206;17481.125943702766;17484.038377889337;17490.125493725263;14489.420423182955;14498.927505362406;14528.128312301296;14532.200728960008;14543;14648.633784155481;14716.779248311284;14735.631609209855;14757.409703611735;14845.183514906785;5716.114002329646;5828.883422331614;5861.150133230658;5873.445051402654;6003.969980150071;1014.3761586624321;1019.8980101989741;1024.513356155835;1030.4281123976266;1036.4196050211906;23973.400664983164;24025.7597424027;24070.51858962811;24225.878870605888;29691.257718556775;1114.0975809594254;1123.337231033694;1124.3197865291545;1125.6848082536903;1140.6064907606863;12728.681782955315;12879.613611591667;12934.41795119222;12943.741125177632;12948.546800861925;241286;243405;243530;243570;246191;56902;57174.42825571774;57175.14237286444;57246.14130788042;59219.11171332433;1481.7851411545266;1484.1317829070115;1509.1473317575535;1515.1515151515187;1518.58238984278;28517.714822851507;28738.281542961595;28783.712162878102;28840.711592883803;29470.557941631323;55181;55468.44531554794;55591.16613250886;55781.72109139428;55935.720321398134;221228;224238;224314;224440;224461;37861;38011.619883800806;40369.39445908255;40674.1865162701;40896;49009.50990490192;50635.24047139222;50693.23960140527;50742.492575073775;51169;36102;36216.63783362238;36368.81815590905;36392.27215455729;36457.270854583294;34732.47901281533;35574.28851423009;36100.81949590235;36123.458148127276;36241.27517449584;39986.20027599374;40002;40043.79978100091;40214.396784047676;40255.1948961025;34642.65357346394;34715.30569388648;34757.47863781995;35120.824395877855;35253.647463525034;23713.40716482102;25299.620505692797;25502.489950201263;25704.871475642503;25718.742812571636 12:11:29 INFO - PID 11132 | |2;jquery.html;565.8245943757436;575.4906907386961;575.6632370063512;585.1515302810924;604.5858586867995;22726.318210453694;23590.646140307887;23616.645750313717;23629;23648.172313969015;24180.27459176223;25210.621840672404;26469;26671.599926001127;26796.598051029203;6527.445167160797;6729.427998620124;6737.461003119739;6741.393274605284;6746.797596072126;6294.43350098491;6570.310117437672;6621.9006714899315;6635.706037322724;6640.734370625193;6537.280899101119;6541.31316211798;6541.443977261914;6542.803715888531;6547.279799222082;6516.348365163493;6536.93463065368;6543.803685889431;6546.93453065468;6546.999999999976;6042.546808989343;6088.573799834014;6094.786682466137;6097.908531372033;6112.480439162677;29895.850520747255;30278;30510.237244068852;30530.694693053007;31209;1864.123861784959;1897.7817550981677;1906.74258975038;1908.3702378215155;1913.0147973793507;18403.72394414085;18926;18958.336458223897;18958.71561926572;18978.240870365167;2304.320225533472;2311.191083120911;2346.9530609387716;2354.1407386304045;2431.9148829790875;136831;138148;139744;140613;141183;14969.476068337555;15074.397024119131;15342.539723808304;15554.144522051169;15594;23790.286291411285;23930.52138957211;23971.400714982265;23976.64035039476;24015.279541613778;10382.636607718694;10684.115288872117;10692.946535267429;10693.732656683645;10723.088537474401;9926.80146397068;10002;10101.94949025265;10199.28604997643;10238.33450825694;7918.366530677532;11642.417879106011;11817.527298907948;12050.939745301217;12379.93810030944;4039.5758445362812;4142.689298302639;4310.719803212781;4322.178786030644;4357.2592659248;948.5873644964463;967.6775738228308;967.9032096790264;971.2666936462925;976.3604838830578;19223.807761922482;19325.710114348298;19695.60608787816;19954.30159944395;20257;992.7518120469882;1024.416082832793;1036.2538971940191;1043.8277684182026;1047.2564479219686;10636.946815265874;10681.198910081775;10916.181286403551;11004.669859904216;11026.558937642405;526154;528922;545688;549451;555436;127783.36108319585;128604.3569782145;129597.35201323933;129823.35088324497;130421.34789325992;1263.7219811641423;1282.9294388808705;1303.328785675378;1307.9280639564724;1314.0538812055304;21123.310135189455;21135.788642113996;21269.89365053165;21448.142074316853;21774.673379899;59337.10994335002;60076.69961650164;60528;61477;62601.373986259554;74879;75008.24991750013;75068;75301;75457.62271188608;14756.926215368854;14776.187309698069;14838.035527690665;14866.479673211386;14869.405223790927;23440.296791096294;23762;23792.286231413087;23822.404439889142;23903.76096239015;18741.250349985847;18835;18887.150078246235;18930.337438189596;19176.328828490936;15121.924390377977;15591.922040389725;15601.375944962074;15728.92135539315;17321.30714771395;20102.698459522828;20439.18243270312;20519.076641550866;20612.690809638167;20709.896450517652;15067.698646026798;15246.237688115329;15291.388344466097;15301.234938252821;15463.149526775685;18386.172622232298;19456.902715486332;19548.706769398184;19692.11385487628;19740.60518789645 12:11:29 INFO - PID 11132 | |3;mootools.html;1334.3194970565012;1400.5378225185689;1406.0790182430512;1423.0826805049649;1428.5143051362534;12283.263004219752;13660.31698415079;14353.712925741478;14411.91910606706;14427.134371937691;12097.09271804616;13784.104033237832;14292.213928233943;14302.92848535756;14308.71382572348;2593.9351516212055;2683.436478339551;2706.512827691015;2715.850628215447;2717.184844546638;2633.76296133348;2773.9167824965284;2775.9167224983285;2778.111004478568;2779.346853489428;2689.610006549049;2722.48272828163;2762.9723702763017;2764.1707487753692;2778.2498725344144;2616.6859976802716;2654.21700598322;2659.0959073914864;2672.425428532865;2675.3980354420196;2647.5234457797587;2667.2665017120253;2675.2375572961805;2676.2372723773633;2678.183154137987;13757.724845503133;14056.437742490289;14088.084274522123;14094.788578171336;14126.293685315795;7382.741604043833;7595.772126836148;7633.770986870402;7633.9618301908695;7637.732679356196;5160.56135228506;5309.707966061865;5371.4897084776885;5442.619016668835;5460.563154947595;1816.0556510614406;1825.8539316854753;1832.0839580209895;1864.263615871723;1868.271374164077;23370.182043628392;23642.408939776473;23707.88146059276;23742.762572374228;23766.287011389686;7111.608861512666;7198.2004498875285;7264.745733899394;7324.304191101837;7383.409327253807;15673.921630391775;15967.600809979844;15971.520854374387;15988.440404585785;16029.759553606706;7398.741044063432;7593.734219302298;7599.5060321080055;7603.0876294844975;7604.885926711104;6956.930430695729;7057.435405167575;7126.928730712731;7145.39264162552;7212.963935180395;4870.537298956664;4983.8504844854715;5009.248612708123;5010.548786266126;5026.421961474477;1548.7599422089595;1549.7133030389414;1563.882708796822;1568.9096078225523;1581.6362236685627;904.2856143646577;933.2254228989922;947.1475671895349;947.9857802132974;957.5164541906292;7472.701091956261;7502.587357695379;7513.586752728543;7523;7543.1325397578885;736.0762243384626;742.1279996004781;746.861830561337;747.6859718918067;748.4947660329256;4709.246520556694;4732.408448943882;4768.332433459318;4783.330333753277;4804.015176888729;19394.127264273142;20102.39692809218;20133.697994530095;20178.899105504377;20360.18559257643;18336.724949125775;18627.627447450974;19461.416157515298;19768;19772.802271977383;10747.83878241827;10948.781024379308;10954.890451095547;11000.834987475195;11036.061934735637;8140.308073813792;8307.252347288773;8311.792205194919;8567.91432085696;8760.342974276828;16272.67454650924;16796.328146873988;16840.15799210059;16891.91554042222;16957.406490773257;17188.140592970052;17338.653226935137;17379.304827806747;17434.302627894744;17636.118194089988;12827;12992.090553661154;13045.086843921214;13101.213927164401;13330.866691332962;12957.740845182854;13305.600831975056;13307.600771976857;13308.001899857743;13308.40112194973;10458.424786636808;10563.52464139131;10617.469126543796;10727.249092563447;10986.505607247533;10404.271700981162;10507.632232872118;10592.046715795308;10624.36253824742;10754.247202695737;9382.530873456164;9407.294452915921;9420.905790942277;9421.29340299494;9501.144896959308;7338.192798792235;7395.149557800706;7408.703651853865;7450.962745186456;7456.888146677913;7426.591537465275;7429.888551671837;7452.292032256927;7454.701811927463;7525.473216874985 12:11:29 INFO - PID 11132 | |4;prototype.html;504.45014933722234;506.7364970215488;523.1655509462408;524.7323864828936;534.6257619666233;6084.452399284063;6112.174856394386;6156.876862462748;6188.381161883809;6198.2252218472695;6067.211262535875;6136.140940268366;6192.1950146481;6207.255129384469;6211.347808480113;5176.559992400632;5176.767045482953;5203.193505006711;5204.583633309327;5204.9960765105325;4896.755162241891;4962.230854217602;5096;5123.436421993578;5173.3533308336455;4925.177684256812;4939.937913348629;4941.382327209099;4941.925871111936;4953.405591329046;4829.806807727687;4924.113659541281;4937.629677774181;4971.55824810808;4993.251012348159;4305.375720520538;4378.9562104378865;4429.379886815848;4435.3125265583885;4468.620167285784;5986.491148252404;6016.338202797689;6059.878802423971;6064.696090340553;6088.96955515224;5609.205054382599;5662.660240385549;5689.687067211302;5698.34469036062;5739.282589676291;6559.704813283413;6593;6618.371254730793;6638.867222655568;6641.236257830363;4904.632152588534;4919.655624106314;4921.18800397934;4926.11329960607;4942.20924652054;6596.43930265928;6722.495812814059;6800.387965083117;6862.769599880009;6889.311068893121;5305.257263983045;5400.810971615974;5436.456354364611;5479.945200548023;5513.9448605513435;5517.531009864207;5521.199426083195;5553.194786755978;5572.442755724395;5582.24639673647;5926.4666180044005;5929.288485381696;5979.880402391927;5985.221921150222;6043.486303664238;6629.303923088103;6650.334966503311;6660.300668429745;6684.86630267392;6698.631575263407;1936.94189174325;1966.9114889829991;1971.5859669469285;1978.3075923426973;1979.7723261824785;1391.7634002219647;1436.2675035731852;1442.8124343835234;1466.9046511976687;1470.9264536773119;5669.43305669438;5712.914306285409;5732.16883551891;5749.511291540182;5836.182934389189;6624.90062649051;6657.40083392497;6679.398854103154;6690.364415380531;6797.490188235902;5734.251053428744;5751.22358481608;5825.88348233033;5829.650220986754;5837.970810146007;3538.398472259722;3565.625609310985;3592.820358982093;3598.3163198992106;3611.368010598135;6499.2200935887995;6511.218653761484;6512.251091124486;6538.5537834273155;6622.536422450382;6894.207166175854;6918.273581273995;6925.688344024531;6952.513324067267;6971.616561089088;6482.319356467503;6492.0261960706275;6514.4462720668325;6516;6521.8695626088165;6626.786008785639;6650.600963942179;6716;6717.865642687217;6758.175292670853;6498.675066246763;6526.575772574957;6602.471802255904;6674.26583075871;6688.097106890702;6451.612903225821;6465.612063276219;6472.15861937945;6523.902141467787;6531.869362612626;5417.783288668409;5435.347758269033;5475;5476.315460567429;5490;6332.715027823851;6447.70985305653;6482.2869484357625;6676.332366763285;6700.664966751546;6273.153124328157;6381.266154392304;6409.9038514423255;6482.902756458562;6490.935090649033;6331.810045698637;6386.6251617642065;6392.552521323462;6445.548811583331;6475.057482755249;6357.332480089524;6425.164728585254;6425.807225783234;6427.614343139427;6469.7412103515335;6471.2234531856475;6473.805785826433;6496.285408605144;6560.409563139149;6583.3087525811015;6289.213848268966;6298.212723409574;6331.865726465429;6335.714892829926;6350.428461438492 12:11:29 INFO - PID 11132 | |5;yui.html;909.9727008189752;924.5654542365088;930.5347326336831;930.8743319651845;942.528735632184;17643.911780441096;18478;18528.907355463205;18563.907180464113;20720.89639551804;19430.319938802146;19431.805681943177;19594.51013724654;19649.901750491226;19676.901615491937;969.2827307792219;1051.673981065872;1066.722652110453;1066.727984363986;1068.871735391754;1060.8355704865758;1064.2603390643505;1065.0308219520239;1069.7004838645153;1071.9892801071967;1046.1839764983288;1099.7525556749747;1106.303029091671;1107.9667609971714;1108.2630051016065;1099.0273607857025;1100.5157730598512;1102.0412241349998;1103.8730545987235;1105;796.275389395653;797.4218691448654;797.9321757650607;800.967961281548;808.2685169921231;18168.909155454137;18416.63166736658;18551.814481855145;18557;19956.600867982703;20949.68575471369;21151.365459036253;21263.574728505497;21449;21462.570748585098;16167.19164041805;16647.66704665912;16771;16891.746623800653;16900.577485562837;3568.536090308269;3609.837557309901;3610.2418492116685;3612.6026137124895;3613.7470377073614;128855.35572322078;130200;133909;134457;134969.32515337362;14939.25303734809;14959.775603365959;15051.849481505264;15207.239638018054;15370.53888383328;30500;30515.237119071757;30751;30756.384872302428;30909.227269318446;7258.237885022102;7703.730369437043;8393.748187554384;8434.704785332606;8498.362622803315;4248.596383343577;4318.114786468829;4337.089211265669;4350.499692535399;4354.869353919387;4958.603311735124;5032.647714660012;5087.287779710843;5104.642675012788;5120.257562653469;1008.369768894441;1023.2785885950387;1033.5142483032962;1033.8552602635637;1037.8339465685606;658.868226354731;676.2932735291632;688.6659969914588;694.6492021529095;699.3880354689646;11088.778224435466;11950.820737688942;12039.879601203877;12618;12771.169873958162;687.051868421575;687.8521117959663;689.162667359151;693.8438851258427;694.6596167877805;5485.369182543979;5601.747921343549;5605.691686957175;5716.114002329646;5761.164631128463;105411.47294263479;105853.47073264584;106308;106464.46767766266;109016;93941.5302923481;95781.52109239409;96789.51605241929;98592;100457;81297.59351203324;81414;81575;83491.58254208691;86247.13752862517;10912.181586380895;11166.553337866395;11432.48553815097;12650.177738446971;12746;36207.094822629646;36629.63370366369;36633.63366366409;36776.9853113667;37674.43720260649;71516.64241678758;71526.28473715196;74136.62931685307;76313.80274084979;76634.6168269155;19037.14332854997;19417.51456213606;19535.316263930694;19639.410817675493;20093.09581068826;21521;21964.450888727908;22269.665955010365;22307.553848922606;22326.553468930855;18274.634507309514;18925;19438.902805485883;20016.399508014783;20128.29550965709;19748.210071596975;19917.800821992176;19977.300794472125;20148.697769533177;20223.898880505505;18920.243190272235;19740.50648733793;19817.207311707945;19866.10602522861;19953.60092798165;14002.229877356436;14072.507462239182;14272.072315299472;14360.281985900454;14382.28088595587;12999.545015924397;13830.30848457553;13856.376463059389;15151.469698560497;15583.84416155824 12:11:29 INFO - PID 11132 | __end_tp_report 12:11:29 INFO - PID 11132 | __start_cc_report 12:11:29 INFO - PID 11132 | _x_x_mozilla_cycle_collect,392 12:11:29 INFO - PID 11132 | __end_cc_report 12:11:29 INFO - PID 11132 | __startTimestamp1501787489731__endTimestamp 12:11:29 INFO - PID 11132 | 12:11:29 INFO - PID 11132 | ------- Summary: start ------- 12:11:29 INFO - PID 11132 | Number of tests: 6 12:11:29 INFO - PID 11132 | 12:11:29 INFO - PID 11132 | [#0] dojo.html Cycles:165 Average:6122.08 Median:6371.94 stddev:876.95 (13.8%) stddev-sans-first:847.07 12:11:29 INFO - PID 11132 | Values: 3103.5 3129.1 3138.5 3159.7 3163.6 6076.3 6315.6 6325.2 6334.7 6342.5 6149.7 6262.1 6262.2 6273.6 6293.7 5675.8 5730.8 5753.9 5758.5 5862.3 5757.3 5813.0 5837.1 5843.4 5848.6 129.3 5685.6 5750.3 5781.7 5805.2 5639.4 5641.4 5651.0 5709.5 5712.0 5577.2 5591.9 5661.5 5667.8 5701.9 5979.0 6089.8 6151.0 6179.9 6189.7 6565.6 6611.0 6616.9 6653.4 6708.1 6673.2 6685.3 6766.7 6781.8 6788.6 6145.8 6220.1 6264.3 6329.0 6343.6 6964.8 6967.9 6970.1 6976.1 6983.3 6609.5 6659.7 6672.7 6688.4 6697.8 6604.1 6686.1 6774.6 6785.3 6794.4 6592.6 6667.7 6688.8 6689.6 6707.1 6617.9 6676.6 6677.6 6700.9 6707.9 5315.7 5346.7 5346.7 5348.2 5385.5 4577.7 4589.6 4602.5 4606.2 4609.8 5123.1 5777.9 5850.8 5900.1 5901.4 6733.6 6743.4 6843.5 6860.8 6865.2 5715.1 5777.1 5778.5 5792.1 5796.0 5880.6 5887.2 5889.9 5890.3 5910.2 6445.7 6480.0 6508.5 6526.9 6535.6 6705.1 6724.6 6733.2 6779.3 6823.0 6492.9 6499.5 6500.0 6594.3 6626.3 6529.1 6580.4 6585.3 6586.6 6595.7 6674.3 6687.6 6692.9 6710.8 6725.3 6403.9 6432.2 6443.3 6455.0 6535.1 6425.4 6431.5 6482.0 6531.8 6533.0 6262.7 6352.2 6371.8 6371.9 6464.3 6482.7 6509.0 6527.7 6558.2 6616.7 6265.3 6324.1 6328.6 6365.0 6461.5 12:11:29 INFO - PID 11132 | 12:11:29 INFO - PID 11132 | [#1] ext.html Cycles:180 Average:42011.48 Median:37936.31 stddev:60588.13 (159.7%) stddev-sans-first:60679.19 12:11:29 INFO - PID 11132 | Values: 830.5 850.7 880.3 888.9 893.5 43957.3 44513.6 44904.6 44931.1 45194.8 39222.8 39794.4 39842.6 39961.0 39985.8 6915.3 7038.8 7041.4 7055.7 7062.7 7145.5 7232.5 7233.9 7234.8 7242.5 7733.4 7924.2 7927.1 7947.8 7965.8 7802.3 7853.7 7889.7 7903.7 7916.3 7596.1 7671.2 7800.8 7837.7 7845.5 41153.8 41282.4 41345.2 41476.4 41517.6 3604.6 3663.8 3672.6 3682.3 3688.7 31842.4 32103.0 32323.5 32358.7 32362.0 4979.2 4989.5 5003.9 5018.9 5028.9 230365.0 232195.0 232367.0 232482.0 234361.0 52649.5 52838.7 52846.7 52946.7 53084.0 54285.0 54697.7 56245.2 57321.4 57369.0 17321.7 17414.6 17481.1 17484.0 17490.1 14489.4 14498.9 14528.1 14532.2 14543.0 14648.6 14716.8 14735.6 14757.4 14845.2 5716.1 5828.9 5861.2 5873.4 6004.0 1014.4 1019.9 1024.5 1030.4 1036.4 23973.4 24025.8 24070.5 24225.9 29691.3 1114.1 1123.3 1124.3 1125.7 1140.6 12728.7 12879.6 12934.4 12943.7 12948.5 241286.0 243405.0 243530.0 243570.0 246191.0 56902.0 57174.4 57175.1 57246.1 59219.1 1481.8 1484.1 1509.1 1515.2 1518.6 28517.7 28738.3 28783.7 28840.7 29470.6 55181.0 55468.4 55591.2 55781.7 55935.7 221228.0 224238.0 224314.0 224440.0 224461.0 37861.0 38011.6 40369.4 40674.2 40896.0 49009.5 50635.2 50693.2 50742.5 51169.0 36102.0 36216.6 36368.8 36392.3 36457.3 34732.5 35574.3 36100.8 36123.5 36241.3 39986.2 40002.0 40043.8 40214.4 40255.2 34642.7 34715.3 34757.5 35120.8 35253.6 23713.4 25299.6 25502.5 25704.9 25718.7 12:11:29 INFO - PID 11132 | 12:11:29 INFO - PID 11132 | [#2] jquery.html Cycles:180 Average:37236.99 Median:21611.41 stddev:90894.89 (420.6%) stddev-sans-first:91108.17 12:11:29 INFO - PID 11132 | Values: 565.8 575.5 575.7 585.2 604.6 22726.3 23590.6 23616.6 23629.0 23648.2 24180.3 25210.6 26469.0 26671.6 26796.6 6527.4 6729.4 6737.5 6741.4 6746.8 6294.4 6570.3 6621.9 6635.7 6640.7 6537.3 6541.3 6541.4 6542.8 6547.3 6516.3 6536.9 6543.8 6546.9 6547.0 6042.5 6088.6 6094.8 6097.9 6112.5 29895.9 30278.0 30510.2 30530.7 31209.0 1864.1 1897.8 1906.7 1908.4 1913.0 18403.7 18926.0 18958.3 18958.7 18978.2 2304.3 2311.2 2347.0 2354.1 2431.9 136831.0 138148.0 139744.0 140613.0 141183.0 14969.5 15074.4 15342.5 15554.1 15594.0 23790.3 23930.5 23971.4 23976.6 24015.3 10382.6 10684.1 10692.9 10693.7 10723.1 9926.8 10002.0 10101.9 10199.3 10238.3 7918.4 11642.4 11817.5 12050.9 12379.9 4039.6 4142.7 4310.7 4322.2 4357.3 948.6 967.7 967.9 971.3 976.4 19223.8 19325.7 19695.6 19954.3 20257.0 992.8 1024.4 1036.3 1043.8 1047.3 10636.9 10681.2 10916.2 11004.7 11026.6 526154.0 528922.0 545688.0 549451.0 555436.0 127783.4 128604.4 129597.4 129823.4 130421.3 1263.7 1282.9 1303.3 1307.9 1314.1 21123.3 21135.8 21269.9 21448.1 21774.7 59337.1 60076.7 60528.0 61477.0 62601.4 74879.0 75008.2 75068.0 75301.0 75457.6 14756.9 14776.2 14838.0 14866.5 14869.4 23440.3 23762.0 23792.3 23822.4 23903.8 18741.3 18835.0 18887.2 18930.3 19176.3 15121.9 15591.9 15601.4 15728.9 17321.3 20102.7 20439.2 20519.1 20612.7 20709.9 15067.7 15246.2 15291.4 15301.2 15463.1 18386.2 19456.9 19548.7 19692.1 19740.6 12:11:29 INFO - PID 11132 | 12:11:29 INFO - PID 11132 | [#3] mootools.html Cycles:180 Average:8828.49 Median:2663.18 stddev:6017.51 (226.0%) stddev-sans-first:6008.04 12:11:29 INFO - PID 11132 | Values: 1334.3 1400.5 1406.1 1423.1 1428.5 12283.3 13660.3 14353.7 14411.9 14427.1 12097.1 13784.1 14292.2 14302.9 14308.7 2593.9 2683.4 2706.5 2715.9 2717.2 2633.8 2773.9 2775.9 2778.1 2779.3 2689.6 2722.5 2763.0 2764.2 2778.2 2616.7 2654.2 2659.1 2672.4 2675.4 2647.5 2667.3 2675.2 2676.2 2678.2 13757.7 14056.4 14088.1 14094.8 14126.3 7382.7 7595.8 7633.8 7634.0 7637.7 5160.6 5309.7 5371.5 5442.6 5460.6 1816.1 1825.9 1832.1 1864.3 1868.3 23370.2 23642.4 23707.9 23742.8 23766.3 7111.6 7198.2 7264.7 7324.3 7383.4 15673.9 15967.6 15971.5 15988.4 16029.8 7398.7 7593.7 7599.5 7603.1 7604.9 6956.9 7057.4 7126.9 7145.4 7213.0 4870.5 4983.9 5009.2 5010.5 5026.4 1548.8 1549.7 1563.9 1568.9 1581.6 904.3 933.2 947.1 948.0 957.5 7472.7 7502.6 7513.6 7523.0 7543.1 736.1 742.1 746.9 747.7 748.5 4709.2 4732.4 4768.3 4783.3 4804.0 19394.1 20102.4 20133.7 20178.9 20360.2 18336.7 18627.6 19461.4 19768.0 19772.8 10747.8 10948.8 10954.9 11000.8 11036.1 8140.3 8307.3 8311.8 8567.9 8760.3 16272.7 16796.3 16840.2 16891.9 16957.4 17188.1 17338.7 17379.3 17434.3 17636.1 12827.0 12992.1 13045.1 13101.2 13330.9 12957.7 13305.6 13307.6 13308.0 13308.4 10458.4 10563.5 10617.5 10727.2 10986.5 10404.3 10507.6 10592.0 10624.4 10754.2 9382.5 9407.3 9420.9 9421.3 9501.1 7338.2 7395.1 7408.7 7451.0 7456.9 7426.6 7429.9 7452.3 7454.7 7525.5 12:11:29 INFO - PID 11132 | 12:11:29 INFO - PID 11132 | [#4] prototype.html Cycles:180 Average:5556.22 Median:6086.71 stddev:1495.84 (24.6%) stddev-sans-first:1451.18 12:11:29 INFO - PID 11132 | Values: 504.5 506.7 523.2 524.7 534.6 6084.5 6112.2 6156.9 6188.4 6198.2 6067.2 6136.1 6192.2 6207.3 6211.3 5176.6 5176.8 5203.2 5204.6 5205.0 4896.8 4962.2 5096.0 5123.4 5173.4 4925.2 4939.9 4941.4 4941.9 4953.4 4829.8 4924.1 4937.6 4971.6 4993.3 4305.4 4379.0 4429.4 4435.3 4468.6 5986.5 6016.3 6059.9 6064.7 6089.0 5609.2 5662.7 5689.7 5698.3 5739.3 6559.7 6593.0 6618.4 6638.9 6641.2 4904.6 4919.7 4921.2 4926.1 4942.2 6596.4 6722.5 6800.4 6862.8 6889.3 5305.3 5400.8 5436.5 5479.9 5513.9 5517.5 5521.2 5553.2 5572.4 5582.2 5926.5 5929.3 5979.9 5985.2 6043.5 6629.3 6650.3 6660.3 6684.9 6698.6 1936.9 1966.9 1971.6 1978.3 1979.8 1391.8 1436.3 1442.8 1466.9 1470.9 5669.4 5712.9 5732.2 5749.5 5836.2 6624.9 6657.4 6679.4 6690.4 6797.5 5734.3 5751.2 5825.9 5829.7 5838.0 3538.4 3565.6 3592.8 3598.3 3611.4 6499.2 6511.2 6512.3 6538.6 6622.5 6894.2 6918.3 6925.7 6952.5 6971.6 6482.3 6492.0 6514.4 6516.0 6521.9 6626.8 6650.6 6716.0 6717.9 6758.2 6498.7 6526.6 6602.5 6674.3 6688.1 6451.6 6465.6 6472.2 6523.9 6531.9 5417.8 5435.3 5475.0 5476.3 5490.0 6332.7 6447.7 6482.3 6676.3 6700.7 6273.2 6381.3 6409.9 6482.9 6490.9 6331.8 6386.6 6392.6 6445.5 6475.1 6357.3 6425.2 6425.8 6427.6 6469.7 6471.2 6473.8 6496.3 6560.4 6583.3 6289.2 6298.2 6331.9 6335.7 6350.4 12:11:29 INFO - PID 11132 | 12:11:29 INFO - PID 11132 | [#5] yui.html Cycles:180 Average:23854.05 Median:19935.70 stddev:32342.52 (162.2%) stddev-sans-first:32387.37 12:11:29 INFO - PID 11132 | Values: 910.0 924.6 930.5 930.9 942.5 17643.9 18478.0 18528.9 18563.9 20720.9 19430.3 19431.8 19594.5 19649.9 19676.9 969.3 1051.7 1066.7 1066.7 1068.9 1060.8 1064.3 1065.0 1069.7 1072.0 1046.2 1099.8 1106.3 1108.0 1108.3 1099.0 1100.5 1102.0 1103.9 1105.0 796.3 797.4 797.9 801.0 808.3 18168.9 18416.6 18551.8 18557.0 19956.6 20949.7 21151.4 21263.6 21449.0 21462.6 16167.2 16647.7 16771.0 16891.7 16900.6 3568.5 3609.8 3610.2 3612.6 3613.7 128855.4 130200.0 133909.0 134457.0 134969.3 14939.3 14959.8 15051.8 15207.2 15370.5 30500.0 30515.2 30751.0 30756.4 30909.2 7258.2 7703.7 8393.7 8434.7 8498.4 4248.6 4318.1 4337.1 4350.5 4354.9 4958.6 5032.6 5087.3 5104.6 5120.3 1008.4 1023.3 1033.5 1033.9 1037.8 658.9 676.3 688.7 694.6 699.4 11088.8 11950.8 12039.9 12618.0 12771.2 687.1 687.9 689.2 693.8 694.7 5485.4 5601.7 5605.7 5716.1 5761.2 105411.5 105853.5 106308.0 106464.5 109016.0 93941.5 95781.5 96789.5 98592.0 100457.0 81297.6 81414.0 81575.0 83491.6 86247.1 10912.2 11166.6 11432.5 12650.2 12746.0 36207.1 36629.6 36633.6 36777.0 37674.4 71516.6 71526.3 74136.6 76313.8 76634.6 19037.1 19417.5 19535.3 19639.4 20093.1 21521.0 21964.5 22269.7 22307.6 22326.6 18274.6 18925.0 19438.9 20016.4 20128.3 19748.2 19917.8 19977.3 20148.7 20223.9 18920.2 19740.5 19817.2 19866.1 19953.6 14002.2 14072.5 14272.1 14360.3 14382.3 12999.5 13830.3 13856.4 15151.5 15583.8 12:11:29 INFO - PID 11132 | -------- Summary: end -------- 12:11:29 INFO - PID 11132 | 12:11:30 INFO - TEST-INFO | 11132: exit 0 12:11:30 INFO - TEST-OK | dromaeo_css | took 1112827ms 12:11:30 INFO - TEST-START | kraken 12:11:30 INFO - Initialising browser for kraken test... 12:11:30 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58081/getInfo.html -profile /tmp/tmpzMkjGK/profile 12:11:30 INFO - TEST-INFO | started process 11504 (/builds/slave/test/build/application/firefox/firefox http://localhost:58081/getInfo.html) 12:11:36 INFO - TEST-INFO | 11504: exit 0 12:11:36 INFO - Browser initialized. 12:11:36 INFO - Running cycle 1/1 for kraken test... 12:11:36 INFO - TEST-INFO | started process 11733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzMkjGK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 12:11:37 INFO - PID 11733 | 12:11:37 INFO - PID 11733 | (/builds/slave/test/build/application/firefox/firefox:11787): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 12:11:37 INFO - PID 11733 | 12:11:48 INFO - PID 11733 | RSS: Main: 174489600 12:11:48 INFO - PID 11733 | 12:11:50 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58081/tests/kraken/driver.html?testName=audio-beat-detection) 12:11:51 INFO - PID 11733 | RSS: Main: 179642368 12:11:51 INFO - PID 11733 | 12:11:54 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58081/tests/kraken/driver.html?testName=audio-dft) 12:11:55 INFO - PID 11733 | RSS: Main: 179757056 12:11:55 INFO - PID 11733 | 12:11:58 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58081/tests/kraken/driver.html?testName=audio-fft) 12:11:58 INFO - PID 11733 | RSS: Main: 174620672 12:11:58 INFO - PID 11733 | 12:12:01 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58081/tests/kraken/driver.html?testName=audio-oscillator) 12:12:01 INFO - PID 11733 | RSS: Main: 175054848 12:12:01 INFO - PID 11733 | 12:12:04 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58081/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:12:04 INFO - PID 11733 | RSS: Main: 174960640 12:12:04 INFO - PID 11733 | 12:12:07 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58081/tests/kraken/driver.html?testName=imaging-darkroom) 12:12:08 INFO - PID 11733 | RSS: Main: 177889280 12:12:08 INFO - PID 11733 | 12:12:11 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58081/tests/kraken/driver.html?testName=imaging-desaturate) 12:12:12 INFO - PID 11733 | RSS: Main: 177397760 12:12:12 INFO - PID 11733 | 12:12:15 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58081/tests/kraken/driver.html?testName=json-parse-financial) 12:12:16 INFO - PID 11733 | RSS: Main: 178262016 12:12:16 INFO - PID 11733 | 12:12:17 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58081/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:12:18 INFO - PID 11733 | RSS: Main: 178155520 12:12:18 INFO - PID 11733 | 12:12:20 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58081/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:12:21 INFO - PID 11733 | RSS: Main: 175206400 12:12:21 INFO - PID 11733 | 12:12:23 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58081/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:12:23 INFO - PID 11733 | RSS: Main: 175808512 12:12:23 INFO - PID 11733 | 12:12:26 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:12:27 INFO - PID 11733 | RSS: Main: 175894528 12:12:27 INFO - PID 11733 | 12:12:30 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:12:31 INFO - PID 11733 | RSS: Main: 175988736 12:12:31 INFO - PID 11733 | 12:12:32 INFO - PID 11733 | Cycle 1(1): loaded http://localhost:58081/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58081/tests/kraken/driver.html?testName=ai-astar) 12:12:33 INFO - PID 11733 | RSS: Main: 177119232 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | __start_tp_report 12:12:33 INFO - PID 11733 | _x_x_mozilla_page_load 12:12:33 INFO - PID 11733 | _x_x_mozilla_page_load_details 12:12:33 INFO - PID 11733 | |i|pagename|runs| 12:12:33 INFO - PID 11733 | |0;ai-astar;99;116;106;108;116;108;112;100;109;108 12:12:33 INFO - PID 11733 | |1;audio-beat-detection;153;122;148;165;122;143;150;127;172;127 12:12:33 INFO - PID 11733 | |2;audio-dft;164;163;162;163;162;177;171;164;162;165 12:12:33 INFO - PID 11733 | |3;audio-fft;78;81;77;182;75;86;84;84;97;77 12:12:33 INFO - PID 11733 | |4;audio-oscillator;85;79;142;79;84;80;126;82;78;128 12:12:33 INFO - PID 11733 | |5;imaging-gaussian-blur;114;114;114;114;115;117;114;114;114;114 12:12:33 INFO - PID 11733 | |6;imaging-darkroom;153;152;153;157;150;150;153;151;151;152 12:12:33 INFO - PID 11733 | |7;imaging-desaturate;96;94;93;95;94;94;94;94;94;94 12:12:33 INFO - PID 11733 | |8;json-parse-financial;56;56;58;59;64;57;57;57;57;57 12:12:33 INFO - PID 11733 | |9;json-stringify-tinderbox;63;60;53;54;55;65;54;54;54;54 12:12:33 INFO - PID 11733 | |10;stanford-crypto-aes;81;90;85;78;82;78;78;83;82;81 12:12:33 INFO - PID 11733 | |11;stanford-crypto-ccm;128;135;139;139;133;125;123;127;123;167 12:12:33 INFO - PID 11733 | |12;stanford-crypto-pbkdf2;181;182;191;176;177;177;179;190;191;188 12:12:33 INFO - PID 11733 | |13;stanford-crypto-sha256-iterative;68;66;66;66;65;67;74;69;66;71 12:12:33 INFO - PID 11733 | __end_tp_report 12:12:33 INFO - PID 11733 | __start_cc_report 12:12:33 INFO - PID 11733 | _x_x_mozilla_cycle_collect,945 12:12:33 INFO - PID 11733 | __end_cc_report 12:12:33 INFO - PID 11733 | __startTimestamp1501787553226__endTimestamp 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | ------- Summary: start ------- 12:12:33 INFO - PID 11733 | Number of tests: 14 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#0] ai-astar Cycles:10 Average:108.20 Median:110.50 stddev:5.71 (5.2%) stddev-sans-first:4.99 12:12:33 INFO - PID 11733 | Values: 99.0 116.0 106.0 108.0 116.0 108.0 112.0 100.0 109.0 108.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:149.00 stddev:17.93 (12.0%) stddev-sans-first:18.64 12:12:33 INFO - PID 11733 | Values: 153.0 122.0 148.0 165.0 122.0 143.0 150.0 127.0 172.0 127.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.00 stddev:4.90 (3.0%) stddev-sans-first:5.17 12:12:33 INFO - PID 11733 | Values: 164.0 163.0 162.0 163.0 162.0 177.0 171.0 164.0 162.0 165.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#3] audio-fft Cycles:10 Average:92.10 Median:82.50 stddev:32.22 (39.1%) stddev-sans-first:33.77 12:12:33 INFO - PID 11733 | Values: 78.0 81.0 77.0 182.0 75.0 86.0 84.0 84.0 97.0 77.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:79.50 stddev:25.07 (31.5%) stddev-sans-first:26.26 12:12:33 INFO - PID 11733 | Values: 85.0 79.0 142.0 79.0 84.0 80.0 126.0 82.0 78.0 128.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 12:12:33 INFO - PID 11733 | Values: 114.0 114.0 114.0 114.0 115.0 117.0 114.0 114.0 114.0 114.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#6] imaging-darkroom Cycles:10 Average:152.20 Median:152.50 stddev:2.04 (1.3%) stddev-sans-first:2.15 12:12:33 INFO - PID 11733 | Values: 153.0 152.0 153.0 157.0 150.0 150.0 153.0 151.0 151.0 152.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.50 12:12:33 INFO - PID 11733 | Values: 96.0 94.0 93.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.00 stddev:2.35 (4.1%) stddev-sans-first:2.40 12:12:33 INFO - PID 11733 | Values: 56.0 56.0 58.0 59.0 64.0 57.0 57.0 57.0 57.0 57.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:54.50 stddev:4.38 (8.0%) stddev-sans-first:3.98 12:12:33 INFO - PID 11733 | Values: 63.0 60.0 53.0 54.0 55.0 65.0 54.0 54.0 54.0 54.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:82.00 stddev:3.71 (4.5%) stddev-sans-first:3.92 12:12:33 INFO - PID 11733 | Values: 81.0 90.0 85.0 78.0 82.0 78.0 78.0 83.0 82.0 81.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:134.00 stddev:13.12 (9.8%) stddev-sans-first:13.74 12:12:33 INFO - PID 11733 | Values: 128.0 135.0 139.0 139.0 133.0 125.0 123.0 127.0 123.0 167.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:185.00 stddev:6.18 (3.3%) stddev-sans-first:6.50 12:12:33 INFO - PID 11733 | Values: 181.0 182.0 191.0 176.0 177.0 177.0 179.0 190.0 191.0 188.0 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:2.82 (4.2%) stddev-sans-first:2.99 12:12:33 INFO - PID 11733 | Values: 68.0 66.0 66.0 66.0 65.0 67.0 74.0 69.0 66.0 71.0 12:12:33 INFO - PID 11733 | -------- Summary: end -------- 12:12:33 INFO - PID 11733 | 12:12:33 INFO - PID 11733 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 12:12:33 INFO - TEST-INFO | 11733: exit 0 12:12:33 INFO - TEST-OK | kraken | took 63479ms 12:12:33 INFO - SUITE-END | took 1176s 12:12:34 INFO - Completed test suite (00:19:36) 12:12:34 INFO - javascript benchmark 12:12:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8672.898552196022, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.5344698295266, 3129.139486641172, 3138.529220616908, 3159.6998285162913, 3163.5571020057196, 6076.270847498296, 6315.589486683362, 6325.209348831396, 6334.651594162319, 6342.46089082428, 6149.723262453189, 6262.0919966604815, 6262.185915830947, 6273.56085074045, 6293.748250070003, 5675.801346952858, 5730.828075157741, 5753.913691294634, 5758.481736643701, 5862.296524417055, 5757.337906140806, 5813.040848260032, 5837.066069428893, 5843.415658434144, 5848.561357898154, 129.27315162212338, 5685.573581981347, 5750.281214848144, 5781.739821708013, 5805.216295800055, 5639.436056394369, 5641.435856414367, 5651.0, 5709.514691251248, 5712.0, 5577.2191893135, 5591.916121258144, 5661.547076233891, 5667.829965101054, 5701.945140149086, 5978.970105149447, 6089.8173054807985, 6150.96924515379, 6179.907301390483, 6189.690515474208, 6565.606063636197, 6610.9669451652435, 6616.933830661728, 6653.401193892573, 6708.12794336738, 6673.199216094051, 6685.298043705438, 6766.729330826761, 6781.762638307685, 6788.558743681645, 6145.78489752861, 6220.098085777582, 6264.310925798159, 6328.968355158195, 6343.587666801689, 6964.825879352956, 6967.8606427871155, 6970.093887794555, 6976.127984002, 6983.266756990544, 6609.504287178481, 6659.6670166491485, 6672.666366681647, 6688.39804417595, 6697.799066028027, 6604.1084453599115, 6686.13080299558, 6774.593524388552, 6785.253622101565, 6794.388505034571, 6592.571482853599, 6667.733290668416, 6688.765893193715, 6689.598624082473, 6707.0610114584, 6617.900731489031, 6676.6327851967635, 6677.599344039373, 6700.899486507707, 6707.899381509281, 5315.707636079976, 5346.679199248058, 5346.732663366894, 5348.224507446398, 5385.461453854583, 4577.679562430598, 4589.586937175603, 4602.493725690171, 4606.170889239902, 4609.838655647036, 5123.129068058439, 5777.913331300034, 5850.765969361178, 5900.085486749561, 5901.380355062743, 6733.6296503692765, 6743.393094621508, 6843.520953533304, 6860.828479288058, 6865.210500792373, 5715.114157305541, 5777.133429985536, 5778.508826749689, 5792.102224155263, 5796.0, 5880.558958078162, 5887.234659494324, 5889.852753681193, 5890.322612899486, 5910.202122713465, 6445.709943052574, 6480.0, 6508.479321654351, 6526.902096468557, 6535.607863528204, 6705.094812200486, 6724.630145342053, 6733.225679046972, 6779.322067793379, 6823.0, 6492.870142597028, 6499.5125365598715, 6500.0, 6594.307597702172, 6626.337366263528, 6529.053287273414, 6580.407763301326, 6585.341465853377, 6586.571872828251, 6595.736170553124, 6674.299198584079, 6687.63218022994, 6692.899606505809, 6710.765123220664, 6725.293844146294, 6403.903941440789, 6432.163818703539, 6443.259025212161, 6454.967725161344, 6535.117759102461, 6425.357464253537, 6431.453326467303, 6482.0, 6531.771388001397, 6532.967335163484, 6262.749490020348, 6352.237731472253, 6371.808845734636, 6371.936280637135, 6464.256610489854, 6482.708278127401, 6508.967455162694, 6527.694461107702, 6558.1802274715665, 6616.66916654175, 6265.342139075514, 6324.146240257506, 6328.588641738273, 6365.045243213555, 6461.515386345949], "value": 6059.613004707715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.5265998380921, 850.6894983331078, 880.2693764175734, 888.8622263549148, 893.4773157702746, 43957.340639890426, 44513.55486445135, 44904.55095449045, 44931.10137797242, 45194.774026129824, 39222.80388598053, 39794.40308395369, 39842.601573984255, 39961.0, 39985.800070999605, 6915.273896240885, 7038.824029399255, 7041.366277035066, 7055.682494287769, 7062.717491300342, 7145.499815012951, 7232.529885557422, 7233.855322893539, 7234.819129521751, 7242.529235599669, 7733.381329493627, 7924.247196516321, 7927.088384835732, 7947.761567152995, 7965.840683186333, 7802.33680137189, 7853.685852565891, 7889.723859664884, 7903.723369682033, 7916.287534121928, 7596.08846938371, 7671.156172820985, 7800.843983120306, 7837.725679601243, 7845.450818442711, 41153.79423102895, 41282.38076428856, 41345.1730965379, 41476.37785433221, 41517.58482415167, 3604.5854726706502, 3663.8351274192723, 3672.57765356982, 3682.263547290526, 3688.6680198782237, 31842.36315273705, 32103.0, 32323.51514727281, 32358.676413236037, 32362.0, 4979.203327467588, 4989.476105008958, 5003.899142188713, 5018.949810501885, 5028.899422011576, 230365.0, 232195.0, 232367.0, 232482.0, 234361.0, 52649.473505265225, 52838.73580632072, 52846.73576632169, 52946.73526632342, 53084.0, 54285.0, 54697.72651136798, 56245.156322655195, 57321.42678573161, 57369.0, 17321.7401738974, 17414.564635884206, 17481.125943702766, 17484.038377889337, 17490.125493725263, 14489.420423182955, 14498.927505362406, 14528.128312301296, 14532.200728960008, 14543.0, 14648.633784155481, 14716.779248311284, 14735.631609209855, 14757.409703611735, 14845.183514906785, 5716.114002329646, 5828.883422331614, 5861.150133230658, 5873.445051402654, 6003.969980150071, 1014.3761586624321, 1019.8980101989741, 1024.513356155835, 1030.4281123976266, 1036.4196050211906, 23973.400664983164, 24025.7597424027, 24070.51858962811, 24225.878870605888, 29691.257718556775, 1114.0975809594254, 1123.337231033694, 1124.3197865291545, 1125.6848082536903, 1140.6064907606863, 12728.681782955315, 12879.613611591667, 12934.41795119222, 12943.741125177632, 12948.546800861925, 241286.0, 243405.0, 243530.0, 243570.0, 246191.0, 56902.0, 57174.42825571774, 57175.14237286444, 57246.14130788042, 59219.11171332433, 1481.7851411545266, 1484.1317829070115, 1509.1473317575535, 1515.1515151515187, 1518.58238984278, 28517.714822851507, 28738.281542961595, 28783.712162878102, 28840.711592883803, 29470.557941631323, 55181.0, 55468.44531554794, 55591.16613250886, 55781.72109139428, 55935.720321398134, 221228.0, 224238.0, 224314.0, 224440.0, 224461.0, 37861.0, 38011.619883800806, 40369.39445908255, 40674.1865162701, 40896.0, 49009.50990490192, 50635.24047139222, 50693.23960140527, 50742.492575073775, 51169.0, 36102.0, 36216.63783362238, 36368.81815590905, 36392.27215455729, 36457.270854583294, 34732.47901281533, 35574.28851423009, 36100.81949590235, 36123.458148127276, 36241.27517449584, 39986.20027599374, 40002.0, 40043.79978100091, 40214.396784047676, 40255.1948961025, 34642.65357346394, 34715.30569388648, 34757.47863781995, 35120.824395877855, 35253.647463525034, 23713.40716482102, 25299.620505692797, 25502.489950201263, 25704.871475642503, 25718.742812571636], "value": 18426.005682411753, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.8245943757436, 575.4906907386961, 575.6632370063512, 585.1515302810924, 604.5858586867995, 22726.318210453694, 23590.646140307887, 23616.645750313717, 23629.0, 23648.172313969015, 24180.27459176223, 25210.621840672404, 26469.0, 26671.599926001127, 26796.598051029203, 6527.445167160797, 6729.427998620124, 6737.461003119739, 6741.393274605284, 6746.797596072126, 6294.43350098491, 6570.310117437672, 6621.9006714899315, 6635.706037322724, 6640.734370625193, 6537.280899101119, 6541.31316211798, 6541.443977261914, 6542.803715888531, 6547.279799222082, 6516.348365163493, 6536.93463065368, 6543.803685889431, 6546.93453065468, 6546.999999999976, 6042.546808989343, 6088.573799834014, 6094.786682466137, 6097.908531372033, 6112.480439162677, 29895.850520747255, 30278.0, 30510.237244068852, 30530.694693053007, 31209.0, 1864.123861784959, 1897.7817550981677, 1906.74258975038, 1908.3702378215155, 1913.0147973793507, 18403.72394414085, 18926.0, 18958.336458223897, 18958.71561926572, 18978.240870365167, 2304.320225533472, 2311.191083120911, 2346.9530609387716, 2354.1407386304045, 2431.9148829790875, 136831.0, 138148.0, 139744.0, 140613.0, 141183.0, 14969.476068337555, 15074.397024119131, 15342.539723808304, 15554.144522051169, 15594.0, 23790.286291411285, 23930.52138957211, 23971.400714982265, 23976.64035039476, 24015.279541613778, 10382.636607718694, 10684.115288872117, 10692.946535267429, 10693.732656683645, 10723.088537474401, 9926.80146397068, 10002.0, 10101.94949025265, 10199.28604997643, 10238.33450825694, 7918.366530677532, 11642.417879106011, 11817.527298907948, 12050.939745301217, 12379.93810030944, 4039.5758445362812, 4142.689298302639, 4310.719803212781, 4322.178786030644, 4357.2592659248, 948.5873644964463, 967.6775738228308, 967.9032096790264, 971.2666936462925, 976.3604838830578, 19223.807761922482, 19325.710114348298, 19695.60608787816, 19954.30159944395, 20257.0, 992.7518120469882, 1024.416082832793, 1036.2538971940191, 1043.8277684182026, 1047.2564479219686, 10636.946815265874, 10681.198910081775, 10916.181286403551, 11004.669859904216, 11026.558937642405, 526154.0, 528922.0, 545688.0, 549451.0, 555436.0, 127783.36108319585, 128604.3569782145, 129597.35201323933, 129823.35088324497, 130421.34789325992, 1263.7219811641423, 1282.9294388808705, 1303.328785675378, 1307.9280639564724, 1314.0538812055304, 21123.310135189455, 21135.788642113996, 21269.89365053165, 21448.142074316853, 21774.673379899, 59337.10994335002, 60076.69961650164, 60528.0, 61477.0, 62601.373986259554, 74879.0, 75008.24991750013, 75068.0, 75301.0, 75457.62271188608, 14756.926215368854, 14776.187309698069, 14838.035527690665, 14866.479673211386, 14869.405223790927, 23440.296791096294, 23762.0, 23792.286231413087, 23822.404439889142, 23903.76096239015, 18741.250349985847, 18835.0, 18887.150078246235, 18930.337438189596, 19176.328828490936, 15121.924390377977, 15591.922040389725, 15601.375944962074, 15728.92135539315, 17321.30714771395, 20102.698459522828, 20439.18243270312, 20519.076641550866, 20612.690809638167, 20709.896450517652, 15067.698646026798, 15246.237688115329, 15291.388344466097, 15301.234938252821, 15463.149526775685, 18386.172622232298, 19456.902715486332, 19548.706769398184, 19692.11385487628, 19740.60518789645], "value": 12515.702420602522, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.3194970565012, 1400.5378225185689, 1406.0790182430512, 1423.0826805049649, 1428.5143051362534, 12283.263004219752, 13660.31698415079, 14353.712925741478, 14411.91910606706, 14427.134371937691, 12097.09271804616, 13784.104033237832, 14292.213928233943, 14302.92848535756, 14308.71382572348, 2593.9351516212055, 2683.436478339551, 2706.512827691015, 2715.850628215447, 2717.184844546638, 2633.76296133348, 2773.9167824965284, 2775.9167224983285, 2778.111004478568, 2779.346853489428, 2689.610006549049, 2722.48272828163, 2762.9723702763017, 2764.1707487753692, 2778.2498725344144, 2616.6859976802716, 2654.21700598322, 2659.0959073914864, 2672.425428532865, 2675.3980354420196, 2647.5234457797587, 2667.2665017120253, 2675.2375572961805, 2676.2372723773633, 2678.183154137987, 13757.724845503133, 14056.437742490289, 14088.084274522123, 14094.788578171336, 14126.293685315795, 7382.741604043833, 7595.772126836148, 7633.770986870402, 7633.9618301908695, 7637.732679356196, 5160.56135228506, 5309.707966061865, 5371.4897084776885, 5442.619016668835, 5460.563154947595, 1816.0556510614406, 1825.8539316854753, 1832.0839580209895, 1864.263615871723, 1868.271374164077, 23370.182043628392, 23642.408939776473, 23707.88146059276, 23742.762572374228, 23766.287011389686, 7111.608861512666, 7198.2004498875285, 7264.745733899394, 7324.304191101837, 7383.409327253807, 15673.921630391775, 15967.600809979844, 15971.520854374387, 15988.440404585785, 16029.759553606706, 7398.741044063432, 7593.734219302298, 7599.5060321080055, 7603.0876294844975, 7604.885926711104, 6956.930430695729, 7057.435405167575, 7126.928730712731, 7145.39264162552, 7212.963935180395, 4870.537298956664, 4983.8504844854715, 5009.248612708123, 5010.548786266126, 5026.421961474477, 1548.7599422089595, 1549.7133030389414, 1563.882708796822, 1568.9096078225523, 1581.6362236685627, 904.2856143646577, 933.2254228989922, 947.1475671895349, 947.9857802132974, 957.5164541906292, 7472.701091956261, 7502.587357695379, 7513.586752728543, 7523.0, 7543.1325397578885, 736.0762243384626, 742.1279996004781, 746.861830561337, 747.6859718918067, 748.4947660329256, 4709.246520556694, 4732.408448943882, 4768.332433459318, 4783.330333753277, 4804.015176888729, 19394.127264273142, 20102.39692809218, 20133.697994530095, 20178.899105504377, 20360.18559257643, 18336.724949125775, 18627.627447450974, 19461.416157515298, 19768.0, 19772.802271977383, 10747.83878241827, 10948.781024379308, 10954.890451095547, 11000.834987475195, 11036.061934735637, 8140.308073813792, 8307.252347288773, 8311.792205194919, 8567.91432085696, 8760.342974276828, 16272.67454650924, 16796.328146873988, 16840.15799210059, 16891.91554042222, 16957.406490773257, 17188.140592970052, 17338.653226935137, 17379.304827806747, 17434.302627894744, 17636.118194089988, 12827.0, 12992.090553661154, 13045.086843921214, 13101.213927164401, 13330.866691332962, 12957.740845182854, 13305.600831975056, 13307.600771976857, 13308.001899857743, 13308.40112194973, 10458.424786636808, 10563.52464139131, 10617.469126543796, 10727.249092563447, 10986.505607247533, 10404.271700981162, 10507.632232872118, 10592.046715795308, 10624.36253824742, 10754.247202695737, 9382.530873456164, 9407.294452915921, 9420.905790942277, 9421.29340299494, 9501.144896959308, 7338.192798792235, 7395.149557800706, 7408.703651853865, 7450.962745186456, 7456.888146677913, 7426.591537465275, 7429.888551671837, 7452.292032256927, 7454.701811927463, 7525.473216874985], "value": 6422.707929209546, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.45014933722234, 506.7364970215488, 523.1655509462408, 524.7323864828936, 534.6257619666233, 6084.452399284063, 6112.174856394386, 6156.876862462748, 6188.381161883809, 6198.2252218472695, 6067.211262535875, 6136.140940268366, 6192.1950146481, 6207.255129384469, 6211.347808480113, 5176.559992400632, 5176.767045482953, 5203.193505006711, 5204.583633309327, 5204.9960765105325, 4896.755162241891, 4962.230854217602, 5096.0, 5123.436421993578, 5173.3533308336455, 4925.177684256812, 4939.937913348629, 4941.382327209099, 4941.925871111936, 4953.405591329046, 4829.806807727687, 4924.113659541281, 4937.629677774181, 4971.55824810808, 4993.251012348159, 4305.375720520538, 4378.9562104378865, 4429.379886815848, 4435.3125265583885, 4468.620167285784, 5986.491148252404, 6016.338202797689, 6059.878802423971, 6064.696090340553, 6088.96955515224, 5609.205054382599, 5662.660240385549, 5689.687067211302, 5698.34469036062, 5739.282589676291, 6559.704813283413, 6593.0, 6618.371254730793, 6638.867222655568, 6641.236257830363, 4904.632152588534, 4919.655624106314, 4921.18800397934, 4926.11329960607, 4942.20924652054, 6596.43930265928, 6722.495812814059, 6800.387965083117, 6862.769599880009, 6889.311068893121, 5305.257263983045, 5400.810971615974, 5436.456354364611, 5479.945200548023, 5513.9448605513435, 5517.531009864207, 5521.199426083195, 5553.194786755978, 5572.442755724395, 5582.24639673647, 5926.4666180044005, 5929.288485381696, 5979.880402391927, 5985.221921150222, 6043.486303664238, 6629.303923088103, 6650.334966503311, 6660.300668429745, 6684.86630267392, 6698.631575263407, 1936.94189174325, 1966.9114889829991, 1971.5859669469285, 1978.3075923426973, 1979.7723261824785, 1391.7634002219647, 1436.2675035731852, 1442.8124343835234, 1466.9046511976687, 1470.9264536773119, 5669.43305669438, 5712.914306285409, 5732.16883551891, 5749.511291540182, 5836.182934389189, 6624.90062649051, 6657.40083392497, 6679.398854103154, 6690.364415380531, 6797.490188235902, 5734.251053428744, 5751.22358481608, 5825.88348233033, 5829.650220986754, 5837.970810146007, 3538.398472259722, 3565.625609310985, 3592.820358982093, 3598.3163198992106, 3611.368010598135, 6499.2200935887995, 6511.218653761484, 6512.251091124486, 6538.5537834273155, 6622.536422450382, 6894.207166175854, 6918.273581273995, 6925.688344024531, 6952.513324067267, 6971.616561089088, 6482.319356467503, 6492.0261960706275, 6514.4462720668325, 6516.0, 6521.8695626088165, 6626.786008785639, 6650.600963942179, 6716.0, 6717.865642687217, 6758.175292670853, 6498.675066246763, 6526.575772574957, 6602.471802255904, 6674.26583075871, 6688.097106890702, 6451.612903225821, 6465.612063276219, 6472.15861937945, 6523.902141467787, 6531.869362612626, 5417.783288668409, 5435.347758269033, 5475.0, 5476.315460567429, 5490.0, 6332.715027823851, 6447.70985305653, 6482.2869484357625, 6676.332366763285, 6700.664966751546, 6273.153124328157, 6381.266154392304, 6409.9038514423255, 6482.902756458562, 6490.935090649033, 6331.810045698637, 6386.6251617642065, 6392.552521323462, 6445.548811583331, 6475.057482755249, 6357.332480089524, 6425.164728585254, 6425.807225783234, 6427.614343139427, 6469.7412103515335, 6471.2234531856475, 6473.805785826433, 6496.285408605144, 6560.409563139149, 6583.3087525811015, 6289.213848268966, 6298.212723409574, 6331.865726465429, 6335.714892829926, 6350.428461438492], "value": 5131.811306811108, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.9727008189752, 924.5654542365088, 930.5347326336831, 930.8743319651845, 942.528735632184, 17643.911780441096, 18478.0, 18528.907355463205, 18563.907180464113, 20720.89639551804, 19430.319938802146, 19431.805681943177, 19594.51013724654, 19649.901750491226, 19676.901615491937, 969.2827307792219, 1051.673981065872, 1066.722652110453, 1066.727984363986, 1068.871735391754, 1060.8355704865758, 1064.2603390643505, 1065.0308219520239, 1069.7004838645153, 1071.9892801071967, 1046.1839764983288, 1099.7525556749747, 1106.303029091671, 1107.9667609971714, 1108.2630051016065, 1099.0273607857025, 1100.5157730598512, 1102.0412241349998, 1103.8730545987235, 1105.0, 796.275389395653, 797.4218691448654, 797.9321757650607, 800.967961281548, 808.2685169921231, 18168.909155454137, 18416.63166736658, 18551.814481855145, 18557.0, 19956.600867982703, 20949.68575471369, 21151.365459036253, 21263.574728505497, 21449.0, 21462.570748585098, 16167.19164041805, 16647.66704665912, 16771.0, 16891.746623800653, 16900.577485562837, 3568.536090308269, 3609.837557309901, 3610.2418492116685, 3612.6026137124895, 3613.7470377073614, 128855.35572322078, 130200.0, 133909.0, 134457.0, 134969.32515337362, 14939.25303734809, 14959.775603365959, 15051.849481505264, 15207.239638018054, 15370.53888383328, 30500.0, 30515.237119071757, 30751.0, 30756.384872302428, 30909.227269318446, 7258.237885022102, 7703.730369437043, 8393.748187554384, 8434.704785332606, 8498.362622803315, 4248.596383343577, 4318.114786468829, 4337.089211265669, 4350.499692535399, 4354.869353919387, 4958.603311735124, 5032.647714660012, 5087.287779710843, 5104.642675012788, 5120.257562653469, 1008.369768894441, 1023.2785885950387, 1033.5142483032962, 1033.8552602635637, 1037.8339465685606, 658.868226354731, 676.2932735291632, 688.6659969914588, 694.6492021529095, 699.3880354689646, 11088.778224435466, 11950.820737688942, 12039.879601203877, 12618.0, 12771.169873958162, 687.051868421575, 687.8521117959663, 689.162667359151, 693.8438851258427, 694.6596167877805, 5485.369182543979, 5601.747921343549, 5605.691686957175, 5716.114002329646, 5761.164631128463, 105411.47294263479, 105853.47073264584, 106308.0, 106464.46767766266, 109016.0, 93941.5302923481, 95781.52109239409, 96789.51605241929, 98592.0, 100457.0, 81297.59351203324, 81414.0, 81575.0, 83491.58254208691, 86247.13752862517, 10912.181586380895, 11166.553337866395, 11432.48553815097, 12650.177738446971, 12746.0, 36207.094822629646, 36629.63370366369, 36633.63366366409, 36776.9853113667, 37674.43720260649, 71516.64241678758, 71526.28473715196, 74136.62931685307, 76313.80274084979, 76634.6168269155, 19037.14332854997, 19417.51456213606, 19535.316263930694, 19639.410817675493, 20093.09581068826, 21521.0, 21964.450888727908, 22269.665955010365, 22307.553848922606, 22326.553468930855, 18274.634507309514, 18925.0, 19438.902805485883, 20016.399508014783, 20128.29550965709, 19748.210071596975, 19917.800821992176, 19977.300794472125, 20148.697769533177, 20223.898880505505, 18920.243190272235, 19740.50648733793, 19817.207311707945, 19866.10602522861, 19953.60092798165, 14002.229877356436, 14072.507462239182, 14272.072315299472, 14360.281985900454, 14382.28088595587, 12999.545015924397, 13830.30848457553, 13856.376463059389, 15151.469698560497, 15583.84416155824], "value": 9239.24943644005, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 116.0, 106.0, 108.0, 116.0, 108.0, 112.0, 100.0, 109.0, 108.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 148.0, 165.0, 122.0, 143.0, 150.0, 127.0, 172.0, 127.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 162.0, 163.0, 162.0, 177.0, 171.0, 164.0, 162.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 81.0, 77.0, 182.0, 75.0, 86.0, 84.0, 84.0, 97.0, 77.0], "value": 92.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 79.0, 142.0, 79.0, 84.0, 80.0, 126.0, 82.0, 78.0, 128.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 115.0, 117.0, 114.0, 114.0, 114.0, 114.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 153.0, 157.0, 150.0, 150.0, 153.0, 151.0, 151.0, 152.0], "value": 152.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 94.0, 93.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 58.0, 59.0, 64.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 53.0, 54.0, 55.0, 65.0, 54.0, 54.0, 54.0, 54.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 90.0, 85.0, 78.0, 82.0, 78.0, 78.0, 83.0, 82.0, 81.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 135.0, 139.0, 139.0, 133.0, 125.0, 123.0, 127.0, 123.0, 167.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 182.0, 191.0, 176.0, 177.0, 177.0, 179.0, 190.0, 191.0, 188.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 66.0, 65.0, 67.0, 74.0, 69.0, 66.0, 71.0], "value": 67.8, "unit": "score"}]}]} 12:12:34 INFO - Return code: 0 12:12:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:12:34 INFO - # TBPL SUCCESS # 12:12:34 INFO - Running post-action listener: _package_coverage_data 12:12:34 INFO - Running post-action listener: _resource_record_post_action 12:12:34 INFO - [mozharness: 2017-08-03 19:12:34.505052Z] Finished run-tests step (success) 12:12:34 INFO - Running post-run listener: _resource_record_post_run 12:12:34 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 8192; Write bytes: 448946176; Read time: 16; Write time: 671404 12:12:34 INFO - TinderboxPrint: CPU usage
13.2% 12:12:34 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 16 12:12:34 INFO - TinderboxPrint: I/O write bytes / time
448,946,176 / 671,404 12:12:34 INFO - TinderboxPrint: CPU idle
8,267.3 (86.8%) 12:12:34 INFO - TinderboxPrint: CPU user
1,204.3 (12.6%) 12:12:34 INFO - TinderboxPrint: Swap in / out
0 / 0 12:12:34 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 115412992; Read time: 0; Write time: 220488 12:12:34 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:12:34 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 333533184; Read time: 4; Write time: 450916 12:12:35 INFO - Running post-run listener: _upload_blobber_files 12:12:35 INFO - Blob upload gear active. 12:12:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:12:35 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 12:12:35 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'] 12:12:35 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 12:12:35 INFO - (blobuploader) - INFO - Open directory for files ... 12:12:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:12:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:12:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:12:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:12:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:12:36 INFO - (blobuploader) - INFO - Done attempting. 12:12:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:12:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:12:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:12:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:12:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:12:43 INFO - (blobuploader) - INFO - Done attempting. 12:12:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:12:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:12:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:12:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:12:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:12:44 INFO - (blobuploader) - INFO - Done attempting. 12:12:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:12:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:12:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:12:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:12:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:12:45 INFO - (blobuploader) - INFO - Done attempting. 12:12:45 INFO - (blobuploader) - INFO - Iteration through files over. 12:12:45 INFO - Return code: 0 12:12:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:12:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:12:45 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40c87b0c4c74e613f04b9c63e21c8eb337ffc1d05dd5ec944e3685e674936da42320fdbc3632b366fa83ba681121ca56a56b6e35f0b7c92dacd27e32e9e1dcd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4c6ba7ccda2f58d33035b3ddf093a0205c3427d31ac5f62dd3fe87353912f28ecdedb9b1806cb8ad1d3c764a5484d8d37b9d608c3fbafc08713b9697f750c17", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434867a3227d146867f000ea55c45088b55329664bb3cf740b2ccc4b83e3f94d7fba45960cd9fb2547241ffc348bd7aa2f57c20fe99bb6a8dabacd2c64335429", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fce9048b104e71c992fdfcd7ca8042108c50443cc60570c8ef8a6be8b44e918068d273a9bb57e2be2b2830e7d6a4c6b9f3913b2db4bbf9827440ff40bac6a1bf"} 12:12:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:12:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:12:45 INFO - Contents: 12:12:45 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40c87b0c4c74e613f04b9c63e21c8eb337ffc1d05dd5ec944e3685e674936da42320fdbc3632b366fa83ba681121ca56a56b6e35f0b7c92dacd27e32e9e1dcd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4c6ba7ccda2f58d33035b3ddf093a0205c3427d31ac5f62dd3fe87353912f28ecdedb9b1806cb8ad1d3c764a5484d8d37b9d608c3fbafc08713b9697f750c17", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434867a3227d146867f000ea55c45088b55329664bb3cf740b2ccc4b83e3f94d7fba45960cd9fb2547241ffc348bd7aa2f57c20fe99bb6a8dabacd2c64335429", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fce9048b104e71c992fdfcd7ca8042108c50443cc60570c8ef8a6be8b44e918068d273a9bb57e2be2b2830e7d6a4c6b9f3913b2db4bbf9827440ff40bac6a1bf"} 12:12:45 INFO - Running post-run listener: copy_logs_to_upload_dir 12:12:45 INFO - Copying logs to upload dir... 12:12:45 INFO - mkdir: /builds/slave/test/build/upload/logs 12:12:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.125795 ========= master_lag: -0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-08-03 12:12:44.885694) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 12:12:44.890663) ========= 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=745a4373a2a16df560f216e000000264-1501785076.404841-901956869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40c87b0c4c74e613f04b9c63e21c8eb337ffc1d05dd5ec944e3685e674936da42320fdbc3632b366fa83ba681121ca56a56b6e35f0b7c92dacd27e32e9e1dcd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4c6ba7ccda2f58d33035b3ddf093a0205c3427d31ac5f62dd3fe87353912f28ecdedb9b1806cb8ad1d3c764a5484d8d37b9d608c3fbafc08713b9697f750c17", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434867a3227d146867f000ea55c45088b55329664bb3cf740b2ccc4b83e3f94d7fba45960cd9fb2547241ffc348bd7aa2f57c20fe99bb6a8dabacd2c64335429", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fce9048b104e71c992fdfcd7ca8042108c50443cc60570c8ef8a6be8b44e918068d273a9bb57e2be2b2830e7d6a4c6b9f3913b2db4bbf9827440ff40bac6a1bf"} build_url:https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011071 build_url: 'https://queue.taskcluster.net/v1/task/cLOXij6DRK-49sIx-uH2bw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40c87b0c4c74e613f04b9c63e21c8eb337ffc1d05dd5ec944e3685e674936da42320fdbc3632b366fa83ba681121ca56a56b6e35f0b7c92dacd27e32e9e1dcd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f4c6ba7ccda2f58d33035b3ddf093a0205c3427d31ac5f62dd3fe87353912f28ecdedb9b1806cb8ad1d3c764a5484d8d37b9d608c3fbafc08713b9697f750c17", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/434867a3227d146867f000ea55c45088b55329664bb3cf740b2ccc4b83e3f94d7fba45960cd9fb2547241ffc348bd7aa2f57c20fe99bb6a8dabacd2c64335429", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fce9048b104e71c992fdfcd7ca8042108c50443cc60570c8ef8a6be8b44e918068d273a9bb57e2be2b2830e7d6a4c6b9f3913b2db4bbf9827440ff40bac6a1bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-03 12:12:44.917907) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 12:12:44.918262) ========= 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=745a4373a2a16df560f216e000000264-1501785076.404841-901956869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-03 12:12:45.002225) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 12:12:45.002534) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-03 12:12:45.002818) ========= ========= Total master_lag: 0.13 =========