builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1500804829.5 results: success (0) revision: fd3634c4b16d89e71adce46be4cf80297e2fbc56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:49.499300) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:49.499744) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:49.500023) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:49.532416) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:49.532725) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-23 03:13:49-- 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% 46.7M=0s 2017-07-23 03:13:50 (46.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.365948 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:49.913693) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:49.914001) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015430 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:49.964001) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:49.964327) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fd3634c4b16d89e71adce46be4cf80297e2fbc56 --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 fd3634c4b16d89e71adce46be4cf80297e2fbc56 --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=a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-23 03:13:50,215 truncating revision to first 12 chars 2017-07-23 03:13:50,215 Setting DEBUG logging. 2017-07-23 03:13:50,215 attempt 1/10 2017-07-23 03:13:50,215 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fd3634c4b16d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-23 03:13:50,513 unpacking tar archive at: mozilla-central-fd3634c4b16d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645322 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:50.623474) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:50.623743) ========= script_repo_revision: fd3634c4b16d89e71adce46be4cf80297e2fbc56 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:50.624079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:50.624356) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-23 03:13:50.636405) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-23 03:13:50.636671) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:13:50 INFO - MultiFileLogger online at 20170723 03:13:50 in /builds/slave/test 03:13:50 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:13:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:13:50 INFO - {'append_to_log': False, 03:13:50 INFO - 'base_work_dir': '/builds/slave/test', 03:13:50 INFO - 'blob_upload_branch': 'Firefox', 03:13:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:13:50 INFO - 'branch': 'Firefox', 03:13:50 INFO - 'buildbot_json_path': 'buildprops.json', 03:13:50 INFO - 'code_coverage': False, 03:13:50 INFO - 'config_files': ('talos/linux_config.py',), 03:13:50 INFO - 'default_actions': ('clobber', 03:13:50 INFO - 'read-buildbot-config', 03:13:50 INFO - 'download-and-extract', 03:13:50 INFO - 'populate-webroot', 03:13:50 INFO - 'create-virtualenv', 03:13:50 INFO - 'install', 03:13:50 INFO - 'setup-mitmproxy', 03:13:50 INFO - 'run-tests'), 03:13:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:13:50 INFO - 'disable_ccov_upload': False, 03:13:50 INFO - 'download_minidump_stackwalk': True, 03:13:50 INFO - 'download_symbols': 'ondemand', 03:13:50 INFO - 'enable_stylo': False, 03:13:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:13:50 INFO - 'tooltool.py': '/tools/tooltool.py', 03:13:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:13:50 INFO - '/tools/misc-python/virtualenv.py')}, 03:13:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:13:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:13:50 INFO - 'gecko_profile': False, 03:13:50 INFO - 'gecko_profile_interval': 0, 03:13:50 INFO - 'installer_path': 'installer.exe', 03:13:50 INFO - 'log_level': 'info', 03:13:50 INFO - 'log_name': 'talos', 03:13:50 INFO - 'log_to_console': True, 03:13:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:13:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:13:50 INFO - 'opt_config_files': (), 03:13:50 INFO - 'pip_index': False, 03:13:50 INFO - 'suite': 'dromaeojs-e10s', 03:13:50 INFO - 'system_bits': '32', 03:13:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:13:50 INFO - 'title': 'talos-linux64-ix-062', 03:13:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:13:50 INFO - 'use_talos_json': True, 03:13:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:13:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:13:50 INFO - 'work_dir': 'build'} 03:13:50 INFO - [mozharness: 2017-07-23 10:13:50.998459Z] Running clobber step. 03:13:50 INFO - Running pre-action listener: _resource_record_pre_action 03:13:50 INFO - Running main action method: clobber 03:13:50 INFO - rmtree: /builds/slave/test/build 03:13:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:13:52 INFO - Running post-action listener: _resource_record_post_action 03:13:52 INFO - [mozharness: 2017-07-23 10:13:52.035668Z] Finished clobber step (success) 03:13:52 INFO - [mozharness: 2017-07-23 10:13:52.035771Z] Running read-buildbot-config step. 03:13:52 INFO - Running pre-action listener: _resource_record_pre_action 03:13:52 INFO - Running main action method: read_buildbot_config 03:13:52 INFO - Using buildbot properties: 03:13:52 INFO - { 03:13:52 INFO - "project": "", 03:13:52 INFO - "product": "firefox", 03:13:52 INFO - "who": "archaeopteryx@coole-files.de", 03:13:52 INFO - "installer_path": "public/build/target.tar.bz2", 03:13:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:13:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:13:52 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:13:52 INFO - "stage_platform": "linux64-stylo", 03:13:52 INFO - "basedir": "/builds/slave/test", 03:13:52 INFO - "buildnumber": 231, 03:13:52 INFO - "platform": "ubuntu64_hw_stylo", 03:13:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:13:52 INFO - "slavebuilddir": "test", 03:13:52 INFO - "taskId": "O4hJ8LOzR0yD34oOhHbB2A", 03:13:52 INFO - "branch": "mozilla-central", 03:13:52 INFO - "script_repo_revision": "production", 03:13:52 INFO - "revision": "fd3634c4b16d89e71adce46be4cf80297e2fbc56", 03:13:52 INFO - "slavename": "talos-linux64-ix-062", 03:13:52 INFO - "repo_path": "mozilla-central" 03:13:52 INFO - } 03:13:52 INFO - Finding installer, test and symbols from parent task. 03:13:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O4hJ8LOzR0yD34oOhHbB2A'}, attempt #1 03:13:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O4hJ8LOzR0yD34oOhHbB2A'}, attempt #1 03:13:52 INFO - Task dependencies: ZDm6q-ewRU2QuG3j5f3Vqw 03:13:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw'}, attempt #1 03:13:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.tar.bz2 03:13:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/test_packages.json 03:13:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.crashreporter-symbols.zip 03:13:53 INFO - Running post-action listener: _resource_record_post_action 03:13:53 INFO - [mozharness: 2017-07-23 10:13:53.442697Z] Finished read-buildbot-config step (success) 03:13:53 INFO - [mozharness: 2017-07-23 10:13:53.442918Z] Running download-and-extract step. 03:13:53 INFO - Running pre-action listener: _resource_record_pre_action 03:13:53 INFO - Running main action method: download_and_extract 03:13:53 INFO - mkdir: /builds/slave/test/build/tests 03:13:53 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:13:53 INFO - trying https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.test_packages.json 03:13:53 INFO - Downloading https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:13:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:13:53 INFO - Downloaded 989 bytes. 03:13:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:13:53 INFO - Using the following test package requirements: 03:13:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:13:53 INFO - u'common': [u'target.common.tests.zip'], 03:13:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:13:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:13:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:13:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:13:53 INFO - u'mozbase': [u'target.common.tests.zip'], 03:13:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:13:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:13:53 INFO - u'web-platform': [u'target.common.tests.zip', 03:13:53 INFO - u'target.web-platform.tests.tar.gz'], 03:13:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:13:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:13:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.common.tests.zip 03:13:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:13:53 INFO - Fetch https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.common.tests.zip into memory 03:13:55 INFO - Content-Length response header: 72767581 03:13:55 INFO - Bytes received: 72767581 03:14:06 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:14:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.common.tests.zip 03:14:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:14:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.common.tests.zip into memory 03:14:07 INFO - Content-Length response header: 72767581 03:14:07 INFO - Bytes received: 72767581 03:14:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.talos.tests.zip 03:14:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:14:19 INFO - Fetch https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.talos.tests.zip into memory 03:14:20 INFO - Content-Length response header: 14498880 03:14:20 INFO - Bytes received: 14498880 03:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:20 INFO - trying https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.tar.bz2 03:14:20 INFO - Downloading https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:14:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:14:22 INFO - Downloaded 61963938 bytes. 03:14:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.tar.bz2 03:14:22 INFO - mkdir: /builds/slave/test/properties 03:14:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:14:22 INFO - Writing to file /builds/slave/test/properties/build_url 03:14:22 INFO - Contents: 03:14:22 INFO - build_url:https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.tar.bz2 03:14:22 INFO - Running post-action listener: _resource_record_post_action 03:14:22 INFO - Running post-action listener: set_extra_try_arguments 03:14:22 INFO - [mozharness: 2017-07-23 10:14:22.084410Z] Finished download-and-extract step (success) 03:14:22 INFO - [mozharness: 2017-07-23 10:14:22.084508Z] Running populate-webroot step. 03:14:22 INFO - Running pre-action listener: _resource_record_pre_action 03:14:22 INFO - Running main action method: populate_webroot 03:14:22 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:14:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:14:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:14:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:14:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:14:22 INFO - 'tests': ['damp', 'tps']}, 03:14:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:14:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:14:22 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:14:22 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:14:22 INFO - 'other-e10s': {'tests': ['a11yr', 03:14:22 INFO - 'ts_paint', 03:14:22 INFO - 'tpaint', 03:14:22 INFO - 'sessionrestore', 03:14:22 INFO - 'sessionrestore_many_windows', 03:14:22 INFO - 'sessionrestore_no_auto_restore', 03:14:22 INFO - 'tabpaint']}, 03:14:22 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:14:22 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:14:22 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:14:22 INFO - 'talos_options': ['--mitmproxy', 03:14:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:14:22 INFO - '--firstNonBlankPaint'], 03:14:22 INFO - 'tests': ['quantum_pageload_google', 03:14:22 INFO - 'quantum_pageload_youtube', 03:14:22 INFO - 'quantum_pageload_amazon', 03:14:22 INFO - 'quantum_pageload_facebook']}, 03:14:22 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:14:22 INFO - 'talos_options': ['--stylo', 03:14:22 INFO - '--mitmproxy', 03:14:22 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:14:22 INFO - '--firstNonBlankPaint'], 03:14:22 INFO - 'tests': ['quantum_pageload_google', 03:14:22 INFO - 'quantum_pageload_youtube', 03:14:22 INFO - 'quantum_pageload_amazon', 03:14:22 INFO - 'quantum_pageload_facebook']}, 03:14:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:14:22 INFO - 'tsvgr_opacity', 03:14:22 INFO - 'tart', 03:14:22 INFO - 'tscrollx', 03:14:22 INFO - 'cart', 03:14:22 INFO - 'tsvg_static']}, 03:14:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:14:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:14:22 INFO - 'talos_options': ['--xperf_path', 03:14:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:14:22 INFO - 'tests': ['tp5n']}}} 03:14:22 INFO - Running post-action listener: _resource_record_post_action 03:14:22 INFO - [mozharness: 2017-07-23 10:14:22.091853Z] Finished populate-webroot step (success) 03:14:22 INFO - [mozharness: 2017-07-23 10:14:22.091944Z] Running create-virtualenv step. 03:14:22 INFO - Running pre-action listener: _resource_record_pre_action 03:14:22 INFO - Running main action method: create_virtualenv 03:14:22 INFO - Creating virtualenv /builds/slave/test/build/venv 03:14:22 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:14:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:14:22 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:14:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:14:22 INFO - Using real prefix '/usr' 03:14:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:14:22 INFO - Installing distribute.............................................................................................................................................................................................done. 03:14:24 INFO - Installing pip.................done. 03:14:24 INFO - Return code: 0 03:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:14:24 INFO - Reading from file tmpfile_stdout 03:14:24 INFO - Output received: 03:14:24 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:14:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2204eb0>, '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 0x2205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2206240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', '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:14:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:14:24 INFO - Using env: {'DISPLAY': ':0', 03:14:24 INFO - 'HOME': '/home/cltbld', 03:14:24 INFO - 'LANG': 'en_US.UTF-8', 03:14:24 INFO - 'LANGUAGE': 'en_US:en', 03:14:24 INFO - 'LOGNAME': 'cltbld', 03:14:24 INFO - 'MAIL': '/var/mail/cltbld', 03:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:24 INFO - 'MOZ_NO_REMOTE': '1', 03:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:24 INFO - 'NO_EM_RESTART': '1', 03:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:24 INFO - 'PWD': '/builds/slave/test', 03:14:24 INFO - 'SHELL': '/bin/bash', 03:14:24 INFO - 'SHLVL': '1', 03:14:24 INFO - 'TERM': 'linux', 03:14:24 INFO - 'TMOUT': '86400', 03:14:24 INFO - 'USER': 'cltbld', 03:14:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', 03:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:24 INFO - '_': '/tools/buildbot/bin/python'} 03:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:25 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:14:25 INFO - Cleaning up... 03:14:25 INFO - Return code: 0 03:14:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2204eb0>, '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 0x2205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2206240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', '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:14:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:14:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:14:25 INFO - Using env: {'DISPLAY': ':0', 03:14:25 INFO - 'HOME': '/home/cltbld', 03:14:25 INFO - 'LANG': 'en_US.UTF-8', 03:14:25 INFO - 'LANGUAGE': 'en_US:en', 03:14:25 INFO - 'LOGNAME': 'cltbld', 03:14:25 INFO - 'MAIL': '/var/mail/cltbld', 03:14:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:25 INFO - 'MOZ_NO_REMOTE': '1', 03:14:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:25 INFO - 'NO_EM_RESTART': '1', 03:14:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:25 INFO - 'PWD': '/builds/slave/test', 03:14:25 INFO - 'SHELL': '/bin/bash', 03:14:25 INFO - 'SHLVL': '1', 03:14:25 INFO - 'TERM': 'linux', 03:14:25 INFO - 'TMOUT': '86400', 03:14:25 INFO - 'USER': 'cltbld', 03:14:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', 03:14:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:25 INFO - '_': '/tools/buildbot/bin/python'} 03:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:25 INFO - Downloading/unpacking psutil>=3.1.1 03:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:14:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:14:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:14:26 INFO - Installing collected packages: psutil 03:14:26 INFO - Running setup.py install for psutil 03:14:26 INFO - building 'psutil._psutil_linux' extension 03:14:26 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:14:26 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:14:26 INFO - building 'psutil._psutil_posix' extension 03:14:26 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:14:26 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:14:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:14:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:14:27 INFO - Successfully installed psutil 03:14:27 INFO - Cleaning up... 03:14:27 INFO - Return code: 0 03:14:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2204eb0>, '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 0x2205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2206240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', '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:14:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:14:27 INFO - Using env: {'DISPLAY': ':0', 03:14:27 INFO - 'HOME': '/home/cltbld', 03:14:27 INFO - 'LANG': 'en_US.UTF-8', 03:14:27 INFO - 'LANGUAGE': 'en_US:en', 03:14:27 INFO - 'LOGNAME': 'cltbld', 03:14:27 INFO - 'MAIL': '/var/mail/cltbld', 03:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:27 INFO - 'MOZ_NO_REMOTE': '1', 03:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:27 INFO - 'NO_EM_RESTART': '1', 03:14:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:27 INFO - 'PWD': '/builds/slave/test', 03:14:27 INFO - 'SHELL': '/bin/bash', 03:14:27 INFO - 'SHLVL': '1', 03:14:27 INFO - 'TERM': 'linux', 03:14:27 INFO - 'TMOUT': '86400', 03:14:27 INFO - 'USER': 'cltbld', 03:14:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', 03:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:27 INFO - '_': '/tools/buildbot/bin/python'} 03:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:14:28 INFO - Installing collected packages: mozsystemmonitor 03:14:28 INFO - Running setup.py install for mozsystemmonitor 03:14:28 INFO - Successfully installed mozsystemmonitor 03:14:28 INFO - Cleaning up... 03:14:28 INFO - Return code: 0 03:14:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:14:28 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:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:28 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:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:28 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 0x1e981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2204eb0>, '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 0x2205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2206240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', '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:14:28 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:14:28 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:14:28 INFO - Using env: {'DISPLAY': ':0', 03:14:28 INFO - 'HOME': '/home/cltbld', 03:14:28 INFO - 'LANG': 'en_US.UTF-8', 03:14:28 INFO - 'LANGUAGE': 'en_US:en', 03:14:28 INFO - 'LOGNAME': 'cltbld', 03:14:28 INFO - 'MAIL': '/var/mail/cltbld', 03:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:28 INFO - 'MOZ_NO_REMOTE': '1', 03:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:28 INFO - 'NO_EM_RESTART': '1', 03:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:28 INFO - 'PWD': '/builds/slave/test', 03:14:28 INFO - 'SHELL': '/bin/bash', 03:14:28 INFO - 'SHLVL': '1', 03:14:28 INFO - 'TERM': 'linux', 03:14:28 INFO - 'TMOUT': '86400', 03:14:28 INFO - 'USER': 'cltbld', 03:14:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', 03:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:28 INFO - '_': '/tools/buildbot/bin/python'} 03:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:28 INFO - Downloading/unpacking jsonschema==2.5.1 03:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:14:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:30 INFO - Downloading functools32-3.2.3-2.tar.gz 03:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:14:30 INFO - warning: no files found matching '*.txt' 03:14:30 INFO - no previously-included directories found matching 'build' 03:14:30 INFO - no previously-included directories found matching 'dist' 03:14:30 INFO - no previously-included directories found matching '.git*' 03:14:30 INFO - Installing collected packages: jsonschema, functools32 03:14:30 INFO - Running setup.py install for functools32 03:14:30 INFO - warning: no files found matching '*.txt' 03:14:30 INFO - no previously-included directories found matching 'build' 03:14:30 INFO - no previously-included directories found matching 'dist' 03:14:30 INFO - no previously-included directories found matching '.git*' 03:14:30 INFO - Successfully installed jsonschema functools32 03:14:30 INFO - Cleaning up... 03:14:30 INFO - Return code: 0 03:14:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:14: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:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14: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:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:30 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 0x1e981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2204eb0>, '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 0x2205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2206240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', '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:14:30 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:14:30 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:14:30 INFO - Using env: {'DISPLAY': ':0', 03:14:30 INFO - 'HOME': '/home/cltbld', 03:14:30 INFO - 'LANG': 'en_US.UTF-8', 03:14:30 INFO - 'LANGUAGE': 'en_US:en', 03:14:30 INFO - 'LOGNAME': 'cltbld', 03:14:30 INFO - 'MAIL': '/var/mail/cltbld', 03:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:30 INFO - 'MOZ_NO_REMOTE': '1', 03:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:30 INFO - 'NO_EM_RESTART': '1', 03:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:30 INFO - 'PWD': '/builds/slave/test', 03:14:30 INFO - 'SHELL': '/bin/bash', 03:14:30 INFO - 'SHLVL': '1', 03:14:30 INFO - 'TERM': 'linux', 03:14:30 INFO - 'TMOUT': '86400', 03:14:30 INFO - 'USER': 'cltbld', 03:14:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', 03:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:30 INFO - '_': '/tools/buildbot/bin/python'} 03:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:14:30 INFO - Cleaning up... 03:14:30 INFO - Return code: 0 03:14:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:14: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:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14: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:14:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:30 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 0x1e981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2204eb0>, '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 0x2205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2206240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', '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:14:30 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:14:30 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:14:30 INFO - Using env: {'DISPLAY': ':0', 03:14:30 INFO - 'HOME': '/home/cltbld', 03:14:30 INFO - 'LANG': 'en_US.UTF-8', 03:14:30 INFO - 'LANGUAGE': 'en_US:en', 03:14:30 INFO - 'LOGNAME': 'cltbld', 03:14:30 INFO - 'MAIL': '/var/mail/cltbld', 03:14:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:30 INFO - 'MOZ_NO_REMOTE': '1', 03:14:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:30 INFO - 'NO_EM_RESTART': '1', 03:14:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:30 INFO - 'PWD': '/builds/slave/test', 03:14:30 INFO - 'SHELL': '/bin/bash', 03:14:30 INFO - 'SHLVL': '1', 03:14:30 INFO - 'TERM': 'linux', 03:14:30 INFO - 'TMOUT': '86400', 03:14:30 INFO - 'USER': 'cltbld', 03:14:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', 03:14:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:30 INFO - '_': '/tools/buildbot/bin/python'} 03:14:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:30 INFO - Downloading/unpacking blobuploader==1.2.4 03:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:31 INFO - Downloading blobuploader-1.2.4.tar.gz 03:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:14:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:14:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:14:32 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:14:32 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:14:32 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:14:32 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:14:32 INFO - Downloading docopt-0.6.1.tar.gz 03:14:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:14:32 INFO - Installing collected packages: blobuploader, requests, docopt 03:14:32 INFO - Running setup.py install for blobuploader 03:14:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:14:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:14:32 INFO - Running setup.py install for requests 03:14:32 INFO - Running setup.py install for docopt 03:14:33 INFO - Successfully installed blobuploader requests docopt 03:14:33 INFO - Cleaning up... 03:14:33 INFO - Return code: 0 03:14:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:33 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 0x1e981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2204eb0>, '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 0x2205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2206240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', '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:14:33 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:14:33 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:14:33 INFO - Using env: {'DISPLAY': ':0', 03:14:33 INFO - 'HOME': '/home/cltbld', 03:14:33 INFO - 'LANG': 'en_US.UTF-8', 03:14:33 INFO - 'LANGUAGE': 'en_US:en', 03:14:33 INFO - 'LOGNAME': 'cltbld', 03:14:33 INFO - 'MAIL': '/var/mail/cltbld', 03:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:33 INFO - 'MOZ_NO_REMOTE': '1', 03:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:33 INFO - 'NO_EM_RESTART': '1', 03:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:33 INFO - 'PWD': '/builds/slave/test', 03:14:33 INFO - 'SHELL': '/bin/bash', 03:14:33 INFO - 'SHLVL': '1', 03:14:33 INFO - 'TERM': 'linux', 03:14:33 INFO - 'TMOUT': '86400', 03:14:33 INFO - 'USER': 'cltbld', 03:14:33 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', 03:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:33 INFO - '_': '/tools/buildbot/bin/python'} 03:14:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:14:33 INFO - Running setup.py (path:/tmp/pip-w4pjVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:14:33 INFO - Running setup.py (path:/tmp/pip-fkASaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:14:33 INFO - Running setup.py (path:/tmp/pip-yfk0vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:14:33 INFO - Running setup.py (path:/tmp/pip-Sakha3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:14:33 INFO - Running setup.py (path:/tmp/pip-eyUW8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:14:33 INFO - Running setup.py (path:/tmp/pip-Ng8NNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:14:33 INFO - Running setup.py (path:/tmp/pip-5hWOyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:14:33 INFO - Running setup.py (path:/tmp/pip-UlRaUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:14:33 INFO - Running setup.py (path:/tmp/pip-CTu1zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:14:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:14:33 INFO - Running setup.py (path:/tmp/pip-kB_zLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:14:34 INFO - Running setup.py (path:/tmp/pip-68fIUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:14:34 INFO - Running setup.py (path:/tmp/pip-67NgJf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:14:34 INFO - Running setup.py (path:/tmp/pip-DLwT86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:14:34 INFO - Running setup.py (path:/tmp/pip-KJJ0Qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:14:34 INFO - Running setup.py (path:/tmp/pip-xv9UgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:14:34 INFO - Running setup.py (path:/tmp/pip-3WX9SN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:14:34 INFO - Running setup.py (path:/tmp/pip-gQPXuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:14:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:14:34 INFO - Running setup.py install for manifestparser 03:14:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:14:34 INFO - Running setup.py install for mozcrash 03:14:34 INFO - Running setup.py install for mozdebug 03:14:34 INFO - Running setup.py install for mozdevice 03:14:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:14:34 INFO - Running setup.py install for mozfile 03:14:35 INFO - Running setup.py install for mozhttpd 03:14:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:14:35 INFO - Running setup.py install for mozinfo 03:14:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:14:35 INFO - Running setup.py install for mozInstall 03:14:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:14:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:14:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:14:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:14:35 INFO - Running setup.py install for mozleak 03:14:35 INFO - Running setup.py install for mozlog 03:14:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:14:35 INFO - Running setup.py install for moznetwork 03:14:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:14:35 INFO - Running setup.py install for mozprocess 03:14:35 INFO - Running setup.py install for mozprofile 03:14:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:14:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:14:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:14:35 INFO - Running setup.py install for mozrunner 03:14:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:14:35 INFO - Running setup.py install for mozscreenshot 03:14:36 INFO - Running setup.py install for moztest 03:14:36 INFO - Running setup.py install for mozversion 03:14:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:14:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:14:36 INFO - Cleaning up... 03:14:36 INFO - Return code: 0 03:14:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:14: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:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14: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:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:36 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 0x1e981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2204eb0>, '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 0x2205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2206240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', '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:14:36 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:14:36 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:14:36 INFO - Using env: {'DISPLAY': ':0', 03:14:36 INFO - 'HOME': '/home/cltbld', 03:14:36 INFO - 'LANG': 'en_US.UTF-8', 03:14:36 INFO - 'LANGUAGE': 'en_US:en', 03:14:36 INFO - 'LOGNAME': 'cltbld', 03:14:36 INFO - 'MAIL': '/var/mail/cltbld', 03:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:36 INFO - 'MOZ_NO_REMOTE': '1', 03:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:36 INFO - 'NO_EM_RESTART': '1', 03:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:36 INFO - 'PWD': '/builds/slave/test', 03:14:36 INFO - 'SHELL': '/bin/bash', 03:14:36 INFO - 'SHLVL': '1', 03:14:36 INFO - 'TERM': 'linux', 03:14:36 INFO - 'TMOUT': '86400', 03:14:36 INFO - 'USER': 'cltbld', 03:14:36 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', 03:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:36 INFO - '_': '/tools/buildbot/bin/python'} 03:14:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:14:36 INFO - Running setup.py (path:/tmp/pip-RPRqVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:14:36 INFO - Running setup.py (path:/tmp/pip-NFgnye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:14:36 INFO - Running setup.py (path:/tmp/pip-uM3IoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:14:36 INFO - Running setup.py (path:/tmp/pip-mEXMQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:14:36 INFO - Running setup.py (path:/tmp/pip-v7SbWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:14:36 INFO - Running setup.py (path:/tmp/pip-zMAFc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:14:36 INFO - Running setup.py (path:/tmp/pip-zcOLXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:14:37 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:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:14:37 INFO - Running setup.py (path:/tmp/pip-9iv0Yz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:14:37 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:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:14:37 INFO - Running setup.py (path:/tmp/pip-RUoJvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:14:37 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:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:14:37 INFO - Running setup.py (path:/tmp/pip-taGqOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:14:37 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:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:14:37 INFO - Running setup.py (path:/tmp/pip-H6sawB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:14:37 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:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:14:37 INFO - Running setup.py (path:/tmp/pip-SAGq2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:14:37 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:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:14:37 INFO - Running setup.py (path:/tmp/pip-6GPt0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:14:37 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:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:14:37 INFO - Running setup.py (path:/tmp/pip-3KUkJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:14:37 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:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:14:37 INFO - Running setup.py (path:/tmp/pip-XtUxvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:14:37 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:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:14:37 INFO - Running setup.py (path:/tmp/pip-MDDR3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:14:37 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:14:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:14:37 INFO - Running setup.py (path:/tmp/pip-vi2b95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:14:37 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:14:37 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:14:37 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:14:37 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:14:37 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:14:37 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:14:37 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:14:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:14:37 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:14:37 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:14:37 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:14:37 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:14:38 INFO - Downloading blessings-1.6.tar.gz 03:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:14:38 INFO - Installing collected packages: blessings 03:14:38 INFO - Running setup.py install for blessings 03:14:39 INFO - Successfully installed blessings 03:14:39 INFO - Cleaning up... 03:14:39 INFO - Return code: 0 03:14:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:14:39 INFO - Reading from file tmpfile_stdout 03:14:39 INFO - Current package versions: 03:14:39 INFO - argparse == 1.2.1 03:14:39 INFO - blessings == 1.6 03:14:39 INFO - blobuploader == 1.2.4 03:14:39 INFO - docopt == 0.6.1 03:14:39 INFO - functools32 == 3.2.3-2 03:14:39 INFO - jsonschema == 2.5.1 03:14:39 INFO - manifestparser == 1.1 03:14:39 INFO - mozInstall == 1.13 03:14:39 INFO - mozcrash == 1.0 03:14:39 INFO - mozdebug == 0.1 03:14:39 INFO - mozdevice == 0.51 03:14:39 INFO - mozfile == 1.2 03:14:39 INFO - mozhttpd == 0.7 03:14:39 INFO - mozinfo == 0.10 03:14:39 INFO - mozleak == 0.1 03:14:39 INFO - mozlog == 3.5 03:14:39 INFO - moznetwork == 0.27 03:14:39 INFO - mozprocess == 0.25 03:14:39 INFO - mozprofile == 0.28 03:14:39 INFO - mozrunner == 6.13 03:14:39 INFO - mozscreenshot == 0.1 03:14:39 INFO - mozsystemmonitor == 0.3 03:14:39 INFO - moztest == 0.8 03:14:39 INFO - mozversion == 1.4 03:14:39 INFO - psutil == 3.1.1 03:14:39 INFO - requests == 1.2.3 03:14:39 INFO - wsgiref == 0.1.2 03:14:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:14: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:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14: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:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:39 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 0x1e981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2204eb0>, '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 0x2205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2206240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', '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:14:39 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:14:39 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:14:39 INFO - Using env: {'DISPLAY': ':0', 03:14:39 INFO - 'HOME': '/home/cltbld', 03:14:39 INFO - 'LANG': 'en_US.UTF-8', 03:14:39 INFO - 'LANGUAGE': 'en_US:en', 03:14:39 INFO - 'LOGNAME': 'cltbld', 03:14:39 INFO - 'MAIL': '/var/mail/cltbld', 03:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:39 INFO - 'MOZ_NO_REMOTE': '1', 03:14:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:39 INFO - 'NO_EM_RESTART': '1', 03:14:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:39 INFO - 'PWD': '/builds/slave/test', 03:14:39 INFO - 'SHELL': '/bin/bash', 03:14:39 INFO - 'SHLVL': '1', 03:14:39 INFO - 'TERM': 'linux', 03:14:39 INFO - 'TMOUT': '86400', 03:14:39 INFO - 'USER': 'cltbld', 03:14:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', 03:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:39 INFO - '_': '/tools/buildbot/bin/python'} 03:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:39 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:14:39 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:14:39 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:14:39 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:14:39 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:14:39 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:14:39 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:14:39 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:14:39 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:14:39 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:14: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:14: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:14: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:14: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:14:40 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:14:40 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:14:40 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:14:40 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:14:40 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:14:40 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:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:14:40 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:14:40 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:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:14:40 INFO - Installing collected packages: marionette-driver, simplejson 03:14:40 INFO - Running setup.py install for marionette-driver 03:14:41 INFO - Running setup.py install for simplejson 03:14:41 INFO - building 'simplejson._speedups' extension 03:14:41 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:14:41 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:14:42 INFO - Successfully installed marionette-driver simplejson 03:14:42 INFO - Cleaning up... 03:14:42 INFO - Return code: 0 03:14:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:14: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:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:14: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:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:14:42 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 0x1e981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2064a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2207d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2204eb0>, '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 0x2205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2206240>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', '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:14:42 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:14:42 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:14:42 INFO - Using env: {'DISPLAY': ':0', 03:14:42 INFO - 'HOME': '/home/cltbld', 03:14:42 INFO - 'LANG': 'en_US.UTF-8', 03:14:42 INFO - 'LANGUAGE': 'en_US:en', 03:14:42 INFO - 'LOGNAME': 'cltbld', 03:14:42 INFO - 'MAIL': '/var/mail/cltbld', 03:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:14:42 INFO - 'MOZ_NO_REMOTE': '1', 03:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:14:42 INFO - 'NO_EM_RESTART': '1', 03:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:14:42 INFO - 'PWD': '/builds/slave/test', 03:14:42 INFO - 'SHELL': '/bin/bash', 03:14:42 INFO - 'SHLVL': '1', 03:14:42 INFO - 'TERM': 'linux', 03:14:42 INFO - 'TMOUT': '86400', 03:14:42 INFO - 'USER': 'cltbld', 03:14:42 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', 03:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:14:42 INFO - '_': '/tools/buildbot/bin/python'} 03:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:14:42 INFO - Cleaning up... 03:14:42 INFO - Return code: 0 03:14:42 INFO - Running post-action listener: _resource_record_post_action 03:14:42 INFO - Running post-action listener: _start_resource_monitoring 03:14:42 INFO - Starting resource monitoring. 03:14:42 INFO - [mozharness: 2017-07-23 10:14:42.374402Z] Finished create-virtualenv step (success) 03:14:42 INFO - [mozharness: 2017-07-23 10:14:42.374874Z] Running install step. 03:14:42 INFO - Running pre-action listener: _resource_record_pre_action 03:14:42 INFO - Running main action method: install 03:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:14:42 INFO - Reading from file tmpfile_stdout 03:14:42 INFO - Detecting whether we're running mozinstall >=1.0... 03:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:14:42 INFO - Reading from file tmpfile_stdout 03:14:42 INFO - Output received: 03:14:42 INFO - Usage: mozinstall [options] installer 03:14:42 INFO - Options: 03:14:42 INFO - -h, --help show this help message and exit 03:14:42 INFO - -d DEST, --destination=DEST 03:14:42 INFO - Directory to install application into. [default: 03:14:42 INFO - "/builds/slave/test"] 03:14:42 INFO - --app=APP Application being installed. [default: firefox] 03:14:42 INFO - mkdir: /builds/slave/test/build/application 03:14:42 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:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:15:00 INFO - Reading from file tmpfile_stdout 03:15:00 INFO - Output received: 03:15:00 INFO - /builds/slave/test/build/application/firefox/firefox 03:15:00 INFO - Running post-action listener: _resource_record_post_action 03:15:00 INFO - [mozharness: 2017-07-23 10:15:00.673795Z] Finished install step (success) 03:15:00 INFO - [mozharness: 2017-07-23 10:15:00.674048Z] Running setup-mitmproxy step. 03:15:00 INFO - Running pre-action listener: _resource_record_pre_action 03:15:00 INFO - Running main action method: setup_mitmproxy 03:15:00 INFO - Skipping: mitmproxy is not required 03:15:00 INFO - Running post-action listener: _resource_record_post_action 03:15:00 INFO - [mozharness: 2017-07-23 10:15:00.675187Z] Finished setup-mitmproxy step (success) 03:15:00 INFO - [mozharness: 2017-07-23 10:15:00.675409Z] Running run-tests step. 03:15:00 INFO - Running pre-action listener: _resource_record_pre_action 03:15:00 INFO - Running pre-action listener: _set_gcov_prefix 03:15:00 INFO - Running main action method: run_tests 03:15:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:15:00 INFO - Python 2.7.3 03:15:00 INFO - Return code: 0 03:15:00 INFO - grabbing minidump binary from tooltool 03:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:00 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 0x2204eb0>, '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 0x2205db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2206240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:15:00 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:15:00 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:15:00 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:15:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:15:00 INFO - Return code: 0 03:15:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:15:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:15:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:15:00 INFO - ENV: RUST_BACKTRACE is now 1 03:15:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:15:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:15:00 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/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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:15:00 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/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --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:15:00 INFO - Using env: {'DISPLAY': ':0', 03:15:00 INFO - 'HOME': '/home/cltbld', 03:15:00 INFO - 'LANG': 'en_US.UTF-8', 03:15:00 INFO - 'LANGUAGE': 'en_US:en', 03:15:00 INFO - 'LOGNAME': 'cltbld', 03:15:00 INFO - 'MAIL': '/var/mail/cltbld', 03:15:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:15:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:00 INFO - 'MOZ_NO_REMOTE': '1', 03:15:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:00 INFO - 'NO_EM_RESTART': '1', 03:15:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:00 INFO - 'PWD': '/builds/slave/test', 03:15:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:15:00 INFO - 'RUST_BACKTRACE': '1', 03:15:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:15:00 INFO - 'SHELL': '/bin/bash', 03:15:00 INFO - 'SHLVL': '1', 03:15:00 INFO - 'STYLO_FORCE_ENABLED': '1', 03:15:00 INFO - 'TERM': 'linux', 03:15:00 INFO - 'TMOUT': '86400', 03:15:00 INFO - 'USER': 'cltbld', 03:15:00 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002', 03:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:00 INFO - '_': '/tools/buildbot/bin/python'} 03:15:00 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/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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:15:01 INFO - mozversion application_buildid: 20170723092729 03:15:01 INFO - mozversion application_changeset: fd3634c4b16d89e71adce46be4cf80297e2fbc56 03:15:01 INFO - mozversion application_display_name: Nightly 03:15:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:15:01 INFO - mozversion application_name: Firefox 03:15:01 INFO - mozversion application_remotingname: firefox 03:15:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:15:01 INFO - mozversion application_vendor: Mozilla 03:15:01 INFO - mozversion application_version: 56.0a1 03:15:01 INFO - mozversion platform_buildid: 20170723092729 03:15:01 INFO - mozversion platform_changeset: fd3634c4b16d89e71adce46be4cf80297e2fbc56 03:15:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:15:01 INFO - mozversion platform_version: 56.0a1 03:15:01 INFO - using testdate: 1500804901 03:15:01 INFO - actual date: 1500804901 03:15:01 INFO - starting webserver on 'localhost:55741' 03:15:01 INFO - SUITE-START | Running 2 tests 03:15:01 INFO - TEST-START | dromaeo_css 03:15:01 INFO - Initialising browser for dromaeo_css test... 03:15:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55741/getInfo.html -profile /tmp/tmpzzGt9h/profile 03:15:01 INFO - TEST-INFO | started process 21942 (/builds/slave/test/build/application/firefox/firefox http://localhost:55741/getInfo.html) 03:15:07 INFO - TEST-INFO | 21942: exit 0 03:15:07 INFO - Browser initialized. 03:15:07 INFO - Running cycle 1/1 for dromaeo_css test... 03:15:07 INFO - TEST-INFO | started process 22169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzzGt9h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:18 INFO - PID 22169 | RSS: Main: 176406528 03:15:18 INFO - PID 22169 | 03:18:18 INFO - PID 22169 | Cycle 1(1): loaded http://localhost:55741/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55741/tests/dromaeo/cssquery-ext.html) 03:18:19 INFO - PID 22169 | RSS: Main: 181481472 03:18:19 INFO - PID 22169 | 03:21:21 INFO - PID 22169 | Cycle 1(1): loaded http://localhost:55741/tests/dromaeo/cssquery-ext.html (next: http://localhost:55741/tests/dromaeo/cssquery-jquery.html) 03:21:22 INFO - PID 22169 | RSS: Main: 179363840 03:21:22 INFO - PID 22169 | 03:24:24 INFO - PID 22169 | Cycle 1(1): loaded http://localhost:55741/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55741/tests/dromaeo/cssquery-mootools.html) 03:24:25 INFO - PID 22169 | RSS: Main: 180531200 03:24:25 INFO - PID 22169 | 03:27:27 INFO - PID 22169 | Cycle 1(1): loaded http://localhost:55741/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55741/tests/dromaeo/cssquery-prototype.html) 03:27:27 INFO - PID 22169 | RSS: Main: 179982336 03:27:27 INFO - PID 22169 | 03:30:31 INFO - PID 22169 | Cycle 1(1): loaded http://localhost:55741/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55741/tests/dromaeo/cssquery-yui.html) 03:30:32 INFO - PID 22169 | RSS: Main: 180953088 03:30:32 INFO - PID 22169 | 03:33:34 INFO - PID 22169 | Cycle 1(1): loaded http://localhost:55741/tests/dromaeo/cssquery-yui.html (next: http://localhost:55741/tests/dromaeo/cssquery-dojo.html) 03:33:34 INFO - PID 22169 | RSS: Main: 183472128 03:33:34 INFO - PID 22169 | 03:33:34 INFO - PID 22169 | __start_tp_report 03:33:34 INFO - PID 22169 | _x_x_mozilla_page_load 03:33:34 INFO - PID 22169 | _x_x_mozilla_page_load_details 03:33:34 INFO - PID 22169 | |i|pagename|runs| 03:33:34 INFO - PID 22169 | |0;dojo.html;3071.769617278703;3122.0477754284943;3123.7813353065267;3153.9369212615748;3173.412918610057;5937.228160339156;6044.727987240573;6123.173371594833;6170.413810687977;6218.098375735527;6020.6086604370685;6067.544934129935;6123.785667501638;6128.11142384354;6186.319504854462;5451.781928722847;5513.917291240635;5614.242077319571;5616.157576363557;5670.3479099903425;5489.890202195954;5575.526080283181;5659;5696.601237913327;5697.373288938214;5558.416366281523;5558.972205138969;5609.943900560983;5615.719214039302;5676.772929082832;5387.919181212285;5467.6719396836315;5577.2191893135;5597.496225339739;5621.7751289948765;5417.891642167135;5485.040117979338;5547.195656629807;5573.331200255995;5573.6098473106895;5992.370801065869;6017.187679663233;6112.205413296243;6119.44924956756;6129.080637904305;6316.273628532732;6430.260520040209;6524.673766311713;6526;6547.738090476375;6320.74717011319;6453.096566480696;6546.869062618769;6587.736490540373;6616.966915165442;6028.0355143176885;6035.245594300756;6118.724657390384;6144.815655530341;6173.1048997895505;6471.0940468334475;6541.574797638138;6670.099536562502;6795.3204679531655;6796.286389929085;6261.060840873814;6298.874022519524;6299.559030867887;6311.431971122529;6349.269833969152;6314.368563143649;6406.6476343800605;6420.5184611154355;6452.612843229421;6475.4819614430735;6450.9354906450335;6505.447037001908;6507.934920650828;6579.605223686594;6589;6493.155889734304;6559.47524198063;6563;6629.270780214172;6641.634710090895;5205.531502164823;5306.442823503554;5321.148616221386;5404.891997140577;5412.972935135299;4596.931046034312;4669.813207471731;4672.719636821802;4683.96952670412;4699.177643912301;5705.82882513517;5719.57103217252;5778.3643799182055;5791.305043394819;5813.186153938452;6376.043593460925;6593.3736295051895;6614.636195009224;6674.16572928384;6697.330266973361;5633.859153521113;5656.4060773619;5656.91514627281;5665.093585026459;5720.8283751487525;5785.218995435646;5787.88424231513;5797;5819.388964158787;5831;6297.338779428185;6354.555181137276;6408.743650254031;6416.839579010469;6423.42189202974;6433.099366088658;6578.76974305897;6654.73381064752;6662.333766623299;6669.266380698023;6205;6223.439890409885;6255.437010668879;6289.716962736779;6315.147455093504;6451.48388128958;6463.482921366373;6464.967675161594;6473.482121430368;6512.479001679949;6615.106960560262;6628.171478565179;6696.866062678621;6710.456594983084;6726.495512836459;6245.937540624717;6268.341824108403;6335.588186767845;6340.239171299289;6488.708008139551;6167.814965551041;6293.244810622755;6305.337939516285;6366.395192456709;6494.415502604788;6122.081687746873;6263.749450021948;6390.616563006234;6392.105105285357;6401.807945761635;6350.396712312323;6478.125453063776;6523.869522609616;6557.278699343164;6567.310432404529;6243.687815609111;6263.812085637438;6326.6520341381665;6356.491480681627;6366.236051673829 03:33:34 INFO - PID 22169 | |1;ext.html;782.8042989252687;834.1241696218968;866.146845357323;870.7213691618684;1128.9661310160698;30332.696673033264;40331.39502907455;40994;41187;41238.175236495255;41463.58536414635;41529.792351038275;41762.373564396556;41951.79024104875;41999.370009449885;7398.7410440634585;7447.813804654873;7581.241875812402;7582.2796834300925;7588;7423.294786995254;7469.813254668649;7474.177840437547;7500;7546.660400282;7459.962700186518;7487.064116985377;7487.812804679872;7494.138174109966;7531.887021694679;7425.108986921577;7452.664630091659;7487.064116985377;7495.28794764502;7501.4748967572295;7429.21993190718;7484.700611975514;7506.812329691801;7514.624268786593;7514.849703005909;37895.810520947496;37936.43095353572;37987;37990.81004594987;38132.42801357982;3464.7055000325004;3514.1039035046156;3538.6284440133672;3554.573451185848;3569.1790888095625;30376;30389.848050759825;30503.389932201233;30737.846310768527;30803.229919252197;4813.687110337817;4900.264960255954;4904.215325547895;4956.727379994099;5027.547520723116;177278;179530.10234948873;179959.10020449813;181336.0933195339;181536;46934.295985560246;46957.765211173726;46976.7651161742;47115.76442117767;47479.762601186776;49570;49591;49649.75175124101;49718;49851.75074124679;14727.779083313759;14975.176365300013;15076.623084422978;15088.471903483325;15107.4712385066;10826.945865270623;11085;11950.760984780256;12121.939390303169;12255.69360765988;14118.364673589713;14233.64415889611;14266.785998210034;14469.710605787825;14553.490627827976;5527.723613819293;5645.181448689999;5698.686572238566;5783.508401785811;5816.2551234629445;991.6777047459605;998;1007.9193664506822;1022.749426390539;1029.7991891581219;22011.559768804535;22259.77740222577;23078.53842923132;29140.562891556645;29542.556861647092;1093.4969913839723;1124.668222874254;1129.9435028248554;1130.1072152999038;1147.403350257878;11932.22440541362;12556.81164782529;12687.746245075046;15592.064476131469;15785.68428631444;230497;232946;235202;235667;235738;54722;55484.16773748316;55641;55874.441255587735;55954;1450.6808502129516;1479.8816094712397;1516.1282262698992;1520.908745475275;1527.4959263443038;26527.734722652527;27643.585346220225;27678.861605691844;28150.85924570364;28219.43561128725;50505.49494505155;51273.743631281606;51670.74164629153;51686.74156629193;51744.741276293375;214265;215793;217102;218612;219187;31923.680763193;32958.17604559905;35658.28683426265;35813.46279805753;36232.45651315285;42787.14425711531;42894.57105428906;43039.56960430356;43194.784026079666;43557.564424355354;29815.701842981292;30668.386632267677;31435.84282078575;31734;31757.206069847514;30097.849510752305;30601.387972240875;30908.918187863317;31135.53296700506;31345.52981705322;34619;34876;35033.82483087568;35135.64864351324;35348.46977295394;30057.248568785955;30284.394312114076;30577.23556911095;30583.388332232786;30980;22815.31554053381;23503.76496235084;23851.403714907265;24561.63157552674;25078.37304067413 03:33:34 INFO - PID 22169 | |2;jquery.html;580.7734983356489;587.667967598307;588.5938702295418;589.1045610671778;601.8585632376393;21787;22664.43338916528;22712;22745.886270568666;22794.54410911783;24150;25624.87187564064;26597;26639.200823975265;26936.730632693667;6504.544681872271;6694.397504224618;6734.966325168391;6744.898826517606;6748.561343512656;5764.221830052931;6336.556441049129;6505.479561635081;6596.076549283104;6604.735810567571;6223.564350495467;6309.968450157743;6318.431341179293;6322.0832979217985;6328.145700330466;6268.435840774307;6277.0584412338285;6301.086342480337;6318.431341179293;6319.210098737658;5823.941760582382;5870.941290587082;5871.442212989759;5896.793612223594;5910.202122713422;27160.864195679093;29292.267693307625;29986;30028.84985575058;30762.23094422635;1869.44851268876;1919.280269898788;1940.4372731907729;1940.6118776244666;1943.6695761720541;18080.18639161241;18639.347622833135;19198.808011919842;19363.61272774551;19553.511162220915;2271.7955384015518;2314.5486630107134;2379.785819276256;2380.809535237177;2381.7022872140983;132242;136303.31848340793;136391.31804341014;136483;136789.999999999;13889.777635578259;14964.625884352978;15320.693586128215;15353.462628808162;15495.767563486557;23236.883815580815;23282.301530954097;23344.299671009558;23350.416239593807;23405.191377034866;9725.416475011521;9781.657641982496;9788.755281118029;9792.657256995972;9832.557534910946;8849.336299777542;8895.822083558292;8921;8952.194302512806;9016.864747028669;8763.582202940857;8990.415622984485;9249.583768730423;9289.581968811419;9411.247100231965;2637.4593208392234;2685.1273336165823;2711.701712811589;2735.317779565553;2738;914.7758799094264;943.4056544376998;958.755517343073;982.297657175109;999.4508511806671;19371.4188574343;19820.40538783839;22858.771412285663;24248.75751242465;24354.63468047981;986.8322385194534;1021.6373187518324;1031.3347890610514;1044.5090807320548;1061.4736926115795;10915.345079295268;11416.744158142597;11650.6504804856;13137.81759641637;13985.23081230542;477953;482712;494773;495455;500460;111079.44460277808;118661.40669296599;119085.40457297658;120806.3959680196;121249.39375303243;1222.1506053292876;1230.9384530773605;1259.9307038112993;1264.797632378815;1274.9107562470724;19806.801931980495;19852.404427867186;21155.259565915734;21772.891135544854;21809.23667671624;56898.7155064222;58187;58232;58468.9999999983;58966.41033589781;66451.66774166099;66738;67314.32685673081;67455.3254467449;68324.6583767078;12459.563915262923;13119;14446.349914254093;14858.851411485746;15022.399104035716;23252.186173483846;23966.161184358465;24002.39994000164;24576.50846983086;24862.12982545602;19136.712949305493;19255.903720481307;19315.323963661205;19340.903295483433;19625;15953;16344.754828677342;17009.404670836462;17147.828521714622;17856.375026873997;19473.8052619472;19996.100175491847;20012.89993550023;20111.296104636855;20183.091760870502;14762.557123286319;14890.925545372203;14904.62738431548;14944.402223910922;14959.326830292446;18479.353222637143;18485.72271415903;19084.23663053518;19090.809091908905;19252 03:33:34 INFO - PID 22169 | |3;mootools.html;1387.3479464651614;1436.5403071017272;1455.9199244041574;1462.1519518679163;1467.493714668439;13383.263920484369;13971.510997115103;13975.860241397608;14008.64978375541;14015.859841401583;13805.240711760849;14639;14798.926005369985;14813.25933703316;14871.107733535995;2477.3063542208165;2518.64738936549;2529.8355606885584;2533.1387328308465;2533.961990570134;2357.4695693468916;2427.9514409711796;2586.237060067285;2594.286571192918;2708;2690.3946612012237;2696.312440327714;2721.0612338743103;2728.6084097110515;2730.5767606021;2574.0476023871192;2607.804414668898;2618.8559629220385;2618.9083382081535;2622.659054322926;2532.189699296226;2583.7028741694758;2588.7022992355933;2593.0276146445085;2595.6495873057274;13738;14093.78859317111;14113.506027288995;14158;14163.716725665532;7652.540847549165;7913.366930645535;7932.682692692285;7939.166387529342;7970.083440404312;4468.151051300275;4679.15775160471;5157.6647517911215;5161.716105614228;5285.392179899284;1830.432565904574;1852.6943054396008;1872.1762424533163;1885.990570047141;1903.714442833572;20665.17339306426;21132.15471381143;22245.332640020824;22486.212982545534;22522.43693907649;5855.121731740273;5932.614380065282;6051.515878729691;6070.150178974947;6124.663143527148;15011.474598389223;15091.320890559951;15102.848971510364;15173;15239.542813715385;7434.256574342522;7569.053868266466;7588.924110758821;7597.430192735456;7619.123800762984;6970.093887794555;7027.051348068047;7049.612271325126;7136.107986501687;7196.388306993964;4750.192467280571;4813.013332266877;4855.927161092586;4928.334674818925;4972.129877271463;1237.9938100309441;1256.447163248168;1258.4525731306728;1264.4562837979756;1276.6297773645724;884.8539990901558;912.5574096563162;931.2782593490099;948.3882895532342;948.9952550237205;7232.0959880015;7288.416926645856;7340.4861659684375;8513.489190648581;8636.827263454696;966.6761634852263;983.3215081593678;998.8801343838641;999.9900001000043;1017.8778546574458;5133.512316329943;5201.557867581222;5292.206169074592;5312.512496500986;5390.622656414013;18740.81259187418;19561.119749611018;19718.90140549288;19729.802701973083;19743.506412339808;18920.43238702841;19042.42872713821;19374.612507749767;19374.80625193758;19379.612407751767;9330.1136392044;10190.796184076276;11032.669019929415;11189.776204475866;11239.325640461599;7108.395786358217;8203.015638123463;8416.705415310435;8504.53225072627;8559.700410485602;15662;15967.121808300655;16046.518604441886;16325.836741632907;16547.503574892773;16516.669666606842;16519.33922643129;16710.916445417693;17172.22724977354;17681.38115165963;10411.167106631603;10432.582696692047;10476.580936762444;10493.790124197321;10564.471776410996;12152.392380381123;12426.502939882303;12501.437435315614;12606.243625382507;12620.936895315464;10372.170226382023;10406.531706073396;10411.11505522039;10534;10869.565217391215;10146.898531014891;10656.62701805433;10727.892721072689;10906.182036347464;11189.720256993314;9107.681231157143;9231.076892310715;9275.350725449423;9276.11876871696;9337;6657.1345725055435;6944.236134025355;7080.752173673896;7148.964255178691;7161.104861892263;6730.528862979544;6905.37851593359;7423.925760742323;7428.257174282745;7448.47860649771 03:33:34 INFO - PID 22169 | |4;prototype.html;480.81479153885664;505.40109969685903;529.1005291005291;533.1256738948126;533.3386600615238;5995.820125396245;6004.979153543897;6050.60671056381;6055.5155587552945;6133.754649814002;5698.629589076707;5898.88202235955;5949.464548190662;5975.701214939247;6005.819825405234;4810.783514741827;4825.686330388531;4841.757912104398;4842.61259099273;4860.552594376141;4653.767311634405;4789.808407663707;4790.9520904791025;4803.711777293356;4823.300621409893;4741.596964258042;4747.8338258160975;4758.905451746084;4770.904581908359;4814.183702534022;4716.457607375161;4735.195016847109;4735.218688916325;4750.643701722367;4762.714237145765;4274.850380236708;4286.592773686495;4316.611504964569;4331.848385306499;4341.261985462479;5752.245565102642;5801.564882633777;5833.358330583633;5891.79378721747;5908.822735317947;5467.726613669341;5472.5621950243885;5480.205370221335;5540.335159780811;5549.5005449509335;6298.496120310364;6335.208098987627;6338.651374174418;6368.808935731936;6403.990124641457;4670.252759558488;4674.415698037746;4739.170645137087;4747;4748.3589715388325;6510.18622672166;6518.93481065188;6544.4110030097045;6577.980413035987;6605.339466053404;4832.903341933142;4835.637327200474;4869.586085182799;4895.6817806843155;4927.187014142698;4918.90162196754;4927.926081108786;4969.577585905166;4984.77568509418;5008.724520151427;5459.426760190202;5478.424765399575;5486.259354987025;5539.2522009529;5545.1682247663175;6121.755129794848;6307.842303942438;6333.276691022812;6377.266614339317;6471.805845824632;1636.6808472347777;1665.4337525241476;1709.4700642800772;1712.6831536165848;1739.6346767178782;972.8832540095234;1148.6439203846835;1202.6392082375253;1214.3078445286278;1219.3171823778712;5458.754356053987;5597.552195824324;5599.776008959596;5616.606837521416;5631.4087020863035;6338.778142764981;6390.740722231695;6476.158099447041;6512.34876512345;6517.869642607121;5556.91664625031;5651.604387692904;5672.376038635747;5676.687782171937;5679.574031947621;3421.8460169292443;3432.5880894292845;3460.4290292102023;3479.5998460176897;3500.649935006479;6288.434040936338;6301.842453938688;6330;6333.429991300805;6354.269259035178;6677.732890684319;6734.047126333407;6749;6754.425873800782;6767.966160169168;6266;6323.747050117944;6348.76199141163;6380.298167201604;6400.807975760735;6465.450436712932;6496.382843629847;6501.414872661483;6502.577332473374;6535.8236466538665;6389.808305750835;6457.773977910751;6519.185101862267;6521.543491955517;6557.573757705733;6288.748450062129;6337.8732425352155;6358.491320694241;6377.489800816016;6387.872242555216;5210.322658054429;5337.412884582771;5344.759485823225;5365.9463405367005;5390.622656414013;6543.5419520633095;6640.701168447335;6643.2360278568585;6648.069270302259;6649.335066493312;6314.547654039505;6341.414646338415;6361.681915904279;6389.594289256356;6431.871362572629;6367.267764207176;6382.266039405527;6383.776567820104;6413.775517856852;6423.935760642334;6197.876042479215;6233.470155036691;6314.8737025258315;6325.588836725598;6343.3339499351905;6379.936200637934;6406.551541392244;6437.871242575216;6462.676866156768;6463;5952.285725712942;6063.211782468251;6079.258178620683;6162.445379915829;6198.101275315144 03:33:34 INFO - PID 22169 | |5;yui.html;905.3526728389201;914.542728635682;927.188709878856;930.4510338900047;939.7180845746277;16080.195990200487;16745.748813767786;16794.412195573143;16842;16966.745498817527;19943;20941.895290523564;21828.781712182874;21886;22031.33905982819;993.2997236947953;1010.2625083688874;1012.9442880641561;1013.0882206014572;1013.2552573858245;978.7259567321162;1066.6000249906285;1071.0895738622187;1076.4563895232895;1080.0441609175896;1108.8780234174235;1113.465536542456;1113.5100555755482;1114.1810769084716;1117.1677100560094;1109.7835921995213;1114.153243534911;1114.5931734916737;1115.1357697784201;1116.268843907242;817.6116344736262;818.8485130250923;819.5246756880995;819.9344052475788;820.3683163963715;19045.61908761831;19287.132079056475;19348.516287092796;19425.22299108034;19797.40607781769;20678.276260330967;20877.791222087737;21226.469338266514;21386.46533836651;21391.465213369636;16316.184190790413;16442.095684737335;16549.91725041367;16557.83442165587;16649.583760406087;3576.1059735066233;3587.031501494608;3605.7475976681644;3607.981960090183;3607.981960090183;110369;113419.43290283579;113966.43016784945;119276;122687.3865630675;16111.194440278174;16495.670086598442;16575.336986520644;16687.415940442268;16723;29650;30141.698583014328;30356.482175891117;30451.390972180434;30567.847160764053;8081.595920203967;8538.615762290712;8583.613737381833;8683.435576687496;8754.824903501894;4086.6117718816663;4214.367844823301;4237.131388065439;4250.341197114452;4252.532221455637;4405.647548196137;5074.441811400743;5237.0835103857435;5814.912776308359;5868.061110222344;1045.811753884308;1067.071647666535;1072.088724584113;1072.5602502973743;1081.4808891732014;657.3229573539262;669.2470970158572;699.4963626189136;703.7185125949559;704.2570088556622;12841.293728845003;13414;13583.86416135826;13804.102733322303;13882.722345553033;668.5687731413211;694.6006046523169;707.6178863413802;717.996410017957;723.4537923867447;5047.899042019139;5387.676739395649;5400.108982018001;5442.673439593637;5635.985522605888;91777;96972;99306.5034674822;100374.49812751035;102460.48769756104;81206.18793812105;83113;84148;85994.57002714946;89563.10436895677;75375.62312188404;76356;77523.61238193772;79340;80327.59836200898;11355.943220283845;11854.644360669194;12259.509619615115;12328.568500102454;12553.601951161088;36323.27353452969;36989.63010369862;37004.629953701195;39128.608713912494;39769.2046159081;63009;64326.67836660787;66878;67741;71114.08872512061;18781.718274226172;18902.05489725536;19070.141843617348;19291.903540482206;19305.613887722448;21450;21484.462888427915;21722;21725.565488689823;21733.23933662314;18421.63156736831;18665.253389864254;19139.521511962314;19150.425487235407;19403.8059619402;18862.811371886655;18930.43208703741;19065.046747662283;19539.609207816047;19652.803471965097;18349;18505.167267473265;18654.44036678902;19070.618587628447;19366.4190074298;13071.346432678518;13894.513692020731;13968.301584920917;14348.49780257686;14565;13419.45676247205;13968.930155349564;14619.19594422317;14651.560453186421;14835.365335492874 03:33:34 INFO - PID 22169 | __end_tp_report 03:33:34 INFO - PID 22169 | __start_cc_report 03:33:34 INFO - PID 22169 | _x_x_mozilla_cycle_collect,393 03:33:34 INFO - PID 22169 | __end_cc_report 03:33:34 INFO - PID 22169 | __startTimestamp1500806014260__endTimestamp 03:33:34 INFO - PID 22169 | 03:33:34 INFO - PID 22169 | ------- Summary: start ------- 03:33:34 INFO - PID 22169 | Number of tests: 6 03:33:34 INFO - PID 22169 | 03:33:34 INFO - PID 22169 | [#0] dojo.html Cycles:165 Average:6024.09 Median:6261.06 stddev:694.87 (11.1%) stddev-sans-first:657.27 03:33:34 INFO - PID 22169 | Values: 3071.8 3122.0 3123.8 3153.9 3173.4 5937.2 6044.7 6123.2 6170.4 6218.1 6020.6 6067.5 6123.8 6128.1 6186.3 5451.8 5513.9 5614.2 5616.2 5670.3 5489.9 5575.5 5659.0 5696.6 5697.4 5558.4 5559.0 5609.9 5615.7 5676.8 5387.9 5467.7 5577.2 5597.5 5621.8 5417.9 5485.0 5547.2 5573.3 5573.6 5992.4 6017.2 6112.2 6119.4 6129.1 6316.3 6430.3 6524.7 6526.0 6547.7 6320.7 6453.1 6546.9 6587.7 6617.0 6028.0 6035.2 6118.7 6144.8 6173.1 6471.1 6541.6 6670.1 6795.3 6796.3 6261.1 6298.9 6299.6 6311.4 6349.3 6314.4 6406.6 6420.5 6452.6 6475.5 6450.9 6505.4 6507.9 6579.6 6589.0 6493.2 6559.5 6563.0 6629.3 6641.6 5205.5 5306.4 5321.1 5404.9 5413.0 4596.9 4669.8 4672.7 4684.0 4699.2 5705.8 5719.6 5778.4 5791.3 5813.2 6376.0 6593.4 6614.6 6674.2 6697.3 5633.9 5656.4 5656.9 5665.1 5720.8 5785.2 5787.9 5797.0 5819.4 5831.0 6297.3 6354.6 6408.7 6416.8 6423.4 6433.1 6578.8 6654.7 6662.3 6669.3 6205.0 6223.4 6255.4 6289.7 6315.1 6451.5 6463.5 6465.0 6473.5 6512.5 6615.1 6628.2 6696.9 6710.5 6726.5 6245.9 6268.3 6335.6 6340.2 6488.7 6167.8 6293.2 6305.3 6366.4 6494.4 6122.1 6263.7 6390.6 6392.1 6401.8 6350.4 6478.1 6523.9 6557.3 6567.3 6243.7 6263.8 6326.7 6356.5 6366.2 03:33:34 INFO - PID 22169 | 03:33:34 INFO - PID 22169 | [#1] ext.html Cycles:180 Average:38232.10 Median:35084.74 stddev:54895.74 (156.5%) stddev-sans-first:54977.72 03:33:34 INFO - PID 22169 | Values: 782.8 834.1 866.1 870.7 1129.0 30332.7 40331.4 40994.0 41187.0 41238.2 41463.6 41529.8 41762.4 41951.8 41999.4 7398.7 7447.8 7581.2 7582.3 7588.0 7423.3 7469.8 7474.2 7500.0 7546.7 7460.0 7487.1 7487.8 7494.1 7531.9 7425.1 7452.7 7487.1 7495.3 7501.5 7429.2 7484.7 7506.8 7514.6 7514.8 37895.8 37936.4 37987.0 37990.8 38132.4 3464.7 3514.1 3538.6 3554.6 3569.2 30376.0 30389.8 30503.4 30737.8 30803.2 4813.7 4900.3 4904.2 4956.7 5027.5 177278.0 179530.1 179959.1 181336.1 181536.0 46934.3 46957.8 46976.8 47115.8 47479.8 49570.0 49591.0 49649.8 49718.0 49851.8 14727.8 14975.2 15076.6 15088.5 15107.5 10826.9 11085.0 11950.8 12121.9 12255.7 14118.4 14233.6 14266.8 14469.7 14553.5 5527.7 5645.2 5698.7 5783.5 5816.3 991.7 998.0 1007.9 1022.7 1029.8 22011.6 22259.8 23078.5 29140.6 29542.6 1093.5 1124.7 1129.9 1130.1 1147.4 11932.2 12556.8 12687.7 15592.1 15785.7 230497.0 232946.0 235202.0 235667.0 235738.0 54722.0 55484.2 55641.0 55874.4 55954.0 1450.7 1479.9 1516.1 1520.9 1527.5 26527.7 27643.6 27678.9 28150.9 28219.4 50505.5 51273.7 51670.7 51686.7 51744.7 214265.0 215793.0 217102.0 218612.0 219187.0 31923.7 32958.2 35658.3 35813.5 36232.5 42787.1 42894.6 43039.6 43194.8 43557.6 29815.7 30668.4 31435.8 31734.0 31757.2 30097.8 30601.4 30908.9 31135.5 31345.5 34619.0 34876.0 35033.8 35135.6 35348.5 30057.2 30284.4 30577.2 30583.4 30980.0 22815.3 23503.8 23851.4 24561.6 25078.4 03:33:34 INFO - PID 22169 | 03:33:34 INFO - PID 22169 | [#2] jquery.html Cycles:180 Average:34950.17 Median:2380.30 stddev:82541.17 (3467.7%) stddev-sans-first:82732.38 03:33:34 INFO - PID 22169 | Values: 580.8 587.7 588.6 589.1 601.9 21787.0 22664.4 22712.0 22745.9 22794.5 24150.0 25624.9 26597.0 26639.2 26936.7 6504.5 6694.4 6735.0 6744.9 6748.6 5764.2 6336.6 6505.5 6596.1 6604.7 6223.6 6310.0 6318.4 6322.1 6328.1 6268.4 6277.1 6301.1 6318.4 6319.2 5823.9 5870.9 5871.4 5896.8 5910.2 27160.9 29292.3 29986.0 30028.8 30762.2 1869.4 1919.3 1940.4 1940.6 1943.7 18080.2 18639.3 19198.8 19363.6 19553.5 2271.8 2314.5 2379.8 2380.8 2381.7 132242.0 136303.3 136391.3 136483.0 136790.0 13889.8 14964.6 15320.7 15353.5 15495.8 23236.9 23282.3 23344.3 23350.4 23405.2 9725.4 9781.7 9788.8 9792.7 9832.6 8849.3 8895.8 8921.0 8952.2 9016.9 8763.6 8990.4 9249.6 9289.6 9411.2 2637.5 2685.1 2711.7 2735.3 2738.0 914.8 943.4 958.8 982.3 999.5 19371.4 19820.4 22858.8 24248.8 24354.6 986.8 1021.6 1031.3 1044.5 1061.5 10915.3 11416.7 11650.7 13137.8 13985.2 477953.0 482712.0 494773.0 495455.0 500460.0 111079.4 118661.4 119085.4 120806.4 121249.4 1222.2 1230.9 1259.9 1264.8 1274.9 19806.8 19852.4 21155.3 21772.9 21809.2 56898.7 58187.0 58232.0 58469.0 58966.4 66451.7 66738.0 67314.3 67455.3 68324.7 12459.6 13119.0 14446.3 14858.9 15022.4 23252.2 23966.2 24002.4 24576.5 24862.1 19136.7 19255.9 19315.3 19340.9 19625.0 15953.0 16344.8 17009.4 17147.8 17856.4 19473.8 19996.1 20012.9 20111.3 20183.1 14762.6 14890.9 14904.6 14944.4 14959.3 18479.4 18485.7 19084.2 19090.8 19252.0 03:33:34 INFO - PID 22169 | 03:33:34 INFO - PID 22169 | [#3] mootools.html Cycles:180 Average:8566.93 Median:2532.66 stddev:5798.79 (229.0%) stddev-sans-first:5789.97 03:33:34 INFO - PID 22169 | Values: 1387.3 1436.5 1455.9 1462.2 1467.5 13383.3 13971.5 13975.9 14008.6 14015.9 13805.2 14639.0 14798.9 14813.3 14871.1 2477.3 2518.6 2529.8 2533.1 2534.0 2357.5 2428.0 2586.2 2594.3 2708.0 2690.4 2696.3 2721.1 2728.6 2730.6 2574.0 2607.8 2618.9 2618.9 2622.7 2532.2 2583.7 2588.7 2593.0 2595.6 13738.0 14093.8 14113.5 14158.0 14163.7 7652.5 7913.4 7932.7 7939.2 7970.1 4468.2 4679.2 5157.7 5161.7 5285.4 1830.4 1852.7 1872.2 1886.0 1903.7 20665.2 21132.2 22245.3 22486.2 22522.4 5855.1 5932.6 6051.5 6070.2 6124.7 15011.5 15091.3 15102.8 15173.0 15239.5 7434.3 7569.1 7588.9 7597.4 7619.1 6970.1 7027.1 7049.6 7136.1 7196.4 4750.2 4813.0 4855.9 4928.3 4972.1 1238.0 1256.4 1258.5 1264.5 1276.6 884.9 912.6 931.3 948.4 949.0 7232.1 7288.4 7340.5 8513.5 8636.8 966.7 983.3 998.9 1000.0 1017.9 5133.5 5201.6 5292.2 5312.5 5390.6 18740.8 19561.1 19718.9 19729.8 19743.5 18920.4 19042.4 19374.6 19374.8 19379.6 9330.1 10190.8 11032.7 11189.8 11239.3 7108.4 8203.0 8416.7 8504.5 8559.7 15662.0 15967.1 16046.5 16325.8 16547.5 16516.7 16519.3 16710.9 17172.2 17681.4 10411.2 10432.6 10476.6 10493.8 10564.5 12152.4 12426.5 12501.4 12606.2 12620.9 10372.2 10406.5 10411.1 10534.0 10869.6 10146.9 10656.6 10727.9 10906.2 11189.7 9107.7 9231.1 9275.4 9276.1 9337.0 6657.1 6944.2 7080.8 7149.0 7161.1 6730.5 6905.4 7423.9 7428.3 7448.5 03:33:34 INFO - PID 22169 | 03:33:34 INFO - PID 22169 | [#4] prototype.html Cycles:180 Average:5354.20 Median:5929.14 stddev:1502.66 (25.3%) stddev-sans-first:1461.68 03:33:34 INFO - PID 22169 | Values: 480.8 505.4 529.1 533.1 533.3 5995.8 6005.0 6050.6 6055.5 6133.8 5698.6 5898.9 5949.5 5975.7 6005.8 4810.8 4825.7 4841.8 4842.6 4860.6 4653.8 4789.8 4791.0 4803.7 4823.3 4741.6 4747.8 4758.9 4770.9 4814.2 4716.5 4735.2 4735.2 4750.6 4762.7 4274.9 4286.6 4316.6 4331.8 4341.3 5752.2 5801.6 5833.4 5891.8 5908.8 5467.7 5472.6 5480.2 5540.3 5549.5 6298.5 6335.2 6338.7 6368.8 6404.0 4670.3 4674.4 4739.2 4747.0 4748.4 6510.2 6518.9 6544.4 6578.0 6605.3 4832.9 4835.6 4869.6 4895.7 4927.2 4918.9 4927.9 4969.6 4984.8 5008.7 5459.4 5478.4 5486.3 5539.3 5545.2 6121.8 6307.8 6333.3 6377.3 6471.8 1636.7 1665.4 1709.5 1712.7 1739.6 972.9 1148.6 1202.6 1214.3 1219.3 5458.8 5597.6 5599.8 5616.6 5631.4 6338.8 6390.7 6476.2 6512.3 6517.9 5556.9 5651.6 5672.4 5676.7 5679.6 3421.8 3432.6 3460.4 3479.6 3500.6 6288.4 6301.8 6330.0 6333.4 6354.3 6677.7 6734.0 6749.0 6754.4 6768.0 6266.0 6323.7 6348.8 6380.3 6400.8 6465.5 6496.4 6501.4 6502.6 6535.8 6389.8 6457.8 6519.2 6521.5 6557.6 6288.7 6337.9 6358.5 6377.5 6387.9 5210.3 5337.4 5344.8 5365.9 5390.6 6543.5 6640.7 6643.2 6648.1 6649.3 6314.5 6341.4 6361.7 6389.6 6431.9 6367.3 6382.3 6383.8 6413.8 6423.9 6197.9 6233.5 6314.9 6325.6 6343.3 6379.9 6406.6 6437.9 6462.7 6463.0 5952.3 6063.2 6079.3 6162.4 6198.1 03:33:34 INFO - PID 22169 | 03:33:34 INFO - PID 22169 | [#5] yui.html Cycles:180 Average:22497.44 Median:20310.64 stddev:28876.70 (142.2%) stddev-sans-first:28912.19 03:33:34 INFO - PID 22169 | Values: 905.4 914.5 927.2 930.5 939.7 16080.2 16745.7 16794.4 16842.0 16966.7 19943.0 20941.9 21828.8 21886.0 22031.3 993.3 1010.3 1012.9 1013.1 1013.3 978.7 1066.6 1071.1 1076.5 1080.0 1108.9 1113.5 1113.5 1114.2 1117.2 1109.8 1114.2 1114.6 1115.1 1116.3 817.6 818.8 819.5 819.9 820.4 19045.6 19287.1 19348.5 19425.2 19797.4 20678.3 20877.8 21226.5 21386.5 21391.5 16316.2 16442.1 16549.9 16557.8 16649.6 3576.1 3587.0 3605.7 3608.0 3608.0 110369.0 113419.4 113966.4 119276.0 122687.4 16111.2 16495.7 16575.3 16687.4 16723.0 29650.0 30141.7 30356.5 30451.4 30567.8 8081.6 8538.6 8583.6 8683.4 8754.8 4086.6 4214.4 4237.1 4250.3 4252.5 4405.6 5074.4 5237.1 5814.9 5868.1 1045.8 1067.1 1072.1 1072.6 1081.5 657.3 669.2 699.5 703.7 704.3 12841.3 13414.0 13583.9 13804.1 13882.7 668.6 694.6 707.6 718.0 723.5 5047.9 5387.7 5400.1 5442.7 5636.0 91777.0 96972.0 99306.5 100374.5 102460.5 81206.2 83113.0 84148.0 85994.6 89563.1 75375.6 76356.0 77523.6 79340.0 80327.6 11355.9 11854.6 12259.5 12328.6 12553.6 36323.3 36989.6 37004.6 39128.6 39769.2 63009.0 64326.7 66878.0 67741.0 71114.1 18781.7 18902.1 19070.1 19291.9 19305.6 21450.0 21484.5 21722.0 21725.6 21733.2 18421.6 18665.3 19139.5 19150.4 19403.8 18862.8 18930.4 19065.0 19539.6 19652.8 18349.0 18505.2 18654.4 19070.6 19366.4 13071.3 13894.5 13968.3 14348.5 14565.0 13419.5 13968.9 14619.2 14651.6 14835.4 03:33:34 INFO - PID 22169 | -------- Summary: end -------- 03:33:34 INFO - PID 22169 | 03:33:34 INFO - TEST-INFO | 22169: exit 0 03:33:35 INFO - TEST-OK | dromaeo_css | took 1113962ms 03:33:35 INFO - TEST-START | kraken 03:33:35 INFO - Initialising browser for kraken test... 03:33:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55741/getInfo.html -profile /tmp/tmp8q3SR5/profile 03:33:35 INFO - TEST-INFO | started process 22548 (/builds/slave/test/build/application/firefox/firefox http://localhost:55741/getInfo.html) 03:33:41 INFO - TEST-INFO | 22548: exit 0 03:33:41 INFO - Browser initialized. 03:33:41 INFO - Running cycle 1/1 for kraken test... 03:33:41 INFO - TEST-INFO | started process 22778 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8q3SR5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:52 INFO - PID 22778 | RSS: Main: 176173056 03:33:52 INFO - PID 22778 | 03:33:55 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55741/tests/kraken/driver.html?testName=audio-beat-detection) 03:33:56 INFO - PID 22778 | RSS: Main: 180105216 03:33:56 INFO - PID 22778 | 03:33:58 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55741/tests/kraken/driver.html?testName=audio-dft) 03:33:59 INFO - PID 22778 | RSS: Main: 181547008 03:33:59 INFO - PID 22778 | 03:34:02 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55741/tests/kraken/driver.html?testName=audio-fft) 03:34:03 INFO - PID 22778 | RSS: Main: 174628864 03:34:03 INFO - PID 22778 | 03:34:05 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55741/tests/kraken/driver.html?testName=audio-oscillator) 03:34:05 INFO - PID 22778 | RSS: Main: 175226880 03:34:05 INFO - PID 22778 | 03:34:08 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55741/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:34:08 INFO - PID 22778 | RSS: Main: 175460352 03:34:08 INFO - PID 22778 | 03:34:11 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55741/tests/kraken/driver.html?testName=imaging-darkroom) 03:34:12 INFO - PID 22778 | RSS: Main: 177754112 03:34:12 INFO - PID 22778 | 03:34:16 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55741/tests/kraken/driver.html?testName=imaging-desaturate) 03:34:16 INFO - PID 22778 | RSS: Main: 178372608 03:34:16 INFO - PID 22778 | 03:34:19 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55741/tests/kraken/driver.html?testName=json-parse-financial) 03:34:20 INFO - PID 22778 | RSS: Main: 179044352 03:34:20 INFO - PID 22778 | 03:34:21 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55741/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:34:22 INFO - PID 22778 | RSS: Main: 178413568 03:34:22 INFO - PID 22778 | 03:34:24 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:34:24 INFO - PID 22778 | RSS: Main: 178872320 03:34:24 INFO - PID 22778 | 03:34:26 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:34:27 INFO - PID 22778 | RSS: Main: 178307072 03:34:27 INFO - PID 22778 | 03:34:30 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:34:31 INFO - PID 22778 | RSS: Main: 179662848 03:34:31 INFO - PID 22778 | 03:34:34 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:34:34 INFO - PID 22778 | RSS: Main: 179343360 03:34:34 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | Cycle 1(1): loaded http://localhost:55741/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55741/tests/kraken/driver.html?testName=ai-astar) 03:34:36 INFO - PID 22778 | RSS: Main: 181837824 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | __start_tp_report 03:34:36 INFO - PID 22778 | _x_x_mozilla_page_load 03:34:36 INFO - PID 22778 | _x_x_mozilla_page_load_details 03:34:36 INFO - PID 22778 | |i|pagename|runs| 03:34:36 INFO - PID 22778 | |0;ai-astar;100;118;102;111;109;114;109;102;110;110 03:34:36 INFO - PID 22778 | |1;audio-beat-detection;154;119;147;171;126;159;150;121;173;123 03:34:36 INFO - PID 22778 | |2;audio-dft;165;166;163;164;165;166;172;167;163;166 03:34:36 INFO - PID 22778 | |3;audio-fft;76;78;75;174;75;75;74;87;104;77 03:34:36 INFO - PID 22778 | |4;audio-oscillator;82;82;145;82;82;83;129;82;82;152 03:34:36 INFO - PID 22778 | |5;imaging-gaussian-blur;117;116;114;116;115;115;115;115;114;119 03:34:36 INFO - PID 22778 | |6;imaging-darkroom;152;153;153;154;152;151;153;152;152;163 03:34:36 INFO - PID 22778 | |7;imaging-desaturate;100;95;95;99;95;96;95;94;94;94 03:34:36 INFO - PID 22778 | |8;json-parse-financial;55;55;54;54;54;53;53;54;54;58 03:34:36 INFO - PID 22778 | |9;json-stringify-tinderbox;55;55;57;55;55;56;54;58;55;54 03:34:36 INFO - PID 22778 | |10;stanford-crypto-aes;80;77;86;78;78;79;78;78;79;78 03:34:36 INFO - PID 22778 | |11;stanford-crypto-ccm;129;128;130;145;132;126;126;128;124;178 03:34:36 INFO - PID 22778 | |12;stanford-crypto-pbkdf2;190;175;176;189;180;178;180;175;179;178 03:34:36 INFO - PID 22778 | |13;stanford-crypto-sha256-iterative;72;72;73;69;74;73;69;71;72;75 03:34:36 INFO - PID 22778 | __end_tp_report 03:34:36 INFO - PID 22778 | __start_cc_report 03:34:36 INFO - PID 22778 | _x_x_mozilla_cycle_collect,955 03:34:36 INFO - PID 22778 | __end_cc_report 03:34:36 INFO - PID 22778 | __startTimestamp1500806076903__endTimestamp 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | ------- Summary: start ------- 03:34:36 INFO - PID 22778 | Number of tests: 14 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:5.66 (5.1%) stddev-sans-first:5.10 03:34:36 INFO - PID 22778 | Values: 100.0 118.0 102.0 111.0 109.0 114.0 109.0 102.0 110.0 110.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:152.00 stddev:20.70 (13.6%) stddev-sans-first:21.66 03:34:36 INFO - PID 22778 | Values: 154.0 119.0 147.0 171.0 126.0 159.0 150.0 121.0 173.0 123.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#2] audio-dft Cycles:10 Average:165.70 Median:166.00 stddev:2.58 (1.6%) stddev-sans-first:2.73 03:34:36 INFO - PID 22778 | Values: 165.0 166.0 163.0 164.0 165.0 166.0 172.0 167.0 163.0 166.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#3] audio-fft Cycles:10 Average:89.50 Median:75.50 stddev:31.09 (41.2%) stddev-sans-first:32.59 03:34:36 INFO - PID 22778 | Values: 76.0 78.0 75.0 174.0 75.0 75.0 74.0 87.0 104.0 77.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#4] audio-oscillator Cycles:10 Average:100.10 Median:82.00 stddev:29.44 (35.9%) stddev-sans-first:30.49 03:34:36 INFO - PID 22778 | Values: 82.0 82.0 145.0 82.0 82.0 83.0 129.0 82.0 82.0 152.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#5] imaging-gaussian-blur Cycles:10 Average:115.60 Median:115.50 stddev:1.51 (1.3%) stddev-sans-first:1.51 03:34:36 INFO - PID 22778 | Values: 117.0 116.0 114.0 116.0 115.0 115.0 115.0 115.0 114.0 119.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#6] imaging-darkroom Cycles:10 Average:153.50 Median:153.00 stddev:3.44 (2.2%) stddev-sans-first:3.61 03:34:36 INFO - PID 22778 | Values: 152.0 153.0 153.0 154.0 152.0 151.0 153.0 152.0 152.0 163.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:95.00 stddev:2.11 (2.2%) stddev-sans-first:1.56 03:34:36 INFO - PID 22778 | Values: 100.0 95.0 95.0 99.0 95.0 96.0 95.0 94.0 94.0 94.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.00 stddev:1.43 (2.6%) stddev-sans-first:1.50 03:34:36 INFO - PID 22778 | Values: 55.0 55.0 54.0 54.0 54.0 53.0 53.0 54.0 54.0 58.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.00 stddev:1.26 (2.3%) stddev-sans-first:1.33 03:34:36 INFO - PID 22778 | Values: 55.0 55.0 57.0 55.0 55.0 56.0 54.0 58.0 55.0 54.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:78.50 stddev:2.56 (3.3%) stddev-sans-first:2.69 03:34:36 INFO - PID 22778 | Values: 80.0 77.0 86.0 78.0 78.0 79.0 78.0 78.0 79.0 78.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:129.50 stddev:16.32 (12.6%) stddev-sans-first:17.19 03:34:36 INFO - PID 22778 | Values: 129.0 128.0 130.0 145.0 132.0 126.0 126.0 128.0 124.0 178.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:179.50 stddev:5.33 (3.0%) stddev-sans-first:4.26 03:34:36 INFO - PID 22778 | Values: 190.0 175.0 176.0 189.0 180.0 178.0 180.0 175.0 179.0 178.0 03:34:36 INFO - PID 22778 | 03:34:36 INFO - PID 22778 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.50 stddev:1.94 (2.7%) stddev-sans-first:2.06 03:34:36 INFO - PID 22778 | Values: 72.0 72.0 73.0 69.0 74.0 73.0 69.0 71.0 72.0 75.0 03:34:36 INFO - PID 22778 | -------- Summary: end -------- 03:34:36 INFO - PID 22778 | 03:34:37 INFO - PID 22778 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:34:37 INFO - TEST-INFO | 22778: exit 0 03:34:37 INFO - TEST-OK | kraken | took 62685ms 03:34:37 INFO - SUITE-END | took 1176s 03:34:38 INFO - Completed test suite (00:19:36) 03:34:38 INFO - javascript benchmark 03:34:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8399.277148759867, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.769617278703, 3122.0477754284943, 3123.7813353065267, 3153.9369212615748, 3173.412918610057, 5937.228160339156, 6044.727987240573, 6123.173371594833, 6170.413810687977, 6218.098375735527, 6020.6086604370685, 6067.544934129935, 6123.785667501638, 6128.11142384354, 6186.319504854462, 5451.781928722847, 5513.917291240635, 5614.242077319571, 5616.157576363557, 5670.3479099903425, 5489.890202195954, 5575.526080283181, 5659.0, 5696.601237913327, 5697.373288938214, 5558.416366281523, 5558.972205138969, 5609.943900560983, 5615.719214039302, 5676.772929082832, 5387.919181212285, 5467.6719396836315, 5577.2191893135, 5597.496225339739, 5621.7751289948765, 5417.891642167135, 5485.040117979338, 5547.195656629807, 5573.331200255995, 5573.6098473106895, 5992.370801065869, 6017.187679663233, 6112.205413296243, 6119.44924956756, 6129.080637904305, 6316.273628532732, 6430.260520040209, 6524.673766311713, 6526.0, 6547.738090476375, 6320.74717011319, 6453.096566480696, 6546.869062618769, 6587.736490540373, 6616.966915165442, 6028.0355143176885, 6035.245594300756, 6118.724657390384, 6144.815655530341, 6173.1048997895505, 6471.0940468334475, 6541.574797638138, 6670.099536562502, 6795.3204679531655, 6796.286389929085, 6261.060840873814, 6298.874022519524, 6299.559030867887, 6311.431971122529, 6349.269833969152, 6314.368563143649, 6406.6476343800605, 6420.5184611154355, 6452.612843229421, 6475.4819614430735, 6450.9354906450335, 6505.447037001908, 6507.934920650828, 6579.605223686594, 6589.0, 6493.155889734304, 6559.47524198063, 6563.0, 6629.270780214172, 6641.634710090895, 5205.531502164823, 5306.442823503554, 5321.148616221386, 5404.891997140577, 5412.972935135299, 4596.931046034312, 4669.813207471731, 4672.719636821802, 4683.96952670412, 4699.177643912301, 5705.82882513517, 5719.57103217252, 5778.3643799182055, 5791.305043394819, 5813.186153938452, 6376.043593460925, 6593.3736295051895, 6614.636195009224, 6674.16572928384, 6697.330266973361, 5633.859153521113, 5656.4060773619, 5656.91514627281, 5665.093585026459, 5720.8283751487525, 5785.218995435646, 5787.88424231513, 5797.0, 5819.388964158787, 5831.0, 6297.338779428185, 6354.555181137276, 6408.743650254031, 6416.839579010469, 6423.42189202974, 6433.099366088658, 6578.76974305897, 6654.73381064752, 6662.333766623299, 6669.266380698023, 6205.0, 6223.439890409885, 6255.437010668879, 6289.716962736779, 6315.147455093504, 6451.48388128958, 6463.482921366373, 6464.967675161594, 6473.482121430368, 6512.479001679949, 6615.106960560262, 6628.171478565179, 6696.866062678621, 6710.456594983084, 6726.495512836459, 6245.937540624717, 6268.341824108403, 6335.588186767845, 6340.239171299289, 6488.708008139551, 6167.814965551041, 6293.244810622755, 6305.337939516285, 6366.395192456709, 6494.415502604788, 6122.081687746873, 6263.749450021948, 6390.616563006234, 6392.105105285357, 6401.807945761635, 6350.396712312323, 6478.125453063776, 6523.869522609616, 6557.278699343164, 6567.310432404529, 6243.687815609111, 6263.812085637438, 6326.6520341381665, 6356.491480681627, 6366.236051673829], "value": 5973.511104628517, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.8042989252687, 834.1241696218968, 866.146845357323, 870.7213691618684, 1128.9661310160698, 30332.696673033264, 40331.39502907455, 40994.0, 41187.0, 41238.175236495255, 41463.58536414635, 41529.792351038275, 41762.373564396556, 41951.79024104875, 41999.370009449885, 7398.7410440634585, 7447.813804654873, 7581.241875812402, 7582.2796834300925, 7588.0, 7423.294786995254, 7469.813254668649, 7474.177840437547, 7500.0, 7546.660400282, 7459.962700186518, 7487.064116985377, 7487.812804679872, 7494.138174109966, 7531.887021694679, 7425.108986921577, 7452.664630091659, 7487.064116985377, 7495.28794764502, 7501.4748967572295, 7429.21993190718, 7484.700611975514, 7506.812329691801, 7514.624268786593, 7514.849703005909, 37895.810520947496, 37936.43095353572, 37987.0, 37990.81004594987, 38132.42801357982, 3464.7055000325004, 3514.1039035046156, 3538.6284440133672, 3554.573451185848, 3569.1790888095625, 30376.0, 30389.848050759825, 30503.389932201233, 30737.846310768527, 30803.229919252197, 4813.687110337817, 4900.264960255954, 4904.215325547895, 4956.727379994099, 5027.547520723116, 177278.0, 179530.10234948873, 179959.10020449813, 181336.0933195339, 181536.0, 46934.295985560246, 46957.765211173726, 46976.7651161742, 47115.76442117767, 47479.762601186776, 49570.0, 49591.0, 49649.75175124101, 49718.0, 49851.75074124679, 14727.779083313759, 14975.176365300013, 15076.623084422978, 15088.471903483325, 15107.4712385066, 10826.945865270623, 11085.0, 11950.760984780256, 12121.939390303169, 12255.69360765988, 14118.364673589713, 14233.64415889611, 14266.785998210034, 14469.710605787825, 14553.490627827976, 5527.723613819293, 5645.181448689999, 5698.686572238566, 5783.508401785811, 5816.2551234629445, 991.6777047459605, 998.0, 1007.9193664506822, 1022.749426390539, 1029.7991891581219, 22011.559768804535, 22259.77740222577, 23078.53842923132, 29140.562891556645, 29542.556861647092, 1093.4969913839723, 1124.668222874254, 1129.9435028248554, 1130.1072152999038, 1147.403350257878, 11932.22440541362, 12556.81164782529, 12687.746245075046, 15592.064476131469, 15785.68428631444, 230497.0, 232946.0, 235202.0, 235667.0, 235738.0, 54722.0, 55484.16773748316, 55641.0, 55874.441255587735, 55954.0, 1450.6808502129516, 1479.8816094712397, 1516.1282262698992, 1520.908745475275, 1527.4959263443038, 26527.734722652527, 27643.585346220225, 27678.861605691844, 28150.85924570364, 28219.43561128725, 50505.49494505155, 51273.743631281606, 51670.74164629153, 51686.74156629193, 51744.741276293375, 214265.0, 215793.0, 217102.0, 218612.0, 219187.0, 31923.680763193, 32958.17604559905, 35658.28683426265, 35813.46279805753, 36232.45651315285, 42787.14425711531, 42894.57105428906, 43039.56960430356, 43194.784026079666, 43557.564424355354, 29815.701842981292, 30668.386632267677, 31435.84282078575, 31734.0, 31757.206069847514, 30097.849510752305, 30601.387972240875, 30908.918187863317, 31135.53296700506, 31345.52981705322, 34619.0, 34876.0, 35033.82483087568, 35135.64864351324, 35348.46977295394, 30057.248568785955, 30284.394312114076, 30577.23556911095, 30583.388332232786, 30980.0, 22815.31554053381, 23503.76496235084, 23851.403714907265, 24561.63157552674, 25078.37304067413], "value": 17281.79209170258, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.7734983356489, 587.667967598307, 588.5938702295418, 589.1045610671778, 601.8585632376393, 21787.0, 22664.43338916528, 22712.0, 22745.886270568666, 22794.54410911783, 24150.0, 25624.87187564064, 26597.0, 26639.200823975265, 26936.730632693667, 6504.544681872271, 6694.397504224618, 6734.966325168391, 6744.898826517606, 6748.561343512656, 5764.221830052931, 6336.556441049129, 6505.479561635081, 6596.076549283104, 6604.735810567571, 6223.564350495467, 6309.968450157743, 6318.431341179293, 6322.0832979217985, 6328.145700330466, 6268.435840774307, 6277.0584412338285, 6301.086342480337, 6318.431341179293, 6319.210098737658, 5823.941760582382, 5870.941290587082, 5871.442212989759, 5896.793612223594, 5910.202122713422, 27160.864195679093, 29292.267693307625, 29986.0, 30028.84985575058, 30762.23094422635, 1869.44851268876, 1919.280269898788, 1940.4372731907729, 1940.6118776244666, 1943.6695761720541, 18080.18639161241, 18639.347622833135, 19198.808011919842, 19363.61272774551, 19553.511162220915, 2271.7955384015518, 2314.5486630107134, 2379.785819276256, 2380.809535237177, 2381.7022872140983, 132242.0, 136303.31848340793, 136391.31804341014, 136483.0, 136789.999999999, 13889.777635578259, 14964.625884352978, 15320.693586128215, 15353.462628808162, 15495.767563486557, 23236.883815580815, 23282.301530954097, 23344.299671009558, 23350.416239593807, 23405.191377034866, 9725.416475011521, 9781.657641982496, 9788.755281118029, 9792.657256995972, 9832.557534910946, 8849.336299777542, 8895.822083558292, 8921.0, 8952.194302512806, 9016.864747028669, 8763.582202940857, 8990.415622984485, 9249.583768730423, 9289.581968811419, 9411.247100231965, 2637.4593208392234, 2685.1273336165823, 2711.701712811589, 2735.317779565553, 2738.0, 914.7758799094264, 943.4056544376998, 958.755517343073, 982.297657175109, 999.4508511806671, 19371.4188574343, 19820.40538783839, 22858.771412285663, 24248.75751242465, 24354.63468047981, 986.8322385194534, 1021.6373187518324, 1031.3347890610514, 1044.5090807320548, 1061.4736926115795, 10915.345079295268, 11416.744158142597, 11650.6504804856, 13137.81759641637, 13985.23081230542, 477953.0, 482712.0, 494773.0, 495455.0, 500460.0, 111079.44460277808, 118661.40669296599, 119085.40457297658, 120806.3959680196, 121249.39375303243, 1222.1506053292876, 1230.9384530773605, 1259.9307038112993, 1264.797632378815, 1274.9107562470724, 19806.801931980495, 19852.404427867186, 21155.259565915734, 21772.891135544854, 21809.23667671624, 56898.7155064222, 58187.0, 58232.0, 58468.9999999983, 58966.41033589781, 66451.66774166099, 66738.0, 67314.32685673081, 67455.3254467449, 68324.6583767078, 12459.563915262923, 13119.0, 14446.349914254093, 14858.851411485746, 15022.399104035716, 23252.186173483846, 23966.161184358465, 24002.39994000164, 24576.50846983086, 24862.12982545602, 19136.712949305493, 19255.903720481307, 19315.323963661205, 19340.903295483433, 19625.0, 15953.0, 16344.754828677342, 17009.404670836462, 17147.828521714622, 17856.375026873997, 19473.8052619472, 19996.100175491847, 20012.89993550023, 20111.296104636855, 20183.091760870502, 14762.557123286319, 14890.925545372203, 14904.62738431548, 14944.402223910922, 14959.326830292446, 18479.353222637143, 18485.72271415903, 19084.23663053518, 19090.809091908905, 19252.0], "value": 12066.761020054111, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1387.3479464651614, 1436.5403071017272, 1455.9199244041574, 1462.1519518679163, 1467.493714668439, 13383.263920484369, 13971.510997115103, 13975.860241397608, 14008.64978375541, 14015.859841401583, 13805.240711760849, 14639.0, 14798.926005369985, 14813.25933703316, 14871.107733535995, 2477.3063542208165, 2518.64738936549, 2529.8355606885584, 2533.1387328308465, 2533.961990570134, 2357.4695693468916, 2427.9514409711796, 2586.237060067285, 2594.286571192918, 2708.0, 2690.3946612012237, 2696.312440327714, 2721.0612338743103, 2728.6084097110515, 2730.5767606021, 2574.0476023871192, 2607.804414668898, 2618.8559629220385, 2618.9083382081535, 2622.659054322926, 2532.189699296226, 2583.7028741694758, 2588.7022992355933, 2593.0276146445085, 2595.6495873057274, 13738.0, 14093.78859317111, 14113.506027288995, 14158.0, 14163.716725665532, 7652.540847549165, 7913.366930645535, 7932.682692692285, 7939.166387529342, 7970.083440404312, 4468.151051300275, 4679.15775160471, 5157.6647517911215, 5161.716105614228, 5285.392179899284, 1830.432565904574, 1852.6943054396008, 1872.1762424533163, 1885.990570047141, 1903.714442833572, 20665.17339306426, 21132.15471381143, 22245.332640020824, 22486.212982545534, 22522.43693907649, 5855.121731740273, 5932.614380065282, 6051.515878729691, 6070.150178974947, 6124.663143527148, 15011.474598389223, 15091.320890559951, 15102.848971510364, 15173.0, 15239.542813715385, 7434.256574342522, 7569.053868266466, 7588.924110758821, 7597.430192735456, 7619.123800762984, 6970.093887794555, 7027.051348068047, 7049.612271325126, 7136.107986501687, 7196.388306993964, 4750.192467280571, 4813.013332266877, 4855.927161092586, 4928.334674818925, 4972.129877271463, 1237.9938100309441, 1256.447163248168, 1258.4525731306728, 1264.4562837979756, 1276.6297773645724, 884.8539990901558, 912.5574096563162, 931.2782593490099, 948.3882895532342, 948.9952550237205, 7232.0959880015, 7288.416926645856, 7340.4861659684375, 8513.489190648581, 8636.827263454696, 966.6761634852263, 983.3215081593678, 998.8801343838641, 999.9900001000043, 1017.8778546574458, 5133.512316329943, 5201.557867581222, 5292.206169074592, 5312.512496500986, 5390.622656414013, 18740.81259187418, 19561.119749611018, 19718.90140549288, 19729.802701973083, 19743.506412339808, 18920.43238702841, 19042.42872713821, 19374.612507749767, 19374.80625193758, 19379.612407751767, 9330.1136392044, 10190.796184076276, 11032.669019929415, 11189.776204475866, 11239.325640461599, 7108.395786358217, 8203.015638123463, 8416.705415310435, 8504.53225072627, 8559.700410485602, 15662.0, 15967.121808300655, 16046.518604441886, 16325.836741632907, 16547.503574892773, 16516.669666606842, 16519.33922643129, 16710.916445417693, 17172.22724977354, 17681.38115165963, 10411.167106631603, 10432.582696692047, 10476.580936762444, 10493.790124197321, 10564.471776410996, 12152.392380381123, 12426.502939882303, 12501.437435315614, 12606.243625382507, 12620.936895315464, 10372.170226382023, 10406.531706073396, 10411.11505522039, 10534.0, 10869.565217391215, 10146.898531014891, 10656.62701805433, 10727.892721072689, 10906.182036347464, 11189.720256993314, 9107.681231157143, 9231.076892310715, 9275.350725449423, 9276.11876871696, 9337.0, 6657.1345725055435, 6944.236134025355, 7080.752173673896, 7148.964255178691, 7161.104861892263, 6730.528862979544, 6905.37851593359, 7423.925760742323, 7428.257174282745, 7448.47860649771], "value": 6275.09140293088, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.81479153885664, 505.40109969685903, 529.1005291005291, 533.1256738948126, 533.3386600615238, 5995.820125396245, 6004.979153543897, 6050.60671056381, 6055.5155587552945, 6133.754649814002, 5698.629589076707, 5898.88202235955, 5949.464548190662, 5975.701214939247, 6005.819825405234, 4810.783514741827, 4825.686330388531, 4841.757912104398, 4842.61259099273, 4860.552594376141, 4653.767311634405, 4789.808407663707, 4790.9520904791025, 4803.711777293356, 4823.300621409893, 4741.596964258042, 4747.8338258160975, 4758.905451746084, 4770.904581908359, 4814.183702534022, 4716.457607375161, 4735.195016847109, 4735.218688916325, 4750.643701722367, 4762.714237145765, 4274.850380236708, 4286.592773686495, 4316.611504964569, 4331.848385306499, 4341.261985462479, 5752.245565102642, 5801.564882633777, 5833.358330583633, 5891.79378721747, 5908.822735317947, 5467.726613669341, 5472.5621950243885, 5480.205370221335, 5540.335159780811, 5549.5005449509335, 6298.496120310364, 6335.208098987627, 6338.651374174418, 6368.808935731936, 6403.990124641457, 4670.252759558488, 4674.415698037746, 4739.170645137087, 4747.0, 4748.3589715388325, 6510.18622672166, 6518.93481065188, 6544.4110030097045, 6577.980413035987, 6605.339466053404, 4832.903341933142, 4835.637327200474, 4869.586085182799, 4895.6817806843155, 4927.187014142698, 4918.90162196754, 4927.926081108786, 4969.577585905166, 4984.77568509418, 5008.724520151427, 5459.426760190202, 5478.424765399575, 5486.259354987025, 5539.2522009529, 5545.1682247663175, 6121.755129794848, 6307.842303942438, 6333.276691022812, 6377.266614339317, 6471.805845824632, 1636.6808472347777, 1665.4337525241476, 1709.4700642800772, 1712.6831536165848, 1739.6346767178782, 972.8832540095234, 1148.6439203846835, 1202.6392082375253, 1214.3078445286278, 1219.3171823778712, 5458.754356053987, 5597.552195824324, 5599.776008959596, 5616.606837521416, 5631.4087020863035, 6338.778142764981, 6390.740722231695, 6476.158099447041, 6512.34876512345, 6517.869642607121, 5556.91664625031, 5651.604387692904, 5672.376038635747, 5676.687782171937, 5679.574031947621, 3421.8460169292443, 3432.5880894292845, 3460.4290292102023, 3479.5998460176897, 3500.649935006479, 6288.434040936338, 6301.842453938688, 6330.0, 6333.429991300805, 6354.269259035178, 6677.732890684319, 6734.047126333407, 6749.0, 6754.425873800782, 6767.966160169168, 6266.0, 6323.747050117944, 6348.76199141163, 6380.298167201604, 6400.807975760735, 6465.450436712932, 6496.382843629847, 6501.414872661483, 6502.577332473374, 6535.8236466538665, 6389.808305750835, 6457.773977910751, 6519.185101862267, 6521.543491955517, 6557.573757705733, 6288.748450062129, 6337.8732425352155, 6358.491320694241, 6377.489800816016, 6387.872242555216, 5210.322658054429, 5337.412884582771, 5344.759485823225, 5365.9463405367005, 5390.622656414013, 6543.5419520633095, 6640.701168447335, 6643.2360278568585, 6648.069270302259, 6649.335066493312, 6314.547654039505, 6341.414646338415, 6361.681915904279, 6389.594289256356, 6431.871362572629, 6367.267764207176, 6382.266039405527, 6383.776567820104, 6413.775517856852, 6423.935760642334, 6197.876042479215, 6233.470155036691, 6314.8737025258315, 6325.588836725598, 6343.3339499351905, 6379.936200637934, 6406.551541392244, 6437.871242575216, 6462.676866156768, 6463.0, 5952.285725712942, 6063.211782468251, 6079.258178620683, 6162.445379915829, 6198.101275315144], "value": 4912.71688473615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.3526728389201, 914.542728635682, 927.188709878856, 930.4510338900047, 939.7180845746277, 16080.195990200487, 16745.748813767786, 16794.412195573143, 16842.0, 16966.745498817527, 19943.0, 20941.895290523564, 21828.781712182874, 21886.0, 22031.33905982819, 993.2997236947953, 1010.2625083688874, 1012.9442880641561, 1013.0882206014572, 1013.2552573858245, 978.7259567321162, 1066.6000249906285, 1071.0895738622187, 1076.4563895232895, 1080.0441609175896, 1108.8780234174235, 1113.465536542456, 1113.5100555755482, 1114.1810769084716, 1117.1677100560094, 1109.7835921995213, 1114.153243534911, 1114.5931734916737, 1115.1357697784201, 1116.268843907242, 817.6116344736262, 818.8485130250923, 819.5246756880995, 819.9344052475788, 820.3683163963715, 19045.61908761831, 19287.132079056475, 19348.516287092796, 19425.22299108034, 19797.40607781769, 20678.276260330967, 20877.791222087737, 21226.469338266514, 21386.46533836651, 21391.465213369636, 16316.184190790413, 16442.095684737335, 16549.91725041367, 16557.83442165587, 16649.583760406087, 3576.1059735066233, 3587.031501494608, 3605.7475976681644, 3607.981960090183, 3607.981960090183, 110369.0, 113419.43290283579, 113966.43016784945, 119276.0, 122687.3865630675, 16111.194440278174, 16495.670086598442, 16575.336986520644, 16687.415940442268, 16723.0, 29650.0, 30141.698583014328, 30356.482175891117, 30451.390972180434, 30567.847160764053, 8081.595920203967, 8538.615762290712, 8583.613737381833, 8683.435576687496, 8754.824903501894, 4086.6117718816663, 4214.367844823301, 4237.131388065439, 4250.341197114452, 4252.532221455637, 4405.647548196137, 5074.441811400743, 5237.0835103857435, 5814.912776308359, 5868.061110222344, 1045.811753884308, 1067.071647666535, 1072.088724584113, 1072.5602502973743, 1081.4808891732014, 657.3229573539262, 669.2470970158572, 699.4963626189136, 703.7185125949559, 704.2570088556622, 12841.293728845003, 13414.0, 13583.86416135826, 13804.102733322303, 13882.722345553033, 668.5687731413211, 694.6006046523169, 707.6178863413802, 717.996410017957, 723.4537923867447, 5047.899042019139, 5387.676739395649, 5400.108982018001, 5442.673439593637, 5635.985522605888, 91777.0, 96972.0, 99306.5034674822, 100374.49812751035, 102460.48769756104, 81206.18793812105, 83113.0, 84148.0, 85994.57002714946, 89563.10436895677, 75375.62312188404, 76356.0, 77523.61238193772, 79340.0, 80327.59836200898, 11355.943220283845, 11854.644360669194, 12259.509619615115, 12328.568500102454, 12553.601951161088, 36323.27353452969, 36989.63010369862, 37004.629953701195, 39128.608713912494, 39769.2046159081, 63009.0, 64326.67836660787, 66878.0, 67741.0, 71114.08872512061, 18781.718274226172, 18902.05489725536, 19070.141843617348, 19291.903540482206, 19305.613887722448, 21450.0, 21484.462888427915, 21722.0, 21725.565488689823, 21733.23933662314, 18421.63156736831, 18665.253389864254, 19139.521511962314, 19150.425487235407, 19403.8059619402, 18862.811371886655, 18930.43208703741, 19065.046747662283, 19539.609207816047, 19652.803471965097, 18349.0, 18505.167267473265, 18654.44036678902, 19070.618587628447, 19366.4190074298, 13071.346432678518, 13894.513692020731, 13968.301584920917, 14348.49780257686, 14565.0, 13419.45676247205, 13968.930155349564, 14619.19594422317, 14651.560453186421, 14835.365335492874], "value": 9142.644238221486, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1548.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 118.0, 102.0, 111.0, 109.0, 114.0, 109.0, 102.0, 110.0, 110.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 119.0, 147.0, 171.0, 126.0, 159.0, 150.0, 121.0, 173.0, 123.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 163.0, 164.0, 165.0, 166.0, 172.0, 167.0, 163.0, 166.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 75.0, 174.0, 75.0, 75.0, 74.0, 87.0, 104.0, 77.0], "value": 89.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 145.0, 82.0, 82.0, 83.0, 129.0, 82.0, 82.0, 152.0], "value": 100.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 114.0, 116.0, 115.0, 115.0, 115.0, 115.0, 114.0, 119.0], "value": 115.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 153.0, 154.0, 152.0, 151.0, 153.0, 152.0, 152.0, 163.0], "value": 153.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 95.0, 95.0, 99.0, 95.0, 96.0, 95.0, 94.0, 94.0, 94.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 54.0, 54.0, 53.0, 53.0, 54.0, 54.0, 58.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 55.0, 55.0, 56.0, 54.0, 58.0, 55.0, 54.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 86.0, 78.0, 78.0, 79.0, 78.0, 78.0, 79.0, 78.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 128.0, 130.0, 145.0, 132.0, 126.0, 126.0, 128.0, 124.0, 178.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 175.0, 176.0, 189.0, 180.0, 178.0, 180.0, 175.0, 179.0, 178.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 73.0, 69.0, 74.0, 73.0, 69.0, 71.0, 72.0, 75.0], "value": 72.0, "unit": "score"}]}]} 03:34:38 INFO - Return code: 0 03:34:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:34:38 INFO - # TBPL SUCCESS # 03:34:38 INFO - Running post-action listener: _package_coverage_data 03:34:38 INFO - Running post-action listener: _resource_record_post_action 03:34:38 INFO - [mozharness: 2017-07-23 10:34:38.173235Z] Finished run-tests step (success) 03:34:38 INFO - Running post-run listener: _resource_record_post_run 03:34:38 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 110592; Write bytes: 438546432; Read time: 448; Write time: 316624 03:34:38 INFO - TinderboxPrint: CPU usage
13.2% 03:34:38 INFO - TinderboxPrint: I/O read bytes / time
110,592 / 448 03:34:38 INFO - TinderboxPrint: I/O write bytes / time
438,546,432 / 316,624 03:34:38 INFO - TinderboxPrint: CPU idle
8,264.7 (86.8%) 03:34:38 INFO - TinderboxPrint: CPU user
1,206.9 (12.7%) 03:34:38 INFO - TinderboxPrint: Swap in / out
0 / 0 03:34:38 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107470848; Read time: 196; Write time: 99948 03:34:38 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:34:38 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 102400; Write bytes: 331075584; Read time: 248; Write time: 216676 03:34:38 INFO - Running post-run listener: _upload_blobber_files 03:34:38 INFO - Blob upload gear active. 03:34:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:34: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:34: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:34: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:34:39 INFO - (blobuploader) - INFO - Open directory for files ... 03:34:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:34:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:34:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:40 INFO - (blobuploader) - INFO - Done attempting. 03:34:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:34:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:40 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:34:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:40 INFO - (blobuploader) - INFO - Done attempting. 03:34:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:34:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:34:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:43 INFO - (blobuploader) - INFO - Done attempting. 03:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:34:44 INFO - (blobuploader) - INFO - Done attempting. 03:34:44 INFO - (blobuploader) - INFO - Iteration through files over. 03:34:44 INFO - Return code: 0 03:34:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:34:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:34:44 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d5e38d6647d1ae8d0ff5e813bc0684f3a66c74f2f7af0667b5d8d53720caca8696b75416bf33f4f7ff3ee0057a3ea22d0e65cbc00a1f190f4abd445a1633a43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77816d0ef737e68497496e79d576934014dc678adf5666befa5863b442fb221a64b068ef0be39f573204c8c5bcfe20931545737616c74f7c58cb4105d9f54e11", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017994bf6f2a32618d6818a6a1b92ca7809432e53f398d9d1315cc582cc1c3cb8e51705a5f7c46632bcdafd127529ac9586a5e53b92da3d446bfb943bd02e1d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a666303930daacfb7f0b996e3eade3507d20cc084fd81e7df32600adf732d8a993698dd6ce8bae504e6aedd741a744a24c3d8e93f9bdf6d4d5f01cac1d74cbe8"} 03:34:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:34:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:34:44 INFO - Contents: 03:34:44 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d5e38d6647d1ae8d0ff5e813bc0684f3a66c74f2f7af0667b5d8d53720caca8696b75416bf33f4f7ff3ee0057a3ea22d0e65cbc00a1f190f4abd445a1633a43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77816d0ef737e68497496e79d576934014dc678adf5666befa5863b442fb221a64b068ef0be39f573204c8c5bcfe20931545737616c74f7c58cb4105d9f54e11", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017994bf6f2a32618d6818a6a1b92ca7809432e53f398d9d1315cc582cc1c3cb8e51705a5f7c46632bcdafd127529ac9586a5e53b92da3d446bfb943bd02e1d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a666303930daacfb7f0b996e3eade3507d20cc084fd81e7df32600adf732d8a993698dd6ce8bae504e6aedd741a744a24c3d8e93f9bdf6d4d5f01cac1d74cbe8"} 03:34:44 INFO - Running post-run listener: copy_logs_to_upload_dir 03:34:44 INFO - Copying logs to upload dir... 03:34:44 INFO - mkdir: /builds/slave/test/build/upload/logs 03:34:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.825532 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-23 03:34:44.841730) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-23 03:34:44.845530) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002 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/4d5e38d6647d1ae8d0ff5e813bc0684f3a66c74f2f7af0667b5d8d53720caca8696b75416bf33f4f7ff3ee0057a3ea22d0e65cbc00a1f190f4abd445a1633a43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77816d0ef737e68497496e79d576934014dc678adf5666befa5863b442fb221a64b068ef0be39f573204c8c5bcfe20931545737616c74f7c58cb4105d9f54e11", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017994bf6f2a32618d6818a6a1b92ca7809432e53f398d9d1315cc582cc1c3cb8e51705a5f7c46632bcdafd127529ac9586a5e53b92da3d446bfb943bd02e1d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a666303930daacfb7f0b996e3eade3507d20cc084fd81e7df32600adf732d8a993698dd6ce8bae504e6aedd741a744a24c3d8e93f9bdf6d4d5f01cac1d74cbe8"} build_url:https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/ZDm6q-ewRU2QuG3j5f3Vqw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d5e38d6647d1ae8d0ff5e813bc0684f3a66c74f2f7af0667b5d8d53720caca8696b75416bf33f4f7ff3ee0057a3ea22d0e65cbc00a1f190f4abd445a1633a43", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77816d0ef737e68497496e79d576934014dc678adf5666befa5863b442fb221a64b068ef0be39f573204c8c5bcfe20931545737616c74f7c58cb4105d9f54e11", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/017994bf6f2a32618d6818a6a1b92ca7809432e53f398d9d1315cc582cc1c3cb8e51705a5f7c46632bcdafd127529ac9586a5e53b92da3d446bfb943bd02e1d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a666303930daacfb7f0b996e3eade3507d20cc084fd81e7df32600adf732d8a993698dd6ce8bae504e6aedd741a744a24c3d8e93f9bdf6d4d5f01cac1d74cbe8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-23 03:34:44.869795) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:34:44.870102) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1500804440.358137-1888403002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:34:44.919891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-23 03:34:44.920218) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-23 03:34:44.920511) ========= ========= Total master_lag: 0.50 =========