builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1502879219.5 results: success (0) revision: c498777e8f39a3027e44d7badad05bd3a3f86f08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:26:59.503822) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:26:59.504244) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:26:59.504513) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:26:59.520393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:26:59.520684) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 03:26:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.8M=0s 2017-08-16 03:26:59 (49.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151247 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:26:59.687112) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:26:59.687419) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021415 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:26:59.741394) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 03:26:59.743743) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c498777e8f39a3027e44d7badad05bd3a3f86f08 --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 c498777e8f39a3027e44d7badad05bd3a3f86f08 --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=56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 03:27:00,037 truncating revision to first 12 chars 2017-08-16 03:27:00,037 Setting DEBUG logging. 2017-08-16 03:27:00,037 attempt 1/10 2017-08-16 03:27:00,037 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c498777e8f39?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 03:27:00,929 unpacking tar archive at: mozilla-central-c498777e8f39/testing/mozharness/ program finished with exit code 0 elapsedTime=1.201075 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 03:27:00.959253) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:00.962559) ========= script_repo_revision: c498777e8f39a3027e44d7badad05bd3a3f86f08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:00.962940) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:00.963198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:27:00.975190) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-08-16 03:27:00.975451) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:27:01 INFO - MultiFileLogger online at 20170816 03:27:01 in /builds/slave/test 03:27:01 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:27:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:27:01 INFO - {'append_to_log': False, 03:27:01 INFO - 'base_work_dir': '/builds/slave/test', 03:27:01 INFO - 'blob_upload_branch': 'Firefox', 03:27:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:27:01 INFO - 'branch': 'Firefox', 03:27:01 INFO - 'buildbot_json_path': 'buildprops.json', 03:27:01 INFO - 'code_coverage': False, 03:27:01 INFO - 'config_files': ('talos/linux_config.py',), 03:27:01 INFO - 'default_actions': ('clobber', 03:27:01 INFO - 'read-buildbot-config', 03:27:01 INFO - 'download-and-extract', 03:27:01 INFO - 'populate-webroot', 03:27:01 INFO - 'create-virtualenv', 03:27:01 INFO - 'install', 03:27:01 INFO - 'setup-mitmproxy', 03:27:01 INFO - 'run-tests'), 03:27:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:27:01 INFO - 'disable_ccov_upload': False, 03:27:01 INFO - 'download_minidump_stackwalk': True, 03:27:01 INFO - 'download_symbols': 'ondemand', 03:27:01 INFO - 'enable_stylo': False, 03:27:01 INFO - 'enable_webrender': False, 03:27:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:27:01 INFO - 'tooltool.py': '/tools/tooltool.py', 03:27:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:27:01 INFO - '/tools/misc-python/virtualenv.py')}, 03:27:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:27:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:27:01 INFO - 'gecko_profile': False, 03:27:01 INFO - 'gecko_profile_interval': 0, 03:27:01 INFO - 'installer_path': 'installer.exe', 03:27:01 INFO - 'log_level': 'info', 03:27:01 INFO - 'log_name': 'talos', 03:27:01 INFO - 'log_to_console': True, 03:27:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:27:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:27:01 INFO - 'opt_config_files': (), 03:27:01 INFO - 'pip_index': False, 03:27:01 INFO - 'suite': 'dromaeojs-e10s', 03:27:01 INFO - 'system_bits': '32', 03:27:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:27:01 INFO - 'title': 'talos-linux64-ix-037', 03:27:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:27:01 INFO - 'use_talos_json': True, 03:27:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:27:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:27:01 INFO - 'work_dir': 'build'} 03:27:01 INFO - [mozharness: 2017-08-16 10:27:01.371645Z] Running clobber step. 03:27:01 INFO - Running pre-action listener: _resource_record_pre_action 03:27:01 INFO - Running main action method: clobber 03:27:01 INFO - rmtree: /builds/slave/test/build 03:27:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:27:02 INFO - Running post-action listener: _resource_record_post_action 03:27:02 INFO - [mozharness: 2017-08-16 10:27:02.466418Z] Finished clobber step (success) 03:27:02 INFO - [mozharness: 2017-08-16 10:27:02.466519Z] Running read-buildbot-config step. 03:27:02 INFO - Running pre-action listener: _resource_record_pre_action 03:27:02 INFO - Running main action method: read_buildbot_config 03:27:02 INFO - Using buildbot properties: 03:27:02 INFO - { 03:27:02 INFO - "project": "", 03:27:02 INFO - "product": "firefox", 03:27:02 INFO - "who": "cbook@mozilla.com", 03:27:02 INFO - "installer_path": "public/build/target.tar.bz2", 03:27:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:27:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:27:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:27:02 INFO - "stage_platform": "linux64-pgo", 03:27:02 INFO - "basedir": "/builds/slave/test", 03:27:02 INFO - "buildnumber": 116, 03:27:02 INFO - "platform": "ubuntu64_hw", 03:27:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:27:02 INFO - "slavebuilddir": "test", 03:27:02 INFO - "taskId": "fvELLTk6QCak45lH1b_2hg", 03:27:02 INFO - "branch": "mozilla-central", 03:27:02 INFO - "script_repo_revision": "production", 03:27:02 INFO - "revision": "c498777e8f39a3027e44d7badad05bd3a3f86f08", 03:27:02 INFO - "slavename": "talos-linux64-ix-037", 03:27:02 INFO - "repo_path": "mozilla-central" 03:27:02 INFO - } 03:27:02 INFO - Finding installer, test and symbols from parent task. 03:27:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fvELLTk6QCak45lH1b_2hg'}, attempt #1 03:27:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fvELLTk6QCak45lH1b_2hg'}, attempt #1 03:27:03 INFO - Task dependencies: ItWMdFNSQ8683rsRnnsRdA 03:27:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA'}, attempt #1 03:27:03 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.tar.bz2 03:27:03 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.test_packages.json 03:27:03 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.crashreporter-symbols.zip 03:27:03 INFO - Running post-action listener: _resource_record_post_action 03:27:03 INFO - [mozharness: 2017-08-16 10:27:03.805870Z] Finished read-buildbot-config step (success) 03:27:03 INFO - [mozharness: 2017-08-16 10:27:03.806095Z] Running download-and-extract step. 03:27:03 INFO - Running pre-action listener: _resource_record_pre_action 03:27:03 INFO - Running main action method: download_and_extract 03:27:03 INFO - mkdir: /builds/slave/test/build/tests 03:27:03 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:27:03 INFO - trying https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.test_packages.json 03:27:03 INFO - Downloading https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:27:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:27:04 INFO - Downloaded 989 bytes. 03:27:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:27:04 INFO - Using the following test package requirements: 03:27:04 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:27:04 INFO - u'common': [u'target.common.tests.zip'], 03:27:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:27:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:27:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:27:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:27:04 INFO - u'mozbase': [u'target.common.tests.zip'], 03:27:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:27:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:27:04 INFO - u'web-platform': [u'target.common.tests.zip', 03:27:04 INFO - u'target.web-platform.tests.tar.gz'], 03:27:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:27:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:27:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.common.tests.zip 03:27:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:27:04 INFO - Fetch https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.common.tests.zip into memory 03:27:05 INFO - Content-Length response header: 54610230 03:27:05 INFO - Bytes received: 54610230 03:27:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:27:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.common.tests.zip 03:27:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:27:16 INFO - Fetch https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.common.tests.zip into memory 03:27:17 INFO - Content-Length response header: 54610230 03:27:17 INFO - Bytes received: 54610230 03:27:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.talos.tests.zip 03:27:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:27:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.talos.tests.zip into memory 03:27:29 INFO - Content-Length response header: 14496050 03:27:29 INFO - Bytes received: 14496050 03:27:30 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:27:30 INFO - trying https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.tar.bz2 03:27:30 INFO - Downloading https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:27:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:27:31 INFO - Downloaded 62739801 bytes. 03:27:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.tar.bz2 03:27:31 INFO - mkdir: /builds/slave/test/properties 03:27:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:27:31 INFO - Writing to file /builds/slave/test/properties/build_url 03:27:31 INFO - Contents: 03:27:31 INFO - build_url:https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.tar.bz2 03:27:31 INFO - Running post-action listener: _resource_record_post_action 03:27:31 INFO - Running post-action listener: set_extra_try_arguments 03:27:31 INFO - [mozharness: 2017-08-16 10:27:31.378497Z] Finished download-and-extract step (success) 03:27:31 INFO - [mozharness: 2017-08-16 10:27:31.378596Z] Running populate-webroot step. 03:27:31 INFO - Running pre-action listener: _resource_record_pre_action 03:27:31 INFO - Running main action method: populate_webroot 03:27:31 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:27:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:27:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:27:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:27:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:27:31 INFO - 'tests': ['damp', 'tps']}, 03:27:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:27:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:27:31 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:27:31 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:27:31 INFO - 'other-e10s': {'tests': ['a11yr', 03:27:31 INFO - 'ts_paint', 03:27:31 INFO - 'tpaint', 03:27:31 INFO - 'sessionrestore', 03:27:31 INFO - 'sessionrestore_many_windows', 03:27:31 INFO - 'sessionrestore_no_auto_restore', 03:27:31 INFO - 'tabpaint']}, 03:27:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:27:31 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:27:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:27:31 INFO - 'tsvgr_opacity', 03:27:31 INFO - 'tart', 03:27:31 INFO - 'tscrollx', 03:27:31 INFO - 'tsvg_static']}, 03:27:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:27:31 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:27:31 INFO - 'talos_options': ['--mitmproxy', 03:27:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:27:31 INFO - '--firstNonBlankPaint'], 03:27:31 INFO - 'tests': ['tp6_google', 03:27:31 INFO - 'tp6_youtube', 03:27:31 INFO - 'tp6_amazon', 03:27:31 INFO - 'tp6_facebook']}, 03:27:31 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:27:31 INFO - 'talos_options': ['--stylo', 03:27:31 INFO - '--mitmproxy', 03:27:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:27:31 INFO - '--firstNonBlankPaint'], 03:27:31 INFO - 'tests': ['tp6_google', 03:27:31 INFO - 'tp6_youtube', 03:27:31 INFO - 'tp6_amazon', 03:27:31 INFO - 'tp6_facebook']}, 03:27:31 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:27:31 INFO - 'talos_options': ['--stylo', 03:27:31 INFO - '--stylo-threads=1', 03:27:31 INFO - '--mitmproxy', 03:27:31 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:27:31 INFO - '--firstNonBlankPaint'], 03:27:31 INFO - 'tests': ['tp6_google', 03:27:31 INFO - 'tp6_youtube', 03:27:31 INFO - 'tp6_amazon', 03:27:31 INFO - 'tp6_facebook']}, 03:27:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:27:31 INFO - 'talos_options': ['--xperf_path', 03:27:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:27:31 INFO - 'tests': ['tp5n']}}} 03:27:31 INFO - Running post-action listener: _resource_record_post_action 03:27:31 INFO - [mozharness: 2017-08-16 10:27:31.387034Z] Finished populate-webroot step (success) 03:27:31 INFO - [mozharness: 2017-08-16 10:27:31.387125Z] Running create-virtualenv step. 03:27:31 INFO - Running pre-action listener: _resource_record_pre_action 03:27:31 INFO - Running main action method: create_virtualenv 03:27:31 INFO - Creating virtualenv /builds/slave/test/build/venv 03:27:31 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:27:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:27:31 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:27:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:27:31 INFO - Using real prefix '/usr' 03:27:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:27:31 INFO - Installing distribute.............................................................................................................................................................................................done. 03:27:33 INFO - Installing pip.................done. 03:27:33 INFO - Return code: 0 03:27:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:27:34 INFO - Reading from file tmpfile_stdout 03:27:34 INFO - Output received: 03:27:34 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:27:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:27:34 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:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:34 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:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:34 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 0xcff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa40b0>, '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 0xfa4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa5440>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', '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:27:34 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:27:34 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:27:34 INFO - Using env: {'DISPLAY': ':0', 03:27:34 INFO - 'HOME': '/home/cltbld', 03:27:34 INFO - 'LANG': 'en_US.UTF-8', 03:27:34 INFO - 'LANGUAGE': 'en_US:en', 03:27:34 INFO - 'LOGNAME': 'cltbld', 03:27:34 INFO - 'MAIL': '/var/mail/cltbld', 03:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:34 INFO - 'MOZ_NO_REMOTE': '1', 03:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:34 INFO - 'NO_EM_RESTART': '1', 03:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:34 INFO - 'PWD': '/builds/slave/test', 03:27:34 INFO - 'SHELL': '/bin/bash', 03:27:34 INFO - 'SHLVL': '1', 03:27:34 INFO - 'TERM': 'linux', 03:27:34 INFO - 'TMOUT': '86400', 03:27:34 INFO - 'USER': 'cltbld', 03:27:34 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', 03:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:34 INFO - '_': '/tools/buildbot/bin/python'} 03:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:34 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:27:34 INFO - Cleaning up... 03:27:34 INFO - Return code: 0 03:27:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:27:34 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:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:34 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:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:34 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 0xcff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa40b0>, '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 0xfa4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa5440>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', '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:27:34 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:27:34 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:27:34 INFO - Using env: {'DISPLAY': ':0', 03:27:34 INFO - 'HOME': '/home/cltbld', 03:27:34 INFO - 'LANG': 'en_US.UTF-8', 03:27:34 INFO - 'LANGUAGE': 'en_US:en', 03:27:34 INFO - 'LOGNAME': 'cltbld', 03:27:34 INFO - 'MAIL': '/var/mail/cltbld', 03:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:34 INFO - 'MOZ_NO_REMOTE': '1', 03:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:34 INFO - 'NO_EM_RESTART': '1', 03:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:34 INFO - 'PWD': '/builds/slave/test', 03:27:34 INFO - 'SHELL': '/bin/bash', 03:27:34 INFO - 'SHLVL': '1', 03:27:34 INFO - 'TERM': 'linux', 03:27:34 INFO - 'TMOUT': '86400', 03:27:34 INFO - 'USER': 'cltbld', 03:27:34 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', 03:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:34 INFO - '_': '/tools/buildbot/bin/python'} 03:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:34 INFO - Downloading/unpacking psutil>=3.1.1 03:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:27:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:35 INFO - Installing collected packages: psutil 03:27:35 INFO - Running setup.py install for psutil 03:27:35 INFO - building 'psutil._psutil_linux' extension 03:27:35 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:27:36 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:27:36 INFO - building 'psutil._psutil_posix' extension 03:27:36 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:27:36 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:27:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:27:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:27:36 INFO - Successfully installed psutil 03:27:36 INFO - Cleaning up... 03:27:36 INFO - Return code: 0 03:27:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:27:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:36 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 0xcff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa40b0>, '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 0xfa4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa5440>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', '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:27:36 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:27:36 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:27:36 INFO - Using env: {'DISPLAY': ':0', 03:27:36 INFO - 'HOME': '/home/cltbld', 03:27:36 INFO - 'LANG': 'en_US.UTF-8', 03:27:36 INFO - 'LANGUAGE': 'en_US:en', 03:27:36 INFO - 'LOGNAME': 'cltbld', 03:27:36 INFO - 'MAIL': '/var/mail/cltbld', 03:27:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:36 INFO - 'MOZ_NO_REMOTE': '1', 03:27:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:36 INFO - 'NO_EM_RESTART': '1', 03:27:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:36 INFO - 'PWD': '/builds/slave/test', 03:27:36 INFO - 'SHELL': '/bin/bash', 03:27:36 INFO - 'SHLVL': '1', 03:27:36 INFO - 'TERM': 'linux', 03:27:36 INFO - 'TMOUT': '86400', 03:27:36 INFO - 'USER': 'cltbld', 03:27:36 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', 03:27:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:36 INFO - '_': '/tools/buildbot/bin/python'} 03:27:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:27:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:27:37 INFO - Installing collected packages: mozsystemmonitor 03:27:37 INFO - Running setup.py install for mozsystemmonitor 03:27:37 INFO - Successfully installed mozsystemmonitor 03:27:37 INFO - Cleaning up... 03:27:37 INFO - Return code: 0 03:27:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:27:37 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:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:37 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:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:37 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 0xcff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa40b0>, '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 0xfa4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa5440>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', '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:27:37 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:27:37 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:27:37 INFO - Using env: {'DISPLAY': ':0', 03:27:37 INFO - 'HOME': '/home/cltbld', 03:27:37 INFO - 'LANG': 'en_US.UTF-8', 03:27:37 INFO - 'LANGUAGE': 'en_US:en', 03:27:37 INFO - 'LOGNAME': 'cltbld', 03:27:37 INFO - 'MAIL': '/var/mail/cltbld', 03:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:37 INFO - 'MOZ_NO_REMOTE': '1', 03:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:37 INFO - 'NO_EM_RESTART': '1', 03:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:37 INFO - 'PWD': '/builds/slave/test', 03:27:37 INFO - 'SHELL': '/bin/bash', 03:27:37 INFO - 'SHLVL': '1', 03:27:37 INFO - 'TERM': 'linux', 03:27:37 INFO - 'TMOUT': '86400', 03:27:37 INFO - 'USER': 'cltbld', 03:27:37 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', 03:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:37 INFO - '_': '/tools/buildbot/bin/python'} 03:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:38 INFO - Downloading/unpacking jsonschema==2.5.1 03:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:27:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:39 INFO - Downloading functools32-3.2.3-2.tar.gz 03:27:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:27:39 INFO - warning: no files found matching '*.txt' 03:27:39 INFO - no previously-included directories found matching 'build' 03:27:39 INFO - no previously-included directories found matching 'dist' 03:27:39 INFO - no previously-included directories found matching '.git*' 03:27:39 INFO - Installing collected packages: jsonschema, functools32 03:27:39 INFO - Running setup.py install for functools32 03:27:39 INFO - warning: no files found matching '*.txt' 03:27:39 INFO - no previously-included directories found matching 'build' 03:27:39 INFO - no previously-included directories found matching 'dist' 03:27:39 INFO - no previously-included directories found matching '.git*' 03:27:39 INFO - Successfully installed jsonschema functools32 03:27:39 INFO - Cleaning up... 03:27:39 INFO - Return code: 0 03:27:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:27:39 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:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:39 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:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:39 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 0xcff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa40b0>, '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 0xfa4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa5440>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', '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:27:39 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:27:39 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:27:39 INFO - Using env: {'DISPLAY': ':0', 03:27:39 INFO - 'HOME': '/home/cltbld', 03:27:39 INFO - 'LANG': 'en_US.UTF-8', 03:27:39 INFO - 'LANGUAGE': 'en_US:en', 03:27:39 INFO - 'LOGNAME': 'cltbld', 03:27:39 INFO - 'MAIL': '/var/mail/cltbld', 03:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:39 INFO - 'MOZ_NO_REMOTE': '1', 03:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:39 INFO - 'NO_EM_RESTART': '1', 03:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:39 INFO - 'PWD': '/builds/slave/test', 03:27:39 INFO - 'SHELL': '/bin/bash', 03:27:39 INFO - 'SHLVL': '1', 03:27:39 INFO - 'TERM': 'linux', 03:27:39 INFO - 'TMOUT': '86400', 03:27:39 INFO - 'USER': 'cltbld', 03:27:39 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', 03:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:39 INFO - '_': '/tools/buildbot/bin/python'} 03:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:27:39 INFO - Cleaning up... 03:27:39 INFO - Return code: 0 03:27:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:27:39 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:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:39 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:27:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:39 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 0xcff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa40b0>, '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 0xfa4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa5440>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', '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:27:39 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:27:39 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:27:39 INFO - Using env: {'DISPLAY': ':0', 03:27:39 INFO - 'HOME': '/home/cltbld', 03:27:39 INFO - 'LANG': 'en_US.UTF-8', 03:27:39 INFO - 'LANGUAGE': 'en_US:en', 03:27:39 INFO - 'LOGNAME': 'cltbld', 03:27:39 INFO - 'MAIL': '/var/mail/cltbld', 03:27:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:39 INFO - 'MOZ_NO_REMOTE': '1', 03:27:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:39 INFO - 'NO_EM_RESTART': '1', 03:27:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:39 INFO - 'PWD': '/builds/slave/test', 03:27:39 INFO - 'SHELL': '/bin/bash', 03:27:39 INFO - 'SHLVL': '1', 03:27:39 INFO - 'TERM': 'linux', 03:27:39 INFO - 'TMOUT': '86400', 03:27:39 INFO - 'USER': 'cltbld', 03:27:39 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', 03:27:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:39 INFO - '_': '/tools/buildbot/bin/python'} 03:27:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:39 INFO - Downloading/unpacking blobuploader==1.2.4 03:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:27:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:27:41 INFO - Downloading blobuploader-1.2.4.tar.gz 03:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:27:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:27:41 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:27:41 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:27:41 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:27:41 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:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:27:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:27:41 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:27:41 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:27:41 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:27:41 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:27:41 INFO - Downloading docopt-0.6.1.tar.gz 03:27:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:27:41 INFO - Installing collected packages: blobuploader, requests, docopt 03:27:41 INFO - Running setup.py install for blobuploader 03:27:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:27:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:27:41 INFO - Running setup.py install for requests 03:27:42 INFO - Running setup.py install for docopt 03:27:42 INFO - Successfully installed blobuploader requests docopt 03:27:42 INFO - Cleaning up... 03:27:42 INFO - Return code: 0 03:27:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:42 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:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:42 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:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:42 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 0xcff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa40b0>, '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 0xfa4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa5440>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', '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:27:42 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:27:42 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:27:42 INFO - Using env: {'DISPLAY': ':0', 03:27:42 INFO - 'HOME': '/home/cltbld', 03:27:42 INFO - 'LANG': 'en_US.UTF-8', 03:27:42 INFO - 'LANGUAGE': 'en_US:en', 03:27:42 INFO - 'LOGNAME': 'cltbld', 03:27:42 INFO - 'MAIL': '/var/mail/cltbld', 03:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:42 INFO - 'MOZ_NO_REMOTE': '1', 03:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:42 INFO - 'NO_EM_RESTART': '1', 03:27:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:42 INFO - 'PWD': '/builds/slave/test', 03:27:42 INFO - 'SHELL': '/bin/bash', 03:27:42 INFO - 'SHLVL': '1', 03:27:42 INFO - 'TERM': 'linux', 03:27:42 INFO - 'TMOUT': '86400', 03:27:42 INFO - 'USER': 'cltbld', 03:27:42 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', 03:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:42 INFO - '_': '/tools/buildbot/bin/python'} 03:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:42 INFO - Running setup.py (path:/tmp/pip-tyctrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:42 INFO - Running setup.py (path:/tmp/pip-HWeWHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:42 INFO - Running setup.py (path:/tmp/pip-Scn4hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:42 INFO - Running setup.py (path:/tmp/pip-8FXLFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:42 INFO - Running setup.py (path:/tmp/pip-S6HaDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:42 INFO - Running setup.py (path:/tmp/pip-lyffno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:42 INFO - Running setup.py (path:/tmp/pip-s0HGr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:43 INFO - Running setup.py (path:/tmp/pip-0Phibw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:43 INFO - Running setup.py (path:/tmp/pip-71kGta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:43 INFO - Running setup.py (path:/tmp/pip-SodI46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:43 INFO - Running setup.py (path:/tmp/pip-2s0G4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:43 INFO - Running setup.py (path:/tmp/pip-d8XbiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:43 INFO - Running setup.py (path:/tmp/pip-Z0EZWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:43 INFO - Running setup.py (path:/tmp/pip-TYoNe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:43 INFO - Running setup.py (path:/tmp/pip-UjMpqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:43 INFO - Running setup.py (path:/tmp/pip-_X0bQU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:43 INFO - Running setup.py (path:/tmp/pip-SDqHfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:27:43 INFO - Running setup.py install for manifestparser 03:27:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:27:43 INFO - Running setup.py install for mozcrash 03:27:43 INFO - Running setup.py install for mozdebug 03:27:44 INFO - Running setup.py install for mozdevice 03:27:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:27:44 INFO - Running setup.py install for mozfile 03:27:44 INFO - Running setup.py install for mozhttpd 03:27:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:27:44 INFO - Running setup.py install for mozinfo 03:27:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:27:44 INFO - Running setup.py install for mozInstall 03:27:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:27:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:27:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:27:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:27:44 INFO - Running setup.py install for mozleak 03:27:44 INFO - Running setup.py install for mozlog 03:27:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:27:44 INFO - Running setup.py install for moznetwork 03:27:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:27:44 INFO - Running setup.py install for mozprocess 03:27:44 INFO - Running setup.py install for mozprofile 03:27:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:27:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:27:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:27:45 INFO - Running setup.py install for mozrunner 03:27:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:27:45 INFO - Running setup.py install for mozscreenshot 03:27:45 INFO - Running setup.py install for moztest 03:27:45 INFO - Running setup.py install for mozversion 03:27:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:27:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:27:45 INFO - Cleaning up... 03:27:45 INFO - Return code: 0 03:27:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:45 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:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:45 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:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:45 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 0xcff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa40b0>, '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 0xfa4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa5440>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', '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:27:45 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:27:45 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:27:45 INFO - Using env: {'DISPLAY': ':0', 03:27:45 INFO - 'HOME': '/home/cltbld', 03:27:45 INFO - 'LANG': 'en_US.UTF-8', 03:27:45 INFO - 'LANGUAGE': 'en_US:en', 03:27:45 INFO - 'LOGNAME': 'cltbld', 03:27:45 INFO - 'MAIL': '/var/mail/cltbld', 03:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:45 INFO - 'MOZ_NO_REMOTE': '1', 03:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:45 INFO - 'NO_EM_RESTART': '1', 03:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:45 INFO - 'PWD': '/builds/slave/test', 03:27:45 INFO - 'SHELL': '/bin/bash', 03:27:45 INFO - 'SHLVL': '1', 03:27:45 INFO - 'TERM': 'linux', 03:27:45 INFO - 'TMOUT': '86400', 03:27:45 INFO - 'USER': 'cltbld', 03:27:45 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', 03:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:45 INFO - '_': '/tools/buildbot/bin/python'} 03:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:27:45 INFO - Running setup.py (path:/tmp/pip-f6RLJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:27:45 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:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:27:45 INFO - Running setup.py (path:/tmp/pip-vTdd9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:27:45 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:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:27:45 INFO - Running setup.py (path:/tmp/pip-fBITNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:27:45 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:27:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:27:45 INFO - Running setup.py (path:/tmp/pip-mJxxUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:27:46 INFO - Running setup.py (path:/tmp/pip-bCKxjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:27:46 INFO - Running setup.py (path:/tmp/pip-4zVWhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:27:46 INFO - Running setup.py (path:/tmp/pip-liU2v7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:27:46 INFO - Running setup.py (path:/tmp/pip-jVZkYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:27:46 INFO - Running setup.py (path:/tmp/pip-5MsomO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:27:46 INFO - Running setup.py (path:/tmp/pip-xulHcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:27:46 INFO - Running setup.py (path:/tmp/pip-gMhl5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:27:46 INFO - Running setup.py (path:/tmp/pip-F0P0_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:27:46 INFO - Running setup.py (path:/tmp/pip-qovgIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:27:46 INFO - Running setup.py (path:/tmp/pip-VkKe7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:46 INFO - Running setup.py (path:/tmp/pip-d7QXHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:27:46 INFO - Running setup.py (path:/tmp/pip-jKQjbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:27:46 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:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:27:46 INFO - Running setup.py (path:/tmp/pip-_uJwz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:27:46 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:27:46 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:27:46 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:27:46 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:27:46 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:27:46 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:27:46 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:27:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:27:46 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:27:46 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:27:46 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:27:46 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:27:48 INFO - Downloading blessings-1.6.tar.gz 03:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:27:48 INFO - Installing collected packages: blessings 03:27:48 INFO - Running setup.py install for blessings 03:27:48 INFO - Successfully installed blessings 03:27:48 INFO - Cleaning up... 03:27:48 INFO - Return code: 0 03:27:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:27:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:48 INFO - Reading from file tmpfile_stdout 03:27:48 INFO - Current package versions: 03:27:48 INFO - argparse == 1.2.1 03:27:48 INFO - blessings == 1.6 03:27:48 INFO - blobuploader == 1.2.4 03:27:48 INFO - docopt == 0.6.1 03:27:48 INFO - functools32 == 3.2.3-2 03:27:48 INFO - jsonschema == 2.5.1 03:27:48 INFO - manifestparser == 1.1 03:27:48 INFO - mozInstall == 1.13 03:27:48 INFO - mozcrash == 1.0 03:27:48 INFO - mozdebug == 0.1 03:27:48 INFO - mozdevice == 0.51 03:27:48 INFO - mozfile == 1.2 03:27:48 INFO - mozhttpd == 0.7 03:27:48 INFO - mozinfo == 0.10 03:27:48 INFO - mozleak == 0.1 03:27:48 INFO - mozlog == 3.5 03:27:48 INFO - moznetwork == 0.27 03:27:48 INFO - mozprocess == 0.25 03:27:48 INFO - mozprofile == 0.28 03:27:48 INFO - mozrunner == 6.13 03:27:48 INFO - mozscreenshot == 0.1 03:27:48 INFO - mozsystemmonitor == 0.3 03:27:48 INFO - moztest == 0.8 03:27:48 INFO - mozversion == 1.4 03:27:48 INFO - psutil == 3.1.1 03:27:48 INFO - requests == 1.2.3 03:27:48 INFO - wsgiref == 0.1.2 03:27:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:27:48 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:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:48 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:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:48 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 0xcff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa40b0>, '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 0xfa4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa5440>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', '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:27:48 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:27:48 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:27:48 INFO - Using env: {'DISPLAY': ':0', 03:27:48 INFO - 'HOME': '/home/cltbld', 03:27:48 INFO - 'LANG': 'en_US.UTF-8', 03:27:48 INFO - 'LANGUAGE': 'en_US:en', 03:27:48 INFO - 'LOGNAME': 'cltbld', 03:27:48 INFO - 'MAIL': '/var/mail/cltbld', 03:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:48 INFO - 'MOZ_NO_REMOTE': '1', 03:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:48 INFO - 'NO_EM_RESTART': '1', 03:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:48 INFO - 'PWD': '/builds/slave/test', 03:27:48 INFO - 'SHELL': '/bin/bash', 03:27:48 INFO - 'SHLVL': '1', 03:27:48 INFO - 'TERM': 'linux', 03:27:48 INFO - 'TMOUT': '86400', 03:27:48 INFO - 'USER': 'cltbld', 03:27:48 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', 03:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:48 INFO - '_': '/tools/buildbot/bin/python'} 03:27:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:48 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:27:48 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:27:48 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:27:48 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:27:48 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:27:48 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:27:48 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:27:48 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:27:48 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:27:48 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:27:48 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:27:48 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:27:48 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:27:48 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:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:27:49 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:27:49 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:27:49 INFO - Installing collected packages: simplejson 03:27:49 INFO - Running setup.py install for simplejson 03:27:49 INFO - building 'simplejson._speedups' extension 03:27:49 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:27:50 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:27:50 INFO - Successfully installed simplejson 03:27:50 INFO - Cleaning up... 03:27:50 INFO - Return code: 0 03:27:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:27:50 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:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:27:50 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:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:27:50 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 0xcff1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe03a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa6ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa40b0>, '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 0xfa4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa5440>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', '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:27:50 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:27:50 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:27:50 INFO - Using env: {'DISPLAY': ':0', 03:27:50 INFO - 'HOME': '/home/cltbld', 03:27:50 INFO - 'LANG': 'en_US.UTF-8', 03:27:50 INFO - 'LANGUAGE': 'en_US:en', 03:27:50 INFO - 'LOGNAME': 'cltbld', 03:27:50 INFO - 'MAIL': '/var/mail/cltbld', 03:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:27:50 INFO - 'MOZ_NO_REMOTE': '1', 03:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:27:50 INFO - 'NO_EM_RESTART': '1', 03:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:27:50 INFO - 'PWD': '/builds/slave/test', 03:27:50 INFO - 'SHELL': '/bin/bash', 03:27:50 INFO - 'SHLVL': '1', 03:27:50 INFO - 'TERM': 'linux', 03:27:50 INFO - 'TMOUT': '86400', 03:27:50 INFO - 'USER': 'cltbld', 03:27:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', 03:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:27:50 INFO - '_': '/tools/buildbot/bin/python'} 03:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:27:51 INFO - Cleaning up... 03:27:51 INFO - Return code: 0 03:27:51 INFO - Running post-action listener: _resource_record_post_action 03:27:51 INFO - Running post-action listener: _start_resource_monitoring 03:27:51 INFO - Starting resource monitoring. 03:27:51 INFO - [mozharness: 2017-08-16 10:27:51.185170Z] Finished create-virtualenv step (success) 03:27:51 INFO - [mozharness: 2017-08-16 10:27:51.185746Z] Running install step. 03:27:51 INFO - Running pre-action listener: _resource_record_pre_action 03:27:51 INFO - Running main action method: install 03:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:27:51 INFO - Reading from file tmpfile_stdout 03:27:51 INFO - Detecting whether we're running mozinstall >=1.0... 03:27:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:27:51 INFO - Reading from file tmpfile_stdout 03:27:51 INFO - Output received: 03:27:51 INFO - Usage: mozinstall [options] installer 03:27:51 INFO - Options: 03:27:51 INFO - -h, --help show this help message and exit 03:27:51 INFO - -d DEST, --destination=DEST 03:27:51 INFO - Directory to install application into. [default: 03:27:51 INFO - "/builds/slave/test"] 03:27:51 INFO - --app=APP Application being installed. [default: firefox] 03:27:51 INFO - mkdir: /builds/slave/test/build/application 03:27:51 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:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:28:09 INFO - Reading from file tmpfile_stdout 03:28:09 INFO - Output received: 03:28:09 INFO - /builds/slave/test/build/application/firefox/firefox 03:28:09 INFO - Running post-action listener: _resource_record_post_action 03:28:09 INFO - [mozharness: 2017-08-16 10:28:09.316685Z] Finished install step (success) 03:28:09 INFO - [mozharness: 2017-08-16 10:28:09.316968Z] Running setup-mitmproxy step. 03:28:09 INFO - Running pre-action listener: _resource_record_pre_action 03:28:09 INFO - Running main action method: setup_mitmproxy 03:28:09 INFO - Skipping: mitmproxy is not required 03:28:09 INFO - Running post-action listener: _resource_record_post_action 03:28:09 INFO - [mozharness: 2017-08-16 10:28:09.318176Z] Finished setup-mitmproxy step (success) 03:28:09 INFO - [mozharness: 2017-08-16 10:28:09.318408Z] Running run-tests step. 03:28:09 INFO - Running pre-action listener: _resource_record_pre_action 03:28:09 INFO - Running pre-action listener: _set_gcov_prefix 03:28:09 INFO - Running main action method: run_tests 03:28:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:28:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:28:09 INFO - Python 2.7.3 03:28:09 INFO - Return code: 0 03:28:09 INFO - grabbing minidump binary from tooltool 03:28:09 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:09 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 0xfa40b0>, '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 0xfa4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa5440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:28:09 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:28:09 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:28:09 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:28:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:28:09 INFO - Return code: 0 03:28:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:28:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:28:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:28:09 INFO - ENV: RUST_BACKTRACE is now full 03:28:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:28:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:28:09 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/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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:28:09 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/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-037 --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:28:09 INFO - Using env: {'DISPLAY': ':0', 03:28:09 INFO - 'HOME': '/home/cltbld', 03:28:09 INFO - 'LANG': 'en_US.UTF-8', 03:28:09 INFO - 'LANGUAGE': 'en_US:en', 03:28:09 INFO - 'LOGNAME': 'cltbld', 03:28:09 INFO - 'MAIL': '/var/mail/cltbld', 03:28:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:28:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:28:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:28:09 INFO - 'MOZ_NO_REMOTE': '1', 03:28:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:28:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:28:09 INFO - 'NO_EM_RESTART': '1', 03:28:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:28:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:28:09 INFO - 'PWD': '/builds/slave/test', 03:28:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:28:09 INFO - 'RUST_BACKTRACE': 'full', 03:28:09 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:28:09 INFO - 'SHELL': '/bin/bash', 03:28:09 INFO - 'SHLVL': '1', 03:28:09 INFO - 'TERM': 'linux', 03:28:09 INFO - 'TMOUT': '86400', 03:28:09 INFO - 'USER': 'cltbld', 03:28:09 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317', 03:28:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:28:09 INFO - '_': '/tools/buildbot/bin/python'} 03:28:09 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/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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:28:09 INFO - mozversion application_buildid: 20170816091812 03:28:09 INFO - mozversion application_changeset: c498777e8f39a3027e44d7badad05bd3a3f86f08 03:28:09 INFO - mozversion application_display_name: Nightly 03:28:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:28:09 INFO - mozversion application_name: Firefox 03:28:09 INFO - mozversion application_remotingname: firefox 03:28:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:28:09 INFO - mozversion application_vendor: Mozilla 03:28:09 INFO - mozversion application_version: 57.0a1 03:28:09 INFO - mozversion platform_buildid: 20170816091812 03:28:09 INFO - mozversion platform_changeset: c498777e8f39a3027e44d7badad05bd3a3f86f08 03:28:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:28:09 INFO - mozversion platform_version: 57.0a1 03:28:09 INFO - using testdate: 1502879289 03:28:09 INFO - actual date: 1502879289 03:28:09 INFO - starting webserver on 'localhost:45174' 03:28:09 INFO - SUITE-START | Running 2 tests 03:28:09 INFO - TEST-START | dromaeo_css 03:28:09 INFO - Initialising browser for dromaeo_css test... 03:28:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45174/getInfo.html -profile /tmp/tmpGBEcJh/profile 03:28:09 INFO - TEST-INFO | started process 16749 (/builds/slave/test/build/application/firefox/firefox http://localhost:45174/getInfo.html) 03:28:15 INFO - TEST-INFO | 16749: exit 0 03:28:15 INFO - Browser initialized. 03:28:15 INFO - Running cycle 1/1 for dromaeo_css test... 03:28:15 INFO - TEST-INFO | started process 16959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGBEcJh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:28:16 INFO - PID 16959 | 03:28:16 INFO - PID 16959 | (/builds/slave/test/build/application/firefox/firefox:17008): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:28:16 INFO - PID 16959 | 03:28:26 INFO - PID 16959 | RSS: Main: 157749248 03:28:26 INFO - PID 16959 | 03:31:23 INFO - PID 16959 | Cycle 1(1): loaded http://localhost:45174/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45174/tests/dromaeo/cssquery-ext.html) 03:31:24 INFO - PID 16959 | RSS: Main: 165769216 03:31:24 INFO - PID 16959 | 03:34:26 INFO - PID 16959 | Cycle 1(1): loaded http://localhost:45174/tests/dromaeo/cssquery-ext.html (next: http://localhost:45174/tests/dromaeo/cssquery-jquery.html) 03:34:26 INFO - PID 16959 | RSS: Main: 162562048 03:34:26 INFO - PID 16959 | 03:37:28 INFO - PID 16959 | Cycle 1(1): loaded http://localhost:45174/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45174/tests/dromaeo/cssquery-mootools.html) 03:37:29 INFO - PID 16959 | RSS: Main: 164913152 03:37:29 INFO - PID 16959 | 03:40:30 INFO - PID 16959 | Cycle 1(1): loaded http://localhost:45174/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45174/tests/dromaeo/cssquery-prototype.html) 03:40:31 INFO - PID 16959 | RSS: Main: 163528704 03:40:31 INFO - PID 16959 | 03:43:34 INFO - PID 16959 | Cycle 1(1): loaded http://localhost:45174/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45174/tests/dromaeo/cssquery-yui.html) 03:43:34 INFO - PID 16959 | RSS: Main: 167010304 03:43:34 INFO - PID 16959 | 03:46:36 INFO - PID 16959 | Cycle 1(1): loaded http://localhost:45174/tests/dromaeo/cssquery-yui.html (next: http://localhost:45174/tests/dromaeo/cssquery-dojo.html) 03:46:36 INFO - PID 16959 | RSS: Main: 167694336 03:46:36 INFO - PID 16959 | 03:46:36 INFO - PID 16959 | __start_tp_report 03:46:36 INFO - PID 16959 | _x_x_mozilla_page_load 03:46:36 INFO - PID 16959 | _x_x_mozilla_page_load_details 03:46:36 INFO - PID 16959 | |i|pagename|runs| 03:46:36 INFO - PID 16959 | |0;dojo.html;3467.8266086695658;3509.929801403972;3542.4509201073834;3548.6806187443135;3557.039599308187;6277.497800175986;6296.244450665927;6301.180846489961;6315.242170939488;6335.461485773703;6176.351483094278;6271.905921411182;6273.466755325791;6291.370862913706;6333.08170315304;5513.2005859150495;5514.779408823642;5527.751251193686;5552.805651802188;5634.098544232924;5582.944170558303;5589.0219211637805;5611.8316450506345;5612.326520817508;5671.602987790856;306.69683765638734;5563.332400111992;5642.689652069134;5643.661380317194;5656.91514627281;5341.851501927104;5469.316335458067;5490.945090549083;5607.80372686954;5616.410276920906;5525.281713377235;5538.252335934638;5593.049181639131;5602.187682786014;5603.719814009324;6133.754649814002;6230.5638605297645;6261.311255761862;6294.496440284766;6299.905501417483;6788.524803263774;6844.691988860463;6852.074969879052;6933.237343892168;6944.236134025253;6642.800715978528;6759.864802703967;6937.410320122795;6995.8600827983155;7011.298870112948;6293.622382657055;6327.5254355923025;6338.524610654174;6345.143405640272;6430.742770289229;7032.367086962198;7088.113985751781;7110.7511237106455;7113.57318560888;7163.820904477326;6773.017912402674;6837.589744615339;6852.794416167423;6855.5543889647015;6861.862762744717;6864.759733409307;6893.551919125241;6911.965440172868;6974.860502790018;6998.720051197895;6675.23234828001;6761.628110453874;6773.356531129535;6777.525573209828;6788.389044985975;6766.15423072116;6768.153980752406;6885.449164066863;6890.655467226618;6893.103896493424;4947.208446648519;4950.752462376867;4985.675931064469;4986.551210391082;5000.949990500121;4284.121755040209;4360.934585981213;4385.693001489865;4393.626541743924;4414.227510185705;6317.273513545909;6346.682665866688;6370.649614271167;6374.235091789015;6394.1687580614225;6889.758858439931;6899.344562266677;6950.235474097845;6966.512344135963;6966.965165174243;6232.501399888089;6300.779472718433;6349.809505714836;6355.205599300088;6376.29860715321;5425.728713564306;5493.395726470085;5508.91736623951;5546.140348245947;5578.497935185853;7144.214136444987;7199.964000179965;7234.131904171533;7237.819054523679;7241.493095483265;6733.393994540319;6770.086038384755;6776.4401552084955;6798;6823.215330237086;7067.929320706727;7129.857402851811;7146.964265178849;7166.175889772743;7247.347738703542;6792.252852186157;6793.762218322335;6795.456363491007;6808.761693340709;6824.590524568542;6884.65576721172;6884.862302753817;6942.895856562054;6947.652617369213;6949.65251737401;6611;6628.635425051669;6694.196696396463;6696.263411024881;6701.463882889259;6547.672616369067;6613.470922326299;6636.601803891589;6645.302243264581;6709.228438729413;6644.103046088716;6673;6678.065070890177;6684.097646817618;6686.297938716365;6690.531662783558;6694.129763130762;6702.497312701469;6710.731570737116;6815.079964204769;6485;6493.707783149675;6555.672216389257;6560.3111673273615;6562.34376562359 03:46:36 INFO - PID 16959 | |1;ext.html;914.51530688735;919.8344298026357;940.2431043010376;959.0984474593881;959.817634649417;43598.78200608996;44113.558864411345;44186.55813441861;44215.778921105346;44400.77799611002;39691.60308396915;39932.800335998276;40009.399859002064;40044.199116017735;40160.39759403604;6974.546654467469;7025.26234745352;7086.503944723871;7104;7107.8933815992805;6975.302469753009;7031.824204394906;7037.22590515043;7039;7039.084918960553;7757.5733334666575;7974.60126993648;7988.121306656263;7991.160928102553;7992.3606111510935;7875.0549934007995;7937.603119843985;7937.960310198469;7938.6824527019135;7942.364610831149;7643.808904777369;7676.9616151919445;7814.0623125224765;7846.254605812439;7846.293833554951;42251;42591.14817703659;42607.78696106531;42654.78672606648;42713.786431067645;3336.099253201646;3350.1289664687115;3378.679025492574;3379.172102834821;3381.1040074380307;32769.50845737316;32945.34109317824;33172.17069573256;33199.33601327984;33214.833925830215;5280.18157185633;5295.761690723926;5324.627276090675;5347.25138480613;5360.678359298455;200871.99999999854;203502;203837;206536;209692.95153524287;53957.46042539524;54094.45905540973;54157.45842541603;54182;54185.45814541883;56468;56492;56550;56550.71724641351;56600.43399566034;15562.299696513684;15654.217289135499;15681.294341754648;15696.450624228097;15699.372025119095;12553.748925021448;12578.81131783024;12580.685482863002;12582.622521324374;12627.305498197687;15430.228488575527;15493.535193944199;15503.302351394213;15566.066036037873;15594.532164035098;5976.432238937294;6026.397360263939;6044.406251249083;6092.847678807977;6150.7847225346895;1091.650671785037;1095.5836782022939;1096.8135416979133;1102.4763237462141;1107.291333546531;24962;25114.497710046064;25267.62098568523;25294.241172764847;25303.62044569333;1180.7461395799944;1188.6493484422117;1191.4936152135308;1195.1753290229713;1204.566356111799;13164.60506184816;13214.537491187762;13231.933840330737;13256.138351007154;13270.469181232642;264647;266302;266401;266494;266776;57747.71126144342;58114;58120.128198077065;58208;58215.12677309844;1456.5630310906897;1459.212025506236;1469.4930249064055;1494.237938651274;1511.5389806109242;24756.361465562703;24805.751942481067;30477.695223047485;30703.2324191897;30975;55947;55995.440045599025;56033.15950260831;56094;56138;227584;227739;228010;228195;228695;36698.26603467969;38698.41952370773;38971.41542876802;39134.412983804694;39204;49359;49895.50104499054;50279.245811313594;50285;50673;36377.27245455129;36795.44806827953;36967.26065478729;37132.62867371292;37166.814165929;36896.26207475782;37154.442683360314;37159.81420092882;37229.81385093057;37431.43852842264;42540.36189457099;42965.57034429616;43196.136077278905;43287.35068973905;43324.56675433205;36046;36103.63896361003;36128.27743445169;36258.274834502634;36686.26627467489;26525.734742653098;26597.202083937515;26659.86670066715;26858.194254172406;26921 03:46:36 INFO - PID 16959 | |2;jquery.html;582.504870859769;585.2771826793906;587.6444750925692;593.2673148661403;600.3846057790764;23137.537249255005;23852.642210366837;24029.75970240297;24051;24143.275701728977;26326.6051009235;28825.56761648577;28904.710952890466;28920.566191507143;28942.710572894266;6340.714667839947;6482.773102941398;6491.058796474508;6491.318411566788;6493.123428337185;6121.877562448748;6315.526335524831;6317.210348706411;6379.298277189506;6432;6285.842853928642;6290.622562646233;6292.056191571255;6293.590916590407;6301.464375528086;6269.937300626981;6272.623642581414;6284.685765711742;6291.874162516747;6304.527160462961;5822.097574875858;5839.824805255849;5842.444967728102;5853.209816674779;5859.267591551056;30275;30680;31140.688593114006;31147.221319466968;31230;2223.5108276179376;2247.797698207169;2250.8424410291286;2255.007796569504;2255.819534437241;20525.17899284027;20825.37523874286;21165.5766884663;21735.13059477619;21740.56518869614;2471.9629205561932;2487.81341399394;2518.6347979543048;2535.6323333116593;2545.6945166579944;161921;165077;165308;165628.9999999988;165840.17079914644;15886.443974460839;15985.920070399574;16225.107619080827;16306.755398668793;16454.42409515685;24633.507329853303;24644.260672179862;24800.131995380074;24800.25599232026;24822;9920.454375009444;9933.920484649781;10005.849912251322;10212.336198147097;10265.846012309821;8175.223353781381;9303.627854885865;9335.626574936927;9366.859497107549;9448.622055117856;8885.911140888638;9851.802963940681;10034.498275086216;10091.293609447415;10101.646442374482;2817.6618805743033;2828.2363761784204;2858.7855910806775;2898.507253766865;2963.4517614241436;1040.8959104089681;1053.257453495284;1056.6724315462232;1058.751193469534;1075.0485820049312;20821.37535873926;21901.890490547445;25628.743712562635;26150;27659.58510622342;1129.4070612928278;1132.1508868348737;1138.0952143046297;1138.5218208352346;1148.936808475542;12038.277703337653;13978.790318145237;15002.774958375632;15012;15130.773038404433;563750;574014;582110;583538;585623;137836;140837;141356;141652;144058;1336.2984433172662;1337.7859542473352;1340.215973655403;1357.8438479574975;1364.7065880835469;22571.43571410728;22878.656820148044;22904.656430153893;23068.192613258456;23237.767622324238;67149.3285067143;69997.30002699907;70412.29587704057;70608.29391706017;72118.27881721326;82839.17160828314;82923.25484018921;83544.58227708822;83657;84959.5752021236;12424.452987137434;14930.328135234158;15196.924015379853;23810.166644168065;24107.758922411253;25833;25922.22233333003;26204.86897565576;26701.19896403111;26742.866285668446;20234.291799786937;20579;20985.58028839384;21150.259740908994;21166.576668466238;16817.915910420368;17826.821731782515;18645.160967756754;18997.905010475413;19263.22947082101;20600.27899023527;21097.578048438638;21312.680309795054;21313.360599182048;21520.246791362228;22567.66148507741;22613.982370793026;22710.75090870018;22749.09003639836;22767.861606919258;19910.800891991476;19915.302964396178;19962;20016.99915004273;20774.792252077285 03:46:36 INFO - PID 16959 | |3;mootools.html;1450.4053338131364;1496.9775453368209;1498.2883130513007;1505.5709122899975;1509.486774496671;15763.133027683472;16385.754213686803;16421.753673694904;16426.835731642695;16432.589185270343;15851.841481585181;15974.201289935485;15981.600459988505;15995.360185592592;16051.83948160518;2724.577690457977;2764.087851009162;2764.5853122031654;2765.5575107982727;2771.9168424947284;2656.2296933889147;2749.6837863645637;2751.545994910837;2751.793615478837;2753.160286112735;2677.3842016336253;2760.986195069022;2763.019128209487;2764.1707487753692;2770.0858716623466;2702.864796785345;2720.8911643534234;2721.632579601748;2755.1596762987283;2760.544510155822;2740.287525243431;2741.876615552305;2743.931401714953;2757.076379412899;2757.310672331917;15689;15779.92110039454;15791.131487768169;15931.601709957227;16046.518604441886;8067.7176298829845;8285.50286982783;8364.707235246737;8368.037675667254;8370.581470926429;5155.432902380735;5323.840284791424;5331.986922484754;5424.91862622057;5500.092484740013;1920.7791104023077;1930.7007413850877;1932.9903350483298;1957.667196576571;1967.2131147540954;28943.276418089506;28994.13017609496;29113.56329655057;29136.125916222547;29200;6958.234594194634;6962.617056061864;6964.233934267227;7106.395956343666;7125.18060423058;19316.227350905807;19637;19639.33065689404;19871.60256794885;19951.600967980557;8281.710140145065;8477.660893564189;8479.364047696448;8485.193906578865;8486.957565212135;7679.923200767921;7739.226077392328;7808.5314881107315;7811.687532498637;7817.530948143016;5460.726963651801;5667.744951477193;5669.780997085564;5694.800681976111;5705.1727499512335;1601.359456217499;1633.5834362237554;1639.5655151384892;1656.8094669113207;1658.3035125247425;947.9857802132974;954.6181527388961;957.8467445208734;958.1951161024773;960.851068084448;8249;8364.456310339809;8389.832203355898;8431.747047588582;8434.114417986146;673.4309508465338;674.784069097884;681.6796105830252;695.1658010387454;709.4466316273212;5092.592592592584;5094.566961808214;5106.7191304477865;5116.488351164928;5895.823125306248;23930.52138957246;24331.148409805926;24369.51260974806;24527.38681532976;24538.386540336633;23191.188308409124;23736.762632373455;23780.643290350657;24324.635130473056;24334.39164020878;12589.181703189264;12801.551945682042;12842.293673848028;12854;12879.227246365248;9160;9530.85703714431;9718.805623887341;9919;9999.050090241415;20024.299149530278;20541.589168216255;20741.27405540799;21248.681269780656;21490.355289341343;21368.893155534122;21486.892565537073;21574;21581.892090540074;21828.345149645535;13164.47342106305;13205.669858253235;13498.527551536043;13612.93193534026;13629.182249065088;15075.849241507445;15172.317245723749;15186.088834669956;15214.771778423112;15242.771358429854;12045.457954391899;12047.51809927593;12071.215371000857;12194.146409751233;12212.450439730412;12049;12183.451744671334;12212.32832194238;12226.510939562319;12476.438560264629;10756.247062705535;10895.891041089804;10905.727356815825;10914.50884710174;10927.508262128064;8364.958175209085;8452.1547845215;8454.112318206746;8529.530875801642;8537.957310213409;8317.126701696236;8444.197801208875;8517.787055323666;8528.616212270586;8578.742637720878 03:46:36 INFO - PID 16959 | |4;prototype.html;523.5628200589383;535.1811728056074;542.6988021647986;546.3034630845672;553.5322652358758;6073.210482637256;6123.571350005502;6213.875722485547;6242.219722534684;6246.125542424053;6086.421789929961;6109.847253818657;6128.142060111588;6129.509639228862;6174.783882564111;4914.213725803863;4933.582544553161;4940.7035577865445;4944.579710724574;4965.478624744404;4638.46657634373;4730.5269473052595;4879.316895634614;4893.559579637832;4923.926141107886;4756.07256584966;4783.832565860195;4811.591014763731;4824.4210694716685;4833.468318484964;4647.1402790483535;4773.665843390947;4809.470958194595;4815.253635686474;4855.562999330077;4301.913961720779;4305.74165550068;4321.286987647034;4339.483099802139;4341.1100724351745;5888.793892213795;5965.731542080617;5992.580519363646;6021.36775638556;6086.60437071589;5736.971315143398;5752.769889204426;5768.029464825619;5793.073108302693;5814.534837213055;6551;6566.441852442548;6598.538102332838;6632.966835165793;6644.269130395653;4871.14754917888;4887.926681099786;4902.950970490285;4925.38432695913;4970.900581988376;6631.336866313378;6718.529702920798;6734.191896972346;6863.897041544381;6892.827679308008;5105.489451054865;5109.897802043938;5113.488651134857;5135.12702840518;5147.510986456281;5182.274481572507;5184.533391994739;5213.165893457104;5215.53060224574;5220.138677118309;5775.451332123442;5778.191053252548;5784.681842498619;5793.623414478046;5803.216565763652;6612.702428390734;6621.966890165519;6643.767468138689;6663;6671.566348187353;1738.7131123364757;1790.883592566479;1795.4075155199014;1809.276289484217;1818.8908665480114;1205.5599706107207;1240.8708075651114;1253.9686507837378;1262.8295180150562;1277.9680507987375;6144.969275153685;6152.815415537541;6178.62928224308;6178.7219575119225;6230.6884655767935;6641.966790166115;6682.899756503656;6713.798586042427;6725.764598239038;6738.865222695518;6080.148779170831;6106.419890110433;6112.419320164578;6136.325004249529;6145.770845830852;3540.6990405815795;3562.9109272267883;3596.8021758803516;3597.8380972856285;3606.495090687306;6965.721371145199;6976.476764242702;7093.645317734093;7126.643667816588;7135.468977199515;6433.169405461582;6823.590584564942;6864.5881247125335;6877.277885822016;6916.654167291716;6948.722051117898;6973.267806880204;7018.859622807515;7036.401905837959;7045.753398631024;6640.468762499085;6733.764318249034;6759.188897332155;6785.321467853175;6793.762218322335;6610.611771528033;6638.701258443478;6677.799666010027;6704.765333213314;6730.8653826924165;7040.260772618802;7123.536970096927;7127.75052873147;7133.964330178316;7142.785716428515;5118.082692865031;5158.8968220636125;5168.9483105168465;5183.274341592105;5191.974040129926;6542.378474044958;6654.234763002123;6718.462522998246;6824.385805277549;6853.697797418475;6533.771318003847;6540.574862633914;6544.770933017321;6579.190722551337;6583.407493325623;6562.606243625398;6579;6587.835304117244;6592.538522303393;6596.7031483584315;6565.835854103686;6566.6388348641285;6601.53789234749;6610.8016759497295;6612.4710023198995;6566.080748695282;6642.302558231316;6644.368784965421;6650.20197576294;6660.6336651484635;6426.325235850169;6429.292777794532;6442.130312407765;6454.612723236621;6463.289038205888 03:46:36 INFO - PID 16959 | |5;yui.html;937.9062093790618;942.1191186240865;961.778790878098;963.0610155098777;963.5471328475614;18841.811581884176;19358.709619355704;20421.28525501608;20905.581888362263;21075.15699372027;20229.898850505728;21843.344699658996;21988.89005554974;22002.88998555009;22059.448513787163;1007.1539906478575;1027.0705011964146;1029.9948500257487;1031.097789434245;1032.8915463876297;1048.8007278617076;1077.6551503518876;1086.16365398643;1087.1085709718034;1089.6730980705797;1150.12590431272;1158.5192145259707;1160.025578514048;1160.0777381981302;1160.2342453980375;1148.1561052626314;1149.2415006095978;1151.9424028798526;1152.6714886257375;1155.682187398468;837.3970741066483;841.1798496465958;844.1895780051158;844.907060223375;845.3533047218882;19642.312519061765;19796;19961.800381996283;20802;21124.577508449744;22337.888310558505;22457.775422245733;22505.21231756897;22629.77370226293;23141.305760827203;16529.33882644693;16600.750988735177;16643.33426662932;16931.746023809654;17107.657846842994;3804.5054142961517;3820.1213720844084;3820.465134881119;3823.445600387928;3830.3296923038356;135656.999999999;136429;137283;137725;138035;16903.323867045427;17092.658146837242;17326.56683582895;17331.30674772995;17334.219960101826;27277.590836137475;28590;31803.522947155812;33735;33949.490757638654;9253.49105799174;9635.662751803653;9638.95180524107;9641.180499657466;9648.469334186688;4629.398178236807;4655.95344046562;4729.6452766042685;4737.502562230985;4811.5805837278085;5558.694271815089;5683.914741278884;5693.430656934273;5695.373508914016;5704.857378565569;1042.301657889201;1059.3432072115338;1063.4470075560664;1151.1078913841839;1185.2118341302937;703.0614130136325;720.8630360231539;726.5931078596003;729.5367441674575;737.181728281607;12941.352932353533;13297.800532992012;14614.707705846036;14694.55916322512;15566.725960866;707.5789905006513;710.8720430322488;716.691822516323;729.744589393708;736.4255880413286;6256.593321434092;6604.3725846044545;6640.236372817188;6650.86698266032;6656.034874943106;133458;136089;137424;142678;144602;117565;119205.40397298131;122486;124167.9999999982;129548;104380;104422;105397;107466;108959.45520272347;13098.942748852905;13561.864381356454;13711.862881371058;14194.858051419353;14579.906507011805;49614.75963100807;50549.74725126351;50651.746741266055;52705.73647131893;53030.73484632552;85695;87654.12345876715;87676;87767.56116219633;88948.5552572233;21077.789222108197;21270.149194032685;21517;21584.568308634054;21868.671969920782;24201.757982420655;24702.382440438414;24908.252752417455;24955.251342459756;25460.2361929135;20780.064897079366;20837.37487875366;20937.685934710687;20967.895160524098;21541.784582154603;19364.903175484033;21578.460538486663;21899.78100219041;21987.34037978863;22090;21304.573908521434;21343.67984480203;21448.24931127403;21507.247246346302;21770.238041669098;14896.255187240811;14929.328180232133;15548.222588870285;15626.921865391056;15949.920250398674;14422.350994205077;14739.92630036843;14838.332275047866;16444;16572.254248558602 03:46:36 INFO - PID 16959 | __end_tp_report 03:46:36 INFO - PID 16959 | __start_cc_report 03:46:36 INFO - PID 16959 | _x_x_mozilla_cycle_collect,332 03:46:36 INFO - PID 16959 | __end_cc_report 03:46:36 INFO - PID 16959 | __startTimestamp1502880396678__endTimestamp 03:46:36 INFO - PID 16959 | 03:46:36 INFO - PID 16959 | ------- Summary: start ------- 03:46:36 INFO - PID 16959 | Number of tests: 6 03:46:36 INFO - PID 16959 | 03:46:36 INFO - PID 16959 | [#0] dojo.html Cycles:165 Average:6250.32 Median:6613.47 stddev:948.24 (14.3%) stddev-sans-first:925.68 03:46:36 INFO - PID 16959 | Values: 3467.8 3509.9 3542.5 3548.7 3557.0 6277.5 6296.2 6301.2 6315.2 6335.5 6176.4 6271.9 6273.5 6291.4 6333.1 5513.2 5514.8 5527.8 5552.8 5634.1 5582.9 5589.0 5611.8 5612.3 5671.6 306.7 5563.3 5642.7 5643.7 5656.9 5341.9 5469.3 5490.9 5607.8 5616.4 5525.3 5538.3 5593.0 5602.2 5603.7 6133.8 6230.6 6261.3 6294.5 6299.9 6788.5 6844.7 6852.1 6933.2 6944.2 6642.8 6759.9 6937.4 6995.9 7011.3 6293.6 6327.5 6338.5 6345.1 6430.7 7032.4 7088.1 7110.8 7113.6 7163.8 6773.0 6837.6 6852.8 6855.6 6861.9 6864.8 6893.6 6912.0 6974.9 6998.7 6675.2 6761.6 6773.4 6777.5 6788.4 6766.2 6768.2 6885.4 6890.7 6893.1 4947.2 4950.8 4985.7 4986.6 5000.9 4284.1 4360.9 4385.7 4393.6 4414.2 6317.3 6346.7 6370.6 6374.2 6394.2 6889.8 6899.3 6950.2 6966.5 6967.0 6232.5 6300.8 6349.8 6355.2 6376.3 5425.7 5493.4 5508.9 5546.1 5578.5 7144.2 7200.0 7234.1 7237.8 7241.5 6733.4 6770.1 6776.4 6798.0 6823.2 7067.9 7129.9 7147.0 7166.2 7247.3 6792.3 6793.8 6795.5 6808.8 6824.6 6884.7 6884.9 6942.9 6947.7 6949.7 6611.0 6628.6 6694.2 6696.3 6701.5 6547.7 6613.5 6636.6 6645.3 6709.2 6644.1 6673.0 6678.1 6684.1 6686.3 6690.5 6694.1 6702.5 6710.7 6815.1 6485.0 6493.7 6555.7 6560.3 6562.3 03:46:36 INFO - PID 16959 | 03:46:36 INFO - PID 16959 | [#1] ext.html Cycles:180 Average:42220.36 Median:38064.93 stddev:60947.54 (160.1%) stddev-sans-first:61039.59 03:46:36 INFO - PID 16959 | Values: 914.5 919.8 940.2 959.1 959.8 43598.8 44113.6 44186.6 44215.8 44400.8 39691.6 39932.8 40009.4 40044.2 40160.4 6974.5 7025.3 7086.5 7104.0 7107.9 6975.3 7031.8 7037.2 7039.0 7039.1 7757.6 7974.6 7988.1 7991.2 7992.4 7875.1 7937.6 7938.0 7938.7 7942.4 7643.8 7677.0 7814.1 7846.3 7846.3 42251.0 42591.1 42607.8 42654.8 42713.8 3336.1 3350.1 3378.7 3379.2 3381.1 32769.5 32945.3 33172.2 33199.3 33214.8 5280.2 5295.8 5324.6 5347.3 5360.7 200872.0 203502.0 203837.0 206536.0 209693.0 53957.5 54094.5 54157.5 54182.0 54185.5 56468.0 56492.0 56550.0 56550.7 56600.4 15562.3 15654.2 15681.3 15696.5 15699.4 12553.7 12578.8 12580.7 12582.6 12627.3 15430.2 15493.5 15503.3 15566.1 15594.5 5976.4 6026.4 6044.4 6092.8 6150.8 1091.7 1095.6 1096.8 1102.5 1107.3 24962.0 25114.5 25267.6 25294.2 25303.6 1180.7 1188.6 1191.5 1195.2 1204.6 13164.6 13214.5 13231.9 13256.1 13270.5 264647.0 266302.0 266401.0 266494.0 266776.0 57747.7 58114.0 58120.1 58208.0 58215.1 1456.6 1459.2 1469.5 1494.2 1511.5 24756.4 24805.8 30477.7 30703.2 30975.0 55947.0 55995.4 56033.2 56094.0 56138.0 227584.0 227739.0 228010.0 228195.0 228695.0 36698.3 38698.4 38971.4 39134.4 39204.0 49359.0 49895.5 50279.2 50285.0 50673.0 36377.3 36795.4 36967.3 37132.6 37166.8 36896.3 37154.4 37159.8 37229.8 37431.4 42540.4 42965.6 43196.1 43287.4 43324.6 36046.0 36103.6 36128.3 36258.3 36686.3 26525.7 26597.2 26659.9 26858.2 26921.0 03:46:36 INFO - PID 16959 | 03:46:36 INFO - PID 16959 | [#2] jquery.html Cycles:180 Average:40655.53 Median:24079.38 stddev:97748.28 (405.9%) stddev-sans-first:97976.19 03:46:36 INFO - PID 16959 | Values: 582.5 585.3 587.6 593.3 600.4 23137.5 23852.6 24029.8 24051.0 24143.3 26326.6 28825.6 28904.7 28920.6 28942.7 6340.7 6482.8 6491.1 6491.3 6493.1 6121.9 6315.5 6317.2 6379.3 6432.0 6285.8 6290.6 6292.1 6293.6 6301.5 6269.9 6272.6 6284.7 6291.9 6304.5 5822.1 5839.8 5842.4 5853.2 5859.3 30275.0 30680.0 31140.7 31147.2 31230.0 2223.5 2247.8 2250.8 2255.0 2255.8 20525.2 20825.4 21165.6 21735.1 21740.6 2472.0 2487.8 2518.6 2535.6 2545.7 161921.0 165077.0 165308.0 165629.0 165840.2 15886.4 15985.9 16225.1 16306.8 16454.4 24633.5 24644.3 24800.1 24800.3 24822.0 9920.5 9933.9 10005.8 10212.3 10265.8 8175.2 9303.6 9335.6 9366.9 9448.6 8885.9 9851.8 10034.5 10091.3 10101.6 2817.7 2828.2 2858.8 2898.5 2963.5 1040.9 1053.3 1056.7 1058.8 1075.0 20821.4 21901.9 25628.7 26150.0 27659.6 1129.4 1132.2 1138.1 1138.5 1148.9 12038.3 13978.8 15002.8 15012.0 15130.8 563750.0 574014.0 582110.0 583538.0 585623.0 137836.0 140837.0 141356.0 141652.0 144058.0 1336.3 1337.8 1340.2 1357.8 1364.7 22571.4 22878.7 22904.7 23068.2 23237.8 67149.3 69997.3 70412.3 70608.3 72118.3 82839.2 82923.3 83544.6 83657.0 84959.6 12424.5 14930.3 15196.9 23810.2 24107.8 25833.0 25922.2 26204.9 26701.2 26742.9 20234.3 20579.0 20985.6 21150.3 21166.6 16817.9 17826.8 18645.2 18997.9 19263.2 20600.3 21097.6 21312.7 21313.4 21520.2 22567.7 22614.0 22710.8 22749.1 22767.9 19910.8 19915.3 19962.0 20017.0 20774.8 03:46:36 INFO - PID 16959 | 03:46:36 INFO - PID 16959 | [#3] mootools.html Cycles:180 Average:10201.84 Median:2732.43 stddev:7475.62 (273.6%) stddev-sans-first:7467.67 03:46:36 INFO - PID 16959 | Values: 1450.4 1497.0 1498.3 1505.6 1509.5 15763.1 16385.8 16421.8 16426.8 16432.6 15851.8 15974.2 15981.6 15995.4 16051.8 2724.6 2764.1 2764.6 2765.6 2771.9 2656.2 2749.7 2751.5 2751.8 2753.2 2677.4 2761.0 2763.0 2764.2 2770.1 2702.9 2720.9 2721.6 2755.2 2760.5 2740.3 2741.9 2743.9 2757.1 2757.3 15689.0 15779.9 15791.1 15931.6 16046.5 8067.7 8285.5 8364.7 8368.0 8370.6 5155.4 5323.8 5332.0 5424.9 5500.1 1920.8 1930.7 1933.0 1957.7 1967.2 28943.3 28994.1 29113.6 29136.1 29200.0 6958.2 6962.6 6964.2 7106.4 7125.2 19316.2 19637.0 19639.3 19871.6 19951.6 8281.7 8477.7 8479.4 8485.2 8487.0 7679.9 7739.2 7808.5 7811.7 7817.5 5460.7 5667.7 5669.8 5694.8 5705.2 1601.4 1633.6 1639.6 1656.8 1658.3 948.0 954.6 957.8 958.2 960.9 8249.0 8364.5 8389.8 8431.7 8434.1 673.4 674.8 681.7 695.2 709.4 5092.6 5094.6 5106.7 5116.5 5895.8 23930.5 24331.1 24369.5 24527.4 24538.4 23191.2 23736.8 23780.6 24324.6 24334.4 12589.2 12801.6 12842.3 12854.0 12879.2 9160.0 9530.9 9718.8 9919.0 9999.1 20024.3 20541.6 20741.3 21248.7 21490.4 21368.9 21486.9 21574.0 21581.9 21828.3 13164.5 13205.7 13498.5 13612.9 13629.2 15075.8 15172.3 15186.1 15214.8 15242.8 12045.5 12047.5 12071.2 12194.1 12212.5 12049.0 12183.5 12212.3 12226.5 12476.4 10756.2 10895.9 10905.7 10914.5 10927.5 8365.0 8452.2 8454.1 8529.5 8538.0 8317.1 8444.2 8517.8 8528.6 8578.7 03:46:36 INFO - PID 16959 | 03:46:36 INFO - PID 16959 | [#4] prototype.html Cycles:180 Average:5582.79 Median:6145.37 stddev:1589.99 (25.9%) stddev-sans-first:1548.44 03:46:36 INFO - PID 16959 | Values: 523.6 535.2 542.7 546.3 553.5 6073.2 6123.6 6213.9 6242.2 6246.1 6086.4 6109.8 6128.1 6129.5 6174.8 4914.2 4933.6 4940.7 4944.6 4965.5 4638.5 4730.5 4879.3 4893.6 4923.9 4756.1 4783.8 4811.6 4824.4 4833.5 4647.1 4773.7 4809.5 4815.3 4855.6 4301.9 4305.7 4321.3 4339.5 4341.1 5888.8 5965.7 5992.6 6021.4 6086.6 5737.0 5752.8 5768.0 5793.1 5814.5 6551.0 6566.4 6598.5 6633.0 6644.3 4871.1 4887.9 4903.0 4925.4 4970.9 6631.3 6718.5 6734.2 6863.9 6892.8 5105.5 5109.9 5113.5 5135.1 5147.5 5182.3 5184.5 5213.2 5215.5 5220.1 5775.5 5778.2 5784.7 5793.6 5803.2 6612.7 6622.0 6643.8 6663.0 6671.6 1738.7 1790.9 1795.4 1809.3 1818.9 1205.6 1240.9 1254.0 1262.8 1278.0 6145.0 6152.8 6178.6 6178.7 6230.7 6642.0 6682.9 6713.8 6725.8 6738.9 6080.1 6106.4 6112.4 6136.3 6145.8 3540.7 3562.9 3596.8 3597.8 3606.5 6965.7 6976.5 7093.6 7126.6 7135.5 6433.2 6823.6 6864.6 6877.3 6916.7 6948.7 6973.3 7018.9 7036.4 7045.8 6640.5 6733.8 6759.2 6785.3 6793.8 6610.6 6638.7 6677.8 6704.8 6730.9 7040.3 7123.5 7127.8 7134.0 7142.8 5118.1 5158.9 5168.9 5183.3 5192.0 6542.4 6654.2 6718.5 6824.4 6853.7 6533.8 6540.6 6544.8 6579.2 6583.4 6562.6 6579.0 6587.8 6592.5 6596.7 6565.8 6566.6 6601.5 6610.8 6612.5 6566.1 6642.3 6644.4 6650.2 6660.6 6426.3 6429.3 6442.1 6454.6 6463.3 03:46:36 INFO - PID 16959 | 03:46:36 INFO - PID 16959 | [#5] yui.html Cycles:180 Average:27811.55 Median:21101.18 stddev:38732.87 (183.6%) stddev-sans-first:38788.96 03:46:36 INFO - PID 16959 | Values: 937.9 942.1 961.8 963.1 963.5 18841.8 19358.7 20421.3 20905.6 21075.2 20229.9 21843.3 21988.9 22002.9 22059.4 1007.2 1027.1 1030.0 1031.1 1032.9 1048.8 1077.7 1086.2 1087.1 1089.7 1150.1 1158.5 1160.0 1160.1 1160.2 1148.2 1149.2 1151.9 1152.7 1155.7 837.4 841.2 844.2 844.9 845.4 19642.3 19796.0 19961.8 20802.0 21124.6 22337.9 22457.8 22505.2 22629.8 23141.3 16529.3 16600.8 16643.3 16931.7 17107.7 3804.5 3820.1 3820.5 3823.4 3830.3 135657.0 136429.0 137283.0 137725.0 138035.0 16903.3 17092.7 17326.6 17331.3 17334.2 27277.6 28590.0 31803.5 33735.0 33949.5 9253.5 9635.7 9639.0 9641.2 9648.5 4629.4 4656.0 4729.6 4737.5 4811.6 5558.7 5683.9 5693.4 5695.4 5704.9 1042.3 1059.3 1063.4 1151.1 1185.2 703.1 720.9 726.6 729.5 737.2 12941.4 13297.8 14614.7 14694.6 15566.7 707.6 710.9 716.7 729.7 736.4 6256.6 6604.4 6640.2 6650.9 6656.0 133458.0 136089.0 137424.0 142678.0 144602.0 117565.0 119205.4 122486.0 124168.0 129548.0 104380.0 104422.0 105397.0 107466.0 108959.5 13098.9 13561.9 13711.9 14194.9 14579.9 49614.8 50549.7 50651.7 52705.7 53030.7 85695.0 87654.1 87676.0 87767.6 88948.6 21077.8 21270.1 21517.0 21584.6 21868.7 24201.8 24702.4 24908.3 24955.3 25460.2 20780.1 20837.4 20937.7 20967.9 21541.8 19364.9 21578.5 21899.8 21987.3 22090.0 21304.6 21343.7 21448.2 21507.2 21770.2 14896.3 14929.3 15548.2 15626.9 15949.9 14422.4 14739.9 14838.3 16444.0 16572.3 03:46:36 INFO - PID 16959 | -------- Summary: end -------- 03:46:36 INFO - PID 16959 | 03:46:37 INFO - TEST-INFO | 16959: exit 0 03:46:37 INFO - TEST-OK | dromaeo_css | took 1107639ms 03:46:37 INFO - TEST-START | kraken 03:46:37 INFO - Initialising browser for kraken test... 03:46:37 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45174/getInfo.html -profile /tmp/tmpBsYqYK/profile 03:46:37 INFO - TEST-INFO | started process 17324 (/builds/slave/test/build/application/firefox/firefox http://localhost:45174/getInfo.html) 03:46:42 INFO - TEST-INFO | 17324: exit 0 03:46:42 INFO - Browser initialized. 03:46:42 INFO - Running cycle 1/1 for kraken test... 03:46:42 INFO - TEST-INFO | started process 17533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBsYqYK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:46:43 INFO - PID 17533 | 03:46:43 INFO - PID 17533 | (/builds/slave/test/build/application/firefox/firefox:17582): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:46:43 INFO - PID 17533 | 03:46:53 INFO - PID 17533 | RSS: Main: 162021376 03:46:53 INFO - PID 17533 | 03:46:56 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45174/tests/kraken/driver.html?testName=audio-beat-detection) 03:46:57 INFO - PID 17533 | RSS: Main: 168247296 03:46:57 INFO - PID 17533 | 03:46:59 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45174/tests/kraken/driver.html?testName=audio-dft) 03:47:00 INFO - PID 17533 | RSS: Main: 171909120 03:47:00 INFO - PID 17533 | 03:47:03 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45174/tests/kraken/driver.html?testName=audio-fft) 03:47:04 INFO - PID 17533 | RSS: Main: 165617664 03:47:04 INFO - PID 17533 | 03:47:06 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45174/tests/kraken/driver.html?testName=audio-oscillator) 03:47:06 INFO - PID 17533 | RSS: Main: 166608896 03:47:06 INFO - PID 17533 | 03:47:08 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45174/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:47:09 INFO - PID 17533 | RSS: Main: 166346752 03:47:09 INFO - PID 17533 | 03:47:12 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45174/tests/kraken/driver.html?testName=imaging-darkroom) 03:47:13 INFO - PID 17533 | RSS: Main: 166658048 03:47:13 INFO - PID 17533 | 03:47:16 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45174/tests/kraken/driver.html?testName=imaging-desaturate) 03:47:17 INFO - PID 17533 | RSS: Main: 169889792 03:47:17 INFO - PID 17533 | 03:47:19 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45174/tests/kraken/driver.html?testName=json-parse-financial) 03:47:20 INFO - PID 17533 | RSS: Main: 167993344 03:47:20 INFO - PID 17533 | 03:47:21 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45174/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:47:22 INFO - PID 17533 | RSS: Main: 168202240 03:47:22 INFO - PID 17533 | 03:47:24 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45174/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:47:25 INFO - PID 17533 | RSS: Main: 168079360 03:47:25 INFO - PID 17533 | 03:47:27 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45174/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:47:27 INFO - PID 17533 | RSS: Main: 165318656 03:47:27 INFO - PID 17533 | 03:47:30 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45174/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:47:30 INFO - PID 17533 | RSS: Main: 165052416 03:47:30 INFO - PID 17533 | 03:47:33 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45174/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:47:34 INFO - PID 17533 | RSS: Main: 165429248 03:47:34 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | Cycle 1(1): loaded http://localhost:45174/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45174/tests/kraken/driver.html?testName=ai-astar) 03:47:36 INFO - PID 17533 | RSS: Main: 167075840 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | __start_tp_report 03:47:36 INFO - PID 17533 | _x_x_mozilla_page_load 03:47:36 INFO - PID 17533 | _x_x_mozilla_page_load_details 03:47:36 INFO - PID 17533 | |i|pagename|runs| 03:47:36 INFO - PID 17533 | |0;ai-astar;103;107;93;107;106;109;115;106;109;108 03:47:36 INFO - PID 17533 | |1;audio-beat-detection;139;114;139;175;114;142;135;117;177;117 03:47:36 INFO - PID 17533 | |2;audio-dft;164;164;163;162;162;165;163;160;168;167 03:47:36 INFO - PID 17533 | |3;audio-fft;73;74;74;182;74;75;73;76;152;74 03:47:36 INFO - PID 17533 | |4;audio-oscillator;78;78;129;77;79;78;135;78;77;123 03:47:36 INFO - PID 17533 | |5;imaging-gaussian-blur;117;114;114;114;113;114;114;114;114;113 03:47:36 INFO - PID 17533 | |6;imaging-darkroom;149;147;149;147;149;148;148;149;148;148 03:47:36 INFO - PID 17533 | |7;imaging-desaturate;94;94;93;94;93;94;94;94;99;94 03:47:36 INFO - PID 17533 | |8;json-parse-financial;47;47;47;47;46;50;46;47;46;47 03:47:36 INFO - PID 17533 | |9;json-stringify-tinderbox;53;55;54;53;53;54;54;53;55;54 03:47:36 INFO - PID 17533 | |10;stanford-crypto-aes;74;73;76;75;74;74;72;82;74;73 03:47:36 INFO - PID 17533 | |11;stanford-crypto-ccm;118;122;116;112;115;113;113;115;117;167 03:47:36 INFO - PID 17533 | |12;stanford-crypto-pbkdf2;177;163;167;164;162;168;162;162;160;167 03:47:36 INFO - PID 17533 | |13;stanford-crypto-sha256-iterative;64;64;63;62;65;61;69;63;60;61 03:47:36 INFO - PID 17533 | __end_tp_report 03:47:36 INFO - PID 17533 | __start_cc_report 03:47:36 INFO - PID 17533 | _x_x_mozilla_cycle_collect,837 03:47:36 INFO - PID 17533 | __end_cc_report 03:47:36 INFO - PID 17533 | __startTimestamp1502880456288__endTimestamp 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | ------- Summary: start ------- 03:47:36 INFO - PID 17533 | Number of tests: 14 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#0] ai-astar Cycles:10 Average:106.30 Median:108.50 stddev:5.60 (5.2%) stddev-sans-first:5.81 03:47:36 INFO - PID 17533 | Values: 103.0 107.0 93.0 107.0 106.0 109.0 115.0 106.0 109.0 108.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#1] audio-beat-detection Cycles:10 Average:136.90 Median:139.00 stddev:23.43 (16.9%) stddev-sans-first:24.83 03:47:36 INFO - PID 17533 | Values: 139.0 114.0 139.0 175.0 114.0 142.0 135.0 117.0 177.0 117.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#2] audio-dft Cycles:10 Average:163.80 Median:164.00 stddev:2.39 (1.5%) stddev-sans-first:2.54 03:47:36 INFO - PID 17533 | Values: 164.0 164.0 163.0 162.0 162.0 165.0 163.0 160.0 168.0 167.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#3] audio-fft Cycles:10 Average:92.70 Median:74.00 stddev:39.80 (53.8%) stddev-sans-first:41.57 03:47:36 INFO - PID 17533 | Values: 73.0 74.0 74.0 182.0 74.0 75.0 73.0 76.0 152.0 74.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:78.00 stddev:24.87 (31.9%) stddev-sans-first:25.77 03:47:36 INFO - PID 17533 | Values: 78.0 78.0 129.0 77.0 79.0 78.0 135.0 78.0 77.0 123.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.10 (1.0%) stddev-sans-first:0.44 03:47:36 INFO - PID 17533 | Values: 117.0 114.0 114.0 114.0 113.0 114.0 114.0 114.0 114.0 113.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 03:47:36 INFO - PID 17533 | Values: 149.0 147.0 149.0 147.0 149.0 148.0 148.0 149.0 148.0 148.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:1.70 (1.8%) stddev-sans-first:1.80 03:47:36 INFO - PID 17533 | Values: 94.0 94.0 93.0 94.0 93.0 94.0 94.0 94.0 99.0 94.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#8] json-parse-financial Cycles:10 Average:47.00 Median:47.00 stddev:1.15 (2.5%) stddev-sans-first:1.22 03:47:36 INFO - PID 17533 | Values: 47.0 47.0 47.0 47.0 46.0 50.0 46.0 47.0 46.0 47.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#9] json-stringify-tinderbox Cycles:10 Average:53.80 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.78 03:47:36 INFO - PID 17533 | Values: 53.0 55.0 54.0 53.0 53.0 54.0 54.0 53.0 55.0 54.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.00 stddev:2.79 (3.8%) stddev-sans-first:2.95 03:47:36 INFO - PID 17533 | Values: 74.0 73.0 76.0 75.0 74.0 74.0 72.0 82.0 74.0 73.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:116.50 stddev:16.49 (14.2%) stddev-sans-first:17.46 03:47:36 INFO - PID 17533 | Values: 118.0 122.0 116.0 112.0 115.0 113.0 113.0 115.0 117.0 167.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:165.50 stddev:4.92 (3.0%) stddev-sans-first:2.80 03:47:36 INFO - PID 17533 | Values: 177.0 163.0 167.0 164.0 162.0 168.0 162.0 162.0 160.0 167.0 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:2.57 (4.1%) stddev-sans-first:2.71 03:47:36 INFO - PID 17533 | Values: 64.0 64.0 63.0 62.0 65.0 61.0 69.0 63.0 60.0 61.0 03:47:36 INFO - PID 17533 | -------- Summary: end -------- 03:47:36 INFO - PID 17533 | 03:47:36 INFO - PID 17533 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:47:37 INFO - TEST-INFO | 17533: exit 0 03:47:37 INFO - TEST-OK | kraken | took 59861ms 03:47:37 INFO - SUITE-END | took 1167s 03:47:37 INFO - Completed test suite (00:19:27) 03:47:37 INFO - javascript benchmark 03:47:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9090.841299799884, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3467.8266086695658, 3509.929801403972, 3542.4509201073834, 3548.6806187443135, 3557.039599308187, 6277.497800175986, 6296.244450665927, 6301.180846489961, 6315.242170939488, 6335.461485773703, 6176.351483094278, 6271.905921411182, 6273.466755325791, 6291.370862913706, 6333.08170315304, 5513.2005859150495, 5514.779408823642, 5527.751251193686, 5552.805651802188, 5634.098544232924, 5582.944170558303, 5589.0219211637805, 5611.8316450506345, 5612.326520817508, 5671.602987790856, 306.69683765638734, 5563.332400111992, 5642.689652069134, 5643.661380317194, 5656.91514627281, 5341.851501927104, 5469.316335458067, 5490.945090549083, 5607.80372686954, 5616.410276920906, 5525.281713377235, 5538.252335934638, 5593.049181639131, 5602.187682786014, 5603.719814009324, 6133.754649814002, 6230.5638605297645, 6261.311255761862, 6294.496440284766, 6299.905501417483, 6788.524803263774, 6844.691988860463, 6852.074969879052, 6933.237343892168, 6944.236134025253, 6642.800715978528, 6759.864802703967, 6937.410320122795, 6995.8600827983155, 7011.298870112948, 6293.622382657055, 6327.5254355923025, 6338.524610654174, 6345.143405640272, 6430.742770289229, 7032.367086962198, 7088.113985751781, 7110.7511237106455, 7113.57318560888, 7163.820904477326, 6773.017912402674, 6837.589744615339, 6852.794416167423, 6855.5543889647015, 6861.862762744717, 6864.759733409307, 6893.551919125241, 6911.965440172868, 6974.860502790018, 6998.720051197895, 6675.23234828001, 6761.628110453874, 6773.356531129535, 6777.525573209828, 6788.389044985975, 6766.15423072116, 6768.153980752406, 6885.449164066863, 6890.655467226618, 6893.103896493424, 4947.208446648519, 4950.752462376867, 4985.675931064469, 4986.551210391082, 5000.949990500121, 4284.121755040209, 4360.934585981213, 4385.693001489865, 4393.626541743924, 4414.227510185705, 6317.273513545909, 6346.682665866688, 6370.649614271167, 6374.235091789015, 6394.1687580614225, 6889.758858439931, 6899.344562266677, 6950.235474097845, 6966.512344135963, 6966.965165174243, 6232.501399888089, 6300.779472718433, 6349.809505714836, 6355.205599300088, 6376.29860715321, 5425.728713564306, 5493.395726470085, 5508.91736623951, 5546.140348245947, 5578.497935185853, 7144.214136444987, 7199.964000179965, 7234.131904171533, 7237.819054523679, 7241.493095483265, 6733.393994540319, 6770.086038384755, 6776.4401552084955, 6798.0, 6823.215330237086, 7067.929320706727, 7129.857402851811, 7146.964265178849, 7166.175889772743, 7247.347738703542, 6792.252852186157, 6793.762218322335, 6795.456363491007, 6808.761693340709, 6824.590524568542, 6884.65576721172, 6884.862302753817, 6942.895856562054, 6947.652617369213, 6949.65251737401, 6611.0, 6628.635425051669, 6694.196696396463, 6696.263411024881, 6701.463882889259, 6547.672616369067, 6613.470922326299, 6636.601803891589, 6645.302243264581, 6709.228438729413, 6644.103046088716, 6673.0, 6678.065070890177, 6684.097646817618, 6686.297938716365, 6690.531662783558, 6694.129763130762, 6702.497312701469, 6710.731570737116, 6815.079964204769, 6485.0, 6493.707783149675, 6555.672216389257, 6560.3111673273615, 6562.34376562359], "value": 6178.7631650618, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [914.51530688735, 919.8344298026357, 940.2431043010376, 959.0984474593881, 959.817634649417, 43598.78200608996, 44113.558864411345, 44186.55813441861, 44215.778921105346, 44400.77799611002, 39691.60308396915, 39932.800335998276, 40009.399859002064, 40044.199116017735, 40160.39759403604, 6974.546654467469, 7025.26234745352, 7086.503944723871, 7104.0, 7107.8933815992805, 6975.302469753009, 7031.824204394906, 7037.22590515043, 7039.0, 7039.084918960553, 7757.5733334666575, 7974.60126993648, 7988.121306656263, 7991.160928102553, 7992.3606111510935, 7875.0549934007995, 7937.603119843985, 7937.960310198469, 7938.6824527019135, 7942.364610831149, 7643.808904777369, 7676.9616151919445, 7814.0623125224765, 7846.254605812439, 7846.293833554951, 42251.0, 42591.14817703659, 42607.78696106531, 42654.78672606648, 42713.786431067645, 3336.099253201646, 3350.1289664687115, 3378.679025492574, 3379.172102834821, 3381.1040074380307, 32769.50845737316, 32945.34109317824, 33172.17069573256, 33199.33601327984, 33214.833925830215, 5280.18157185633, 5295.761690723926, 5324.627276090675, 5347.25138480613, 5360.678359298455, 200871.99999999854, 203502.0, 203837.0, 206536.0, 209692.95153524287, 53957.46042539524, 54094.45905540973, 54157.45842541603, 54182.0, 54185.45814541883, 56468.0, 56492.0, 56550.0, 56550.71724641351, 56600.43399566034, 15562.299696513684, 15654.217289135499, 15681.294341754648, 15696.450624228097, 15699.372025119095, 12553.748925021448, 12578.81131783024, 12580.685482863002, 12582.622521324374, 12627.305498197687, 15430.228488575527, 15493.535193944199, 15503.302351394213, 15566.066036037873, 15594.532164035098, 5976.432238937294, 6026.397360263939, 6044.406251249083, 6092.847678807977, 6150.7847225346895, 1091.650671785037, 1095.5836782022939, 1096.8135416979133, 1102.4763237462141, 1107.291333546531, 24962.0, 25114.497710046064, 25267.62098568523, 25294.241172764847, 25303.62044569333, 1180.7461395799944, 1188.6493484422117, 1191.4936152135308, 1195.1753290229713, 1204.566356111799, 13164.60506184816, 13214.537491187762, 13231.933840330737, 13256.138351007154, 13270.469181232642, 264647.0, 266302.0, 266401.0, 266494.0, 266776.0, 57747.71126144342, 58114.0, 58120.128198077065, 58208.0, 58215.12677309844, 1456.5630310906897, 1459.212025506236, 1469.4930249064055, 1494.237938651274, 1511.5389806109242, 24756.361465562703, 24805.751942481067, 30477.695223047485, 30703.2324191897, 30975.0, 55947.0, 55995.440045599025, 56033.15950260831, 56094.0, 56138.0, 227584.0, 227739.0, 228010.0, 228195.0, 228695.0, 36698.26603467969, 38698.41952370773, 38971.41542876802, 39134.412983804694, 39204.0, 49359.0, 49895.50104499054, 50279.245811313594, 50285.0, 50673.0, 36377.27245455129, 36795.44806827953, 36967.26065478729, 37132.62867371292, 37166.814165929, 36896.26207475782, 37154.442683360314, 37159.81420092882, 37229.81385093057, 37431.43852842264, 42540.36189457099, 42965.57034429616, 43196.136077278905, 43287.35068973905, 43324.56675433205, 36046.0, 36103.63896361003, 36128.27743445169, 36258.274834502634, 36686.26627467489, 26525.734742653098, 26597.202083937515, 26659.86670066715, 26858.194254172406, 26921.0], "value": 18563.466301163364, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.504870859769, 585.2771826793906, 587.6444750925692, 593.2673148661403, 600.3846057790764, 23137.537249255005, 23852.642210366837, 24029.75970240297, 24051.0, 24143.275701728977, 26326.6051009235, 28825.56761648577, 28904.710952890466, 28920.566191507143, 28942.710572894266, 6340.714667839947, 6482.773102941398, 6491.058796474508, 6491.318411566788, 6493.123428337185, 6121.877562448748, 6315.526335524831, 6317.210348706411, 6379.298277189506, 6432.0, 6285.842853928642, 6290.622562646233, 6292.056191571255, 6293.590916590407, 6301.464375528086, 6269.937300626981, 6272.623642581414, 6284.685765711742, 6291.874162516747, 6304.527160462961, 5822.097574875858, 5839.824805255849, 5842.444967728102, 5853.209816674779, 5859.267591551056, 30275.0, 30680.0, 31140.688593114006, 31147.221319466968, 31230.0, 2223.5108276179376, 2247.797698207169, 2250.8424410291286, 2255.007796569504, 2255.819534437241, 20525.17899284027, 20825.37523874286, 21165.5766884663, 21735.13059477619, 21740.56518869614, 2471.9629205561932, 2487.81341399394, 2518.6347979543048, 2535.6323333116593, 2545.6945166579944, 161921.0, 165077.0, 165308.0, 165628.9999999988, 165840.17079914644, 15886.443974460839, 15985.920070399574, 16225.107619080827, 16306.755398668793, 16454.42409515685, 24633.507329853303, 24644.260672179862, 24800.131995380074, 24800.25599232026, 24822.0, 9920.454375009444, 9933.920484649781, 10005.849912251322, 10212.336198147097, 10265.846012309821, 8175.223353781381, 9303.627854885865, 9335.626574936927, 9366.859497107549, 9448.622055117856, 8885.911140888638, 9851.802963940681, 10034.498275086216, 10091.293609447415, 10101.646442374482, 2817.6618805743033, 2828.2363761784204, 2858.7855910806775, 2898.507253766865, 2963.4517614241436, 1040.8959104089681, 1053.257453495284, 1056.6724315462232, 1058.751193469534, 1075.0485820049312, 20821.37535873926, 21901.890490547445, 25628.743712562635, 26150.0, 27659.58510622342, 1129.4070612928278, 1132.1508868348737, 1138.0952143046297, 1138.5218208352346, 1148.936808475542, 12038.277703337653, 13978.790318145237, 15002.774958375632, 15012.0, 15130.773038404433, 563750.0, 574014.0, 582110.0, 583538.0, 585623.0, 137836.0, 140837.0, 141356.0, 141652.0, 144058.0, 1336.2984433172662, 1337.7859542473352, 1340.215973655403, 1357.8438479574975, 1364.7065880835469, 22571.43571410728, 22878.656820148044, 22904.656430153893, 23068.192613258456, 23237.767622324238, 67149.3285067143, 69997.30002699907, 70412.29587704057, 70608.29391706017, 72118.27881721326, 82839.17160828314, 82923.25484018921, 83544.58227708822, 83657.0, 84959.5752021236, 12424.452987137434, 14930.328135234158, 15196.924015379853, 23810.166644168065, 24107.758922411253, 25833.0, 25922.22233333003, 26204.86897565576, 26701.19896403111, 26742.866285668446, 20234.291799786937, 20579.0, 20985.58028839384, 21150.259740908994, 21166.576668466238, 16817.915910420368, 17826.821731782515, 18645.160967756754, 18997.905010475413, 19263.22947082101, 20600.27899023527, 21097.578048438638, 21312.680309795054, 21313.360599182048, 21520.246791362228, 22567.66148507741, 22613.982370793026, 22710.75090870018, 22749.09003639836, 22767.861606919258, 19910.800891991476, 19915.302964396178, 19962.0, 20016.99915004273, 20774.792252077285], "value": 13258.802922020288, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1450.4053338131364, 1496.9775453368209, 1498.2883130513007, 1505.5709122899975, 1509.486774496671, 15763.133027683472, 16385.754213686803, 16421.753673694904, 16426.835731642695, 16432.589185270343, 15851.841481585181, 15974.201289935485, 15981.600459988505, 15995.360185592592, 16051.83948160518, 2724.577690457977, 2764.087851009162, 2764.5853122031654, 2765.5575107982727, 2771.9168424947284, 2656.2296933889147, 2749.6837863645637, 2751.545994910837, 2751.793615478837, 2753.160286112735, 2677.3842016336253, 2760.986195069022, 2763.019128209487, 2764.1707487753692, 2770.0858716623466, 2702.864796785345, 2720.8911643534234, 2721.632579601748, 2755.1596762987283, 2760.544510155822, 2740.287525243431, 2741.876615552305, 2743.931401714953, 2757.076379412899, 2757.310672331917, 15689.0, 15779.92110039454, 15791.131487768169, 15931.601709957227, 16046.518604441886, 8067.7176298829845, 8285.50286982783, 8364.707235246737, 8368.037675667254, 8370.581470926429, 5155.432902380735, 5323.840284791424, 5331.986922484754, 5424.91862622057, 5500.092484740013, 1920.7791104023077, 1930.7007413850877, 1932.9903350483298, 1957.667196576571, 1967.2131147540954, 28943.276418089506, 28994.13017609496, 29113.56329655057, 29136.125916222547, 29200.0, 6958.234594194634, 6962.617056061864, 6964.233934267227, 7106.395956343666, 7125.18060423058, 19316.227350905807, 19637.0, 19639.33065689404, 19871.60256794885, 19951.600967980557, 8281.710140145065, 8477.660893564189, 8479.364047696448, 8485.193906578865, 8486.957565212135, 7679.923200767921, 7739.226077392328, 7808.5314881107315, 7811.687532498637, 7817.530948143016, 5460.726963651801, 5667.744951477193, 5669.780997085564, 5694.800681976111, 5705.1727499512335, 1601.359456217499, 1633.5834362237554, 1639.5655151384892, 1656.8094669113207, 1658.3035125247425, 947.9857802132974, 954.6181527388961, 957.8467445208734, 958.1951161024773, 960.851068084448, 8249.0, 8364.456310339809, 8389.832203355898, 8431.747047588582, 8434.114417986146, 673.4309508465338, 674.784069097884, 681.6796105830252, 695.1658010387454, 709.4466316273212, 5092.592592592584, 5094.566961808214, 5106.7191304477865, 5116.488351164928, 5895.823125306248, 23930.52138957246, 24331.148409805926, 24369.51260974806, 24527.38681532976, 24538.386540336633, 23191.188308409124, 23736.762632373455, 23780.643290350657, 24324.635130473056, 24334.39164020878, 12589.181703189264, 12801.551945682042, 12842.293673848028, 12854.0, 12879.227246365248, 9160.0, 9530.85703714431, 9718.805623887341, 9919.0, 9999.050090241415, 20024.299149530278, 20541.589168216255, 20741.27405540799, 21248.681269780656, 21490.355289341343, 21368.893155534122, 21486.892565537073, 21574.0, 21581.892090540074, 21828.345149645535, 13164.47342106305, 13205.669858253235, 13498.527551536043, 13612.93193534026, 13629.182249065088, 15075.849241507445, 15172.317245723749, 15186.088834669956, 15214.771778423112, 15242.771358429854, 12045.457954391899, 12047.51809927593, 12071.215371000857, 12194.146409751233, 12212.450439730412, 12049.0, 12183.451744671334, 12212.32832194238, 12226.510939562319, 12476.438560264629, 10756.247062705535, 10895.891041089804, 10905.727356815825, 10914.50884710174, 10927.508262128064, 8364.958175209085, 8452.1547845215, 8454.112318206746, 8529.530875801642, 8537.957310213409, 8317.126701696236, 8444.197801208875, 8517.787055323666, 8528.616212270586, 8578.742637720878], "value": 7100.285283532213, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.5628200589383, 535.1811728056074, 542.6988021647986, 546.3034630845672, 553.5322652358758, 6073.210482637256, 6123.571350005502, 6213.875722485547, 6242.219722534684, 6246.125542424053, 6086.421789929961, 6109.847253818657, 6128.142060111588, 6129.509639228862, 6174.783882564111, 4914.213725803863, 4933.582544553161, 4940.7035577865445, 4944.579710724574, 4965.478624744404, 4638.46657634373, 4730.5269473052595, 4879.316895634614, 4893.559579637832, 4923.926141107886, 4756.07256584966, 4783.832565860195, 4811.591014763731, 4824.4210694716685, 4833.468318484964, 4647.1402790483535, 4773.665843390947, 4809.470958194595, 4815.253635686474, 4855.562999330077, 4301.913961720779, 4305.74165550068, 4321.286987647034, 4339.483099802139, 4341.1100724351745, 5888.793892213795, 5965.731542080617, 5992.580519363646, 6021.36775638556, 6086.60437071589, 5736.971315143398, 5752.769889204426, 5768.029464825619, 5793.073108302693, 5814.534837213055, 6551.0, 6566.441852442548, 6598.538102332838, 6632.966835165793, 6644.269130395653, 4871.14754917888, 4887.926681099786, 4902.950970490285, 4925.38432695913, 4970.900581988376, 6631.336866313378, 6718.529702920798, 6734.191896972346, 6863.897041544381, 6892.827679308008, 5105.489451054865, 5109.897802043938, 5113.488651134857, 5135.12702840518, 5147.510986456281, 5182.274481572507, 5184.533391994739, 5213.165893457104, 5215.53060224574, 5220.138677118309, 5775.451332123442, 5778.191053252548, 5784.681842498619, 5793.623414478046, 5803.216565763652, 6612.702428390734, 6621.966890165519, 6643.767468138689, 6663.0, 6671.566348187353, 1738.7131123364757, 1790.883592566479, 1795.4075155199014, 1809.276289484217, 1818.8908665480114, 1205.5599706107207, 1240.8708075651114, 1253.9686507837378, 1262.8295180150562, 1277.9680507987375, 6144.969275153685, 6152.815415537541, 6178.62928224308, 6178.7219575119225, 6230.6884655767935, 6641.966790166115, 6682.899756503656, 6713.798586042427, 6725.764598239038, 6738.865222695518, 6080.148779170831, 6106.419890110433, 6112.419320164578, 6136.325004249529, 6145.770845830852, 3540.6990405815795, 3562.9109272267883, 3596.8021758803516, 3597.8380972856285, 3606.495090687306, 6965.721371145199, 6976.476764242702, 7093.645317734093, 7126.643667816588, 7135.468977199515, 6433.169405461582, 6823.590584564942, 6864.5881247125335, 6877.277885822016, 6916.654167291716, 6948.722051117898, 6973.267806880204, 7018.859622807515, 7036.401905837959, 7045.753398631024, 6640.468762499085, 6733.764318249034, 6759.188897332155, 6785.321467853175, 6793.762218322335, 6610.611771528033, 6638.701258443478, 6677.799666010027, 6704.765333213314, 6730.8653826924165, 7040.260772618802, 7123.536970096927, 7127.75052873147, 7133.964330178316, 7142.785716428515, 5118.082692865031, 5158.8968220636125, 5168.9483105168465, 5183.274341592105, 5191.974040129926, 6542.378474044958, 6654.234763002123, 6718.462522998246, 6824.385805277549, 6853.697797418475, 6533.771318003847, 6540.574862633914, 6544.770933017321, 6579.190722551337, 6583.407493325623, 6562.606243625398, 6579.0, 6587.835304117244, 6592.538522303393, 6596.7031483584315, 6565.835854103686, 6566.6388348641285, 6601.53789234749, 6610.8016759497295, 6612.4710023198995, 6566.080748695282, 6642.302558231316, 6644.368784965421, 6650.20197576294, 6660.6336651484635, 6426.325235850169, 6429.292777794532, 6442.130312407765, 6454.612723236621, 6463.289038205888], "value": 5121.226310712458, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [937.9062093790618, 942.1191186240865, 961.778790878098, 963.0610155098777, 963.5471328475614, 18841.811581884176, 19358.709619355704, 20421.28525501608, 20905.581888362263, 21075.15699372027, 20229.898850505728, 21843.344699658996, 21988.89005554974, 22002.88998555009, 22059.448513787163, 1007.1539906478575, 1027.0705011964146, 1029.9948500257487, 1031.097789434245, 1032.8915463876297, 1048.8007278617076, 1077.6551503518876, 1086.16365398643, 1087.1085709718034, 1089.6730980705797, 1150.12590431272, 1158.5192145259707, 1160.025578514048, 1160.0777381981302, 1160.2342453980375, 1148.1561052626314, 1149.2415006095978, 1151.9424028798526, 1152.6714886257375, 1155.682187398468, 837.3970741066483, 841.1798496465958, 844.1895780051158, 844.907060223375, 845.3533047218882, 19642.312519061765, 19796.0, 19961.800381996283, 20802.0, 21124.577508449744, 22337.888310558505, 22457.775422245733, 22505.21231756897, 22629.77370226293, 23141.305760827203, 16529.33882644693, 16600.750988735177, 16643.33426662932, 16931.746023809654, 17107.657846842994, 3804.5054142961517, 3820.1213720844084, 3820.465134881119, 3823.445600387928, 3830.3296923038356, 135656.999999999, 136429.0, 137283.0, 137725.0, 138035.0, 16903.323867045427, 17092.658146837242, 17326.56683582895, 17331.30674772995, 17334.219960101826, 27277.590836137475, 28590.0, 31803.522947155812, 33735.0, 33949.490757638654, 9253.49105799174, 9635.662751803653, 9638.95180524107, 9641.180499657466, 9648.469334186688, 4629.398178236807, 4655.95344046562, 4729.6452766042685, 4737.502562230985, 4811.5805837278085, 5558.694271815089, 5683.914741278884, 5693.430656934273, 5695.373508914016, 5704.857378565569, 1042.301657889201, 1059.3432072115338, 1063.4470075560664, 1151.1078913841839, 1185.2118341302937, 703.0614130136325, 720.8630360231539, 726.5931078596003, 729.5367441674575, 737.181728281607, 12941.352932353533, 13297.800532992012, 14614.707705846036, 14694.55916322512, 15566.725960866, 707.5789905006513, 710.8720430322488, 716.691822516323, 729.744589393708, 736.4255880413286, 6256.593321434092, 6604.3725846044545, 6640.236372817188, 6650.86698266032, 6656.034874943106, 133458.0, 136089.0, 137424.0, 142678.0, 144602.0, 117565.0, 119205.40397298131, 122486.0, 124167.9999999982, 129548.0, 104380.0, 104422.0, 105397.0, 107466.0, 108959.45520272347, 13098.942748852905, 13561.864381356454, 13711.862881371058, 14194.858051419353, 14579.906507011805, 49614.75963100807, 50549.74725126351, 50651.746741266055, 52705.73647131893, 53030.73484632552, 85695.0, 87654.12345876715, 87676.0, 87767.56116219633, 88948.5552572233, 21077.789222108197, 21270.149194032685, 21517.0, 21584.568308634054, 21868.671969920782, 24201.757982420655, 24702.382440438414, 24908.252752417455, 24955.251342459756, 25460.2361929135, 20780.064897079366, 20837.37487875366, 20937.685934710687, 20967.895160524098, 21541.784582154603, 19364.903175484033, 21578.460538486663, 21899.78100219041, 21987.34037978863, 22090.0, 21304.573908521434, 21343.67984480203, 21448.24931127403, 21507.247246346302, 21770.238041669098, 14896.255187240811, 14929.328180232133, 15548.222588870285, 15626.921865391056, 15949.920250398674, 14422.350994205077, 14739.92630036843, 14838.332275047866, 16444.0, 16572.254248558602], "value": 10206.608070087168, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1474.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 107.0, 93.0, 107.0, 106.0, 109.0, 115.0, 106.0, 109.0, 108.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 114.0, 139.0, 175.0, 114.0, 142.0, 135.0, 117.0, 177.0, 117.0], "value": 136.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 162.0, 162.0, 165.0, 163.0, 160.0, 168.0, 167.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 74.0, 182.0, 74.0, 75.0, 73.0, 76.0, 152.0, 74.0], "value": 92.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 129.0, 77.0, 79.0, 78.0, 135.0, 78.0, 77.0, 123.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 149.0, 147.0, 149.0, 148.0, 148.0, 149.0, 148.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 93.0, 94.0, 94.0, 94.0, 99.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 47.0, 47.0, 46.0, 50.0, 46.0, 47.0, 46.0, 47.0], "value": 47.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 55.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 76.0, 75.0, 74.0, 74.0, 72.0, 82.0, 74.0, 73.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 122.0, 116.0, 112.0, 115.0, 113.0, 113.0, 115.0, 117.0, 167.0], "value": 120.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 163.0, 167.0, 164.0, 162.0, 168.0, 162.0, 162.0, 160.0, 167.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 62.0, 65.0, 61.0, 69.0, 63.0, 60.0, 61.0], "value": 63.2, "unit": "score"}]}]} 03:47:37 INFO - Return code: 0 03:47:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:47:37 INFO - # TBPL SUCCESS # 03:47:37 INFO - Running post-action listener: _package_coverage_data 03:47:37 INFO - Running post-action listener: _resource_record_post_action 03:47:37 INFO - [mozharness: 2017-08-16 10:47:37.587373Z] Finished run-tests step (success) 03:47:37 INFO - Running post-run listener: _resource_record_post_run 03:47:37 INFO - Total resource usage - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431190016; Read time: 176; Write time: 273352 03:47:37 INFO - TinderboxPrint: CPU usage
13.1% 03:47:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 176 03:47:37 INFO - TinderboxPrint: I/O write bytes / time
431,190,016 / 273,352 03:47:37 INFO - TinderboxPrint: CPU idle
8,222.1 (86.9%) 03:47:37 INFO - TinderboxPrint: CPU user
1,188.3 (12.6%) 03:47:37 INFO - TinderboxPrint: Swap in / out
0 / 0 03:47:37 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 108343296; Read time: 0; Write time: 89220 03:47:37 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:47:37 INFO - run-tests - Wall time: 1168s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322846720; Read time: 176; Write time: 184132 03:47:38 INFO - Running post-run listener: _upload_blobber_files 03:47:38 INFO - Blob upload gear active. 03:47:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:47:38 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:47:38 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:47:38 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:47:38 INFO - (blobuploader) - INFO - Open directory for files ... 03:47:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:47:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:47:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:39 INFO - (blobuploader) - INFO - Done attempting. 03:47:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:47:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:47:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:46 INFO - (blobuploader) - INFO - Done attempting. 03:47:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:47:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:47:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:47 INFO - (blobuploader) - INFO - Done attempting. 03:47:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:47:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:47:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:47:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:47:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:47:47 INFO - (blobuploader) - INFO - Done attempting. 03:47:47 INFO - (blobuploader) - INFO - Iteration through files over. 03:47:47 INFO - Return code: 0 03:47:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:47:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:47:47 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f8488ab87db7b4ec8ae85e3e043d7bf478e0dad61c478796222cd79cdaf999c74113ebdc1611400cfdc35e7a85253ad27992fe9645114b9d5ea78be4fbd5e1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b477ef97692753a346afa69e317782e3b4b81c861395c71c65edc572ece288d02171d4684edb760da71d072c308a7be871d290318b440ade7b5a0774fba87305", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/278d225d7d6a7d0d13a32563647e07d1b075b18721bf2a8a59ad2b2d3443e589a6111a4f3e2a583e1442e51a8ef279dcda5cdc79c0ac7af92dd36a5267b5b826", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3c7e67271b15653f9e55cf7256a7b83ade38bbae624e1766ebb2f8905f400c3fdde6143c8583044e376fbe7a451232c54bf54090652a9b8f76480f2575e08c"} 03:47:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:47:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:47:47 INFO - Contents: 03:47:47 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f8488ab87db7b4ec8ae85e3e043d7bf478e0dad61c478796222cd79cdaf999c74113ebdc1611400cfdc35e7a85253ad27992fe9645114b9d5ea78be4fbd5e1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b477ef97692753a346afa69e317782e3b4b81c861395c71c65edc572ece288d02171d4684edb760da71d072c308a7be871d290318b440ade7b5a0774fba87305", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/278d225d7d6a7d0d13a32563647e07d1b075b18721bf2a8a59ad2b2d3443e589a6111a4f3e2a583e1442e51a8ef279dcda5cdc79c0ac7af92dd36a5267b5b826", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3c7e67271b15653f9e55cf7256a7b83ade38bbae624e1766ebb2f8905f400c3fdde6143c8583044e376fbe7a451232c54bf54090652a9b8f76480f2575e08c"} 03:47:47 INFO - Running post-run listener: copy_logs_to_upload_dir 03:47:47 INFO - Copying logs to upload dir... 03:47:47 INFO - mkdir: /builds/slave/test/build/upload/logs 03:47:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.636997 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-08-16 03:47:47.647608) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:47:47.651921) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317 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/4f8488ab87db7b4ec8ae85e3e043d7bf478e0dad61c478796222cd79cdaf999c74113ebdc1611400cfdc35e7a85253ad27992fe9645114b9d5ea78be4fbd5e1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b477ef97692753a346afa69e317782e3b4b81c861395c71c65edc572ece288d02171d4684edb760da71d072c308a7be871d290318b440ade7b5a0774fba87305", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/278d225d7d6a7d0d13a32563647e07d1b075b18721bf2a8a59ad2b2d3443e589a6111a4f3e2a583e1442e51a8ef279dcda5cdc79c0ac7af92dd36a5267b5b826", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3c7e67271b15653f9e55cf7256a7b83ade38bbae624e1766ebb2f8905f400c3fdde6143c8583044e376fbe7a451232c54bf54090652a9b8f76480f2575e08c"} build_url:https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/ItWMdFNSQ8683rsRnnsRdA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4f8488ab87db7b4ec8ae85e3e043d7bf478e0dad61c478796222cd79cdaf999c74113ebdc1611400cfdc35e7a85253ad27992fe9645114b9d5ea78be4fbd5e1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b477ef97692753a346afa69e317782e3b4b81c861395c71c65edc572ece288d02171d4684edb760da71d072c308a7be871d290318b440ade7b5a0774fba87305", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/278d225d7d6a7d0d13a32563647e07d1b075b18721bf2a8a59ad2b2d3443e589a6111a4f3e2a583e1442e51a8ef279dcda5cdc79c0ac7af92dd36a5267b5b826", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bc3c7e67271b15653f9e55cf7256a7b83ade38bbae624e1766ebb2f8905f400c3fdde6143c8583044e376fbe7a451232c54bf54090652a9b8f76480f2575e08c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:47:47.681115) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:47:47.681424) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1502879218.834849-2114068317 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:47:47.763147) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:47:47.763430) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:47:47.766704) ========= ========= Total master_lag: 0.19 =========