builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1502645851.63 results: success (0) revision: 8a12a4fcdb0519ec686ec7ec31b6296429f9fb3e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:31.630440) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:31.631569) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:31.631861) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:31.674303) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:31.674651) ========= 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=8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-13 10:37:32-- 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% 40.4M=0s 2017-08-13 10:37:32 (40.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.305676 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:32.008890) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:32.009181) ========= 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=8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016847 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:32.060943) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:32.061414) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a12a4fcdb0519ec686ec7ec31b6296429f9fb3e --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 8a12a4fcdb0519ec686ec7ec31b6296429f9fb3e --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=8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-13 10:37:32,891 truncating revision to first 12 chars 2017-08-13 10:37:32,891 Setting DEBUG logging. 2017-08-13 10:37:32,891 attempt 1/10 2017-08-13 10:37:32,891 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a12a4fcdb05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-13 10:37:33,153 unpacking tar archive at: mozilla-central-8a12a4fcdb05/testing/mozharness/ program finished with exit code 0 elapsedTime=0.583520 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:32.661257) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:32.664600) ========= script_repo_revision: 8a12a4fcdb0519ec686ec7ec31b6296429f9fb3e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:32.665033) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:32.665302) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-13 10:37:32.677148) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-13 10:37:32.677455) ========= /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=8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:37:33 INFO - MultiFileLogger online at 20170813 10:37:33 in /builds/slave/test 10:37:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:37:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:37:33 INFO - {'append_to_log': False, 10:37:33 INFO - 'base_work_dir': '/builds/slave/test', 10:37:33 INFO - 'blob_upload_branch': 'Firefox', 10:37:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:37:33 INFO - 'branch': 'Firefox', 10:37:33 INFO - 'buildbot_json_path': 'buildprops.json', 10:37:33 INFO - 'code_coverage': False, 10:37:33 INFO - 'config_files': ('talos/linux_config.py',), 10:37:33 INFO - 'default_actions': ('clobber', 10:37:33 INFO - 'read-buildbot-config', 10:37:33 INFO - 'download-and-extract', 10:37:33 INFO - 'populate-webroot', 10:37:33 INFO - 'create-virtualenv', 10:37:33 INFO - 'install', 10:37:33 INFO - 'setup-mitmproxy', 10:37:33 INFO - 'run-tests'), 10:37:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:37:33 INFO - 'disable_ccov_upload': False, 10:37:33 INFO - 'download_minidump_stackwalk': True, 10:37:33 INFO - 'download_symbols': 'ondemand', 10:37:33 INFO - 'enable_stylo': False, 10:37:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:37:33 INFO - 'tooltool.py': '/tools/tooltool.py', 10:37:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:37:33 INFO - '/tools/misc-python/virtualenv.py')}, 10:37:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:37:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:37:33 INFO - 'gecko_profile': False, 10:37:33 INFO - 'gecko_profile_interval': 0, 10:37:33 INFO - 'installer_path': 'installer.exe', 10:37:33 INFO - 'log_level': 'info', 10:37:33 INFO - 'log_name': 'talos', 10:37:33 INFO - 'log_to_console': True, 10:37:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:37:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:37:33 INFO - 'opt_config_files': (), 10:37:33 INFO - 'pip_index': False, 10:37:33 INFO - 'suite': 'dromaeojs-e10s', 10:37:33 INFO - 'system_bits': '32', 10:37:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:37:33 INFO - 'title': 'talos-linux64-ix-038', 10:37:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:37:33 INFO - 'use_talos_json': True, 10:37:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:37:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:37:33 INFO - 'work_dir': 'build'} 10:37:33 INFO - [mozharness: 2017-08-13 17:37:33.613910Z] Running clobber step. 10:37:33 INFO - Running pre-action listener: _resource_record_pre_action 10:37:33 INFO - Running main action method: clobber 10:37:33 INFO - rmtree: /builds/slave/test/build 10:37:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:37:35 INFO - Running post-action listener: _resource_record_post_action 10:37:35 INFO - [mozharness: 2017-08-13 17:37:35.163135Z] Finished clobber step (success) 10:37:35 INFO - [mozharness: 2017-08-13 17:37:35.163238Z] Running read-buildbot-config step. 10:37:35 INFO - Running pre-action listener: _resource_record_pre_action 10:37:35 INFO - Running main action method: read_buildbot_config 10:37:35 INFO - Using buildbot properties: 10:37:35 INFO - { 10:37:35 INFO - "project": "", 10:37:35 INFO - "product": "firefox", 10:37:35 INFO - "who": "ffxbld@noreply.mozilla.org", 10:37:35 INFO - "installer_path": "public/build/target.tar.bz2", 10:37:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:37:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:37:35 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:37:35 INFO - "stage_platform": "linux64-stylosequential", 10:37:35 INFO - "basedir": "/builds/slave/test", 10:37:35 INFO - "buildnumber": 146, 10:37:35 INFO - "platform": "ubuntu64_hw_styloseq", 10:37:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:37:35 INFO - "slavebuilddir": "test", 10:37:35 INFO - "taskId": "cXG_9zrgTJuyFL0wzM2BVg", 10:37:35 INFO - "branch": "mozilla-central", 10:37:35 INFO - "script_repo_revision": "production", 10:37:35 INFO - "revision": "8a12a4fcdb0519ec686ec7ec31b6296429f9fb3e", 10:37:35 INFO - "slavename": "talos-linux64-ix-038", 10:37:35 INFO - "repo_path": "mozilla-central" 10:37:35 INFO - } 10:37:35 INFO - Finding installer, test and symbols from parent task. 10:37:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cXG_9zrgTJuyFL0wzM2BVg'}, attempt #1 10:37:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cXG_9zrgTJuyFL0wzM2BVg'}, attempt #1 10:37:36 INFO - Task dependencies: J_vgLFRaS7OWlqukWZ875g 10:37:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g'}, attempt #1 10:37:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.tar.bz2 10:37:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.test_packages.json 10:37:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.crashreporter-symbols.zip 10:37:36 INFO - Running post-action listener: _resource_record_post_action 10:37:36 INFO - [mozharness: 2017-08-13 17:37:36.599032Z] Finished read-buildbot-config step (success) 10:37:36 INFO - [mozharness: 2017-08-13 17:37:36.599253Z] Running download-and-extract step. 10:37:36 INFO - Running pre-action listener: _resource_record_pre_action 10:37:36 INFO - Running main action method: download_and_extract 10:37:36 INFO - mkdir: /builds/slave/test/build/tests 10:37: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')]} 10:37:36 INFO - trying https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.test_packages.json 10:37:36 INFO - Downloading https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:37:37 INFO - Downloaded 989 bytes. 10:37:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:37:37 INFO - Using the following test package requirements: 10:37:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:37:37 INFO - u'common': [u'target.common.tests.zip'], 10:37:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:37:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:37:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:37:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:37:37 INFO - u'mozbase': [u'target.common.tests.zip'], 10:37:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:37:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:37:37 INFO - u'web-platform': [u'target.common.tests.zip', 10:37:37 INFO - u'target.web-platform.tests.tar.gz'], 10:37:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:37:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:37:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.common.tests.zip 10:37:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:37:37 INFO - Fetch https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.common.tests.zip into memory 10:37:38 INFO - Content-Length response header: 54034684 10:37:38 INFO - Bytes received: 54034684 10:37:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:37:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.common.tests.zip 10:37:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:37:50 INFO - Fetch https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.common.tests.zip into memory 10:37:52 INFO - Content-Length response header: 54034684 10:37:52 INFO - Bytes received: 54034684 10:38:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.talos.tests.zip 10:38:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:38:03 INFO - Fetch https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.talos.tests.zip into memory 10:38:04 INFO - Content-Length response header: 14496050 10:38:05 INFO - Bytes received: 14496050 10:38: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')]} 10:38:05 INFO - trying https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.tar.bz2 10:38:05 INFO - Downloading https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:38:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:38:07 INFO - Downloaded 61764780 bytes. 10:38:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.tar.bz2 10:38:07 INFO - mkdir: /builds/slave/test/properties 10:38:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:38:07 INFO - Writing to file /builds/slave/test/properties/build_url 10:38:07 INFO - Contents: 10:38:07 INFO - build_url:https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.tar.bz2 10:38:07 INFO - Running post-action listener: _resource_record_post_action 10:38:07 INFO - Running post-action listener: set_extra_try_arguments 10:38:07 INFO - [mozharness: 2017-08-13 17:38:07.297038Z] Finished download-and-extract step (success) 10:38:07 INFO - [mozharness: 2017-08-13 17:38:07.297136Z] Running populate-webroot step. 10:38:07 INFO - Running pre-action listener: _resource_record_pre_action 10:38:07 INFO - Running main action method: populate_webroot 10:38:07 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:38:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:38:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:38:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:38:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:38:07 INFO - 'tests': ['damp', 'tps']}, 10:38:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:38:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:38:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:38:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:38:07 INFO - 'other-e10s': {'tests': ['a11yr', 10:38:07 INFO - 'ts_paint', 10:38:07 INFO - 'tpaint', 10:38:07 INFO - 'sessionrestore', 10:38:07 INFO - 'sessionrestore_many_windows', 10:38:07 INFO - 'sessionrestore_no_auto_restore', 10:38:07 INFO - 'tabpaint']}, 10:38:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:38:07 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:38:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:38:07 INFO - 'tsvgr_opacity', 10:38:07 INFO - 'tart', 10:38:07 INFO - 'tscrollx', 10:38:07 INFO - 'tsvg_static']}, 10:38:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:38:07 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:38:07 INFO - 'talos_options': ['--mitmproxy', 10:38:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:38:07 INFO - '--firstNonBlankPaint'], 10:38:07 INFO - 'tests': ['tp6_google', 10:38:07 INFO - 'tp6_youtube', 10:38:07 INFO - 'tp6_amazon', 10:38:07 INFO - 'tp6_facebook']}, 10:38:07 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:38:07 INFO - 'talos_options': ['--stylo', 10:38:07 INFO - '--mitmproxy', 10:38:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:38:07 INFO - '--firstNonBlankPaint'], 10:38:07 INFO - 'tests': ['tp6_google', 10:38:07 INFO - 'tp6_youtube', 10:38:07 INFO - 'tp6_amazon', 10:38:07 INFO - 'tp6_facebook']}, 10:38:07 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:38:07 INFO - 'talos_options': ['--stylo', 10:38:07 INFO - '--stylo-threads=1', 10:38:07 INFO - '--mitmproxy', 10:38:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:38:07 INFO - '--firstNonBlankPaint'], 10:38:07 INFO - 'tests': ['tp6_google', 10:38:07 INFO - 'tp6_youtube', 10:38:07 INFO - 'tp6_amazon', 10:38:07 INFO - 'tp6_facebook']}, 10:38:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:38:07 INFO - 'talos_options': ['--xperf_path', 10:38:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:38:07 INFO - 'tests': ['tp5n']}}} 10:38:07 INFO - Running post-action listener: _resource_record_post_action 10:38:07 INFO - [mozharness: 2017-08-13 17:38:07.305533Z] Finished populate-webroot step (success) 10:38:07 INFO - [mozharness: 2017-08-13 17:38:07.305622Z] Running create-virtualenv step. 10:38:07 INFO - Running pre-action listener: _resource_record_pre_action 10:38:07 INFO - Running main action method: create_virtualenv 10:38:07 INFO - Creating virtualenv /builds/slave/test/build/venv 10:38:07 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 10:38:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:38:07 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:38:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:38:07 INFO - Using real prefix '/usr' 10:38:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:38:07 INFO - Installing distribute.............................................................................................................................................................................................done. 10:38:09 INFO - Installing pip.................done. 10:38:09 INFO - Return code: 0 10:38:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:38:10 INFO - Reading from file tmpfile_stdout 10:38:10 INFO - Output received: 10:38:10 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) 10:38:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b84b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b87f00>, '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 0x2b82ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b83050>, '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': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', '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 10:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:38:10 INFO - Using env: {'DISPLAY': ':0', 10:38:10 INFO - 'HOME': '/home/cltbld', 10:38:10 INFO - 'LANG': 'en_US.UTF-8', 10:38:10 INFO - 'LANGUAGE': 'en_US:en', 10:38:10 INFO - 'LOGNAME': 'cltbld', 10:38:10 INFO - 'MAIL': '/var/mail/cltbld', 10:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:10 INFO - 'MOZ_NO_REMOTE': '1', 10:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:10 INFO - 'NO_EM_RESTART': '1', 10:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:10 INFO - 'PWD': '/builds/slave/test', 10:38:10 INFO - 'SHELL': '/bin/bash', 10:38:10 INFO - 'SHLVL': '1', 10:38:10 INFO - 'TERM': 'linux', 10:38:10 INFO - 'TMOUT': '86400', 10:38:10 INFO - 'USER': 'cltbld', 10:38:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', 10:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:10 INFO - '_': '/tools/buildbot/bin/python'} 10:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:10 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 10:38:10 INFO - Cleaning up... 10:38:10 INFO - Return code: 0 10:38:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b84b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b87f00>, '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 0x2b82ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b83050>, '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': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', '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 10:38:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:38:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:38:10 INFO - Using env: {'DISPLAY': ':0', 10:38:10 INFO - 'HOME': '/home/cltbld', 10:38:10 INFO - 'LANG': 'en_US.UTF-8', 10:38:10 INFO - 'LANGUAGE': 'en_US:en', 10:38:10 INFO - 'LOGNAME': 'cltbld', 10:38:10 INFO - 'MAIL': '/var/mail/cltbld', 10:38:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:10 INFO - 'MOZ_NO_REMOTE': '1', 10:38:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:10 INFO - 'NO_EM_RESTART': '1', 10:38:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:10 INFO - 'PWD': '/builds/slave/test', 10:38:10 INFO - 'SHELL': '/bin/bash', 10:38:10 INFO - 'SHLVL': '1', 10:38:10 INFO - 'TERM': 'linux', 10:38:10 INFO - 'TMOUT': '86400', 10:38:10 INFO - 'USER': 'cltbld', 10:38:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', 10:38:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:10 INFO - '_': '/tools/buildbot/bin/python'} 10:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:10 INFO - Downloading/unpacking psutil>=3.1.1 10:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:38:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:38:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:38:11 INFO - Installing collected packages: psutil 10:38:11 INFO - Running setup.py install for psutil 10:38:11 INFO - building 'psutil._psutil_linux' extension 10:38:11 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 10:38:11 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 10:38:12 INFO - building 'psutil._psutil_posix' extension 10:38:12 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 10:38:12 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 10:38:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:38:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:38:12 INFO - Successfully installed psutil 10:38:12 INFO - Cleaning up... 10:38:12 INFO - Return code: 0 10:38:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:38: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')]} 10:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38: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')]} 10:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:12 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 0x28171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b84b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b87f00>, '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 0x2b82ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b83050>, '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': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', '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 10:38:12 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 10:38:12 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 10:38:12 INFO - Using env: {'DISPLAY': ':0', 10:38:12 INFO - 'HOME': '/home/cltbld', 10:38:12 INFO - 'LANG': 'en_US.UTF-8', 10:38:12 INFO - 'LANGUAGE': 'en_US:en', 10:38:12 INFO - 'LOGNAME': 'cltbld', 10:38:12 INFO - 'MAIL': '/var/mail/cltbld', 10:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:12 INFO - 'MOZ_NO_REMOTE': '1', 10:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:12 INFO - 'NO_EM_RESTART': '1', 10:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:12 INFO - 'PWD': '/builds/slave/test', 10:38:12 INFO - 'SHELL': '/bin/bash', 10:38:12 INFO - 'SHLVL': '1', 10:38:12 INFO - 'TERM': 'linux', 10:38:12 INFO - 'TMOUT': '86400', 10:38:12 INFO - 'USER': 'cltbld', 10:38:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', 10:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:12 INFO - '_': '/tools/buildbot/bin/python'} 10:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:38:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:38:13 INFO - Installing collected packages: mozsystemmonitor 10:38:13 INFO - Running setup.py install for mozsystemmonitor 10:38:13 INFO - Successfully installed mozsystemmonitor 10:38:13 INFO - Cleaning up... 10:38:13 INFO - Return code: 0 10:38:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:38:13 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')]} 10:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:13 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')]} 10:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:13 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 0x28171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b84b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b87f00>, '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 0x2b82ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b83050>, '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': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', '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 10:38:13 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 10:38:13 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 10:38:13 INFO - Using env: {'DISPLAY': ':0', 10:38:13 INFO - 'HOME': '/home/cltbld', 10:38:13 INFO - 'LANG': 'en_US.UTF-8', 10:38:13 INFO - 'LANGUAGE': 'en_US:en', 10:38:13 INFO - 'LOGNAME': 'cltbld', 10:38:13 INFO - 'MAIL': '/var/mail/cltbld', 10:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:13 INFO - 'MOZ_NO_REMOTE': '1', 10:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:13 INFO - 'NO_EM_RESTART': '1', 10:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:13 INFO - 'PWD': '/builds/slave/test', 10:38:13 INFO - 'SHELL': '/bin/bash', 10:38:13 INFO - 'SHLVL': '1', 10:38:13 INFO - 'TERM': 'linux', 10:38:13 INFO - 'TMOUT': '86400', 10:38:13 INFO - 'USER': 'cltbld', 10:38:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', 10:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:13 INFO - '_': '/tools/buildbot/bin/python'} 10:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:13 INFO - Downloading/unpacking jsonschema==2.5.1 10:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:38:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:38:15 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 10:38:15 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 10:38:15 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 10:38:15 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 10:38:15 INFO - Downloading functools32-3.2.3-2.tar.gz 10:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:38:15 INFO - warning: no files found matching '*.txt' 10:38:15 INFO - no previously-included directories found matching 'build' 10:38:15 INFO - no previously-included directories found matching 'dist' 10:38:15 INFO - no previously-included directories found matching '.git*' 10:38:15 INFO - Installing collected packages: jsonschema, functools32 10:38:15 INFO - Running setup.py install for functools32 10:38:15 INFO - warning: no files found matching '*.txt' 10:38:15 INFO - no previously-included directories found matching 'build' 10:38:15 INFO - no previously-included directories found matching 'dist' 10:38:15 INFO - no previously-included directories found matching '.git*' 10:38:15 INFO - Successfully installed jsonschema functools32 10:38:15 INFO - Cleaning up... 10:38:15 INFO - Return code: 0 10:38:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:38:15 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')]} 10:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:15 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')]} 10:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:15 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 0x28171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b84b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b87f00>, '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 0x2b82ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b83050>, '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': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', '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 10:38:15 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 10:38:15 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 10:38:15 INFO - Using env: {'DISPLAY': ':0', 10:38:15 INFO - 'HOME': '/home/cltbld', 10:38:15 INFO - 'LANG': 'en_US.UTF-8', 10:38:15 INFO - 'LANGUAGE': 'en_US:en', 10:38:15 INFO - 'LOGNAME': 'cltbld', 10:38:15 INFO - 'MAIL': '/var/mail/cltbld', 10:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:15 INFO - 'MOZ_NO_REMOTE': '1', 10:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:15 INFO - 'NO_EM_RESTART': '1', 10:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:15 INFO - 'PWD': '/builds/slave/test', 10:38:15 INFO - 'SHELL': '/bin/bash', 10:38:15 INFO - 'SHLVL': '1', 10:38:15 INFO - 'TERM': 'linux', 10:38:15 INFO - 'TMOUT': '86400', 10:38:15 INFO - 'USER': 'cltbld', 10:38:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', 10:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:15 INFO - '_': '/tools/buildbot/bin/python'} 10:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:38:15 INFO - Cleaning up... 10:38:15 INFO - Return code: 0 10:38:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:38:15 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')]} 10:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:15 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')]} 10:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:15 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 0x28171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b84b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b87f00>, '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 0x2b82ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b83050>, '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': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', '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 10:38:15 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 10:38:15 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 10:38:15 INFO - Using env: {'DISPLAY': ':0', 10:38:15 INFO - 'HOME': '/home/cltbld', 10:38:15 INFO - 'LANG': 'en_US.UTF-8', 10:38:15 INFO - 'LANGUAGE': 'en_US:en', 10:38:15 INFO - 'LOGNAME': 'cltbld', 10:38:15 INFO - 'MAIL': '/var/mail/cltbld', 10:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:15 INFO - 'MOZ_NO_REMOTE': '1', 10:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:15 INFO - 'NO_EM_RESTART': '1', 10:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:15 INFO - 'PWD': '/builds/slave/test', 10:38:15 INFO - 'SHELL': '/bin/bash', 10:38:15 INFO - 'SHLVL': '1', 10:38:15 INFO - 'TERM': 'linux', 10:38:15 INFO - 'TMOUT': '86400', 10:38:15 INFO - 'USER': 'cltbld', 10:38:15 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', 10:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:15 INFO - '_': '/tools/buildbot/bin/python'} 10:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:15 INFO - Downloading/unpacking blobuploader==1.2.4 10:38:15 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 10:38:15 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 10:38:15 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 10:38:15 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 10:38:16 INFO - Downloading blobuploader-1.2.4.tar.gz 10:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:38:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:38:17 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 10:38:17 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 10:38:17 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 10:38:17 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 10:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:38:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:38:17 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 10:38:17 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 10:38:17 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 10:38:17 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 10:38:17 INFO - Downloading docopt-0.6.1.tar.gz 10:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:38:17 INFO - Installing collected packages: blobuploader, requests, docopt 10:38:17 INFO - Running setup.py install for blobuploader 10:38:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:38:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:38:17 INFO - Running setup.py install for requests 10:38:18 INFO - Running setup.py install for docopt 10:38:18 INFO - Successfully installed blobuploader requests docopt 10:38:18 INFO - Cleaning up... 10:38:18 INFO - Return code: 0 10:38:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:18 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 0x28171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b84b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b87f00>, '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 0x2b82ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b83050>, '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': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', '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 10:38:18 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 10:38:18 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 10:38:18 INFO - Using env: {'DISPLAY': ':0', 10:38:18 INFO - 'HOME': '/home/cltbld', 10:38:18 INFO - 'LANG': 'en_US.UTF-8', 10:38:18 INFO - 'LANGUAGE': 'en_US:en', 10:38:18 INFO - 'LOGNAME': 'cltbld', 10:38:18 INFO - 'MAIL': '/var/mail/cltbld', 10:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:18 INFO - 'MOZ_NO_REMOTE': '1', 10:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:18 INFO - 'NO_EM_RESTART': '1', 10:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:18 INFO - 'PWD': '/builds/slave/test', 10:38:18 INFO - 'SHELL': '/bin/bash', 10:38:18 INFO - 'SHLVL': '1', 10:38:18 INFO - 'TERM': 'linux', 10:38:18 INFO - 'TMOUT': '86400', 10:38:18 INFO - 'USER': 'cltbld', 10:38:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', 10:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:18 INFO - '_': '/tools/buildbot/bin/python'} 10:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:18 INFO - Running setup.py (path:/tmp/pip-IFMYkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:18 INFO - Running setup.py (path:/tmp/pip-o37vZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:18 INFO - Running setup.py (path:/tmp/pip-beSV4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:18 INFO - Running setup.py (path:/tmp/pip-5gzMuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:18 INFO - Running setup.py (path:/tmp/pip-Fd4myr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:18 INFO - Running setup.py (path:/tmp/pip-ms0liE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:19 INFO - Running setup.py (path:/tmp/pip-dVy7QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:19 INFO - Running setup.py (path:/tmp/pip-PMYkAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:19 INFO - Running setup.py (path:/tmp/pip-zXHO2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:19 INFO - Running setup.py (path:/tmp/pip-Xz2vBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:19 INFO - Running setup.py (path:/tmp/pip-5w2vWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:19 INFO - Running setup.py (path:/tmp/pip-n9XYEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:19 INFO - Running setup.py (path:/tmp/pip-dVfOAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:19 INFO - Running setup.py (path:/tmp/pip-Z6UHWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:19 INFO - Running setup.py (path:/tmp/pip-Bm4SRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:19 INFO - Running setup.py (path:/tmp/pip-Npoyvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:19 INFO - Running setup.py (path:/tmp/pip-ePdpPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:38:19 INFO - Running setup.py install for manifestparser 10:38:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:38:19 INFO - Running setup.py install for mozcrash 10:38:20 INFO - Running setup.py install for mozdebug 10:38:20 INFO - Running setup.py install for mozdevice 10:38:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Running setup.py install for mozfile 10:38:20 INFO - Running setup.py install for mozhttpd 10:38:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Running setup.py install for mozinfo 10:38:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Running setup.py install for mozInstall 10:38:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Running setup.py install for mozleak 10:38:20 INFO - Running setup.py install for mozlog 10:38:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Running setup.py install for moznetwork 10:38:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Running setup.py install for mozprocess 10:38:21 INFO - Running setup.py install for mozprofile 10:38:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for mozrunner 10:38:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for mozscreenshot 10:38:21 INFO - Running setup.py install for moztest 10:38:21 INFO - Running setup.py install for mozversion 10:38:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:38:21 INFO - Cleaning up... 10:38:21 INFO - Return code: 0 10:38:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:21 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 0x28171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b84b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b87f00>, '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 0x2b82ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b83050>, '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': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', '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 10:38:21 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 10:38:21 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 10:38:21 INFO - Using env: {'DISPLAY': ':0', 10:38:21 INFO - 'HOME': '/home/cltbld', 10:38:21 INFO - 'LANG': 'en_US.UTF-8', 10:38:21 INFO - 'LANGUAGE': 'en_US:en', 10:38:21 INFO - 'LOGNAME': 'cltbld', 10:38:21 INFO - 'MAIL': '/var/mail/cltbld', 10:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:21 INFO - 'MOZ_NO_REMOTE': '1', 10:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:21 INFO - 'NO_EM_RESTART': '1', 10:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:21 INFO - 'PWD': '/builds/slave/test', 10:38:21 INFO - 'SHELL': '/bin/bash', 10:38:21 INFO - 'SHLVL': '1', 10:38:21 INFO - 'TERM': 'linux', 10:38:21 INFO - 'TMOUT': '86400', 10:38:21 INFO - 'USER': 'cltbld', 10:38:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', 10:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:21 INFO - '_': '/tools/buildbot/bin/python'} 10:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:21 INFO - Running setup.py (path:/tmp/pip-o8KVI2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:21 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)) 10:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:21 INFO - Running setup.py (path:/tmp/pip-QpUucB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:21 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)) 10:38:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:21 INFO - Running setup.py (path:/tmp/pip-6dvcrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:22 INFO - Running setup.py (path:/tmp/pip-8f88U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:22 INFO - Running setup.py (path:/tmp/pip-57pzdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:22 INFO - Running setup.py (path:/tmp/pip-HejD4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:22 INFO - Running setup.py (path:/tmp/pip-m2aq2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:22 INFO - Running setup.py (path:/tmp/pip-vVxYVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:22 INFO - Running setup.py (path:/tmp/pip-cuUubQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:22 INFO - Running setup.py (path:/tmp/pip-Ynr4SM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:22 INFO - Running setup.py (path:/tmp/pip-LCcpFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:22 INFO - Running setup.py (path:/tmp/pip-uFmVJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:22 INFO - Running setup.py (path:/tmp/pip-GOMma3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:22 INFO - Running setup.py (path:/tmp/pip-9rkZgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:22 INFO - Running setup.py (path:/tmp/pip-3nOjZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:22 INFO - Running setup.py (path:/tmp/pip-f5lPeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:23 INFO - Running setup.py (path:/tmp/pip-UkdCxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:23 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)) 10:38:23 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)) 10:38:23 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)) 10:38:23 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)) 10:38:23 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)) 10:38:23 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)) 10:38:23 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)) 10:38:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:38:23 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 10:38:23 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 10:38:23 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 10:38:23 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 10:38:24 INFO - Downloading blessings-1.6.tar.gz 10:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:38:24 INFO - Installing collected packages: blessings 10:38:24 INFO - Running setup.py install for blessings 10:38:24 INFO - Successfully installed blessings 10:38:24 INFO - Cleaning up... 10:38:24 INFO - Return code: 0 10:38:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:38:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:38:24 INFO - Reading from file tmpfile_stdout 10:38:24 INFO - Current package versions: 10:38:24 INFO - argparse == 1.2.1 10:38:24 INFO - blessings == 1.6 10:38:24 INFO - blobuploader == 1.2.4 10:38:24 INFO - docopt == 0.6.1 10:38:24 INFO - functools32 == 3.2.3-2 10:38:24 INFO - jsonschema == 2.5.1 10:38:24 INFO - manifestparser == 1.1 10:38:24 INFO - mozInstall == 1.13 10:38:24 INFO - mozcrash == 1.0 10:38:24 INFO - mozdebug == 0.1 10:38:24 INFO - mozdevice == 0.51 10:38:24 INFO - mozfile == 1.2 10:38:24 INFO - mozhttpd == 0.7 10:38:24 INFO - mozinfo == 0.10 10:38:24 INFO - mozleak == 0.1 10:38:24 INFO - mozlog == 3.5 10:38:24 INFO - moznetwork == 0.27 10:38:24 INFO - mozprocess == 0.25 10:38:24 INFO - mozprofile == 0.28 10:38:24 INFO - mozrunner == 6.13 10:38:24 INFO - mozscreenshot == 0.1 10:38:24 INFO - mozsystemmonitor == 0.3 10:38:24 INFO - moztest == 0.8 10:38:24 INFO - mozversion == 1.4 10:38:24 INFO - psutil == 3.1.1 10:38:24 INFO - requests == 1.2.3 10:38:24 INFO - wsgiref == 0.1.2 10:38:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:24 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 0x28171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b84b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b87f00>, '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 0x2b82ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b83050>, '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': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', '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 10:38:24 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 10:38:24 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 10:38:24 INFO - Using env: {'DISPLAY': ':0', 10:38:24 INFO - 'HOME': '/home/cltbld', 10:38:24 INFO - 'LANG': 'en_US.UTF-8', 10:38:24 INFO - 'LANGUAGE': 'en_US:en', 10:38:24 INFO - 'LOGNAME': 'cltbld', 10:38:24 INFO - 'MAIL': '/var/mail/cltbld', 10:38:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:24 INFO - 'MOZ_NO_REMOTE': '1', 10:38:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:24 INFO - 'NO_EM_RESTART': '1', 10:38:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:24 INFO - 'PWD': '/builds/slave/test', 10:38:24 INFO - 'SHELL': '/bin/bash', 10:38:24 INFO - 'SHLVL': '1', 10:38:24 INFO - 'TERM': 'linux', 10:38:24 INFO - 'TMOUT': '86400', 10:38:24 INFO - 'USER': 'cltbld', 10:38:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', 10:38:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:24 INFO - '_': '/tools/buildbot/bin/python'} 10:38:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:24 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)) 10:38:24 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)) 10:38:24 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)) 10:38:24 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)) 10:38:24 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)) 10:38:24 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)) 10:38:24 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)) 10:38:24 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)) 10:38:24 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)) 10:38:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:38:26 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)) 10:38:26 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)) 10:38:26 INFO - Installing collected packages: simplejson 10:38:26 INFO - Running setup.py install for simplejson 10:38:26 INFO - building 'simplejson._speedups' extension 10:38:26 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 10:38:26 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 10:38:27 INFO - Successfully installed simplejson 10:38:27 INFO - Cleaning up... 10:38:27 INFO - Return code: 0 10:38:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29e3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b84b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b87f00>, '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 0x2b82ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b83050>, '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': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', '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 10:38:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:38:27 INFO - Using env: {'DISPLAY': ':0', 10:38:27 INFO - 'HOME': '/home/cltbld', 10:38:27 INFO - 'LANG': 'en_US.UTF-8', 10:38:27 INFO - 'LANGUAGE': 'en_US:en', 10:38:27 INFO - 'LOGNAME': 'cltbld', 10:38:27 INFO - 'MAIL': '/var/mail/cltbld', 10:38:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:27 INFO - 'MOZ_NO_REMOTE': '1', 10:38:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:27 INFO - 'NO_EM_RESTART': '1', 10:38:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:27 INFO - 'PWD': '/builds/slave/test', 10:38:27 INFO - 'SHELL': '/bin/bash', 10:38:27 INFO - 'SHLVL': '1', 10:38:27 INFO - 'TERM': 'linux', 10:38:27 INFO - 'TMOUT': '86400', 10:38:27 INFO - 'USER': 'cltbld', 10:38:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', 10:38:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:27 INFO - '_': '/tools/buildbot/bin/python'} 10:38:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:38:27 INFO - Cleaning up... 10:38:27 INFO - Return code: 0 10:38:27 INFO - Running post-action listener: _resource_record_post_action 10:38:27 INFO - Running post-action listener: _start_resource_monitoring 10:38:27 INFO - Starting resource monitoring. 10:38:27 INFO - [mozharness: 2017-08-13 17:38:27.339223Z] Finished create-virtualenv step (success) 10:38:27 INFO - [mozharness: 2017-08-13 17:38:27.339750Z] Running install step. 10:38:27 INFO - Running pre-action listener: _resource_record_pre_action 10:38:27 INFO - Running main action method: install 10:38:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:38:27 INFO - Reading from file tmpfile_stdout 10:38:27 INFO - Detecting whether we're running mozinstall >=1.0... 10:38:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:38:27 INFO - Reading from file tmpfile_stdout 10:38:27 INFO - Output received: 10:38:27 INFO - Usage: mozinstall [options] installer 10:38:27 INFO - Options: 10:38:27 INFO - -h, --help show this help message and exit 10:38:27 INFO - -d DEST, --destination=DEST 10:38:27 INFO - Directory to install application into. [default: 10:38:27 INFO - "/builds/slave/test"] 10:38:27 INFO - --app=APP Application being installed. [default: firefox] 10:38:27 INFO - mkdir: /builds/slave/test/build/application 10:38:27 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'] 10:38:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:38:45 INFO - Reading from file tmpfile_stdout 10:38:45 INFO - Output received: 10:38:45 INFO - /builds/slave/test/build/application/firefox/firefox 10:38:45 INFO - Running post-action listener: _resource_record_post_action 10:38:45 INFO - [mozharness: 2017-08-13 17:38:45.566727Z] Finished install step (success) 10:38:45 INFO - [mozharness: 2017-08-13 17:38:45.566875Z] Running setup-mitmproxy step. 10:38:45 INFO - Running pre-action listener: _resource_record_pre_action 10:38:45 INFO - Running main action method: setup_mitmproxy 10:38:45 INFO - Skipping: mitmproxy is not required 10:38:45 INFO - Running post-action listener: _resource_record_post_action 10:38:45 INFO - [mozharness: 2017-08-13 17:38:45.567416Z] Finished setup-mitmproxy step (success) 10:38:45 INFO - [mozharness: 2017-08-13 17:38:45.567522Z] Running run-tests step. 10:38:45 INFO - Running pre-action listener: _resource_record_pre_action 10:38:45 INFO - Running pre-action listener: _set_gcov_prefix 10:38:45 INFO - Running main action method: run_tests 10:38:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:38:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:38:45 INFO - Python 2.7.3 10:38:45 INFO - Return code: 0 10:38:45 INFO - grabbing minidump binary from tooltool 10:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:45 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 0x2b87f00>, '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 0x2b82ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b83050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:38:45 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 10:38:45 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 10:38:45 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 10:38:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:38:45 INFO - Return code: 0 10:38:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:38:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:38:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:38:45 INFO - ENV: RUST_BACKTRACE is now full 10:38:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:38:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:38:45 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/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 10:38:45 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/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 10:38:45 INFO - Using env: {'DISPLAY': ':0', 10:38:45 INFO - 'HOME': '/home/cltbld', 10:38:45 INFO - 'LANG': 'en_US.UTF-8', 10:38:45 INFO - 'LANGUAGE': 'en_US:en', 10:38:45 INFO - 'LOGNAME': 'cltbld', 10:38:45 INFO - 'MAIL': '/var/mail/cltbld', 10:38:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:38:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:38:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:45 INFO - 'MOZ_NO_REMOTE': '1', 10:38:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:38:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:45 INFO - 'NO_EM_RESTART': '1', 10:38:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:45 INFO - 'PWD': '/builds/slave/test', 10:38:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:38:45 INFO - 'RUST_BACKTRACE': 'full', 10:38:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:38:45 INFO - 'SHELL': '/bin/bash', 10:38:45 INFO - 'SHLVL': '1', 10:38:45 INFO - 'STYLO_FORCE_ENABLED': '1', 10:38:45 INFO - 'TERM': 'linux', 10:38:45 INFO - 'TMOUT': '86400', 10:38:45 INFO - 'USER': 'cltbld', 10:38:45 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101', 10:38:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:45 INFO - '_': '/tools/buildbot/bin/python'} 10:38:45 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/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 10:38:45 INFO - mozversion application_buildid: 20170813164931 10:38:45 INFO - mozversion application_changeset: 8a12a4fcdb0519ec686ec7ec31b6296429f9fb3e 10:38:45 INFO - mozversion application_display_name: Nightly 10:38:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:38:45 INFO - mozversion application_name: Firefox 10:38:45 INFO - mozversion application_remotingname: firefox 10:38:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:38:45 INFO - mozversion application_vendor: Mozilla 10:38:45 INFO - mozversion application_version: 57.0a1 10:38:45 INFO - mozversion platform_buildid: 20170813164931 10:38:45 INFO - mozversion platform_changeset: 8a12a4fcdb0519ec686ec7ec31b6296429f9fb3e 10:38:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:38:45 INFO - mozversion platform_version: 57.0a1 10:38:45 INFO - using testdate: 1502645925 10:38:45 INFO - actual date: 1502645925 10:38:45 INFO - starting webserver on 'localhost:47500' 10:38:45 INFO - SUITE-START | Running 2 tests 10:38:45 INFO - TEST-START | dromaeo_css 10:38:45 INFO - Initialising browser for dromaeo_css test... 10:38:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47500/getInfo.html -profile /tmp/tmpMJP0b4/profile 10:38:45 INFO - TEST-INFO | started process 5878 (/builds/slave/test/build/application/firefox/firefox http://localhost:47500/getInfo.html) 10:38:53 INFO - TEST-INFO | 5878: exit 0 10:38:54 INFO - Browser initialized. 10:38:54 INFO - Running cycle 1/1 for dromaeo_css test... 10:38:54 INFO - TEST-INFO | started process 6112 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMJP0b4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:55 INFO - PID 6112 | 10:38:55 INFO - PID 6112 | (/builds/slave/test/build/application/firefox/firefox:6167): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:38:55 INFO - PID 6112 | 10:39:05 INFO - PID 6112 | RSS: Main: 167747584 10:39:05 INFO - PID 6112 | 10:42:04 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:47500/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47500/tests/dromaeo/cssquery-ext.html) 10:42:05 INFO - PID 6112 | RSS: Main: 175611904 10:42:05 INFO - PID 6112 | 10:45:07 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:47500/tests/dromaeo/cssquery-ext.html (next: http://localhost:47500/tests/dromaeo/cssquery-jquery.html) 10:45:08 INFO - PID 6112 | RSS: Main: 171515904 10:45:08 INFO - PID 6112 | 10:48:10 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:47500/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47500/tests/dromaeo/cssquery-mootools.html) 10:48:10 INFO - PID 6112 | RSS: Main: 174923776 10:48:10 INFO - PID 6112 | 10:51:12 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:47500/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47500/tests/dromaeo/cssquery-prototype.html) 10:51:13 INFO - PID 6112 | RSS: Main: 173072384 10:51:13 INFO - PID 6112 | 10:54:17 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:47500/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47500/tests/dromaeo/cssquery-yui.html) 10:54:17 INFO - PID 6112 | RSS: Main: 176463872 10:54:17 INFO - PID 6112 | 10:57:19 INFO - PID 6112 | Cycle 1(1): loaded http://localhost:47500/tests/dromaeo/cssquery-yui.html (next: http://localhost:47500/tests/dromaeo/cssquery-dojo.html) 10:57:19 INFO - PID 6112 | RSS: Main: 177102848 10:57:19 INFO - PID 6112 | 10:57:19 INFO - PID 6112 | __start_tp_report 10:57:19 INFO - PID 6112 | _x_x_mozilla_page_load 10:57:19 INFO - PID 6112 | _x_x_mozilla_page_load_details 10:57:19 INFO - PID 6112 | |i|pagename|runs| 10:57:19 INFO - PID 6112 | |0;dojo.html;3137.6077990251206;3166.2242750526125;3179.141631759425;3195.057458049875;3211.293515426605;6208.875822483547;6274.121622972787;6292.811215663526;6312.68436578171;6355.650439225841;6150.384961503847;6186.597871138373;6188.288346840115;6189.969050154754;6263.530235232364;5727.3699893011735;5728.112142617901;5789.739461724212;5791.884162316751;5804.506616937544;5676.801311954083;5780.826575202751;5784.392638772932;5836.416358364172;5859.970700146493;5532.059549876511;5688.459596338341;5703.458171473703;5740.913886291709;5794.5074668653215;5715.714214289269;5720.799772007959;5756;5783.016887129198;5798.043322851724;5591.189277554732;5676.631018983753;5746.856328591777;5761.135829625548;5772.942270577282;6147.569670123094;6153.538484613627;6192.504599632064;6203.627782333075;6231.844203894939;6671.2995135510555;6783.898241526381;6791.490638202105;6796.898046529306;6802.183737951477;6764.627945462998;6781.423578995742;6842.384185423336;6842.828929276759;6847.486438517081;6095.238095238095;6118.969405153035;6179.5056395488255;6250.4374606285655;6344.333844946306;6932.202796678345;6976.930230697628;6977;6987.510874238857;6988;6551.082848401227;6568.934310656928;6569.967150164219;6662.56693314933;6670.699818508178;6445.6786358796335;6593.7362505500205;6669.066330713704;6669.066330713704;6772.661366931732;6544.7382104716235;6594.604323740591;6601.801945941629;6616.801495955129;6617.735290588419;6631.668416579152;6636.933630663631;6638.601683898885;6642.634655094016;6649.4347980421235;5360.195970604363;5399.811006614749;5433.429489903582;5445.1560008198;5455.018096742624;4613.021009996188;4653.581177694024;4678.181318269358;4679.344891715163;4684.320773487825;5756.25168728071;5788.913166302509;5844.386339434383;5862.12068189775;5873.3245676746865;6574.3754343337305;6676.298988606127;6702.832429189211;6767.830804229835;6772.221194562689;5825.650460972355;5840.094785308284;5847.152162936351;5847.766089356378;5847.8245652630485;5920.763169473259;5939.970300148558;5942.197803296586;5943.138244954457;5947.49446297061;6492.837679057967;6502.479801615859;6515.837104072341;6594.769183078569;6611.900821487681;6518.185226846645;6605.273419923708;6745.696443660146;6819.829504262433;6831.726730930707;6424.614523128627;6442.484601231984;6447;6454.580452270588;6490.578112422678;6446.323136070832;6572.34276572339;6629.337066293525;6632.2372927114;6634.203895532567;6742.022406751092;6778.694958726967;6785.355391237825;6787.253402125861;6826.351496607815;6499.902501462577;6519.185101862267;6584.670766461562;6586.769463068769;6601.273859875314;6419.197600299963;6470.158879345843;6499.707513162014;6511.837204069936;6520.445762110274;6332.2717887441695;6344.080108384351;6358.682065896779;6364.77723279683;6368;6437.581557198767;6455;6465.64438955862;6477;6486.610803351814;5677.3471050829685;6239.188905442264;6247.875042499216;6376.458001069961;6467.223933127867 10:57:19 INFO - PID 6112 | |1;ext.html;851.7359618518258;871.6252011634997;1146.9369184694845;1172.6833754886181;1236.777380071588;36121.63878361216;39020.80489597552;39147.41278880819;39190.608093919014;39232;36090.09774755633;36254.637453625524;36388;36443.453348199735;36471.635283647156;7090.503664743457;7194.892076618855;7215.314545118205;7218.566885986857;7446.218147094532;7471.925280747205;7565.243475652445;7567.508111972732;7567.962160189219;7569.962150189242;7559.622018899033;7586.279303466162;7605.8478830423355;7606.42951778616;7623.047119110111;7545.924540754604;7580.65887035082;7585.1656317805;7586.658600362997;7587.544747315179;7428.62856857155;7503.212162722944;7507.549547027142;7508.211637778009;7508.511946723445;36374;36661.266774664626;36684.44973325402;36745.448818267745;36760.26479470422;3520.524729161556;3545.2023294758733;3561.127523756696;3562.038249672574;3566.0728210665156;29973.70026299731;30166.84916575403;30325;30356.54465183024;30419;4981.601471882241;5018.974905125451;5054.873628159288;5081.466446023188;5098;182076.08961955106;183722;184331;185253;185879.99999999866;42499.57500425018;46202;46465;46652.7667361661;46789.76605116953;44424.555754442044;50389.23637672737;50599.747001265496;50604;50899.49100509022;15539.5338139856;15633.530994070195;15658.060516369054;15662.686746265012;15696.529104126894;12776.488940442465;12811.359432028361;12831.35843207836;12917.870821291855;12922.41849116792;14424.567262982127;14456.855431445761;14733.631659208391;14781.630459238606;14807.259637018322;5581.6930068845795;5642.492175704124;5674.404187560329;5833.562482813806;5881.38245484218;1008.4655132779639;1031.8606988056667;1040.6877936619135;1041.5000799616075;1051.5163025008583;22989.655155172684;23348.649770253458;23476.178333758235;23578.0568777247;23774.13969250718;1107.092184408777;1110.8833572474934;1129.5594718059963;1134.8297755336766;1152.0438036429744;12531.498740050296;12569;12628.305443200528;12651.810222846665;12758.80861787074;220879;222862;223422;223477;223505;50639.49360506421;50934;50938;51007;51118.74440627848;1421.4172189402295;1454.6508837878832;1495;1496.1696258576594;1503.0605871330417;22882.65676014828;22995.6550651737;23031.84840757922;23164.6525302124;23180.18869339565;36865.44701829529;37083.443748343256;37106.44340334951;37156.44265336076;37186.62813371832;183459;184593;185171;185238;185768;33848.830755846066;36472;37020.814895925345;37065.073373165884;37111.6288837119;45824.770876145405;46202.53797461982;46489.767551162025;46536;46895.531044690484;34243.65756342504;34317.14207144841;34453.82773086119;34628.82685586556;34895;34668.65331346755;34929.825350873085;34969.125771855906;34984;35090.122746931534;37373;37596.812015939744;37906;37942;38419;34227.65772342344;34318;34414.31171376609;34619;34698.479522807684;24262.878685606458;25160.37099072538;25716.110107852808;25823.741762582133;25921.740782591933 10:57:19 INFO - PID 6112 | |2;jquery.html;555.1783360626273;569.5813577020891;580.8141394753675;582.766893242703;589.1457386789156;21319.467013324676;22336.329910102722;22345.329640110784;22386.88806555967;22634.43413914653;26951.86524067382;27565.586516202275;27592.448151036966;27599;27604.447911041818;6943.930560694404;7099.219085900572;7100.715971361139;7102.964485177593;7103.715851365939;6391.137196478486;6639.601623902558;6931.306869313079;6970.47721420893;6971.407430368425;6984.441244700437;6999.580025198479;7009.4392448603985;7010.7546235881755;7020.333068358524;7012.649367531603;7013.123359580052;7015.438764898821;7016.649167541654;7022.964885175593;6867.896981545281;6876.724931002754;6879.105716256905;6881.8967715484305;6891.896621550681;31326.843365783025;31626.209344766336;32008.679913200802;32235.35529289401;32257.193570160933;1975.6542605044203;2003.378952524722;2006.297795771483;2007.8594498385119;2008.668569686;20272.898635506877;20884.79115208859;21096;21161.15355385783;21161.78838211629;2373.964390534143;2556.2459074572857;2570.1518498895507;2575.36903458652;2589.1196993022463;138251.99999999898;139275;142176;142319.28840355834;142351;20580.588388232452;21282.36152915415;21753.891230543744;21846.631927617582;22546;44542.10915781666;44752.55247447549;44964.325535117;45065.09869802585;45132;10733.141348692243;11135.888641113484;11146;11157.49791259379;11175.273607215668;7524.510906791041;9062.320325975577;9107.08929107084;9197.264218862474;9210.493422861673;10105.696829095139;11519.88480115205;11625.302481851117;11769.588064417705;11987.760244795056;3790.3556395412847;4271.551487093872;4314.633256173261;4475.686701930898;4484.484284307347;925.546482223719;939.9107084827067;952.8380175370204;972.1639390124487;972.2367941166151;19902.90048549748;19934.60130797376;20042.89978550098;20054.49863753418;20495.795042049685;1000.1998401278947;1012.4937531234383;1016.8220561401873;1026.656070216486;1033.245730616654;10865.728356791144;11121.833172502418;11168.776624467466;11195.393940601312;11197.440127993568;485181;491741;500270;502543;505870;105301.94698052922;108292;108657;108829.45585272023;111562;1181.5628217559558;1205.8974987126016;1208.5980262895175;1217.257472941505;1225.2158618484177;17538.561535961704;17766.378176763752;17835.910820445813;17880.731789023434;18047;53072.2039169405;53520;53577;54243.45756542542;55327.72336138294;76887.61556192407;78758.21241787508;78795.81806273025;79039;79228;14678.192699401208;15106.39574417055;15136.091834489966;15164.772528412303;15208.391664333303;23292.95181716793;23825.642615360437;23915.880420597787;23928.760712392654;24391.634125488486;18212.81787182164;19036;19188.424347269603;19345.12946917364;19494;16856.66286674284;17417.82582174162;17545.912270438566;17572.121393929996;18057.458276251735;18427.90786046061;18806.435806925812;18943.715844262624;19831.40505784829;19873.900630496755;14701.55895323142;14858.479953201586;14915.105093694414;14984.100953942798;15001;17743.467695969142;17954.730679039563;18115;18885.43343699691;19290.903545482182 10:57:19 INFO - PID 6112 | |3;mootools.html;1371.6776557508986;1430.8640679135485;1432.7850822376643;1438.6259572511144;1440.7118576284745;14174.220417877026;14746.705065898675;14751.926240368797;14754.852451475483;14764.704705905875;13987.860121398782;14397.64005899853;14955.92522037391;14958.177300248482;14965.775513367309;2682.329417645589;2744.4373903349765;2745.546984747514;2745.8879153942685;2752.3394385347574;2661.081926735273;2667.906623268186;2702.594610808375;2746.1898739871685;2757.1177223288555;2717.0490328385104;2743.9572962274406;2759.227416323433;2763.0605594098;2764.405652784651;2728.4952283827456;2753.8623068846678;2756.421151558175;2757.531219692647;2808.396194818124;2650.204938518456;2655.8539280339573;2685.771709404703;2687;2705.6753189617175;14204.431822727181;14391.640208994755;14396.784048239284;14411.351489183013;14413.639659008504;7227.710891564384;7465.701371945116;7500.699972001114;7502.437317201177;7513.774586762406;4808.855734327975;5023.472535383768;5187.7406129693745;5200.947990520084;5213.32226810516;1877.774667039964;1909.455805095541;1917;1957.5889063296725;1968.22255209193;24131.276061718;24659.50680986388;24666.753332466626;24689.25932222036;24718;6827.863442731117;6884.173899132136;6905.965470172617;7025.578465292099;7111.324424179695;18885.716714249298;18957.526061848563;18958.810411895705;18964.715529267072;18967;7496.212897645778;7743.225677432324;7760.068791745027;7769.72805951789;7770.339521140653;6808.08090907731;6947.270536593584;6964.582125072512;6978.127734033246;6978.337057979586;5534.225208470817;5578.581606379537;5588.441155884379;5645.096784514541;5821.53427725781;1458.1761304862719;1484.4730120807174;1712.6745918275487;1723.3968111161244;1738.5392870889225;922.3405265235389;923.3167456082585;937.6671281695036;938.5541867612966;940.304174910575;8185.386096042821;8453.112423195598;8453.112423195598;8494.490330580185;8525.786855328543;974.2303580171586;989.5003023473244;997.3915911294105;999.3354419311222;1000.1448761309122;4370.978145109254;4470.418845550058;4724.763761811964;5437.048516509674;5457.699826509501;18999.905000474908;19072.71390929137;20030.098645560985;20070.59858802816;20223.393298201077;19402.4179274622;19476.70784938227;19539.51151221231;19550.41348759511;19688.409347719593;9760.755981100387;10154.492275386201;10377.9481102594;10643.308184967953;10666.200034997406;8412.369072319478;8451.619677114422;8487.405881588229;8491.95754021226;8507.40448168647;17420.390286339916;17651.82348176502;17925.551861203574;18091.36680216239;18330.54173645616;17416.65166696684;17499.56251093733;17861.821381786536;18238.90880545589;18273.543161420537;11398.658040258806;11450.828237576276;11653.88346116528;11732.824007640063;11736.823947640622;12041.75916481648;12451.688707782378;13359.732805343645;13528.797068044185;13571.59285221445;10895.78208435811;10920.126389888632;10949.671509854717;11076.944615276872;11154.665360039211;10628.202884783517;10763;10974;10980.945095274472;11101.38942358178;9772.462514561767;9955.900440995498;9962.701118966443;9964.202863771026;9972.800543988935;7106.893396598952;7181.569105853666;7206.099237595301;7238.23998480152;7373.963130184315;7213.1704853942465;7295.52579082358;7341.963290183515;7374.852502950018;7450.254974502506 10:57:19 INFO - PID 6112 | |4;prototype.html;500.65454836163036;507.7332056518986;520.7214140434867;532.8641196494893;534.9224362467443;6286.874262514752;6320.431161195492;6361.137488130343;6377.968110159449;6397.648129352884;6017.969910150443;6184.319724830277;6213.440790328869;6290.150829637997;6326.335734747854;5105;5118.846434606968;5170.560502357304;5170.896582068356;5197.454267301936;5143.434222235551;5165.302684137631;5189.351331083614;5201;5211.114110601188;4938.530839570235;5105.770240339194;5114;5167.48325167484;5177.792888284464;5090.796368145269;5098.898022039557;5134.537891589756;5175.896482070375;5226.764795584208;4830.903381932341;4845.200541910581;4849.951500484985;4881.219004959225;4899.510048995107;6173.876522469571;6198.194234749499;6245.594036387621;6251.687415629201;6255.812325630239;5876.7649294028615;6025.578209525335;6027.156198132265;6037.245344331958;6106.908396374058;6522.7390904363765;6658.400743933021;6661.433778128817;6679.699413526403;6727.697253623599;5310.468953104659;5314.60140489461;5323.334583177103;5332.786688532493;5367.490088441592;7021.9297807021785;7070.752523661698;7072.434205263618;7074;7083.18543367509;5461.836144915579;5465.289512363367;5490.313710786152;5517.117261238182;5517.503424691717;5512.724363781795;5525.889482210333;5530.640508366943;5553.444655534414;5597.104463285855;6022.69886505673;6025.9397406026255;6031.487323577458;6031.698415079229;6045.3652366501765;6598.274189839114;6644.235912869985;6654.772435368842;6760.42536384403;6766.357196066366;1816.582186097205;1857.9814201858078;1861.8324350808493;1875.6623807714743;1941.4466876940005;1418.1207651256286;1428.5642878922029;1438.762604170321;1448.8840892728556;1451.535508637226;5695.487406133385;5727.398623144593;5734.913976290359;5766.308043034863;5827.4172582741385;6689.665516724144;6691.464682825363;6721;6722.361375669304;6786.898196527056;5794.507466865363;5842.415758424208;5851.9569823691445;5864.736086876101;5915;3636.7999760013454;3649.087728067983;3659;3661.6338366163172;3667.688246499024;6653.600783952978;6711.322169457636;6736.093066021695;6750.291219421988;6751.797446076625;6936.410405115521;6962.443004559725;7033.2966703330285;7038.436925045984;7054.964725176444;6536.7712130075215;6670.4997125215805;6702.36327548882;6703.296153903867;6704.765333213314;6820.556663816836;6872.965635171992;6883.724651014104;6884.277150899284;6936.375726184668;6701.32986701326;6718.697658605277;6735.103905320759;6760.695768690519;6835.726570937107;6534.79106365324;6612.603243805387;6613.933860661525;6631.966840165768;6692.698828552824;4967.180415231446;4975.950240497548;4987.376577927759;4992.2511623256805;5066.417362003417;6681.826132587176;6713.6908302880465;6803;6809.557378770364;6830.59016459014;6520.902186467112;6582.605043697394;6622.9799911025675;6628.27089020217;6713.765018224339;6318.210223722035;6530.281669016309;6609.074729537965;6659.20089589233;6723;6284.622922624657;6413;6509.414152726277;6542;6564.6389448580785;6585.539012269095;6620.900686489803;6654.700538475877;6693.2972037935315;6736.629485378156;6312.589681670676;6358.300586935526;6388.808335749749;6418.101465794886;6425.490009847776 10:57:19 INFO - PID 6112 | |5;yui.html;893.4282059481931;906.2025417632486;913.8492148795447;918.5682729117312;919.301330988449;18691.158897849597;19574.21703131873;19601.509962250915;19636.116374763133;21999.560008799854;21219.151233950623;21679.132834686632;21683.13267469299;21710.89144554279;21729.67405488919;1038.3199004651965;1045.1273186888957;1046.5133712823535;1046.9319494232889;1047.2826114111858;1003.1523362758494;1043.1446214104399;1054.2883553601328;1058.2327812336034;1059.6397224943519;1089.1504626391388;1101.3777215873006;1101.895319944604;1102.476323746222;1102.944852757363;1089.6186334782763;1098.7143342730908;1101.4107452512867;1101.5373543111873;1102.244962200891;803.8512875118064;808.9919100808976;809.2554849538438;809.7125520440277;811.6063709101081;17746.822531774647;18746.343877964344;20255.594888102154;20428.693569596468;20436.38690839277;21287.254946076813;21675.45811354713;21718.89140554303;21749.13003479859;21924.561508769893;16963.406280780113;17158.828411715847;17216.139193040424;17268.740968885475;17299.30802767888;3592.6766591006935;3592.8203589820664;3608.9278214435826;3613.674769270778;3614.132608174046;127460;128659.35670321589;129234;131433.34283328618;132637;16855.241514131892;17231.913840430716;17289.48131556055;17422.825771742373;17554.122293885255;28881.711182887902;29051.56422653662;29373.26566835846;29867.850660746557;30236;7509.474336796481;7798.5710785906185;7994.40041996841;8543.700970466003;9022.684206052756;4351.934720979188;4463.152001119777;4470.910581788411;4473.910521789611;4474.284114541658;5257.526822585985;5292.947070529322;5319.973400132974;5357.7589008494715;5362.410134885159;1055.9894401056044;1076.0692001418715;1088.1621151713136;1090.1224514266091;1090.9399983000853;584.3484514766005;592.2626330218819;592.8399332180287;594.4887396838715;610.4536439886277;11158.330500170016;11867;12448.377581121089;12493.25040497573;12610.75088475921;620.7299824576323;622.8941080016408;625.5839866488734;628.4406877878691;631.5610650597882;5193.974030129825;5257.211418287287;5298.284731561267;5351.357837059578;5416.702081385482;108378.45810770895;109120;109348.4532577348;114672.42663786627;115620.42189789166;91040.54479727692;93596.53201733947;93661;96745.51627241819;98069.50965245128;81400.59299703463;83646;85547.57226213829;87472;89102.10897890938;10353.896461035594;10364.689059328231;10478.947605261925;10562.260641755003;10644.520996555018;38386.23227535378;38578.80710596429;38725.22549548937;40147;40242;48603.756981214865;51273.487265126874;51458.742706287725;52043.21935171051;52709.20936185883;15007.6998460028;15295.923520382326;17379.913100434416;18085.186166622272;18250.543736406697;19124.713129302792;19387.2245110194;19520.02399879972;19538.706919395936;19710.507237319183;16316.102614356325;17313.65372692514;17414.82585174132;17555.82444175593;17776.644467110327;17034.48896533106;17416.564585885455;18159.27362905469;18265.17806698675;18341.174647140644;16083.597910052342;16107.436239731553;16137.59656008609;16289.348426062825;17034.574135646708;12766.936165319114;13448.596542103753;13593.45626174942;13700.794488082885;14207.64480887986;12923.612291631267;13630.228070350791;13645.795313070113;13756;14021.369038393093 10:57:19 INFO - PID 6112 | __end_tp_report 10:57:19 INFO - PID 6112 | __start_cc_report 10:57:19 INFO - PID 6112 | _x_x_mozilla_cycle_collect,350 10:57:19 INFO - PID 6112 | __end_cc_report 10:57:19 INFO - PID 6112 | __startTimestamp1502647039856__endTimestamp 10:57:19 INFO - PID 6112 | 10:57:19 INFO - PID 6112 | ------- Summary: start ------- 10:57:19 INFO - PID 6112 | Number of tests: 6 10:57:19 INFO - PID 6112 | 10:57:19 INFO - PID 6112 | [#0] dojo.html Cycles:165 Average:6160.56 Median:6368.00 stddev:721.91 (11.3%) stddev-sans-first:684.07 10:57:19 INFO - PID 6112 | Values: 3137.6 3166.2 3179.1 3195.1 3211.3 6208.9 6274.1 6292.8 6312.7 6355.7 6150.4 6186.6 6188.3 6190.0 6263.5 5727.4 5728.1 5789.7 5791.9 5804.5 5676.8 5780.8 5784.4 5836.4 5860.0 5532.1 5688.5 5703.5 5740.9 5794.5 5715.7 5720.8 5756.0 5783.0 5798.0 5591.2 5676.6 5746.9 5761.1 5772.9 6147.6 6153.5 6192.5 6203.6 6231.8 6671.3 6783.9 6791.5 6796.9 6802.2 6764.6 6781.4 6842.4 6842.8 6847.5 6095.2 6119.0 6179.5 6250.4 6344.3 6932.2 6976.9 6977.0 6987.5 6988.0 6551.1 6568.9 6570.0 6662.6 6670.7 6445.7 6593.7 6669.1 6669.1 6772.7 6544.7 6594.6 6601.8 6616.8 6617.7 6631.7 6636.9 6638.6 6642.6 6649.4 5360.2 5399.8 5433.4 5445.2 5455.0 4613.0 4653.6 4678.2 4679.3 4684.3 5756.3 5788.9 5844.4 5862.1 5873.3 6574.4 6676.3 6702.8 6767.8 6772.2 5825.7 5840.1 5847.2 5847.8 5847.8 5920.8 5940.0 5942.2 5943.1 5947.5 6492.8 6502.5 6515.8 6594.8 6611.9 6518.2 6605.3 6745.7 6819.8 6831.7 6424.6 6442.5 6447.0 6454.6 6490.6 6446.3 6572.3 6629.3 6632.2 6634.2 6742.0 6778.7 6785.4 6787.3 6826.4 6499.9 6519.2 6584.7 6586.8 6601.3 6419.2 6470.2 6499.7 6511.8 6520.4 6332.3 6344.1 6358.7 6364.8 6368.0 6437.6 6455.0 6465.6 6477.0 6486.6 5677.3 6239.2 6247.9 6376.5 6467.2 10:57:19 INFO - PID 6112 | 10:57:19 INFO - PID 6112 | [#1] ext.html Cycles:180 Average:36814.33 Median:3553.16 stddev:51220.17 (1441.5%) stddev-sans-first:51292.67 10:57:19 INFO - PID 6112 | Values: 851.7 871.6 1146.9 1172.7 1236.8 36121.6 39020.8 39147.4 39190.6 39232.0 36090.1 36254.6 36388.0 36443.5 36471.6 7090.5 7194.9 7215.3 7218.6 7446.2 7471.9 7565.2 7567.5 7568.0 7570.0 7559.6 7586.3 7605.8 7606.4 7623.0 7545.9 7580.7 7585.2 7586.7 7587.5 7428.6 7503.2 7507.5 7508.2 7508.5 36374.0 36661.3 36684.4 36745.4 36760.3 3520.5 3545.2 3561.1 3562.0 3566.1 29973.7 30166.8 30325.0 30356.5 30419.0 4981.6 5019.0 5054.9 5081.5 5098.0 182076.1 183722.0 184331.0 185253.0 185880.0 42499.6 46202.0 46465.0 46652.8 46789.8 44424.6 50389.2 50599.7 50604.0 50899.5 15539.5 15633.5 15658.1 15662.7 15696.5 12776.5 12811.4 12831.4 12917.9 12922.4 14424.6 14456.9 14733.6 14781.6 14807.3 5581.7 5642.5 5674.4 5833.6 5881.4 1008.5 1031.9 1040.7 1041.5 1051.5 22989.7 23348.6 23476.2 23578.1 23774.1 1107.1 1110.9 1129.6 1134.8 1152.0 12531.5 12569.0 12628.3 12651.8 12758.8 220879.0 222862.0 223422.0 223477.0 223505.0 50639.5 50934.0 50938.0 51007.0 51118.7 1421.4 1454.7 1495.0 1496.2 1503.1 22882.7 22995.7 23031.8 23164.7 23180.2 36865.4 37083.4 37106.4 37156.4 37186.6 183459.0 184593.0 185171.0 185238.0 185768.0 33848.8 36472.0 37020.8 37065.1 37111.6 45824.8 46202.5 46489.8 46536.0 46895.5 34243.7 34317.1 34453.8 34628.8 34895.0 34668.7 34929.8 34969.1 34984.0 35090.1 37373.0 37596.8 37906.0 37942.0 38419.0 34227.7 34318.0 34414.3 34619.0 34698.5 24262.9 25160.4 25716.1 25823.7 25921.7 10:57:19 INFO - PID 6112 | 10:57:19 INFO - PID 6112 | [#2] jquery.html Cycles:180 Average:36209.14 Median:22340.83 stddev:83520.27 (373.8%) stddev-sans-first:83711.66 10:57:19 INFO - PID 6112 | Values: 555.2 569.6 580.8 582.8 589.1 21319.5 22336.3 22345.3 22386.9 22634.4 26951.9 27565.6 27592.4 27599.0 27604.4 6943.9 7099.2 7100.7 7103.0 7103.7 6391.1 6639.6 6931.3 6970.5 6971.4 6984.4 6999.6 7009.4 7010.8 7020.3 7012.6 7013.1 7015.4 7016.6 7023.0 6867.9 6876.7 6879.1 6881.9 6891.9 31326.8 31626.2 32008.7 32235.4 32257.2 1975.7 2003.4 2006.3 2007.9 2008.7 20272.9 20884.8 21096.0 21161.2 21161.8 2374.0 2556.2 2570.2 2575.4 2589.1 138252.0 139275.0 142176.0 142319.3 142351.0 20580.6 21282.4 21753.9 21846.6 22546.0 44542.1 44752.6 44964.3 45065.1 45132.0 10733.1 11135.9 11146.0 11157.5 11175.3 7524.5 9062.3 9107.1 9197.3 9210.5 10105.7 11519.9 11625.3 11769.6 11987.8 3790.4 4271.6 4314.6 4475.7 4484.5 925.5 939.9 952.8 972.2 972.2 19902.9 19934.6 20042.9 20054.5 20495.8 1000.2 1012.5 1016.8 1026.7 1033.2 10865.7 11121.8 11168.8 11195.4 11197.4 485181.0 491741.0 500270.0 502543.0 505870.0 105301.9 108292.0 108657.0 108829.5 111562.0 1181.6 1205.9 1208.6 1217.3 1225.2 17538.6 17766.4 17835.9 17880.7 18047.0 53072.2 53520.0 53577.0 54243.5 55327.7 76887.6 78758.2 78795.8 79039.0 79228.0 14678.2 15106.4 15136.1 15164.8 15208.4 23293.0 23825.6 23915.9 23928.8 24391.6 18212.8 19036.0 19188.4 19345.1 19494.0 16856.7 17417.8 17545.9 17572.1 18057.5 18427.9 18806.4 18943.7 19831.4 19873.9 14701.6 14858.5 14915.1 14984.1 15001.0 17743.5 17954.7 18115.0 18885.4 19290.9 10:57:19 INFO - PID 6112 | 10:57:19 INFO - PID 6112 | [#3] mootools.html Cycles:180 Average:9040.87 Median:2686.39 stddev:6256.47 (232.9%) stddev-sans-first:6247.48 10:57:19 INFO - PID 6112 | Values: 1371.7 1430.9 1432.8 1438.6 1440.7 14174.2 14746.7 14751.9 14754.9 14764.7 13987.9 14397.6 14955.9 14958.2 14965.8 2682.3 2744.4 2745.5 2745.9 2752.3 2661.1 2667.9 2702.6 2746.2 2757.1 2717.0 2744.0 2759.2 2763.1 2764.4 2728.5 2753.9 2756.4 2757.5 2808.4 2650.2 2655.9 2685.8 2687.0 2705.7 14204.4 14391.6 14396.8 14411.4 14413.6 7227.7 7465.7 7500.7 7502.4 7513.8 4808.9 5023.5 5187.7 5200.9 5213.3 1877.8 1909.5 1917.0 1957.6 1968.2 24131.3 24659.5 24666.8 24689.3 24718.0 6827.9 6884.2 6906.0 7025.6 7111.3 18885.7 18957.5 18958.8 18964.7 18967.0 7496.2 7743.2 7760.1 7769.7 7770.3 6808.1 6947.3 6964.6 6978.1 6978.3 5534.2 5578.6 5588.4 5645.1 5821.5 1458.2 1484.5 1712.7 1723.4 1738.5 922.3 923.3 937.7 938.6 940.3 8185.4 8453.1 8453.1 8494.5 8525.8 974.2 989.5 997.4 999.3 1000.1 4371.0 4470.4 4724.8 5437.0 5457.7 18999.9 19072.7 20030.1 20070.6 20223.4 19402.4 19476.7 19539.5 19550.4 19688.4 9760.8 10154.5 10377.9 10643.3 10666.2 8412.4 8451.6 8487.4 8492.0 8507.4 17420.4 17651.8 17925.6 18091.4 18330.5 17416.7 17499.6 17861.8 18238.9 18273.5 11398.7 11450.8 11653.9 11732.8 11736.8 12041.8 12451.7 13359.7 13528.8 13571.6 10895.8 10920.1 10949.7 11076.9 11154.7 10628.2 10763.0 10974.0 10980.9 11101.4 9772.5 9955.9 9962.7 9964.2 9972.8 7106.9 7181.6 7206.1 7238.2 7374.0 7213.2 7295.5 7342.0 7374.9 7450.3 10:57:19 INFO - PID 6112 | 10:57:19 INFO - PID 6112 | [#4] prototype.html Cycles:180 Average:5664.60 Median:6248.64 stddev:1533.83 (24.5%) stddev-sans-first:1488.35 10:57:19 INFO - PID 6112 | Values: 500.7 507.7 520.7 532.9 534.9 6286.9 6320.4 6361.1 6378.0 6397.6 6018.0 6184.3 6213.4 6290.2 6326.3 5105.0 5118.8 5170.6 5170.9 5197.5 5143.4 5165.3 5189.4 5201.0 5211.1 4938.5 5105.8 5114.0 5167.5 5177.8 5090.8 5098.9 5134.5 5175.9 5226.8 4830.9 4845.2 4850.0 4881.2 4899.5 6173.9 6198.2 6245.6 6251.7 6255.8 5876.8 6025.6 6027.2 6037.2 6106.9 6522.7 6658.4 6661.4 6679.7 6727.7 5310.5 5314.6 5323.3 5332.8 5367.5 7021.9 7070.8 7072.4 7074.0 7083.2 5461.8 5465.3 5490.3 5517.1 5517.5 5512.7 5525.9 5530.6 5553.4 5597.1 6022.7 6025.9 6031.5 6031.7 6045.4 6598.3 6644.2 6654.8 6760.4 6766.4 1816.6 1858.0 1861.8 1875.7 1941.4 1418.1 1428.6 1438.8 1448.9 1451.5 5695.5 5727.4 5734.9 5766.3 5827.4 6689.7 6691.5 6721.0 6722.4 6786.9 5794.5 5842.4 5852.0 5864.7 5915.0 3636.8 3649.1 3659.0 3661.6 3667.7 6653.6 6711.3 6736.1 6750.3 6751.8 6936.4 6962.4 7033.3 7038.4 7055.0 6536.8 6670.5 6702.4 6703.3 6704.8 6820.6 6873.0 6883.7 6884.3 6936.4 6701.3 6718.7 6735.1 6760.7 6835.7 6534.8 6612.6 6613.9 6632.0 6692.7 4967.2 4976.0 4987.4 4992.3 5066.4 6681.8 6713.7 6803.0 6809.6 6830.6 6520.9 6582.6 6623.0 6628.3 6713.8 6318.2 6530.3 6609.1 6659.2 6723.0 6284.6 6413.0 6509.4 6542.0 6564.6 6585.5 6620.9 6654.7 6693.3 6736.6 6312.6 6358.3 6388.8 6418.1 6425.5 10:57:19 INFO - PID 6112 | 10:57:19 INFO - PID 6112 | [#5] yui.html Cycles:180 Average:23084.26 Median:19529.37 stddev:31737.87 (162.5%) stddev-sans-first:31783.16 10:57:19 INFO - PID 6112 | Values: 893.4 906.2 913.8 918.6 919.3 18691.2 19574.2 19601.5 19636.1 21999.6 21219.2 21679.1 21683.1 21710.9 21729.7 1038.3 1045.1 1046.5 1046.9 1047.3 1003.2 1043.1 1054.3 1058.2 1059.6 1089.2 1101.4 1101.9 1102.5 1102.9 1089.6 1098.7 1101.4 1101.5 1102.2 803.9 809.0 809.3 809.7 811.6 17746.8 18746.3 20255.6 20428.7 20436.4 21287.3 21675.5 21718.9 21749.1 21924.6 16963.4 17158.8 17216.1 17268.7 17299.3 3592.7 3592.8 3608.9 3613.7 3614.1 127460.0 128659.4 129234.0 131433.3 132637.0 16855.2 17231.9 17289.5 17422.8 17554.1 28881.7 29051.6 29373.3 29867.9 30236.0 7509.5 7798.6 7994.4 8543.7 9022.7 4351.9 4463.2 4470.9 4473.9 4474.3 5257.5 5292.9 5320.0 5357.8 5362.4 1056.0 1076.1 1088.2 1090.1 1090.9 584.3 592.3 592.8 594.5 610.5 11158.3 11867.0 12448.4 12493.3 12610.8 620.7 622.9 625.6 628.4 631.6 5194.0 5257.2 5298.3 5351.4 5416.7 108378.5 109120.0 109348.5 114672.4 115620.4 91040.5 93596.5 93661.0 96745.5 98069.5 81400.6 83646.0 85547.6 87472.0 89102.1 10353.9 10364.7 10478.9 10562.3 10644.5 38386.2 38578.8 38725.2 40147.0 40242.0 48603.8 51273.5 51458.7 52043.2 52709.2 15007.7 15295.9 17379.9 18085.2 18250.5 19124.7 19387.2 19520.0 19538.7 19710.5 16316.1 17313.7 17414.8 17555.8 17776.6 17034.5 17416.6 18159.3 18265.2 18341.2 16083.6 16107.4 16137.6 16289.3 17034.6 12766.9 13448.6 13593.5 13700.8 14207.6 12923.6 13630.2 13645.8 13756.0 14021.4 10:57:19 INFO - PID 6112 | -------- Summary: end -------- 10:57:19 INFO - PID 6112 | 10:57:20 INFO - TEST-INFO | 6112: exit 0 10:57:20 INFO - TEST-OK | dromaeo_css | took 1114665ms 10:57:20 INFO - TEST-START | kraken 10:57:20 INFO - Initialising browser for kraken test... 10:57:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:47500/getInfo.html -profile /tmp/tmpPR6ixj/profile 10:57:20 INFO - TEST-INFO | started process 6488 (/builds/slave/test/build/application/firefox/firefox http://localhost:47500/getInfo.html) 10:57:27 INFO - TEST-INFO | 6488: exit 0 10:57:27 INFO - Browser initialized. 10:57:27 INFO - Running cycle 1/1 for kraken test... 10:57:27 INFO - TEST-INFO | started process 6720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPR6ixj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:28 INFO - PID 6720 | 10:57:28 INFO - PID 6720 | (/builds/slave/test/build/application/firefox/firefox:6775): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:57:28 INFO - PID 6720 | 10:57:38 INFO - PID 6720 | RSS: Main: 171638784 10:57:38 INFO - PID 6720 | 10:57:41 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47500/tests/kraken/driver.html?testName=audio-beat-detection) 10:57:42 INFO - PID 6720 | RSS: Main: 177688576 10:57:42 INFO - PID 6720 | 10:57:44 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47500/tests/kraken/driver.html?testName=audio-dft) 10:57:45 INFO - PID 6720 | RSS: Main: 181411840 10:57:45 INFO - PID 6720 | 10:57:48 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47500/tests/kraken/driver.html?testName=audio-fft) 10:57:49 INFO - PID 6720 | RSS: Main: 175443968 10:57:49 INFO - PID 6720 | 10:57:51 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47500/tests/kraken/driver.html?testName=audio-oscillator) 10:57:51 INFO - PID 6720 | RSS: Main: 176066560 10:57:51 INFO - PID 6720 | 10:57:54 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47500/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:57:54 INFO - PID 6720 | RSS: Main: 176422912 10:57:54 INFO - PID 6720 | 10:57:57 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47500/tests/kraken/driver.html?testName=imaging-darkroom) 10:57:58 INFO - PID 6720 | RSS: Main: 177557504 10:57:58 INFO - PID 6720 | 10:58:02 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47500/tests/kraken/driver.html?testName=imaging-desaturate) 10:58:02 INFO - PID 6720 | RSS: Main: 176955392 10:58:02 INFO - PID 6720 | 10:58:05 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47500/tests/kraken/driver.html?testName=json-parse-financial) 10:58:06 INFO - PID 6720 | RSS: Main: 177864704 10:58:06 INFO - PID 6720 | 10:58:07 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47500/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:58:08 INFO - PID 6720 | RSS: Main: 177967104 10:58:08 INFO - PID 6720 | 10:58:10 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47500/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:58:11 INFO - PID 6720 | RSS: Main: 174911488 10:58:11 INFO - PID 6720 | 10:58:13 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47500/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:58:13 INFO - PID 6720 | RSS: Main: 174436352 10:58:13 INFO - PID 6720 | 10:58:16 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:58:17 INFO - PID 6720 | RSS: Main: 175030272 10:58:17 INFO - PID 6720 | 10:58:20 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:58:21 INFO - PID 6720 | RSS: Main: 175349760 10:58:21 INFO - PID 6720 | 10:58:22 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:47500/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47500/tests/kraken/driver.html?testName=ai-astar) 10:58:23 INFO - PID 6720 | RSS: Main: 176824320 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | __start_tp_report 10:58:23 INFO - PID 6720 | _x_x_mozilla_page_load 10:58:23 INFO - PID 6720 | _x_x_mozilla_page_load_details 10:58:23 INFO - PID 6720 | |i|pagename|runs| 10:58:23 INFO - PID 6720 | |0;ai-astar;99;108;101;108;110;116;110;99;108;114 10:58:23 INFO - PID 6720 | |1;audio-beat-detection;148;117;157;168;119;148;147;120;174;123 10:58:23 INFO - PID 6720 | |2;audio-dft;164;172;163;161;163;166;165;169;168;165 10:58:23 INFO - PID 6720 | |3;audio-fft;76;75;76;167;79;77;75;74;164;76 10:58:23 INFO - PID 6720 | |4;audio-oscillator;79;80;127;78;79;79;139;77;79;126 10:58:23 INFO - PID 6720 | |5;imaging-gaussian-blur;117;115;118;114;113;113;118;114;115;114 10:58:23 INFO - PID 6720 | |6;imaging-darkroom;154;150;150;150;150;150;150;150;150;152 10:58:23 INFO - PID 6720 | |7;imaging-desaturate;99;94;94;94;101;94;94;93;99;98 10:58:23 INFO - PID 6720 | |8;json-parse-financial;55;56;54;55;55;64;55;55;55;55 10:58:23 INFO - PID 6720 | |9;json-stringify-tinderbox;55;55;57;54;55;55;58;55;56;62 10:58:23 INFO - PID 6720 | |10;stanford-crypto-aes;83;77;77;77;80;82;77;85;79;77 10:58:23 INFO - PID 6720 | |11;stanford-crypto-ccm;134;138;127;126;122;127;125;125;121;177 10:58:23 INFO - PID 6720 | |12;stanford-crypto-pbkdf2;193;181;175;182;176;195;178;176;175;178 10:58:23 INFO - PID 6720 | |13;stanford-crypto-sha256-iterative;69;67;72;69;68;68;69;66;71;70 10:58:23 INFO - PID 6720 | __end_tp_report 10:58:23 INFO - PID 6720 | __start_cc_report 10:58:23 INFO - PID 6720 | _x_x_mozilla_cycle_collect,991 10:58:23 INFO - PID 6720 | __end_cc_report 10:58:23 INFO - PID 6720 | __startTimestamp1502647103207__endTimestamp 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | ------- Summary: start ------- 10:58:23 INFO - PID 6720 | Number of tests: 14 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#0] ai-astar Cycles:10 Average:107.30 Median:112.00 stddev:5.91 (5.3%) stddev-sans-first:5.45 10:58:23 INFO - PID 6720 | Values: 99.0 108.0 101.0 108.0 110.0 116.0 110.0 99.0 108.0 114.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:148.00 stddev:21.14 (14.3%) stddev-sans-first:22.31 10:58:23 INFO - PID 6720 | Values: 148.0 117.0 157.0 168.0 119.0 148.0 147.0 120.0 174.0 123.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#2] audio-dft Cycles:10 Average:165.60 Median:165.50 stddev:3.27 (2.0%) stddev-sans-first:3.42 10:58:23 INFO - PID 6720 | Values: 164.0 172.0 163.0 161.0 163.0 166.0 165.0 169.0 168.0 165.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#3] audio-fft Cycles:10 Average:93.90 Median:76.00 stddev:37.77 (49.7%) stddev-sans-first:39.50 10:58:23 INFO - PID 6720 | Values: 76.0 75.0 76.0 167.0 79.0 77.0 75.0 74.0 164.0 76.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:79.00 stddev:25.34 (32.1%) stddev-sans-first:26.26 10:58:23 INFO - PID 6720 | Values: 79.0 80.0 127.0 78.0 79.0 79.0 139.0 77.0 79.0 126.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#5] imaging-gaussian-blur Cycles:10 Average:115.10 Median:115.00 stddev:1.91 (1.7%) stddev-sans-first:1.90 10:58:23 INFO - PID 6720 | Values: 117.0 115.0 118.0 114.0 113.0 113.0 118.0 114.0 115.0 114.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.00 stddev:1.35 (0.9%) stddev-sans-first:0.67 10:58:23 INFO - PID 6720 | Values: 154.0 150.0 150.0 150.0 150.0 150.0 150.0 150.0 150.0 152.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:94.00 stddev:2.91 (3.1%) stddev-sans-first:2.87 10:58:23 INFO - PID 6720 | Values: 99.0 94.0 94.0 94.0 101.0 94.0 94.0 93.0 99.0 98.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.00 stddev:2.88 (5.2%) stddev-sans-first:3.04 10:58:23 INFO - PID 6720 | Values: 55.0 56.0 54.0 55.0 55.0 64.0 55.0 55.0 55.0 55.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:55.50 stddev:2.35 (4.2%) stddev-sans-first:2.45 10:58:23 INFO - PID 6720 | Values: 55.0 55.0 57.0 54.0 55.0 55.0 58.0 55.0 56.0 62.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#10] stanford-crypto-aes Cycles:10 Average:79.40 Median:79.50 stddev:2.99 (3.8%) stddev-sans-first:2.87 10:58:23 INFO - PID 6720 | Values: 83.0 77.0 77.0 77.0 80.0 82.0 77.0 85.0 79.0 77.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:127.00 stddev:16.57 (13.0%) stddev-sans-first:17.56 10:58:23 INFO - PID 6720 | Values: 134.0 138.0 127.0 126.0 122.0 127.0 125.0 125.0 121.0 177.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.90 Median:179.50 stddev:7.31 (4.1%) stddev-sans-first:6.31 10:58:23 INFO - PID 6720 | Values: 193.0 181.0 175.0 182.0 176.0 195.0 178.0 176.0 175.0 178.0 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.79 (2.6%) stddev-sans-first:1.90 10:58:23 INFO - PID 6720 | Values: 69.0 67.0 72.0 69.0 68.0 68.0 69.0 66.0 71.0 70.0 10:58:23 INFO - PID 6720 | -------- Summary: end -------- 10:58:23 INFO - PID 6720 | 10:58:23 INFO - PID 6720 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:58:23 INFO - TEST-INFO | 6720: exit 0 10:58:23 INFO - TEST-OK | kraken | took 63345ms 10:58:23 INFO - SUITE-END | took 1178s 10:58:24 INFO - Completed test suite (00:19:38) 10:58:24 INFO - javascript benchmark 10:58:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8643.274575019215, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3137.6077990251206, 3166.2242750526125, 3179.141631759425, 3195.057458049875, 3211.293515426605, 6208.875822483547, 6274.121622972787, 6292.811215663526, 6312.68436578171, 6355.650439225841, 6150.384961503847, 6186.597871138373, 6188.288346840115, 6189.969050154754, 6263.530235232364, 5727.3699893011735, 5728.112142617901, 5789.739461724212, 5791.884162316751, 5804.506616937544, 5676.801311954083, 5780.826575202751, 5784.392638772932, 5836.416358364172, 5859.970700146493, 5532.059549876511, 5688.459596338341, 5703.458171473703, 5740.913886291709, 5794.5074668653215, 5715.714214289269, 5720.799772007959, 5756.0, 5783.016887129198, 5798.043322851724, 5591.189277554732, 5676.631018983753, 5746.856328591777, 5761.135829625548, 5772.942270577282, 6147.569670123094, 6153.538484613627, 6192.504599632064, 6203.627782333075, 6231.844203894939, 6671.2995135510555, 6783.898241526381, 6791.490638202105, 6796.898046529306, 6802.183737951477, 6764.627945462998, 6781.423578995742, 6842.384185423336, 6842.828929276759, 6847.486438517081, 6095.238095238095, 6118.969405153035, 6179.5056395488255, 6250.4374606285655, 6344.333844946306, 6932.202796678345, 6976.930230697628, 6977.0, 6987.510874238857, 6988.0, 6551.082848401227, 6568.934310656928, 6569.967150164219, 6662.56693314933, 6670.699818508178, 6445.6786358796335, 6593.7362505500205, 6669.066330713704, 6669.066330713704, 6772.661366931732, 6544.7382104716235, 6594.604323740591, 6601.801945941629, 6616.801495955129, 6617.735290588419, 6631.668416579152, 6636.933630663631, 6638.601683898885, 6642.634655094016, 6649.4347980421235, 5360.195970604363, 5399.811006614749, 5433.429489903582, 5445.1560008198, 5455.018096742624, 4613.021009996188, 4653.581177694024, 4678.181318269358, 4679.344891715163, 4684.320773487825, 5756.25168728071, 5788.913166302509, 5844.386339434383, 5862.12068189775, 5873.3245676746865, 6574.3754343337305, 6676.298988606127, 6702.832429189211, 6767.830804229835, 6772.221194562689, 5825.650460972355, 5840.094785308284, 5847.152162936351, 5847.766089356378, 5847.8245652630485, 5920.763169473259, 5939.970300148558, 5942.197803296586, 5943.138244954457, 5947.49446297061, 6492.837679057967, 6502.479801615859, 6515.837104072341, 6594.769183078569, 6611.900821487681, 6518.185226846645, 6605.273419923708, 6745.696443660146, 6819.829504262433, 6831.726730930707, 6424.614523128627, 6442.484601231984, 6447.0, 6454.580452270588, 6490.578112422678, 6446.323136070832, 6572.34276572339, 6629.337066293525, 6632.2372927114, 6634.203895532567, 6742.022406751092, 6778.694958726967, 6785.355391237825, 6787.253402125861, 6826.351496607815, 6499.902501462577, 6519.185101862267, 6584.670766461562, 6586.769463068769, 6601.273859875314, 6419.197600299963, 6470.158879345843, 6499.707513162014, 6511.837204069936, 6520.445762110274, 6332.2717887441695, 6344.080108384351, 6358.682065896779, 6364.77723279683, 6368.0, 6437.581557198767, 6455.0, 6465.64438955862, 6477.0, 6486.610803351814, 5677.3471050829685, 6239.188905442264, 6247.875042499216, 6376.458001069961, 6467.223933127867], "value": 6107.069000603586, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [851.7359618518258, 871.6252011634997, 1146.9369184694845, 1172.6833754886181, 1236.777380071588, 36121.63878361216, 39020.80489597552, 39147.41278880819, 39190.608093919014, 39232.0, 36090.09774755633, 36254.637453625524, 36388.0, 36443.453348199735, 36471.635283647156, 7090.503664743457, 7194.892076618855, 7215.314545118205, 7218.566885986857, 7446.218147094532, 7471.925280747205, 7565.243475652445, 7567.508111972732, 7567.962160189219, 7569.962150189242, 7559.622018899033, 7586.279303466162, 7605.8478830423355, 7606.42951778616, 7623.047119110111, 7545.924540754604, 7580.65887035082, 7585.1656317805, 7586.658600362997, 7587.544747315179, 7428.62856857155, 7503.212162722944, 7507.549547027142, 7508.211637778009, 7508.511946723445, 36374.0, 36661.266774664626, 36684.44973325402, 36745.448818267745, 36760.26479470422, 3520.524729161556, 3545.2023294758733, 3561.127523756696, 3562.038249672574, 3566.0728210665156, 29973.70026299731, 30166.84916575403, 30325.0, 30356.54465183024, 30419.0, 4981.601471882241, 5018.974905125451, 5054.873628159288, 5081.466446023188, 5098.0, 182076.08961955106, 183722.0, 184331.0, 185253.0, 185879.99999999866, 42499.57500425018, 46202.0, 46465.0, 46652.7667361661, 46789.76605116953, 44424.555754442044, 50389.23637672737, 50599.747001265496, 50604.0, 50899.49100509022, 15539.5338139856, 15633.530994070195, 15658.060516369054, 15662.686746265012, 15696.529104126894, 12776.488940442465, 12811.359432028361, 12831.35843207836, 12917.870821291855, 12922.41849116792, 14424.567262982127, 14456.855431445761, 14733.631659208391, 14781.630459238606, 14807.259637018322, 5581.6930068845795, 5642.492175704124, 5674.404187560329, 5833.562482813806, 5881.38245484218, 1008.4655132779639, 1031.8606988056667, 1040.6877936619135, 1041.5000799616075, 1051.5163025008583, 22989.655155172684, 23348.649770253458, 23476.178333758235, 23578.0568777247, 23774.13969250718, 1107.092184408777, 1110.8833572474934, 1129.5594718059963, 1134.8297755336766, 1152.0438036429744, 12531.498740050296, 12569.0, 12628.305443200528, 12651.810222846665, 12758.80861787074, 220879.0, 222862.0, 223422.0, 223477.0, 223505.0, 50639.49360506421, 50934.0, 50938.0, 51007.0, 51118.74440627848, 1421.4172189402295, 1454.6508837878832, 1495.0, 1496.1696258576594, 1503.0605871330417, 22882.65676014828, 22995.6550651737, 23031.84840757922, 23164.6525302124, 23180.18869339565, 36865.44701829529, 37083.443748343256, 37106.44340334951, 37156.44265336076, 37186.62813371832, 183459.0, 184593.0, 185171.0, 185238.0, 185768.0, 33848.830755846066, 36472.0, 37020.814895925345, 37065.073373165884, 37111.6288837119, 45824.770876145405, 46202.53797461982, 46489.767551162025, 46536.0, 46895.531044690484, 34243.65756342504, 34317.14207144841, 34453.82773086119, 34628.82685586556, 34895.0, 34668.65331346755, 34929.825350873085, 34969.125771855906, 34984.0, 35090.122746931534, 37373.0, 37596.812015939744, 37906.0, 37942.0, 38419.0, 34227.65772342344, 34318.0, 34414.31171376609, 34619.0, 34698.479522807684, 24262.878685606458, 25160.37099072538, 25716.110107852808, 25823.741762582133, 25921.740782591933], "value": 17194.38369279938, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.1783360626273, 569.5813577020891, 580.8141394753675, 582.766893242703, 589.1457386789156, 21319.467013324676, 22336.329910102722, 22345.329640110784, 22386.88806555967, 22634.43413914653, 26951.86524067382, 27565.586516202275, 27592.448151036966, 27599.0, 27604.447911041818, 6943.930560694404, 7099.219085900572, 7100.715971361139, 7102.964485177593, 7103.715851365939, 6391.137196478486, 6639.601623902558, 6931.306869313079, 6970.47721420893, 6971.407430368425, 6984.441244700437, 6999.580025198479, 7009.4392448603985, 7010.7546235881755, 7020.333068358524, 7012.649367531603, 7013.123359580052, 7015.438764898821, 7016.649167541654, 7022.964885175593, 6867.896981545281, 6876.724931002754, 6879.105716256905, 6881.8967715484305, 6891.896621550681, 31326.843365783025, 31626.209344766336, 32008.679913200802, 32235.35529289401, 32257.193570160933, 1975.6542605044203, 2003.378952524722, 2006.297795771483, 2007.8594498385119, 2008.668569686, 20272.898635506877, 20884.79115208859, 21096.0, 21161.15355385783, 21161.78838211629, 2373.964390534143, 2556.2459074572857, 2570.1518498895507, 2575.36903458652, 2589.1196993022463, 138251.99999999898, 139275.0, 142176.0, 142319.28840355834, 142351.0, 20580.588388232452, 21282.36152915415, 21753.891230543744, 21846.631927617582, 22546.0, 44542.10915781666, 44752.55247447549, 44964.325535117, 45065.09869802585, 45132.0, 10733.141348692243, 11135.888641113484, 11146.0, 11157.49791259379, 11175.273607215668, 7524.510906791041, 9062.320325975577, 9107.08929107084, 9197.264218862474, 9210.493422861673, 10105.696829095139, 11519.88480115205, 11625.302481851117, 11769.588064417705, 11987.760244795056, 3790.3556395412847, 4271.551487093872, 4314.633256173261, 4475.686701930898, 4484.484284307347, 925.546482223719, 939.9107084827067, 952.8380175370204, 972.1639390124487, 972.2367941166151, 19902.90048549748, 19934.60130797376, 20042.89978550098, 20054.49863753418, 20495.795042049685, 1000.1998401278947, 1012.4937531234383, 1016.8220561401873, 1026.656070216486, 1033.245730616654, 10865.728356791144, 11121.833172502418, 11168.776624467466, 11195.393940601312, 11197.440127993568, 485181.0, 491741.0, 500270.0, 502543.0, 505870.0, 105301.94698052922, 108292.0, 108657.0, 108829.45585272023, 111562.0, 1181.5628217559558, 1205.8974987126016, 1208.5980262895175, 1217.257472941505, 1225.2158618484177, 17538.561535961704, 17766.378176763752, 17835.910820445813, 17880.731789023434, 18047.0, 53072.2039169405, 53520.0, 53577.0, 54243.45756542542, 55327.72336138294, 76887.61556192407, 78758.21241787508, 78795.81806273025, 79039.0, 79228.0, 14678.192699401208, 15106.39574417055, 15136.091834489966, 15164.772528412303, 15208.391664333303, 23292.95181716793, 23825.642615360437, 23915.880420597787, 23928.760712392654, 24391.634125488486, 18212.81787182164, 19036.0, 19188.424347269603, 19345.12946917364, 19494.0, 16856.66286674284, 17417.82582174162, 17545.912270438566, 17572.121393929996, 18057.458276251735, 18427.90786046061, 18806.435806925812, 18943.715844262624, 19831.40505784829, 19873.900630496755, 14701.55895323142, 14858.479953201586, 14915.105093694414, 14984.100953942798, 15001.0, 17743.467695969142, 17954.730679039563, 18115.0, 18885.43343699691, 19290.903545482182], "value": 12852.964612646372, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.6776557508986, 1430.8640679135485, 1432.7850822376643, 1438.6259572511144, 1440.7118576284745, 14174.220417877026, 14746.705065898675, 14751.926240368797, 14754.852451475483, 14764.704705905875, 13987.860121398782, 14397.64005899853, 14955.92522037391, 14958.177300248482, 14965.775513367309, 2682.329417645589, 2744.4373903349765, 2745.546984747514, 2745.8879153942685, 2752.3394385347574, 2661.081926735273, 2667.906623268186, 2702.594610808375, 2746.1898739871685, 2757.1177223288555, 2717.0490328385104, 2743.9572962274406, 2759.227416323433, 2763.0605594098, 2764.405652784651, 2728.4952283827456, 2753.8623068846678, 2756.421151558175, 2757.531219692647, 2808.396194818124, 2650.204938518456, 2655.8539280339573, 2685.771709404703, 2687.0, 2705.6753189617175, 14204.431822727181, 14391.640208994755, 14396.784048239284, 14411.351489183013, 14413.639659008504, 7227.710891564384, 7465.701371945116, 7500.699972001114, 7502.437317201177, 7513.774586762406, 4808.855734327975, 5023.472535383768, 5187.7406129693745, 5200.947990520084, 5213.32226810516, 1877.774667039964, 1909.455805095541, 1917.0, 1957.5889063296725, 1968.22255209193, 24131.276061718, 24659.50680986388, 24666.753332466626, 24689.25932222036, 24718.0, 6827.863442731117, 6884.173899132136, 6905.965470172617, 7025.578465292099, 7111.324424179695, 18885.716714249298, 18957.526061848563, 18958.810411895705, 18964.715529267072, 18967.0, 7496.212897645778, 7743.225677432324, 7760.068791745027, 7769.72805951789, 7770.339521140653, 6808.08090907731, 6947.270536593584, 6964.582125072512, 6978.127734033246, 6978.337057979586, 5534.225208470817, 5578.581606379537, 5588.441155884379, 5645.096784514541, 5821.53427725781, 1458.1761304862719, 1484.4730120807174, 1712.6745918275487, 1723.3968111161244, 1738.5392870889225, 922.3405265235389, 923.3167456082585, 937.6671281695036, 938.5541867612966, 940.304174910575, 8185.386096042821, 8453.112423195598, 8453.112423195598, 8494.490330580185, 8525.786855328543, 974.2303580171586, 989.5003023473244, 997.3915911294105, 999.3354419311222, 1000.1448761309122, 4370.978145109254, 4470.418845550058, 4724.763761811964, 5437.048516509674, 5457.699826509501, 18999.905000474908, 19072.71390929137, 20030.098645560985, 20070.59858802816, 20223.393298201077, 19402.4179274622, 19476.70784938227, 19539.51151221231, 19550.41348759511, 19688.409347719593, 9760.755981100387, 10154.492275386201, 10377.9481102594, 10643.308184967953, 10666.200034997406, 8412.369072319478, 8451.619677114422, 8487.405881588229, 8491.95754021226, 8507.40448168647, 17420.390286339916, 17651.82348176502, 17925.551861203574, 18091.36680216239, 18330.54173645616, 17416.65166696684, 17499.56251093733, 17861.821381786536, 18238.90880545589, 18273.543161420537, 11398.658040258806, 11450.828237576276, 11653.88346116528, 11732.824007640063, 11736.823947640622, 12041.75916481648, 12451.688707782378, 13359.732805343645, 13528.797068044185, 13571.59285221445, 10895.78208435811, 10920.126389888632, 10949.671509854717, 11076.944615276872, 11154.665360039211, 10628.202884783517, 10763.0, 10974.0, 10980.945095274472, 11101.38942358178, 9772.462514561767, 9955.900440995498, 9962.701118966443, 9964.202863771026, 9972.800543988935, 7106.893396598952, 7181.569105853666, 7206.099237595301, 7238.23998480152, 7373.963130184315, 7213.1704853942465, 7295.52579082358, 7341.963290183515, 7374.852502950018, 7450.254974502506], "value": 6586.384369220454, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.65454836163036, 507.7332056518986, 520.7214140434867, 532.8641196494893, 534.9224362467443, 6286.874262514752, 6320.431161195492, 6361.137488130343, 6377.968110159449, 6397.648129352884, 6017.969910150443, 6184.319724830277, 6213.440790328869, 6290.150829637997, 6326.335734747854, 5105.0, 5118.846434606968, 5170.560502357304, 5170.896582068356, 5197.454267301936, 5143.434222235551, 5165.302684137631, 5189.351331083614, 5201.0, 5211.114110601188, 4938.530839570235, 5105.770240339194, 5114.0, 5167.48325167484, 5177.792888284464, 5090.796368145269, 5098.898022039557, 5134.537891589756, 5175.896482070375, 5226.764795584208, 4830.903381932341, 4845.200541910581, 4849.951500484985, 4881.219004959225, 4899.510048995107, 6173.876522469571, 6198.194234749499, 6245.594036387621, 6251.687415629201, 6255.812325630239, 5876.7649294028615, 6025.578209525335, 6027.156198132265, 6037.245344331958, 6106.908396374058, 6522.7390904363765, 6658.400743933021, 6661.433778128817, 6679.699413526403, 6727.697253623599, 5310.468953104659, 5314.60140489461, 5323.334583177103, 5332.786688532493, 5367.490088441592, 7021.9297807021785, 7070.752523661698, 7072.434205263618, 7074.0, 7083.18543367509, 5461.836144915579, 5465.289512363367, 5490.313710786152, 5517.117261238182, 5517.503424691717, 5512.724363781795, 5525.889482210333, 5530.640508366943, 5553.444655534414, 5597.104463285855, 6022.69886505673, 6025.9397406026255, 6031.487323577458, 6031.698415079229, 6045.3652366501765, 6598.274189839114, 6644.235912869985, 6654.772435368842, 6760.42536384403, 6766.357196066366, 1816.582186097205, 1857.9814201858078, 1861.8324350808493, 1875.6623807714743, 1941.4466876940005, 1418.1207651256286, 1428.5642878922029, 1438.762604170321, 1448.8840892728556, 1451.535508637226, 5695.487406133385, 5727.398623144593, 5734.913976290359, 5766.308043034863, 5827.4172582741385, 6689.665516724144, 6691.464682825363, 6721.0, 6722.361375669304, 6786.898196527056, 5794.507466865363, 5842.415758424208, 5851.9569823691445, 5864.736086876101, 5915.0, 3636.7999760013454, 3649.087728067983, 3659.0, 3661.6338366163172, 3667.688246499024, 6653.600783952978, 6711.322169457636, 6736.093066021695, 6750.291219421988, 6751.797446076625, 6936.410405115521, 6962.443004559725, 7033.2966703330285, 7038.436925045984, 7054.964725176444, 6536.7712130075215, 6670.4997125215805, 6702.36327548882, 6703.296153903867, 6704.765333213314, 6820.556663816836, 6872.965635171992, 6883.724651014104, 6884.277150899284, 6936.375726184668, 6701.32986701326, 6718.697658605277, 6735.103905320759, 6760.695768690519, 6835.726570937107, 6534.79106365324, 6612.603243805387, 6613.933860661525, 6631.966840165768, 6692.698828552824, 4967.180415231446, 4975.950240497548, 4987.376577927759, 4992.2511623256805, 5066.417362003417, 6681.826132587176, 6713.6908302880465, 6803.0, 6809.557378770364, 6830.59016459014, 6520.902186467112, 6582.605043697394, 6622.9799911025675, 6628.27089020217, 6713.765018224339, 6318.210223722035, 6530.281669016309, 6609.074729537965, 6659.20089589233, 6723.0, 6284.622922624657, 6413.0, 6509.414152726277, 6542.0, 6564.6389448580785, 6585.539012269095, 6620.900686489803, 6654.700538475877, 6693.2972037935315, 6736.629485378156, 6312.589681670676, 6358.300586935526, 6388.808335749749, 6418.101465794886, 6425.490009847776], "value": 5221.91920078093, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.4282059481931, 906.2025417632486, 913.8492148795447, 918.5682729117312, 919.301330988449, 18691.158897849597, 19574.21703131873, 19601.509962250915, 19636.116374763133, 21999.560008799854, 21219.151233950623, 21679.132834686632, 21683.13267469299, 21710.89144554279, 21729.67405488919, 1038.3199004651965, 1045.1273186888957, 1046.5133712823535, 1046.9319494232889, 1047.2826114111858, 1003.1523362758494, 1043.1446214104399, 1054.2883553601328, 1058.2327812336034, 1059.6397224943519, 1089.1504626391388, 1101.3777215873006, 1101.895319944604, 1102.476323746222, 1102.944852757363, 1089.6186334782763, 1098.7143342730908, 1101.4107452512867, 1101.5373543111873, 1102.244962200891, 803.8512875118064, 808.9919100808976, 809.2554849538438, 809.7125520440277, 811.6063709101081, 17746.822531774647, 18746.343877964344, 20255.594888102154, 20428.693569596468, 20436.38690839277, 21287.254946076813, 21675.45811354713, 21718.89140554303, 21749.13003479859, 21924.561508769893, 16963.406280780113, 17158.828411715847, 17216.139193040424, 17268.740968885475, 17299.30802767888, 3592.6766591006935, 3592.8203589820664, 3608.9278214435826, 3613.674769270778, 3614.132608174046, 127460.0, 128659.35670321589, 129234.0, 131433.34283328618, 132637.0, 16855.241514131892, 17231.913840430716, 17289.48131556055, 17422.825771742373, 17554.122293885255, 28881.711182887902, 29051.56422653662, 29373.26566835846, 29867.850660746557, 30236.0, 7509.474336796481, 7798.5710785906185, 7994.40041996841, 8543.700970466003, 9022.684206052756, 4351.934720979188, 4463.152001119777, 4470.910581788411, 4473.910521789611, 4474.284114541658, 5257.526822585985, 5292.947070529322, 5319.973400132974, 5357.7589008494715, 5362.410134885159, 1055.9894401056044, 1076.0692001418715, 1088.1621151713136, 1090.1224514266091, 1090.9399983000853, 584.3484514766005, 592.2626330218819, 592.8399332180287, 594.4887396838715, 610.4536439886277, 11158.330500170016, 11867.0, 12448.377581121089, 12493.25040497573, 12610.75088475921, 620.7299824576323, 622.8941080016408, 625.5839866488734, 628.4406877878691, 631.5610650597882, 5193.974030129825, 5257.211418287287, 5298.284731561267, 5351.357837059578, 5416.702081385482, 108378.45810770895, 109120.0, 109348.4532577348, 114672.42663786627, 115620.42189789166, 91040.54479727692, 93596.53201733947, 93661.0, 96745.51627241819, 98069.50965245128, 81400.59299703463, 83646.0, 85547.57226213829, 87472.0, 89102.10897890938, 10353.896461035594, 10364.689059328231, 10478.947605261925, 10562.260641755003, 10644.520996555018, 38386.23227535378, 38578.80710596429, 38725.22549548937, 40147.0, 40242.0, 48603.756981214865, 51273.487265126874, 51458.742706287725, 52043.21935171051, 52709.20936185883, 15007.6998460028, 15295.923520382326, 17379.913100434416, 18085.186166622272, 18250.543736406697, 19124.713129302792, 19387.2245110194, 19520.02399879972, 19538.706919395936, 19710.507237319183, 16316.102614356325, 17313.65372692514, 17414.82585174132, 17555.82444175593, 17776.644467110327, 17034.48896533106, 17416.564585885455, 18159.27362905469, 18265.17806698675, 18341.174647140644, 16083.597910052342, 16107.436239731553, 16137.59656008609, 16289.348426062825, 17034.574135646708, 12766.936165319114, 13448.596542103753, 13593.45626174942, 13700.794488082885, 14207.64480887986, 12923.612291631267, 13630.228070350791, 13645.795313070113, 13756.0, 14021.369038393093], "value": 8981.394023095203, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1538.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 101.0, 108.0, 110.0, 116.0, 110.0, 99.0, 108.0, 114.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 157.0, 168.0, 119.0, 148.0, 147.0, 120.0, 174.0, 123.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 172.0, 163.0, 161.0, 163.0, 166.0, 165.0, 169.0, 168.0, 165.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 167.0, 79.0, 77.0, 75.0, 74.0, 164.0, 76.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 127.0, 78.0, 79.0, 79.0, 139.0, 77.0, 79.0, 126.0], "value": 94.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 118.0, 114.0, 113.0, 113.0, 118.0, 114.0, 115.0, 114.0], "value": 115.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 150.0, 152.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 94.0, 94.0, 94.0, 101.0, 94.0, 94.0, 93.0, 99.0, 98.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 55.0, 55.0, 64.0, 55.0, 55.0, 55.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 57.0, 54.0, 55.0, 55.0, 58.0, 55.0, 56.0, 62.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 77.0, 77.0, 77.0, 80.0, 82.0, 77.0, 85.0, 79.0, 77.0], "value": 79.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 127.0, 126.0, 122.0, 127.0, 125.0, 125.0, 121.0, 177.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 181.0, 175.0, 182.0, 176.0, 195.0, 178.0, 176.0, 175.0, 178.0], "value": 180.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 72.0, 69.0, 68.0, 68.0, 69.0, 66.0, 71.0, 70.0], "value": 68.9, "unit": "score"}]}]} 10:58:24 INFO - Return code: 0 10:58:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:58:24 INFO - # TBPL SUCCESS # 10:58:24 INFO - Running post-action listener: _package_coverage_data 10:58:24 INFO - Running post-action listener: _resource_record_post_action 10:58:24 INFO - [mozharness: 2017-08-13 17:58:24.488612Z] Finished run-tests step (success) 10:58:24 INFO - Running post-run listener: _resource_record_post_run 10:58:24 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 16384; Write bytes: 429260800; Read time: 32; Write time: 1073324 10:58:24 INFO - TinderboxPrint: CPU usage
13.2% 10:58:24 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 32 10:58:24 INFO - TinderboxPrint: I/O write bytes / time
429,260,800 / 1,073,324 10:58:24 INFO - TinderboxPrint: CPU idle
8,282.9 (86.8%) 10:58:24 INFO - TinderboxPrint: CPU user
1,201.7 (12.6%) 10:58:24 INFO - TinderboxPrint: Swap in / out
0 / 0 10:58:24 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 107016192; Read time: 0; Write time: 334868 10:58:24 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:58:24 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 12288; Write bytes: 322244608; Read time: 20; Write time: 738456 10:58:25 INFO - Running post-run listener: _upload_blobber_files 10:58:25 INFO - Blob upload gear active. 10:58:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:58:25 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 10:58:25 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'] 10:58:25 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 10:58:25 INFO - (blobuploader) - INFO - Open directory for files ... 10:58:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:58:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:58:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:58:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:58:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:58:26 INFO - (blobuploader) - INFO - Done attempting. 10:58:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:58:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:58:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:58:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:58:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:58:33 INFO - (blobuploader) - INFO - Done attempting. 10:58:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:58:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:58:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:58:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:58:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:58:33 INFO - (blobuploader) - INFO - Done attempting. 10:58:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:58:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:58:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:58:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:58:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:58:34 INFO - (blobuploader) - INFO - Done attempting. 10:58:34 INFO - (blobuploader) - INFO - Iteration through files over. 10:58:34 INFO - Return code: 0 10:58:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:58:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:58:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dea4fded11f1e2c2ca679e679d31547da7e5ee77f27f1dd3a08a898ed6b368654455267bc5844ec17a1e55e4a8a0a38ebbf01ee58889106fa7830e820c8b3c41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8c7a1cb395f230532668284ad25980e52f6805601da73fc08cabc5e7f152463c7400be00322e195beea2fd22666f429108f86ae475ae95d12da47c670a0b987", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/820a4dd2bb40020e3bb8411ea99a305460925c4a6fc3bf327887fb71c0c9f593fa22f389dd1c33fcbab05cef3645baca2a8988851cf504077d7fd19fe99ed780", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d4ecf9545f4887f9657aa2e3f5dbc0863023ec3d603b8412cf75b59dec93210457c5c44eb9e1e8ede9470ab3dde5dde1f502e2134cac7ff8c7a2be7fd6083ad"} 10:58:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:58:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:58:34 INFO - Contents: 10:58:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dea4fded11f1e2c2ca679e679d31547da7e5ee77f27f1dd3a08a898ed6b368654455267bc5844ec17a1e55e4a8a0a38ebbf01ee58889106fa7830e820c8b3c41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8c7a1cb395f230532668284ad25980e52f6805601da73fc08cabc5e7f152463c7400be00322e195beea2fd22666f429108f86ae475ae95d12da47c670a0b987", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/820a4dd2bb40020e3bb8411ea99a305460925c4a6fc3bf327887fb71c0c9f593fa22f389dd1c33fcbab05cef3645baca2a8988851cf504077d7fd19fe99ed780", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d4ecf9545f4887f9657aa2e3f5dbc0863023ec3d603b8412cf75b59dec93210457c5c44eb9e1e8ede9470ab3dde5dde1f502e2134cac7ff8c7a2be7fd6083ad"} 10:58:34 INFO - Running post-run listener: copy_logs_to_upload_dir 10:58:34 INFO - Copying logs to upload dir... 10:58:34 INFO - mkdir: /builds/slave/test/build/upload/logs 10:58:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.225273 ========= master_lag: -0.18 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-13 10:58:33.727146) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-13 10:58:33.731736) ========= 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=8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101 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/dea4fded11f1e2c2ca679e679d31547da7e5ee77f27f1dd3a08a898ed6b368654455267bc5844ec17a1e55e4a8a0a38ebbf01ee58889106fa7830e820c8b3c41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8c7a1cb395f230532668284ad25980e52f6805601da73fc08cabc5e7f152463c7400be00322e195beea2fd22666f429108f86ae475ae95d12da47c670a0b987", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/820a4dd2bb40020e3bb8411ea99a305460925c4a6fc3bf327887fb71c0c9f593fa22f389dd1c33fcbab05cef3645baca2a8988851cf504077d7fd19fe99ed780", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d4ecf9545f4887f9657aa2e3f5dbc0863023ec3d603b8412cf75b59dec93210457c5c44eb9e1e8ede9470ab3dde5dde1f502e2134cac7ff8c7a2be7fd6083ad"} build_url:https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/J_vgLFRaS7OWlqukWZ875g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dea4fded11f1e2c2ca679e679d31547da7e5ee77f27f1dd3a08a898ed6b368654455267bc5844ec17a1e55e4a8a0a38ebbf01ee58889106fa7830e820c8b3c41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e8c7a1cb395f230532668284ad25980e52f6805601da73fc08cabc5e7f152463c7400be00322e195beea2fd22666f429108f86ae475ae95d12da47c670a0b987", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/820a4dd2bb40020e3bb8411ea99a305460925c4a6fc3bf327887fb71c0c9f593fa22f389dd1c33fcbab05cef3645baca2a8988851cf504077d7fd19fe99ed780", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6d4ecf9545f4887f9657aa2e3f5dbc0863023ec3d603b8412cf75b59dec93210457c5c44eb9e1e8ede9470ab3dde5dde1f502e2134cac7ff8c7a2be7fd6083ad"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-13 10:58:33.758842) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 10:58:33.759129) ========= 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=8783db0840cc980e80bb0bd400000236-1502634568.357444-1886471101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004726 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-13 10:58:33.838000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-13 10:58:33.838293) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-13 10:58:33.841583) ========= ========= Total master_lag: -0.01 =========