builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-009 starttime: 1502819523.82 results: success (0) revision: 5ab5511100233277a760550ac509283278a0e3d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:03.822234) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:03.822993) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:03.823261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:03.890461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:03.890766) ========= 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=17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 10:52:04-- 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% 68.5M=0s 2017-08-15 10:52:04 (68.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087633 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:03.997761) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:03.998038) ========= 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=17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018106 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.054147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.054472) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5ab5511100233277a760550ac509283278a0e3d9 --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 5ab5511100233277a760550ac509283278a0e3d9 --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=17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 10:52:04,385 truncating revision to first 12 chars 2017-08-15 10:52:04,385 Setting DEBUG logging. 2017-08-15 10:52:04,385 attempt 1/10 2017-08-15 10:52:04,385 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5ab551110023?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 10:52:04,662 unpacking tar archive at: mozilla-central-5ab551110023/testing/mozharness/ program finished with exit code 0 elapsedTime=0.598226 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.677466) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.677810) ========= script_repo_revision: 5ab5511100233277a760550ac509283278a0e3d9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.678283) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.678557) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 10:52:04.699658) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-15 10:52:04.700015) ========= /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=17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:52:05 INFO - MultiFileLogger online at 20170815 10:52:05 in /builds/slave/test 10:52:05 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:52:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:52:05 INFO - {'append_to_log': False, 10:52:05 INFO - 'base_work_dir': '/builds/slave/test', 10:52:05 INFO - 'blob_upload_branch': 'Firefox', 10:52:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:52:05 INFO - 'branch': 'Firefox', 10:52:05 INFO - 'buildbot_json_path': 'buildprops.json', 10:52:05 INFO - 'code_coverage': False, 10:52:05 INFO - 'config_files': ('talos/linux_config.py',), 10:52:05 INFO - 'default_actions': ('clobber', 10:52:05 INFO - 'read-buildbot-config', 10:52:05 INFO - 'download-and-extract', 10:52:05 INFO - 'populate-webroot', 10:52:05 INFO - 'create-virtualenv', 10:52:05 INFO - 'install', 10:52:05 INFO - 'setup-mitmproxy', 10:52:05 INFO - 'run-tests'), 10:52:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:52:05 INFO - 'disable_ccov_upload': False, 10:52:05 INFO - 'download_minidump_stackwalk': True, 10:52:05 INFO - 'download_symbols': 'ondemand', 10:52:05 INFO - 'enable_stylo': False, 10:52:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:52:05 INFO - 'tooltool.py': '/tools/tooltool.py', 10:52:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:52:05 INFO - '/tools/misc-python/virtualenv.py')}, 10:52:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:52:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:52:05 INFO - 'gecko_profile': False, 10:52:05 INFO - 'gecko_profile_interval': 0, 10:52:05 INFO - 'installer_path': 'installer.exe', 10:52:05 INFO - 'log_level': 'info', 10:52:05 INFO - 'log_name': 'talos', 10:52:05 INFO - 'log_to_console': True, 10:52:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:52:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:52:05 INFO - 'opt_config_files': (), 10:52:05 INFO - 'pip_index': False, 10:52:05 INFO - 'suite': 'dromaeojs-e10s', 10:52:05 INFO - 'system_bits': '32', 10:52:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:52:05 INFO - 'title': 'talos-linux64-ix-009', 10:52:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:52:05 INFO - 'use_talos_json': True, 10:52:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:52:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:52:05 INFO - 'work_dir': 'build'} 10:52:05 INFO - [mozharness: 2017-08-15 17:52:05.139985Z] Running clobber step. 10:52:05 INFO - Running pre-action listener: _resource_record_pre_action 10:52:05 INFO - Running main action method: clobber 10:52:05 INFO - rmtree: /builds/slave/test/build 10:52:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:52:06 INFO - Running post-action listener: _resource_record_post_action 10:52:06 INFO - [mozharness: 2017-08-15 17:52:06.684669Z] Finished clobber step (success) 10:52:06 INFO - [mozharness: 2017-08-15 17:52:06.684772Z] Running read-buildbot-config step. 10:52:06 INFO - Running pre-action listener: _resource_record_pre_action 10:52:06 INFO - Running main action method: read_buildbot_config 10:52:06 INFO - Using buildbot properties: 10:52:06 INFO - { 10:52:06 INFO - "project": "", 10:52:06 INFO - "product": "firefox", 10:52:06 INFO - "who": "ffxbld@noreply.mozilla.org", 10:52:06 INFO - "installer_path": "public/build/target.tar.bz2", 10:52:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:52:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:52:06 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:52:06 INFO - "stage_platform": "linux64-stylosequential", 10:52:06 INFO - "basedir": "/builds/slave/test", 10:52:06 INFO - "buildnumber": 34, 10:52:06 INFO - "platform": "ubuntu64_hw_styloseq", 10:52:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:52:06 INFO - "slavebuilddir": "test", 10:52:06 INFO - "taskId": "FPcE4FphQEKk1aveiE9c5Q", 10:52:06 INFO - "branch": "mozilla-central", 10:52:06 INFO - "script_repo_revision": "production", 10:52:06 INFO - "revision": "5ab5511100233277a760550ac509283278a0e3d9", 10:52:06 INFO - "slavename": "talos-linux64-ix-009", 10:52:06 INFO - "repo_path": "mozilla-central" 10:52:06 INFO - } 10:52:06 INFO - Finding installer, test and symbols from parent task. 10:52:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FPcE4FphQEKk1aveiE9c5Q'}, attempt #1 10:52:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FPcE4FphQEKk1aveiE9c5Q'}, attempt #1 10:52:07 INFO - Task dependencies: YgRi8VxOQVeYwb_FbxWT9g 10:52:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g'}, attempt #1 10:52:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2 10:52:08 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.test_packages.json 10:52:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.crashreporter-symbols.zip 10:52:08 INFO - Running post-action listener: _resource_record_post_action 10:52:08 INFO - [mozharness: 2017-08-15 17:52:08.099285Z] Finished read-buildbot-config step (success) 10:52:08 INFO - [mozharness: 2017-08-15 17:52:08.099508Z] Running download-and-extract step. 10:52:08 INFO - Running pre-action listener: _resource_record_pre_action 10:52:08 INFO - Running main action method: download_and_extract 10:52:08 INFO - mkdir: /builds/slave/test/build/tests 10:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:08 INFO - trying https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.test_packages.json 10:52:08 INFO - Downloading https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:52:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:52:08 INFO - Downloaded 989 bytes. 10:52:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:52:08 INFO - Using the following test package requirements: 10:52:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:52:08 INFO - u'common': [u'target.common.tests.zip'], 10:52:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:52:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:52:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:52:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:52:08 INFO - u'mozbase': [u'target.common.tests.zip'], 10:52:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:52:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:52:08 INFO - u'web-platform': [u'target.common.tests.zip', 10:52:08 INFO - u'target.web-platform.tests.tar.gz'], 10:52:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:52:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:52:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.common.tests.zip 10:52:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:52:08 INFO - Fetch https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.common.tests.zip into memory 10:52:10 INFO - Content-Length response header: 54002477 10:52:10 INFO - Bytes received: 54002477 10:52:21 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:52:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.common.tests.zip 10:52:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:52:21 INFO - Fetch https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.common.tests.zip into memory 10:52:23 INFO - Content-Length response header: 54002477 10:52:23 INFO - Bytes received: 54002477 10:52:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.talos.tests.zip 10:52:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:52:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.talos.tests.zip into memory 10:52:36 INFO - Content-Length response header: 14496050 10:52:36 INFO - Bytes received: 14496050 10:52: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:52:36 INFO - trying https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2 10:52:36 INFO - Downloading https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:52:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:52:39 INFO - Downloaded 61956701 bytes. 10:52:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2 10:52:39 INFO - mkdir: /builds/slave/test/properties 10:52:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:52:39 INFO - Writing to file /builds/slave/test/properties/build_url 10:52:39 INFO - Contents: 10:52:39 INFO - build_url:https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2 10:52:39 INFO - Running post-action listener: _resource_record_post_action 10:52:39 INFO - Running post-action listener: set_extra_try_arguments 10:52:39 INFO - [mozharness: 2017-08-15 17:52:39.649992Z] Finished download-and-extract step (success) 10:52:39 INFO - [mozharness: 2017-08-15 17:52:39.650224Z] Running populate-webroot step. 10:52:39 INFO - Running pre-action listener: _resource_record_pre_action 10:52:39 INFO - Running main action method: populate_webroot 10:52:39 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:52:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:52:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:52:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:52:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:52:39 INFO - 'tests': ['damp', 'tps']}, 10:52:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:52:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:52:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:52:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:52:39 INFO - 'other-e10s': {'tests': ['a11yr', 10:52:39 INFO - 'ts_paint', 10:52:39 INFO - 'tpaint', 10:52:39 INFO - 'sessionrestore', 10:52:39 INFO - 'sessionrestore_many_windows', 10:52:39 INFO - 'sessionrestore_no_auto_restore', 10:52:39 INFO - 'tabpaint']}, 10:52:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:52:39 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:52:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:52:39 INFO - 'tsvgr_opacity', 10:52:39 INFO - 'tart', 10:52:39 INFO - 'tscrollx', 10:52:39 INFO - 'tsvg_static']}, 10:52:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:52:39 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:52:39 INFO - 'talos_options': ['--mitmproxy', 10:52:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:52:39 INFO - '--firstNonBlankPaint'], 10:52:39 INFO - 'tests': ['tp6_google', 10:52:39 INFO - 'tp6_youtube', 10:52:39 INFO - 'tp6_amazon', 10:52:39 INFO - 'tp6_facebook']}, 10:52:39 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:52:39 INFO - 'talos_options': ['--stylo', 10:52:39 INFO - '--mitmproxy', 10:52:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:52:39 INFO - '--firstNonBlankPaint'], 10:52:39 INFO - 'tests': ['tp6_google', 10:52:39 INFO - 'tp6_youtube', 10:52:39 INFO - 'tp6_amazon', 10:52:39 INFO - 'tp6_facebook']}, 10:52:39 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:52:39 INFO - 'talos_options': ['--stylo', 10:52:39 INFO - '--stylo-threads=1', 10:52:39 INFO - '--mitmproxy', 10:52:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:52:39 INFO - '--firstNonBlankPaint'], 10:52:39 INFO - 'tests': ['tp6_google', 10:52:39 INFO - 'tp6_youtube', 10:52:39 INFO - 'tp6_amazon', 10:52:39 INFO - 'tp6_facebook']}, 10:52:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:52:39 INFO - 'talos_options': ['--xperf_path', 10:52:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:52:39 INFO - 'tests': ['tp5n']}}} 10:52:39 INFO - Running post-action listener: _resource_record_post_action 10:52:39 INFO - [mozharness: 2017-08-15 17:52:39.664582Z] Finished populate-webroot step (success) 10:52:39 INFO - [mozharness: 2017-08-15 17:52:39.664673Z] Running create-virtualenv step. 10:52:39 INFO - Running pre-action listener: _resource_record_pre_action 10:52:39 INFO - Running main action method: create_virtualenv 10:52:39 INFO - Creating virtualenv /builds/slave/test/build/venv 10:52:39 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:52:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:52:39 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:52:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:52:39 INFO - Using real prefix '/usr' 10:52:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:52:40 INFO - Installing distribute.............................................................................................................................................................................................done. 10:52:42 INFO - Installing pip.................done. 10:52:42 INFO - Return code: 0 10:52:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:52:42 INFO - Reading from file tmpfile_stdout 10:52:42 INFO - Output received: 10:52:42 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:52:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f00>, '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 0x1413ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414050>, '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': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', '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:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:52:42 INFO - Using env: {'DISPLAY': ':0', 10:52:42 INFO - 'HOME': '/home/cltbld', 10:52:42 INFO - 'LANG': 'en_US.UTF-8', 10:52:42 INFO - 'LANGUAGE': 'en_US:en', 10:52:42 INFO - 'LOGNAME': 'cltbld', 10:52:42 INFO - 'MAIL': '/var/mail/cltbld', 10:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:42 INFO - 'MOZ_NO_REMOTE': '1', 10:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:42 INFO - 'NO_EM_RESTART': '1', 10:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:42 INFO - 'PWD': '/builds/slave/test', 10:52:42 INFO - 'SHELL': '/bin/bash', 10:52:42 INFO - 'SHLVL': '1', 10:52:42 INFO - 'TERM': 'linux', 10:52:42 INFO - 'TMOUT': '86400', 10:52:42 INFO - 'USER': 'cltbld', 10:52:42 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', 10:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:42 INFO - '_': '/tools/buildbot/bin/python'} 10:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:42 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:52:42 INFO - Cleaning up... 10:52:42 INFO - Return code: 0 10:52:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f00>, '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 0x1413ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414050>, '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': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', '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:52:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:52:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:52:42 INFO - Using env: {'DISPLAY': ':0', 10:52:42 INFO - 'HOME': '/home/cltbld', 10:52:42 INFO - 'LANG': 'en_US.UTF-8', 10:52:42 INFO - 'LANGUAGE': 'en_US:en', 10:52:42 INFO - 'LOGNAME': 'cltbld', 10:52:42 INFO - 'MAIL': '/var/mail/cltbld', 10:52:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:42 INFO - 'MOZ_NO_REMOTE': '1', 10:52:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:42 INFO - 'NO_EM_RESTART': '1', 10:52:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:42 INFO - 'PWD': '/builds/slave/test', 10:52:42 INFO - 'SHELL': '/bin/bash', 10:52:42 INFO - 'SHLVL': '1', 10:52:42 INFO - 'TERM': 'linux', 10:52:42 INFO - 'TMOUT': '86400', 10:52:42 INFO - 'USER': 'cltbld', 10:52:42 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', 10:52:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:42 INFO - '_': '/tools/buildbot/bin/python'} 10:52:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:42 INFO - Downloading/unpacking psutil>=3.1.1 10:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:52:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:44 INFO - Installing collected packages: psutil 10:52:44 INFO - Running setup.py install for psutil 10:52:44 INFO - building 'psutil._psutil_linux' extension 10:52:44 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:52:44 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:52:44 INFO - building 'psutil._psutil_posix' extension 10:52:44 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:52:44 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:52:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:52:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:52:44 INFO - Successfully installed psutil 10:52:44 INFO - Cleaning up... 10:52:44 INFO - Return code: 0 10:52:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:44 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 0x10a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f00>, '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 0x1413ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414050>, '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': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', '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:52:44 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:52:44 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:52:44 INFO - Using env: {'DISPLAY': ':0', 10:52:44 INFO - 'HOME': '/home/cltbld', 10:52:44 INFO - 'LANG': 'en_US.UTF-8', 10:52:44 INFO - 'LANGUAGE': 'en_US:en', 10:52:44 INFO - 'LOGNAME': 'cltbld', 10:52:44 INFO - 'MAIL': '/var/mail/cltbld', 10:52:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:44 INFO - 'MOZ_NO_REMOTE': '1', 10:52:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:44 INFO - 'NO_EM_RESTART': '1', 10:52:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:44 INFO - 'PWD': '/builds/slave/test', 10:52:44 INFO - 'SHELL': '/bin/bash', 10:52:44 INFO - 'SHLVL': '1', 10:52:44 INFO - 'TERM': 'linux', 10:52:44 INFO - 'TMOUT': '86400', 10:52:44 INFO - 'USER': 'cltbld', 10:52:44 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', 10:52:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:44 INFO - '_': '/tools/buildbot/bin/python'} 10:52:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:52:44 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:52:44 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:52:44 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:52:44 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:52:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:52:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:52:46 INFO - Installing collected packages: mozsystemmonitor 10:52:46 INFO - Running setup.py install for mozsystemmonitor 10:52:46 INFO - Successfully installed mozsystemmonitor 10:52:46 INFO - Cleaning up... 10:52:46 INFO - Return code: 0 10:52:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:52:46 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:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:46 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:52:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:46 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 0x10a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f00>, '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 0x1413ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414050>, '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': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', '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:52:46 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:52:46 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:52:46 INFO - Using env: {'DISPLAY': ':0', 10:52:46 INFO - 'HOME': '/home/cltbld', 10:52:46 INFO - 'LANG': 'en_US.UTF-8', 10:52:46 INFO - 'LANGUAGE': 'en_US:en', 10:52:46 INFO - 'LOGNAME': 'cltbld', 10:52:46 INFO - 'MAIL': '/var/mail/cltbld', 10:52:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:46 INFO - 'MOZ_NO_REMOTE': '1', 10:52:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:46 INFO - 'NO_EM_RESTART': '1', 10:52:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:46 INFO - 'PWD': '/builds/slave/test', 10:52:46 INFO - 'SHELL': '/bin/bash', 10:52:46 INFO - 'SHLVL': '1', 10:52:46 INFO - 'TERM': 'linux', 10:52:46 INFO - 'TMOUT': '86400', 10:52:46 INFO - 'USER': 'cltbld', 10:52:46 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', 10:52:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:46 INFO - '_': '/tools/buildbot/bin/python'} 10:52:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:46 INFO - Downloading/unpacking jsonschema==2.5.1 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:52:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:52:47 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:52:47 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:52:47 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:52:47 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:52:47 INFO - Downloading functools32-3.2.3-2.tar.gz 10:52:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:52:47 INFO - warning: no files found matching '*.txt' 10:52:47 INFO - no previously-included directories found matching 'build' 10:52:47 INFO - no previously-included directories found matching 'dist' 10:52:47 INFO - no previously-included directories found matching '.git*' 10:52:47 INFO - Installing collected packages: jsonschema, functools32 10:52:47 INFO - Running setup.py install for functools32 10:52:47 INFO - warning: no files found matching '*.txt' 10:52:47 INFO - no previously-included directories found matching 'build' 10:52:47 INFO - no previously-included directories found matching 'dist' 10:52:47 INFO - no previously-included directories found matching '.git*' 10:52:48 INFO - Successfully installed jsonschema functools32 10:52:48 INFO - Cleaning up... 10:52:48 INFO - Return code: 0 10:52:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:48 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 0x10a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f00>, '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 0x1413ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414050>, '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': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', '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:52:48 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:52:48 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:52:48 INFO - Using env: {'DISPLAY': ':0', 10:52:48 INFO - 'HOME': '/home/cltbld', 10:52:48 INFO - 'LANG': 'en_US.UTF-8', 10:52:48 INFO - 'LANGUAGE': 'en_US:en', 10:52:48 INFO - 'LOGNAME': 'cltbld', 10:52:48 INFO - 'MAIL': '/var/mail/cltbld', 10:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:48 INFO - 'MOZ_NO_REMOTE': '1', 10:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:48 INFO - 'NO_EM_RESTART': '1', 10:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:48 INFO - 'PWD': '/builds/slave/test', 10:52:48 INFO - 'SHELL': '/bin/bash', 10:52:48 INFO - 'SHLVL': '1', 10:52:48 INFO - 'TERM': 'linux', 10:52:48 INFO - 'TMOUT': '86400', 10:52:48 INFO - 'USER': 'cltbld', 10:52:48 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', 10:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:48 INFO - '_': '/tools/buildbot/bin/python'} 10:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:52:48 INFO - Cleaning up... 10:52:48 INFO - Return code: 0 10:52:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:48 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 0x10a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f00>, '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 0x1413ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414050>, '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': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', '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:52:48 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:52:48 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:52:48 INFO - Using env: {'DISPLAY': ':0', 10:52:48 INFO - 'HOME': '/home/cltbld', 10:52:48 INFO - 'LANG': 'en_US.UTF-8', 10:52:48 INFO - 'LANGUAGE': 'en_US:en', 10:52:48 INFO - 'LOGNAME': 'cltbld', 10:52:48 INFO - 'MAIL': '/var/mail/cltbld', 10:52:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:48 INFO - 'MOZ_NO_REMOTE': '1', 10:52:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:48 INFO - 'NO_EM_RESTART': '1', 10:52:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:48 INFO - 'PWD': '/builds/slave/test', 10:52:48 INFO - 'SHELL': '/bin/bash', 10:52:48 INFO - 'SHLVL': '1', 10:52:48 INFO - 'TERM': 'linux', 10:52:48 INFO - 'TMOUT': '86400', 10:52:48 INFO - 'USER': 'cltbld', 10:52:48 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', 10:52:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:48 INFO - '_': '/tools/buildbot/bin/python'} 10:52:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:48 INFO - Downloading/unpacking blobuploader==1.2.4 10:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:49 INFO - Downloading blobuploader-1.2.4.tar.gz 10:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:52:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:52:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:52:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:52:50 INFO - Downloading docopt-0.6.1.tar.gz 10:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:52:50 INFO - Installing collected packages: blobuploader, requests, docopt 10:52:50 INFO - Running setup.py install for blobuploader 10:52:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:52:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:52:50 INFO - Running setup.py install for requests 10:52:50 INFO - Running setup.py install for docopt 10:52:50 INFO - Successfully installed blobuploader requests docopt 10:52:50 INFO - Cleaning up... 10:52:50 INFO - Return code: 0 10:52:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:50 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 0x10a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f00>, '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 0x1413ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414050>, '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': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', '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:52:50 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:52:50 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:52:50 INFO - Using env: {'DISPLAY': ':0', 10:52:50 INFO - 'HOME': '/home/cltbld', 10:52:50 INFO - 'LANG': 'en_US.UTF-8', 10:52:50 INFO - 'LANGUAGE': 'en_US:en', 10:52:50 INFO - 'LOGNAME': 'cltbld', 10:52:50 INFO - 'MAIL': '/var/mail/cltbld', 10:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:50 INFO - 'MOZ_NO_REMOTE': '1', 10:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:50 INFO - 'NO_EM_RESTART': '1', 10:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:50 INFO - 'PWD': '/builds/slave/test', 10:52:50 INFO - 'SHELL': '/bin/bash', 10:52:50 INFO - 'SHLVL': '1', 10:52:50 INFO - 'TERM': 'linux', 10:52:50 INFO - 'TMOUT': '86400', 10:52:50 INFO - 'USER': 'cltbld', 10:52:50 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', 10:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:50 INFO - '_': '/tools/buildbot/bin/python'} 10:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:51 INFO - Running setup.py (path:/tmp/pip-lZMUGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:51 INFO - Running setup.py (path:/tmp/pip-_9caSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:51 INFO - Running setup.py (path:/tmp/pip-Mkv1go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:51 INFO - Running setup.py (path:/tmp/pip-h9hzqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:51 INFO - Running setup.py (path:/tmp/pip-xUu3yE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:51 INFO - Running setup.py (path:/tmp/pip-rEuuAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:51 INFO - Running setup.py (path:/tmp/pip-8bkBwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:51 INFO - Running setup.py (path:/tmp/pip-mHWvqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:51 INFO - Running setup.py (path:/tmp/pip-CxIaMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:51 INFO - Running setup.py (path:/tmp/pip-dREwV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:51 INFO - Running setup.py (path:/tmp/pip-Zt1gu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:51 INFO - Running setup.py (path:/tmp/pip-hkmFGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:51 INFO - Running setup.py (path:/tmp/pip-kLgki5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:51 INFO - Running setup.py (path:/tmp/pip-luYTvv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:52 INFO - Running setup.py (path:/tmp/pip-jW2qhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:52 INFO - Running setup.py (path:/tmp/pip-eqL7ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:52 INFO - Running setup.py (path:/tmp/pip-h5Ug27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:52:52 INFO - Running setup.py install for manifestparser 10:52:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Running setup.py install for mozcrash 10:52:52 INFO - Running setup.py install for mozdebug 10:52:52 INFO - Running setup.py install for mozdevice 10:52:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Running setup.py install for mozfile 10:52:52 INFO - Running setup.py install for mozhttpd 10:52:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Running setup.py install for mozinfo 10:52:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:52:52 INFO - Running setup.py install for mozInstall 10:52:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Running setup.py install for mozleak 10:52:53 INFO - Running setup.py install for mozlog 10:52:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Running setup.py install for moznetwork 10:52:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Running setup.py install for mozprocess 10:52:53 INFO - Running setup.py install for mozprofile 10:52:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Running setup.py install for mozrunner 10:52:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:52:53 INFO - Running setup.py install for mozscreenshot 10:52:53 INFO - Running setup.py install for moztest 10:52:53 INFO - Running setup.py install for mozversion 10:52:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:52:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:52:54 INFO - Cleaning up... 10:52:54 INFO - Return code: 0 10:52:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:54 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:52:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:54 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:52:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:54 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 0x10a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f00>, '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 0x1413ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414050>, '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': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', '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:52:54 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:52:54 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:52:54 INFO - Using env: {'DISPLAY': ':0', 10:52:54 INFO - 'HOME': '/home/cltbld', 10:52:54 INFO - 'LANG': 'en_US.UTF-8', 10:52:54 INFO - 'LANGUAGE': 'en_US:en', 10:52:54 INFO - 'LOGNAME': 'cltbld', 10:52:54 INFO - 'MAIL': '/var/mail/cltbld', 10:52:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:54 INFO - 'MOZ_NO_REMOTE': '1', 10:52:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:54 INFO - 'NO_EM_RESTART': '1', 10:52:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:54 INFO - 'PWD': '/builds/slave/test', 10:52:54 INFO - 'SHELL': '/bin/bash', 10:52:54 INFO - 'SHLVL': '1', 10:52:54 INFO - 'TERM': 'linux', 10:52:54 INFO - 'TMOUT': '86400', 10:52:54 INFO - 'USER': 'cltbld', 10:52:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', 10:52:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:54 INFO - '_': '/tools/buildbot/bin/python'} 10:52:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:52:54 INFO - Running setup.py (path:/tmp/pip-7EQh5H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:52:54 INFO - Running setup.py (path:/tmp/pip-LGm8i2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:52:54 INFO - Running setup.py (path:/tmp/pip-coFVw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:52:54 INFO - Running setup.py (path:/tmp/pip-n79lO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:52:54 INFO - Running setup.py (path:/tmp/pip-n1_PSv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:52:54 INFO - Running setup.py (path:/tmp/pip-cLxQQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:52:54 INFO - Running setup.py (path:/tmp/pip-dPnalB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:52:54 INFO - Running setup.py (path:/tmp/pip-65C6m1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:52:54 INFO - Running setup.py (path:/tmp/pip-jFGT8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:52:54 INFO - Running setup.py (path:/tmp/pip-72YAGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:52:54 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:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:52:54 INFO - Running setup.py (path:/tmp/pip-Pg2ceI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:52:55 INFO - Running setup.py (path:/tmp/pip-ocVg4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:52:55 INFO - Running setup.py (path:/tmp/pip-4xoboL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:52:55 INFO - Running setup.py (path:/tmp/pip-xnSEYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:55 INFO - Running setup.py (path:/tmp/pip-FhYb8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:52:55 INFO - Running setup.py (path:/tmp/pip-T1AZi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:52:55 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:52:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:52:55 INFO - Running setup.py (path:/tmp/pip-oS7beO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:52:55 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:52:55 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:52:55 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:52:55 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:52:55 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:52:55 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:52:55 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:52:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:52:55 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:52:55 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:52:55 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:52:55 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:52:56 INFO - Downloading blessings-1.6.tar.gz 10:52:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:52:56 INFO - Installing collected packages: blessings 10:52:56 INFO - Running setup.py install for blessings 10:52:56 INFO - Successfully installed blessings 10:52:56 INFO - Cleaning up... 10:52:56 INFO - Return code: 0 10:52:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:52:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:57 INFO - Reading from file tmpfile_stdout 10:52:57 INFO - Current package versions: 10:52:57 INFO - argparse == 1.2.1 10:52:57 INFO - blessings == 1.6 10:52:57 INFO - blobuploader == 1.2.4 10:52:57 INFO - docopt == 0.6.1 10:52:57 INFO - functools32 == 3.2.3-2 10:52:57 INFO - jsonschema == 2.5.1 10:52:57 INFO - manifestparser == 1.1 10:52:57 INFO - mozInstall == 1.13 10:52:57 INFO - mozcrash == 1.0 10:52:57 INFO - mozdebug == 0.1 10:52:57 INFO - mozdevice == 0.51 10:52:57 INFO - mozfile == 1.2 10:52:57 INFO - mozhttpd == 0.7 10:52:57 INFO - mozinfo == 0.10 10:52:57 INFO - mozleak == 0.1 10:52:57 INFO - mozlog == 3.5 10:52:57 INFO - moznetwork == 0.27 10:52:57 INFO - mozprocess == 0.25 10:52:57 INFO - mozprofile == 0.28 10:52:57 INFO - mozrunner == 6.13 10:52:57 INFO - mozscreenshot == 0.1 10:52:57 INFO - mozsystemmonitor == 0.3 10:52:57 INFO - moztest == 0.8 10:52:57 INFO - mozversion == 1.4 10:52:57 INFO - psutil == 3.1.1 10:52:57 INFO - requests == 1.2.3 10:52:57 INFO - wsgiref == 0.1.2 10:52:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:52:57 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:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:57 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:52:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:57 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 0x10a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f00>, '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 0x1413ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414050>, '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': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', '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:52:57 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:52:57 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:52:57 INFO - Using env: {'DISPLAY': ':0', 10:52:57 INFO - 'HOME': '/home/cltbld', 10:52:57 INFO - 'LANG': 'en_US.UTF-8', 10:52:57 INFO - 'LANGUAGE': 'en_US:en', 10:52:57 INFO - 'LOGNAME': 'cltbld', 10:52:57 INFO - 'MAIL': '/var/mail/cltbld', 10:52:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:57 INFO - 'MOZ_NO_REMOTE': '1', 10:52:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:57 INFO - 'NO_EM_RESTART': '1', 10:52:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:57 INFO - 'PWD': '/builds/slave/test', 10:52:57 INFO - 'SHELL': '/bin/bash', 10:52:57 INFO - 'SHLVL': '1', 10:52:57 INFO - 'TERM': 'linux', 10:52:57 INFO - 'TMOUT': '86400', 10:52:57 INFO - 'USER': 'cltbld', 10:52:57 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', 10:52:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:57 INFO - '_': '/tools/buildbot/bin/python'} 10:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:57 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:52:57 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:52:57 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:52:57 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:52:57 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:52:57 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:52:57 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:52:57 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:52:57 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:52:57 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:52:57 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:52:57 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:52:57 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:52:57 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:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:52:58 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:52:58 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:52:58 INFO - Installing collected packages: simplejson 10:52:58 INFO - Running setup.py install for simplejson 10:52:58 INFO - building 'simplejson._speedups' extension 10:52:58 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:52:59 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:52:59 INFO - Successfully installed simplejson 10:52:59 INFO - Cleaning up... 10:52:59 INFO - Return code: 0 10:52:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:52:59 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:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:52:59 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:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:52:59 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 0x10a81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1274a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1415b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1418f00>, '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 0x1413ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414050>, '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': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', '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:52:59 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:52:59 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:52:59 INFO - Using env: {'DISPLAY': ':0', 10:52:59 INFO - 'HOME': '/home/cltbld', 10:52:59 INFO - 'LANG': 'en_US.UTF-8', 10:52:59 INFO - 'LANGUAGE': 'en_US:en', 10:52:59 INFO - 'LOGNAME': 'cltbld', 10:52:59 INFO - 'MAIL': '/var/mail/cltbld', 10:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:52:59 INFO - 'MOZ_NO_REMOTE': '1', 10:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:52:59 INFO - 'NO_EM_RESTART': '1', 10:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:52:59 INFO - 'PWD': '/builds/slave/test', 10:52:59 INFO - 'SHELL': '/bin/bash', 10:52:59 INFO - 'SHLVL': '1', 10:52:59 INFO - 'TERM': 'linux', 10:52:59 INFO - 'TMOUT': '86400', 10:52:59 INFO - 'USER': 'cltbld', 10:52:59 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', 10:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:52:59 INFO - '_': '/tools/buildbot/bin/python'} 10:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:52:59 INFO - Cleaning up... 10:52:59 INFO - Return code: 0 10:52:59 INFO - Running post-action listener: _resource_record_post_action 10:52:59 INFO - Running post-action listener: _start_resource_monitoring 10:52:59 INFO - Starting resource monitoring. 10:52:59 INFO - [mozharness: 2017-08-15 17:52:59.741253Z] Finished create-virtualenv step (success) 10:52:59 INFO - [mozharness: 2017-08-15 17:52:59.741767Z] Running install step. 10:52:59 INFO - Running pre-action listener: _resource_record_pre_action 10:52:59 INFO - Running main action method: install 10:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:52:59 INFO - Reading from file tmpfile_stdout 10:52:59 INFO - Detecting whether we're running mozinstall >=1.0... 10:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:53:00 INFO - Reading from file tmpfile_stdout 10:53:00 INFO - Output received: 10:53:00 INFO - Usage: mozinstall [options] installer 10:53:00 INFO - Options: 10:53:00 INFO - -h, --help show this help message and exit 10:53:00 INFO - -d DEST, --destination=DEST 10:53:00 INFO - Directory to install application into. [default: 10:53:00 INFO - "/builds/slave/test"] 10:53:00 INFO - --app=APP Application being installed. [default: firefox] 10:53:00 INFO - mkdir: /builds/slave/test/build/application 10:53:00 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:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:53:18 INFO - Reading from file tmpfile_stdout 10:53:18 INFO - Output received: 10:53:18 INFO - /builds/slave/test/build/application/firefox/firefox 10:53:18 INFO - Running post-action listener: _resource_record_post_action 10:53:18 INFO - [mozharness: 2017-08-15 17:53:18.099356Z] Finished install step (success) 10:53:18 INFO - [mozharness: 2017-08-15 17:53:18.099504Z] Running setup-mitmproxy step. 10:53:18 INFO - Running pre-action listener: _resource_record_pre_action 10:53:18 INFO - Running main action method: setup_mitmproxy 10:53:18 INFO - Skipping: mitmproxy is not required 10:53:18 INFO - Running post-action listener: _resource_record_post_action 10:53:18 INFO - [mozharness: 2017-08-15 17:53:18.100553Z] Finished setup-mitmproxy step (success) 10:53:18 INFO - [mozharness: 2017-08-15 17:53:18.100775Z] Running run-tests step. 10:53:18 INFO - Running pre-action listener: _resource_record_pre_action 10:53:18 INFO - Running pre-action listener: _set_gcov_prefix 10:53:18 INFO - Running main action method: run_tests 10:53:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:53:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:53:18 INFO - Python 2.7.3 10:53:18 INFO - Return code: 0 10:53:18 INFO - grabbing minidump binary from tooltool 10:53: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:53:18 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 0x1418f00>, '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 0x1413ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1414050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:53:18 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:53:18 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:53:18 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:53:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:53:18 INFO - Return code: 0 10:53:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:53:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:53:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:53:18 INFO - ENV: RUST_BACKTRACE is now full 10:53:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:53:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:53:18 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/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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:53:18 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/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-009 --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:53:18 INFO - Using env: {'DISPLAY': ':0', 10:53:18 INFO - 'HOME': '/home/cltbld', 10:53:18 INFO - 'LANG': 'en_US.UTF-8', 10:53:18 INFO - 'LANGUAGE': 'en_US:en', 10:53:18 INFO - 'LOGNAME': 'cltbld', 10:53:18 INFO - 'MAIL': '/var/mail/cltbld', 10:53:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:53:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:53:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:53:18 INFO - 'MOZ_NO_REMOTE': '1', 10:53:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:53:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:53:18 INFO - 'NO_EM_RESTART': '1', 10:53:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:53:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:53:18 INFO - 'PWD': '/builds/slave/test', 10:53:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:53:18 INFO - 'RUST_BACKTRACE': 'full', 10:53:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:53:18 INFO - 'SHELL': '/bin/bash', 10:53:18 INFO - 'SHLVL': '1', 10:53:18 INFO - 'STYLO_FORCE_ENABLED': '1', 10:53:18 INFO - 'TERM': 'linux', 10:53:18 INFO - 'TMOUT': '86400', 10:53:18 INFO - 'USER': 'cltbld', 10:53:18 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208', 10:53:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:53:18 INFO - '_': '/tools/buildbot/bin/python'} 10:53:18 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/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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:53:18 INFO - mozversion application_buildid: 20170815170214 10:53:18 INFO - mozversion application_changeset: 5ab5511100233277a760550ac509283278a0e3d9 10:53:18 INFO - mozversion application_display_name: Nightly 10:53:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:53:18 INFO - mozversion application_name: Firefox 10:53:18 INFO - mozversion application_remotingname: firefox 10:53:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:53:18 INFO - mozversion application_vendor: Mozilla 10:53:18 INFO - mozversion application_version: 57.0a1 10:53:18 INFO - mozversion platform_buildid: 20170815170214 10:53:18 INFO - mozversion platform_changeset: 5ab5511100233277a760550ac509283278a0e3d9 10:53:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:53:18 INFO - mozversion platform_version: 57.0a1 10:53:18 INFO - using testdate: 1502819598 10:53:18 INFO - actual date: 1502819598 10:53:18 INFO - starting webserver on 'localhost:46395' 10:53:18 INFO - SUITE-START | Running 2 tests 10:53:18 INFO - TEST-START | dromaeo_css 10:53:18 INFO - Initialising browser for dromaeo_css test... 10:53:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46395/getInfo.html -profile /tmp/tmpPuET1w/profile 10:53:18 INFO - TEST-INFO | started process 24225 (/builds/slave/test/build/application/firefox/firefox http://localhost:46395/getInfo.html) 10:53:25 INFO - TEST-INFO | 24225: exit 0 10:53:25 INFO - Browser initialized. 10:53:25 INFO - Running cycle 1/1 for dromaeo_css test... 10:53:25 INFO - TEST-INFO | started process 24461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPuET1w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:26 INFO - PID 24461 | 10:53:26 INFO - PID 24461 | (/builds/slave/test/build/application/firefox/firefox:24515): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:53:26 INFO - PID 24461 | 10:53:36 INFO - PID 24461 | RSS: Main: 167026688 10:53:36 INFO - PID 24461 | 10:56:35 INFO - PID 24461 | Cycle 1(1): loaded http://localhost:46395/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46395/tests/dromaeo/cssquery-ext.html) 10:56:36 INFO - PID 24461 | RSS: Main: 174886912 10:56:36 INFO - PID 24461 | 10:59:38 INFO - PID 24461 | Cycle 1(1): loaded http://localhost:46395/tests/dromaeo/cssquery-ext.html (next: http://localhost:46395/tests/dromaeo/cssquery-jquery.html) 10:59:39 INFO - PID 24461 | RSS: Main: 172199936 10:59:39 INFO - PID 24461 | 11:02:40 INFO - PID 24461 | Cycle 1(1): loaded http://localhost:46395/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46395/tests/dromaeo/cssquery-mootools.html) 11:02:41 INFO - PID 24461 | RSS: Main: 173846528 11:02:41 INFO - PID 24461 | 11:05:43 INFO - PID 24461 | Cycle 1(1): loaded http://localhost:46395/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46395/tests/dromaeo/cssquery-prototype.html) 11:05:43 INFO - PID 24461 | RSS: Main: 171872256 11:05:43 INFO - PID 24461 | 11:08:47 INFO - PID 24461 | Cycle 1(1): loaded http://localhost:46395/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46395/tests/dromaeo/cssquery-yui.html) 11:08:48 INFO - PID 24461 | RSS: Main: 175534080 11:08:48 INFO - PID 24461 | 11:11:49 INFO - PID 24461 | Cycle 1(1): loaded http://localhost:46395/tests/dromaeo/cssquery-yui.html (next: http://localhost:46395/tests/dromaeo/cssquery-dojo.html) 11:11:50 INFO - PID 24461 | RSS: Main: 176734208 11:11:50 INFO - PID 24461 | 11:11:50 INFO - PID 24461 | __start_tp_report 11:11:50 INFO - PID 24461 | _x_x_mozilla_page_load 11:11:50 INFO - PID 24461 | _x_x_mozilla_page_load_details 11:11:50 INFO - PID 24461 | |i|pagename|runs| 11:11:50 INFO - PID 24461 | |0;dojo.html;3152.4325621388157;3172.8572214250357;3181.5704879841223;3192.7605429592777;3218.8873389431374;5967.8209653710455;6074.48366888815;6137.539684523662;6171.783987560442;6211.440970312671;6008.519318454524;6059.091136329553;6067.24159480065;6098.786542471014;6129.356417576146;5645.2096706461125;5666.971665141668;5679.630823996447;5686.3744988051285;5708.80019199326;5435.0488664483555;5550.944490555084;5633.0987042073275;5657.405972372903;5692;5568.52667523261;5572.86067848303;5651.095824668033;5659.151127330892;5667.886642267173;5600.4959553639965;5604.047311956936;5636.915446268309;5649.915251271234;5678.403767604384;5475.06923822951;5579.107342825128;5588.1059030555325;5634.32388113429;5641.323041235037;6137.877242455171;6155.630662160284;6191.566590338678;6196.380361963813;6222.906656400158;6565.343465653445;6573.6055836649475;6607.405333520006;6674.566153200075;6683.732650693966;6575.868482630369;6620.172478440195;6626.370494802986;6659.467242620579;6742.8314292142595;5986.49114825236;6116.908246376308;6143.354947730513;6150.108234306045;6166.136740856328;6687.632180230037;6691.364320389555;6704.363085506869;6704.564203326768;6712.060311556386;6264.874702505925;6345.206849143857;6351.618902865843;6448.967755161194;6491.7078731457195;6564.8358791030605;6649.401553860176;6652.83367915806;6655.600663960178;6661;6470.579412338183;6475.902861457082;6553.606783593;6580.078788969548;6583.210014798255;6437.581557198767;6495.197704877136;6499.512536559777;6610;6623.966880165664;5220.060389129917;5232.816851410183;5237.580993520509;5243.606729495303;5247.685138891678;4470.038941627566;4488.39406680094;4495.685302028826;4500.797464114123;4523.185826551252;5611.102223644198;5646.20953066571;5653.604247702704;5654.236678048493;5658.830235092953;6500.707468163944;6532.5753826001155;6539.346065393518;6558.639274839834;6622.933770662328;5671;5681.488666019995;5757.424257574293;5776.364599894008;5780.71096445176;5678.68767217807;5759.8560035999435;5760.337561180434;5766.481016708516;5819.563532735062;6266.279377871512;6286.5599408041;6362.363763623694;6364.522660800366;6364.84087897797;6647.202335719745;6663.400293973566;6691.330866913269;6696.4977626679165;6726.058351830846;6357.268914074755;6381.521385895983;6465.321141280097;6474.125992991075;6478.352164783484;6493.642849643126;6498.090267362668;6600.1089852869245;6603.735850565923;6610.768623098168;6452.9677351612945;6540.869182616226;6582.506312026713;6645.867082658223;6649.700763465559;6247.625142491465;6312.337204593451;6322.778702745381;6351.809445716636;6366.6180029198395;6315.621062736067;6371.5221358397375;6377.043443483514;6385.45723613498;6388;6218.041915160888;6225.844353891189;6297.748090076346;6312.43188113072;6313.905291420724;6280.717367718372;6281.497480201664;6402.487800976004;6408.295087540274;6457.806265812033;6261.092141639528;6285.402886725754;6291.773104244811;6305.495560355253;6334.493240540838 11:11:50 INFO - PID 24461 | |1;ext.html;828.329053466692;868.5743985447131;895.4448242089906;897.7665806890211;1145.4959817680226;29966.25084372889;30216;39804.80097599515;40770.184596308056;40956.59043409573;40828.38757418641;40909;41053.17893642125;41138.7943060285;41154;7187.460940429462;7512.66193021314;7671.539707617533;7677.385809135256;7678.731244406419;7517.4737768356235;7598.506097103698;7598.51828893366;7606.923930760705;7635;7569.545827250355;7652.808679783022;7653.770386888402;7657.731979380723;7658.617069146549;7583.27958843909;7607.391408687292;7615.124260710034;7617.047869016373;7618.580978046205;7465.962670186615;7522.736704215326;7526.774196774106;7530.924690753077;7534.773956781305;37382.62617373819;37465.62534374676;37521.81239093787;37620.62379376226;37657.81171094155;3457.7233821294235;3496.423090190141;3504.2465869838106;3523.612402635708;3527.206378564828;29792;29847.40305193884;30008.699913001026;30035.399292014037;30119.397612047855;4856.8300109495995;4978.800847966077;4987.426445958725;5029.949700502984;5038.647294689373;188901;189816;190519;191868;192119;47249.291260631115;47264.527354726015;47393.5260647396;47422.762886186036;47564.5243547567;48577.27134092992;48873.51126488761;48903;48910.75544622254;48924.510754892;15264.694706105816;15484.148371839432;15485.458008969632;15494.767578486331;15498.225088745517;11557.942210289062;11719.06247500215;12798.61604151877;13005.544805931748;13016.674583135497;14235.85764142366;14313.85686143146;14369.64075898111;14394.352254148589;14478.34847431847;5775.487662866666;5853.09277062056;5947.464728174485;5962.582619216613;5969.611975221596;1006.6225165562914;1009.530568285736;1027.2809033676456;1032.9173666106694;1040.2354269611828;22239.110435582395;22980.65529017066;23037.308880733606;23137.305880823602;23265.534689306118;1120.8879112088725;1136.2330426961933;1138.4194061028934;1140.6406981800706;1144.0790163918125;12107.939460302818;12396;12404.441800119017;12410.81383779244;12433.440495177738;219989;222187;222778;223025;224011;49933.75033124884;49942.25086623704;50072.49927500678;50339.24491132636;50391.74804126029;1481.896267261303;1490.225082956878;1499.377758230344;1514.4320879670124;1537.7385844406479;22483.887580561994;22661.773382265965;22733.545329093657;22883.42791430161;22914.312570622908;35258.118547035505;35653.82173089118;35658.82170589131;35723.64276357307;35948.28103437969;183527;184444;186508;187448;187764;32432;32999.515021824554;34445.31109377748;34569.96290111301;34590.65409345975;44136.33795493135;45355.09289814251;45629.77185114053;45677.77161114173;45764.54235457603;33398.33203335871;33830.492542612374;34208.657913420546;34229;34363.82818085894;33213.33573328568;33234;33299.83350083234;33326.33347332991;33619.15952101119;35905.46141807927;36198.63801361953;36279;36454;36473.635263647026;32515.674843251265;32662.83668581642;32664.51003235001;33146.50280245847;33309.33381332408;23607.29178124659;24186;24799.50400992006;25143.622845657697;25481.793373875767 11:11:50 INFO - PID 24461 | |2;jquery.html;557.1336571631113;564.8305508347495;568.985775355616;573.7676241122347;590.2268028882165;22424.88787556062;23001;23362.76637233627;23392.064317427303;23403.1808886689;26021;26839.463210735823;26841.865790671018;26902.058427955024;27037.459250814973;6485.286618471952;6651.1021012163465;6652.301508341627;6656.201255849305;6664.233613134479;5882.5588080893895;6503.057056726771;6503.349665033506;6524.543281970264;6631.3700198481065;6468.8706225875685;6485.059666348377;6485.351464853524;6489.1888513935755;6499.1876015498065;6424.967875160641;6438.742450301982;6453.645049522274;6458;6487.091807147003;6023.337432882379;6040.939590604125;6042.1238920356745;6055.818325450244;6059.575829691923;29451.70548294511;29648.555271670943;30496.085117446513;30968.225794355323;31011.68988310133;1874.7281644161656;1903.8762480438866;1905.1807722679243;1907.523119220195;1909.9045047747557;19216.231350745955;19666.70499942502;19728.21087156512;19766.110525026408;19881.701774473393;2354.7850315390283;2382.8451150675323;2445.400876785181;2450.9387265318333;2455.4229756007326;129019;135029.32485337608;135203.999999999;135577;135679;14653;14801.629959251104;14822.629434264014;15213.131797824812;15385.538433847003;23528;23559.76440235576;23582.764172358056;23618.409539761644;23621.409464763517;10438.425886576311;10450.372977621368;10533.894661053444;10649.201309901633;10686.25196236256;8396.622152003174;9778.266630002778;9841.261905357127;9854.556544955494;10039.899601003897;8277.875831862528;9311.953440232755;9372.90627093734;9382.671606493877;9388.342816002814;2798.538241190181;2822.7036161203187;2831.5186418308936;2861.241770930705;2895.7683385329124;926.8053708721244;938.9765255868522;973.0755782007121;998;1004.5379125602304;20079.49801254951;20216.09027593762;20250;20281.49296267605;20614.690779638317;1036.0416614631586;1036.9066783989326;1037.9377237365782;1038.7610849504656;1042.5360714481983;11188.049015833583;11265.549378024787;11285.830712539318;11286;11293.830592541119;524355;543305;544452;560843;569302;120354;125865.37067314606;127109.36445317714;127328.36335818446;129244;1250.2186133666457;1259.9525770622738;1289.052546378411;1295.838020247469;1296.857345691973;20858.68711969352;21001.789982099985;21051;21270.680939785605;21452;56578.7171064142;56856.71571642115;58160.4183958155;59130.70434647971;59236.40763592309;67019;67029.32970670231;67495.3250467489;68001;68075.65962170355;14441.638959026108;14577.781333279798;14662.413503459742;15029.173395463355;15096.320665570296;22837.31488055361;22944.541109178055;22973.425664357856;23494.88252558726;24027.51944961126;14409.927950360181;14497;14596.343164557833;14633.902457315531;18088.638227235646;16532.917335413727;16793.07638079917;17663.646727065643;18157;18246.270149194414;18486.907565462086;19199.424017279503;19828.70256946176;19965.900170499055;19983.800161998195;14897.627559311104;15349;15351.385944562093;15359.692806144038;15367.077975321516;18467.907660461613;18562.814371856108;19092.427227183205;19280.903595481934;19426.12582433822 11:11:50 INFO - PID 24461 | |3;mootools.html;1375.7042235919278;1411.4989178841508;1418.0995068131733;1437.1448987852225;1442.4061412139579;13500.32498375081;13918.93040534796;14023.298835058258;14062.64843378916;14560.126392416463;14775.408983640642;14966.925165374185;15007.849921500781;15022.173780442072;15111.168885711282;2688.4354285600048;2738.8904443822225;2744.986275068622;2746.8763905624196;2747;2618.371590818209;2733.521633714102;2821.407504424063;2822.32264256579;2824.166870773127;2720.102366219153;2745.6567929008875;2752.078053851952;2753.4630747004244;2754.7107553706874;2685.4494828560196;2705.9729402706116;2709.552923767576;2729.7270272972546;2764.8202866813594;2663.4673065386805;2668.9599656005175;2680.0351873325585;2683.771879390254;2700.702922678504;14290;14450.205238711867;14466.566003019821;14468;14484.42062317506;7315.085614298213;7459.477836551444;7665.5783931883725;7728.033995750531;7731.690732370698;5176.844694659167;5185.611079169077;5290.497402746733;5319.468053194688;5323.307969963918;1841.9975440032795;1863.1802007116826;1874.6157037807218;1904.238304678126;1909.9427017189369;24137.879310603512;24454.510909781882;24476.14333498319;24545.14092006771;24663.5067298653;6905.37851593359;7023.95610148622;7243.275672432715;7250.9637451812405;7305.050343455317;16355.100469474055;16370.099644519427;16517.33930642785;16617.169141543116;16674.49976500707;7485.663145158481;7581.469297149257;7586.658600362997;7601.12587052485;7606.543607383574;6970.477214208955;6991;7124.251953544803;7379.8155046124275;7387.593682347522;5133.076046311699;5153.793848246103;5157.948420515747;5192.61055420845;5244.475552444725;1486.3980088064352;1495.633569775412;1514.1596413990342;1519.7735317759536;1525.6872341170033;917.2524392620127;934.0939288889766;941.491594538955;946.990530094704;947.1428357336621;7555.282248186523;7585.962070189724;7624.733134340271;7666.8083297918;7870.44906856526;680.8672308899717;695.9826004349932;715.4419552748864;716.6739133694157;718.9568625882464;4549.499555048942;4576.176288268077;4604.815807367735;4610.4467463903875;5118.411382690963;18479.260829566665;19307.131179096974;19371.12829922657;19572.70640940387;20164.495887602632;19908.203671852963;20069.197232110844;20081.39755807328;20133.798662013487;20349.694754578693;10718.464076796128;10730.678079657622;10870.510827012804;11110.888891111146;11173.553057877594;8228.876566851382;8512;8600.78498037529;8625.525596092275;9062.592183351633;17680.91159544194;17946.5513362167;17970.281188752826;18004.189811458255;18374.448766537025;18206.635867282846;18207.817921820613;18403;18493;18676.43970680882;11500.137489688474;11824;11824.70438239051;11833.585824496102;11838.585649502225;13279.601611951657;13280.269585172522;13436.126651767994;13464.798028029392;13544.79682804739;10579.206559507913;10712.839307410239;10739.463026848782;10896.291741036806;10909.18181136402;10670.19973502006;10779.892201078203;10867.619633312795;10895.945520272347;11122.555097796321;8960.955195223982;9051.27589792828;9075.2286055686;9076.228520575562;9080.364374493722;7187.9640601796655;7293.927060729325;7382.6677799498075;7411.629418528944;7413.406927445899;7348.559086454829;7351.41188704913;7390.778276651709;7408.333250007525;7487.962560187164 11:11:50 INFO - PID 24461 | |4;prototype.html;491.80982023503105;498.11833055491803;511.81574633132067;519.7271432497938;526.179160509605;6248.687565621718;6258.561900666949;6276.6547839868845;6283.968580157104;6362.363763623635;6132.3749206460325;6142.232220972379;6173.660448675332;6185.226846644169;6214.5649804513705;4856.6357523185725;4859.41686997559;5076.771545280471;5101.821436249732;5126.641135120524;4954.367666232067;4975.402951645808;4980.452150263468;4992.925106123411;5017.322661440713;4943.604511639061;4960.3303554020285;4964.826231081913;4974.477679843619;4991.550760431561;4929.309896614459;4950.158473059589;4980.427250866124;4988.152014157584;4990.176620857555;4416.646668266531;4441.533638967927;4455.22033644111;4455.331700244957;4481.126180394825;5978.551608629326;6038.396160383971;6105.450509454126;6108.358622344635;6133.938660613381;5611.859703507404;5620.353659329147;5656.321241451011;5709.400512946164;5743.339515955677;6621.271660117383;6669.399754022162;6697.6986035628515;6698.732050717966;6732.596044237362;4804.75976201192;4844;4846.854594362175;4857.465678775332;4860.586850117745;6544.738210471575;6717.16035495563;6796.66016699168;6948.33990770876;6962.721491140348;4891.3124971884645;4894.583960363409;4911.45973942866;4924.236743304794;4959.256111583291;4936.050260147222;4946.752662366867;4990.276409920614;5002.324686167393;5035.874103147451;5636.153742360082;5637.06872426336;5665.830025099253;5672.177534257509;5706.42935706426;6578.598811433888;6652.467802575782;6657;6672.299408562031;6709.463242940553;1715.9914200428918;1722.1819635672955;1735.7136072548142;1747.8077411484726;1756.3238153311067;1122.2368789223406;1161.7618388230392;1178.911581631381;1198.7362780188519;1200.7298357869408;5807.796727114531;5815.302163740378;5836.328822185418;5846.327672317653;5858.769658371704;6720.6639668016405;6738.528303018742;6761.594304341756;6811.523193376515;6852.417544508673;5734.913976290359;5807.12893066035;5817.360090390053;5823.592348535646;5829.47534721877;3535.3106144301614;3570.767900086486;3590.7127429806073;3606.495090687306;3643.9635603644156;6523.260230703021;6549.377809108127;6601.6699165041555;6641.701123449457;6646.136002319668;6856.725730970706;6908.758193463204;6937.306269373023;6976.453594438095;7006.229314775371;6536.869262614721;6540.836479087966;6566.638834864033;6578.407943285128;6613.6362500062;6727.831804204934;6746.291639377991;6843.897341539781;6871.106756121872;6901.171859376706;6719.361660642231;6786.457083433413;6800.353966373186;6827.89758153638;6829.726810927706;6540.50946179048;6548.443382312366;6554.639494827639;6596.406323430914;6625.55471154987;4938.012397520439;4953.851384458472;4955.108080545537;4965.553100220997;4990.1516742154645;5857.062869940789;6398.5201109916015;6598.60408375499;6624.90062649051;6880.759173428906;6489.424955406333;6554.737810487527;6555.377848860494;6571.96714016446;6638.709645172407;6506.479481641552;6515.381038801306;6538;6577.177852768404;6604.867902641824;6440.710168042543;6486.6756662167645;6538;6557.196770888044;6559.14731084975;6508;6525.3800888915475;6610.140681711347;6668.233153187445;6687.465002799861;6433.420992110732;6446.5165112615805;6478.546501744832;6483.2544257411;6520.804375868732 11:11:50 INFO - PID 24461 | |5;yui.html;894.8612964990425;905.072300891586;920.682364584219;922.3082687984014;922.5802259971714;18204.90897545512;19060.523486912818;19149.234030638792;19201.327953521628;19503.512412189702;20114.295999640017;20999;21015.47461313468;21020.684689729627;21055.36833894982;1027.3322340478692;1039.870016247969;1040.6513817871023;1051.9737006574858;1054.8892366301504;980.6910823090703;1023.0230130225654;1024.9180065594771;1027.4554486122329;1027.7687520307945;1100.6918062942389;1123.0959077942252;1124.4714983957526;1124.5558004588183;1124.7131981344746;1117.9776404471907;1118.7818375416798;1119.121489630636;1119.972000699981;1120.1263014848432;818.643889907886;819.8606236939735;819.8770184472377;819.9549024803633;820.9958950205271;19971.900140499205;20215.191392344288;20357;20424.38726838197;20749.688754668692;21118.894405528026;21368.35894923139;21629.45926351838;21639.45901352479;22095.226667066574;15701.450449234222;16149.03105813655;16189.919050404791;16404.425845095364;16467.505974820775;3652.470391793175;3680.963190368089;3681.4661874028116;3682.0794801299676;3682.8895133146048;128594.35702821426;130267.34866325703;131132;133632.33183834018;134012.989805153;16498.6700265994;16515.6696866062;16664.91667541679;16673.749893751603;16948.57628559296;30789.538156927665;30932.22669433282;31188.376232475224;31284.687153128176;31404;7396.926030739732;7748.728794492165;8091.797705057421;8167.714130005421;8353.20644538768;4105.7331273467125;4178.373244013423;4190.287651099259;4193.601607847249;4194.412782210493;5171.2501687255135;5255.39562950258;5261.131913234273;5280.6303558750515;5282.022825777243;1023.8668973033458;1026.0406519903913;1041.3907863899703;1045.174312293295;1045.435464848973;650.1645385679379;682.477904403132;684.1892357556212;694.4513834071129;696.4010950582496;10508.316959397614;10818.1345492362;10836.187285953585;10932.726681832859;11034.337939723642;689.3106893106893;690.0959742736931;692.394155114275;701.5089437393844;705.7212401101639;5570.832875013756;5831.708414579254;5901.439363260483;5951.317385293409;5988.371221021817;108675.65297388016;113135.4343228295;113577;114063.42968285106;114298;91936;98270;101624.49187754015;101656.49171754094;104194.31125599366;85801.14198857931;86183;86496;88362;88447.55776221078;11597.478113484745;11629.941850290694;11735.295882247092;11841.711101791137;11856.822147667965;35776.64223357733;36517.81741091277;37133.25733485369;37198.25603487861;38537.80731096327;47019.529804702885;47383.52616473791;47677.28484072672;48756.5124348752;48794.75602621964;18204.726929096338;18519.53701157482;18610.2555897768;18814.745963449677;18854.811451885853;18386.264549417872;21093.89453052725;21180.894095529424;21364.359069227947;21473.46316342104;15991.360345586512;16059.036457812568;16123.919380403024;16160.434384796476;16312.347506099622;16982.74525882088;16985.40551080706;17047.48857534276;17154.571135721708;17240.568985775455;14794.260286985393;14908.925455372653;14919.62700932442;15033.624159396102;15138.545843624708;12043.156979011736;12172.756544868877;12310.07674424404;12504.374781260718;12571.308578028296;12961.481540738641;13048.217106973612;13139.080264381402;13275.402606882906;13286.601401957956 11:11:50 INFO - PID 24461 | __end_tp_report 11:11:50 INFO - PID 24461 | __start_cc_report 11:11:50 INFO - PID 24461 | _x_x_mozilla_cycle_collect,368 11:11:50 INFO - PID 24461 | __end_cc_report 11:11:50 INFO - PID 24461 | __startTimestamp1502820710157__endTimestamp 11:11:50 INFO - PID 24461 | 11:11:50 INFO - PID 24461 | ------- Summary: start ------- 11:11:50 INFO - PID 24461 | Number of tests: 6 11:11:50 INFO - PID 24461 | 11:11:50 INFO - PID 24461 | [#0] dojo.html Cycles:165 Average:6043.81 Median:6281.50 stddev:709.01 (11.3%) stddev-sans-first:673.93 11:11:50 INFO - PID 24461 | Values: 3152.4 3172.9 3181.6 3192.8 3218.9 5967.8 6074.5 6137.5 6171.8 6211.4 6008.5 6059.1 6067.2 6098.8 6129.4 5645.2 5667.0 5679.6 5686.4 5708.8 5435.0 5550.9 5633.1 5657.4 5692.0 5568.5 5572.9 5651.1 5659.2 5667.9 5600.5 5604.0 5636.9 5649.9 5678.4 5475.1 5579.1 5588.1 5634.3 5641.3 6137.9 6155.6 6191.6 6196.4 6222.9 6565.3 6573.6 6607.4 6674.6 6683.7 6575.9 6620.2 6626.4 6659.5 6742.8 5986.5 6116.9 6143.4 6150.1 6166.1 6687.6 6691.4 6704.4 6704.6 6712.1 6264.9 6345.2 6351.6 6449.0 6491.7 6564.8 6649.4 6652.8 6655.6 6661.0 6470.6 6475.9 6553.6 6580.1 6583.2 6437.6 6495.2 6499.5 6610.0 6624.0 5220.1 5232.8 5237.6 5243.6 5247.7 4470.0 4488.4 4495.7 4500.8 4523.2 5611.1 5646.2 5653.6 5654.2 5658.8 6500.7 6532.6 6539.3 6558.6 6622.9 5671.0 5681.5 5757.4 5776.4 5780.7 5678.7 5759.9 5760.3 5766.5 5819.6 6266.3 6286.6 6362.4 6364.5 6364.8 6647.2 6663.4 6691.3 6696.5 6726.1 6357.3 6381.5 6465.3 6474.1 6478.4 6493.6 6498.1 6600.1 6603.7 6610.8 6453.0 6540.9 6582.5 6645.9 6649.7 6247.6 6312.3 6322.8 6351.8 6366.6 6315.6 6371.5 6377.0 6385.5 6388.0 6218.0 6225.8 6297.7 6312.4 6313.9 6280.7 6281.5 6402.5 6408.3 6457.8 6261.1 6285.4 6291.8 6305.5 6334.5 11:11:50 INFO - PID 24461 | 11:11:50 INFO - PID 24461 | [#1] ext.html Cycles:180 Average:36754.90 Median:34507.64 stddev:51818.78 (150.2%) stddev-sans-first:51893.93 11:11:50 INFO - PID 24461 | Values: 828.3 868.6 895.4 897.8 1145.5 29966.3 30216.0 39804.8 40770.2 40956.6 40828.4 40909.0 41053.2 41138.8 41154.0 7187.5 7512.7 7671.5 7677.4 7678.7 7517.5 7598.5 7598.5 7606.9 7635.0 7569.5 7652.8 7653.8 7657.7 7658.6 7583.3 7607.4 7615.1 7617.0 7618.6 7466.0 7522.7 7526.8 7530.9 7534.8 37382.6 37465.6 37521.8 37620.6 37657.8 3457.7 3496.4 3504.2 3523.6 3527.2 29792.0 29847.4 30008.7 30035.4 30119.4 4856.8 4978.8 4987.4 5029.9 5038.6 188901.0 189816.0 190519.0 191868.0 192119.0 47249.3 47264.5 47393.5 47422.8 47564.5 48577.3 48873.5 48903.0 48910.8 48924.5 15264.7 15484.1 15485.5 15494.8 15498.2 11557.9 11719.1 12798.6 13005.5 13016.7 14235.9 14313.9 14369.6 14394.4 14478.3 5775.5 5853.1 5947.5 5962.6 5969.6 1006.6 1009.5 1027.3 1032.9 1040.2 22239.1 22980.7 23037.3 23137.3 23265.5 1120.9 1136.2 1138.4 1140.6 1144.1 12107.9 12396.0 12404.4 12410.8 12433.4 219989.0 222187.0 222778.0 223025.0 224011.0 49933.8 49942.3 50072.5 50339.2 50391.7 1481.9 1490.2 1499.4 1514.4 1537.7 22483.9 22661.8 22733.5 22883.4 22914.3 35258.1 35653.8 35658.8 35723.6 35948.3 183527.0 184444.0 186508.0 187448.0 187764.0 32432.0 32999.5 34445.3 34570.0 34590.7 44136.3 45355.1 45629.8 45677.8 45764.5 33398.3 33830.5 34208.7 34229.0 34363.8 33213.3 33234.0 33299.8 33326.3 33619.2 35905.5 36198.6 36279.0 36454.0 36473.6 32515.7 32662.8 32664.5 33146.5 33309.3 23607.3 24186.0 24799.5 25143.6 25481.8 11:11:50 INFO - PID 24461 | 11:11:50 INFO - PID 24461 | [#2] jquery.html Cycles:180 Average:36718.69 Median:22987.21 stddev:91755.78 (399.2%) stddev-sans-first:91973.01 11:11:50 INFO - PID 24461 | Values: 557.1 564.8 569.0 573.8 590.2 22424.9 23001.0 23362.8 23392.1 23403.2 26021.0 26839.5 26841.9 26902.1 27037.5 6485.3 6651.1 6652.3 6656.2 6664.2 5882.6 6503.1 6503.3 6524.5 6631.4 6468.9 6485.1 6485.4 6489.2 6499.2 6425.0 6438.7 6453.6 6458.0 6487.1 6023.3 6040.9 6042.1 6055.8 6059.6 29451.7 29648.6 30496.1 30968.2 31011.7 1874.7 1903.9 1905.2 1907.5 1909.9 19216.2 19666.7 19728.2 19766.1 19881.7 2354.8 2382.8 2445.4 2450.9 2455.4 129019.0 135029.3 135204.0 135577.0 135679.0 14653.0 14801.6 14822.6 15213.1 15385.5 23528.0 23559.8 23582.8 23618.4 23621.4 10438.4 10450.4 10533.9 10649.2 10686.3 8396.6 9778.3 9841.3 9854.6 10039.9 8277.9 9312.0 9372.9 9382.7 9388.3 2798.5 2822.7 2831.5 2861.2 2895.8 926.8 939.0 973.1 998.0 1004.5 20079.5 20216.1 20250.0 20281.5 20614.7 1036.0 1036.9 1037.9 1038.8 1042.5 11188.0 11265.5 11285.8 11286.0 11293.8 524355.0 543305.0 544452.0 560843.0 569302.0 120354.0 125865.4 127109.4 127328.4 129244.0 1250.2 1260.0 1289.1 1295.8 1296.9 20858.7 21001.8 21051.0 21270.7 21452.0 56578.7 56856.7 58160.4 59130.7 59236.4 67019.0 67029.3 67495.3 68001.0 68075.7 14441.6 14577.8 14662.4 15029.2 15096.3 22837.3 22944.5 22973.4 23494.9 24027.5 14409.9 14497.0 14596.3 14633.9 18088.6 16532.9 16793.1 17663.6 18157.0 18246.3 18486.9 19199.4 19828.7 19965.9 19983.8 14897.6 15349.0 15351.4 15359.7 15367.1 18467.9 18562.8 19092.4 19280.9 19426.1 11:11:50 INFO - PID 24461 | 11:11:50 INFO - PID 24461 | [#3] mootools.html Cycles:180 Average:8964.43 Median:2686.94 stddev:6218.18 (231.4%) stddev-sans-first:6209.48 11:11:50 INFO - PID 24461 | Values: 1375.7 1411.5 1418.1 1437.1 1442.4 13500.3 13918.9 14023.3 14062.6 14560.1 14775.4 14966.9 15007.8 15022.2 15111.2 2688.4 2738.9 2745.0 2746.9 2747.0 2618.4 2733.5 2821.4 2822.3 2824.2 2720.1 2745.7 2752.1 2753.5 2754.7 2685.4 2706.0 2709.6 2729.7 2764.8 2663.5 2669.0 2680.0 2683.8 2700.7 14290.0 14450.2 14466.6 14468.0 14484.4 7315.1 7459.5 7665.6 7728.0 7731.7 5176.8 5185.6 5290.5 5319.5 5323.3 1842.0 1863.2 1874.6 1904.2 1909.9 24137.9 24454.5 24476.1 24545.1 24663.5 6905.4 7024.0 7243.3 7251.0 7305.1 16355.1 16370.1 16517.3 16617.2 16674.5 7485.7 7581.5 7586.7 7601.1 7606.5 6970.5 6991.0 7124.3 7379.8 7387.6 5133.1 5153.8 5157.9 5192.6 5244.5 1486.4 1495.6 1514.2 1519.8 1525.7 917.3 934.1 941.5 947.0 947.1 7555.3 7586.0 7624.7 7666.8 7870.4 680.9 696.0 715.4 716.7 719.0 4549.5 4576.2 4604.8 4610.4 5118.4 18479.3 19307.1 19371.1 19572.7 20164.5 19908.2 20069.2 20081.4 20133.8 20349.7 10718.5 10730.7 10870.5 11110.9 11173.6 8228.9 8512.0 8600.8 8625.5 9062.6 17680.9 17946.6 17970.3 18004.2 18374.4 18206.6 18207.8 18403.0 18493.0 18676.4 11500.1 11824.0 11824.7 11833.6 11838.6 13279.6 13280.3 13436.1 13464.8 13544.8 10579.2 10712.8 10739.5 10896.3 10909.2 10670.2 10779.9 10867.6 10895.9 11122.6 8961.0 9051.3 9075.2 9076.2 9080.4 7188.0 7293.9 7382.7 7411.6 7413.4 7348.6 7351.4 7390.8 7408.3 7488.0 11:11:50 INFO - PID 24461 | 11:11:50 INFO - PID 24461 | [#4] prototype.html Cycles:180 Average:5526.06 Median:6133.16 stddev:1569.22 (25.6%) stddev-sans-first:1527.45 11:11:50 INFO - PID 24461 | Values: 491.8 498.1 511.8 519.7 526.2 6248.7 6258.6 6276.7 6284.0 6362.4 6132.4 6142.2 6173.7 6185.2 6214.6 4856.6 4859.4 5076.8 5101.8 5126.6 4954.4 4975.4 4980.5 4992.9 5017.3 4943.6 4960.3 4964.8 4974.5 4991.6 4929.3 4950.2 4980.4 4988.2 4990.2 4416.6 4441.5 4455.2 4455.3 4481.1 5978.6 6038.4 6105.5 6108.4 6133.9 5611.9 5620.4 5656.3 5709.4 5743.3 6621.3 6669.4 6697.7 6698.7 6732.6 4804.8 4844.0 4846.9 4857.5 4860.6 6544.7 6717.2 6796.7 6948.3 6962.7 4891.3 4894.6 4911.5 4924.2 4959.3 4936.1 4946.8 4990.3 5002.3 5035.9 5636.2 5637.1 5665.8 5672.2 5706.4 6578.6 6652.5 6657.0 6672.3 6709.5 1716.0 1722.2 1735.7 1747.8 1756.3 1122.2 1161.8 1178.9 1198.7 1200.7 5807.8 5815.3 5836.3 5846.3 5858.8 6720.7 6738.5 6761.6 6811.5 6852.4 5734.9 5807.1 5817.4 5823.6 5829.5 3535.3 3570.8 3590.7 3606.5 3644.0 6523.3 6549.4 6601.7 6641.7 6646.1 6856.7 6908.8 6937.3 6976.5 7006.2 6536.9 6540.8 6566.6 6578.4 6613.6 6727.8 6746.3 6843.9 6871.1 6901.2 6719.4 6786.5 6800.4 6827.9 6829.7 6540.5 6548.4 6554.6 6596.4 6625.6 4938.0 4953.9 4955.1 4965.6 4990.2 5857.1 6398.5 6598.6 6624.9 6880.8 6489.4 6554.7 6555.4 6572.0 6638.7 6506.5 6515.4 6538.0 6577.2 6604.9 6440.7 6486.7 6538.0 6557.2 6559.1 6508.0 6525.4 6610.1 6668.2 6687.5 6433.4 6446.5 6478.5 6483.3 6520.8 11:11:50 INFO - PID 24461 | 11:11:50 INFO - PID 24461 | [#5] yui.html Cycles:180 Average:23122.45 Median:19175.28 stddev:32333.82 (168.6%) stddev-sans-first:32381.44 11:11:50 INFO - PID 24461 | Values: 894.9 905.1 920.7 922.3 922.6 18204.9 19060.5 19149.2 19201.3 19503.5 20114.3 20999.0 21015.5 21020.7 21055.4 1027.3 1039.9 1040.7 1052.0 1054.9 980.7 1023.0 1024.9 1027.5 1027.8 1100.7 1123.1 1124.5 1124.6 1124.7 1118.0 1118.8 1119.1 1120.0 1120.1 818.6 819.9 819.9 820.0 821.0 19971.9 20215.2 20357.0 20424.4 20749.7 21118.9 21368.4 21629.5 21639.5 22095.2 15701.5 16149.0 16189.9 16404.4 16467.5 3652.5 3681.0 3681.5 3682.1 3682.9 128594.4 130267.3 131132.0 133632.3 134013.0 16498.7 16515.7 16664.9 16673.7 16948.6 30789.5 30932.2 31188.4 31284.7 31404.0 7396.9 7748.7 8091.8 8167.7 8353.2 4105.7 4178.4 4190.3 4193.6 4194.4 5171.3 5255.4 5261.1 5280.6 5282.0 1023.9 1026.0 1041.4 1045.2 1045.4 650.2 682.5 684.2 694.5 696.4 10508.3 10818.1 10836.2 10932.7 11034.3 689.3 690.1 692.4 701.5 705.7 5570.8 5831.7 5901.4 5951.3 5988.4 108675.7 113135.4 113577.0 114063.4 114298.0 91936.0 98270.0 101624.5 101656.5 104194.3 85801.1 86183.0 86496.0 88362.0 88447.6 11597.5 11629.9 11735.3 11841.7 11856.8 35776.6 36517.8 37133.3 37198.3 38537.8 47019.5 47383.5 47677.3 48756.5 48794.8 18204.7 18519.5 18610.3 18814.7 18854.8 18386.3 21093.9 21180.9 21364.4 21473.5 15991.4 16059.0 16123.9 16160.4 16312.3 16982.7 16985.4 17047.5 17154.6 17240.6 14794.3 14908.9 14919.6 15033.6 15138.5 12043.2 12172.8 12310.1 12504.4 12571.3 12961.5 13048.2 13139.1 13275.4 13286.6 11:11:50 INFO - PID 24461 | -------- Summary: end -------- 11:11:50 INFO - PID 24461 | 11:11:50 INFO - TEST-INFO | 24461: exit 0 11:11:50 INFO - TEST-OK | dromaeo_css | took 1112413ms 11:11:50 INFO - TEST-START | kraken 11:11:50 INFO - Initialising browser for kraken test... 11:11:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46395/getInfo.html -profile /tmp/tmpDUaB4X/profile 11:11:50 INFO - TEST-INFO | started process 24831 (/builds/slave/test/build/application/firefox/firefox http://localhost:46395/getInfo.html) 11:11:56 INFO - TEST-INFO | 24831: exit 0 11:11:57 INFO - Browser initialized. 11:11:57 INFO - Running cycle 1/1 for kraken test... 11:11:57 INFO - TEST-INFO | started process 25068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDUaB4X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:11:57 INFO - PID 25068 | 11:11:57 INFO - PID 25068 | (/builds/slave/test/build/application/firefox/firefox:25123): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:11:57 INFO - PID 25068 | 11:12:08 INFO - PID 25068 | RSS: Main: 166653952 11:12:08 INFO - PID 25068 | 11:12:11 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46395/tests/kraken/driver.html?testName=audio-beat-detection) 11:12:11 INFO - PID 25068 | RSS: Main: 173142016 11:12:11 INFO - PID 25068 | 11:12:14 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46395/tests/kraken/driver.html?testName=audio-dft) 11:12:15 INFO - PID 25068 | RSS: Main: 176533504 11:12:15 INFO - PID 25068 | 11:12:18 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46395/tests/kraken/driver.html?testName=audio-fft) 11:12:19 INFO - PID 25068 | RSS: Main: 171212800 11:12:19 INFO - PID 25068 | 11:12:21 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46395/tests/kraken/driver.html?testName=audio-oscillator) 11:12:21 INFO - PID 25068 | RSS: Main: 171786240 11:12:21 INFO - PID 25068 | 11:12:24 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46395/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:12:24 INFO - PID 25068 | RSS: Main: 171835392 11:12:24 INFO - PID 25068 | 11:12:27 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46395/tests/kraken/driver.html?testName=imaging-darkroom) 11:12:28 INFO - PID 25068 | RSS: Main: 173219840 11:12:28 INFO - PID 25068 | 11:12:31 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46395/tests/kraken/driver.html?testName=imaging-desaturate) 11:12:32 INFO - PID 25068 | RSS: Main: 173105152 11:12:32 INFO - PID 25068 | 11:12:35 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46395/tests/kraken/driver.html?testName=json-parse-financial) 11:12:36 INFO - PID 25068 | RSS: Main: 173608960 11:12:36 INFO - PID 25068 | 11:12:37 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46395/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:12:38 INFO - PID 25068 | RSS: Main: 173309952 11:12:38 INFO - PID 25068 | 11:12:40 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46395/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:12:40 INFO - PID 25068 | RSS: Main: 174256128 11:12:40 INFO - PID 25068 | 11:12:43 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46395/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:12:43 INFO - PID 25068 | RSS: Main: 173744128 11:12:43 INFO - PID 25068 | 11:12:46 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:12:47 INFO - PID 25068 | RSS: Main: 174153728 11:12:47 INFO - PID 25068 | 11:12:50 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:12:50 INFO - PID 25068 | RSS: Main: 174235648 11:12:50 INFO - PID 25068 | 11:12:52 INFO - PID 25068 | Cycle 1(1): loaded http://localhost:46395/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46395/tests/kraken/driver.html?testName=ai-astar) 11:12:53 INFO - PID 25068 | RSS: Main: 175423488 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | __start_tp_report 11:12:53 INFO - PID 25068 | _x_x_mozilla_page_load 11:12:53 INFO - PID 25068 | _x_x_mozilla_page_load_details 11:12:53 INFO - PID 25068 | |i|pagename|runs| 11:12:53 INFO - PID 25068 | |0;ai-astar;98;108;101;107;110;117;107;100;109;109 11:12:53 INFO - PID 25068 | |1;audio-beat-detection;150;135;153;175;118;139;142;116;187;117 11:12:53 INFO - PID 25068 | |2;audio-dft;163;162;164;167;162;164;170;166;170;163 11:12:53 INFO - PID 25068 | |3;audio-fft;77;80;75;182;75;75;74;91;97;75 11:12:53 INFO - PID 25068 | |4;audio-oscillator;80;88;133;79;81;79;136;78;80;131 11:12:53 INFO - PID 25068 | |5;imaging-gaussian-blur;114;114;113;114;120;115;113;113;115;114 11:12:53 INFO - PID 25068 | |6;imaging-darkroom;149;150;150;152;149;151;151;150;151;151 11:12:53 INFO - PID 25068 | |7;imaging-desaturate;94;96;94;93;93;93;98;94;94;93 11:12:53 INFO - PID 25068 | |8;json-parse-financial;63;53;63;54;53;57;53;53;54;54 11:12:53 INFO - PID 25068 | |9;json-stringify-tinderbox;60;55;56;56;64;56;55;55;56;60 11:12:53 INFO - PID 25068 | |10;stanford-crypto-aes;87;76;78;86;82;79;78;83;76;77 11:12:53 INFO - PID 25068 | |11;stanford-crypto-ccm;123;120;121;128;130;136;133;131;128;167 11:12:53 INFO - PID 25068 | |12;stanford-crypto-pbkdf2;175;183;178;178;185;184;178;180;185;181 11:12:53 INFO - PID 25068 | |13;stanford-crypto-sha256-iterative;83;67;70;70;72;67;72;68;69;68 11:12:53 INFO - PID 25068 | __end_tp_report 11:12:53 INFO - PID 25068 | __start_cc_report 11:12:53 INFO - PID 25068 | _x_x_mozilla_cycle_collect,940 11:12:53 INFO - PID 25068 | __end_cc_report 11:12:53 INFO - PID 25068 | __startTimestamp1502820773043__endTimestamp 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | ------- Summary: start ------- 11:12:53 INFO - PID 25068 | Number of tests: 14 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#0] ai-astar Cycles:10 Average:106.60 Median:109.00 stddev:5.60 (5.1%) stddev-sans-first:5.00 11:12:53 INFO - PID 25068 | Values: 98.0 108.0 101.0 107.0 110.0 117.0 107.0 100.0 109.0 109.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:146.00 stddev:24.08 (16.5%) stddev-sans-first:25.42 11:12:53 INFO - PID 25068 | Values: 150.0 135.0 153.0 175.0 118.0 139.0 142.0 116.0 187.0 117.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.03 (1.8%) stddev-sans-first:3.12 11:12:53 INFO - PID 25068 | Values: 163.0 162.0 164.0 167.0 162.0 164.0 170.0 166.0 170.0 163.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#3] audio-fft Cycles:10 Average:90.10 Median:76.00 stddev:33.23 (43.7%) stddev-sans-first:34.91 11:12:53 INFO - PID 25068 | Values: 77.0 80.0 75.0 182.0 75.0 75.0 74.0 91.0 97.0 75.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:79.50 stddev:25.59 (32.2%) stddev-sans-first:26.44 11:12:53 INFO - PID 25068 | Values: 80.0 88.0 133.0 79.0 81.0 79.0 136.0 78.0 80.0 131.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:2.07 (1.8%) stddev-sans-first:2.19 11:12:53 INFO - PID 25068 | Values: 114.0 114.0 113.0 114.0 120.0 115.0 113.0 113.0 115.0 114.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:151.00 stddev:0.97 (0.6%) stddev-sans-first:0.88 11:12:53 INFO - PID 25068 | Values: 149.0 150.0 150.0 152.0 149.0 151.0 151.0 150.0 151.0 151.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:1.62 (1.7%) stddev-sans-first:1.72 11:12:53 INFO - PID 25068 | Values: 94.0 96.0 94.0 93.0 93.0 93.0 98.0 94.0 94.0 93.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:54.00 stddev:4.03 (7.5%) stddev-sans-first:3.30 11:12:53 INFO - PID 25068 | Values: 63.0 53.0 63.0 54.0 53.0 57.0 53.0 53.0 54.0 54.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#9] json-stringify-tinderbox Cycles:10 Average:57.30 Median:56.00 stddev:3.02 (5.4%) stddev-sans-first:3.04 11:12:53 INFO - PID 25068 | Values: 60.0 55.0 56.0 56.0 64.0 56.0 55.0 55.0 56.0 60.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.50 stddev:4.05 (5.0%) stddev-sans-first:3.47 11:12:53 INFO - PID 25068 | Values: 87.0 76.0 78.0 86.0 82.0 79.0 78.0 83.0 76.0 77.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:130.50 stddev:13.43 (10.3%) stddev-sans-first:13.87 11:12:53 INFO - PID 25068 | Values: 123.0 120.0 121.0 128.0 130.0 136.0 133.0 131.0 128.0 167.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.70 Median:182.00 stddev:3.47 (1.9%) stddev-sans-first:3.00 11:12:53 INFO - PID 25068 | Values: 175.0 183.0 178.0 178.0 185.0 184.0 178.0 180.0 185.0 181.0 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:4.72 (6.7%) stddev-sans-first:1.92 11:12:53 INFO - PID 25068 | Values: 83.0 67.0 70.0 70.0 72.0 67.0 72.0 68.0 69.0 68.0 11:12:53 INFO - PID 25068 | -------- Summary: end -------- 11:12:53 INFO - PID 25068 | 11:12:53 INFO - PID 25068 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:12:53 INFO - TEST-INFO | 25068: exit 0 11:12:53 INFO - TEST-OK | kraken | took 62904ms 11:12:53 INFO - SUITE-END | took 1175s 11:12:54 INFO - Completed test suite (00:19:35) 11:12:54 INFO - javascript benchmark 11:12:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8450.07337160688, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3152.4325621388157, 3172.8572214250357, 3181.5704879841223, 3192.7605429592777, 3218.8873389431374, 5967.8209653710455, 6074.48366888815, 6137.539684523662, 6171.783987560442, 6211.440970312671, 6008.519318454524, 6059.091136329553, 6067.24159480065, 6098.786542471014, 6129.356417576146, 5645.2096706461125, 5666.971665141668, 5679.630823996447, 5686.3744988051285, 5708.80019199326, 5435.0488664483555, 5550.944490555084, 5633.0987042073275, 5657.405972372903, 5692.0, 5568.52667523261, 5572.86067848303, 5651.095824668033, 5659.151127330892, 5667.886642267173, 5600.4959553639965, 5604.047311956936, 5636.915446268309, 5649.915251271234, 5678.403767604384, 5475.06923822951, 5579.107342825128, 5588.1059030555325, 5634.32388113429, 5641.323041235037, 6137.877242455171, 6155.630662160284, 6191.566590338678, 6196.380361963813, 6222.906656400158, 6565.343465653445, 6573.6055836649475, 6607.405333520006, 6674.566153200075, 6683.732650693966, 6575.868482630369, 6620.172478440195, 6626.370494802986, 6659.467242620579, 6742.8314292142595, 5986.49114825236, 6116.908246376308, 6143.354947730513, 6150.108234306045, 6166.136740856328, 6687.632180230037, 6691.364320389555, 6704.363085506869, 6704.564203326768, 6712.060311556386, 6264.874702505925, 6345.206849143857, 6351.618902865843, 6448.967755161194, 6491.7078731457195, 6564.8358791030605, 6649.401553860176, 6652.83367915806, 6655.600663960178, 6661.0, 6470.579412338183, 6475.902861457082, 6553.606783593, 6580.078788969548, 6583.210014798255, 6437.581557198767, 6495.197704877136, 6499.512536559777, 6610.0, 6623.966880165664, 5220.060389129917, 5232.816851410183, 5237.580993520509, 5243.606729495303, 5247.685138891678, 4470.038941627566, 4488.39406680094, 4495.685302028826, 4500.797464114123, 4523.185826551252, 5611.102223644198, 5646.20953066571, 5653.604247702704, 5654.236678048493, 5658.830235092953, 6500.707468163944, 6532.5753826001155, 6539.346065393518, 6558.639274839834, 6622.933770662328, 5671.0, 5681.488666019995, 5757.424257574293, 5776.364599894008, 5780.71096445176, 5678.68767217807, 5759.8560035999435, 5760.337561180434, 5766.481016708516, 5819.563532735062, 6266.279377871512, 6286.5599408041, 6362.363763623694, 6364.522660800366, 6364.84087897797, 6647.202335719745, 6663.400293973566, 6691.330866913269, 6696.4977626679165, 6726.058351830846, 6357.268914074755, 6381.521385895983, 6465.321141280097, 6474.125992991075, 6478.352164783484, 6493.642849643126, 6498.090267362668, 6600.1089852869245, 6603.735850565923, 6610.768623098168, 6452.9677351612945, 6540.869182616226, 6582.506312026713, 6645.867082658223, 6649.700763465559, 6247.625142491465, 6312.337204593451, 6322.778702745381, 6351.809445716636, 6366.6180029198395, 6315.621062736067, 6371.5221358397375, 6377.043443483514, 6385.45723613498, 6388.0, 6218.041915160888, 6225.844353891189, 6297.748090076346, 6312.43188113072, 6313.905291420724, 6280.717367718372, 6281.497480201664, 6402.487800976004, 6408.295087540274, 6457.806265812033, 6261.092141639528, 6285.402886725754, 6291.773104244811, 6305.495560355253, 6334.493240540838], "value": 5991.65281391769, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.329053466692, 868.5743985447131, 895.4448242089906, 897.7665806890211, 1145.4959817680226, 29966.25084372889, 30216.0, 39804.80097599515, 40770.184596308056, 40956.59043409573, 40828.38757418641, 40909.0, 41053.17893642125, 41138.7943060285, 41154.0, 7187.460940429462, 7512.66193021314, 7671.539707617533, 7677.385809135256, 7678.731244406419, 7517.4737768356235, 7598.506097103698, 7598.51828893366, 7606.923930760705, 7635.0, 7569.545827250355, 7652.808679783022, 7653.770386888402, 7657.731979380723, 7658.617069146549, 7583.27958843909, 7607.391408687292, 7615.124260710034, 7617.047869016373, 7618.580978046205, 7465.962670186615, 7522.736704215326, 7526.774196774106, 7530.924690753077, 7534.773956781305, 37382.62617373819, 37465.62534374676, 37521.81239093787, 37620.62379376226, 37657.81171094155, 3457.7233821294235, 3496.423090190141, 3504.2465869838106, 3523.612402635708, 3527.206378564828, 29792.0, 29847.40305193884, 30008.699913001026, 30035.399292014037, 30119.397612047855, 4856.8300109495995, 4978.800847966077, 4987.426445958725, 5029.949700502984, 5038.647294689373, 188901.0, 189816.0, 190519.0, 191868.0, 192119.0, 47249.291260631115, 47264.527354726015, 47393.5260647396, 47422.762886186036, 47564.5243547567, 48577.27134092992, 48873.51126488761, 48903.0, 48910.75544622254, 48924.510754892, 15264.694706105816, 15484.148371839432, 15485.458008969632, 15494.767578486331, 15498.225088745517, 11557.942210289062, 11719.06247500215, 12798.61604151877, 13005.544805931748, 13016.674583135497, 14235.85764142366, 14313.85686143146, 14369.64075898111, 14394.352254148589, 14478.34847431847, 5775.487662866666, 5853.09277062056, 5947.464728174485, 5962.582619216613, 5969.611975221596, 1006.6225165562914, 1009.530568285736, 1027.2809033676456, 1032.9173666106694, 1040.2354269611828, 22239.110435582395, 22980.65529017066, 23037.308880733606, 23137.305880823602, 23265.534689306118, 1120.8879112088725, 1136.2330426961933, 1138.4194061028934, 1140.6406981800706, 1144.0790163918125, 12107.939460302818, 12396.0, 12404.441800119017, 12410.81383779244, 12433.440495177738, 219989.0, 222187.0, 222778.0, 223025.0, 224011.0, 49933.75033124884, 49942.25086623704, 50072.49927500678, 50339.24491132636, 50391.74804126029, 1481.896267261303, 1490.225082956878, 1499.377758230344, 1514.4320879670124, 1537.7385844406479, 22483.887580561994, 22661.773382265965, 22733.545329093657, 22883.42791430161, 22914.312570622908, 35258.118547035505, 35653.82173089118, 35658.82170589131, 35723.64276357307, 35948.28103437969, 183527.0, 184444.0, 186508.0, 187448.0, 187764.0, 32432.0, 32999.515021824554, 34445.31109377748, 34569.96290111301, 34590.65409345975, 44136.33795493135, 45355.09289814251, 45629.77185114053, 45677.77161114173, 45764.54235457603, 33398.33203335871, 33830.492542612374, 34208.657913420546, 34229.0, 34363.82818085894, 33213.33573328568, 33234.0, 33299.83350083234, 33326.33347332991, 33619.15952101119, 35905.46141807927, 36198.63801361953, 36279.0, 36454.0, 36473.635263647026, 32515.674843251265, 32662.83668581642, 32664.51003235001, 33146.50280245847, 33309.33381332408, 23607.29178124659, 24186.0, 24799.50400992006, 25143.622845657697, 25481.793373875767], "value": 17021.79106124327, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.1336571631113, 564.8305508347495, 568.985775355616, 573.7676241122347, 590.2268028882165, 22424.88787556062, 23001.0, 23362.76637233627, 23392.064317427303, 23403.1808886689, 26021.0, 26839.463210735823, 26841.865790671018, 26902.058427955024, 27037.459250814973, 6485.286618471952, 6651.1021012163465, 6652.301508341627, 6656.201255849305, 6664.233613134479, 5882.5588080893895, 6503.057056726771, 6503.349665033506, 6524.543281970264, 6631.3700198481065, 6468.8706225875685, 6485.059666348377, 6485.351464853524, 6489.1888513935755, 6499.1876015498065, 6424.967875160641, 6438.742450301982, 6453.645049522274, 6458.0, 6487.091807147003, 6023.337432882379, 6040.939590604125, 6042.1238920356745, 6055.818325450244, 6059.575829691923, 29451.70548294511, 29648.555271670943, 30496.085117446513, 30968.225794355323, 31011.68988310133, 1874.7281644161656, 1903.8762480438866, 1905.1807722679243, 1907.523119220195, 1909.9045047747557, 19216.231350745955, 19666.70499942502, 19728.21087156512, 19766.110525026408, 19881.701774473393, 2354.7850315390283, 2382.8451150675323, 2445.400876785181, 2450.9387265318333, 2455.4229756007326, 129019.0, 135029.32485337608, 135203.999999999, 135577.0, 135679.0, 14653.0, 14801.629959251104, 14822.629434264014, 15213.131797824812, 15385.538433847003, 23528.0, 23559.76440235576, 23582.764172358056, 23618.409539761644, 23621.409464763517, 10438.425886576311, 10450.372977621368, 10533.894661053444, 10649.201309901633, 10686.25196236256, 8396.622152003174, 9778.266630002778, 9841.261905357127, 9854.556544955494, 10039.899601003897, 8277.875831862528, 9311.953440232755, 9372.90627093734, 9382.671606493877, 9388.342816002814, 2798.538241190181, 2822.7036161203187, 2831.5186418308936, 2861.241770930705, 2895.7683385329124, 926.8053708721244, 938.9765255868522, 973.0755782007121, 998.0, 1004.5379125602304, 20079.49801254951, 20216.09027593762, 20250.0, 20281.49296267605, 20614.690779638317, 1036.0416614631586, 1036.9066783989326, 1037.9377237365782, 1038.7610849504656, 1042.5360714481983, 11188.049015833583, 11265.549378024787, 11285.830712539318, 11286.0, 11293.830592541119, 524355.0, 543305.0, 544452.0, 560843.0, 569302.0, 120354.0, 125865.37067314606, 127109.36445317714, 127328.36335818446, 129244.0, 1250.2186133666457, 1259.9525770622738, 1289.052546378411, 1295.838020247469, 1296.857345691973, 20858.68711969352, 21001.789982099985, 21051.0, 21270.680939785605, 21452.0, 56578.7171064142, 56856.71571642115, 58160.4183958155, 59130.70434647971, 59236.40763592309, 67019.0, 67029.32970670231, 67495.3250467489, 68001.0, 68075.65962170355, 14441.638959026108, 14577.781333279798, 14662.413503459742, 15029.173395463355, 15096.320665570296, 22837.31488055361, 22944.541109178055, 22973.425664357856, 23494.88252558726, 24027.51944961126, 14409.927950360181, 14497.0, 14596.343164557833, 14633.902457315531, 18088.638227235646, 16532.917335413727, 16793.07638079917, 17663.646727065643, 18157.0, 18246.270149194414, 18486.907565462086, 19199.424017279503, 19828.70256946176, 19965.900170499055, 19983.800161998195, 14897.627559311104, 15349.0, 15351.385944562093, 15359.692806144038, 15367.077975321516, 18467.907660461613, 18562.814371856108, 19092.427227183205, 19280.903595481934, 19426.12582433822], "value": 12154.63729342047, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.7042235919278, 1411.4989178841508, 1418.0995068131733, 1437.1448987852225, 1442.4061412139579, 13500.32498375081, 13918.93040534796, 14023.298835058258, 14062.64843378916, 14560.126392416463, 14775.408983640642, 14966.925165374185, 15007.849921500781, 15022.173780442072, 15111.168885711282, 2688.4354285600048, 2738.8904443822225, 2744.986275068622, 2746.8763905624196, 2747.0, 2618.371590818209, 2733.521633714102, 2821.407504424063, 2822.32264256579, 2824.166870773127, 2720.102366219153, 2745.6567929008875, 2752.078053851952, 2753.4630747004244, 2754.7107553706874, 2685.4494828560196, 2705.9729402706116, 2709.552923767576, 2729.7270272972546, 2764.8202866813594, 2663.4673065386805, 2668.9599656005175, 2680.0351873325585, 2683.771879390254, 2700.702922678504, 14290.0, 14450.205238711867, 14466.566003019821, 14468.0, 14484.42062317506, 7315.085614298213, 7459.477836551444, 7665.5783931883725, 7728.033995750531, 7731.690732370698, 5176.844694659167, 5185.611079169077, 5290.497402746733, 5319.468053194688, 5323.307969963918, 1841.9975440032795, 1863.1802007116826, 1874.6157037807218, 1904.238304678126, 1909.9427017189369, 24137.879310603512, 24454.510909781882, 24476.14333498319, 24545.14092006771, 24663.5067298653, 6905.37851593359, 7023.95610148622, 7243.275672432715, 7250.9637451812405, 7305.050343455317, 16355.100469474055, 16370.099644519427, 16517.33930642785, 16617.169141543116, 16674.49976500707, 7485.663145158481, 7581.469297149257, 7586.658600362997, 7601.12587052485, 7606.543607383574, 6970.477214208955, 6991.0, 7124.251953544803, 7379.8155046124275, 7387.593682347522, 5133.076046311699, 5153.793848246103, 5157.948420515747, 5192.61055420845, 5244.475552444725, 1486.3980088064352, 1495.633569775412, 1514.1596413990342, 1519.7735317759536, 1525.6872341170033, 917.2524392620127, 934.0939288889766, 941.491594538955, 946.990530094704, 947.1428357336621, 7555.282248186523, 7585.962070189724, 7624.733134340271, 7666.8083297918, 7870.44906856526, 680.8672308899717, 695.9826004349932, 715.4419552748864, 716.6739133694157, 718.9568625882464, 4549.499555048942, 4576.176288268077, 4604.815807367735, 4610.4467463903875, 5118.411382690963, 18479.260829566665, 19307.131179096974, 19371.12829922657, 19572.70640940387, 20164.495887602632, 19908.203671852963, 20069.197232110844, 20081.39755807328, 20133.798662013487, 20349.694754578693, 10718.464076796128, 10730.678079657622, 10870.510827012804, 11110.888891111146, 11173.553057877594, 8228.876566851382, 8512.0, 8600.78498037529, 8625.525596092275, 9062.592183351633, 17680.91159544194, 17946.5513362167, 17970.281188752826, 18004.189811458255, 18374.448766537025, 18206.635867282846, 18207.817921820613, 18403.0, 18493.0, 18676.43970680882, 11500.137489688474, 11824.0, 11824.70438239051, 11833.585824496102, 11838.585649502225, 13279.601611951657, 13280.269585172522, 13436.126651767994, 13464.798028029392, 13544.79682804739, 10579.206559507913, 10712.839307410239, 10739.463026848782, 10896.291741036806, 10909.18181136402, 10670.19973502006, 10779.892201078203, 10867.619633312795, 10895.945520272347, 11122.555097796321, 8960.955195223982, 9051.27589792828, 9075.2286055686, 9076.228520575562, 9080.364374493722, 7187.9640601796655, 7293.927060729325, 7382.6677799498075, 7411.629418528944, 7413.406927445899, 7348.559086454829, 7351.41188704913, 7390.778276651709, 7408.333250007525, 7487.962560187164], "value": 6469.827040265806, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.80982023503105, 498.11833055491803, 511.81574633132067, 519.7271432497938, 526.179160509605, 6248.687565621718, 6258.561900666949, 6276.6547839868845, 6283.968580157104, 6362.363763623635, 6132.3749206460325, 6142.232220972379, 6173.660448675332, 6185.226846644169, 6214.5649804513705, 4856.6357523185725, 4859.41686997559, 5076.771545280471, 5101.821436249732, 5126.641135120524, 4954.367666232067, 4975.402951645808, 4980.452150263468, 4992.925106123411, 5017.322661440713, 4943.604511639061, 4960.3303554020285, 4964.826231081913, 4974.477679843619, 4991.550760431561, 4929.309896614459, 4950.158473059589, 4980.427250866124, 4988.152014157584, 4990.176620857555, 4416.646668266531, 4441.533638967927, 4455.22033644111, 4455.331700244957, 4481.126180394825, 5978.551608629326, 6038.396160383971, 6105.450509454126, 6108.358622344635, 6133.938660613381, 5611.859703507404, 5620.353659329147, 5656.321241451011, 5709.400512946164, 5743.339515955677, 6621.271660117383, 6669.399754022162, 6697.6986035628515, 6698.732050717966, 6732.596044237362, 4804.75976201192, 4844.0, 4846.854594362175, 4857.465678775332, 4860.586850117745, 6544.738210471575, 6717.16035495563, 6796.66016699168, 6948.33990770876, 6962.721491140348, 4891.3124971884645, 4894.583960363409, 4911.45973942866, 4924.236743304794, 4959.256111583291, 4936.050260147222, 4946.752662366867, 4990.276409920614, 5002.324686167393, 5035.874103147451, 5636.153742360082, 5637.06872426336, 5665.830025099253, 5672.177534257509, 5706.42935706426, 6578.598811433888, 6652.467802575782, 6657.0, 6672.299408562031, 6709.463242940553, 1715.9914200428918, 1722.1819635672955, 1735.7136072548142, 1747.8077411484726, 1756.3238153311067, 1122.2368789223406, 1161.7618388230392, 1178.911581631381, 1198.7362780188519, 1200.7298357869408, 5807.796727114531, 5815.302163740378, 5836.328822185418, 5846.327672317653, 5858.769658371704, 6720.6639668016405, 6738.528303018742, 6761.594304341756, 6811.523193376515, 6852.417544508673, 5734.913976290359, 5807.12893066035, 5817.360090390053, 5823.592348535646, 5829.47534721877, 3535.3106144301614, 3570.767900086486, 3590.7127429806073, 3606.495090687306, 3643.9635603644156, 6523.260230703021, 6549.377809108127, 6601.6699165041555, 6641.701123449457, 6646.136002319668, 6856.725730970706, 6908.758193463204, 6937.306269373023, 6976.453594438095, 7006.229314775371, 6536.869262614721, 6540.836479087966, 6566.638834864033, 6578.407943285128, 6613.6362500062, 6727.831804204934, 6746.291639377991, 6843.897341539781, 6871.106756121872, 6901.171859376706, 6719.361660642231, 6786.457083433413, 6800.353966373186, 6827.89758153638, 6829.726810927706, 6540.50946179048, 6548.443382312366, 6554.639494827639, 6596.406323430914, 6625.55471154987, 4938.012397520439, 4953.851384458472, 4955.108080545537, 4965.553100220997, 4990.1516742154645, 5857.062869940789, 6398.5201109916015, 6598.60408375499, 6624.90062649051, 6880.759173428906, 6489.424955406333, 6554.737810487527, 6555.377848860494, 6571.96714016446, 6638.709645172407, 6506.479481641552, 6515.381038801306, 6538.0, 6577.177852768404, 6604.867902641824, 6440.710168042543, 6486.6756662167645, 6538.0, 6557.196770888044, 6559.14731084975, 6508.0, 6525.3800888915475, 6610.140681711347, 6668.233153187445, 6687.465002799861, 6433.420992110732, 6446.5165112615805, 6478.546501744832, 6483.2544257411, 6520.804375868732], "value": 5059.558479162969, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [894.8612964990425, 905.072300891586, 920.682364584219, 922.3082687984014, 922.5802259971714, 18204.90897545512, 19060.523486912818, 19149.234030638792, 19201.327953521628, 19503.512412189702, 20114.295999640017, 20999.0, 21015.47461313468, 21020.684689729627, 21055.36833894982, 1027.3322340478692, 1039.870016247969, 1040.6513817871023, 1051.9737006574858, 1054.8892366301504, 980.6910823090703, 1023.0230130225654, 1024.9180065594771, 1027.4554486122329, 1027.7687520307945, 1100.6918062942389, 1123.0959077942252, 1124.4714983957526, 1124.5558004588183, 1124.7131981344746, 1117.9776404471907, 1118.7818375416798, 1119.121489630636, 1119.972000699981, 1120.1263014848432, 818.643889907886, 819.8606236939735, 819.8770184472377, 819.9549024803633, 820.9958950205271, 19971.900140499205, 20215.191392344288, 20357.0, 20424.38726838197, 20749.688754668692, 21118.894405528026, 21368.35894923139, 21629.45926351838, 21639.45901352479, 22095.226667066574, 15701.450449234222, 16149.03105813655, 16189.919050404791, 16404.425845095364, 16467.505974820775, 3652.470391793175, 3680.963190368089, 3681.4661874028116, 3682.0794801299676, 3682.8895133146048, 128594.35702821426, 130267.34866325703, 131132.0, 133632.33183834018, 134012.989805153, 16498.6700265994, 16515.6696866062, 16664.91667541679, 16673.749893751603, 16948.57628559296, 30789.538156927665, 30932.22669433282, 31188.376232475224, 31284.687153128176, 31404.0, 7396.926030739732, 7748.728794492165, 8091.797705057421, 8167.714130005421, 8353.20644538768, 4105.7331273467125, 4178.373244013423, 4190.287651099259, 4193.601607847249, 4194.412782210493, 5171.2501687255135, 5255.39562950258, 5261.131913234273, 5280.6303558750515, 5282.022825777243, 1023.8668973033458, 1026.0406519903913, 1041.3907863899703, 1045.174312293295, 1045.435464848973, 650.1645385679379, 682.477904403132, 684.1892357556212, 694.4513834071129, 696.4010950582496, 10508.316959397614, 10818.1345492362, 10836.187285953585, 10932.726681832859, 11034.337939723642, 689.3106893106893, 690.0959742736931, 692.394155114275, 701.5089437393844, 705.7212401101639, 5570.832875013756, 5831.708414579254, 5901.439363260483, 5951.317385293409, 5988.371221021817, 108675.65297388016, 113135.4343228295, 113577.0, 114063.42968285106, 114298.0, 91936.0, 98270.0, 101624.49187754015, 101656.49171754094, 104194.31125599366, 85801.14198857931, 86183.0, 86496.0, 88362.0, 88447.55776221078, 11597.478113484745, 11629.941850290694, 11735.295882247092, 11841.711101791137, 11856.822147667965, 35776.64223357733, 36517.81741091277, 37133.25733485369, 37198.25603487861, 38537.80731096327, 47019.529804702885, 47383.52616473791, 47677.28484072672, 48756.5124348752, 48794.75602621964, 18204.726929096338, 18519.53701157482, 18610.2555897768, 18814.745963449677, 18854.811451885853, 18386.264549417872, 21093.89453052725, 21180.894095529424, 21364.359069227947, 21473.46316342104, 15991.360345586512, 16059.036457812568, 16123.919380403024, 16160.434384796476, 16312.347506099622, 16982.74525882088, 16985.40551080706, 17047.48857534276, 17154.571135721708, 17240.568985775455, 14794.260286985393, 14908.925455372653, 14919.62700932442, 15033.624159396102, 15138.545843624708, 12043.156979011736, 12172.756544868877, 12310.07674424404, 12504.374781260718, 12571.308578028296, 12961.481540738641, 13048.217106973612, 13139.080264381402, 13275.402606882906, 13286.601401957956], "value": 8970.919637998086, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1536.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 101.0, 107.0, 110.0, 117.0, 107.0, 100.0, 109.0, 109.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 135.0, 153.0, 175.0, 118.0, 139.0, 142.0, 116.0, 187.0, 117.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 164.0, 167.0, 162.0, 164.0, 170.0, 166.0, 170.0, 163.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 75.0, 182.0, 75.0, 75.0, 74.0, 91.0, 97.0, 75.0], "value": 90.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 88.0, 133.0, 79.0, 81.0, 79.0, 136.0, 78.0, 80.0, 131.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 120.0, 115.0, 113.0, 113.0, 115.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 152.0, 149.0, 151.0, 151.0, 150.0, 151.0, 151.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 93.0, 93.0, 93.0, 98.0, 94.0, 94.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 53.0, 63.0, 54.0, 53.0, 57.0, 53.0, 53.0, 54.0, 54.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 55.0, 56.0, 56.0, 64.0, 56.0, 55.0, 55.0, 56.0, 60.0], "value": 57.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 76.0, 78.0, 86.0, 82.0, 79.0, 78.0, 83.0, 76.0, 77.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 120.0, 121.0, 128.0, 130.0, 136.0, 133.0, 131.0, 128.0, 167.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 183.0, 178.0, 178.0, 185.0, 184.0, 178.0, 180.0, 185.0, 181.0], "value": 180.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 67.0, 70.0, 70.0, 72.0, 67.0, 72.0, 68.0, 69.0, 68.0], "value": 70.6, "unit": "score"}]}]} 11:12:54 INFO - Return code: 0 11:12:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:12:54 INFO - # TBPL SUCCESS # 11:12:54 INFO - Running post-action listener: _package_coverage_data 11:12:54 INFO - Running post-action listener: _resource_record_post_action 11:12:54 INFO - [mozharness: 2017-08-15 18:12:54.341928Z] Finished run-tests step (success) 11:12:54 INFO - Running post-run listener: _resource_record_post_run 11:12:54 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 432971776; Read time: 316; Write time: 407604 11:12:54 INFO - TinderboxPrint: CPU usage
13.1% 11:12:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 316 11:12:54 INFO - TinderboxPrint: I/O write bytes / time
432,971,776 / 407,604 11:12:54 INFO - TinderboxPrint: CPU idle
8,268.3 (86.8%) 11:12:54 INFO - TinderboxPrint: CPU user
1,201.1 (12.6%) 11:12:54 INFO - TinderboxPrint: Swap in / out
0 / 0 11:12:54 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106795008; Read time: 0; Write time: 85408 11:12:54 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:12:54 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326176768; Read time: 316; Write time: 322196 11:12:54 INFO - Running post-run listener: _upload_blobber_files 11:12:54 INFO - Blob upload gear active. 11:12:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:12:54 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 11:12:54 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'] 11:12:54 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 11:12:55 INFO - (blobuploader) - INFO - Open directory for files ... 11:12:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:12:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:12:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:12:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:12:56 INFO - (blobuploader) - INFO - Done attempting. 11:12:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:12:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:12:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:13:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:03 INFO - (blobuploader) - INFO - Done attempting. 11:13:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:13:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:04 INFO - (blobuploader) - INFO - Done attempting. 11:13:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:13:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:13:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:13:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:13:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:13:04 INFO - (blobuploader) - INFO - Done attempting. 11:13:04 INFO - (blobuploader) - INFO - Iteration through files over. 11:13:04 INFO - Return code: 0 11:13:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:13:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:13:04 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c272f99831d13ce6cebb516618b4406ae19364d8490907d87133e902bf6d836e835dc29c3881bc91702126ac94509a31d864717e5f9569885e90a3a195589090", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ea12d463a29bc7e8730ca067624fe4f879451d5084678e3d764ecbf4fd6b121fadfd66bc26c925b98f6d67c27a6a506c4e5f5f2c63b57e3465d1ddc66d8645e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/918bdeabfc7876292bfd248cb802268bab775b98dc84b9c49e66879cd67212ee65cdb3190102f63483ef6fa648e5380d4645990541af94038d36d01b05e857ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b288692c89087329f0b92c0cf676c78afb3e8d5fc56773e8b4602ffcf381193d14da2cf9f3ae1f95b1767abb1da23e81c7ef3425a459a0db2cf02e9cd7cb982"} 11:13:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:13:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:13:04 INFO - Contents: 11:13:04 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c272f99831d13ce6cebb516618b4406ae19364d8490907d87133e902bf6d836e835dc29c3881bc91702126ac94509a31d864717e5f9569885e90a3a195589090", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ea12d463a29bc7e8730ca067624fe4f879451d5084678e3d764ecbf4fd6b121fadfd66bc26c925b98f6d67c27a6a506c4e5f5f2c63b57e3465d1ddc66d8645e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/918bdeabfc7876292bfd248cb802268bab775b98dc84b9c49e66879cd67212ee65cdb3190102f63483ef6fa648e5380d4645990541af94038d36d01b05e857ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b288692c89087329f0b92c0cf676c78afb3e8d5fc56773e8b4602ffcf381193d14da2cf9f3ae1f95b1767abb1da23e81c7ef3425a459a0db2cf02e9cd7cb982"} 11:13:04 INFO - Running post-run listener: copy_logs_to_upload_dir 11:13:04 INFO - Copying logs to upload dir... 11:13:04 INFO - mkdir: /builds/slave/test/build/upload/logs 11:13:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.983102 ========= master_lag: 1.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-08-15 11:13:06.090094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 11:13:06.093954) ========= 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=17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c272f99831d13ce6cebb516618b4406ae19364d8490907d87133e902bf6d836e835dc29c3881bc91702126ac94509a31d864717e5f9569885e90a3a195589090", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ea12d463a29bc7e8730ca067624fe4f879451d5084678e3d764ecbf4fd6b121fadfd66bc26c925b98f6d67c27a6a506c4e5f5f2c63b57e3465d1ddc66d8645e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/918bdeabfc7876292bfd248cb802268bab775b98dc84b9c49e66879cd67212ee65cdb3190102f63483ef6fa648e5380d4645990541af94038d36d01b05e857ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b288692c89087329f0b92c0cf676c78afb3e8d5fc56773e8b4602ffcf381193d14da2cf9f3ae1f95b1767abb1da23e81c7ef3425a459a0db2cf02e9cd7cb982"} build_url:https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/YgRi8VxOQVeYwb_FbxWT9g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c272f99831d13ce6cebb516618b4406ae19364d8490907d87133e902bf6d836e835dc29c3881bc91702126ac94509a31d864717e5f9569885e90a3a195589090", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4ea12d463a29bc7e8730ca067624fe4f879451d5084678e3d764ecbf4fd6b121fadfd66bc26c925b98f6d67c27a6a506c4e5f5f2c63b57e3465d1ddc66d8645e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/918bdeabfc7876292bfd248cb802268bab775b98dc84b9c49e66879cd67212ee65cdb3190102f63483ef6fa648e5380d4645990541af94038d36d01b05e857ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b288692c89087329f0b92c0cf676c78afb3e8d5fc56773e8b4602ffcf381193d14da2cf9f3ae1f95b1767abb1da23e81c7ef3425a459a0db2cf02e9cd7cb982"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 11:13:06.120281) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 11:13:06.124348) ========= 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=17051fcd5208b27b50bedfeb000001dd-1502817871.332289-2056586208 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 11:13:06.182393) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 11:13:06.182710) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 11:13:06.182996) ========= ========= Total master_lag: 1.56 =========