builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1502360911.08 results: success (0) revision: 4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:31.079149) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:31.079595) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:31.079874) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:31.115542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:31.115810) ========= 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=20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-10 03:28:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 31.3M=0s 2017-08-10 03:28:31 (31.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.194113 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:31.326529) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:31.326843) ========= 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=20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016643 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:31.380401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:31.380764) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5 --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 4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5 --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=20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-10 03:28:32,036 truncating revision to first 12 chars 2017-08-10 03:28:32,036 Setting DEBUG logging. 2017-08-10 03:28:32,036 attempt 1/10 2017-08-10 03:28:32,036 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4d54ac07b8c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-10 03:28:32,652 unpacking tar archive at: mozilla-central-4d54ac07b8c9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.959360 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:32.354184) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:32.357530) ========= script_repo_revision: 4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:32.357943) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:32.358211) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-10 03:28:32.367440) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-10 03:28:32.367799) ========= /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=20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:33 INFO - MultiFileLogger online at 20170810 03:28:33 in /builds/slave/test 03:28:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:28:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:33 INFO - {'append_to_log': False, 03:28:33 INFO - 'base_work_dir': '/builds/slave/test', 03:28:33 INFO - 'blob_upload_branch': 'Firefox', 03:28:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:33 INFO - 'branch': 'Firefox', 03:28:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:33 INFO - 'code_coverage': False, 03:28:33 INFO - 'config_files': ('talos/linux_config.py',), 03:28:33 INFO - 'default_actions': ('clobber', 03:28:33 INFO - 'read-buildbot-config', 03:28:33 INFO - 'download-and-extract', 03:28:33 INFO - 'populate-webroot', 03:28:33 INFO - 'create-virtualenv', 03:28:33 INFO - 'install', 03:28:33 INFO - 'setup-mitmproxy', 03:28:33 INFO - 'run-tests'), 03:28:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:33 INFO - 'disable_ccov_upload': False, 03:28:33 INFO - 'download_minidump_stackwalk': True, 03:28:33 INFO - 'download_symbols': 'ondemand', 03:28:33 INFO - 'enable_stylo': False, 03:28:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:33 INFO - 'gecko_profile': False, 03:28:33 INFO - 'gecko_profile_interval': 0, 03:28:33 INFO - 'installer_path': 'installer.exe', 03:28:33 INFO - 'log_level': 'info', 03:28:33 INFO - 'log_name': 'talos', 03:28:33 INFO - 'log_to_console': True, 03:28:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:33 INFO - 'opt_config_files': (), 03:28:33 INFO - 'pip_index': False, 03:28:33 INFO - 'suite': 'dromaeojs-e10s', 03:28:33 INFO - 'system_bits': '32', 03:28:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:33 INFO - 'title': 'talos-linux64-ix-015', 03:28:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:33 INFO - 'use_talos_json': True, 03:28:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:33 INFO - 'work_dir': 'build'} 03:28:33 INFO - [mozharness: 2017-08-10 10:28:33.140457Z] Running clobber step. 03:28:33 INFO - Running pre-action listener: _resource_record_pre_action 03:28:33 INFO - Running main action method: clobber 03:28:33 INFO - rmtree: /builds/slave/test/build 03:28:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:34 INFO - Running post-action listener: _resource_record_post_action 03:28:34 INFO - [mozharness: 2017-08-10 10:28:34.190050Z] Finished clobber step (success) 03:28:34 INFO - [mozharness: 2017-08-10 10:28:34.190152Z] Running read-buildbot-config step. 03:28:34 INFO - Running pre-action listener: _resource_record_pre_action 03:28:34 INFO - Running main action method: read_buildbot_config 03:28:34 INFO - Using buildbot properties: 03:28:34 INFO - { 03:28:34 INFO - "project": "", 03:28:34 INFO - "product": "firefox", 03:28:34 INFO - "who": "archaeopteryx@coole-files.de", 03:28:34 INFO - "installer_path": "public/build/target.tar.bz2", 03:28:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:28:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:28:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:28:34 INFO - "stage_platform": "linux64-stylosequential", 03:28:34 INFO - "basedir": "/builds/slave/test", 03:28:34 INFO - "buildnumber": 142, 03:28:34 INFO - "platform": "ubuntu64_hw_styloseq", 03:28:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:28:34 INFO - "slavebuilddir": "test", 03:28:34 INFO - "taskId": "DgkG8jKXSKuV190ejI0nGw", 03:28:34 INFO - "branch": "mozilla-central", 03:28:34 INFO - "script_repo_revision": "production", 03:28:34 INFO - "revision": "4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5", 03:28:34 INFO - "slavename": "talos-linux64-ix-015", 03:28:34 INFO - "repo_path": "mozilla-central" 03:28:34 INFO - } 03:28:34 INFO - Finding installer, test and symbols from parent task. 03:28:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DgkG8jKXSKuV190ejI0nGw'}, attempt #1 03:28:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DgkG8jKXSKuV190ejI0nGw'}, attempt #1 03:28:35 INFO - Task dependencies: GaVERyTITH-z0EQo_o-6HQ 03:28:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ'}, attempt #1 03:28:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2 03:28:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.test_packages.json 03:28:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.crashreporter-symbols.zip 03:28:35 INFO - Running post-action listener: _resource_record_post_action 03:28:35 INFO - [mozharness: 2017-08-10 10:28:35.507267Z] Finished read-buildbot-config step (success) 03:28:35 INFO - [mozharness: 2017-08-10 10:28:35.507490Z] Running download-and-extract step. 03:28:35 INFO - Running pre-action listener: _resource_record_pre_action 03:28:35 INFO - Running main action method: download_and_extract 03:28:35 INFO - mkdir: /builds/slave/test/build/tests 03:28:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:28:35 INFO - trying https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.test_packages.json 03:28:35 INFO - Downloading https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:28:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:28:36 INFO - Downloaded 989 bytes. 03:28:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:28:36 INFO - Using the following test package requirements: 03:28:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:28:36 INFO - u'common': [u'target.common.tests.zip'], 03:28:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:28:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:28:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:28:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:28:36 INFO - u'mozbase': [u'target.common.tests.zip'], 03:28:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:28:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:28:36 INFO - u'web-platform': [u'target.common.tests.zip', 03:28:36 INFO - u'target.web-platform.tests.tar.gz'], 03:28:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:28:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:28:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.common.tests.zip 03:28:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:28:36 INFO - Fetch https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.common.tests.zip into memory 03:28:37 INFO - Content-Length response header: 54284018 03:28:37 INFO - Bytes received: 54284018 03:28:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:28:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.common.tests.zip 03:28:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:28:48 INFO - Fetch https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.common.tests.zip into memory 03:28:49 INFO - Content-Length response header: 54284018 03:28:49 INFO - Bytes received: 54284018 03:29:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.talos.tests.zip 03:29:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:29:01 INFO - Fetch https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.talos.tests.zip into memory 03:29:02 INFO - Content-Length response header: 14496008 03:29:02 INFO - Bytes received: 14496008 03:29:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:02 INFO - trying https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2 03:29:02 INFO - Downloading https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:29:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:29:03 INFO - Downloaded 61984427 bytes. 03:29:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2 03:29:03 INFO - mkdir: /builds/slave/test/properties 03:29:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:03 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:03 INFO - Contents: 03:29:03 INFO - build_url:https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2 03:29:03 INFO - Running post-action listener: _resource_record_post_action 03:29:03 INFO - Running post-action listener: set_extra_try_arguments 03:29:03 INFO - [mozharness: 2017-08-10 10:29:03.594142Z] Finished download-and-extract step (success) 03:29:03 INFO - [mozharness: 2017-08-10 10:29:03.594250Z] Running populate-webroot step. 03:29:03 INFO - Running pre-action listener: _resource_record_pre_action 03:29:03 INFO - Running main action method: populate_webroot 03:29:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:29:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:29:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:29:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:29:03 INFO - 'tests': ['damp', 'tps']}, 03:29:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:29:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:29:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:29:03 INFO - 'other-e10s': {'tests': ['a11yr', 03:29:03 INFO - 'ts_paint', 03:29:03 INFO - 'tpaint', 03:29:03 INFO - 'sessionrestore', 03:29:03 INFO - 'sessionrestore_many_windows', 03:29:03 INFO - 'sessionrestore_no_auto_restore', 03:29:03 INFO - 'tabpaint']}, 03:29:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:29:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:29:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:29:03 INFO - 'tsvgr_opacity', 03:29:03 INFO - 'tart', 03:29:03 INFO - 'tscrollx', 03:29:03 INFO - 'tsvg_static']}, 03:29:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:29:03 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:03 INFO - 'talos_options': ['--mitmproxy', 03:29:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:03 INFO - '--firstNonBlankPaint'], 03:29:03 INFO - 'tests': ['tp6_google', 03:29:03 INFO - 'tp6_youtube', 03:29:03 INFO - 'tp6_amazon', 03:29:03 INFO - 'tp6_facebook']}, 03:29:03 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:03 INFO - 'talos_options': ['--stylo', 03:29:03 INFO - '--mitmproxy', 03:29:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:03 INFO - '--firstNonBlankPaint'], 03:29:03 INFO - 'tests': ['tp6_google', 03:29:03 INFO - 'tp6_youtube', 03:29:03 INFO - 'tp6_amazon', 03:29:03 INFO - 'tp6_facebook']}, 03:29:03 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:03 INFO - 'talos_options': ['--stylo', 03:29:03 INFO - '--stylo-threads=1', 03:29:03 INFO - '--mitmproxy', 03:29:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:03 INFO - '--firstNonBlankPaint'], 03:29:03 INFO - 'tests': ['tp6_google', 03:29:03 INFO - 'tp6_youtube', 03:29:03 INFO - 'tp6_amazon', 03:29:03 INFO - 'tp6_facebook']}, 03:29:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:29:03 INFO - 'talos_options': ['--xperf_path', 03:29:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:03 INFO - 'tests': ['tp5n']}}} 03:29:03 INFO - Running post-action listener: _resource_record_post_action 03:29:03 INFO - [mozharness: 2017-08-10 10:29:03.602686Z] Finished populate-webroot step (success) 03:29:03 INFO - [mozharness: 2017-08-10 10:29:03.602775Z] Running create-virtualenv step. 03:29:03 INFO - Running pre-action listener: _resource_record_pre_action 03:29:03 INFO - Running main action method: create_virtualenv 03:29:03 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:03 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:29:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:29:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:29:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:03 INFO - Using real prefix '/usr' 03:29:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:04 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:06 INFO - Installing pip.................done. 03:29:06 INFO - Return code: 0 03:29:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:29:06 INFO - Reading from file tmpfile_stdout 03:29:06 INFO - Output received: 03:29:06 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:29:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:06 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 0x13b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1729f00>, '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 0x1724ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1725050>, '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': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:29:06 INFO - Using env: {'DISPLAY': ':0', 03:29:06 INFO - 'HOME': '/home/cltbld', 03:29:06 INFO - 'LANG': 'en_US.UTF-8', 03:29:06 INFO - 'LANGUAGE': 'en_US:en', 03:29:06 INFO - 'LOGNAME': 'cltbld', 03:29:06 INFO - 'MAIL': '/var/mail/cltbld', 03:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:06 INFO - 'MOZ_NO_REMOTE': '1', 03:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:06 INFO - 'NO_EM_RESTART': '1', 03:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:06 INFO - 'PWD': '/builds/slave/test', 03:29:06 INFO - 'SHELL': '/bin/bash', 03:29:06 INFO - 'SHLVL': '1', 03:29:06 INFO - 'TERM': 'linux', 03:29:06 INFO - 'TMOUT': '86400', 03:29:06 INFO - 'USER': 'cltbld', 03:29:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 03:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:06 INFO - '_': '/tools/buildbot/bin/python'} 03:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:29:06 INFO - Cleaning up... 03:29:06 INFO - Return code: 0 03:29:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:06 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 0x13b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1729f00>, '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 0x1724ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1725050>, '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': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:29:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:29:06 INFO - Using env: {'DISPLAY': ':0', 03:29:06 INFO - 'HOME': '/home/cltbld', 03:29:06 INFO - 'LANG': 'en_US.UTF-8', 03:29:06 INFO - 'LANGUAGE': 'en_US:en', 03:29:06 INFO - 'LOGNAME': 'cltbld', 03:29:06 INFO - 'MAIL': '/var/mail/cltbld', 03:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:06 INFO - 'MOZ_NO_REMOTE': '1', 03:29:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:06 INFO - 'NO_EM_RESTART': '1', 03:29:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:06 INFO - 'PWD': '/builds/slave/test', 03:29:06 INFO - 'SHELL': '/bin/bash', 03:29:06 INFO - 'SHLVL': '1', 03:29:06 INFO - 'TERM': 'linux', 03:29:06 INFO - 'TMOUT': '86400', 03:29:06 INFO - 'USER': 'cltbld', 03:29:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 03:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:06 INFO - '_': '/tools/buildbot/bin/python'} 03:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:06 INFO - Downloading/unpacking psutil>=3.1.1 03:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:08 INFO - Installing collected packages: psutil 03:29:08 INFO - Running setup.py install for psutil 03:29:08 INFO - building 'psutil._psutil_linux' extension 03:29:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:29:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:29:08 INFO - building 'psutil._psutil_posix' extension 03:29:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:29:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:29:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:08 INFO - Successfully installed psutil 03:29:08 INFO - Cleaning up... 03:29:08 INFO - Return code: 0 03:29:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x13b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1729f00>, '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 0x1724ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1725050>, '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': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:29:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:29:08 INFO - Using env: {'DISPLAY': ':0', 03:29:08 INFO - 'HOME': '/home/cltbld', 03:29:08 INFO - 'LANG': 'en_US.UTF-8', 03:29:08 INFO - 'LANGUAGE': 'en_US:en', 03:29:08 INFO - 'LOGNAME': 'cltbld', 03:29:08 INFO - 'MAIL': '/var/mail/cltbld', 03:29:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:08 INFO - 'MOZ_NO_REMOTE': '1', 03:29:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:08 INFO - 'NO_EM_RESTART': '1', 03:29:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:08 INFO - 'PWD': '/builds/slave/test', 03:29:08 INFO - 'SHELL': '/bin/bash', 03:29:08 INFO - 'SHLVL': '1', 03:29:08 INFO - 'TERM': 'linux', 03:29:08 INFO - 'TMOUT': '86400', 03:29:08 INFO - 'USER': 'cltbld', 03:29:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 03:29:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:08 INFO - '_': '/tools/buildbot/bin/python'} 03:29:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:29:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:29:09 INFO - Installing collected packages: mozsystemmonitor 03:29:09 INFO - Running setup.py install for mozsystemmonitor 03:29:10 INFO - Successfully installed mozsystemmonitor 03:29:10 INFO - Cleaning up... 03:29:10 INFO - Return code: 0 03:29:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:10 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 0x13b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1729f00>, '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 0x1724ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1725050>, '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': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:29:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:29:10 INFO - Using env: {'DISPLAY': ':0', 03:29:10 INFO - 'HOME': '/home/cltbld', 03:29:10 INFO - 'LANG': 'en_US.UTF-8', 03:29:10 INFO - 'LANGUAGE': 'en_US:en', 03:29:10 INFO - 'LOGNAME': 'cltbld', 03:29:10 INFO - 'MAIL': '/var/mail/cltbld', 03:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:10 INFO - 'MOZ_NO_REMOTE': '1', 03:29:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:10 INFO - 'NO_EM_RESTART': '1', 03:29:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:10 INFO - 'PWD': '/builds/slave/test', 03:29:10 INFO - 'SHELL': '/bin/bash', 03:29:10 INFO - 'SHLVL': '1', 03:29:10 INFO - 'TERM': 'linux', 03:29:10 INFO - 'TMOUT': '86400', 03:29:10 INFO - 'USER': 'cltbld', 03:29:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 03:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:10 INFO - '_': '/tools/buildbot/bin/python'} 03:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:10 INFO - Downloading/unpacking jsonschema==2.5.1 03:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:29:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:29:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:29:11 INFO - warning: no files found matching '*.txt' 03:29:11 INFO - no previously-included directories found matching 'build' 03:29:11 INFO - no previously-included directories found matching 'dist' 03:29:11 INFO - no previously-included directories found matching '.git*' 03:29:11 INFO - Installing collected packages: jsonschema, functools32 03:29:11 INFO - Running setup.py install for functools32 03:29:11 INFO - warning: no files found matching '*.txt' 03:29:11 INFO - no previously-included directories found matching 'build' 03:29:11 INFO - no previously-included directories found matching 'dist' 03:29:11 INFO - no previously-included directories found matching '.git*' 03:29:11 INFO - Successfully installed jsonschema functools32 03:29:11 INFO - Cleaning up... 03:29:11 INFO - Return code: 0 03:29:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x13b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1729f00>, '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 0x1724ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1725050>, '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': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:29:11 INFO - Using env: {'DISPLAY': ':0', 03:29:11 INFO - 'HOME': '/home/cltbld', 03:29:11 INFO - 'LANG': 'en_US.UTF-8', 03:29:11 INFO - 'LANGUAGE': 'en_US:en', 03:29:11 INFO - 'LOGNAME': 'cltbld', 03:29:11 INFO - 'MAIL': '/var/mail/cltbld', 03:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:11 INFO - 'MOZ_NO_REMOTE': '1', 03:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:11 INFO - 'NO_EM_RESTART': '1', 03:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:11 INFO - 'PWD': '/builds/slave/test', 03:29:11 INFO - 'SHELL': '/bin/bash', 03:29:11 INFO - 'SHLVL': '1', 03:29:11 INFO - 'TERM': 'linux', 03:29:11 INFO - 'TMOUT': '86400', 03:29:11 INFO - 'USER': 'cltbld', 03:29:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 03:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:11 INFO - '_': '/tools/buildbot/bin/python'} 03:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:29:11 INFO - Cleaning up... 03:29:11 INFO - Return code: 0 03:29:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--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 0x13b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1729f00>, '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 0x1724ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1725050>, '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': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:29:11 INFO - Using env: {'DISPLAY': ':0', 03:29:11 INFO - 'HOME': '/home/cltbld', 03:29:11 INFO - 'LANG': 'en_US.UTF-8', 03:29:11 INFO - 'LANGUAGE': 'en_US:en', 03:29:11 INFO - 'LOGNAME': 'cltbld', 03:29:11 INFO - 'MAIL': '/var/mail/cltbld', 03:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:11 INFO - 'MOZ_NO_REMOTE': '1', 03:29:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:11 INFO - 'NO_EM_RESTART': '1', 03:29:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:11 INFO - 'PWD': '/builds/slave/test', 03:29:11 INFO - 'SHELL': '/bin/bash', 03:29:11 INFO - 'SHLVL': '1', 03:29:11 INFO - 'TERM': 'linux', 03:29:11 INFO - 'TMOUT': '86400', 03:29:11 INFO - 'USER': 'cltbld', 03:29:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 03:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:11 INFO - '_': '/tools/buildbot/bin/python'} 03:29:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:12 INFO - Downloading/unpacking blobuploader==1.2.4 03:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:13 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:29:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:13 INFO - Downloading docopt-0.6.1.tar.gz 03:29:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:13 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:13 INFO - Running setup.py install for blobuploader 03:29:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:29:13 INFO - Running setup.py install for requests 03:29:14 INFO - Running setup.py install for docopt 03:29:14 INFO - Successfully installed blobuploader requests docopt 03:29:14 INFO - Cleaning up... 03:29:14 INFO - Return code: 0 03:29:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x13b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1729f00>, '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 0x1724ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1725050>, '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': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:14 INFO - Using env: {'DISPLAY': ':0', 03:29:14 INFO - 'HOME': '/home/cltbld', 03:29:14 INFO - 'LANG': 'en_US.UTF-8', 03:29:14 INFO - 'LANGUAGE': 'en_US:en', 03:29:14 INFO - 'LOGNAME': 'cltbld', 03:29:14 INFO - 'MAIL': '/var/mail/cltbld', 03:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:14 INFO - 'MOZ_NO_REMOTE': '1', 03:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:14 INFO - 'NO_EM_RESTART': '1', 03:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:14 INFO - 'PWD': '/builds/slave/test', 03:29:14 INFO - 'SHELL': '/bin/bash', 03:29:14 INFO - 'SHLVL': '1', 03:29:14 INFO - 'TERM': 'linux', 03:29:14 INFO - 'TMOUT': '86400', 03:29:14 INFO - 'USER': 'cltbld', 03:29:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 03:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:14 INFO - '_': '/tools/buildbot/bin/python'} 03:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:14 INFO - Running setup.py (path:/tmp/pip-XFLhnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:14 INFO - Running setup.py (path:/tmp/pip-9ed0qH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:14 INFO - Running setup.py (path:/tmp/pip-kkEXt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:14 INFO - Running setup.py (path:/tmp/pip-zw_aAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:14 INFO - Running setup.py (path:/tmp/pip-m2ihDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:15 INFO - Running setup.py (path:/tmp/pip-GfEGLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:15 INFO - Running setup.py (path:/tmp/pip-rX3KFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:15 INFO - Running setup.py (path:/tmp/pip-JW26dB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:15 INFO - Running setup.py (path:/tmp/pip-NLexGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:15 INFO - Running setup.py (path:/tmp/pip-k2kwLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:15 INFO - Running setup.py (path:/tmp/pip-TkhLOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:15 INFO - Running setup.py (path:/tmp/pip-HVtsbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:15 INFO - Running setup.py (path:/tmp/pip-EZWdVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:15 INFO - Running setup.py (path:/tmp/pip-Wsr2XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:15 INFO - Running setup.py (path:/tmp/pip-x4dtmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:15 INFO - Running setup.py (path:/tmp/pip-hZxSCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:15 INFO - Running setup.py (path:/tmp/pip-JJbx3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:29:15 INFO - Running setup.py install for manifestparser 03:29:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:29:16 INFO - Running setup.py install for mozcrash 03:29:16 INFO - Running setup.py install for mozdebug 03:29:16 INFO - Running setup.py install for mozdevice 03:29:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:29:16 INFO - Running setup.py install for mozfile 03:29:16 INFO - Running setup.py install for mozhttpd 03:29:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:29:16 INFO - Running setup.py install for mozinfo 03:29:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:29:16 INFO - Running setup.py install for mozInstall 03:29:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:29:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:29:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:29:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:29:16 INFO - Running setup.py install for mozleak 03:29:16 INFO - Running setup.py install for mozlog 03:29:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:29:16 INFO - Running setup.py install for moznetwork 03:29:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:29:17 INFO - Running setup.py install for mozprocess 03:29:17 INFO - Running setup.py install for mozprofile 03:29:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:29:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:29:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:29:17 INFO - Running setup.py install for mozrunner 03:29:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:29:17 INFO - Running setup.py install for mozscreenshot 03:29:17 INFO - Running setup.py install for moztest 03:29:17 INFO - Running setup.py install for mozversion 03:29:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:29:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:29:17 INFO - Cleaning up... 03:29:17 INFO - Return code: 0 03:29:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:17 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 0x13b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1729f00>, '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 0x1724ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1725050>, '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': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:17 INFO - Using env: {'DISPLAY': ':0', 03:29:17 INFO - 'HOME': '/home/cltbld', 03:29:17 INFO - 'LANG': 'en_US.UTF-8', 03:29:17 INFO - 'LANGUAGE': 'en_US:en', 03:29:17 INFO - 'LOGNAME': 'cltbld', 03:29:17 INFO - 'MAIL': '/var/mail/cltbld', 03:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:17 INFO - 'MOZ_NO_REMOTE': '1', 03:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:17 INFO - 'NO_EM_RESTART': '1', 03:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:17 INFO - 'PWD': '/builds/slave/test', 03:29:17 INFO - 'SHELL': '/bin/bash', 03:29:17 INFO - 'SHLVL': '1', 03:29:17 INFO - 'TERM': 'linux', 03:29:17 INFO - 'TMOUT': '86400', 03:29:17 INFO - 'USER': 'cltbld', 03:29:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 03:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:17 INFO - '_': '/tools/buildbot/bin/python'} 03:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:17 INFO - Running setup.py (path:/tmp/pip-55AQkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:18 INFO - Running setup.py (path:/tmp/pip-r1xXM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:18 INFO - Running setup.py (path:/tmp/pip-bnu6J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:18 INFO - Running setup.py (path:/tmp/pip-stXeMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:18 INFO - Running setup.py (path:/tmp/pip-IgsLrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:18 INFO - Running setup.py (path:/tmp/pip-n3ecVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:18 INFO - Running setup.py (path:/tmp/pip-7BpY82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:18 INFO - Running setup.py (path:/tmp/pip-EDIPtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:18 INFO - Running setup.py (path:/tmp/pip-yGLx2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:18 INFO - Running setup.py (path:/tmp/pip-anuvsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:18 INFO - Running setup.py (path:/tmp/pip-jDytj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:18 INFO - Running setup.py (path:/tmp/pip-qz9SAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:18 INFO - Running setup.py (path:/tmp/pip-Y9irgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:18 INFO - Running setup.py (path:/tmp/pip-ZQ16Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:29:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:18 INFO - Running setup.py (path:/tmp/pip-g7WpbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:19 INFO - Running setup.py (path:/tmp/pip-x_cYch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:29:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:19 INFO - Running setup.py (path:/tmp/pip-Wx_HAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:29:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:20 INFO - Downloading blessings-1.6.tar.gz 03:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:29:20 INFO - Installing collected packages: blessings 03:29:20 INFO - Running setup.py install for blessings 03:29:20 INFO - Successfully installed blessings 03:29:20 INFO - Cleaning up... 03:29:20 INFO - Return code: 0 03:29:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:29:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:20 INFO - Reading from file tmpfile_stdout 03:29:20 INFO - Current package versions: 03:29:20 INFO - argparse == 1.2.1 03:29:20 INFO - blessings == 1.6 03:29:20 INFO - blobuploader == 1.2.4 03:29:20 INFO - docopt == 0.6.1 03:29:20 INFO - functools32 == 3.2.3-2 03:29:20 INFO - jsonschema == 2.5.1 03:29:20 INFO - manifestparser == 1.1 03:29:20 INFO - mozInstall == 1.13 03:29:20 INFO - mozcrash == 1.0 03:29:20 INFO - mozdebug == 0.1 03:29:20 INFO - mozdevice == 0.51 03:29:20 INFO - mozfile == 1.2 03:29:20 INFO - mozhttpd == 0.7 03:29:20 INFO - mozinfo == 0.10 03:29:20 INFO - mozleak == 0.1 03:29:20 INFO - mozlog == 3.5 03:29:20 INFO - moznetwork == 0.27 03:29:20 INFO - mozprocess == 0.25 03:29:20 INFO - mozprofile == 0.28 03:29:20 INFO - mozrunner == 6.13 03:29:20 INFO - mozscreenshot == 0.1 03:29:20 INFO - mozsystemmonitor == 0.3 03:29:20 INFO - moztest == 0.8 03:29:20 INFO - mozversion == 1.4 03:29:20 INFO - psutil == 3.1.1 03:29:20 INFO - requests == 1.2.3 03:29:20 INFO - wsgiref == 0.1.2 03:29:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:20 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 0x13b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1729f00>, '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 0x1724ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1725050>, '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': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:29:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:29:20 INFO - Using env: {'DISPLAY': ':0', 03:29:20 INFO - 'HOME': '/home/cltbld', 03:29:20 INFO - 'LANG': 'en_US.UTF-8', 03:29:20 INFO - 'LANGUAGE': 'en_US:en', 03:29:20 INFO - 'LOGNAME': 'cltbld', 03:29:20 INFO - 'MAIL': '/var/mail/cltbld', 03:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:20 INFO - 'MOZ_NO_REMOTE': '1', 03:29:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:20 INFO - 'NO_EM_RESTART': '1', 03:29:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:20 INFO - 'PWD': '/builds/slave/test', 03:29:20 INFO - 'SHELL': '/bin/bash', 03:29:20 INFO - 'SHLVL': '1', 03:29:20 INFO - 'TERM': 'linux', 03:29:20 INFO - 'TMOUT': '86400', 03:29:20 INFO - 'USER': 'cltbld', 03:29:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 03:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:20 INFO - '_': '/tools/buildbot/bin/python'} 03:29:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:29:20 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:29:22 INFO - Installing collected packages: simplejson 03:29:22 INFO - Running setup.py install for simplejson 03:29:22 INFO - building 'simplejson._speedups' extension 03:29:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:29:23 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:29:23 INFO - Successfully installed simplejson 03:29:23 INFO - Cleaning up... 03:29:23 INFO - Return code: 0 03:29:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13b91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1729f00>, '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 0x1724ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1725050>, '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': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:29:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:29:23 INFO - Using env: {'DISPLAY': ':0', 03:29:23 INFO - 'HOME': '/home/cltbld', 03:29:23 INFO - 'LANG': 'en_US.UTF-8', 03:29:23 INFO - 'LANGUAGE': 'en_US:en', 03:29:23 INFO - 'LOGNAME': 'cltbld', 03:29:23 INFO - 'MAIL': '/var/mail/cltbld', 03:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:23 INFO - 'MOZ_NO_REMOTE': '1', 03:29:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:23 INFO - 'NO_EM_RESTART': '1', 03:29:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:23 INFO - 'PWD': '/builds/slave/test', 03:29:23 INFO - 'SHELL': '/bin/bash', 03:29:23 INFO - 'SHLVL': '1', 03:29:23 INFO - 'TERM': 'linux', 03:29:23 INFO - 'TMOUT': '86400', 03:29:23 INFO - 'USER': 'cltbld', 03:29:23 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 03:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:23 INFO - '_': '/tools/buildbot/bin/python'} 03:29:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:29:23 INFO - Cleaning up... 03:29:23 INFO - Return code: 0 03:29:23 INFO - Running post-action listener: _resource_record_post_action 03:29:23 INFO - Running post-action listener: _start_resource_monitoring 03:29:23 INFO - Starting resource monitoring. 03:29:23 INFO - [mozharness: 2017-08-10 10:29:23.466957Z] Finished create-virtualenv step (success) 03:29:23 INFO - [mozharness: 2017-08-10 10:29:23.467419Z] Running install step. 03:29:23 INFO - Running pre-action listener: _resource_record_pre_action 03:29:23 INFO - Running main action method: install 03:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:23 INFO - Reading from file tmpfile_stdout 03:29:23 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:29:23 INFO - Reading from file tmpfile_stdout 03:29:23 INFO - Output received: 03:29:23 INFO - Usage: mozinstall [options] installer 03:29:23 INFO - Options: 03:29:23 INFO - -h, --help show this help message and exit 03:29:23 INFO - -d DEST, --destination=DEST 03:29:23 INFO - Directory to install application into. [default: 03:29:23 INFO - "/builds/slave/test"] 03:29:23 INFO - --app=APP Application being installed. [default: firefox] 03:29:23 INFO - mkdir: /builds/slave/test/build/application 03:29:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:29:41 INFO - Reading from file tmpfile_stdout 03:29:41 INFO - Output received: 03:29:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:29:41 INFO - Running post-action listener: _resource_record_post_action 03:29:41 INFO - [mozharness: 2017-08-10 10:29:41.811995Z] Finished install step (success) 03:29:41 INFO - [mozharness: 2017-08-10 10:29:41.812341Z] Running setup-mitmproxy step. 03:29:41 INFO - Running pre-action listener: _resource_record_pre_action 03:29:41 INFO - Running main action method: setup_mitmproxy 03:29:41 INFO - Skipping: mitmproxy is not required 03:29:41 INFO - Running post-action listener: _resource_record_post_action 03:29:41 INFO - [mozharness: 2017-08-10 10:29:41.814021Z] Finished setup-mitmproxy step (success) 03:29:41 INFO - [mozharness: 2017-08-10 10:29:41.814335Z] Running run-tests step. 03:29:41 INFO - Running pre-action listener: _resource_record_pre_action 03:29:41 INFO - Running pre-action listener: _set_gcov_prefix 03:29:41 INFO - Running main action method: run_tests 03:29:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:41 INFO - Python 2.7.3 03:29:41 INFO - Return code: 0 03:29:41 INFO - grabbing minidump binary from tooltool 03:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:41 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 0x1729f00>, '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 0x1724ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1725050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:29:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:29:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:29:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:41 INFO - Return code: 0 03:29:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:29:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:41 INFO - ENV: RUST_BACKTRACE is now full 03:29:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:29:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:41 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/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:29:41 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/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:29:41 INFO - Using env: {'DISPLAY': ':0', 03:29:41 INFO - 'HOME': '/home/cltbld', 03:29:41 INFO - 'LANG': 'en_US.UTF-8', 03:29:41 INFO - 'LANGUAGE': 'en_US:en', 03:29:41 INFO - 'LOGNAME': 'cltbld', 03:29:41 INFO - 'MAIL': '/var/mail/cltbld', 03:29:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:41 INFO - 'MOZ_NO_REMOTE': '1', 03:29:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:41 INFO - 'NO_EM_RESTART': '1', 03:29:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:41 INFO - 'PWD': '/builds/slave/test', 03:29:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:41 INFO - 'RUST_BACKTRACE': 'full', 03:29:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:29:41 INFO - 'SHELL': '/bin/bash', 03:29:41 INFO - 'SHLVL': '1', 03:29:41 INFO - 'STYLO_FORCE_ENABLED': '1', 03:29:41 INFO - 'TERM': 'linux', 03:29:41 INFO - 'TMOUT': '86400', 03:29:41 INFO - 'USER': 'cltbld', 03:29:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239', 03:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:41 INFO - '_': '/tools/buildbot/bin/python'} 03:29:41 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/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:29:42 INFO - mozversion application_buildid: 20170810094558 03:29:42 INFO - mozversion application_changeset: 4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5 03:29:42 INFO - mozversion application_display_name: Nightly 03:29:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:42 INFO - mozversion application_name: Firefox 03:29:42 INFO - mozversion application_remotingname: firefox 03:29:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:29:42 INFO - mozversion application_vendor: Mozilla 03:29:42 INFO - mozversion application_version: 57.0a1 03:29:42 INFO - mozversion platform_buildid: 20170810094558 03:29:42 INFO - mozversion platform_changeset: 4d54ac07b8c97f0e6713dab2ba694023b5b2f3b5 03:29:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:29:42 INFO - mozversion platform_version: 57.0a1 03:29:42 INFO - using testdate: 1502360982 03:29:42 INFO - actual date: 1502360982 03:29:42 INFO - starting webserver on 'localhost:39603' 03:29:42 INFO - SUITE-START | Running 2 tests 03:29:42 INFO - TEST-START | dromaeo_css 03:29:42 INFO - Initialising browser for dromaeo_css test... 03:29:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39603/getInfo.html -profile /tmp/tmpt_vC99/profile 03:29:42 INFO - TEST-INFO | started process 20492 (/builds/slave/test/build/application/firefox/firefox http://localhost:39603/getInfo.html) 03:29:48 INFO - TEST-INFO | 20492: exit 0 03:29:48 INFO - Browser initialized. 03:29:48 INFO - Running cycle 1/1 for dromaeo_css test... 03:29:48 INFO - TEST-INFO | started process 20725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt_vC99/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:29:49 INFO - PID 20725 | 03:29:49 INFO - PID 20725 | (/builds/slave/test/build/application/firefox/firefox:20779): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:29:49 INFO - PID 20725 | 03:29:59 INFO - PID 20725 | RSS: Main: 171057152 03:29:59 INFO - PID 20725 | 03:32:59 INFO - PID 20725 | Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39603/tests/dromaeo/cssquery-ext.html) 03:33:01 INFO - PID 20725 | RSS: Main: 175108096 03:33:01 INFO - PID 20725 | 03:36:02 INFO - PID 20725 | Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-ext.html (next: http://localhost:39603/tests/dromaeo/cssquery-jquery.html) 03:36:03 INFO - PID 20725 | RSS: Main: 173043712 03:36:03 INFO - PID 20725 | 03:39:05 INFO - PID 20725 | Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39603/tests/dromaeo/cssquery-mootools.html) 03:39:06 INFO - PID 20725 | RSS: Main: 175022080 03:39:06 INFO - PID 20725 | 03:42:07 INFO - PID 20725 | Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39603/tests/dromaeo/cssquery-prototype.html) 03:42:08 INFO - PID 20725 | RSS: Main: 173445120 03:42:08 INFO - PID 20725 | 03:45:12 INFO - PID 20725 | Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39603/tests/dromaeo/cssquery-yui.html) 03:45:13 INFO - PID 20725 | RSS: Main: 176795648 03:45:13 INFO - PID 20725 | 03:48:14 INFO - PID 20725 | Cycle 1(1): loaded http://localhost:39603/tests/dromaeo/cssquery-yui.html (next: http://localhost:39603/tests/dromaeo/cssquery-dojo.html) 03:48:15 INFO - PID 20725 | RSS: Main: 176996352 03:48:15 INFO - PID 20725 | 03:48:15 INFO - PID 20725 | __start_tp_report 03:48:15 INFO - PID 20725 | _x_x_mozilla_page_load 03:48:15 INFO - PID 20725 | _x_x_mozilla_page_load_details 03:48:15 INFO - PID 20725 | |i|pagename|runs| 03:48:15 INFO - PID 20725 | |0;dojo.html;3136.937261254775;3145.4809956357217;3151.1649412905576;3165.651778304386;3183.2837611537393;6194.566380353377;6218.502519798417;6246.187995560571;6253.812385628427;6270.090836828657;6145.108959200925;6276.717547710353;6286;6294.590851594643;6353.555251132422;5690.231818704484;5757.050086735683;5778.971105144489;5782.219400380958;5842.123681447795;5750.482456578907;5786.623869448494;5816.912746308788;5822.650640961535;5853.239078919734;5582.190582365575;5747;5797.420257974211;5844.561657875655;5852.561057920651;5706.828795136153;5711.02912504871;5712.457316554921;5741.45456181662;5820.708964551798;5676.318841739017;5702.116171993348;5742.569307301969;5773.451522105435;5787.276590426197;6141.201643786324;6182.381761823826;6220.12918191449;6271.059341098826;6306.779262725829;6732.1921369435495;6783.3555812197765;6805.829854253634;6814.863702725967;6849.794506164823;6727;6739.056532085512;6833.58998460089;6843.657817109174;6848;6227.065940108974;6316.936830631681;6373.107764912916;6373.968130159412;6398.232212134527;6858.897116543256;6933.618650974144;6942.895856562156;6950.131233595801;6968.930310696929;6524.478041756648;6602.933970660328;6608.173978252718;6645.634490102994;6648;6711.127553418024;6726.091977582963;6729.899051514231;6741.325867413219;6741.426978706767;6698.330166983263;6731.259561448237;6741.393274605309;6752.392284694303;6797.592144471348;6758.797236082925;6792.150981127359;6807.149106361705;6817.352351526597;6829.931700683029;5426.70153141581;5482.671039737628;5489.451054894478;5494.478024587658;5508.091164957817;4605.148047611203;4653.581177693956;4656.511066338054;4666.486686464486;4710.26990816424;5870.207521984563;5873.647581145145;5884.382139875337;5887.2052272943465;5887.528997680175;6759.357861003196;6764.086848275519;6771.322867713189;6776.28848970851;6776.9322306777285;5869.8239052828485;5871.354151043467;5917.053271476543;5925.822225333247;5926.2888453385;5894.469497745138;5896.292444906553;5957.761689532457;5965.224520812267;5978.760849565969;6482.416582507597;6526.412622863965;6564.212294524687;6572.277049524549;6589.934100658932;6658.400743933069;6717.92513197886;6782.932170678428;6789.830254243683;6808.353206445379;6472.126262954629;6558.081868538313;6569.9014514783275;6624.834379140368;6628.403443690091;6633.535652504278;6637.933620663925;6659.034440006269;6723.798286051427;6727.327267273234;6729.158855143107;6780.864382712417;6800.047993281044;6873.20958089826;6874.106366172366;6525.053867189136;6553.115329430466;6563.737450501926;6570.671466426564;6571.605703657796;6506.544541882023;6508.349165083454;6598.670066496752;6608.570442921195;6609.735610575523;6488.221413430419;6512.5766825156215;6537.444317233088;6539.738410463528;6560.212774467094;6596.406323430914;6635.23694775107;6697;6705.865882682221;6714.966425167843;6299.244090708961;6392.360763923571;6395.392437718409;6412.454941330039;6434.485241180788 03:48:15 INFO - PID 20725 | |1;ext.html;758.9089309282887;818.1205204405264;850.8681154421063;853.0445900591338;1170.5025364220205;29840.403191936148;30423.391532169342;40139.79930100349;41128.38307425391;41139;41225.175496490054;41272.793636031776;41407.58592414075;41490.58509414905;41534;7553.320201181892;7588.772336829904;7606.657700403467;7838.372930165573;7874.763757087297;7620.08558972924;7641.617919104023;7650.043744531934;7661.655225514837;7727.111382191064;7528.887066694004;7557.546547207157;7638.197989211136;7748.070231572219;7778.766637000899;7685.923140768633;7710.344620707247;7768.339691126261;7769.3784497240085;7775.1447340792465;7639.770806875803;7665.8850117248285;7670;7677.846443071163;7680.923190768132;36592.26815463702;36730.63269367299;36772.63227367719;36868.81565592182;36905.261894762225;3583.4445660922597;3613.7109031277696;3619.8009109498967;3620.3664358737115;3625.29306785177;30569.694303056905;30584.235394115327;30614;30618.234544136576;30728.846355768077;4905.4358748744;5087.287779710843;5088;5091.134507133796;5127.2052831811125;197718;197992;198702;198801.00599497053;199261;48473.51526484761;48484.757576211894;48657.513424866;48819;48905.5109448901;50252.49747502551;50367.74816125896;50447.74776126169;50691.74654126706;50938.490615093375;13186.340682965812;13230;14446;14450.205238711762;14675.192864392347;11647.76704465906;11954.760904781855;11992.520299188109;11993.340366279765;12000.1599888007;14379.849612031012;14489;14623.561293161221;14635.92682036583;14769.630759231106;5633.718314084279;5693.715314234271;5725.77096916127;5725.971370143123;5731.226284451629;984.5028260728429;1006.4665727164614;1014.2443879309814;1017.9847302290472;1025.738436698637;22603;29619.407611847644;29902.401951961274;30594.08217753471;30662.926797561977;1081.5511562701547;1082.815921293382;1091.9945400272948;1094.7099018760034;1099.428297285423;12305;12880.291583962784;12993.350332483338;13048.673783155307;13056.08607397492;223009;227448;227518;228117;228148;53061.2040819388;53522;53646.195307070426;53667.73166134222;53730;1416.129080615414;1456.155429850684;1467.4423718986716;1468.9412423503154;1476.4094362255184;22953.426164346023;23352.88323558439;23403;23403.180888668816;23508.707021114;37909.62090379061;38181.61818381781;38209.80895095507;38298.23403531969;38413;201036;201060;201760;202214;203087;30744.385112298078;31003.224919377197;33956;34737;34841.825790870884;42927.49753758604;43740.34389484224;43900.780496097315;43984;44442.11115777731;32237.677623223466;32602.34795304128;32705.509417358284;32721.672783271864;33328.33343333168;31904.84047579747;32297.677023229466;32357.676423235465;32362.352752944338;32675.509867352484;34648;35285.82357088301;35657.46513802347;35698.46452303165;35752.64247357597;30912.69087309098;31019;31429.68570314359;31561.8421907889;31958;23036.4240893979;23595.41011474727;23683;24144.758552414954;24201 03:48:15 INFO - PID 20725 | |2;jquery.html;563.3606553297798;563.8844036972421;571.6541492397103;579.8927198468284;599.7720866070894;21416.678749818744;22146.22488212913;22227.888860555675;22269.109235630556;22426.215082472118;24631.384215394624;27282.5907611386;27333.45333093337;27369.315767105832;27501.31246718833;6541.771038013659;6644.202695676526;6710.932890671104;6713.966430167842;6713.966430167867;6066.332703402622;6366.968165159168;6368.203974503187;6560.868782624345;6637.767678131267;6333.524985626096;6338.809835704937;6340.714667839935;6344.49244060474;6344.6510441925675;6292.150559674431;6298.086777417295;6301.180846489973;6311.52663550231;6317.905231421532;5873.911891321633;5904.084866845646;5914.2015827863115;5917.20117784098;5924.2298501195;28513.85743071292;29134.12597622075;29388.412231755246;29933.25166870824;30550.54174187389;1915.3583549510931;1969.3107412405543;1978.5053736565858;1980.2475059477451;1981.6532106881239;19022.144003519876;19657.901710491355;19665.705014424795;19687.704684429744;19749.407517774347;2377.7741114594087;2418.069043418279;2420.8668523231217;2423.9272821815375;2484.142970675114;138684;141135;141326.29336853352;141666.29166854202;142121;14509.347079381454;15300.693986120437;15483.303251353716;15529.922350388175;15863.920680396524;23958.760412396;23980;24193.39516512066;24216;24243.66659833691;9641.37331073492;9793.755156121155;9950.80098398028;9986.151177150025;10014.49927503622;9081.81836363269;9110.59002344896;9127.224185944136;9141.405808622418;9152;7746.883796743054;9235.122663347105;9327.300452466092;9400.48297343639;9504.477253750973;2548.9745102548736;2616.7775739062013;2670.1588999465107;2694.5419278722666;2700.257429206984;936.6440752514137;969.6945561706003;975.3075316525346;975.4634950777045;977.7751117243074;18304.725429118575;18884.24463021491;23854.228045820695;23973.160939367037;25092.870820812743;1021.269792098653;1035.4158138048797;1046.4349251404155;1051.1380667852288;1055.3034996902009;10654.680359589225;10972.615958441416;10979.505922233519;11060.391678457761;11151.38667373286;498342;499218;516088;516619;519200;116285;116482.41758791152;119190;121430;122076.38961805134;1254.1221145198397;1264.9557265495664;1297.0531511996107;1300.9674758131123;1305.145129939891;17395.2172152256;17402.82597174012;17600.911995440452;17762.91118544399;18028.909855450638;52695.47304526906;55108.44891551033;56584.43415565956;58672.4132758667;60117.196484105545;68034.65982670055;68049.65975170092;68240;68464;69006.65496672485;14280;14569.053011554215;14727.410903563738;14788.11271323724;14837.40650373973;22529;22728.88635556878;22827.88586057059;22932.082716691144;23020.654690179326;18121.36575219861;18143.909280453514;18374.173162207466;18378.908105459923;18452.630947381247;16771.413000544922;16855.410060647817;16968.151592420578;17008.574785629964;17374.39189628357;17541.912290438977;17841.553961151076;18348.541286467946;18452.723209151605;18709.43871683852;14476.131432114107;14506.274686265433;14515.491957781427;14555.92722036383;14643.780343294646;17547;17965.281388744304;18071.367502137364;18217.544561386072;18225.726614101066 03:48:15 INFO - PID 20725 | |3;mootools.html;1362.7002059546899;1406.6202125426141;1422.1680317014545;1427.4076258352784;1431.5776845830485;13691.452341906324;14298.714025719491;14363.856361436383;14372.856271437282;14397.424103035879;14123.223222722747;14667.853321466782;14676.412943482275;14698.926505367484;14751.631209219775;2667.653205083346;2712.593111033341;2714.606382074598;2714.8914043438335;2715.0633031604066;2670.3591138126903;2698.9865050674816;2761.199252216855;2764.861756912146;2769.9584506232422;2658.9601155982677;2715.551933930899;2764.060219525361;2766.0595397564825;2766.9169924902185;2595.8442493450357;2636.1959602321285;2648.72188420216;2650.1651979626454;2655.9601605975927;2609.5041942030953;2621.501914636213;2624.960625590618;2638.9472210555873;2640.2871224769206;13734.381952812148;13791.931040344834;13820.308984550733;13914.860851391559;13989.090709103977;7438.73964411243;7693.269139431745;7700;7702.422318326092;7717.151113377524;5049.64652474327;5177.689338639656;5206.609504287194;5306.628536002481;5359.196120581944;1823.2889173222454;1829.3597240965555;1843.714224295223;1875.165551329659;1885.208212550732;22931.656025159635;23003.654945175836;23060.308190754306;23061.077556897704;23076;6278.246610406689;6501.934980650228;6526.412622863965;6615.735370585219;6745.730170793211;15733.921330393276;15739.68520629581;15780.842191578167;15791.763123553155;15868;7218.097737782778;7503.099628044561;7557.395408367317;7575.431842611826;7581.166071732105;5756.107803290497;5987.101934709828;6205.441510264098;6221.377862213742;7010;4950.455449900508;5072.949270507248;5142.71715055668;5179.19722443022;5183.585313174937;1452.157748505864;1483.5757672634177;1484.2801241397913;1505.9623509412352;1509.5773183508636;890.8129292848445;903.1961554216753;914.401067300919;915.844306467902;915.8626206069143;7098.1482222132645;7142.28577142292;7160.176579693402;7180.9640951795955;7192.352688258082;687.8890591694377;693.8855088910274;699.4194818300798;702.9964850175717;709.737397163053;4455.420795296591;5508.14623733314;5624.128260119688;5800.8259752207505;5913.083472061838;18757.90621046886;18816.62366752657;19383.612327753646;19573.314933977243;19584.21663133487;17604;17806.46580602584;17851.107444627716;17859.910700446413;17915.641687166444;10249.12882404989;10300.845487317696;10502.264841461025;10861.619843305447;10939.781204375868;8063.516189028677;8282.544460054754;8405.579721014046;8423.241908228289;8498.787530311545;16543.751843722595;17070.231839567;17087.23107460192;17101;17324.826751732322;17211.65576688434;17273.654526909642;17375.47873563795;17384.65230695404;17430.564235894206;11602.129840261845;11621.6513504595;11881.524739010689;11883.108766842694;11918.225315354473;12705.555305564261;13232;13389.866101338863;13401.329933503092;13419.530316438877;10430.582776688847;10587.841182382424;10603.94698026505;10667.093297069836;10963.50664220096;10377.481125943823;10488.632897848538;10556.630517931835;10803.459827008775;10884.836727448936;9592.66425675098;9645.855312170183;9723.854142188015;9777.022297770167;9788.706338809847;6807.503567326775;7040.718371265092;7110.43116550685;7173.1392232932385;7187.28127187298;7220.855582888208;7262.745803896838;7280.67236974348;7298.416126709957;7435.33082022599 03:48:15 INFO - PID 20725 | |4;prototype.html;503.64241388614084;505.797680927629;518.1114388823169;524.6327570700511;530.6126527634824;6280.712453946941;6323.177986861713;6345.699131678;6359.4594459471;6380.29816720161;6121.510279177666;6144.938550614493;6150.815475535741;6155.353687862777;6166.321704612489;4879.365682461275;4962.503749625027;5051.419086805027;5082.170418649283;5098.668586541881;4886.633502487328;4921.769557610597;4944.8516544503545;4948.059868624968;5017.297578339036;4888.169011268075;4921.729304888229;4948.628852836052;4953.23224900141;5027.0699920514635;4883.853484395474;4887.193613053842;4907.533784290505;4931.309616653672;4972.105021096201;4477.440319960005;4478.731276123411;4511.413516242867;4516.299973504112;4524.88687782808;5968.492678122365;6060.787872424444;6098.69506524672;6165.568410211287;6170.598911070811;5646.181303710939;5661.264035675335;5665.54675625953;5677;5729.598928075036;6469.256035555924;6502.93497065028;6521.369657585604;6534.215894092692;6569.587538679207;4864.464908860023;4872.537108974641;4873.829415970424;4907.043126590316;4927.743425426494;6581.2431570369545;6719.193696756421;6818.829529261808;6834.316568343175;6875.52785843151;4941.950580494149;4948.257761335756;4949.82675606352;4978.875528111754;5042.621803364762;5065.138926382524;5065.721385323843;5071.112555302807;5071.87320316995;5094.159463688524;5617.9438205618235;5627.774889004476;5720.971395143081;5742.626729262584;5750.539956803445;6597.043428702811;6638.634875081821;6649.700763465656;6656.201255849329;6695.933040669531;1784.3933062758724;1789.498940296693;1798.6312805874763;1803.8466730327807;1814.8729588928911;1184.7867383870987;1211.7273613437083;1219.4451524556305;1232.4022848918266;1248.4132457745027;5760.3951585083805;5818.8254352369495;5820.708964551755;5841.88316233673;5859.44335288147;6682.398584127354;6724.462043036546;6759.526833121733;6767.627780472023;6775.593464392152;5734.845834790932;5737.913931291034;5753.1370294456165;5772.220750198753;5870.26621672291;3568.964310356915;3601.693856022215;3613.403788374941;3618.457231415256;3622.3117607654463;6543.448055258453;6575.408213260829;6601.900971485432;6628.602283862887;6639.34016495876;6945.51381403307;6962.512624116263;6978.371946524837;6995.1955525114245;7002.684879180449;6578.934210657832;6584.934150658528;6599.571027883172;6609.933900660932;6642.900356494656;6255.211041031117;6707;6715.395614394728;6769;6797.304654914806;6591.209054913441;6592.7033283503315;6594.637294948824;6633.867322653424;6717.932820671731;6363.8952875396035;6447.259914536397;6448.322926092693;6483.610983341015;6495.772647957298;5037.244413338029;5048.318477005557;5065.366829146356;5079.415867175175;5098.2352647103235;6406.263279722892;6603.1041685403925;6720.8319792005595;6766.323367663391;6784.694688739118;6207.324022513986;6409.262934762562;6417.550771445954;6521.641309727821;6566.2093610214515;6365.172527571386;6444.747530762414;6472.611643301417;6508.121403610452;6544;6420.357964203542;6434.935650643621;6481.254655714653;6523.445507131947;6526.738930442919;6520.804375868732;6556.704948277435;6572.704228309642;6608.43828274602;6622.437092847162;6329.594753993453;6373.5857169283845;6447.967760161169;6467.967660161669;6507.577007494498 03:48:15 INFO - PID 20725 | |5;yui.html;904.5206040798375;911.8951320598131;931.6506310133698;936.1434287626818;936.6534382278558;16750.078745668983;17387.565310867234;17404.91297543512;17452;17508;18645.90677046613;22290.108395664152;22291.554168916613;22423;22470.77529224707;1046.7958748044134;1075.4138994248115;1075.6181555547746;1075.6450371377466;1076.8546246256733;1041.515695201731;1056.3714589819044;1068.7114479090642;1070.9196810239225;1072.4476894399352;1101.1741194104422;1103.3269705479652;1108.1799468393372;1110.0675432636624;1120.5797825815318;1095.1293721491393;1095.4413249242943;1097.3690128176331;1098.555085190499;1100.4112799652187;804.1395706593947;808.5189312359196;809.0655293136437;810.0401024785648;810.712197170002;19139.425817225507;20023.699644505345;20128.094235759425;20429.284975025952;20448;22001.449963751034;22024.889875550518;22056.558868822693;22371.44071398212;22595.548089038293;16788.160591970354;16801.15994200285;16896.40862569804;16959.915200424042;17121;3657.030886814996;3682.963170368289;3684.5394325709285;3686.078480379905;3688.0042388555207;127940;130753.34623326822;131375;131599.99999999904;132836;16845.91577042107;16863.494095177164;17112.828871711372;17360.82639173592;17374.826251737322;30491.542626860613;31392.686073139434;31400;31906.36187276288;32250.677493225237;8382.706605268908;8541.27399171065;8546.487210767375;8583.828323433496;8590.613422396007;3899.941500877489;4009.4587230724064;4023.1752490739327;4023.7988100594853;4025.355943049098;5062.190049592121;5292.550133238641;5335.706536140549;5751.511121554715;6058.21243238385;1120.6525976947173;1139.9544018239344;1144.8053830848776;1160.2632328471313;1173.0556901694217;662.4071456046811;689.1936434371797;698.9161300643955;713.5968177979425;722.227216877946;12028.398580070962;12358.691032724075;12371.257724536557;12764.425600847984;13568.525101621593;681.4820736240393;687.6183718036538;688.9862202755917;701.5264696330058;703.1000319590829;5670.5747068969995;5708.828735137952;5788.739506722208;5911.970440147772;6495.545311828127;106590;108303.45848270708;111814.44092779647;111888;115237;96222;98145;98968.50515747376;102338.48830755799;102665.48667256765;82038.58980705058;82417.17582824094;83161;83269;86192;12249.865331285138;13038.739225215631;13075;13091.083624146218;13376;40961.59038409697;41514.58485415107;41589.37615935824;42710.57289427066;44311.778441107585;71534.64232679011;74370;75362;80784.59607701923;81894.59052704698;19642.50893727668;20163.596728065062;20297.79702202959;20439.386818395473;20514.692279616116;19411.2235510578;21527.677084844054;21932.232371866907;22090.668639970736;22270.218382529034;19802.90098549498;20011.799882000993;20040.59918801645;20169.495762606053;20334.59330813405;19554;19725.40823775289;19749.70375444398;19856.60286794285;20509.2821751238;19215.423537293904;19424.90287548553;19634.607307853476;19731.704024439932;19787;13873.375698093812;13898.652533686334;14005.929970350491;14074.648133796736;14304.499342522962;12356.691082722644;12701.36493175356;12757.107002509736;12814;12922.612321630366 03:48:15 INFO - PID 20725 | __end_tp_report 03:48:15 INFO - PID 20725 | __start_cc_report 03:48:15 INFO - PID 20725 | _x_x_mozilla_cycle_collect,377 03:48:15 INFO - PID 20725 | __end_cc_report 03:48:15 INFO - PID 20725 | __startTimestamp1502362095166__endTimestamp 03:48:15 INFO - PID 20725 | 03:48:15 INFO - PID 20725 | ------- Summary: start ------- 03:48:15 INFO - PID 20725 | Number of tests: 6 03:48:15 INFO - PID 20725 | 03:48:15 INFO - PID 20725 | [#0] dojo.html Cycles:165 Average:6216.47 Median:6488.22 stddev:739.11 (11.4%) stddev-sans-first:700.79 03:48:15 INFO - PID 20725 | Values: 3136.9 3145.5 3151.2 3165.7 3183.3 6194.6 6218.5 6246.2 6253.8 6270.1 6145.1 6276.7 6286.0 6294.6 6353.6 5690.2 5757.1 5779.0 5782.2 5842.1 5750.5 5786.6 5816.9 5822.7 5853.2 5582.2 5747.0 5797.4 5844.6 5852.6 5706.8 5711.0 5712.5 5741.5 5820.7 5676.3 5702.1 5742.6 5773.5 5787.3 6141.2 6182.4 6220.1 6271.1 6306.8 6732.2 6783.4 6805.8 6814.9 6849.8 6727.0 6739.1 6833.6 6843.7 6848.0 6227.1 6316.9 6373.1 6374.0 6398.2 6858.9 6933.6 6942.9 6950.1 6968.9 6524.5 6602.9 6608.2 6645.6 6648.0 6711.1 6726.1 6729.9 6741.3 6741.4 6698.3 6731.3 6741.4 6752.4 6797.6 6758.8 6792.2 6807.1 6817.4 6829.9 5426.7 5482.7 5489.5 5494.5 5508.1 4605.1 4653.6 4656.5 4666.5 4710.3 5870.2 5873.6 5884.4 5887.2 5887.5 6759.4 6764.1 6771.3 6776.3 6776.9 5869.8 5871.4 5917.1 5925.8 5926.3 5894.5 5896.3 5957.8 5965.2 5978.8 6482.4 6526.4 6564.2 6572.3 6589.9 6658.4 6717.9 6782.9 6789.8 6808.4 6472.1 6558.1 6569.9 6624.8 6628.4 6633.5 6637.9 6659.0 6723.8 6727.3 6729.2 6780.9 6800.0 6873.2 6874.1 6525.1 6553.1 6563.7 6570.7 6571.6 6506.5 6508.3 6598.7 6608.6 6609.7 6488.2 6512.6 6537.4 6539.7 6560.2 6596.4 6635.2 6697.0 6705.9 6715.0 6299.2 6392.4 6395.4 6412.5 6434.5 03:48:15 INFO - PID 20725 | 03:48:15 INFO - PID 20725 | [#1] ext.html Cycles:180 Average:37733.98 Median:34692.50 stddev:54247.02 (156.4%) stddev-sans-first:54328.15 03:48:15 INFO - PID 20725 | Values: 758.9 818.1 850.9 853.0 1170.5 29840.4 30423.4 40139.8 41128.4 41139.0 41225.2 41272.8 41407.6 41490.6 41534.0 7553.3 7588.8 7606.7 7838.4 7874.8 7620.1 7641.6 7650.0 7661.7 7727.1 7528.9 7557.5 7638.2 7748.1 7778.8 7685.9 7710.3 7768.3 7769.4 7775.1 7639.8 7665.9 7670.0 7677.8 7680.9 36592.3 36730.6 36772.6 36868.8 36905.3 3583.4 3613.7 3619.8 3620.4 3625.3 30569.7 30584.2 30614.0 30618.2 30728.8 4905.4 5087.3 5088.0 5091.1 5127.2 197718.0 197992.0 198702.0 198801.0 199261.0 48473.5 48484.8 48657.5 48819.0 48905.5 50252.5 50367.7 50447.7 50691.7 50938.5 13186.3 13230.0 14446.0 14450.2 14675.2 11647.8 11954.8 11992.5 11993.3 12000.2 14379.8 14489.0 14623.6 14635.9 14769.6 5633.7 5693.7 5725.8 5726.0 5731.2 984.5 1006.5 1014.2 1018.0 1025.7 22603.0 29619.4 29902.4 30594.1 30662.9 1081.6 1082.8 1092.0 1094.7 1099.4 12305.0 12880.3 12993.4 13048.7 13056.1 223009.0 227448.0 227518.0 228117.0 228148.0 53061.2 53522.0 53646.2 53667.7 53730.0 1416.1 1456.2 1467.4 1468.9 1476.4 22953.4 23352.9 23403.0 23403.2 23508.7 37909.6 38181.6 38209.8 38298.2 38413.0 201036.0 201060.0 201760.0 202214.0 203087.0 30744.4 31003.2 33956.0 34737.0 34841.8 42927.5 43740.3 43900.8 43984.0 44442.1 32237.7 32602.3 32705.5 32721.7 33328.3 31904.8 32297.7 32357.7 32362.4 32675.5 34648.0 35285.8 35657.5 35698.5 35752.6 30912.7 31019.0 31429.7 31561.8 31958.0 23036.4 23595.4 23683.0 24144.8 24201.0 03:48:15 INFO - PID 20725 | 03:48:15 INFO - PID 20725 | [#2] jquery.html Cycles:180 Average:35473.73 Median:23965.96 stddev:85815.29 (358.1%) stddev-sans-first:86016.00 03:48:15 INFO - PID 20725 | Values: 563.4 563.9 571.7 579.9 599.8 21416.7 22146.2 22227.9 22269.1 22426.2 24631.4 27282.6 27333.5 27369.3 27501.3 6541.8 6644.2 6710.9 6714.0 6714.0 6066.3 6367.0 6368.2 6560.9 6637.8 6333.5 6338.8 6340.7 6344.5 6344.7 6292.2 6298.1 6301.2 6311.5 6317.9 5873.9 5904.1 5914.2 5917.2 5924.2 28513.9 29134.1 29388.4 29933.3 30550.5 1915.4 1969.3 1978.5 1980.2 1981.7 19022.1 19657.9 19665.7 19687.7 19749.4 2377.8 2418.1 2420.9 2423.9 2484.1 138684.0 141135.0 141326.3 141666.3 142121.0 14509.3 15300.7 15483.3 15529.9 15863.9 23958.8 23980.0 24193.4 24216.0 24243.7 9641.4 9793.8 9950.8 9986.2 10014.5 9081.8 9110.6 9127.2 9141.4 9152.0 7746.9 9235.1 9327.3 9400.5 9504.5 2549.0 2616.8 2670.2 2694.5 2700.3 936.6 969.7 975.3 975.5 977.8 18304.7 18884.2 23854.2 23973.2 25092.9 1021.3 1035.4 1046.4 1051.1 1055.3 10654.7 10972.6 10979.5 11060.4 11151.4 498342.0 499218.0 516088.0 516619.0 519200.0 116285.0 116482.4 119190.0 121430.0 122076.4 1254.1 1265.0 1297.1 1301.0 1305.1 17395.2 17402.8 17600.9 17762.9 18028.9 52695.5 55108.4 56584.4 58672.4 60117.2 68034.7 68049.7 68240.0 68464.0 69006.7 14280.0 14569.1 14727.4 14788.1 14837.4 22529.0 22728.9 22827.9 22932.1 23020.7 18121.4 18143.9 18374.2 18378.9 18452.6 16771.4 16855.4 16968.2 17008.6 17374.4 17541.9 17841.6 18348.5 18452.7 18709.4 14476.1 14506.3 14515.5 14555.9 14643.8 17547.0 17965.3 18071.4 18217.5 18225.7 03:48:15 INFO - PID 20725 | 03:48:15 INFO - PID 20725 | [#3] mootools.html Cycles:180 Average:8687.70 Median:2639.62 stddev:5888.72 (223.1%) stddev-sans-first:5879.52 03:48:15 INFO - PID 20725 | Values: 1362.7 1406.6 1422.2 1427.4 1431.6 13691.5 14298.7 14363.9 14372.9 14397.4 14123.2 14667.9 14676.4 14698.9 14751.6 2667.7 2712.6 2714.6 2714.9 2715.1 2670.4 2699.0 2761.2 2764.9 2770.0 2659.0 2715.6 2764.1 2766.1 2766.9 2595.8 2636.2 2648.7 2650.2 2656.0 2609.5 2621.5 2625.0 2638.9 2640.3 13734.4 13791.9 13820.3 13914.9 13989.1 7438.7 7693.3 7700.0 7702.4 7717.2 5049.6 5177.7 5206.6 5306.6 5359.2 1823.3 1829.4 1843.7 1875.2 1885.2 22931.7 23003.7 23060.3 23061.1 23076.0 6278.2 6501.9 6526.4 6615.7 6745.7 15733.9 15739.7 15780.8 15791.8 15868.0 7218.1 7503.1 7557.4 7575.4 7581.2 5756.1 5987.1 6205.4 6221.4 7010.0 4950.5 5072.9 5142.7 5179.2 5183.6 1452.2 1483.6 1484.3 1506.0 1509.6 890.8 903.2 914.4 915.8 915.9 7098.1 7142.3 7160.2 7181.0 7192.4 687.9 693.9 699.4 703.0 709.7 4455.4 5508.1 5624.1 5800.8 5913.1 18757.9 18816.6 19383.6 19573.3 19584.2 17604.0 17806.5 17851.1 17859.9 17915.6 10249.1 10300.8 10502.3 10861.6 10939.8 8063.5 8282.5 8405.6 8423.2 8498.8 16543.8 17070.2 17087.2 17101.0 17324.8 17211.7 17273.7 17375.5 17384.7 17430.6 11602.1 11621.7 11881.5 11883.1 11918.2 12705.6 13232.0 13389.9 13401.3 13419.5 10430.6 10587.8 10603.9 10667.1 10963.5 10377.5 10488.6 10556.6 10803.5 10884.8 9592.7 9645.9 9723.9 9777.0 9788.7 6807.5 7040.7 7110.4 7173.1 7187.3 7220.9 7262.7 7280.7 7298.4 7435.3 03:48:15 INFO - PID 20725 | 03:48:15 INFO - PID 20725 | [#4] prototype.html Cycles:180 Average:5516.84 Median:6153.08 stddev:1542.63 (25.1%) stddev-sans-first:1500.37 03:48:15 INFO - PID 20725 | Values: 503.6 505.8 518.1 524.6 530.6 6280.7 6323.2 6345.7 6359.5 6380.3 6121.5 6144.9 6150.8 6155.4 6166.3 4879.4 4962.5 5051.4 5082.2 5098.7 4886.6 4921.8 4944.9 4948.1 5017.3 4888.2 4921.7 4948.6 4953.2 5027.1 4883.9 4887.2 4907.5 4931.3 4972.1 4477.4 4478.7 4511.4 4516.3 4524.9 5968.5 6060.8 6098.7 6165.6 6170.6 5646.2 5661.3 5665.5 5677.0 5729.6 6469.3 6502.9 6521.4 6534.2 6569.6 4864.5 4872.5 4873.8 4907.0 4927.7 6581.2 6719.2 6818.8 6834.3 6875.5 4942.0 4948.3 4949.8 4978.9 5042.6 5065.1 5065.7 5071.1 5071.9 5094.2 5617.9 5627.8 5721.0 5742.6 5750.5 6597.0 6638.6 6649.7 6656.2 6695.9 1784.4 1789.5 1798.6 1803.8 1814.9 1184.8 1211.7 1219.4 1232.4 1248.4 5760.4 5818.8 5820.7 5841.9 5859.4 6682.4 6724.5 6759.5 6767.6 6775.6 5734.8 5737.9 5753.1 5772.2 5870.3 3569.0 3601.7 3613.4 3618.5 3622.3 6543.4 6575.4 6601.9 6628.6 6639.3 6945.5 6962.5 6978.4 6995.2 7002.7 6578.9 6584.9 6599.6 6609.9 6642.9 6255.2 6707.0 6715.4 6769.0 6797.3 6591.2 6592.7 6594.6 6633.9 6717.9 6363.9 6447.3 6448.3 6483.6 6495.8 5037.2 5048.3 5065.4 5079.4 5098.2 6406.3 6603.1 6720.8 6766.3 6784.7 6207.3 6409.3 6417.6 6521.6 6566.2 6365.2 6444.7 6472.6 6508.1 6544.0 6420.4 6434.9 6481.3 6523.4 6526.7 6520.8 6556.7 6572.7 6608.4 6622.4 6329.6 6373.6 6448.0 6468.0 6507.6 03:48:15 INFO - PID 20725 | 03:48:15 INFO - PID 20725 | [#5] yui.html Cycles:180 Average:24448.93 Median:20166.55 stddev:32853.53 (162.9%) stddev-sans-first:32898.12 03:48:15 INFO - PID 20725 | Values: 904.5 911.9 931.7 936.1 936.7 16750.1 17387.6 17404.9 17452.0 17508.0 18645.9 22290.1 22291.6 22423.0 22470.8 1046.8 1075.4 1075.6 1075.6 1076.9 1041.5 1056.4 1068.7 1070.9 1072.4 1101.2 1103.3 1108.2 1110.1 1120.6 1095.1 1095.4 1097.4 1098.6 1100.4 804.1 808.5 809.1 810.0 810.7 19139.4 20023.7 20128.1 20429.3 20448.0 22001.4 22024.9 22056.6 22371.4 22595.5 16788.2 16801.2 16896.4 16959.9 17121.0 3657.0 3683.0 3684.5 3686.1 3688.0 127940.0 130753.3 131375.0 131600.0 132836.0 16845.9 16863.5 17112.8 17360.8 17374.8 30491.5 31392.7 31400.0 31906.4 32250.7 8382.7 8541.3 8546.5 8583.8 8590.6 3899.9 4009.5 4023.2 4023.8 4025.4 5062.2 5292.6 5335.7 5751.5 6058.2 1120.7 1140.0 1144.8 1160.3 1173.1 662.4 689.2 698.9 713.6 722.2 12028.4 12358.7 12371.3 12764.4 13568.5 681.5 687.6 689.0 701.5 703.1 5670.6 5708.8 5788.7 5912.0 6495.5 106590.0 108303.5 111814.4 111888.0 115237.0 96222.0 98145.0 98968.5 102338.5 102665.5 82038.6 82417.2 83161.0 83269.0 86192.0 12249.9 13038.7 13075.0 13091.1 13376.0 40961.6 41514.6 41589.4 42710.6 44311.8 71534.6 74370.0 75362.0 80784.6 81894.6 19642.5 20163.6 20297.8 20439.4 20514.7 19411.2 21527.7 21932.2 22090.7 22270.2 19802.9 20011.8 20040.6 20169.5 20334.6 19554.0 19725.4 19749.7 19856.6 20509.3 19215.4 19424.9 19634.6 19731.7 19787.0 13873.4 13898.7 14005.9 14074.6 14304.5 12356.7 12701.4 12757.1 12814.0 12922.6 03:48:15 INFO - PID 20725 | -------- Summary: end -------- 03:48:15 INFO - PID 20725 | 03:48:15 INFO - TEST-INFO | 20725: exit 0 03:48:15 INFO - TEST-OK | dromaeo_css | took 1113681ms 03:48:15 INFO - TEST-START | kraken 03:48:15 INFO - Initialising browser for kraken test... 03:48:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:39603/getInfo.html -profile /tmp/tmp4IRlIW/profile 03:48:15 INFO - TEST-INFO | started process 21094 (/builds/slave/test/build/application/firefox/firefox http://localhost:39603/getInfo.html) 03:48:21 INFO - TEST-INFO | 21094: exit 0 03:48:21 INFO - Browser initialized. 03:48:21 INFO - Running cycle 1/1 for kraken test... 03:48:21 INFO - TEST-INFO | started process 21325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4IRlIW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:22 INFO - PID 21325 | 03:48:22 INFO - PID 21325 | (/builds/slave/test/build/application/firefox/firefox:21379): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:48:22 INFO - PID 21325 | 03:48:33 INFO - PID 21325 | RSS: Main: 170401792 03:48:33 INFO - PID 21325 | 03:48:35 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39603/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:36 INFO - PID 21325 | RSS: Main: 174596096 03:48:36 INFO - PID 21325 | 03:48:39 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39603/tests/kraken/driver.html?testName=audio-dft) 03:48:40 INFO - PID 21325 | RSS: Main: 175894528 03:48:40 INFO - PID 21325 | 03:48:43 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39603/tests/kraken/driver.html?testName=audio-fft) 03:48:43 INFO - PID 21325 | RSS: Main: 170602496 03:48:43 INFO - PID 21325 | 03:48:46 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39603/tests/kraken/driver.html?testName=audio-oscillator) 03:48:46 INFO - PID 21325 | RSS: Main: 171610112 03:48:46 INFO - PID 21325 | 03:48:48 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39603/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:48:49 INFO - PID 21325 | RSS: Main: 171331584 03:48:49 INFO - PID 21325 | 03:48:52 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39603/tests/kraken/driver.html?testName=imaging-darkroom) 03:48:53 INFO - PID 21325 | RSS: Main: 173342720 03:48:53 INFO - PID 21325 | 03:48:56 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39603/tests/kraken/driver.html?testName=imaging-desaturate) 03:48:57 INFO - PID 21325 | RSS: Main: 173735936 03:48:57 INFO - PID 21325 | 03:49:00 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39603/tests/kraken/driver.html?testName=json-parse-financial) 03:49:01 INFO - PID 21325 | RSS: Main: 173973504 03:49:01 INFO - PID 21325 | 03:49:02 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39603/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:03 INFO - PID 21325 | RSS: Main: 174661632 03:49:03 INFO - PID 21325 | 03:49:05 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:05 INFO - PID 21325 | RSS: Main: 174530560 03:49:05 INFO - PID 21325 | 03:49:08 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:08 INFO - PID 21325 | RSS: Main: 174448640 03:49:08 INFO - PID 21325 | 03:49:11 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:12 INFO - PID 21325 | RSS: Main: 174993408 03:49:12 INFO - PID 21325 | 03:49:15 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:16 INFO - PID 21325 | RSS: Main: 174866432 03:49:16 INFO - PID 21325 | 03:49:17 INFO - PID 21325 | Cycle 1(1): loaded http://localhost:39603/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39603/tests/kraken/driver.html?testName=ai-astar) 03:49:18 INFO - PID 21325 | RSS: Main: 176066560 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | __start_tp_report 03:49:18 INFO - PID 21325 | _x_x_mozilla_page_load 03:49:18 INFO - PID 21325 | _x_x_mozilla_page_load_details 03:49:18 INFO - PID 21325 | |i|pagename|runs| 03:49:18 INFO - PID 21325 | |0;ai-astar;99;115;102;107;108;109;107;100;109;110 03:49:18 INFO - PID 21325 | |1;audio-beat-detection;168;119;151;189;127;146;157;118;187;124 03:49:18 INFO - PID 21325 | |2;audio-dft;167;163;163;162;163;174;170;163;162;163 03:49:18 INFO - PID 21325 | |3;audio-fft;75;75;75;165;76;76;77;74;152;78 03:49:18 INFO - PID 21325 | |4;audio-oscillator;77;79;125;83;79;79;128;82;78;138 03:49:18 INFO - PID 21325 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;114;121;115 03:49:18 INFO - PID 21325 | |6;imaging-darkroom;149;153;151;159;154;150;150;154;151;150 03:49:18 INFO - PID 21325 | |7;imaging-desaturate;95;94;94;94;94;94;94;95;93;94 03:49:18 INFO - PID 21325 | |8;json-parse-financial;61;54;54;67;55;58;55;59;59;56 03:49:18 INFO - PID 21325 | |9;json-stringify-tinderbox;54;55;56;54;54;55;58;53;62;55 03:49:18 INFO - PID 21325 | |10;stanford-crypto-aes;87;79;84;87;91;101;78;93;78;81 03:49:18 INFO - PID 21325 | |11;stanford-crypto-ccm;137;134;142;140;129;126;143;150;129;180 03:49:18 INFO - PID 21325 | |12;stanford-crypto-pbkdf2;187;174;177;176;180;177;183;179;185;169 03:49:18 INFO - PID 21325 | |13;stanford-crypto-sha256-iterative;71;69;68;67;67;66;70;69;66;65 03:49:18 INFO - PID 21325 | __end_tp_report 03:49:18 INFO - PID 21325 | __start_cc_report 03:49:18 INFO - PID 21325 | _x_x_mozilla_cycle_collect,962 03:49:18 INFO - PID 21325 | __end_cc_report 03:49:18 INFO - PID 21325 | __startTimestamp1502362158151__endTimestamp 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | ------- Summary: start ------- 03:49:18 INFO - PID 21325 | Number of tests: 14 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#0] ai-astar Cycles:10 Average:106.60 Median:109.00 stddev:4.93 (4.5%) stddev-sans-first:4.39 03:49:18 INFO - PID 21325 | Values: 99.0 115.0 102.0 107.0 108.0 109.0 107.0 100.0 109.0 110.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#1] audio-beat-detection Cycles:10 Average:148.60 Median:154.00 stddev:26.77 (17.4%) stddev-sans-first:27.46 03:49:18 INFO - PID 21325 | Values: 168.0 119.0 151.0 189.0 127.0 146.0 157.0 118.0 187.0 124.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#2] audio-dft Cycles:10 Average:165.00 Median:163.00 stddev:4.06 (2.5%) stddev-sans-first:4.24 03:49:18 INFO - PID 21325 | Values: 167.0 163.0 163.0 162.0 163.0 174.0 170.0 163.0 162.0 163.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#3] audio-fft Cycles:10 Average:92.30 Median:75.50 stddev:35.04 (46.4%) stddev-sans-first:36.61 03:49:18 INFO - PID 21325 | Values: 75.0 75.0 75.0 165.0 76.0 76.0 77.0 74.0 152.0 78.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#4] audio-oscillator Cycles:10 Average:94.80 Median:79.00 stddev:24.79 (31.4%) stddev-sans-first:25.44 03:49:18 INFO - PID 21325 | Values: 77.0 79.0 125.0 83.0 79.0 79.0 128.0 82.0 78.0 138.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:114.00 stddev:2.18 (1.9%) stddev-sans-first:2.29 03:49:18 INFO - PID 21325 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 121.0 115.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#6] imaging-darkroom Cycles:10 Average:152.10 Median:152.00 stddev:3.00 (2.0%) stddev-sans-first:2.96 03:49:18 INFO - PID 21325 | Values: 149.0 153.0 151.0 159.0 154.0 150.0 150.0 154.0 151.0 150.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 03:49:18 INFO - PID 21325 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 93.0 94.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.50 stddev:4.02 (6.9%) stddev-sans-first:4.10 03:49:18 INFO - PID 21325 | Values: 61.0 54.0 54.0 67.0 55.0 58.0 55.0 59.0 59.0 56.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:55.00 stddev:2.63 (4.8%) stddev-sans-first:2.73 03:49:18 INFO - PID 21325 | Values: 54.0 55.0 56.0 54.0 54.0 55.0 58.0 53.0 62.0 55.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.50 stddev:7.50 (8.8%) stddev-sans-first:7.95 03:49:18 INFO - PID 21325 | Values: 87.0 79.0 84.0 87.0 91.0 101.0 78.0 93.0 78.0 81.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:141.00 stddev:15.58 (11.1%) stddev-sans-first:16.46 03:49:18 INFO - PID 21325 | Values: 137.0 134.0 142.0 140.0 129.0 126.0 143.0 150.0 129.0 180.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.70 Median:179.50 stddev:5.36 (3.0%) stddev-sans-first:4.76 03:49:18 INFO - PID 21325 | Values: 187.0 174.0 177.0 176.0 180.0 177.0 183.0 179.0 185.0 169.0 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.93 (2.8%) stddev-sans-first:1.67 03:49:18 INFO - PID 21325 | Values: 71.0 69.0 68.0 67.0 67.0 66.0 70.0 69.0 66.0 65.0 03:49:18 INFO - PID 21325 | -------- Summary: end -------- 03:49:18 INFO - PID 21325 | 03:49:18 INFO - PID 21325 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:49:18 INFO - TEST-INFO | 21325: exit 0 03:49:18 INFO - TEST-OK | kraken | took 63045ms 03:49:18 INFO - SUITE-END | took 1176s 03:49:19 INFO - Completed test suite (00:19:37) 03:49:19 INFO - javascript benchmark 03:49:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8524.28223572105, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3136.937261254775, 3145.4809956357217, 3151.1649412905576, 3165.651778304386, 3183.2837611537393, 6194.566380353377, 6218.502519798417, 6246.187995560571, 6253.812385628427, 6270.090836828657, 6145.108959200925, 6276.717547710353, 6286.0, 6294.590851594643, 6353.555251132422, 5690.231818704484, 5757.050086735683, 5778.971105144489, 5782.219400380958, 5842.123681447795, 5750.482456578907, 5786.623869448494, 5816.912746308788, 5822.650640961535, 5853.239078919734, 5582.190582365575, 5747.0, 5797.420257974211, 5844.561657875655, 5852.561057920651, 5706.828795136153, 5711.02912504871, 5712.457316554921, 5741.45456181662, 5820.708964551798, 5676.318841739017, 5702.116171993348, 5742.569307301969, 5773.451522105435, 5787.276590426197, 6141.201643786324, 6182.381761823826, 6220.12918191449, 6271.059341098826, 6306.779262725829, 6732.1921369435495, 6783.3555812197765, 6805.829854253634, 6814.863702725967, 6849.794506164823, 6727.0, 6739.056532085512, 6833.58998460089, 6843.657817109174, 6848.0, 6227.065940108974, 6316.936830631681, 6373.107764912916, 6373.968130159412, 6398.232212134527, 6858.897116543256, 6933.618650974144, 6942.895856562156, 6950.131233595801, 6968.930310696929, 6524.478041756648, 6602.933970660328, 6608.173978252718, 6645.634490102994, 6648.0, 6711.127553418024, 6726.091977582963, 6729.899051514231, 6741.325867413219, 6741.426978706767, 6698.330166983263, 6731.259561448237, 6741.393274605309, 6752.392284694303, 6797.592144471348, 6758.797236082925, 6792.150981127359, 6807.149106361705, 6817.352351526597, 6829.931700683029, 5426.70153141581, 5482.671039737628, 5489.451054894478, 5494.478024587658, 5508.091164957817, 4605.148047611203, 4653.581177693956, 4656.511066338054, 4666.486686464486, 4710.26990816424, 5870.207521984563, 5873.647581145145, 5884.382139875337, 5887.2052272943465, 5887.528997680175, 6759.357861003196, 6764.086848275519, 6771.322867713189, 6776.28848970851, 6776.9322306777285, 5869.8239052828485, 5871.354151043467, 5917.053271476543, 5925.822225333247, 5926.2888453385, 5894.469497745138, 5896.292444906553, 5957.761689532457, 5965.224520812267, 5978.760849565969, 6482.416582507597, 6526.412622863965, 6564.212294524687, 6572.277049524549, 6589.934100658932, 6658.400743933069, 6717.92513197886, 6782.932170678428, 6789.830254243683, 6808.353206445379, 6472.126262954629, 6558.081868538313, 6569.9014514783275, 6624.834379140368, 6628.403443690091, 6633.535652504278, 6637.933620663925, 6659.034440006269, 6723.798286051427, 6727.327267273234, 6729.158855143107, 6780.864382712417, 6800.047993281044, 6873.20958089826, 6874.106366172366, 6525.053867189136, 6553.115329430466, 6563.737450501926, 6570.671466426564, 6571.605703657796, 6506.544541882023, 6508.349165083454, 6598.670066496752, 6608.570442921195, 6609.735610575523, 6488.221413430419, 6512.5766825156215, 6537.444317233088, 6539.738410463528, 6560.212774467094, 6596.406323430914, 6635.23694775107, 6697.0, 6705.865882682221, 6714.966425167843, 6299.244090708961, 6392.360763923571, 6395.392437718409, 6412.454941330039, 6434.485241180788], "value": 6160.156007518825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.9089309282887, 818.1205204405264, 850.8681154421063, 853.0445900591338, 1170.5025364220205, 29840.403191936148, 30423.391532169342, 40139.79930100349, 41128.38307425391, 41139.0, 41225.175496490054, 41272.793636031776, 41407.58592414075, 41490.58509414905, 41534.0, 7553.320201181892, 7588.772336829904, 7606.657700403467, 7838.372930165573, 7874.763757087297, 7620.08558972924, 7641.617919104023, 7650.043744531934, 7661.655225514837, 7727.111382191064, 7528.887066694004, 7557.546547207157, 7638.197989211136, 7748.070231572219, 7778.766637000899, 7685.923140768633, 7710.344620707247, 7768.339691126261, 7769.3784497240085, 7775.1447340792465, 7639.770806875803, 7665.8850117248285, 7670.0, 7677.846443071163, 7680.923190768132, 36592.26815463702, 36730.63269367299, 36772.63227367719, 36868.81565592182, 36905.261894762225, 3583.4445660922597, 3613.7109031277696, 3619.8009109498967, 3620.3664358737115, 3625.29306785177, 30569.694303056905, 30584.235394115327, 30614.0, 30618.234544136576, 30728.846355768077, 4905.4358748744, 5087.287779710843, 5088.0, 5091.134507133796, 5127.2052831811125, 197718.0, 197992.0, 198702.0, 198801.00599497053, 199261.0, 48473.51526484761, 48484.757576211894, 48657.513424866, 48819.0, 48905.5109448901, 50252.49747502551, 50367.74816125896, 50447.74776126169, 50691.74654126706, 50938.490615093375, 13186.340682965812, 13230.0, 14446.0, 14450.205238711762, 14675.192864392347, 11647.76704465906, 11954.760904781855, 11992.520299188109, 11993.340366279765, 12000.1599888007, 14379.849612031012, 14489.0, 14623.561293161221, 14635.92682036583, 14769.630759231106, 5633.718314084279, 5693.715314234271, 5725.77096916127, 5725.971370143123, 5731.226284451629, 984.5028260728429, 1006.4665727164614, 1014.2443879309814, 1017.9847302290472, 1025.738436698637, 22603.0, 29619.407611847644, 29902.401951961274, 30594.08217753471, 30662.926797561977, 1081.5511562701547, 1082.815921293382, 1091.9945400272948, 1094.7099018760034, 1099.428297285423, 12305.0, 12880.291583962784, 12993.350332483338, 13048.673783155307, 13056.08607397492, 223009.0, 227448.0, 227518.0, 228117.0, 228148.0, 53061.2040819388, 53522.0, 53646.195307070426, 53667.73166134222, 53730.0, 1416.129080615414, 1456.155429850684, 1467.4423718986716, 1468.9412423503154, 1476.4094362255184, 22953.426164346023, 23352.88323558439, 23403.0, 23403.180888668816, 23508.707021114, 37909.62090379061, 38181.61818381781, 38209.80895095507, 38298.23403531969, 38413.0, 201036.0, 201060.0, 201760.0, 202214.0, 203087.0, 30744.385112298078, 31003.224919377197, 33956.0, 34737.0, 34841.825790870884, 42927.49753758604, 43740.34389484224, 43900.780496097315, 43984.0, 44442.11115777731, 32237.677623223466, 32602.34795304128, 32705.509417358284, 32721.672783271864, 33328.33343333168, 31904.84047579747, 32297.677023229466, 32357.676423235465, 32362.352752944338, 32675.509867352484, 34648.0, 35285.82357088301, 35657.46513802347, 35698.46452303165, 35752.64247357597, 30912.69087309098, 31019.0, 31429.68570314359, 31561.8421907889, 31958.0, 23036.4240893979, 23595.41011474727, 23683.0, 24144.758552414954, 24201.0], "value": 17134.472772516194, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.3606553297798, 563.8844036972421, 571.6541492397103, 579.8927198468284, 599.7720866070894, 21416.678749818744, 22146.22488212913, 22227.888860555675, 22269.109235630556, 22426.215082472118, 24631.384215394624, 27282.5907611386, 27333.45333093337, 27369.315767105832, 27501.31246718833, 6541.771038013659, 6644.202695676526, 6710.932890671104, 6713.966430167842, 6713.966430167867, 6066.332703402622, 6366.968165159168, 6368.203974503187, 6560.868782624345, 6637.767678131267, 6333.524985626096, 6338.809835704937, 6340.714667839935, 6344.49244060474, 6344.6510441925675, 6292.150559674431, 6298.086777417295, 6301.180846489973, 6311.52663550231, 6317.905231421532, 5873.911891321633, 5904.084866845646, 5914.2015827863115, 5917.20117784098, 5924.2298501195, 28513.85743071292, 29134.12597622075, 29388.412231755246, 29933.25166870824, 30550.54174187389, 1915.3583549510931, 1969.3107412405543, 1978.5053736565858, 1980.2475059477451, 1981.6532106881239, 19022.144003519876, 19657.901710491355, 19665.705014424795, 19687.704684429744, 19749.407517774347, 2377.7741114594087, 2418.069043418279, 2420.8668523231217, 2423.9272821815375, 2484.142970675114, 138684.0, 141135.0, 141326.29336853352, 141666.29166854202, 142121.0, 14509.347079381454, 15300.693986120437, 15483.303251353716, 15529.922350388175, 15863.920680396524, 23958.760412396, 23980.0, 24193.39516512066, 24216.0, 24243.66659833691, 9641.37331073492, 9793.755156121155, 9950.80098398028, 9986.151177150025, 10014.49927503622, 9081.81836363269, 9110.59002344896, 9127.224185944136, 9141.405808622418, 9152.0, 7746.883796743054, 9235.122663347105, 9327.300452466092, 9400.48297343639, 9504.477253750973, 2548.9745102548736, 2616.7775739062013, 2670.1588999465107, 2694.5419278722666, 2700.257429206984, 936.6440752514137, 969.6945561706003, 975.3075316525346, 975.4634950777045, 977.7751117243074, 18304.725429118575, 18884.24463021491, 23854.228045820695, 23973.160939367037, 25092.870820812743, 1021.269792098653, 1035.4158138048797, 1046.4349251404155, 1051.1380667852288, 1055.3034996902009, 10654.680359589225, 10972.615958441416, 10979.505922233519, 11060.391678457761, 11151.38667373286, 498342.0, 499218.0, 516088.0, 516619.0, 519200.0, 116285.0, 116482.41758791152, 119190.0, 121430.0, 122076.38961805134, 1254.1221145198397, 1264.9557265495664, 1297.0531511996107, 1300.9674758131123, 1305.145129939891, 17395.2172152256, 17402.82597174012, 17600.911995440452, 17762.91118544399, 18028.909855450638, 52695.47304526906, 55108.44891551033, 56584.43415565956, 58672.4132758667, 60117.196484105545, 68034.65982670055, 68049.65975170092, 68240.0, 68464.0, 69006.65496672485, 14280.0, 14569.053011554215, 14727.410903563738, 14788.11271323724, 14837.40650373973, 22529.0, 22728.88635556878, 22827.88586057059, 22932.082716691144, 23020.654690179326, 18121.36575219861, 18143.909280453514, 18374.173162207466, 18378.908105459923, 18452.630947381247, 16771.413000544922, 16855.410060647817, 16968.151592420578, 17008.574785629964, 17374.39189628357, 17541.912290438977, 17841.553961151076, 18348.541286467946, 18452.723209151605, 18709.43871683852, 14476.131432114107, 14506.274686265433, 14515.491957781427, 14555.92722036383, 14643.780343294646, 17547.0, 17965.281388744304, 18071.367502137364, 18217.544561386072, 18225.726614101066], "value": 11987.872303944348, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1362.7002059546899, 1406.6202125426141, 1422.1680317014545, 1427.4076258352784, 1431.5776845830485, 13691.452341906324, 14298.714025719491, 14363.856361436383, 14372.856271437282, 14397.424103035879, 14123.223222722747, 14667.853321466782, 14676.412943482275, 14698.926505367484, 14751.631209219775, 2667.653205083346, 2712.593111033341, 2714.606382074598, 2714.8914043438335, 2715.0633031604066, 2670.3591138126903, 2698.9865050674816, 2761.199252216855, 2764.861756912146, 2769.9584506232422, 2658.9601155982677, 2715.551933930899, 2764.060219525361, 2766.0595397564825, 2766.9169924902185, 2595.8442493450357, 2636.1959602321285, 2648.72188420216, 2650.1651979626454, 2655.9601605975927, 2609.5041942030953, 2621.501914636213, 2624.960625590618, 2638.9472210555873, 2640.2871224769206, 13734.381952812148, 13791.931040344834, 13820.308984550733, 13914.860851391559, 13989.090709103977, 7438.73964411243, 7693.269139431745, 7700.0, 7702.422318326092, 7717.151113377524, 5049.64652474327, 5177.689338639656, 5206.609504287194, 5306.628536002481, 5359.196120581944, 1823.2889173222454, 1829.3597240965555, 1843.714224295223, 1875.165551329659, 1885.208212550732, 22931.656025159635, 23003.654945175836, 23060.308190754306, 23061.077556897704, 23076.0, 6278.246610406689, 6501.934980650228, 6526.412622863965, 6615.735370585219, 6745.730170793211, 15733.921330393276, 15739.68520629581, 15780.842191578167, 15791.763123553155, 15868.0, 7218.097737782778, 7503.099628044561, 7557.395408367317, 7575.431842611826, 7581.166071732105, 5756.107803290497, 5987.101934709828, 6205.441510264098, 6221.377862213742, 7010.0, 4950.455449900508, 5072.949270507248, 5142.71715055668, 5179.19722443022, 5183.585313174937, 1452.157748505864, 1483.5757672634177, 1484.2801241397913, 1505.9623509412352, 1509.5773183508636, 890.8129292848445, 903.1961554216753, 914.401067300919, 915.844306467902, 915.8626206069143, 7098.1482222132645, 7142.28577142292, 7160.176579693402, 7180.9640951795955, 7192.352688258082, 687.8890591694377, 693.8855088910274, 699.4194818300798, 702.9964850175717, 709.737397163053, 4455.420795296591, 5508.14623733314, 5624.128260119688, 5800.8259752207505, 5913.083472061838, 18757.90621046886, 18816.62366752657, 19383.612327753646, 19573.314933977243, 19584.21663133487, 17604.0, 17806.46580602584, 17851.107444627716, 17859.910700446413, 17915.641687166444, 10249.12882404989, 10300.845487317696, 10502.264841461025, 10861.619843305447, 10939.781204375868, 8063.516189028677, 8282.544460054754, 8405.579721014046, 8423.241908228289, 8498.787530311545, 16543.751843722595, 17070.231839567, 17087.23107460192, 17101.0, 17324.826751732322, 17211.65576688434, 17273.654526909642, 17375.47873563795, 17384.65230695404, 17430.564235894206, 11602.129840261845, 11621.6513504595, 11881.524739010689, 11883.108766842694, 11918.225315354473, 12705.555305564261, 13232.0, 13389.866101338863, 13401.329933503092, 13419.530316438877, 10430.582776688847, 10587.841182382424, 10603.94698026505, 10667.093297069836, 10963.50664220096, 10377.481125943823, 10488.632897848538, 10556.630517931835, 10803.459827008775, 10884.836727448936, 9592.66425675098, 9645.855312170183, 9723.854142188015, 9777.022297770167, 9788.706338809847, 6807.503567326775, 7040.718371265092, 7110.43116550685, 7173.1392232932385, 7187.28127187298, 7220.855582888208, 7262.745803896838, 7280.67236974348, 7298.416126709957, 7435.33082022599], "value": 6325.255106744481, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [503.64241388614084, 505.797680927629, 518.1114388823169, 524.6327570700511, 530.6126527634824, 6280.712453946941, 6323.177986861713, 6345.699131678, 6359.4594459471, 6380.29816720161, 6121.510279177666, 6144.938550614493, 6150.815475535741, 6155.353687862777, 6166.321704612489, 4879.365682461275, 4962.503749625027, 5051.419086805027, 5082.170418649283, 5098.668586541881, 4886.633502487328, 4921.769557610597, 4944.8516544503545, 4948.059868624968, 5017.297578339036, 4888.169011268075, 4921.729304888229, 4948.628852836052, 4953.23224900141, 5027.0699920514635, 4883.853484395474, 4887.193613053842, 4907.533784290505, 4931.309616653672, 4972.105021096201, 4477.440319960005, 4478.731276123411, 4511.413516242867, 4516.299973504112, 4524.88687782808, 5968.492678122365, 6060.787872424444, 6098.69506524672, 6165.568410211287, 6170.598911070811, 5646.181303710939, 5661.264035675335, 5665.54675625953, 5677.0, 5729.598928075036, 6469.256035555924, 6502.93497065028, 6521.369657585604, 6534.215894092692, 6569.587538679207, 4864.464908860023, 4872.537108974641, 4873.829415970424, 4907.043126590316, 4927.743425426494, 6581.2431570369545, 6719.193696756421, 6818.829529261808, 6834.316568343175, 6875.52785843151, 4941.950580494149, 4948.257761335756, 4949.82675606352, 4978.875528111754, 5042.621803364762, 5065.138926382524, 5065.721385323843, 5071.112555302807, 5071.87320316995, 5094.159463688524, 5617.9438205618235, 5627.774889004476, 5720.971395143081, 5742.626729262584, 5750.539956803445, 6597.043428702811, 6638.634875081821, 6649.700763465656, 6656.201255849329, 6695.933040669531, 1784.3933062758724, 1789.498940296693, 1798.6312805874763, 1803.8466730327807, 1814.8729588928911, 1184.7867383870987, 1211.7273613437083, 1219.4451524556305, 1232.4022848918266, 1248.4132457745027, 5760.3951585083805, 5818.8254352369495, 5820.708964551755, 5841.88316233673, 5859.44335288147, 6682.398584127354, 6724.462043036546, 6759.526833121733, 6767.627780472023, 6775.593464392152, 5734.845834790932, 5737.913931291034, 5753.1370294456165, 5772.220750198753, 5870.26621672291, 3568.964310356915, 3601.693856022215, 3613.403788374941, 3618.457231415256, 3622.3117607654463, 6543.448055258453, 6575.408213260829, 6601.900971485432, 6628.602283862887, 6639.34016495876, 6945.51381403307, 6962.512624116263, 6978.371946524837, 6995.1955525114245, 7002.684879180449, 6578.934210657832, 6584.934150658528, 6599.571027883172, 6609.933900660932, 6642.900356494656, 6255.211041031117, 6707.0, 6715.395614394728, 6769.0, 6797.304654914806, 6591.209054913441, 6592.7033283503315, 6594.637294948824, 6633.867322653424, 6717.932820671731, 6363.8952875396035, 6447.259914536397, 6448.322926092693, 6483.610983341015, 6495.772647957298, 5037.244413338029, 5048.318477005557, 5065.366829146356, 5079.415867175175, 5098.2352647103235, 6406.263279722892, 6603.1041685403925, 6720.8319792005595, 6766.323367663391, 6784.694688739118, 6207.324022513986, 6409.262934762562, 6417.550771445954, 6521.641309727821, 6566.2093610214515, 6365.172527571386, 6444.747530762414, 6472.611643301417, 6508.121403610452, 6544.0, 6420.357964203542, 6434.935650643621, 6481.254655714653, 6523.445507131947, 6526.738930442919, 6520.804375868732, 6556.704948277435, 6572.704228309642, 6608.43828274602, 6622.437092847162, 6329.594753993453, 6373.5857169283845, 6447.967760161169, 6467.967660161669, 6507.577007494498], "value": 5064.632798100837, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.5206040798375, 911.8951320598131, 931.6506310133698, 936.1434287626818, 936.6534382278558, 16750.078745668983, 17387.565310867234, 17404.91297543512, 17452.0, 17508.0, 18645.90677046613, 22290.108395664152, 22291.554168916613, 22423.0, 22470.77529224707, 1046.7958748044134, 1075.4138994248115, 1075.6181555547746, 1075.6450371377466, 1076.8546246256733, 1041.515695201731, 1056.3714589819044, 1068.7114479090642, 1070.9196810239225, 1072.4476894399352, 1101.1741194104422, 1103.3269705479652, 1108.1799468393372, 1110.0675432636624, 1120.5797825815318, 1095.1293721491393, 1095.4413249242943, 1097.3690128176331, 1098.555085190499, 1100.4112799652187, 804.1395706593947, 808.5189312359196, 809.0655293136437, 810.0401024785648, 810.712197170002, 19139.425817225507, 20023.699644505345, 20128.094235759425, 20429.284975025952, 20448.0, 22001.449963751034, 22024.889875550518, 22056.558868822693, 22371.44071398212, 22595.548089038293, 16788.160591970354, 16801.15994200285, 16896.40862569804, 16959.915200424042, 17121.0, 3657.030886814996, 3682.963170368289, 3684.5394325709285, 3686.078480379905, 3688.0042388555207, 127940.0, 130753.34623326822, 131375.0, 131599.99999999904, 132836.0, 16845.91577042107, 16863.494095177164, 17112.828871711372, 17360.82639173592, 17374.826251737322, 30491.542626860613, 31392.686073139434, 31400.0, 31906.36187276288, 32250.677493225237, 8382.706605268908, 8541.27399171065, 8546.487210767375, 8583.828323433496, 8590.613422396007, 3899.941500877489, 4009.4587230724064, 4023.1752490739327, 4023.7988100594853, 4025.355943049098, 5062.190049592121, 5292.550133238641, 5335.706536140549, 5751.511121554715, 6058.21243238385, 1120.6525976947173, 1139.9544018239344, 1144.8053830848776, 1160.2632328471313, 1173.0556901694217, 662.4071456046811, 689.1936434371797, 698.9161300643955, 713.5968177979425, 722.227216877946, 12028.398580070962, 12358.691032724075, 12371.257724536557, 12764.425600847984, 13568.525101621593, 681.4820736240393, 687.6183718036538, 688.9862202755917, 701.5264696330058, 703.1000319590829, 5670.5747068969995, 5708.828735137952, 5788.739506722208, 5911.970440147772, 6495.545311828127, 106590.0, 108303.45848270708, 111814.44092779647, 111888.0, 115237.0, 96222.0, 98145.0, 98968.50515747376, 102338.48830755799, 102665.48667256765, 82038.58980705058, 82417.17582824094, 83161.0, 83269.0, 86192.0, 12249.865331285138, 13038.739225215631, 13075.0, 13091.083624146218, 13376.0, 40961.59038409697, 41514.58485415107, 41589.37615935824, 42710.57289427066, 44311.778441107585, 71534.64232679011, 74370.0, 75362.0, 80784.59607701923, 81894.59052704698, 19642.50893727668, 20163.596728065062, 20297.79702202959, 20439.386818395473, 20514.692279616116, 19411.2235510578, 21527.677084844054, 21932.232371866907, 22090.668639970736, 22270.218382529034, 19802.90098549498, 20011.799882000993, 20040.59918801645, 20169.495762606053, 20334.59330813405, 19554.0, 19725.40823775289, 19749.70375444398, 19856.60286794285, 20509.2821751238, 19215.423537293904, 19424.90287548553, 19634.607307853476, 19731.704024439932, 19787.0, 13873.375698093812, 13898.652533686334, 14005.929970350491, 14074.648133796736, 14304.499342522962, 12356.691082722644, 12701.36493175356, 12757.107002509736, 12814.0, 12922.612321630366], "value": 9464.325552938817, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 115.0, 102.0, 107.0, 108.0, 109.0, 107.0, 100.0, 109.0, 110.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 119.0, 151.0, 189.0, 127.0, 146.0, 157.0, 118.0, 187.0, 124.0], "value": 148.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 163.0, 162.0, 163.0, 174.0, 170.0, 163.0, 162.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 165.0, 76.0, 76.0, 77.0, 74.0, 152.0, 78.0], "value": 92.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 125.0, 83.0, 79.0, 79.0, 128.0, 82.0, 78.0, 138.0], "value": 94.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 121.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 153.0, 151.0, 159.0, 154.0, 150.0, 150.0, 154.0, 151.0, 150.0], "value": 152.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 93.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 54.0, 54.0, 67.0, 55.0, 58.0, 55.0, 59.0, 59.0, 56.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 56.0, 54.0, 54.0, 55.0, 58.0, 53.0, 62.0, 55.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 84.0, 87.0, 91.0, 101.0, 78.0, 93.0, 78.0, 81.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 142.0, 140.0, 129.0, 126.0, 143.0, 150.0, 129.0, 180.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 174.0, 177.0, 176.0, 180.0, 177.0, 183.0, 179.0, 185.0, 169.0], "value": 178.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 68.0, 67.0, 67.0, 66.0, 70.0, 69.0, 66.0, 65.0], "value": 67.8, "unit": "score"}]}]} 03:49:19 INFO - Return code: 0 03:49:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:49:19 INFO - # TBPL SUCCESS # 03:49:19 INFO - Running post-action listener: _package_coverage_data 03:49:19 INFO - Running post-action listener: _resource_record_post_action 03:49:19 INFO - [mozharness: 2017-08-10 10:49:19.452694Z] Finished run-tests step (success) 03:49:19 INFO - Running post-run listener: _resource_record_post_run 03:49:19 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 16384; Write bytes: 432676864; Read time: 396; Write time: 260776 03:49:19 INFO - TinderboxPrint: CPU usage
13.2% 03:49:19 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 396 03:49:19 INFO - TinderboxPrint: I/O write bytes / time
432,676,864 / 260,776 03:49:19 INFO - TinderboxPrint: CPU idle
8,272.2 (86.8%) 03:49:19 INFO - TinderboxPrint: CPU user
1,205.7 (12.7%) 03:49:19 INFO - TinderboxPrint: Swap in / out
0 / 0 03:49:19 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106688512; Read time: 76; Write time: 97876 03:49:19 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:49:19 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 8192; Write bytes: 324866048; Read time: 276; Write time: 162872 03:49:20 INFO - Running post-run listener: _upload_blobber_files 03:49:20 INFO - Blob upload gear active. 03:49:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:49:20 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:49:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:49:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:21 INFO - (blobuploader) - INFO - Done attempting. 03:49:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:24 INFO - (blobuploader) - INFO - Done attempting. 03:49:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:49:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:49:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:25 INFO - (blobuploader) - INFO - Done attempting. 03:49:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:49:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:49:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:25 INFO - (blobuploader) - INFO - Done attempting. 03:49:25 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:25 INFO - Return code: 0 03:49:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:25 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6f1005a74ecde7d50b3e0a959552af7fbfeaff4af6314b3e60822d79847e00af843fa0225c303de25317873f0b7313802d3f0df0f65895b0cd7411429bf4857", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c568f33b8169d8b9b7df04fdea15737798b34ef7213cc77d8726d819a5b7cef19d503ad5bd100e232ed89e3ebbd4324278febb989ee5fe0e80b2166bb76c3207", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fde091e136244e505652f525be58e9117f85ba79fbf0a36045a15affac9c9cacc4843994dc53411ec5affc25bcb1f15e1f997a58ea3074527e8e733b642ad7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42fa78b7dd3d94cbafe4762e984a5b9a88d04606ed9079e9ad7f3702cd93e05af6343b240adbfb54707614fba78d895c2b7525e9971295261db54f0c023a4c44"} 03:49:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:25 INFO - Contents: 03:49:25 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6f1005a74ecde7d50b3e0a959552af7fbfeaff4af6314b3e60822d79847e00af843fa0225c303de25317873f0b7313802d3f0df0f65895b0cd7411429bf4857", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c568f33b8169d8b9b7df04fdea15737798b34ef7213cc77d8726d819a5b7cef19d503ad5bd100e232ed89e3ebbd4324278febb989ee5fe0e80b2166bb76c3207", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fde091e136244e505652f525be58e9117f85ba79fbf0a36045a15affac9c9cacc4843994dc53411ec5affc25bcb1f15e1f997a58ea3074527e8e733b642ad7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42fa78b7dd3d94cbafe4762e984a5b9a88d04606ed9079e9ad7f3702cd93e05af6343b240adbfb54707614fba78d895c2b7525e9971295261db54f0c023a4c44"} 03:49:25 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:25 INFO - Copying logs to upload dir... 03:49:25 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.967879 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-08-10 03:49:25.478353) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-10 03:49:25.485760) ========= 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=20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239 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/f6f1005a74ecde7d50b3e0a959552af7fbfeaff4af6314b3e60822d79847e00af843fa0225c303de25317873f0b7313802d3f0df0f65895b0cd7411429bf4857", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c568f33b8169d8b9b7df04fdea15737798b34ef7213cc77d8726d819a5b7cef19d503ad5bd100e232ed89e3ebbd4324278febb989ee5fe0e80b2166bb76c3207", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fde091e136244e505652f525be58e9117f85ba79fbf0a36045a15affac9c9cacc4843994dc53411ec5affc25bcb1f15e1f997a58ea3074527e8e733b642ad7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42fa78b7dd3d94cbafe4762e984a5b9a88d04606ed9079e9ad7f3702cd93e05af6343b240adbfb54707614fba78d895c2b7525e9971295261db54f0c023a4c44"} build_url:https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011216 build_url: 'https://queue.taskcluster.net/v1/task/GaVERyTITH-z0EQo_o-6HQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6f1005a74ecde7d50b3e0a959552af7fbfeaff4af6314b3e60822d79847e00af843fa0225c303de25317873f0b7313802d3f0df0f65895b0cd7411429bf4857", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c568f33b8169d8b9b7df04fdea15737798b34ef7213cc77d8726d819a5b7cef19d503ad5bd100e232ed89e3ebbd4324278febb989ee5fe0e80b2166bb76c3207", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fde091e136244e505652f525be58e9117f85ba79fbf0a36045a15affac9c9cacc4843994dc53411ec5affc25bcb1f15e1f997a58ea3074527e8e733b642ad7b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42fa78b7dd3d94cbafe4762e984a5b9a88d04606ed9079e9ad7f3702cd93e05af6343b240adbfb54707614fba78d895c2b7525e9971295261db54f0c023a4c44"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-10 03:49:25.510017) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:49:25.513326) ========= 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=20e666a3d4cfbb71505a330e000001b4-1502351359.272810-418727239 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004376 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-10 03:49:25.596095) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-10 03:49:25.599452) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-10 03:49:25.599754) ========= ========= Total master_lag: 0.30 =========