builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1502233260.11 results: success (0) revision: 1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:00.105317) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:00.105792) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:00.106061) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:00.125338) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:00.125734) ========= 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=62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-08 16:01:00-- 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% 110M=0s 2017-08-08 16:01:00 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150141 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:00.289208) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:00.289514) ========= 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=62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015209 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:00.341527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:00.343889) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961 --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 1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961 --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=62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-08 16:01:00,703 truncating revision to first 12 chars 2017-08-08 16:01:00,703 Setting DEBUG logging. 2017-08-08 16:01:00,703 attempt 1/10 2017-08-08 16:01:00,703 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1d042bcb2632?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-08 16:01:01,170 unpacking tar archive at: mozilla-central-1d042bcb2632/testing/mozharness/ program finished with exit code 0 elapsedTime=0.823965 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:01.180515) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:01.183976) ========= script_repo_revision: 1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:01.184409) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:01.184703) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-08 16:01:01.194633) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-08 16:01:01.195058) ========= /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=62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:01:01 INFO - MultiFileLogger online at 20170808 16:01:01 in /builds/slave/test 16:01:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:01:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:01:01 INFO - {'append_to_log': False, 16:01:01 INFO - 'base_work_dir': '/builds/slave/test', 16:01:01 INFO - 'blob_upload_branch': 'Firefox', 16:01:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:01:01 INFO - 'branch': 'Firefox', 16:01:01 INFO - 'buildbot_json_path': 'buildprops.json', 16:01:01 INFO - 'code_coverage': False, 16:01:01 INFO - 'config_files': ('talos/linux_config.py',), 16:01:01 INFO - 'default_actions': ('clobber', 16:01:01 INFO - 'read-buildbot-config', 16:01:01 INFO - 'download-and-extract', 16:01:01 INFO - 'populate-webroot', 16:01:01 INFO - 'create-virtualenv', 16:01:01 INFO - 'install', 16:01:01 INFO - 'setup-mitmproxy', 16:01:01 INFO - 'run-tests'), 16:01:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:01:01 INFO - 'disable_ccov_upload': False, 16:01:01 INFO - 'download_minidump_stackwalk': True, 16:01:01 INFO - 'download_symbols': 'ondemand', 16:01:01 INFO - 'enable_stylo': False, 16:01:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:01:01 INFO - 'tooltool.py': '/tools/tooltool.py', 16:01:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:01:01 INFO - '/tools/misc-python/virtualenv.py')}, 16:01:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:01:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:01:01 INFO - 'gecko_profile': False, 16:01:01 INFO - 'gecko_profile_interval': 0, 16:01:01 INFO - 'installer_path': 'installer.exe', 16:01:01 INFO - 'log_level': 'info', 16:01:01 INFO - 'log_name': 'talos', 16:01:01 INFO - 'log_to_console': True, 16:01:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:01:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:01:01 INFO - 'opt_config_files': (), 16:01:01 INFO - 'pip_index': False, 16:01:01 INFO - 'suite': 'dromaeojs-e10s', 16:01:01 INFO - 'system_bits': '32', 16:01:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:01:01 INFO - 'title': 'talos-linux64-ix-018', 16:01:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:01:01 INFO - 'use_talos_json': True, 16:01:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:01:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:01:01 INFO - 'work_dir': 'build'} 16:01:01 INFO - [mozharness: 2017-08-08 23:01:01.666572Z] Running clobber step. 16:01:01 INFO - Running pre-action listener: _resource_record_pre_action 16:01:01 INFO - Running main action method: clobber 16:01:01 INFO - rmtree: /builds/slave/test/build 16:01:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:01:02 INFO - Running post-action listener: _resource_record_post_action 16:01:02 INFO - [mozharness: 2017-08-08 23:01:02.708801Z] Finished clobber step (success) 16:01:02 INFO - [mozharness: 2017-08-08 23:01:02.708904Z] Running read-buildbot-config step. 16:01:02 INFO - Running pre-action listener: _resource_record_pre_action 16:01:02 INFO - Running main action method: read_buildbot_config 16:01:02 INFO - Using buildbot properties: 16:01:02 INFO - { 16:01:02 INFO - "project": "", 16:01:02 INFO - "product": "firefox", 16:01:02 INFO - "who": "kwierso@gmail.com", 16:01:02 INFO - "installer_path": "public/build/target.tar.bz2", 16:01:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 16:01:02 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:01:02 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 16:01:02 INFO - "stage_platform": "linux64-stylosequential", 16:01:02 INFO - "basedir": "/builds/slave/test", 16:01:02 INFO - "buildnumber": 25, 16:01:02 INFO - "platform": "ubuntu64_hw_styloseq", 16:01:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:01:02 INFO - "slavebuilddir": "test", 16:01:02 INFO - "taskId": "Vfqe0KyVQ0i0PDobPs2wXg", 16:01:02 INFO - "branch": "mozilla-central", 16:01:02 INFO - "script_repo_revision": "production", 16:01:02 INFO - "revision": "1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961", 16:01:02 INFO - "slavename": "talos-linux64-ix-018", 16:01:02 INFO - "repo_path": "mozilla-central" 16:01:02 INFO - } 16:01:02 INFO - Finding installer, test and symbols from parent task. 16:01:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vfqe0KyVQ0i0PDobPs2wXg'}, attempt #1 16:01:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Vfqe0KyVQ0i0PDobPs2wXg'}, attempt #1 16:01:04 INFO - Task dependencies: F7NQqaIQR2-2IEUa3S5RaA 16:01:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA'}, attempt #1 16:01:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2 16:01:05 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.test_packages.json 16:01:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.crashreporter-symbols.zip 16:01:05 INFO - Running post-action listener: _resource_record_post_action 16:01:05 INFO - [mozharness: 2017-08-08 23:01:05.039415Z] Finished read-buildbot-config step (success) 16:01:05 INFO - [mozharness: 2017-08-08 23:01:05.039640Z] Running download-and-extract step. 16:01:05 INFO - Running pre-action listener: _resource_record_pre_action 16:01:05 INFO - Running main action method: download_and_extract 16:01:05 INFO - mkdir: /builds/slave/test/build/tests 16:01:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:05 INFO - trying https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.test_packages.json 16:01:05 INFO - Downloading https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:01:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:01:06 INFO - Downloaded 989 bytes. 16:01:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:01:06 INFO - Using the following test package requirements: 16:01:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:01:06 INFO - u'common': [u'target.common.tests.zip'], 16:01:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:01:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:01:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:01:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:01:06 INFO - u'mozbase': [u'target.common.tests.zip'], 16:01:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:01:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:01:06 INFO - u'web-platform': [u'target.common.tests.zip', 16:01:06 INFO - u'target.web-platform.tests.tar.gz'], 16:01:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:01:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:01:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.common.tests.zip 16:01:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:01:06 INFO - Fetch https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.common.tests.zip into memory 16:01:07 INFO - Content-Length response header: 54285203 16:01:07 INFO - Bytes received: 54285203 16:01:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:01:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.common.tests.zip 16:01:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:01:18 INFO - Fetch https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.common.tests.zip into memory 16:01:19 INFO - Content-Length response header: 54285203 16:01:19 INFO - Bytes received: 54285203 16:01:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.talos.tests.zip 16:01:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:01:31 INFO - Fetch https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.talos.tests.zip into memory 16:01:32 INFO - Content-Length response header: 14496008 16:01:32 INFO - Bytes received: 14496008 16:01:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:32 INFO - trying https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2 16:01:32 INFO - Downloading https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:01:33 INFO - Downloaded 61959679 bytes. 16:01:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2 16:01:33 INFO - mkdir: /builds/slave/test/properties 16:01:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:01:33 INFO - Writing to file /builds/slave/test/properties/build_url 16:01:33 INFO - Contents: 16:01:33 INFO - build_url:https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2 16:01:33 INFO - Running post-action listener: _resource_record_post_action 16:01:33 INFO - Running post-action listener: set_extra_try_arguments 16:01:33 INFO - [mozharness: 2017-08-08 23:01:33.769505Z] Finished download-and-extract step (success) 16:01:33 INFO - [mozharness: 2017-08-08 23:01:33.769605Z] Running populate-webroot step. 16:01:33 INFO - Running pre-action listener: _resource_record_pre_action 16:01:33 INFO - Running main action method: populate_webroot 16:01:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:01:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:01:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:01:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:01:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:01:33 INFO - 'tests': ['damp', 'tps']}, 16:01:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:01:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:01:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:01:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:01:33 INFO - 'other-e10s': {'tests': ['a11yr', 16:01:33 INFO - 'ts_paint', 16:01:33 INFO - 'tpaint', 16:01:33 INFO - 'sessionrestore', 16:01:33 INFO - 'sessionrestore_many_windows', 16:01:33 INFO - 'sessionrestore_no_auto_restore', 16:01:33 INFO - 'tabpaint']}, 16:01:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:01:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:01:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:01:33 INFO - 'tsvgr_opacity', 16:01:33 INFO - 'tart', 16:01:33 INFO - 'tscrollx', 16:01:33 INFO - 'tsvg_static']}, 16:01:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:01:33 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:01:33 INFO - 'talos_options': ['--mitmproxy', 16:01:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:01:33 INFO - '--firstNonBlankPaint'], 16:01:33 INFO - 'tests': ['tp6_google', 16:01:33 INFO - 'tp6_youtube', 16:01:33 INFO - 'tp6_amazon', 16:01:33 INFO - 'tp6_facebook']}, 16:01:33 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:01:33 INFO - 'talos_options': ['--stylo', 16:01:33 INFO - '--mitmproxy', 16:01:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:01:33 INFO - '--firstNonBlankPaint'], 16:01:33 INFO - 'tests': ['tp6_google', 16:01:33 INFO - 'tp6_youtube', 16:01:33 INFO - 'tp6_amazon', 16:01:33 INFO - 'tp6_facebook']}, 16:01:33 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:01:33 INFO - 'talos_options': ['--stylo', 16:01:33 INFO - '--stylo-threads=1', 16:01:33 INFO - '--mitmproxy', 16:01:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:01:33 INFO - '--firstNonBlankPaint'], 16:01:33 INFO - 'tests': ['tp6_google', 16:01:33 INFO - 'tp6_youtube', 16:01:33 INFO - 'tp6_amazon', 16:01:33 INFO - 'tp6_facebook']}, 16:01:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:01:33 INFO - 'talos_options': ['--xperf_path', 16:01:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:01:33 INFO - 'tests': ['tp5n']}}} 16:01:33 INFO - Running post-action listener: _resource_record_post_action 16:01:33 INFO - [mozharness: 2017-08-08 23:01:33.778169Z] Finished populate-webroot step (success) 16:01:33 INFO - [mozharness: 2017-08-08 23:01:33.778260Z] Running create-virtualenv step. 16:01:33 INFO - Running pre-action listener: _resource_record_pre_action 16:01:33 INFO - Running main action method: create_virtualenv 16:01:33 INFO - Creating virtualenv /builds/slave/test/build/venv 16:01:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:01:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:01:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:01:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:01:33 INFO - Using real prefix '/usr' 16:01:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:01:34 INFO - Installing distribute.............................................................................................................................................................................................done. 16:01:36 INFO - Installing pip.................done. 16:01:36 INFO - Return code: 0 16:01:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:01:36 INFO - Reading from file tmpfile_stdout 16:01:36 INFO - Output received: 16:01:36 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:01:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01: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')]} 16:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:01:36 INFO - Using env: {'DISPLAY': ':0', 16:01:36 INFO - 'HOME': '/home/cltbld', 16:01:36 INFO - 'LANG': 'en_US.UTF-8', 16:01:36 INFO - 'LANGUAGE': 'en_US:en', 16:01:36 INFO - 'LOGNAME': 'cltbld', 16:01:36 INFO - 'MAIL': '/var/mail/cltbld', 16:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:36 INFO - 'MOZ_NO_REMOTE': '1', 16:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:36 INFO - 'NO_EM_RESTART': '1', 16:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:36 INFO - 'PWD': '/builds/slave/test', 16:01:36 INFO - 'SHELL': '/bin/bash', 16:01:36 INFO - 'SHLVL': '1', 16:01:36 INFO - 'TERM': 'linux', 16:01:36 INFO - 'TMOUT': '86400', 16:01:36 INFO - 'USER': 'cltbld', 16:01:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 16:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:36 INFO - '_': '/tools/buildbot/bin/python'} 16:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:01:36 INFO - Cleaning up... 16:01:36 INFO - Return code: 0 16:01:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01: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')]} 16:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:01:36 INFO - Using env: {'DISPLAY': ':0', 16:01:36 INFO - 'HOME': '/home/cltbld', 16:01:36 INFO - 'LANG': 'en_US.UTF-8', 16:01:36 INFO - 'LANGUAGE': 'en_US:en', 16:01:36 INFO - 'LOGNAME': 'cltbld', 16:01:36 INFO - 'MAIL': '/var/mail/cltbld', 16:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:36 INFO - 'MOZ_NO_REMOTE': '1', 16:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:36 INFO - 'NO_EM_RESTART': '1', 16:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:36 INFO - 'PWD': '/builds/slave/test', 16:01:36 INFO - 'SHELL': '/bin/bash', 16:01:36 INFO - 'SHLVL': '1', 16:01:36 INFO - 'TERM': 'linux', 16:01:36 INFO - 'TMOUT': '86400', 16:01:36 INFO - 'USER': 'cltbld', 16:01:36 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 16:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:36 INFO - '_': '/tools/buildbot/bin/python'} 16:01:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:37 INFO - Downloading/unpacking psutil>=3.1.1 16:01: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 16:01: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 16:01: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 16:01: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 16:01:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:01:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:38 INFO - Installing collected packages: psutil 16:01:38 INFO - Running setup.py install for psutil 16:01:38 INFO - building 'psutil._psutil_linux' extension 16:01:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:01:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:01:38 INFO - building 'psutil._psutil_posix' extension 16:01:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:01:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:01:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:01:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:01:38 INFO - Successfully installed psutil 16:01:38 INFO - Cleaning up... 16:01:38 INFO - Return code: 0 16:01:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:01:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:01:38 INFO - Using env: {'DISPLAY': ':0', 16:01:38 INFO - 'HOME': '/home/cltbld', 16:01:38 INFO - 'LANG': 'en_US.UTF-8', 16:01:38 INFO - 'LANGUAGE': 'en_US:en', 16:01:38 INFO - 'LOGNAME': 'cltbld', 16:01:38 INFO - 'MAIL': '/var/mail/cltbld', 16:01:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:38 INFO - 'MOZ_NO_REMOTE': '1', 16:01:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:38 INFO - 'NO_EM_RESTART': '1', 16:01:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:38 INFO - 'PWD': '/builds/slave/test', 16:01:38 INFO - 'SHELL': '/bin/bash', 16:01:38 INFO - 'SHLVL': '1', 16:01:38 INFO - 'TERM': 'linux', 16:01:38 INFO - 'TMOUT': '86400', 16:01:38 INFO - 'USER': 'cltbld', 16:01:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 16:01:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:38 INFO - '_': '/tools/buildbot/bin/python'} 16:01:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:01:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:01:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:01:40 INFO - Installing collected packages: mozsystemmonitor 16:01:40 INFO - Running setup.py install for mozsystemmonitor 16:01:40 INFO - Successfully installed mozsystemmonitor 16:01:40 INFO - Cleaning up... 16:01:40 INFO - Return code: 0 16:01:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:01:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:01:40 INFO - Using env: {'DISPLAY': ':0', 16:01:40 INFO - 'HOME': '/home/cltbld', 16:01:40 INFO - 'LANG': 'en_US.UTF-8', 16:01:40 INFO - 'LANGUAGE': 'en_US:en', 16:01:40 INFO - 'LOGNAME': 'cltbld', 16:01:40 INFO - 'MAIL': '/var/mail/cltbld', 16:01:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:40 INFO - 'MOZ_NO_REMOTE': '1', 16:01:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:40 INFO - 'NO_EM_RESTART': '1', 16:01:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:40 INFO - 'PWD': '/builds/slave/test', 16:01:40 INFO - 'SHELL': '/bin/bash', 16:01:40 INFO - 'SHLVL': '1', 16:01:40 INFO - 'TERM': 'linux', 16:01:40 INFO - 'TMOUT': '86400', 16:01:40 INFO - 'USER': 'cltbld', 16:01:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 16:01:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:40 INFO - '_': '/tools/buildbot/bin/python'} 16:01:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:40 INFO - Downloading/unpacking jsonschema==2.5.1 16:01: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 16:01: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 16:01: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 16:01: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 16:01:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:01:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:41 INFO - Downloading functools32-3.2.3-2.tar.gz 16:01:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:01:41 INFO - warning: no files found matching '*.txt' 16:01:41 INFO - no previously-included directories found matching 'build' 16:01:41 INFO - no previously-included directories found matching 'dist' 16:01:41 INFO - no previously-included directories found matching '.git*' 16:01:41 INFO - Installing collected packages: jsonschema, functools32 16:01:41 INFO - Running setup.py install for functools32 16:01:41 INFO - warning: no files found matching '*.txt' 16:01:41 INFO - no previously-included directories found matching 'build' 16:01:41 INFO - no previously-included directories found matching 'dist' 16:01:41 INFO - no previously-included directories found matching '.git*' 16:01:41 INFO - Successfully installed jsonschema functools32 16:01:41 INFO - Cleaning up... 16:01:41 INFO - Return code: 0 16:01:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:41 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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:01:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:01:41 INFO - Using env: {'DISPLAY': ':0', 16:01:41 INFO - 'HOME': '/home/cltbld', 16:01:41 INFO - 'LANG': 'en_US.UTF-8', 16:01:41 INFO - 'LANGUAGE': 'en_US:en', 16:01:41 INFO - 'LOGNAME': 'cltbld', 16:01:41 INFO - 'MAIL': '/var/mail/cltbld', 16:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:41 INFO - 'MOZ_NO_REMOTE': '1', 16:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:41 INFO - 'NO_EM_RESTART': '1', 16:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:41 INFO - 'PWD': '/builds/slave/test', 16:01:41 INFO - 'SHELL': '/bin/bash', 16:01:41 INFO - 'SHLVL': '1', 16:01:41 INFO - 'TERM': 'linux', 16:01:41 INFO - 'TMOUT': '86400', 16:01:41 INFO - 'USER': 'cltbld', 16:01:41 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 16:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:41 INFO - '_': '/tools/buildbot/bin/python'} 16:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:01:42 INFO - Cleaning up... 16:01:42 INFO - Return code: 0 16:01:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01: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')]} 16:01:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01: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', '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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:01: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 blobuploader==1.2.4 16:01:42 INFO - Using env: {'DISPLAY': ':0', 16:01:42 INFO - 'HOME': '/home/cltbld', 16:01:42 INFO - 'LANG': 'en_US.UTF-8', 16:01:42 INFO - 'LANGUAGE': 'en_US:en', 16:01:42 INFO - 'LOGNAME': 'cltbld', 16:01:42 INFO - 'MAIL': '/var/mail/cltbld', 16:01:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:42 INFO - 'MOZ_NO_REMOTE': '1', 16:01:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:42 INFO - 'NO_EM_RESTART': '1', 16:01:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:42 INFO - 'PWD': '/builds/slave/test', 16:01:42 INFO - 'SHELL': '/bin/bash', 16:01:42 INFO - 'SHLVL': '1', 16:01:42 INFO - 'TERM': 'linux', 16:01:42 INFO - 'TMOUT': '86400', 16:01:42 INFO - 'USER': 'cltbld', 16:01:42 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 16:01:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:42 INFO - '_': '/tools/buildbot/bin/python'} 16:01:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:42 INFO - Downloading/unpacking blobuploader==1.2.4 16:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:43 INFO - Downloading blobuploader-1.2.4.tar.gz 16:01:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:01:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:01:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:44 INFO - Downloading docopt-0.6.1.tar.gz 16:01:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:01:44 INFO - Installing collected packages: blobuploader, requests, docopt 16:01:44 INFO - Running setup.py install for blobuploader 16:01:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:01:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:01:44 INFO - Running setup.py install for requests 16:01:44 INFO - Running setup.py install for docopt 16:01:44 INFO - Successfully installed blobuploader requests docopt 16:01:44 INFO - Cleaning up... 16:01:44 INFO - Return code: 0 16:01:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:44 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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:01:44 INFO - Using env: {'DISPLAY': ':0', 16:01:44 INFO - 'HOME': '/home/cltbld', 16:01:44 INFO - 'LANG': 'en_US.UTF-8', 16:01:44 INFO - 'LANGUAGE': 'en_US:en', 16:01:44 INFO - 'LOGNAME': 'cltbld', 16:01:44 INFO - 'MAIL': '/var/mail/cltbld', 16:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:44 INFO - 'MOZ_NO_REMOTE': '1', 16:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:44 INFO - 'NO_EM_RESTART': '1', 16:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:44 INFO - 'PWD': '/builds/slave/test', 16:01:44 INFO - 'SHELL': '/bin/bash', 16:01:44 INFO - 'SHLVL': '1', 16:01:44 INFO - 'TERM': 'linux', 16:01:44 INFO - 'TMOUT': '86400', 16:01:44 INFO - 'USER': 'cltbld', 16:01:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 16:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:44 INFO - '_': '/tools/buildbot/bin/python'} 16:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:44 INFO - Running setup.py (path:/tmp/pip-b2v3XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:45 INFO - Running setup.py (path:/tmp/pip-cRzIsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:45 INFO - Running setup.py (path:/tmp/pip-4sEd3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:45 INFO - Running setup.py (path:/tmp/pip-7dPyig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:45 INFO - Running setup.py (path:/tmp/pip-zHbhpl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:45 INFO - Running setup.py (path:/tmp/pip-sruXO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:45 INFO - Running setup.py (path:/tmp/pip-sbPCM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:45 INFO - Running setup.py (path:/tmp/pip-jfP6h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:45 INFO - Running setup.py (path:/tmp/pip-CeJlI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:45 INFO - Running setup.py (path:/tmp/pip-4xI7Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:45 INFO - Running setup.py (path:/tmp/pip-A3VHSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:45 INFO - Running setup.py (path:/tmp/pip-niFeUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:45 INFO - Running setup.py (path:/tmp/pip-Cxc4DF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:45 INFO - Running setup.py (path:/tmp/pip-1hLDMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:45 INFO - Running setup.py (path:/tmp/pip-D7pnMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:46 INFO - Running setup.py (path:/tmp/pip-9ThD3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:46 INFO - Running setup.py (path:/tmp/pip-QXrq7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:01:46 INFO - Running setup.py install for manifestparser 16:01:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:01:46 INFO - Running setup.py install for mozcrash 16:01:46 INFO - Running setup.py install for mozdebug 16:01:46 INFO - Running setup.py install for mozdevice 16:01:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:01:46 INFO - Running setup.py install for mozfile 16:01:46 INFO - Running setup.py install for mozhttpd 16:01:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:01:46 INFO - Running setup.py install for mozinfo 16:01:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:01:46 INFO - Running setup.py install for mozInstall 16:01:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:01:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:01:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:01:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:01:46 INFO - Running setup.py install for mozleak 16:01:47 INFO - Running setup.py install for mozlog 16:01:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:01:47 INFO - Running setup.py install for moznetwork 16:01:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:01:47 INFO - Running setup.py install for mozprocess 16:01:47 INFO - Running setup.py install for mozprofile 16:01:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:01:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:01:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:01:47 INFO - Running setup.py install for mozrunner 16:01:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:01:47 INFO - Running setup.py install for mozscreenshot 16:01:47 INFO - Running setup.py install for moztest 16:01:47 INFO - Running setup.py install for mozversion 16:01:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:01:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:01:47 INFO - Cleaning up... 16:01:47 INFO - Return code: 0 16:01:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:47 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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:01:47 INFO - Using env: {'DISPLAY': ':0', 16:01:47 INFO - 'HOME': '/home/cltbld', 16:01:47 INFO - 'LANG': 'en_US.UTF-8', 16:01:47 INFO - 'LANGUAGE': 'en_US:en', 16:01:47 INFO - 'LOGNAME': 'cltbld', 16:01:47 INFO - 'MAIL': '/var/mail/cltbld', 16:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:47 INFO - 'MOZ_NO_REMOTE': '1', 16:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:47 INFO - 'NO_EM_RESTART': '1', 16:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:47 INFO - 'PWD': '/builds/slave/test', 16:01:47 INFO - 'SHELL': '/bin/bash', 16:01:47 INFO - 'SHLVL': '1', 16:01:47 INFO - 'TERM': 'linux', 16:01:47 INFO - 'TMOUT': '86400', 16:01:47 INFO - 'USER': 'cltbld', 16:01:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 16:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:47 INFO - '_': '/tools/buildbot/bin/python'} 16:01:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:01:48 INFO - Running setup.py (path:/tmp/pip-_nhqTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:01:48 INFO - Running setup.py (path:/tmp/pip-8fnIJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:01:48 INFO - Running setup.py (path:/tmp/pip-fQjhRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:01:48 INFO - Running setup.py (path:/tmp/pip-oYXiJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:01:48 INFO - Running setup.py (path:/tmp/pip-RaBeLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:01:48 INFO - Running setup.py (path:/tmp/pip-v8XFtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:01:48 INFO - Running setup.py (path:/tmp/pip-4KPn47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:01:48 INFO - Running setup.py (path:/tmp/pip-nzfD1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:01:48 INFO - Running setup.py (path:/tmp/pip-w2AbPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:01:48 INFO - Running setup.py (path:/tmp/pip-lOBOeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:01:48 INFO - Running setup.py (path:/tmp/pip-gD80xb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:01:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:01:48 INFO - Running setup.py (path:/tmp/pip-FVPRbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:01:49 INFO - Running setup.py (path:/tmp/pip-3jrlsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:01:49 INFO - Running setup.py (path:/tmp/pip-eqSzd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:49 INFO - Running setup.py (path:/tmp/pip-8ys3Og-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:01:49 INFO - Running setup.py (path:/tmp/pip-StJrRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:01:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:01:49 INFO - Running setup.py (path:/tmp/pip-bznIla-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:01:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:50 INFO - Downloading blessings-1.6.tar.gz 16:01:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:01:50 INFO - Installing collected packages: blessings 16:01:50 INFO - Running setup.py install for blessings 16:01:50 INFO - Successfully installed blessings 16:01:50 INFO - Cleaning up... 16:01:50 INFO - Return code: 0 16:01:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:01:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:50 INFO - Reading from file tmpfile_stdout 16:01:50 INFO - Current package versions: 16:01:50 INFO - argparse == 1.2.1 16:01:50 INFO - blessings == 1.6 16:01:50 INFO - blobuploader == 1.2.4 16:01:50 INFO - docopt == 0.6.1 16:01:50 INFO - functools32 == 3.2.3-2 16:01:50 INFO - jsonschema == 2.5.1 16:01:50 INFO - manifestparser == 1.1 16:01:50 INFO - mozInstall == 1.13 16:01:50 INFO - mozcrash == 1.0 16:01:50 INFO - mozdebug == 0.1 16:01:50 INFO - mozdevice == 0.51 16:01:50 INFO - mozfile == 1.2 16:01:50 INFO - mozhttpd == 0.7 16:01:50 INFO - mozinfo == 0.10 16:01:50 INFO - mozleak == 0.1 16:01:50 INFO - mozlog == 3.5 16:01:50 INFO - moznetwork == 0.27 16:01:50 INFO - mozprocess == 0.25 16:01:50 INFO - mozprofile == 0.28 16:01:50 INFO - mozrunner == 6.13 16:01:50 INFO - mozscreenshot == 0.1 16:01:50 INFO - mozsystemmonitor == 0.3 16:01:50 INFO - moztest == 0.8 16:01:50 INFO - mozversion == 1.4 16:01:50 INFO - psutil == 3.1.1 16:01:50 INFO - requests == 1.2.3 16:01:50 INFO - wsgiref == 0.1.2 16:01:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:50 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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:01:50 INFO - Using env: {'DISPLAY': ':0', 16:01:50 INFO - 'HOME': '/home/cltbld', 16:01:50 INFO - 'LANG': 'en_US.UTF-8', 16:01:50 INFO - 'LANGUAGE': 'en_US:en', 16:01:50 INFO - 'LOGNAME': 'cltbld', 16:01:50 INFO - 'MAIL': '/var/mail/cltbld', 16:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:50 INFO - 'MOZ_NO_REMOTE': '1', 16:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:50 INFO - 'NO_EM_RESTART': '1', 16:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:50 INFO - 'PWD': '/builds/slave/test', 16:01:50 INFO - 'SHELL': '/bin/bash', 16:01:50 INFO - 'SHLVL': '1', 16:01:50 INFO - 'TERM': 'linux', 16:01:50 INFO - 'TMOUT': '86400', 16:01:50 INFO - 'USER': 'cltbld', 16:01:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 16:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:50 INFO - '_': '/tools/buildbot/bin/python'} 16:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:01:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:01:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:01:52 INFO - Installing collected packages: simplejson 16:01:52 INFO - Running setup.py install for simplejson 16:01:52 INFO - building 'simplejson._speedups' extension 16:01:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 16:01:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 16:01:53 INFO - Successfully installed simplejson 16:01:53 INFO - Cleaning up... 16:01:53 INFO - Return code: 0 16:01:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:01: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')]} 16:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:01: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')]} 16:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:01:53 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 0x11c41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1390a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1533d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, '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': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:01:53 INFO - Using env: {'DISPLAY': ':0', 16:01:53 INFO - 'HOME': '/home/cltbld', 16:01:53 INFO - 'LANG': 'en_US.UTF-8', 16:01:53 INFO - 'LANGUAGE': 'en_US:en', 16:01:53 INFO - 'LOGNAME': 'cltbld', 16:01:53 INFO - 'MAIL': '/var/mail/cltbld', 16:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:01:53 INFO - 'MOZ_NO_REMOTE': '1', 16:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:01:53 INFO - 'NO_EM_RESTART': '1', 16:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:01:53 INFO - 'PWD': '/builds/slave/test', 16:01:53 INFO - 'SHELL': '/bin/bash', 16:01:53 INFO - 'SHLVL': '1', 16:01:53 INFO - 'TERM': 'linux', 16:01:53 INFO - 'TMOUT': '86400', 16:01:53 INFO - 'USER': 'cltbld', 16:01:53 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 16:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:01:53 INFO - '_': '/tools/buildbot/bin/python'} 16:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:01:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:01:53 INFO - Cleaning up... 16:01:53 INFO - Return code: 0 16:01:53 INFO - Running post-action listener: _resource_record_post_action 16:01:53 INFO - Running post-action listener: _start_resource_monitoring 16:01:53 INFO - Starting resource monitoring. 16:01:53 INFO - [mozharness: 2017-08-08 23:01:53.675620Z] Finished create-virtualenv step (success) 16:01:53 INFO - [mozharness: 2017-08-08 23:01:53.676095Z] Running install step. 16:01:53 INFO - Running pre-action listener: _resource_record_pre_action 16:01:53 INFO - Running main action method: install 16:01:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:01:53 INFO - Reading from file tmpfile_stdout 16:01:53 INFO - Detecting whether we're running mozinstall >=1.0... 16:01:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:01:54 INFO - Reading from file tmpfile_stdout 16:01:54 INFO - Output received: 16:01:54 INFO - Usage: mozinstall [options] installer 16:01:54 INFO - Options: 16:01:54 INFO - -h, --help show this help message and exit 16:01:54 INFO - -d DEST, --destination=DEST 16:01:54 INFO - Directory to install application into. [default: 16:01:54 INFO - "/builds/slave/test"] 16:01:54 INFO - --app=APP Application being installed. [default: firefox] 16:01:54 INFO - mkdir: /builds/slave/test/build/application 16:01:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:01:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:02:11 INFO - Reading from file tmpfile_stdout 16:02:11 INFO - Output received: 16:02:12 INFO - /builds/slave/test/build/application/firefox/firefox 16:02:12 INFO - Running post-action listener: _resource_record_post_action 16:02:12 INFO - [mozharness: 2017-08-08 23:02:12.000525Z] Finished install step (success) 16:02:12 INFO - [mozharness: 2017-08-08 23:02:12.000673Z] Running setup-mitmproxy step. 16:02:12 INFO - Running pre-action listener: _resource_record_pre_action 16:02:12 INFO - Running main action method: setup_mitmproxy 16:02:12 INFO - Skipping: mitmproxy is not required 16:02:12 INFO - Running post-action listener: _resource_record_post_action 16:02:12 INFO - [mozharness: 2017-08-08 23:02:12.001416Z] Finished setup-mitmproxy step (success) 16:02:12 INFO - [mozharness: 2017-08-08 23:02:12.001638Z] Running run-tests step. 16:02:12 INFO - Running pre-action listener: _resource_record_pre_action 16:02:12 INFO - Running pre-action listener: _set_gcov_prefix 16:02:12 INFO - Running main action method: run_tests 16:02:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:02:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:02:12 INFO - Python 2.7.3 16:02:12 INFO - Return code: 0 16:02:12 INFO - grabbing minidump binary from tooltool 16:02:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:02:12 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 0x1530eb0>, '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 0x1531db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1532240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:02:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:02:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:02:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:02:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:02:12 INFO - Return code: 0 16:02:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:02:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:02:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:02:12 INFO - ENV: RUST_BACKTRACE is now 1 16:02:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:02:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:02:12 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/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:02:12 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/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:02:12 INFO - Using env: {'DISPLAY': ':0', 16:02:12 INFO - 'HOME': '/home/cltbld', 16:02:12 INFO - 'LANG': 'en_US.UTF-8', 16:02:12 INFO - 'LANGUAGE': 'en_US:en', 16:02:12 INFO - 'LOGNAME': 'cltbld', 16:02:12 INFO - 'MAIL': '/var/mail/cltbld', 16:02:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:02:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:02:12 INFO - 'MOZ_NO_REMOTE': '1', 16:02:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:02:12 INFO - 'NO_EM_RESTART': '1', 16:02:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:02:12 INFO - 'PWD': '/builds/slave/test', 16:02:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:02:12 INFO - 'RUST_BACKTRACE': '1', 16:02:12 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:02:12 INFO - 'SHELL': '/bin/bash', 16:02:12 INFO - 'SHLVL': '1', 16:02:12 INFO - 'STYLO_FORCE_ENABLED': '1', 16:02:12 INFO - 'TERM': 'linux', 16:02:12 INFO - 'TMOUT': '86400', 16:02:12 INFO - 'USER': 'cltbld', 16:02:12 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374', 16:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:02:12 INFO - '_': '/tools/buildbot/bin/python'} 16:02:12 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/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:02:12 INFO - mozversion application_buildid: 20170808221439 16:02:12 INFO - mozversion application_changeset: 1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961 16:02:12 INFO - mozversion application_display_name: Nightly 16:02:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:02:12 INFO - mozversion application_name: Firefox 16:02:12 INFO - mozversion application_remotingname: firefox 16:02:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:02:12 INFO - mozversion application_vendor: Mozilla 16:02:12 INFO - mozversion application_version: 57.0a1 16:02:12 INFO - mozversion platform_buildid: 20170808221439 16:02:12 INFO - mozversion platform_changeset: 1d042bcb2632ea6a38fa08dbe21a6e8a0ee46961 16:02:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:02:12 INFO - mozversion platform_version: 57.0a1 16:02:12 INFO - using testdate: 1502233332 16:02:12 INFO - actual date: 1502233332 16:02:12 INFO - starting webserver on 'localhost:36936' 16:02:12 INFO - SUITE-START | Running 2 tests 16:02:12 INFO - TEST-START | dromaeo_css 16:02:12 INFO - Initialising browser for dromaeo_css test... 16:02:12 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36936/getInfo.html -profile /tmp/tmpEzkUKB/profile 16:02:12 INFO - TEST-INFO | started process 6275 (/builds/slave/test/build/application/firefox/firefox http://localhost:36936/getInfo.html) 16:02:18 INFO - TEST-INFO | 6275: exit 0 16:02:18 INFO - Browser initialized. 16:02:18 INFO - Running cycle 1/1 for dromaeo_css test... 16:02:18 INFO - TEST-INFO | started process 6505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEzkUKB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:02:19 INFO - PID 6505 | 16:02:19 INFO - PID 6505 | (/builds/slave/test/build/application/firefox/firefox:6560): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:02:19 INFO - PID 6505 | 16:02:30 INFO - PID 6505 | RSS: Main: 168308736 16:02:30 INFO - PID 6505 | 16:05:29 INFO - PID 6505 | Cycle 1(1): loaded http://localhost:36936/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36936/tests/dromaeo/cssquery-ext.html) 16:05:30 INFO - PID 6505 | RSS: Main: 175955968 16:05:30 INFO - PID 6505 | 16:08:32 INFO - PID 6505 | Cycle 1(1): loaded http://localhost:36936/tests/dromaeo/cssquery-ext.html (next: http://localhost:36936/tests/dromaeo/cssquery-jquery.html) 16:08:32 INFO - PID 6505 | RSS: Main: 171220992 16:08:32 INFO - PID 6505 | 16:11:34 INFO - PID 6505 | Cycle 1(1): loaded http://localhost:36936/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36936/tests/dromaeo/cssquery-mootools.html) 16:11:35 INFO - PID 6505 | RSS: Main: 173764608 16:11:35 INFO - PID 6505 | 16:14:37 INFO - PID 6505 | Cycle 1(1): loaded http://localhost:36936/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36936/tests/dromaeo/cssquery-prototype.html) 16:14:37 INFO - PID 6505 | RSS: Main: 174067712 16:14:37 INFO - PID 6505 | 16:17:41 INFO - PID 6505 | Cycle 1(1): loaded http://localhost:36936/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36936/tests/dromaeo/cssquery-yui.html) 16:17:42 INFO - PID 6505 | RSS: Main: 177115136 16:17:42 INFO - PID 6505 | 16:20:44 INFO - PID 6505 | Cycle 1(1): loaded http://localhost:36936/tests/dromaeo/cssquery-yui.html (next: http://localhost:36936/tests/dromaeo/cssquery-dojo.html) 16:20:44 INFO - PID 6505 | RSS: Main: 178077696 16:20:44 INFO - PID 6505 | 16:20:44 INFO - PID 6505 | __start_tp_report 16:20:44 INFO - PID 6505 | _x_x_mozilla_page_load 16:20:44 INFO - PID 6505 | _x_x_mozilla_page_load_details 16:20:44 INFO - PID 6505 | |i|pagename|runs| 16:20:44 INFO - PID 6505 | |0;dojo.html;3051.2982014136746;3136.4824803907354;3148.6379066407358;3191.9945217256563;3203.7276831469326;6225.626462412259;6230.096635987779;6292.5909815862;6319.6524191169465;6326.177596912406;6251.531135164858;6262.185915830935;6287.654179020152;6311.684415779216;6366.363363663643;5668.064769313079;5754.683492407916;5796.275465566804;5804;5819.709014549277;5615.410381909882;5681.744321505522;5732.541396688276;5748.798792042279;5766.942330576703;5700.201971723962;5702.201691763156;5705;5716.028275193206;5723.198752174699;5631.155326700987;5668.43315668434;5721.370649228582;5749.453801888814;5759.1937128802;5617.831465056014;5674.290713660793;5694.914576281359;5713.400092990218;5780.566457515703;6161.876762464725;6179.81460556184;6247.312795592481;6258.71835767387;6300.810975670737;6581.21025476941;6601.603903765741;6679.398854103154;6697.966510167466;6791.796246112624;6685.465162786965;6752.358525940028;6761.661916904135;6763.222229443628;6763.7632682855865;6252.437280644764;6260.624362538262;6271.498280137578;6276.995680691068;6302.621842689453;6945.513814032969;6950.20072691647;6955.269696681776;6965.756198533027;6988.510804243654;6521.543491955613;6630.86738265232;6640.634765087966;6643.86712265752;6646.26891041985;6627.304133066055;6705.195376554844;6706.094677218611;6773.559718618274;6780.796576102626;6536.738530458729;6615.900761488581;6657.667116644148;6736.629485378351;6750.561213521106;6581.045748366556;6708.161479815023;6710.698018589078;6720.9663951680905;6731.730730770812;5246.422893481714;5454.972725136428;5504.422035686195;5559.249501317351;5562.415946325658;4671.322658214608;4693.108309421199;4698.906021879611;4719.646026548023;4752.7385993769985;5785.363610002896;5788.913166302509;5889.676067816225;5893.381194974466;5894.2926848778425;6774.119364482585;6775.288594697585;6776.9322306777285;6797.354251346114;6808.285130061371;5723.77104915807;5777.913331300034;5821.79623713168;5844.298684157929;5855.648661080349;5915.852103697356;5921.911171332434;5923.378045305181;5964.522838173022;6013.947559177126;6380.202474690664;6490.350964903566;6526.771562995367;6609.570377925419;6622.437092847162;6715;6737.461003119836;6758.526903116931;6769.661516924232;6773.390394864486;6430.678466076584;6507.023946408077;6511.544191906521;6516.478681705547;6551.312112228147;6595.241547222131;6640.734370625314;6645.933540664725;6656.36764507371;6661.666916654051;6712.127423434922;6725.461963042847;6805.863882722417;6815.42068924147;6815.556988795713;6465.191851018622;6467.482601391972;6482.967585162044;6562.278149403466;6569.9014514783275;6578.539502234989;6593;6604.867902642017;6608.636524991171;6613.867722645617;6468.935310646833;6570.5729127606555;6571.244306904767;6571.310012448624;6584.506162037962;6555.246146693191;6594.307597702172;6599.274079851309;6646.767363142267;6708.362705542965;6292.496600271876;6385.68071596409;6398.168238129014;6478.125453063776;6486.351364863476 16:20:44 INFO - PID 6505 | |1;ext.html;817.6933649881295;856.1737922904396;876.6712482818942;885.2210055151468;1199.3883119608997;42935;43540.3468947966;43552.128957420835;43582.12835743287;43609.56390436095;44065;44435.55564444354;44443.333349999775;44451.77774111133;44468.77765611168;7775.222477752222;7823.921760782405;7861.174576669425;7890.842183156334;7939.364850811921;7772.494787838772;7893.250141236602;7899;7901.881471777928;7932;7238.203797582261;7910.841783164333;7919.406044546653;7922.960385198095;7928.048634163908;7818.061832580099;7861.292483676468;7866.803329916741;7872.527648341118;7878.09401918781;7607.391408687292;7802;7828.373730101578;7834.138244793068;7885.684572617089;39943.60056399428;40242.59757402447;40319.39520907189;40413;40476.59523404758;3579.3736096183325;3638.745287829853;3640.908977275563;3641.9453708194396;3643.2531331077066;32288.192795180308;32438.189045273823;32474.18814529632;32547;32671.019869403957;5157.767900444489;5170.922436163461;5181.663191892515;5196.740162991835;5199.194124910645;196470;197378;197683;198553;199285.99999999854;51558.74220628873;51588.48411515912;51670.22494662583;51879.48120518822;51884.22173667398;53722.46277537253;53949.460505395225;53968.73015634897;54126.18810717842;54140;15908.284127214303;15940;15956.2819673115;16004.359825607078;16014.119223442822;13104.951603871667;13118.344082795822;13123.803142952864;13132.737345253041;13143.211407315592;13156.473741050251;13442.395092220873;14880.181590012653;14887;15153.242337883063;5296.576273898079;5393.570703763506;5428.565714742811;5465.316835395575;5587.189857470644;1012.5899010900597;1012.6152062216458;1019.3832731197667;1023.1354505442889;1032.1587905856702;22876;23209.88395058014;23345.533089338118;23359.88320058389;23507.294781156594;1107.1751545098953;1126.8253420719802;1129.4747942206914;1134.0587312530579;1137.2323681514945;12296.446659900326;12543.184692994926;12640.367981600883;12644.873551264554;12652.797984191488;230695;232467;233003;233339;234133;55369;55696.72151639216;55797.442025580036;55915;56153;1454.2946670864621;1498.7377208988382;1499.8275198352328;1521.52072097289;1536;23243;23471.647925281475;23475.178368757013;23479.17822876191;23496.412589685395;38959.80520097382;39035.21929561449;39125.2174956505;39185;39198.216035679696;197557;198905;199218;199460;199489;33431.66568334286;33537.66462335443;33715.49426758551;33746.66253337435;36277.45583816192;42788.358174628025;43353.783231083646;43362;43655.78172109119;49008.2648760276;35775.46336804898;35823.104422389646;35827.82086089553;35861.462078068325;36136.81931590325;35011.82494087513;35433.82283088671;35630.465543016355;35792.28415431729;36283.637163628024;38457.807710961264;38595.614043860325;38762.612373877026;39252.607473924894;39450.60549394584;34378.484322735676;34807.4778878312;34911.12722181966;35087;35542;24317.39206519851;24347.51304973855;24976.37559061038;25230;25412.364690882874 16:20:44 INFO - PID 6505 | |2;jquery.html;588.1941739816452;588.4703766610053;590.477427476683;597.2206270816582;601.4707057789145;22722.88638556809;23132;24044.639330410035;24098.277051688434;24119.879400603015;26535.469290614175;27178.32054198646;27225.86387068062;27245;27352.863235683795;6578.440832529241;6696.363845434676;6758.05387245786;6760.898586521206;6766;6307.558470907038;6599.967000164993;6646.169228846395;7009.614471204081;7033;7006.964965175167;7007.929920700779;7027.262137475568;7029.789106326818;7040.04959330489;6965.930340696605;7013.473989450786;7017.3684368406575;7019.859602807941;7032;6893.724251029953;6897.310268973062;6910.585364878123;6913.032175495385;6920.100386949714;30847.228819279473;31546;33120.668793312;33351.83324083388;33369.83315083433;1942.2813558983125;1972.0731256309512;1973.2107157137116;1976.3873199308116;1976.8616196866226;20357.694634580494;20936.685949710765;21003;21080;21134.5773084539;2333.544958733031;2505.985076044205;2515.962260566093;2527.4692314613953;2583.935401614956;142103;145902;145979;146104;146310;21568.352949411543;21829.563408731738;22001.394700139404;22558.774412255996;22670.546589068126;45945.77027114843;45981;46060.3090953636;46117.30824037642;46158.30762538565;10791.733735915388;10998.450077496092;11290.266132701348;11366.374849383363;11388.715282117848;9146.725598232064;9177.862332065024;9192.770180745534;9219.631214751469;9293;11418.85811418868;11573.594924177612;11592;11814.46834892432;12264.141510094387;3978.8976676632074;4260.91478170441;4317.481902171759;4420.31485119807;4712.175369310357;956.660385563129;980.6959842448864;982.4596471940404;991.127807529384;1005.4671024357102;19647.705284420746;20149.19403223884;20445.79554204439;20674.173033078507;20990.265340713002;1057.2652006855162;1061.824798908187;1062.5006247063868;1069.2354966199205;1070.8929107089384;11407.657770266906;11456.083513318914;11474.311541307548;11501.942490287494;11507.424628768695;453782;461941;490991;493261;503330;119288.40355798166;121922.3903880475;122176;122419.3879030617;122687;1269.435101379877;1279.1429742072833;1305.08643949234;1317.6047185844209;1327.2368388176837;21251.574968500852;21330.360089197347;21517;21619.891900540395;21713.131474741465;55897;57357.13964290622;58169;58748;59422.405775943414;66074;66504.6674766623;66875;67132.32867671456;68460;12915;13333.666658333232;14792.556223313319;15271.236438178268;15317.310721017804;23661.881690591435;23870.641940371257;24230.75769242285;24368.147114850894;24671;18877.811221887605;18926.43220703381;19091.809081909003;19122.904385477985;19146.425607231806;17279.7408038877;17516.562085947953;17629.823701763333;17939.820601793814;18056.368027118988;19382.321618743277;19784.802151978296;20054.398368048984;20313.085911133738;20408.183672653522;14922.179280139697;15007.249637518298;15010.549683509513;15072;15077.623059423602;17072.658546829243;17269.65460690754;17286.481405557854;17394.565135871704;17398.913005434893 16:20:44 INFO - PID 6505 | |3;mootools.html;1364.924929128898;1392.8050072989784;1413.8656827601374;1419.5670320552233;1423.5658124272097;13873.445062197512;14434.783478247835;14487.927560362197;14503.854961450383;14511.129332240047;14017;14474.638134046654;14906.850931490682;14925.328360223788;14993;2653.6948250951195;2685.9194224173307;2687.946241075177;2702.6216329713857;2702.8378297302124;2479.454520005605;2569.357660584854;2582.19951814938;2642.8150029497942;2692.0712354237853;2572.2926195296254;2591.5464793661126;2595.8182927195103;2599.116300457844;2600.5319042572423;2483.081259933818;2523.079076137206;2523.3187039499417;2524.4193835417864;2603.7005744339453;2527.431327951196;2544.9491010179877;2548.4775620997652;2561.3724637463943;2600.700919394275;14077.084989475652;14230.715385692229;14231.928840355835;14344.42622295107;14352.354144063438;7367.668454919542;7525.811854703621;7588.089429268468;7656.042994625672;7670.808229794244;4856.360818919545;5041.899162016776;5176.482351764831;5179.896402071975;5214.634975551675;1654.8427899349542;1659.6929568029952;1679.17720317045;1695.042301099887;1710.076558658323;23818.880905595535;24028.39929001789;24103.638445423334;24133.276001719976;24142.879285603634;6087.3303936566945;6329.841753956188;6439.22729272481;6454.741810327534;6459.709313080923;15235.466758663393;15298.388064477296;15396.46112386061;15420.46028389001;16183;7378.741744038933;7598.0502437195355;7617.847643047108;7632.045994250719;7635.732749353746;6827.726890924308;7060.505764596429;7075.292470752884;7112.6443677815905;7131.251218622074;4682.601978831769;4808.519148085234;4850.5149485051215;4867.7322747249245;4869.099216644932;1371.067673981702;1372.478458185883;1380.882624976888;1459.3287087939455;1481.2593703148425;874.1608056266056;888.2449917570013;895.8790563273875;900.7748062984253;913.5386629751932;7614.961925190339;8020.558869262247;8075.717349892726;8082.838343233102;8129.918700813035;997.665781963036;1019.3221507697298;1022.4478781458079;1023.0945613132432;1027.9588816447258;4796.448408433075;4812.205986012339;4866.489018653061;4972.328735620717;5043.117454445457;19151;19200.423987280403;19685.803141968685;19696.507587310432;19870.403887883385;18935.43193704191;19358.322458713876;19526.804731952783;19620.411387658394;19621.21515139407;10689.893101069045;10712.196585256137;10905.236633435583;10919.689637243422;10922.672319830577;7775.339096176888;7830.33442157423;7845.097813751263;7870.449068565375;7883.763487095396;16497.587560311087;16920.830791691926;16955.866180327077;17038.57403564921;17111.22999465052;16680.332786688396;17017;17033.659326813147;17114.97310161394;17526.649467010844;11018.228723989243;11070.446477675923;11238.438078095898;11269.943650281695;11398.94300528492;12450.564230251897;12574;12574.37128143571;12590.811137833123;12590.937045314715;10548.894511054792;10550.103241224275;10715.35707857531;10831;10959.06847917936;9533.285003624895;9582;9668.516574171123;9775;9797.853032204664;8198.83602327962;8309.542975136426;8316.708915187939;8317.085120636604;8319.168083191875;6387.808365749035;6479.060536222127;6501.349865013461;6566.540342176193;6571.178602674666;6797.388235058868;6877.6217308048535;6908.44732421395;6944.305569443015;7058.435325174077 16:20:44 INFO - PID 6505 | |4;prototype.html;453.8252772682516;469.20235599480867;493.90552321256763;494.54748904752154;496.37208930702667;6303.180586523751;6303.810885673432;6376.489880809536;6392.520560957923;6400.743970241185;6006.9876591341845;6176.227971503562;6205.751769929208;6218.7201575929075;6247.7813276535335;4953.900921981558;4974.179260422026;4991.525805048533;5001.6998980061135;5030.899382012358;4806.591439727627;4903.387076615423;4965.180745177059;5001.349824522807;5038.319826823387;4928.753562321869;4944.357233559632;4952.727599981999;4964.379452568429;4984.950150498485;4930.975345123252;4936.654434189608;4953.257011448276;4982.9252561211615;4985.426675932278;4421.336799480072;4429.734215947021;4445.933311000305;4466.57567531084;4488.236999710024;6091.11678806575;6092.421219984139;6116.694165291718;6121.234845644294;6127.509799216052;5661.575381846337;5688.118341657008;5724.914126288109;5742.167385729088;5761.279840019997;6552.3120072392185;6589.275179730226;6627.536072474929;6647.501437392215;6682.599044057323;4859;4875.634327425421;4879.097366987084;4895.559399654048;4904.828331008398;6936.20233673129;6993.860122797516;7003.789886303419;7032;7072.913490520206;4874.878128046827;4929.802807887644;4940.925886111711;4945.826896058621;5010.423801262828;4970.130227210224;5030.270610761492;5039.916417970154;5047.141985862412;5053.9494605054215;5716.313687462209;5729.427057294321;5752.07966725322;5763.337216220105;5768.096528145702;6556.541042127005;6563.278039415661;6568.704408301638;6636.435902948207;6647.966760166169;1654.5367297156815;1712.2637265975502;1714.7942246930447;1736.47905628311;1742.3466200174935;1187.2401662935729;1189.4052973513244;1208.9542545697907;1209.4799236328463;1212.351392005273;5686.459786320293;5703.116017017369;5738.397468265772;5758.337791153987;5777.942220577825;6622.834429139214;6643.335666433318;6677.599344039276;6703.525224450613;6779.72881084761;5775.393583673737;5803.332616749128;5830.708464576839;5876.768726516901;5907.940920590825;3613.6928361089076;3645.65366290202;3656.1590834108306;3666.6333366663653;3668.6881615062484;6664.600123992576;6674.197966549004;6694.497912656473;6705.597664140168;6708.765193218312;7066.187388450291;7081.468889833283;7086.291370862976;7094.290570942864;7101.076860008166;6489.578177418547;6568.934310656928;6602.504812139013;6614.206295244601;6635.5023373247195;6808.923278399938;6847.144106986627;6859.279775623488;6871.793846184622;6896.586204827727;6838.281980391987;6840.384365407137;6843.520953533205;6844.28135045813;6868.690908909211;6545.901811472927;6636.13730215069;6667.566608170453;6667.799966001027;6674.699638516181;4897.240927656219;4929.630277729113;4934.7285899275885;5005.749712514433;5015.473375295687;6760.628165450751;6761.932380676327;6769.695363708744;6839.589624622538;6875.243723190345;6625.668716564249;6629.966850165718;6631.1379520662;6644.4020038196795;6682.3317668232785;6559.8024661736945;6641.203055633355;6669.866602668017;6707.195136583641;6722.529422940347;6281.4660753834605;6378.532937424511;6471.870562588816;6523.6738163092605;6533;6508.772192973223;6555.180602424697;6576.8355791105605;6602.854072426385;6613.66931653425;6350.650714210763;6383.265924418752;6393.680315984275;6448;6474.967625161844 16:20:44 INFO - PID 6505 | |5;yui.html;924.440713368412;930.1582068228253;945.791925776329;949.5679465843042;955.8470644696846;18908.99999999998;19547.609047819053;19775.80224197756;19898.20407183711;22051.33845984623;21118.788812111914;21501.139954401806;21789.237376691817;22071.227507037256;22073.779262207372;1012.8025035118155;1043.8173319669027;1046.0585473074218;1046.0585473074257;1046.1317106801337;1017.6692574913146;1055.5935964653586;1065.8028264771042;1065.9733506662317;1066.4188017530464;1116.9050630696402;1127.1264769803386;1127.689885281546;1127.7011591928147;1128.5767837061103;1118.4072441605963;1123.0454114003073;1125.5160281079134;1127.8251870960014;1128.1764312052167;822.1408627983711;822.4489591973393;823.7652269103337;824.0358780227149;826.4338927834452;17233.39683111085;17291.481255562354;17364.39224627132;17391.826081739146;20465.897670511702;21779.564408711896;21959.560808783735;22110.889445552668;22308.330750077523;22429.66355504669;16823.242954067096;17083.914580427143;17089.914550427293;17163.485095447155;17163.71272154581;3640.7087433005295;3694.058015206132;3694.741368104234;3696.1129328961124;3698.2418604186078;125202.37398812948;125385.37307313496;126419.36790316082;127988.36005820005;128425;16783.58041048959;16854.578635533966;16917.238724257437;17169.570760731083;17285.049322287396;30691.69308306933;31042.68957310443;31127.533087003714;31155.753769849405;31172.844135779174;7335.1197856257595;7732.536047837148;8732.170443807829;8845.51349675774;9167.72496825083;4113.321301985199;4179.791010449465;4184.916301673949;4186.309258972296;4196.790160492024;5376.354837419534;5420.91868621971;5428.864278393072;5518.475744804237;5555.2222688823595;1079.643717573199;1091.3942761767296;1102.6967583914327;1109.2789686703707;1115.938623375706;683.8085336105898;702.8032150997728;714.9106361704787;714.9320814522612;720.3768740039828;11937.70155746096;12147.878521214674;12467.251964882136;12501.124921255607;12743.044271679475;711.1821405383747;715.2990069731692;719.9820004499825;722.5303552690688;728.8615163118991;5529.557635389239;5558.44415558441;5638.4925356718095;5666.631668941588;5731.885362292731;112304;113365.43317283361;113774.43112784383;114787;117431;90034.54982725045;90895;92960.53519732493;95541;95615;81586;83183.58408207921;84381;84417;87240.12759872447;10773.838392423962;10795.73010674708;10932.180086493703;10934.179936504635;10991.945040274748;37193.81403092967;37878;38123.618763813116;38180.6181938177;39431.408528872664;48368.27447588219;48369.274460882414;48763.512364875896;48837.2674409877;49212.2618160735;16233.18834058316;16514.917425412797;16563.254653540378;16586.58533536671;16848.663026739643;21890.12439502402;21907.67138492956;22439.43901402478;22472.662910056035;22621.43446413853;17974.01142937151;18948.715769263195;19485.70771438401;19626.214951401784;20059.699104513737;19936.90031549833;20201.494962625464;20371.18515259373;20510.38468845937;20565.280215192397;19648.410547683594;19695.507612309233;19936.800631993494;20270.493237668587;20474.38576842697;14294.142351458946;14631.70736585241;14649.12105273687;14806.703865922405;15017.849821501644;15583.45457909013;15594.844051559792;15623.531294061197;15792.842071579596;15880.841191587937 16:20:44 INFO - PID 6505 | __end_tp_report 16:20:44 INFO - PID 6505 | __start_cc_report 16:20:44 INFO - PID 6505 | _x_x_mozilla_cycle_collect,360 16:20:44 INFO - PID 6505 | __end_cc_report 16:20:44 INFO - PID 6505 | __startTimestamp1502234444311__endTimestamp 16:20:44 INFO - PID 6505 | 16:20:44 INFO - PID 6505 | ------- Summary: start ------- 16:20:44 INFO - PID 6505 | Number of tests: 6 16:20:44 INFO - PID 6505 | 16:20:44 INFO - PID 6505 | [#0] dojo.html Cycles:165 Average:6191.61 Median:6468.94 stddev:733.97 (11.3%) stddev-sans-first:693.65 16:20:44 INFO - PID 6505 | Values: 3051.3 3136.5 3148.6 3192.0 3203.7 6225.6 6230.1 6292.6 6319.7 6326.2 6251.5 6262.2 6287.7 6311.7 6366.4 5668.1 5754.7 5796.3 5804.0 5819.7 5615.4 5681.7 5732.5 5748.8 5766.9 5700.2 5702.2 5705.0 5716.0 5723.2 5631.2 5668.4 5721.4 5749.5 5759.2 5617.8 5674.3 5694.9 5713.4 5780.6 6161.9 6179.8 6247.3 6258.7 6300.8 6581.2 6601.6 6679.4 6698.0 6791.8 6685.5 6752.4 6761.7 6763.2 6763.8 6252.4 6260.6 6271.5 6277.0 6302.6 6945.5 6950.2 6955.3 6965.8 6988.5 6521.5 6630.9 6640.6 6643.9 6646.3 6627.3 6705.2 6706.1 6773.6 6780.8 6536.7 6615.9 6657.7 6736.6 6750.6 6581.0 6708.2 6710.7 6721.0 6731.7 5246.4 5455.0 5504.4 5559.2 5562.4 4671.3 4693.1 4698.9 4719.6 4752.7 5785.4 5788.9 5889.7 5893.4 5894.3 6774.1 6775.3 6776.9 6797.4 6808.3 5723.8 5777.9 5821.8 5844.3 5855.6 5915.9 5921.9 5923.4 5964.5 6013.9 6380.2 6490.4 6526.8 6609.6 6622.4 6715.0 6737.5 6758.5 6769.7 6773.4 6430.7 6507.0 6511.5 6516.5 6551.3 6595.2 6640.7 6645.9 6656.4 6661.7 6712.1 6725.5 6805.9 6815.4 6815.6 6465.2 6467.5 6483.0 6562.3 6569.9 6578.5 6593.0 6604.9 6608.6 6613.9 6468.9 6570.6 6571.2 6571.3 6584.5 6555.2 6594.3 6599.3 6646.8 6708.4 6292.5 6385.7 6398.2 6478.1 6486.4 16:20:44 INFO - PID 6505 | 16:20:44 INFO - PID 6505 | [#1] ext.html Cycles:180 Average:38892.28 Median:36280.55 stddev:54547.24 (150.3%) stddev-sans-first:54625.34 16:20:44 INFO - PID 6505 | Values: 817.7 856.2 876.7 885.2 1199.4 42935.0 43540.3 43552.1 43582.1 43609.6 44065.0 44435.6 44443.3 44451.8 44468.8 7775.2 7823.9 7861.2 7890.8 7939.4 7772.5 7893.3 7899.0 7901.9 7932.0 7238.2 7910.8 7919.4 7923.0 7928.0 7818.1 7861.3 7866.8 7872.5 7878.1 7607.4 7802.0 7828.4 7834.1 7885.7 39943.6 40242.6 40319.4 40413.0 40476.6 3579.4 3638.7 3640.9 3641.9 3643.3 32288.2 32438.2 32474.2 32547.0 32671.0 5157.8 5170.9 5181.7 5196.7 5199.2 196470.0 197378.0 197683.0 198553.0 199286.0 51558.7 51588.5 51670.2 51879.5 51884.2 53722.5 53949.5 53968.7 54126.2 54140.0 15908.3 15940.0 15956.3 16004.4 16014.1 13105.0 13118.3 13123.8 13132.7 13143.2 13156.5 13442.4 14880.2 14887.0 15153.2 5296.6 5393.6 5428.6 5465.3 5587.2 1012.6 1012.6 1019.4 1023.1 1032.2 22876.0 23209.9 23345.5 23359.9 23507.3 1107.2 1126.8 1129.5 1134.1 1137.2 12296.4 12543.2 12640.4 12644.9 12652.8 230695.0 232467.0 233003.0 233339.0 234133.0 55369.0 55696.7 55797.4 55915.0 56153.0 1454.3 1498.7 1499.8 1521.5 1536.0 23243.0 23471.6 23475.2 23479.2 23496.4 38959.8 39035.2 39125.2 39185.0 39198.2 197557.0 198905.0 199218.0 199460.0 199489.0 33431.7 33537.7 33715.5 33746.7 36277.5 42788.4 43353.8 43362.0 43655.8 49008.3 35775.5 35823.1 35827.8 35861.5 36136.8 35011.8 35433.8 35630.5 35792.3 36283.6 38457.8 38595.6 38762.6 39252.6 39450.6 34378.5 34807.5 34911.1 35087.0 35542.0 24317.4 24347.5 24976.4 25230.0 25412.4 16:20:44 INFO - PID 6505 | 16:20:44 INFO - PID 6505 | [#2] jquery.html Cycles:180 Average:36246.50 Median:22696.72 stddev:81413.09 (358.7%) stddev-sans-first:81597.46 16:20:44 INFO - PID 6505 | Values: 588.2 588.5 590.5 597.2 601.5 22722.9 23132.0 24044.6 24098.3 24119.9 26535.5 27178.3 27225.9 27245.0 27352.9 6578.4 6696.4 6758.1 6760.9 6766.0 6307.6 6600.0 6646.2 7009.6 7033.0 7007.0 7007.9 7027.3 7029.8 7040.0 6965.9 7013.5 7017.4 7019.9 7032.0 6893.7 6897.3 6910.6 6913.0 6920.1 30847.2 31546.0 33120.7 33351.8 33369.8 1942.3 1972.1 1973.2 1976.4 1976.9 20357.7 20936.7 21003.0 21080.0 21134.6 2333.5 2506.0 2516.0 2527.5 2583.9 142103.0 145902.0 145979.0 146104.0 146310.0 21568.4 21829.6 22001.4 22558.8 22670.5 45945.8 45981.0 46060.3 46117.3 46158.3 10791.7 10998.5 11290.3 11366.4 11388.7 9146.7 9177.9 9192.8 9219.6 9293.0 11418.9 11573.6 11592.0 11814.5 12264.1 3978.9 4260.9 4317.5 4420.3 4712.2 956.7 980.7 982.5 991.1 1005.5 19647.7 20149.2 20445.8 20674.2 20990.3 1057.3 1061.8 1062.5 1069.2 1070.9 11407.7 11456.1 11474.3 11501.9 11507.4 453782.0 461941.0 490991.0 493261.0 503330.0 119288.4 121922.4 122176.0 122419.4 122687.0 1269.4 1279.1 1305.1 1317.6 1327.2 21251.6 21330.4 21517.0 21619.9 21713.1 55897.0 57357.1 58169.0 58748.0 59422.4 66074.0 66504.7 66875.0 67132.3 68460.0 12915.0 13333.7 14792.6 15271.2 15317.3 23661.9 23870.6 24230.8 24368.1 24671.0 18877.8 18926.4 19091.8 19122.9 19146.4 17279.7 17516.6 17629.8 17939.8 18056.4 19382.3 19784.8 20054.4 20313.1 20408.2 14922.2 15007.2 15010.5 15072.0 15077.6 17072.7 17269.7 17286.5 17394.6 17398.9 16:20:44 INFO - PID 6505 | 16:20:44 INFO - PID 6505 | [#3] mootools.html Cycles:180 Average:8637.70 Median:2546.71 stddev:6039.43 (237.1%) stddev-sans-first:6031.65 16:20:44 INFO - PID 6505 | Values: 1364.9 1392.8 1413.9 1419.6 1423.6 13873.4 14434.8 14487.9 14503.9 14511.1 14017.0 14474.6 14906.9 14925.3 14993.0 2653.7 2685.9 2687.9 2702.6 2702.8 2479.5 2569.4 2582.2 2642.8 2692.1 2572.3 2591.5 2595.8 2599.1 2600.5 2483.1 2523.1 2523.3 2524.4 2603.7 2527.4 2544.9 2548.5 2561.4 2600.7 14077.1 14230.7 14231.9 14344.4 14352.4 7367.7 7525.8 7588.1 7656.0 7670.8 4856.4 5041.9 5176.5 5179.9 5214.6 1654.8 1659.7 1679.2 1695.0 1710.1 23818.9 24028.4 24103.6 24133.3 24142.9 6087.3 6329.8 6439.2 6454.7 6459.7 15235.5 15298.4 15396.5 15420.5 16183.0 7378.7 7598.1 7617.8 7632.0 7635.7 6827.7 7060.5 7075.3 7112.6 7131.3 4682.6 4808.5 4850.5 4867.7 4869.1 1371.1 1372.5 1380.9 1459.3 1481.3 874.2 888.2 895.9 900.8 913.5 7615.0 8020.6 8075.7 8082.8 8129.9 997.7 1019.3 1022.4 1023.1 1028.0 4796.4 4812.2 4866.5 4972.3 5043.1 19151.0 19200.4 19685.8 19696.5 19870.4 18935.4 19358.3 19526.8 19620.4 19621.2 10689.9 10712.2 10905.2 10919.7 10922.7 7775.3 7830.3 7845.1 7870.4 7883.8 16497.6 16920.8 16955.9 17038.6 17111.2 16680.3 17017.0 17033.7 17115.0 17526.6 11018.2 11070.4 11238.4 11269.9 11398.9 12450.6 12574.0 12574.4 12590.8 12590.9 10548.9 10550.1 10715.4 10831.0 10959.1 9533.3 9582.0 9668.5 9775.0 9797.9 8198.8 8309.5 8316.7 8317.1 8319.2 6387.8 6479.1 6501.3 6566.5 6571.2 6797.4 6877.6 6908.4 6944.3 7058.4 16:20:44 INFO - PID 6505 | 16:20:44 INFO - PID 6505 | [#4] prototype.html Cycles:180 Average:5554.17 Median:6151.87 stddev:1586.24 (25.8%) stddev-sans-first:1543.80 16:20:44 INFO - PID 6505 | Values: 453.8 469.2 493.9 494.5 496.4 6303.2 6303.8 6376.5 6392.5 6400.7 6007.0 6176.2 6205.8 6218.7 6247.8 4953.9 4974.2 4991.5 5001.7 5030.9 4806.6 4903.4 4965.2 5001.3 5038.3 4928.8 4944.4 4952.7 4964.4 4985.0 4931.0 4936.7 4953.3 4982.9 4985.4 4421.3 4429.7 4445.9 4466.6 4488.2 6091.1 6092.4 6116.7 6121.2 6127.5 5661.6 5688.1 5724.9 5742.2 5761.3 6552.3 6589.3 6627.5 6647.5 6682.6 4859.0 4875.6 4879.1 4895.6 4904.8 6936.2 6993.9 7003.8 7032.0 7072.9 4874.9 4929.8 4940.9 4945.8 5010.4 4970.1 5030.3 5039.9 5047.1 5053.9 5716.3 5729.4 5752.1 5763.3 5768.1 6556.5 6563.3 6568.7 6636.4 6648.0 1654.5 1712.3 1714.8 1736.5 1742.3 1187.2 1189.4 1209.0 1209.5 1212.4 5686.5 5703.1 5738.4 5758.3 5777.9 6622.8 6643.3 6677.6 6703.5 6779.7 5775.4 5803.3 5830.7 5876.8 5907.9 3613.7 3645.7 3656.2 3666.6 3668.7 6664.6 6674.2 6694.5 6705.6 6708.8 7066.2 7081.5 7086.3 7094.3 7101.1 6489.6 6568.9 6602.5 6614.2 6635.5 6808.9 6847.1 6859.3 6871.8 6896.6 6838.3 6840.4 6843.5 6844.3 6868.7 6545.9 6636.1 6667.6 6667.8 6674.7 4897.2 4929.6 4934.7 5005.7 5015.5 6760.6 6761.9 6769.7 6839.6 6875.2 6625.7 6630.0 6631.1 6644.4 6682.3 6559.8 6641.2 6669.9 6707.2 6722.5 6281.5 6378.5 6471.9 6523.7 6533.0 6508.8 6555.2 6576.8 6602.9 6613.7 6350.7 6383.3 6393.7 6448.0 6475.0 16:20:44 INFO - PID 6505 | 16:20:44 INFO - PID 6505 | [#5] yui.html Cycles:180 Average:23330.40 Median:20470.14 stddev:31352.63 (153.2%) stddev-sans-first:31395.44 16:20:44 INFO - PID 6505 | Values: 924.4 930.2 945.8 949.6 955.8 18909.0 19547.6 19775.8 19898.2 22051.3 21118.8 21501.1 21789.2 22071.2 22073.8 1012.8 1043.8 1046.1 1046.1 1046.1 1017.7 1055.6 1065.8 1066.0 1066.4 1116.9 1127.1 1127.7 1127.7 1128.6 1118.4 1123.0 1125.5 1127.8 1128.2 822.1 822.4 823.8 824.0 826.4 17233.4 17291.5 17364.4 17391.8 20465.9 21779.6 21959.6 22110.9 22308.3 22429.7 16823.2 17083.9 17089.9 17163.5 17163.7 3640.7 3694.1 3694.7 3696.1 3698.2 125202.4 125385.4 126419.4 127988.4 128425.0 16783.6 16854.6 16917.2 17169.6 17285.0 30691.7 31042.7 31127.5 31155.8 31172.8 7335.1 7732.5 8732.2 8845.5 9167.7 4113.3 4179.8 4184.9 4186.3 4196.8 5376.4 5420.9 5428.9 5518.5 5555.2 1079.6 1091.4 1102.7 1109.3 1115.9 683.8 702.8 714.9 714.9 720.4 11937.7 12147.9 12467.3 12501.1 12743.0 711.2 715.3 720.0 722.5 728.9 5529.6 5558.4 5638.5 5666.6 5731.9 112304.0 113365.4 113774.4 114787.0 117431.0 90034.5 90895.0 92960.5 95541.0 95615.0 81586.0 83183.6 84381.0 84417.0 87240.1 10773.8 10795.7 10932.2 10934.2 10991.9 37193.8 37878.0 38123.6 38180.6 39431.4 48368.3 48369.3 48763.5 48837.3 49212.3 16233.2 16514.9 16563.3 16586.6 16848.7 21890.1 21907.7 22439.4 22472.7 22621.4 17974.0 18948.7 19485.7 19626.2 20059.7 19936.9 20201.5 20371.2 20510.4 20565.3 19648.4 19695.5 19936.8 20270.5 20474.4 14294.1 14631.7 14649.1 14806.7 15017.8 15583.5 15594.8 15623.5 15792.8 15880.8 16:20:44 INFO - PID 6505 | -------- Summary: end -------- 16:20:44 INFO - PID 6505 | 16:20:44 INFO - TEST-INFO | 6505: exit 0 16:20:44 INFO - TEST-OK | dromaeo_css | took 1112592ms 16:20:44 INFO - TEST-START | kraken 16:20:44 INFO - Initialising browser for kraken test... 16:20:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36936/getInfo.html -profile /tmp/tmp1bUp_D/profile 16:20:44 INFO - TEST-INFO | started process 6881 (/builds/slave/test/build/application/firefox/firefox http://localhost:36936/getInfo.html) 16:20:50 INFO - TEST-INFO | 6881: exit 0 16:20:50 INFO - Browser initialized. 16:20:50 INFO - Running cycle 1/1 for kraken test... 16:20:51 INFO - TEST-INFO | started process 7111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1bUp_D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:20:52 INFO - PID 7111 | 16:20:52 INFO - PID 7111 | (/builds/slave/test/build/application/firefox/firefox:7165): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:20:52 INFO - PID 7111 | 16:21:02 INFO - PID 7111 | RSS: Main: 170950656 16:21:02 INFO - PID 7111 | 16:21:04 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36936/tests/kraken/driver.html?testName=audio-beat-detection) 16:21:05 INFO - PID 7111 | RSS: Main: 175464448 16:21:05 INFO - PID 7111 | 16:21:08 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36936/tests/kraken/driver.html?testName=audio-dft) 16:21:09 INFO - PID 7111 | RSS: Main: 176115712 16:21:09 INFO - PID 7111 | 16:21:12 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36936/tests/kraken/driver.html?testName=audio-fft) 16:21:12 INFO - PID 7111 | RSS: Main: 170180608 16:21:12 INFO - PID 7111 | 16:21:15 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36936/tests/kraken/driver.html?testName=audio-oscillator) 16:21:15 INFO - PID 7111 | RSS: Main: 171401216 16:21:15 INFO - PID 7111 | 16:21:18 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36936/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:21:18 INFO - PID 7111 | RSS: Main: 171290624 16:21:18 INFO - PID 7111 | 16:21:21 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36936/tests/kraken/driver.html?testName=imaging-darkroom) 16:21:22 INFO - PID 7111 | RSS: Main: 174260224 16:21:22 INFO - PID 7111 | 16:21:25 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36936/tests/kraken/driver.html?testName=imaging-desaturate) 16:21:26 INFO - PID 7111 | RSS: Main: 174206976 16:21:26 INFO - PID 7111 | 16:21:29 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36936/tests/kraken/driver.html?testName=json-parse-financial) 16:21:30 INFO - PID 7111 | RSS: Main: 174383104 16:21:30 INFO - PID 7111 | 16:21:31 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36936/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:21:32 INFO - PID 7111 | RSS: Main: 174112768 16:21:32 INFO - PID 7111 | 16:21:34 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:21:34 INFO - PID 7111 | RSS: Main: 174239744 16:21:34 INFO - PID 7111 | 16:21:37 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:21:37 INFO - PID 7111 | RSS: Main: 174329856 16:21:37 INFO - PID 7111 | 16:21:40 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:21:41 INFO - PID 7111 | RSS: Main: 175042560 16:21:41 INFO - PID 7111 | 16:21:44 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:21:45 INFO - PID 7111 | RSS: Main: 175005696 16:21:45 INFO - PID 7111 | 16:21:46 INFO - PID 7111 | Cycle 1(1): loaded http://localhost:36936/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36936/tests/kraken/driver.html?testName=ai-astar) 16:21:47 INFO - PID 7111 | RSS: Main: 176459776 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | __start_tp_report 16:21:47 INFO - PID 7111 | _x_x_mozilla_page_load 16:21:47 INFO - PID 7111 | _x_x_mozilla_page_load_details 16:21:47 INFO - PID 7111 | |i|pagename|runs| 16:21:47 INFO - PID 7111 | |0;ai-astar;99;108;104;106;108;109;109;98;114;110 16:21:47 INFO - PID 7111 | |1;audio-beat-detection;143;116;146;186;118;146;142;119;180;127 16:21:47 INFO - PID 7111 | |2;audio-dft;163;162;164;163;163;163;166;165;169;161 16:21:47 INFO - PID 7111 | |3;audio-fft;77;76;74;164;86;76;76;85;99;75 16:21:47 INFO - PID 7111 | |4;audio-oscillator;79;79;138;79;78;78;123;82;79;130 16:21:47 INFO - PID 7111 | |5;imaging-gaussian-blur;119;124;116;114;118;118;119;114;119;115 16:21:47 INFO - PID 7111 | |6;imaging-darkroom;152;155;153;151;150;150;152;151;151;151 16:21:47 INFO - PID 7111 | |7;imaging-desaturate;94;99;94;94;94;94;94;94;94;93 16:21:47 INFO - PID 7111 | |8;json-parse-financial;59;58;54;54;57;56;55;54;54;54 16:21:47 INFO - PID 7111 | |9;json-stringify-tinderbox;54;53;53;54;54;53;53;63;55;58 16:21:47 INFO - PID 7111 | |10;stanford-crypto-aes;94;94;79;101;79;78;77;87;102;77 16:21:47 INFO - PID 7111 | |11;stanford-crypto-ccm;130;135;158;140;133;124;142;131;138;163 16:21:47 INFO - PID 7111 | |12;stanford-crypto-pbkdf2;187;189;179;176;192;189;186;172;177;180 16:21:47 INFO - PID 7111 | |13;stanford-crypto-sha256-iterative;65;66;64;71;67;65;73;67;65;64 16:21:47 INFO - PID 7111 | __end_tp_report 16:21:47 INFO - PID 7111 | __start_cc_report 16:21:47 INFO - PID 7111 | _x_x_mozilla_cycle_collect,932 16:21:47 INFO - PID 7111 | __end_cc_report 16:21:47 INFO - PID 7111 | __startTimestamp1502234507233__endTimestamp 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | ------- Summary: start ------- 16:21:47 INFO - PID 7111 | Number of tests: 14 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#0] ai-astar Cycles:10 Average:106.50 Median:109.50 stddev:4.95 (4.5%) stddev-sans-first:4.44 16:21:47 INFO - PID 7111 | Values: 99.0 108.0 104.0 106.0 108.0 109.0 109.0 98.0 114.0 110.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:144.50 stddev:24.54 (17.0%) stddev-sans-first:26.02 16:21:47 INFO - PID 7111 | Values: 143.0 116.0 146.0 186.0 118.0 146.0 142.0 119.0 180.0 127.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.28 (1.4%) stddev-sans-first:2.40 16:21:47 INFO - PID 7111 | Values: 163.0 162.0 164.0 163.0 163.0 163.0 166.0 165.0 169.0 161.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#3] audio-fft Cycles:10 Average:88.80 Median:76.50 stddev:27.53 (36.0%) stddev-sans-first:28.87 16:21:47 INFO - PID 7111 | Values: 77.0 76.0 74.0 164.0 86.0 76.0 76.0 85.0 99.0 75.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:79.00 stddev:25.00 (31.6%) stddev-sans-first:25.88 16:21:47 INFO - PID 7111 | Values: 79.0 79.0 138.0 79.0 78.0 78.0 123.0 82.0 79.0 130.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.50 stddev:3.03 (2.6%) stddev-sans-first:3.17 16:21:47 INFO - PID 7111 | Values: 119.0 124.0 116.0 114.0 118.0 118.0 119.0 114.0 119.0 115.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.50 stddev:1.51 (1.0%) stddev-sans-first:1.59 16:21:47 INFO - PID 7111 | Values: 152.0 155.0 153.0 151.0 150.0 150.0 152.0 151.0 151.0 151.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.65 (1.8%) stddev-sans-first:1.74 16:21:47 INFO - PID 7111 | Values: 94.0 99.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 93.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:1.90 (3.4%) stddev-sans-first:1.54 16:21:47 INFO - PID 7111 | Values: 59.0 58.0 54.0 54.0 57.0 56.0 55.0 54.0 54.0 54.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:54.00 stddev:3.20 (5.9%) stddev-sans-first:3.37 16:21:47 INFO - PID 7111 | Values: 54.0 53.0 53.0 54.0 54.0 53.0 53.0 63.0 55.0 58.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:79.00 stddev:10.15 (12.9%) stddev-sans-first:10.43 16:21:47 INFO - PID 7111 | Values: 94.0 94.0 79.0 101.0 79.0 78.0 77.0 87.0 102.0 77.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:139.00 stddev:12.33 (8.9%) stddev-sans-first:12.60 16:21:47 INFO - PID 7111 | Values: 130.0 135.0 158.0 140.0 133.0 124.0 142.0 131.0 138.0 163.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:186.50 stddev:6.73 (3.6%) stddev-sans-first:6.96 16:21:47 INFO - PID 7111 | Values: 187.0 189.0 179.0 176.0 192.0 189.0 186.0 172.0 177.0 180.0 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:3.02 (4.5%) stddev-sans-first:3.14 16:21:47 INFO - PID 7111 | Values: 65.0 66.0 64.0 71.0 67.0 65.0 73.0 67.0 65.0 64.0 16:21:47 INFO - PID 7111 | -------- Summary: end -------- 16:21:47 INFO - PID 7111 | 16:21:47 INFO - PID 7111 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:21:47 INFO - TEST-INFO | 7111: exit 0 16:21:47 INFO - TEST-OK | kraken | took 62946ms 16:21:47 INFO - SUITE-END | took 1175s 16:21:48 INFO - Completed test suite (00:19:36) 16:21:48 INFO - javascript benchmark 16:21:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8651.914501314694, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3051.2982014136746, 3136.4824803907354, 3148.6379066407358, 3191.9945217256563, 3203.7276831469326, 6225.626462412259, 6230.096635987779, 6292.5909815862, 6319.6524191169465, 6326.177596912406, 6251.531135164858, 6262.185915830935, 6287.654179020152, 6311.684415779216, 6366.363363663643, 5668.064769313079, 5754.683492407916, 5796.275465566804, 5804.0, 5819.709014549277, 5615.410381909882, 5681.744321505522, 5732.541396688276, 5748.798792042279, 5766.942330576703, 5700.201971723962, 5702.201691763156, 5705.0, 5716.028275193206, 5723.198752174699, 5631.155326700987, 5668.43315668434, 5721.370649228582, 5749.453801888814, 5759.1937128802, 5617.831465056014, 5674.290713660793, 5694.914576281359, 5713.400092990218, 5780.566457515703, 6161.876762464725, 6179.81460556184, 6247.312795592481, 6258.71835767387, 6300.810975670737, 6581.21025476941, 6601.603903765741, 6679.398854103154, 6697.966510167466, 6791.796246112624, 6685.465162786965, 6752.358525940028, 6761.661916904135, 6763.222229443628, 6763.7632682855865, 6252.437280644764, 6260.624362538262, 6271.498280137578, 6276.995680691068, 6302.621842689453, 6945.513814032969, 6950.20072691647, 6955.269696681776, 6965.756198533027, 6988.510804243654, 6521.543491955613, 6630.86738265232, 6640.634765087966, 6643.86712265752, 6646.26891041985, 6627.304133066055, 6705.195376554844, 6706.094677218611, 6773.559718618274, 6780.796576102626, 6536.738530458729, 6615.900761488581, 6657.667116644148, 6736.629485378351, 6750.561213521106, 6581.045748366556, 6708.161479815023, 6710.698018589078, 6720.9663951680905, 6731.730730770812, 5246.422893481714, 5454.972725136428, 5504.422035686195, 5559.249501317351, 5562.415946325658, 4671.322658214608, 4693.108309421199, 4698.906021879611, 4719.646026548023, 4752.7385993769985, 5785.363610002896, 5788.913166302509, 5889.676067816225, 5893.381194974466, 5894.2926848778425, 6774.119364482585, 6775.288594697585, 6776.9322306777285, 6797.354251346114, 6808.285130061371, 5723.77104915807, 5777.913331300034, 5821.79623713168, 5844.298684157929, 5855.648661080349, 5915.852103697356, 5921.911171332434, 5923.378045305181, 5964.522838173022, 6013.947559177126, 6380.202474690664, 6490.350964903566, 6526.771562995367, 6609.570377925419, 6622.437092847162, 6715.0, 6737.461003119836, 6758.526903116931, 6769.661516924232, 6773.390394864486, 6430.678466076584, 6507.023946408077, 6511.544191906521, 6516.478681705547, 6551.312112228147, 6595.241547222131, 6640.734370625314, 6645.933540664725, 6656.36764507371, 6661.666916654051, 6712.127423434922, 6725.461963042847, 6805.863882722417, 6815.42068924147, 6815.556988795713, 6465.191851018622, 6467.482601391972, 6482.967585162044, 6562.278149403466, 6569.9014514783275, 6578.539502234989, 6593.0, 6604.867902642017, 6608.636524991171, 6613.867722645617, 6468.935310646833, 6570.5729127606555, 6571.244306904767, 6571.310012448624, 6584.506162037962, 6555.246146693191, 6594.307597702172, 6599.274079851309, 6646.767363142267, 6708.362705542965, 6292.496600271876, 6385.68071596409, 6398.168238129014, 6478.125453063776, 6486.351364863476], "value": 6136.00449827907, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.6933649881295, 856.1737922904396, 876.6712482818942, 885.2210055151468, 1199.3883119608997, 42935.0, 43540.3468947966, 43552.128957420835, 43582.12835743287, 43609.56390436095, 44065.0, 44435.55564444354, 44443.333349999775, 44451.77774111133, 44468.77765611168, 7775.222477752222, 7823.921760782405, 7861.174576669425, 7890.842183156334, 7939.364850811921, 7772.494787838772, 7893.250141236602, 7899.0, 7901.881471777928, 7932.0, 7238.203797582261, 7910.841783164333, 7919.406044546653, 7922.960385198095, 7928.048634163908, 7818.061832580099, 7861.292483676468, 7866.803329916741, 7872.527648341118, 7878.09401918781, 7607.391408687292, 7802.0, 7828.373730101578, 7834.138244793068, 7885.684572617089, 39943.60056399428, 40242.59757402447, 40319.39520907189, 40413.0, 40476.59523404758, 3579.3736096183325, 3638.745287829853, 3640.908977275563, 3641.9453708194396, 3643.2531331077066, 32288.192795180308, 32438.189045273823, 32474.18814529632, 32547.0, 32671.019869403957, 5157.767900444489, 5170.922436163461, 5181.663191892515, 5196.740162991835, 5199.194124910645, 196470.0, 197378.0, 197683.0, 198553.0, 199285.99999999854, 51558.74220628873, 51588.48411515912, 51670.22494662583, 51879.48120518822, 51884.22173667398, 53722.46277537253, 53949.460505395225, 53968.73015634897, 54126.18810717842, 54140.0, 15908.284127214303, 15940.0, 15956.2819673115, 16004.359825607078, 16014.119223442822, 13104.951603871667, 13118.344082795822, 13123.803142952864, 13132.737345253041, 13143.211407315592, 13156.473741050251, 13442.395092220873, 14880.181590012653, 14887.0, 15153.242337883063, 5296.576273898079, 5393.570703763506, 5428.565714742811, 5465.316835395575, 5587.189857470644, 1012.5899010900597, 1012.6152062216458, 1019.3832731197667, 1023.1354505442889, 1032.1587905856702, 22876.0, 23209.88395058014, 23345.533089338118, 23359.88320058389, 23507.294781156594, 1107.1751545098953, 1126.8253420719802, 1129.4747942206914, 1134.0587312530579, 1137.2323681514945, 12296.446659900326, 12543.184692994926, 12640.367981600883, 12644.873551264554, 12652.797984191488, 230695.0, 232467.0, 233003.0, 233339.0, 234133.0, 55369.0, 55696.72151639216, 55797.442025580036, 55915.0, 56153.0, 1454.2946670864621, 1498.7377208988382, 1499.8275198352328, 1521.52072097289, 1536.0, 23243.0, 23471.647925281475, 23475.178368757013, 23479.17822876191, 23496.412589685395, 38959.80520097382, 39035.21929561449, 39125.2174956505, 39185.0, 39198.216035679696, 197557.0, 198905.0, 199218.0, 199460.0, 199489.0, 33431.66568334286, 33537.66462335443, 33715.49426758551, 33746.66253337435, 36277.45583816192, 42788.358174628025, 43353.783231083646, 43362.0, 43655.78172109119, 49008.2648760276, 35775.46336804898, 35823.104422389646, 35827.82086089553, 35861.462078068325, 36136.81931590325, 35011.82494087513, 35433.82283088671, 35630.465543016355, 35792.28415431729, 36283.637163628024, 38457.807710961264, 38595.614043860325, 38762.612373877026, 39252.607473924894, 39450.60549394584, 34378.484322735676, 34807.4778878312, 34911.12722181966, 35087.0, 35542.0, 24317.39206519851, 24347.51304973855, 24976.37559061038, 25230.0, 25412.364690882874], "value": 17739.69889974122, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [588.1941739816452, 588.4703766610053, 590.477427476683, 597.2206270816582, 601.4707057789145, 22722.88638556809, 23132.0, 24044.639330410035, 24098.277051688434, 24119.879400603015, 26535.469290614175, 27178.32054198646, 27225.86387068062, 27245.0, 27352.863235683795, 6578.440832529241, 6696.363845434676, 6758.05387245786, 6760.898586521206, 6766.0, 6307.558470907038, 6599.967000164993, 6646.169228846395, 7009.614471204081, 7033.0, 7006.964965175167, 7007.929920700779, 7027.262137475568, 7029.789106326818, 7040.04959330489, 6965.930340696605, 7013.473989450786, 7017.3684368406575, 7019.859602807941, 7032.0, 6893.724251029953, 6897.310268973062, 6910.585364878123, 6913.032175495385, 6920.100386949714, 30847.228819279473, 31546.0, 33120.668793312, 33351.83324083388, 33369.83315083433, 1942.2813558983125, 1972.0731256309512, 1973.2107157137116, 1976.3873199308116, 1976.8616196866226, 20357.694634580494, 20936.685949710765, 21003.0, 21080.0, 21134.5773084539, 2333.544958733031, 2505.985076044205, 2515.962260566093, 2527.4692314613953, 2583.935401614956, 142103.0, 145902.0, 145979.0, 146104.0, 146310.0, 21568.352949411543, 21829.563408731738, 22001.394700139404, 22558.774412255996, 22670.546589068126, 45945.77027114843, 45981.0, 46060.3090953636, 46117.30824037642, 46158.30762538565, 10791.733735915388, 10998.450077496092, 11290.266132701348, 11366.374849383363, 11388.715282117848, 9146.725598232064, 9177.862332065024, 9192.770180745534, 9219.631214751469, 9293.0, 11418.85811418868, 11573.594924177612, 11592.0, 11814.46834892432, 12264.141510094387, 3978.8976676632074, 4260.91478170441, 4317.481902171759, 4420.31485119807, 4712.175369310357, 956.660385563129, 980.6959842448864, 982.4596471940404, 991.127807529384, 1005.4671024357102, 19647.705284420746, 20149.19403223884, 20445.79554204439, 20674.173033078507, 20990.265340713002, 1057.2652006855162, 1061.824798908187, 1062.5006247063868, 1069.2354966199205, 1070.8929107089384, 11407.657770266906, 11456.083513318914, 11474.311541307548, 11501.942490287494, 11507.424628768695, 453782.0, 461941.0, 490991.0, 493261.0, 503330.0, 119288.40355798166, 121922.3903880475, 122176.0, 122419.3879030617, 122687.0, 1269.435101379877, 1279.1429742072833, 1305.08643949234, 1317.6047185844209, 1327.2368388176837, 21251.574968500852, 21330.360089197347, 21517.0, 21619.891900540395, 21713.131474741465, 55897.0, 57357.13964290622, 58169.0, 58748.0, 59422.405775943414, 66074.0, 66504.6674766623, 66875.0, 67132.32867671456, 68460.0, 12915.0, 13333.666658333232, 14792.556223313319, 15271.236438178268, 15317.310721017804, 23661.881690591435, 23870.641940371257, 24230.75769242285, 24368.147114850894, 24671.0, 18877.811221887605, 18926.43220703381, 19091.809081909003, 19122.904385477985, 19146.425607231806, 17279.7408038877, 17516.562085947953, 17629.823701763333, 17939.820601793814, 18056.368027118988, 19382.321618743277, 19784.802151978296, 20054.398368048984, 20313.085911133738, 20408.183672653522, 14922.179280139697, 15007.249637518298, 15010.549683509513, 15072.0, 15077.623059423602, 17072.658546829243, 17269.65460690754, 17286.481405557854, 17394.565135871704, 17398.913005434893], "value": 13040.458903061673, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.924929128898, 1392.8050072989784, 1413.8656827601374, 1419.5670320552233, 1423.5658124272097, 13873.445062197512, 14434.783478247835, 14487.927560362197, 14503.854961450383, 14511.129332240047, 14017.0, 14474.638134046654, 14906.850931490682, 14925.328360223788, 14993.0, 2653.6948250951195, 2685.9194224173307, 2687.946241075177, 2702.6216329713857, 2702.8378297302124, 2479.454520005605, 2569.357660584854, 2582.19951814938, 2642.8150029497942, 2692.0712354237853, 2572.2926195296254, 2591.5464793661126, 2595.8182927195103, 2599.116300457844, 2600.5319042572423, 2483.081259933818, 2523.079076137206, 2523.3187039499417, 2524.4193835417864, 2603.7005744339453, 2527.431327951196, 2544.9491010179877, 2548.4775620997652, 2561.3724637463943, 2600.700919394275, 14077.084989475652, 14230.715385692229, 14231.928840355835, 14344.42622295107, 14352.354144063438, 7367.668454919542, 7525.811854703621, 7588.089429268468, 7656.042994625672, 7670.808229794244, 4856.360818919545, 5041.899162016776, 5176.482351764831, 5179.896402071975, 5214.634975551675, 1654.8427899349542, 1659.6929568029952, 1679.17720317045, 1695.042301099887, 1710.076558658323, 23818.880905595535, 24028.39929001789, 24103.638445423334, 24133.276001719976, 24142.879285603634, 6087.3303936566945, 6329.841753956188, 6439.22729272481, 6454.741810327534, 6459.709313080923, 15235.466758663393, 15298.388064477296, 15396.46112386061, 15420.46028389001, 16183.0, 7378.741744038933, 7598.0502437195355, 7617.847643047108, 7632.045994250719, 7635.732749353746, 6827.726890924308, 7060.505764596429, 7075.292470752884, 7112.6443677815905, 7131.251218622074, 4682.601978831769, 4808.519148085234, 4850.5149485051215, 4867.7322747249245, 4869.099216644932, 1371.067673981702, 1372.478458185883, 1380.882624976888, 1459.3287087939455, 1481.2593703148425, 874.1608056266056, 888.2449917570013, 895.8790563273875, 900.7748062984253, 913.5386629751932, 7614.961925190339, 8020.558869262247, 8075.717349892726, 8082.838343233102, 8129.918700813035, 997.665781963036, 1019.3221507697298, 1022.4478781458079, 1023.0945613132432, 1027.9588816447258, 4796.448408433075, 4812.205986012339, 4866.489018653061, 4972.328735620717, 5043.117454445457, 19151.0, 19200.423987280403, 19685.803141968685, 19696.507587310432, 19870.403887883385, 18935.43193704191, 19358.322458713876, 19526.804731952783, 19620.411387658394, 19621.21515139407, 10689.893101069045, 10712.196585256137, 10905.236633435583, 10919.689637243422, 10922.672319830577, 7775.339096176888, 7830.33442157423, 7845.097813751263, 7870.449068565375, 7883.763487095396, 16497.587560311087, 16920.830791691926, 16955.866180327077, 17038.57403564921, 17111.22999465052, 16680.332786688396, 17017.0, 17033.659326813147, 17114.97310161394, 17526.649467010844, 11018.228723989243, 11070.446477675923, 11238.438078095898, 11269.943650281695, 11398.94300528492, 12450.564230251897, 12574.0, 12574.37128143571, 12590.811137833123, 12590.937045314715, 10548.894511054792, 10550.103241224275, 10715.35707857531, 10831.0, 10959.06847917936, 9533.285003624895, 9582.0, 9668.516574171123, 9775.0, 9797.853032204664, 8198.83602327962, 8309.542975136426, 8316.708915187939, 8317.085120636604, 8319.168083191875, 6387.808365749035, 6479.060536222127, 6501.349865013461, 6566.540342176193, 6571.178602674666, 6797.388235058868, 6877.6217308048535, 6908.44732421395, 6944.305569443015, 7058.435325174077], "value": 6266.7306086396175, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [453.8252772682516, 469.20235599480867, 493.90552321256763, 494.54748904752154, 496.37208930702667, 6303.180586523751, 6303.810885673432, 6376.489880809536, 6392.520560957923, 6400.743970241185, 6006.9876591341845, 6176.227971503562, 6205.751769929208, 6218.7201575929075, 6247.7813276535335, 4953.900921981558, 4974.179260422026, 4991.525805048533, 5001.6998980061135, 5030.899382012358, 4806.591439727627, 4903.387076615423, 4965.180745177059, 5001.349824522807, 5038.319826823387, 4928.753562321869, 4944.357233559632, 4952.727599981999, 4964.379452568429, 4984.950150498485, 4930.975345123252, 4936.654434189608, 4953.257011448276, 4982.9252561211615, 4985.426675932278, 4421.336799480072, 4429.734215947021, 4445.933311000305, 4466.57567531084, 4488.236999710024, 6091.11678806575, 6092.421219984139, 6116.694165291718, 6121.234845644294, 6127.509799216052, 5661.575381846337, 5688.118341657008, 5724.914126288109, 5742.167385729088, 5761.279840019997, 6552.3120072392185, 6589.275179730226, 6627.536072474929, 6647.501437392215, 6682.599044057323, 4859.0, 4875.634327425421, 4879.097366987084, 4895.559399654048, 4904.828331008398, 6936.20233673129, 6993.860122797516, 7003.789886303419, 7032.0, 7072.913490520206, 4874.878128046827, 4929.802807887644, 4940.925886111711, 4945.826896058621, 5010.423801262828, 4970.130227210224, 5030.270610761492, 5039.916417970154, 5047.141985862412, 5053.9494605054215, 5716.313687462209, 5729.427057294321, 5752.07966725322, 5763.337216220105, 5768.096528145702, 6556.541042127005, 6563.278039415661, 6568.704408301638, 6636.435902948207, 6647.966760166169, 1654.5367297156815, 1712.2637265975502, 1714.7942246930447, 1736.47905628311, 1742.3466200174935, 1187.2401662935729, 1189.4052973513244, 1208.9542545697907, 1209.4799236328463, 1212.351392005273, 5686.459786320293, 5703.116017017369, 5738.397468265772, 5758.337791153987, 5777.942220577825, 6622.834429139214, 6643.335666433318, 6677.599344039276, 6703.525224450613, 6779.72881084761, 5775.393583673737, 5803.332616749128, 5830.708464576839, 5876.768726516901, 5907.940920590825, 3613.6928361089076, 3645.65366290202, 3656.1590834108306, 3666.6333366663653, 3668.6881615062484, 6664.600123992576, 6674.197966549004, 6694.497912656473, 6705.597664140168, 6708.765193218312, 7066.187388450291, 7081.468889833283, 7086.291370862976, 7094.290570942864, 7101.076860008166, 6489.578177418547, 6568.934310656928, 6602.504812139013, 6614.206295244601, 6635.5023373247195, 6808.923278399938, 6847.144106986627, 6859.279775623488, 6871.793846184622, 6896.586204827727, 6838.281980391987, 6840.384365407137, 6843.520953533205, 6844.28135045813, 6868.690908909211, 6545.901811472927, 6636.13730215069, 6667.566608170453, 6667.799966001027, 6674.699638516181, 4897.240927656219, 4929.630277729113, 4934.7285899275885, 5005.749712514433, 5015.473375295687, 6760.628165450751, 6761.932380676327, 6769.695363708744, 6839.589624622538, 6875.243723190345, 6625.668716564249, 6629.966850165718, 6631.1379520662, 6644.4020038196795, 6682.3317668232785, 6559.8024661736945, 6641.203055633355, 6669.866602668017, 6707.195136583641, 6722.529422940347, 6281.4660753834605, 6378.532937424511, 6471.870562588816, 6523.6738163092605, 6533.0, 6508.772192973223, 6555.180602424697, 6576.8355791105605, 6602.854072426385, 6613.66931653425, 6350.650714210763, 6383.265924418752, 6393.680315984275, 6448.0, 6474.967625161844], "value": 5076.371555199691, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [924.440713368412, 930.1582068228253, 945.791925776329, 949.5679465843042, 955.8470644696846, 18908.99999999998, 19547.609047819053, 19775.80224197756, 19898.20407183711, 22051.33845984623, 21118.788812111914, 21501.139954401806, 21789.237376691817, 22071.227507037256, 22073.779262207372, 1012.8025035118155, 1043.8173319669027, 1046.0585473074218, 1046.0585473074257, 1046.1317106801337, 1017.6692574913146, 1055.5935964653586, 1065.8028264771042, 1065.9733506662317, 1066.4188017530464, 1116.9050630696402, 1127.1264769803386, 1127.689885281546, 1127.7011591928147, 1128.5767837061103, 1118.4072441605963, 1123.0454114003073, 1125.5160281079134, 1127.8251870960014, 1128.1764312052167, 822.1408627983711, 822.4489591973393, 823.7652269103337, 824.0358780227149, 826.4338927834452, 17233.39683111085, 17291.481255562354, 17364.39224627132, 17391.826081739146, 20465.897670511702, 21779.564408711896, 21959.560808783735, 22110.889445552668, 22308.330750077523, 22429.66355504669, 16823.242954067096, 17083.914580427143, 17089.914550427293, 17163.485095447155, 17163.71272154581, 3640.7087433005295, 3694.058015206132, 3694.741368104234, 3696.1129328961124, 3698.2418604186078, 125202.37398812948, 125385.37307313496, 126419.36790316082, 127988.36005820005, 128425.0, 16783.58041048959, 16854.578635533966, 16917.238724257437, 17169.570760731083, 17285.049322287396, 30691.69308306933, 31042.68957310443, 31127.533087003714, 31155.753769849405, 31172.844135779174, 7335.1197856257595, 7732.536047837148, 8732.170443807829, 8845.51349675774, 9167.72496825083, 4113.321301985199, 4179.791010449465, 4184.916301673949, 4186.309258972296, 4196.790160492024, 5376.354837419534, 5420.91868621971, 5428.864278393072, 5518.475744804237, 5555.2222688823595, 1079.643717573199, 1091.3942761767296, 1102.6967583914327, 1109.2789686703707, 1115.938623375706, 683.8085336105898, 702.8032150997728, 714.9106361704787, 714.9320814522612, 720.3768740039828, 11937.70155746096, 12147.878521214674, 12467.251964882136, 12501.124921255607, 12743.044271679475, 711.1821405383747, 715.2990069731692, 719.9820004499825, 722.5303552690688, 728.8615163118991, 5529.557635389239, 5558.44415558441, 5638.4925356718095, 5666.631668941588, 5731.885362292731, 112304.0, 113365.43317283361, 113774.43112784383, 114787.0, 117431.0, 90034.54982725045, 90895.0, 92960.53519732493, 95541.0, 95615.0, 81586.0, 83183.58408207921, 84381.0, 84417.0, 87240.12759872447, 10773.838392423962, 10795.73010674708, 10932.180086493703, 10934.179936504635, 10991.945040274748, 37193.81403092967, 37878.0, 38123.618763813116, 38180.6181938177, 39431.408528872664, 48368.27447588219, 48369.274460882414, 48763.512364875896, 48837.2674409877, 49212.2618160735, 16233.18834058316, 16514.917425412797, 16563.254653540378, 16586.58533536671, 16848.663026739643, 21890.12439502402, 21907.67138492956, 22439.43901402478, 22472.662910056035, 22621.43446413853, 17974.01142937151, 18948.715769263195, 19485.70771438401, 19626.214951401784, 20059.699104513737, 19936.90031549833, 20201.494962625464, 20371.18515259373, 20510.38468845937, 20565.280215192397, 19648.410547683594, 19695.507612309233, 19936.800631993494, 20270.493237668587, 20474.38576842697, 14294.142351458946, 14631.70736585241, 14649.12105273687, 14806.703865922405, 15017.849821501644, 15583.45457909013, 15594.844051559792, 15623.531294061197, 15792.842071579596, 15880.841191587937], "value": 9288.062046190014, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 104.0, 106.0, 108.0, 109.0, 109.0, 98.0, 114.0, 110.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 116.0, 146.0, 186.0, 118.0, 146.0, 142.0, 119.0, 180.0, 127.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 163.0, 163.0, 163.0, 166.0, 165.0, 169.0, 161.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 74.0, 164.0, 86.0, 76.0, 76.0, 85.0, 99.0, 75.0], "value": 88.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 138.0, 79.0, 78.0, 78.0, 123.0, 82.0, 79.0, 130.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 124.0, 116.0, 114.0, 118.0, 118.0, 119.0, 114.0, 119.0, 115.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 155.0, 153.0, 151.0, 150.0, 150.0, 152.0, 151.0, 151.0, 151.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 99.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 54.0, 54.0, 57.0, 56.0, 55.0, 54.0, 54.0, 54.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 54.0, 54.0, 53.0, 53.0, 63.0, 55.0, 58.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 79.0, 101.0, 79.0, 78.0, 77.0, 87.0, 102.0, 77.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 135.0, 158.0, 140.0, 133.0, 124.0, 142.0, 131.0, 138.0, 163.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 189.0, 179.0, 176.0, 192.0, 189.0, 186.0, 172.0, 177.0, 180.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 64.0, 71.0, 67.0, 65.0, 73.0, 67.0, 65.0, 64.0], "value": 66.7, "unit": "score"}]}]} 16:21:48 INFO - Return code: 0 16:21:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:21:48 INFO - # TBPL SUCCESS # 16:21:48 INFO - Running post-action listener: _package_coverage_data 16:21:48 INFO - Running post-action listener: _resource_record_post_action 16:21:48 INFO - [mozharness: 2017-08-08 23:21:48.529508Z] Finished run-tests step (success) 16:21:48 INFO - Running post-run listener: _resource_record_post_run 16:21:48 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 431681536; Read time: 28; Write time: 431512 16:21:48 INFO - TinderboxPrint: CPU usage
13.2% 16:21:48 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 28 16:21:48 INFO - TinderboxPrint: I/O write bytes / time
431,681,536 / 431,512 16:21:48 INFO - TinderboxPrint: CPU idle
8,264.4 (86.8%) 16:21:48 INFO - TinderboxPrint: CPU user
1,205.5 (12.7%) 16:21:48 INFO - TinderboxPrint: Swap in / out
0 / 0 16:21:48 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106835968; Read time: 0; Write time: 91860 16:21:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:21:48 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324845568; Read time: 12; Write time: 339652 16:21:49 INFO - Running post-run listener: _upload_blobber_files 16:21:49 INFO - Blob upload gear active. 16:21:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:21:49 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 16:21:49 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'] 16:21:49 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 16:21:49 INFO - (blobuploader) - INFO - Open directory for files ... 16:21:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:21:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:21:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:50 INFO - (blobuploader) - INFO - Done attempting. 16:21:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:21:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:21:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:51 INFO - (blobuploader) - INFO - Done attempting. 16:21:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:21:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:21:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:55 INFO - (blobuploader) - INFO - Done attempting. 16:21:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:21:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:21:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:21:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:21:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:21:56 INFO - (blobuploader) - INFO - Done attempting. 16:21:56 INFO - (blobuploader) - INFO - Iteration through files over. 16:21:56 INFO - Return code: 0 16:21:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:21:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:21:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b1ed0a2fdbed5dfa3c057dff6293ce95830af1caf5e0e56c2c62b556a15d49b9e7270a97173a6af762849be21b144892c1a967fe30d14b16dc54a8c3ddc748e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5828fe77ee8eb9cdc4486faf1c42623b95badcf51cb33254b4f21af1dfe5b50a9491ea7e7321c9856dcd80c0458955e3b706a3bc3df868d49f92ab82e2451da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84481757d3f16789dc507ec19877fe45846214674b7cc618223483c618b289394980712171441dcedee61f37ea2f44890407ed0ae186d84e2b0c4bfa1248e2e4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/106dfd7858a80ddd8e231288b138f98a7cbba48bbe2087cf2c89bb2a6733b89864462644d5111bf7a1df71df8504e40d43c38977b0d70e5971010282f3b32d1b"} 16:21:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:21:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:21:56 INFO - Contents: 16:21:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b1ed0a2fdbed5dfa3c057dff6293ce95830af1caf5e0e56c2c62b556a15d49b9e7270a97173a6af762849be21b144892c1a967fe30d14b16dc54a8c3ddc748e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5828fe77ee8eb9cdc4486faf1c42623b95badcf51cb33254b4f21af1dfe5b50a9491ea7e7321c9856dcd80c0458955e3b706a3bc3df868d49f92ab82e2451da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84481757d3f16789dc507ec19877fe45846214674b7cc618223483c618b289394980712171441dcedee61f37ea2f44890407ed0ae186d84e2b0c4bfa1248e2e4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/106dfd7858a80ddd8e231288b138f98a7cbba48bbe2087cf2c89bb2a6733b89864462644d5111bf7a1df71df8504e40d43c38977b0d70e5971010282f3b32d1b"} 16:21:56 INFO - Running post-run listener: copy_logs_to_upload_dir 16:21:56 INFO - Copying logs to upload dir... 16:21:56 INFO - mkdir: /builds/slave/test/build/upload/logs 16:21:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.180886 ========= master_lag: 0.23 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-08 16:21:56.605497) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 16:21:56.609966) ========= 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=62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b1ed0a2fdbed5dfa3c057dff6293ce95830af1caf5e0e56c2c62b556a15d49b9e7270a97173a6af762849be21b144892c1a967fe30d14b16dc54a8c3ddc748e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5828fe77ee8eb9cdc4486faf1c42623b95badcf51cb33254b4f21af1dfe5b50a9491ea7e7321c9856dcd80c0458955e3b706a3bc3df868d49f92ab82e2451da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84481757d3f16789dc507ec19877fe45846214674b7cc618223483c618b289394980712171441dcedee61f37ea2f44890407ed0ae186d84e2b0c4bfa1248e2e4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/106dfd7858a80ddd8e231288b138f98a7cbba48bbe2087cf2c89bb2a6733b89864462644d5111bf7a1df71df8504e40d43c38977b0d70e5971010282f3b32d1b"} build_url:https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/F7NQqaIQR2-2IEUa3S5RaA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b1ed0a2fdbed5dfa3c057dff6293ce95830af1caf5e0e56c2c62b556a15d49b9e7270a97173a6af762849be21b144892c1a967fe30d14b16dc54a8c3ddc748e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f5828fe77ee8eb9cdc4486faf1c42623b95badcf51cb33254b4f21af1dfe5b50a9491ea7e7321c9856dcd80c0458955e3b706a3bc3df868d49f92ab82e2451da", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/84481757d3f16789dc507ec19877fe45846214674b7cc618223483c618b289394980712171441dcedee61f37ea2f44890407ed0ae186d84e2b0c4bfa1248e2e4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/106dfd7858a80ddd8e231288b138f98a7cbba48bbe2087cf2c89bb2a6733b89864462644d5111bf7a1df71df8504e40d43c38977b0d70e5971010282f3b32d1b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-08 16:21:56.635095) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:21:56.635420) ========= 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=62c568580acbfdaac3eec7be000001dc-1502233259.772002-1034998374 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004455 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-08 16:21:56.717418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 16:21:56.720764) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-08 16:21:56.721257) ========= ========= Total master_lag: 0.38 =========