builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-068 starttime: 1502449172.4 results: success (0) revision: f74094603063c92b710c0bae0bb5c092b915e92c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 03:59:32.404810) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 03:59:32.405349) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 03:59:32.405634) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 03:59:32.452018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:59:32.452337) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-11 03:59:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 229M=0s 2017-08-11 03:59:32 (229 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168243 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:59:32.671521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:59:32.671861) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017381 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 03:59:32.720906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-11 03:59:32.721236) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f74094603063c92b710c0bae0bb5c092b915e92c --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 f74094603063c92b710c0bae0bb5c092b915e92c --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=97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-11 03:59:32,965 truncating revision to first 12 chars 2017-08-11 03:59:32,965 Setting DEBUG logging. 2017-08-11 03:59:32,965 attempt 1/10 2017-08-11 03:59:32,965 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f74094603063?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-11 03:59:34,209 unpacking tar archive at: mozilla-central-f74094603063/testing/mozharness/ program finished with exit code 0 elapsedTime=1.544389 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-11 03:59:34.279274) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 03:59:34.279672) ========= script_repo_revision: f74094603063c92b710c0bae0bb5c092b915e92c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 03:59:34.280040) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 03:59:34.280386) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 03:59:34.289702) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-11 03:59:34.290147) ========= /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=97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:59:34 INFO - MultiFileLogger online at 20170811 03:59:34 in /builds/slave/test 03:59:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:59:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:59:34 INFO - {'append_to_log': False, 03:59:34 INFO - 'base_work_dir': '/builds/slave/test', 03:59:34 INFO - 'blob_upload_branch': 'Firefox', 03:59:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:59:34 INFO - 'branch': 'Firefox', 03:59:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:59:34 INFO - 'code_coverage': False, 03:59:34 INFO - 'config_files': ('talos/linux_config.py',), 03:59:34 INFO - 'default_actions': ('clobber', 03:59:34 INFO - 'read-buildbot-config', 03:59:34 INFO - 'download-and-extract', 03:59:34 INFO - 'populate-webroot', 03:59:34 INFO - 'create-virtualenv', 03:59:34 INFO - 'install', 03:59:34 INFO - 'setup-mitmproxy', 03:59:34 INFO - 'run-tests'), 03:59:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:59:34 INFO - 'disable_ccov_upload': False, 03:59:34 INFO - 'download_minidump_stackwalk': True, 03:59:34 INFO - 'download_symbols': 'ondemand', 03:59:34 INFO - 'enable_stylo': False, 03:59:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:59:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:59:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:59:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:59:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:59:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:59:34 INFO - 'gecko_profile': False, 03:59:34 INFO - 'gecko_profile_interval': 0, 03:59:34 INFO - 'installer_path': 'installer.exe', 03:59:34 INFO - 'log_level': 'info', 03:59:34 INFO - 'log_name': 'talos', 03:59:34 INFO - 'log_to_console': True, 03:59:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:59:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:59:34 INFO - 'opt_config_files': (), 03:59:34 INFO - 'pip_index': False, 03:59:34 INFO - 'suite': 'dromaeojs-e10s', 03:59:34 INFO - 'system_bits': '32', 03:59:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:59:34 INFO - 'title': 'talos-linux64-ix-068', 03:59:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:59:34 INFO - 'use_talos_json': True, 03:59:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:59:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:59:34 INFO - 'work_dir': 'build'} 03:59:34 INFO - [mozharness: 2017-08-11 10:59:34.770349Z] Running clobber step. 03:59:34 INFO - Running pre-action listener: _resource_record_pre_action 03:59:34 INFO - Running main action method: clobber 03:59:34 INFO - rmtree: /builds/slave/test/build 03:59:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:59:35 INFO - Running post-action listener: _resource_record_post_action 03:59:35 INFO - [mozharness: 2017-08-11 10:59:35.745384Z] Finished clobber step (success) 03:59:35 INFO - [mozharness: 2017-08-11 10:59:35.745490Z] Running read-buildbot-config step. 03:59:35 INFO - Running pre-action listener: _resource_record_pre_action 03:59:35 INFO - Running main action method: read_buildbot_config 03:59:35 INFO - Using buildbot properties: 03:59:35 INFO - { 03:59:35 INFO - "project": "", 03:59:35 INFO - "product": "firefox", 03:59:35 INFO - "who": "archaeopteryx@coole-files.de", 03:59:35 INFO - "installer_path": "public/build/target.tar.bz2", 03:59:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:59:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:59:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:59:35 INFO - "stage_platform": "linux64-pgo", 03:59:35 INFO - "basedir": "/builds/slave/test", 03:59:35 INFO - "buildnumber": 117, 03:59:35 INFO - "platform": "ubuntu64_hw", 03:59:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:59:35 INFO - "slavebuilddir": "test", 03:59:35 INFO - "taskId": "bycn58AjQWeSoMCL84ktAw", 03:59:35 INFO - "branch": "mozilla-central", 03:59:35 INFO - "script_repo_revision": "production", 03:59:35 INFO - "revision": "f74094603063c92b710c0bae0bb5c092b915e92c", 03:59:35 INFO - "slavename": "talos-linux64-ix-068", 03:59:35 INFO - "repo_path": "mozilla-central" 03:59:35 INFO - } 03:59:35 INFO - Finding installer, test and symbols from parent task. 03:59:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bycn58AjQWeSoMCL84ktAw'}, attempt #1 03:59:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bycn58AjQWeSoMCL84ktAw'}, attempt #1 03:59:36 INFO - Task dependencies: G0j-mfVvREuhlU_NxFAAYA 03:59:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA'}, attempt #1 03:59:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.tar.bz2 03:59:37 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.test_packages.json 03:59:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.crashreporter-symbols.zip 03:59:37 INFO - Running post-action listener: _resource_record_post_action 03:59:37 INFO - [mozharness: 2017-08-11 10:59:37.121209Z] Finished read-buildbot-config step (success) 03:59:37 INFO - [mozharness: 2017-08-11 10:59:37.121476Z] Running download-and-extract step. 03:59:37 INFO - Running pre-action listener: _resource_record_pre_action 03:59:37 INFO - Running main action method: download_and_extract 03:59:37 INFO - mkdir: /builds/slave/test/build/tests 03:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:59:37 INFO - trying https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.test_packages.json 03:59:37 INFO - Downloading https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:59:37 INFO - Downloaded 989 bytes. 03:59:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:59:37 INFO - Using the following test package requirements: 03:59:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:59:37 INFO - u'common': [u'target.common.tests.zip'], 03:59:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:59:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:59:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:59:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:59:37 INFO - u'mozbase': [u'target.common.tests.zip'], 03:59:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:59:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:59:37 INFO - u'web-platform': [u'target.common.tests.zip', 03:59:37 INFO - u'target.web-platform.tests.tar.gz'], 03:59:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:59:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:59:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.common.tests.zip 03:59:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:59:37 INFO - Fetch https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.common.tests.zip into memory 03:59:38 INFO - Content-Length response header: 54654384 03:59:38 INFO - Bytes received: 54654384 03:59:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:59:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.common.tests.zip 03:59:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:59:50 INFO - Fetch https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.common.tests.zip into memory 03:59:51 INFO - Content-Length response header: 54654384 03:59:51 INFO - Bytes received: 54654384 04:00:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.talos.tests.zip 04:00:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:00:03 INFO - Fetch https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.talos.tests.zip into memory 04:00:04 INFO - Content-Length response header: 14496050 04:00:04 INFO - Bytes received: 14496050 04:00:04 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')]} 04:00:04 INFO - trying https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.tar.bz2 04:00:04 INFO - Downloading https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:00:05 INFO - Downloaded 62643873 bytes. 04:00:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.tar.bz2 04:00:05 INFO - mkdir: /builds/slave/test/properties 04:00:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:00:05 INFO - Writing to file /builds/slave/test/properties/build_url 04:00:05 INFO - Contents: 04:00:05 INFO - build_url:https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.tar.bz2 04:00:05 INFO - Running post-action listener: _resource_record_post_action 04:00:05 INFO - Running post-action listener: set_extra_try_arguments 04:00:05 INFO - [mozharness: 2017-08-11 11:00:05.834647Z] Finished download-and-extract step (success) 04:00:05 INFO - [mozharness: 2017-08-11 11:00:05.834772Z] Running populate-webroot step. 04:00:05 INFO - Running pre-action listener: _resource_record_pre_action 04:00:05 INFO - Running main action method: populate_webroot 04:00:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:00:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:00:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:00:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:00:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:00:05 INFO - 'tests': ['damp', 'tps']}, 04:00:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:00:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:00:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:00:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:00:05 INFO - 'other-e10s': {'tests': ['a11yr', 04:00:05 INFO - 'ts_paint', 04:00:05 INFO - 'tpaint', 04:00:05 INFO - 'sessionrestore', 04:00:05 INFO - 'sessionrestore_many_windows', 04:00:05 INFO - 'sessionrestore_no_auto_restore', 04:00:05 INFO - 'tabpaint']}, 04:00:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:00:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:00:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:00:05 INFO - 'tsvgr_opacity', 04:00:05 INFO - 'tart', 04:00:05 INFO - 'tscrollx', 04:00:05 INFO - 'tsvg_static']}, 04:00:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:00:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:00:05 INFO - 'talos_options': ['--mitmproxy', 04:00:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:00:05 INFO - '--firstNonBlankPaint'], 04:00:05 INFO - 'tests': ['tp6_google', 04:00:05 INFO - 'tp6_youtube', 04:00:05 INFO - 'tp6_amazon', 04:00:05 INFO - 'tp6_facebook']}, 04:00:05 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:00:05 INFO - 'talos_options': ['--stylo', 04:00:05 INFO - '--mitmproxy', 04:00:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:00:05 INFO - '--firstNonBlankPaint'], 04:00:05 INFO - 'tests': ['tp6_google', 04:00:05 INFO - 'tp6_youtube', 04:00:05 INFO - 'tp6_amazon', 04:00:05 INFO - 'tp6_facebook']}, 04:00:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:00:05 INFO - 'talos_options': ['--stylo', 04:00:05 INFO - '--stylo-threads=1', 04:00:05 INFO - '--mitmproxy', 04:00:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:00:05 INFO - '--firstNonBlankPaint'], 04:00:05 INFO - 'tests': ['tp6_google', 04:00:05 INFO - 'tp6_youtube', 04:00:05 INFO - 'tp6_amazon', 04:00:05 INFO - 'tp6_facebook']}, 04:00:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:00:05 INFO - 'talos_options': ['--xperf_path', 04:00:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:00:05 INFO - 'tests': ['tp5n']}}} 04:00:05 INFO - Running post-action listener: _resource_record_post_action 04:00:05 INFO - [mozharness: 2017-08-11 11:00:05.845787Z] Finished populate-webroot step (success) 04:00:05 INFO - [mozharness: 2017-08-11 11:00:05.845877Z] Running create-virtualenv step. 04:00:05 INFO - Running pre-action listener: _resource_record_pre_action 04:00:05 INFO - Running main action method: create_virtualenv 04:00:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:00:05 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 04:00:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:00:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:00:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:00:06 INFO - Using real prefix '/usr' 04:00:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:00:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:00:08 INFO - Installing pip.................done. 04:00:08 INFO - Return code: 0 04:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:00:08 INFO - Reading from file tmpfile_stdout 04:00:08 INFO - Output received: 04:00:08 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) 04:00:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:08 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 0x13bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ff00>, '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 0x172aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b050>, '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': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', '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 04:00:08 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 04:00:08 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 04:00:08 INFO - Using env: {'DISPLAY': ':0', 04:00:08 INFO - 'HOME': '/home/cltbld', 04:00:08 INFO - 'LANG': 'en_US.UTF-8', 04:00:08 INFO - 'LANGUAGE': 'en_US:en', 04:00:08 INFO - 'LOGNAME': 'cltbld', 04:00:08 INFO - 'MAIL': '/var/mail/cltbld', 04:00:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:08 INFO - 'MOZ_NO_REMOTE': '1', 04:00:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:08 INFO - 'NO_EM_RESTART': '1', 04:00:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:08 INFO - 'PWD': '/builds/slave/test', 04:00:08 INFO - 'SHELL': '/bin/bash', 04:00:08 INFO - 'SHLVL': '1', 04:00:08 INFO - 'TERM': 'linux', 04:00:08 INFO - 'TMOUT': '86400', 04:00:08 INFO - 'USER': 'cltbld', 04:00:08 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', 04:00:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:08 INFO - '_': '/tools/buildbot/bin/python'} 04:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:09 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 04:00:09 INFO - Cleaning up... 04:00:09 INFO - Return code: 0 04:00:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:09 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 0x13bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ff00>, '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 0x172aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b050>, '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': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', '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 04:00:09 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 04:00:09 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 04:00:09 INFO - Using env: {'DISPLAY': ':0', 04:00:09 INFO - 'HOME': '/home/cltbld', 04:00:09 INFO - 'LANG': 'en_US.UTF-8', 04:00:09 INFO - 'LANGUAGE': 'en_US:en', 04:00:09 INFO - 'LOGNAME': 'cltbld', 04:00:09 INFO - 'MAIL': '/var/mail/cltbld', 04:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:09 INFO - 'MOZ_NO_REMOTE': '1', 04:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:09 INFO - 'NO_EM_RESTART': '1', 04:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:09 INFO - 'PWD': '/builds/slave/test', 04:00:09 INFO - 'SHELL': '/bin/bash', 04:00:09 INFO - 'SHLVL': '1', 04:00:09 INFO - 'TERM': 'linux', 04:00:09 INFO - 'TMOUT': '86400', 04:00:09 INFO - 'USER': 'cltbld', 04:00:09 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', 04:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:09 INFO - '_': '/tools/buildbot/bin/python'} 04:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:09 INFO - Downloading/unpacking psutil>=3.1.1 04:00:09 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 04:00:09 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 04:00:09 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 04:00:09 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 04:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:00:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:10 INFO - Installing collected packages: psutil 04:00:10 INFO - Running setup.py install for psutil 04:00:10 INFO - building 'psutil._psutil_linux' extension 04:00:10 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 04:00:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:00:11 INFO - building 'psutil._psutil_posix' extension 04:00:11 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 04:00:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:00:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:00:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:00:12 INFO - Successfully installed psutil 04:00:12 INFO - Cleaning up... 04:00:12 INFO - Return code: 0 04:00:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ff00>, '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 0x172aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b050>, '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': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', '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 04:00:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:00:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:00:12 INFO - Using env: {'DISPLAY': ':0', 04:00:12 INFO - 'HOME': '/home/cltbld', 04:00:12 INFO - 'LANG': 'en_US.UTF-8', 04:00:12 INFO - 'LANGUAGE': 'en_US:en', 04:00:12 INFO - 'LOGNAME': 'cltbld', 04:00:12 INFO - 'MAIL': '/var/mail/cltbld', 04:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:12 INFO - 'MOZ_NO_REMOTE': '1', 04:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:12 INFO - 'NO_EM_RESTART': '1', 04:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:12 INFO - 'PWD': '/builds/slave/test', 04:00:12 INFO - 'SHELL': '/bin/bash', 04:00:12 INFO - 'SHLVL': '1', 04:00:12 INFO - 'TERM': 'linux', 04:00:12 INFO - 'TMOUT': '86400', 04:00:12 INFO - 'USER': 'cltbld', 04:00:12 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', 04:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:12 INFO - '_': '/tools/buildbot/bin/python'} 04:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:00:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:00:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:00:13 INFO - Installing collected packages: mozsystemmonitor 04:00:13 INFO - Running setup.py install for mozsystemmonitor 04:00:13 INFO - Successfully installed mozsystemmonitor 04:00:13 INFO - Cleaning up... 04:00:13 INFO - Return code: 0 04:00:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ff00>, '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 0x172aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b050>, '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': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', '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 04:00:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:00:13 INFO - Using env: {'DISPLAY': ':0', 04:00:13 INFO - 'HOME': '/home/cltbld', 04:00:13 INFO - 'LANG': 'en_US.UTF-8', 04:00:13 INFO - 'LANGUAGE': 'en_US:en', 04:00:13 INFO - 'LOGNAME': 'cltbld', 04:00:13 INFO - 'MAIL': '/var/mail/cltbld', 04:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:13 INFO - 'MOZ_NO_REMOTE': '1', 04:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:13 INFO - 'NO_EM_RESTART': '1', 04:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:13 INFO - 'PWD': '/builds/slave/test', 04:00:13 INFO - 'SHELL': '/bin/bash', 04:00:13 INFO - 'SHLVL': '1', 04:00:13 INFO - 'TERM': 'linux', 04:00:13 INFO - 'TMOUT': '86400', 04:00:13 INFO - 'USER': 'cltbld', 04:00:13 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', 04:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:13 INFO - '_': '/tools/buildbot/bin/python'} 04:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:13 INFO - Downloading/unpacking jsonschema==2.5.1 04:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:00:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:15 INFO - Downloading functools32-3.2.3-2.tar.gz 04:00:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:00:15 INFO - warning: no files found matching '*.txt' 04:00:15 INFO - no previously-included directories found matching 'build' 04:00:15 INFO - no previously-included directories found matching 'dist' 04:00:15 INFO - no previously-included directories found matching '.git*' 04:00:15 INFO - Installing collected packages: jsonschema, functools32 04:00:15 INFO - Running setup.py install for functools32 04:00:15 INFO - warning: no files found matching '*.txt' 04:00:15 INFO - no previously-included directories found matching 'build' 04:00:15 INFO - no previously-included directories found matching 'dist' 04:00:15 INFO - no previously-included directories found matching '.git*' 04:00:15 INFO - Successfully installed jsonschema functools32 04:00:15 INFO - Cleaning up... 04:00:15 INFO - Return code: 0 04:00:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ff00>, '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 0x172aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b050>, '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': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', '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 04:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:00:15 INFO - Using env: {'DISPLAY': ':0', 04:00:15 INFO - 'HOME': '/home/cltbld', 04:00:15 INFO - 'LANG': 'en_US.UTF-8', 04:00:15 INFO - 'LANGUAGE': 'en_US:en', 04:00:15 INFO - 'LOGNAME': 'cltbld', 04:00:15 INFO - 'MAIL': '/var/mail/cltbld', 04:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:15 INFO - 'MOZ_NO_REMOTE': '1', 04:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:15 INFO - 'NO_EM_RESTART': '1', 04:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:15 INFO - 'PWD': '/builds/slave/test', 04:00:15 INFO - 'SHELL': '/bin/bash', 04:00:15 INFO - 'SHLVL': '1', 04:00:15 INFO - 'TERM': 'linux', 04:00:15 INFO - 'TMOUT': '86400', 04:00:15 INFO - 'USER': 'cltbld', 04:00:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', 04:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:15 INFO - '_': '/tools/buildbot/bin/python'} 04:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:00:15 INFO - Cleaning up... 04:00:15 INFO - Return code: 0 04:00:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ff00>, '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 0x172aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b050>, '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': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', '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 04:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:00:15 INFO - Using env: {'DISPLAY': ':0', 04:00:15 INFO - 'HOME': '/home/cltbld', 04:00:15 INFO - 'LANG': 'en_US.UTF-8', 04:00:15 INFO - 'LANGUAGE': 'en_US:en', 04:00:15 INFO - 'LOGNAME': 'cltbld', 04:00:15 INFO - 'MAIL': '/var/mail/cltbld', 04:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:15 INFO - 'MOZ_NO_REMOTE': '1', 04:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:15 INFO - 'NO_EM_RESTART': '1', 04:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:15 INFO - 'PWD': '/builds/slave/test', 04:00:15 INFO - 'SHELL': '/bin/bash', 04:00:15 INFO - 'SHLVL': '1', 04:00:15 INFO - 'TERM': 'linux', 04:00:15 INFO - 'TMOUT': '86400', 04:00:15 INFO - 'USER': 'cltbld', 04:00:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', 04:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:15 INFO - '_': '/tools/buildbot/bin/python'} 04:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:15 INFO - Downloading/unpacking blobuploader==1.2.4 04:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:00:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:00:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:17 INFO - Downloading docopt-0.6.1.tar.gz 04:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:00:17 INFO - Installing collected packages: blobuploader, requests, docopt 04:00:17 INFO - Running setup.py install for blobuploader 04:00:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:00:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:00:17 INFO - Running setup.py install for requests 04:00:18 INFO - Running setup.py install for docopt 04:00:18 INFO - Successfully installed blobuploader requests docopt 04:00:18 INFO - Cleaning up... 04:00:18 INFO - Return code: 0 04:00:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00: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')]} 04:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00: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')]} 04:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ff00>, '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 0x172aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b050>, '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': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', '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 04:00:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:00:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:00:18 INFO - Using env: {'DISPLAY': ':0', 04:00:18 INFO - 'HOME': '/home/cltbld', 04:00:18 INFO - 'LANG': 'en_US.UTF-8', 04:00:18 INFO - 'LANGUAGE': 'en_US:en', 04:00:18 INFO - 'LOGNAME': 'cltbld', 04:00:18 INFO - 'MAIL': '/var/mail/cltbld', 04:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:18 INFO - 'MOZ_NO_REMOTE': '1', 04:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:18 INFO - 'NO_EM_RESTART': '1', 04:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:18 INFO - 'PWD': '/builds/slave/test', 04:00:18 INFO - 'SHELL': '/bin/bash', 04:00:18 INFO - 'SHLVL': '1', 04:00:18 INFO - 'TERM': 'linux', 04:00:18 INFO - 'TMOUT': '86400', 04:00:18 INFO - 'USER': 'cltbld', 04:00:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', 04:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:18 INFO - '_': '/tools/buildbot/bin/python'} 04:00:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:18 INFO - Running setup.py (path:/tmp/pip-6I9LNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:18 INFO - Running setup.py (path:/tmp/pip-LOqshW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:18 INFO - Running setup.py (path:/tmp/pip-H5T1b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:18 INFO - Running setup.py (path:/tmp/pip-kLbt9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:18 INFO - Running setup.py (path:/tmp/pip-LLgX5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:18 INFO - Running setup.py (path:/tmp/pip-wWx6lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:18 INFO - Running setup.py (path:/tmp/pip-hIc7ML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:18 INFO - Running setup.py (path:/tmp/pip-RAzRW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:18 INFO - Running setup.py (path:/tmp/pip-a_h7Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:19 INFO - Running setup.py (path:/tmp/pip-jOZ3Ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:19 INFO - Running setup.py (path:/tmp/pip-AvthW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:19 INFO - Running setup.py (path:/tmp/pip-vD96Mx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:19 INFO - Running setup.py (path:/tmp/pip-lG2pzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:19 INFO - Running setup.py (path:/tmp/pip-D8xrKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:19 INFO - Running setup.py (path:/tmp/pip-iHQt9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:19 INFO - Running setup.py (path:/tmp/pip-2_NI8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:19 INFO - Running setup.py (path:/tmp/pip-vtRqnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:00:19 INFO - Running setup.py install for manifestparser 04:00:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:00:19 INFO - Running setup.py install for mozcrash 04:00:19 INFO - Running setup.py install for mozdebug 04:00:19 INFO - Running setup.py install for mozdevice 04:00:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:00:20 INFO - Running setup.py install for mozfile 04:00:20 INFO - Running setup.py install for mozhttpd 04:00:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:00:20 INFO - Running setup.py install for mozinfo 04:00:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:00:20 INFO - Running setup.py install for mozInstall 04:00:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:00:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:00:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:00:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:00:20 INFO - Running setup.py install for mozleak 04:00:20 INFO - Running setup.py install for mozlog 04:00:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:00:20 INFO - Running setup.py install for moznetwork 04:00:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:00:20 INFO - Running setup.py install for mozprocess 04:00:20 INFO - Running setup.py install for mozprofile 04:00:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:00:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:00:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:00:20 INFO - Running setup.py install for mozrunner 04:00:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:00:21 INFO - Running setup.py install for mozscreenshot 04:00:21 INFO - Running setup.py install for moztest 04:00:21 INFO - Running setup.py install for mozversion 04:00:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:00:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:00:21 INFO - Cleaning up... 04:00:21 INFO - Return code: 0 04:00:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ff00>, '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 0x172aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b050>, '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': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', '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 04:00:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:00:21 INFO - Using env: {'DISPLAY': ':0', 04:00:21 INFO - 'HOME': '/home/cltbld', 04:00:21 INFO - 'LANG': 'en_US.UTF-8', 04:00:21 INFO - 'LANGUAGE': 'en_US:en', 04:00:21 INFO - 'LOGNAME': 'cltbld', 04:00:21 INFO - 'MAIL': '/var/mail/cltbld', 04:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:21 INFO - 'MOZ_NO_REMOTE': '1', 04:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:21 INFO - 'NO_EM_RESTART': '1', 04:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:21 INFO - 'PWD': '/builds/slave/test', 04:00:21 INFO - 'SHELL': '/bin/bash', 04:00:21 INFO - 'SHLVL': '1', 04:00:21 INFO - 'TERM': 'linux', 04:00:21 INFO - 'TMOUT': '86400', 04:00:21 INFO - 'USER': 'cltbld', 04:00:21 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', 04:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:21 INFO - '_': '/tools/buildbot/bin/python'} 04:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:00:21 INFO - Running setup.py (path:/tmp/pip-MyYgQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:00:21 INFO - Running setup.py (path:/tmp/pip-FtaEHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:00:21 INFO - Running setup.py (path:/tmp/pip-bbFdK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:00:21 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)) 04:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:00:21 INFO - Running setup.py (path:/tmp/pip-rC0MYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:00:21 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)) 04:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:00:21 INFO - Running setup.py (path:/tmp/pip-83Nldz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:00:21 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)) 04:00:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:00:21 INFO - Running setup.py (path:/tmp/pip-7XO0sy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:00:22 INFO - Running setup.py (path:/tmp/pip-iJZHLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:00:22 INFO - Running setup.py (path:/tmp/pip-snu1oO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:00:22 INFO - Running setup.py (path:/tmp/pip-EaKRWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:00:22 INFO - Running setup.py (path:/tmp/pip-N7jYZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:00:22 INFO - Running setup.py (path:/tmp/pip-Su41xE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:00:22 INFO - Running setup.py (path:/tmp/pip-xC9_ZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:00:22 INFO - Running setup.py (path:/tmp/pip-UYufHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:00:22 INFO - Running setup.py (path:/tmp/pip-iYekwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:22 INFO - Running setup.py (path:/tmp/pip-hhPCsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:00:22 INFO - Running setup.py (path:/tmp/pip-5Ns2J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:00:22 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)) 04:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:00:22 INFO - Running setup.py (path:/tmp/pip-zDD5zD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:00:22 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)) 04:00:22 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)) 04:00:22 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)) 04:00:22 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)) 04:00:22 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)) 04:00:22 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)) 04:00:22 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)) 04:00:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:00:22 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 04:00:22 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 04:00:22 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 04:00:22 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 04:00:23 INFO - Downloading blessings-1.6.tar.gz 04:00:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:00:24 INFO - Installing collected packages: blessings 04:00:24 INFO - Running setup.py install for blessings 04:00:24 INFO - Successfully installed blessings 04:00:24 INFO - Cleaning up... 04:00:24 INFO - Return code: 0 04:00:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:00:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:24 INFO - Reading from file tmpfile_stdout 04:00:24 INFO - Current package versions: 04:00:24 INFO - argparse == 1.2.1 04:00:24 INFO - blessings == 1.6 04:00:24 INFO - blobuploader == 1.2.4 04:00:24 INFO - docopt == 0.6.1 04:00:24 INFO - functools32 == 3.2.3-2 04:00:24 INFO - jsonschema == 2.5.1 04:00:24 INFO - manifestparser == 1.1 04:00:24 INFO - mozInstall == 1.13 04:00:24 INFO - mozcrash == 1.0 04:00:24 INFO - mozdebug == 0.1 04:00:24 INFO - mozdevice == 0.51 04:00:24 INFO - mozfile == 1.2 04:00:24 INFO - mozhttpd == 0.7 04:00:24 INFO - mozinfo == 0.10 04:00:24 INFO - mozleak == 0.1 04:00:24 INFO - mozlog == 3.5 04:00:24 INFO - moznetwork == 0.27 04:00:24 INFO - mozprocess == 0.25 04:00:24 INFO - mozprofile == 0.28 04:00:24 INFO - mozrunner == 6.13 04:00:24 INFO - mozscreenshot == 0.1 04:00:24 INFO - mozsystemmonitor == 0.3 04:00:24 INFO - moztest == 0.8 04:00:24 INFO - mozversion == 1.4 04:00:24 INFO - psutil == 3.1.1 04:00:24 INFO - requests == 1.2.3 04:00:24 INFO - wsgiref == 0.1.2 04:00:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ff00>, '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 0x172aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b050>, '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': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', '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 04:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:00:24 INFO - Using env: {'DISPLAY': ':0', 04:00:24 INFO - 'HOME': '/home/cltbld', 04:00:24 INFO - 'LANG': 'en_US.UTF-8', 04:00:24 INFO - 'LANGUAGE': 'en_US:en', 04:00:24 INFO - 'LOGNAME': 'cltbld', 04:00:24 INFO - 'MAIL': '/var/mail/cltbld', 04:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:24 INFO - 'MOZ_NO_REMOTE': '1', 04:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:24 INFO - 'NO_EM_RESTART': '1', 04:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:24 INFO - 'PWD': '/builds/slave/test', 04:00:24 INFO - 'SHELL': '/bin/bash', 04:00:24 INFO - 'SHLVL': '1', 04:00:24 INFO - 'TERM': 'linux', 04:00:24 INFO - 'TMOUT': '86400', 04:00:24 INFO - 'USER': 'cltbld', 04:00:24 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', 04:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:24 INFO - '_': '/tools/buildbot/bin/python'} 04:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:00:24 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:00:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:00:25 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)) 04:00:25 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)) 04:00:25 INFO - Installing collected packages: simplejson 04:00:25 INFO - Running setup.py install for simplejson 04:00:25 INFO - building 'simplejson._speedups' extension 04:00:25 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 04:00:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 04:00:26 INFO - Successfully installed simplejson 04:00:26 INFO - Cleaning up... 04:00:26 INFO - Return code: 0 04:00:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:00:26 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')]} 04:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:00:26 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')]} 04:00:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:00:26 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 0x13bf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x172cb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ff00>, '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 0x172aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b050>, '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': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', '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 04:00:26 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 04:00:26 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 04:00:26 INFO - Using env: {'DISPLAY': ':0', 04:00:26 INFO - 'HOME': '/home/cltbld', 04:00:26 INFO - 'LANG': 'en_US.UTF-8', 04:00:26 INFO - 'LANGUAGE': 'en_US:en', 04:00:26 INFO - 'LOGNAME': 'cltbld', 04:00:26 INFO - 'MAIL': '/var/mail/cltbld', 04:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:26 INFO - 'MOZ_NO_REMOTE': '1', 04:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:26 INFO - 'NO_EM_RESTART': '1', 04:00:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:26 INFO - 'PWD': '/builds/slave/test', 04:00:26 INFO - 'SHELL': '/bin/bash', 04:00:26 INFO - 'SHLVL': '1', 04:00:26 INFO - 'TERM': 'linux', 04:00:26 INFO - 'TMOUT': '86400', 04:00:26 INFO - 'USER': 'cltbld', 04:00:26 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', 04:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:26 INFO - '_': '/tools/buildbot/bin/python'} 04:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:00:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:00:27 INFO - Cleaning up... 04:00:27 INFO - Return code: 0 04:00:27 INFO - Running post-action listener: _resource_record_post_action 04:00:27 INFO - Running post-action listener: _start_resource_monitoring 04:00:27 INFO - Starting resource monitoring. 04:00:27 INFO - [mozharness: 2017-08-11 11:00:27.178304Z] Finished create-virtualenv step (success) 04:00:27 INFO - [mozharness: 2017-08-11 11:00:27.179321Z] Running install step. 04:00:27 INFO - Running pre-action listener: _resource_record_pre_action 04:00:27 INFO - Running main action method: install 04:00:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:00:27 INFO - Reading from file tmpfile_stdout 04:00:27 INFO - Detecting whether we're running mozinstall >=1.0... 04:00:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:00:27 INFO - Reading from file tmpfile_stdout 04:00:27 INFO - Output received: 04:00:27 INFO - Usage: mozinstall [options] installer 04:00:27 INFO - Options: 04:00:27 INFO - -h, --help show this help message and exit 04:00:27 INFO - -d DEST, --destination=DEST 04:00:27 INFO - Directory to install application into. [default: 04:00:27 INFO - "/builds/slave/test"] 04:00:27 INFO - --app=APP Application being installed. [default: firefox] 04:00:27 INFO - mkdir: /builds/slave/test/build/application 04:00:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:00:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:00:45 INFO - Reading from file tmpfile_stdout 04:00:45 INFO - Output received: 04:00:45 INFO - /builds/slave/test/build/application/firefox/firefox 04:00:45 INFO - Running post-action listener: _resource_record_post_action 04:00:45 INFO - [mozharness: 2017-08-11 11:00:45.349282Z] Finished install step (success) 04:00:45 INFO - [mozharness: 2017-08-11 11:00:45.349577Z] Running setup-mitmproxy step. 04:00:45 INFO - Running pre-action listener: _resource_record_pre_action 04:00:45 INFO - Running main action method: setup_mitmproxy 04:00:45 INFO - Skipping: mitmproxy is not required 04:00:45 INFO - Running post-action listener: _resource_record_post_action 04:00:45 INFO - [mozharness: 2017-08-11 11:00:45.350740Z] Finished setup-mitmproxy step (success) 04:00:45 INFO - [mozharness: 2017-08-11 11:00:45.350963Z] Running run-tests step. 04:00:45 INFO - Running pre-action listener: _resource_record_pre_action 04:00:45 INFO - Running pre-action listener: _set_gcov_prefix 04:00:45 INFO - Running main action method: run_tests 04:00:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:00:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:00:45 INFO - Python 2.7.3 04:00:45 INFO - Return code: 0 04:00:45 INFO - grabbing minidump binary from tooltool 04:00:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:00:45 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x172ff00>, '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 0x172aba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x172b050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:00:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:00:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:00:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:00:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:00:45 INFO - Return code: 0 04:00:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:00:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:00:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:00:45 INFO - ENV: RUST_BACKTRACE is now full 04:00:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:00:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:00:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 04:00:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 04:00:45 INFO - Using env: {'DISPLAY': ':0', 04:00:45 INFO - 'HOME': '/home/cltbld', 04:00:45 INFO - 'LANG': 'en_US.UTF-8', 04:00:45 INFO - 'LANGUAGE': 'en_US:en', 04:00:45 INFO - 'LOGNAME': 'cltbld', 04:00:45 INFO - 'MAIL': '/var/mail/cltbld', 04:00:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:00:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:00:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:00:45 INFO - 'MOZ_NO_REMOTE': '1', 04:00:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:00:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:00:45 INFO - 'NO_EM_RESTART': '1', 04:00:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:00:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:00:45 INFO - 'PWD': '/builds/slave/test', 04:00:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:00:45 INFO - 'RUST_BACKTRACE': 'full', 04:00:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:00:45 INFO - 'SHELL': '/bin/bash', 04:00:45 INFO - 'SHLVL': '1', 04:00:45 INFO - 'TERM': 'linux', 04:00:45 INFO - 'TMOUT': '86400', 04:00:45 INFO - 'USER': 'cltbld', 04:00:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133', 04:00:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:00:45 INFO - '_': '/tools/buildbot/bin/python'} 04:00:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 04:00:45 INFO - mozversion application_buildid: 20170811095513 04:00:45 INFO - mozversion application_changeset: f74094603063c92b710c0bae0bb5c092b915e92c 04:00:45 INFO - mozversion application_display_name: Nightly 04:00:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:00:45 INFO - mozversion application_name: Firefox 04:00:45 INFO - mozversion application_remotingname: firefox 04:00:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:00:45 INFO - mozversion application_vendor: Mozilla 04:00:45 INFO - mozversion application_version: 57.0a1 04:00:45 INFO - mozversion platform_buildid: 20170811095513 04:00:45 INFO - mozversion platform_changeset: f74094603063c92b710c0bae0bb5c092b915e92c 04:00:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:00:45 INFO - mozversion platform_version: 57.0a1 04:00:45 INFO - using testdate: 1502449245 04:00:45 INFO - actual date: 1502449245 04:00:45 INFO - starting webserver on 'localhost:34354' 04:00:45 INFO - SUITE-START | Running 2 tests 04:00:45 INFO - TEST-START | dromaeo_css 04:00:45 INFO - Initialising browser for dromaeo_css test... 04:00:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34354/getInfo.html -profile /tmp/tmpbZIZv6/profile 04:00:45 INFO - TEST-INFO | started process 3347 (/builds/slave/test/build/application/firefox/firefox http://localhost:34354/getInfo.html) 04:00:55 INFO - TEST-INFO | 3347: exit 0 04:00:55 INFO - Browser initialized. 04:00:55 INFO - Running cycle 1/1 for dromaeo_css test... 04:00:55 INFO - TEST-INFO | started process 3559 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbZIZv6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:00:56 INFO - PID 3559 | 04:00:56 INFO - PID 3559 | (/builds/slave/test/build/application/firefox/firefox:3608): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:00:56 INFO - PID 3559 | 04:01:06 INFO - PID 3559 | RSS: Main: 162197504 04:01:06 INFO - PID 3559 | 04:04:04 INFO - PID 3559 | Cycle 1(1): loaded http://localhost:34354/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34354/tests/dromaeo/cssquery-ext.html) 04:04:05 INFO - PID 3559 | RSS: Main: 165793792 04:04:05 INFO - PID 3559 | 04:07:07 INFO - PID 3559 | Cycle 1(1): loaded http://localhost:34354/tests/dromaeo/cssquery-ext.html (next: http://localhost:34354/tests/dromaeo/cssquery-jquery.html) 04:07:08 INFO - PID 3559 | RSS: Main: 164954112 04:07:08 INFO - PID 3559 | 04:10:09 INFO - PID 3559 | Cycle 1(1): loaded http://localhost:34354/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34354/tests/dromaeo/cssquery-mootools.html) 04:10:10 INFO - PID 3559 | RSS: Main: 166621184 04:10:10 INFO - PID 3559 | 04:13:11 INFO - PID 3559 | Cycle 1(1): loaded http://localhost:34354/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34354/tests/dromaeo/cssquery-prototype.html) 04:13:12 INFO - PID 3559 | RSS: Main: 165244928 04:13:12 INFO - PID 3559 | 04:16:15 INFO - PID 3559 | Cycle 1(1): loaded http://localhost:34354/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34354/tests/dromaeo/cssquery-yui.html) 04:16:16 INFO - PID 3559 | RSS: Main: 166547456 04:16:16 INFO - PID 3559 | 04:19:18 INFO - PID 3559 | Cycle 1(1): loaded http://localhost:34354/tests/dromaeo/cssquery-yui.html (next: http://localhost:34354/tests/dromaeo/cssquery-dojo.html) 04:19:18 INFO - PID 3559 | RSS: Main: 168820736 04:19:18 INFO - PID 3559 | 04:19:18 INFO - PID 3559 | __start_tp_report 04:19:18 INFO - PID 3559 | _x_x_mozilla_page_load 04:19:18 INFO - PID 3559 | _x_x_mozilla_page_load_details 04:19:18 INFO - PID 3559 | |i|pagename|runs| 04:19:18 INFO - PID 3559 | |0;dojo.html;3491.1272181954528;3513.4202856528673;3513.9648603513965;3540.911477213071;3543.8050907200095;6151.784687535937;6238.5321100917445;6262.2172228471445;6264.248290205171;6292.276388215351;6121.66330851803;6180.134781130634;6192.845178870531;6200.10098535712;6201.317855035943;5446.1558458439;5448.42791506892;5451.945480545203;5457.099578569531;5547.223388725562;5514.6139770216105;5516.14499752537;5528.226048353234;5540.584456165783;5578.079616863233;5432.538234250054;5476.315460567429;5512.173174023888;5593.468620481048;5603.7478313475995;5333.946660533384;5368.892622147574;5444.564434845203;5461.808836690697;5532.059549876531;5419.945800542023;5484.862878428032;5487.917681234785;5494.780208791643;5502.5597952163735;5969.552283578705;6027.939720602782;6048.213732214784;6146.938530614681;6235.189425374718;6785.762498312535;6791.830204244884;6822.488313376467;6827.795166144974;6850.177978642545;6791.3208679132185;6801.4558835293055;6810.863782724317;6881.277465866062;6889.345512176335;6147.323794382614;6307.936920630781;6349.8412539686415;6355.745770169187;6356.300806911236;6880.2431732509385;6882;6988.266232045664;6990.860182796316;6995.02069710241;6564.409203171737;6638.5684930479365;6640.601563906181;6712.664366781642;6733.8653226935185;6775.796726098225;6783.762568310085;6836.555623884432;6836.897446538306;6875.656217189121;6534.248561415498;6663.900041499382;6685.632290223987;6739.898901516482;6767.086443330186;6735.831604209934;6782.152230971129;6812.14848143982;6819.863602727918;6823.624700641512;4821.156297647968;4840.636952228597;4848.369711937426;4887.877803054881;4920.138975679241;4312.525622181557;4332.718373305725;4351.456067991501;4384.539623339567;4459.509453960061;6372.267189273293;6423.518236132309;6443.065755465525;6448.065030570541;6472.35276472349;6717.764878229238;6733.023711561894;6758.594484330956;6802.387785099365;6826.624535650587;6241.843953901098;6327.557071004985;6345.33373995733;6345.428911397904;6421.51838612106;5401.513863752202;5445;5451.727413629303;5455.9454405455435;5465.535429488458;7080.327368899946;7092.468064895051;7112.35988761014;7179.820504487325;7182.748603798842;6763.560368576027;6767.154105736685;6768.627725475146;6851.45188384918;6852.6231057292325;6963.268856769966;7011.123609548807;7016.614086225307;7017.05269788572;7043.823904402431;6626.304238055128;6653.9667301663185;6701.597904125768;6721.831954201184;6750.35871592198;6751.223609284995;6770.763023294161;6806.217285012287;6832.965835170792;6856.142982127234;6500.122483464672;6524.771632992823;6529.7061632227615;6601.504887133388;6605.603663780189;6471.870562588816;6558.967205163944;6559.967200163968;6565.310642382481;6567.408933196035;6515.934840651533;6524.510661700297;6528.118703974903;6540.607563546202;6546.738130474918;6546.312637173219;6646.966765166143;6661.4004739573675;6691;6691.063251144747;6432.774852880127;6446.742130314735;6480.773172938924;6500.577462464925;6521.836954076186 04:19:18 INFO - PID 3559 | |1;ext.html;875.8272663019034;942.4345392764341;1206.2400687566837;1228.6007047709497;1232.0697873105803;33178.33643327132;42236;42957.78521107398;43033.7848310758;43110.56889431109;42936.78531607338;43314.13371732563;43424.565754342446;43487.565124348745;43496.347554786706;7348.412127029838;7455.291747283999;7480.139783924837;7487.663055162504;7488.625568721569;7348.081489813773;7424.665890034961;7430.814229644275;7438.628068596576;7451.068616422947;7427.257274272583;7453.627318634074;7455.552666840007;7462.7014919403155;7463.701451941915;7363.815904602374;7405.666744996488;7407.518511296748;7434.070741157356;7458.216887226818;7294.781156565312;7321.231270716605;7326.157491888448;7327.194008659043;7332.523385979895;38957.61042389597;39348;39372.40941385881;39430.40854387187;39628.20743585112;3502.824858757052;3544.929101417957;3546.592141903688;3559.4482855157494;3567.661072198137;31106.688933110832;31106.688933110832;31134.221644458845;31173.844130779427;31190.376192476022;4989.65072444929;4989.775460104304;5025;5032.521910418504;5063.721495317793;208984;209560.95219523957;209738;210988;211675;49311.50688493069;49334.506654933706;49394.50605493971;49411.50588494141;49590;50600.24099638508;50993;51027.23459148116;51048.489515104375;51083.48916510787;16099.1145486997;16491.17544122813;16495.83504164967;16502.092384918946;16505.587360315847;13577.321133943264;13591.660208494866;13595.320233988261;13624.931875340759;13626;13067.281299528428;13177.496275707585;13402.865971340358;13418.329083545783;13613.319334033258;5531.640443371168;5547.528460080857;5552.250446189712;5568.582356323292;5581.023320918823;1080.3140006096185;1087.1194332590626;1106.9003789658968;1107.9944600276947;1111.77208672222;23902.88048559746;24203.39491512726;24311.75688243095;24322.878385608314;24351.75648243495;1197.275648232824;1210.1226610707167;1210.3282678113555;1211.8848709372771;1217.8173274008793;12576.559820406243;12888.742225155444;12890.80663790044;12943.158694684815;12986.220826750425;269368;270413;271716;271981;273661;56900;57328.71335643295;57378.71310643503;57387;57438.7128064357;1497.161589509878;1501.7071671024046;1511.863932246103;1519.6580769327034;1520.0803513874168;28717.856410717814;29016.854915725286;29156.56265155982;29487;29553.113406597837;53170.468295316554;53357;53640;53661.46338536565;53687;238870;239188;239331;239791;240134;34760.304793904485;34873.30253394969;34876.65123348734;35080.47379289364;35110.64889351176;45785;47773.522264776904;48490.27264590964;48753.5124648749;49081.26378104403;34633.1341716449;34834.47748283829;36022.819885900404;36029;36212;35184.29631407409;35398.823005884806;35429.46855797114;35592.46611300781;35701.1074723134;39210.2157956845;40288.59711402848;40614;40870.59129408668;40874.79562602168;33611.159721006195;33736.49395259024;33737.493937590465;33771.324573508886;33810.15474613154;25695.229143125736;25700.485990280464;26364.60453093167;26793;27014.864925675247 04:19:18 INFO - PID 3559 | |2;jquery.html;544.7385255077563;545.4654438650122;549.2283341904625;557.0613516225159;568.5338022821286;22394.88802555989;22917.77082229177;23584.88207558964;23687.407814804617;23708.407289817762;27132.728672713267;27683.723162768365;27748.445031099418;27755.167344979633;27764.861175694143;5990.191324171246;6128.356522565134;6138.324784273748;6139.938600613981;6160.19917410736;5794.304683437993;5996.460318571328;6061.242344706911;6072.726727297282;6107.175531303284;6010.699465026753;6045.546584006195;6046.758129674808;6049.30433000204;6062.636241825482;6021.518278537728;6025.8192254232445;6028.849278768044;6033.849153771147;6036.396360363972;5560.610757246995;5571.275734154575;5577.107662773978;5580.804671836466;5620.859478513029;30294.242643933856;30588.235294117825;30636.080917572508;30704.385912281854;32330.838345808355;2213.103693004336;2227.654713519407;2245.4274160089235;2258.7402448718444;2267.2178098555974;19602.803971960242;20167.596648067105;20506.282280120126;20946.685799713017;21126.577468450698;2406.338256979327;2452.3133522613516;2454.5459090068216;2456.803455723538;2474.381404648838;159556;162695;163925.7214855708;164055;164109.17945410198;14087.520810314974;14839.812814974775;15000.549983500512;15275.61810954735;15508.302126404338;23034;23043.654345184837;23124.53750924972;23125.7687423127;23128.537429251322;10163.288569800043;10416.375017498975;10606.734831629272;10704.625338113285;10780.29928054674;8957.776055598531;10001;10030;10110.646127385506;10165;8371.111966371593;8994.425975454269;9288.164065234161;9521.904780952102;9658.275629327829;2518.28228954747;2559.5264875998;2572.4340645058055;2675.250929739676;2748.2579703480346;1010.9477760146914;1026.373911913732;1045.926785125034;1056.5192837259028;1062.4422178356424;21054.2631007914;21637.78362216389;21721.891390542947;21808.510638297797;22490.100395984304;1054.99472502637;1127.3517727306833;1129.5820546397886;1132.7904337697553;1134.489479734123;11407.714807129889;12232.877671223352;12308.876911230953;12384.938075309747;12448.564300249447;561549;570428;613120;627864;629335;138188;140604.2969785165;143734;144406.27796860947;144571;1281.3208999230424;1344.9865501345057;1348;1350.5610676530166;1353.208373101727;19124.713129302792;19367.806321937165;19658.606827863077;20331.695024574346;20332.983350832103;61427;63002.054969174584;63268.36731632625;64442.677786610766;65953.34046659664;83862.16137838544;84491.15508844833;84756.576217121;84951.57524212587;86194;12501.56244531437;14678;14741.55775326742;14855.108693478425;15164;25056;25077.74922250754;25157;25185.622215667147;25268.620970685086;19947.900260498605;19970;20043.699344509554;20103.798962010194;20490.590188195856;16158;16229.837701622833;16535.917320413322;16591.66816663636;16861.241244144287;19451.3192038278;20121.496962576053;20299.08654110539;20421.59156816885;20584.764914105202;14385.64035899111;14460.27698615086;14466.770324522113;14499.420023199376;14535.200563969083;19818.405447836587;19893.900530497835;20054.29809956703;20171.39485815428;20213.49466263355 04:19:18 INFO - PID 3559 | |3;mootools.html;1469.9118052916826;1519.8708109810666;1526.9618259543504;1536.9001014934029;1541.4450797712825;15820.367185312589;16385;16519.83480165198;16545.25546350414;16645.83354166458;16773.4129305474;17015.91492042538;17023.744643830352;17046.23291951862;17052.829471705278;2638.828476149049;2690.811643184978;2695.878685459159;2697.4200546882416;2698.8650567471645;2426.1265944260053;2516.358328626198;2519.282004628681;2519.59686450168;2522.3441905104623;2578.6518819959347;2610.9738902611016;2624.2258533732593;2624.619430182622;2633.683957925052;2572.858492782896;2614.424826538168;2622.777063949557;2624.4488657381876;2632.144553020276;2528.608065749812;2563.8077144214258;2565.756253155966;2566.1788227767124;2575.58790593506;15800.130992795392;16157.192140392934;16172.919135404365;16173.272202750904;16188.83811161885;7938.920610793876;8328.417010809246;8328.541930193836;8338.916610833874;8340.916590834075;5166.354205724285;5321.2284218788445;5402.432744561843;5455.263539422207;5467.371252305996;1834.092124398418;1834.4038187588953;1862.832345088935;1885.255324146968;1893.2237782509105;28923.855380723173;29162.70837291621;29183.978560750485;29220.41559168826;29226;6773.983902414579;6902.275261097613;6928.653567321614;7062.71749130029;7109.82225444368;19112;19419.514512137026;19424.514387140152;19428.611427771364;19440.18117372973;8265;8452.788680283042;8457.069722330538;8472;8483.406161568755;7715.1899050600005;7759;7808.258215469521;7849.058113026359;7861.410394220342;5188.9740551297755;5319.654222475527;5328.92006619901;5342.519173274424;5362.544183744425;1493.9028963117362;1500.7298686236581;1503.7368460519365;1516.8862335324895;1519.3694616734153;927.4296307770672;972.6401231544232;979.1530326267728;981.788915383196;991.177322822056;9155.22180614642;9211.170994610517;9225.446473211628;9239.029901860342;9331.766705832408;1031.7626945802508;1062.2882668612049;1071.9732006699894;1086.9076128529164;1099.4118146791427;5217.686938783685;5722.942770572325;5886.293644762656;6014.1580178775;6276.937230627726;22152.667709984362;22805.88597057004;22966.540669186856;23035.078596856274;23220.65169022466;23056.88471557665;23063.88468057649;23495.530089398115;23776.52446951086;23901.402464938168;12247.816282755766;12484.438200281009;12646.810297845539;12659.493620255087;12788;9435.716928491882;9891.258155638212;9925.255605829447;10022.3485473444;10030.147437467896;19825.30611428593;19936.401907942785;20666.380008599164;20921.37235882926;21215.469613259793;20421.387358379274;20551.691724623844;20673.79326206779;21204.4698882523;21493.892530537247;12770.872291276968;12965.740685186433;13089.60731178028;13125.278109704059;13153.079284449997;14395.352209150404;14649;14653.267336632913;14656.706865862836;14660.266986650839;11343.432828358715;11584.594539191088;11610.419479026184;11718.88281117212;11943.283402995849;11071.778564428505;11086;11087.22389432732;11369.886301136883;11403.885961140282;10203.84694229602;10455.84316235242;10468.947655261674;10470.895291046992;10481.737956551147;7742.8451430969935;7822.9608851957655;7826.334761545332;7916.168802275678;7919.604019798871;8245.917540824516;8293.668253269801;8296.170382961656;8299.917000829915;8310.33517318601 04:19:18 INFO - PID 3559 | |4;prototype.html;487.5383116728839;494.1224138868162;518.2666526864487;522.8248536740192;522.9660072095314;5985.610935289204;6045.546584006195;6048.09278608209;6068.510606401326;6091.604045737035;5778.884422311551;5902.3507414184405;5919.556033297498;5927.496162826165;5952.672603006833;4656.8602941911795;4703.5061318561575;4718.4809670936165;4729.810807567693;4739.123262196487;4609.585137337639;4719.126961512131;4721.173794585951;4728.527147285278;4746.335513028179;4633.6524760642915;4652.418447694038;4660.277656963159;4669.649776266777;4706.905861882778;4658.231391820345;4659.790309436084;4691.648126390517;4715.952840471586;4725.385699858996;4216.599423054805;4233.894152646178;4236.173946080516;4242.490901091889;4256.659152366995;5903.2325797646035;5919.526437884959;5921.230240068763;5960.523158147338;5974.910376344358;5601.60788744788;5611.691356975365;5625.212470254127;5629.577781666391;5692.174634677948;6372.394622510854;6380.840478988016;6401.551891367606;6402.93597064028;6457.870842583122;4814.711117332936;4815.109204797123;4829.975850120762;4845.466998630148;4849.75751212438;6658.700358483879;6694.230163531159;6708.228553716288;6744.426723728489;6776.017477465789;4902.338184345139;4925.655204135676;4954.058728841508;4958.553730164303;4961.131801934647;4993.226049962262;5028.572571331478;5042.495750424928;5042.899142017212;5043.672161309503;5527.474889885454;5648.378678345379;5667.773289068474;5685.118806584986;5716.399778023248;6146.815595532141;6363.936360636334;6403.96798016007;6443.48452123829;6481.319461456574;1644.9753253701203;1667.241405160649;1701.778768760078;1727.421313859871;1729.904855232949;1201.5794471934753;1213.7997230456876;1217.8612996847976;1220.4020030185322;1223.7858374784378;6033.78881739137;6053.878922421527;6094.390560943959;6133.754649813957;6159.19930409044;6405.967970160213;6488.28628850826;6526.934730652632;6561.80314590563;6653.73385064592;6121.96939015311;6128.142060111588;6153.261608606996;6168.383161683885;6299.5275354348605;3453.9481907771406;3489.476578513243;3498.7026102781037;3499.2826470573473;3523.436250199956;6849.4177994871;6855.040294358794;6878.27778083294;6881.587104773629;6989.965050174818;6714.160729908762;6720.513410038219;6762.661866906635;6799.864002719918;6822.714390679079;6970.79087627372;6975.581465112109;6985.266547012592;6994.195667498201;7002.964985175042;6642.83392915181;6667.799966001027;6670.199576050905;6692.431143352869;6696.296888826603;6590.439812615981;6620.304867988792;6620.470362371095;6633.900491492535;6641.33586641332;6960.756373526902;6961.234264231032;6992.8811390177325;7028.262032486516;7029.29707029293;4932.654714169974;4954.281629163823;4957.330760347307;4988.42633097184;4998.4501704813165;6365.331640177715;6504.1869766279215;6510.869782604226;6545.527256367279;6610.603363797995;6257.21438529683;6357.205349331333;6394.872102558016;6418.165638467156;6424.9036264455135;6344.524160687874;6377.7767778127545;6405.807825765234;6415.005674120519;6432.163818703539;6322.33615470369;6361.982082866719;6380.872382552416;6439.291677915519;6473.352664733489;6447.774327898501;6458.22501299847;6467.708953097216;6498.602800397937;6520.836979075371;6280.277768056732;6288.490762217127;6290.622562646256;6301.338359472189;6346.587471814318 04:19:18 INFO - PID 3559 | |5;yui.html;930.8138372325536;941.9997308572198;956.1108169402453;959.4339339789527;964.0263334032625;18808.15363308651;19718.70421943672;19741.407757767272;19747.802521974776;22903.198388056422;21501.892490537564;22288.219912303073;22467.21364752234;22504.437389065282;22505.774942250573;1061.7717190803994;1082.83216101504;1083.2309060566968;1083.496174278964;1083.5070043130397;1053.5206481051102;1090.6891535912266;1092.088106431127;1099.433791597328;1100.8128618134897;1159.8318243854635;1162.517555214585;1162.8720840707558;1163.0114402757672;1166.049669519339;1138.6071805227184;1141.3095077478172;1141.8972292493715;1142.4915912418976;1145.8453108830286;836.1763662792144;836.4019725895953;839.341117222977;840.1766269056359;840.5881118252013;20227.79772202274;20284.898575507177;20381.388558343275;21388.89305553478;21646.350609481742;22708.205212817473;23003;23275.06899724009;23384.64923026156;23490.412739681473;17152.22814973329;17377.3049078038;17479.300827966865;17755.73366399505;17919.104044797707;3729.0490924814;3737.0657335666083;3771.1891943232336;3775.924481510382;3785.848566057382;135331.32334338364;138252;138558;146050.26974865058;147396;16873;17319.65360692779;17504;17563;17654.382096626814;33008;33658.66341336555;34131.65868341285;34218.48672269918;34260.82869585636;9376.67181648639;9616.615335386507;9622.51887405627;9630.566624501915;9632.181264592587;4448;4520.276755719135;4532.252178390595;4533;4533.954660453353;5463.31708536433;5690.829275121753;5739.8565035874435;5743.368229494752;5754.856128596819;1172.7654469106042;1201.645514573203;1216.1486959128645;1218;1220.5850010996126;712.3731116617447;736.3262614707482;742.5730205132071;752.6274494125333;763.8815983522563;12843.550475733491;13887.097338672955;14728.410863565552;14806.851931480547;14822.851771482363;711.5019486359569;721.6247551273309;729.1141263365037;733.2174398159;742.9777106686809;5999.910001349983;6029.427204415573;6086.573939824169;6243.656598887105;6334.809955701337;137946;138372;138689;140452.29773851065;142589;125356.37321813333;126203;126240.36879815542;126536;126984;107865;107942;110330;110854.44572777084;110942;11381.146414019147;11392.601258955896;11628.302301861915;11649.650510484698;11666.824997624874;49995.75002124966;50001.24998124958;50176;50867.491325086274;52536.73731631317;65567.67216163888;67025.66487167533;67090;67498.66250668715;67857.66071169612;20078;21077;21143.788562114183;21334.253301135006;21336.679949801077;22570.435739106655;22871.77128228763;23872.28383148508;24279.51440971206;25094.62358064594;22173.55652886901;22665.433364166027;22840.31479055631;22890.42773930665;22912.4271893204;19179.424617261506;19217.231310747415;19462.513437164183;20082.89958550198;20606.175752969713;21673.241436549644;22192.778072219717;22318.21886233974;22374.888125559268;22450.438739031655;15314;15479.148646824533;15553.533393998197;15632.609184770017;15708.13605251722;16065.919670401574;16380.11628662719;16566.17169141562;16682.833171668615;16758.832411676216 04:19:18 INFO - PID 3559 | __end_tp_report 04:19:18 INFO - PID 3559 | __start_cc_report 04:19:18 INFO - PID 3559 | _x_x_mozilla_cycle_collect,324 04:19:18 INFO - PID 3559 | __end_cc_report 04:19:18 INFO - PID 3559 | __startTimestamp1502450358279__endTimestamp 04:19:18 INFO - PID 3559 | 04:19:18 INFO - PID 3559 | ------- Summary: start ------- 04:19:18 INFO - PID 3559 | Number of tests: 6 04:19:18 INFO - PID 3559 | 04:19:18 INFO - PID 3559 | [#0] dojo.html Cycles:165 Average:6203.49 Median:6521.84 stddev:810.95 (12.4%) stddev-sans-first:785.02 04:19:18 INFO - PID 3559 | Values: 3491.1 3513.4 3514.0 3540.9 3543.8 6151.8 6238.5 6262.2 6264.2 6292.3 6121.7 6180.1 6192.8 6200.1 6201.3 5446.2 5448.4 5451.9 5457.1 5547.2 5514.6 5516.1 5528.2 5540.6 5578.1 5432.5 5476.3 5512.2 5593.5 5603.7 5333.9 5368.9 5444.6 5461.8 5532.1 5419.9 5484.9 5487.9 5494.8 5502.6 5969.6 6027.9 6048.2 6146.9 6235.2 6785.8 6791.8 6822.5 6827.8 6850.2 6791.3 6801.5 6810.9 6881.3 6889.3 6147.3 6307.9 6349.8 6355.7 6356.3 6880.2 6882.0 6988.3 6990.9 6995.0 6564.4 6638.6 6640.6 6712.7 6733.9 6775.8 6783.8 6836.6 6836.9 6875.7 6534.2 6663.9 6685.6 6739.9 6767.1 6735.8 6782.2 6812.1 6819.9 6823.6 4821.2 4840.6 4848.4 4887.9 4920.1 4312.5 4332.7 4351.5 4384.5 4459.5 6372.3 6423.5 6443.1 6448.1 6472.4 6717.8 6733.0 6758.6 6802.4 6826.6 6241.8 6327.6 6345.3 6345.4 6421.5 5401.5 5445.0 5451.7 5455.9 5465.5 7080.3 7092.5 7112.4 7179.8 7182.7 6763.6 6767.2 6768.6 6851.5 6852.6 6963.3 7011.1 7016.6 7017.1 7043.8 6626.3 6654.0 6701.6 6721.8 6750.4 6751.2 6770.8 6806.2 6833.0 6856.1 6500.1 6524.8 6529.7 6601.5 6605.6 6471.9 6559.0 6560.0 6565.3 6567.4 6515.9 6524.5 6528.1 6540.6 6546.7 6546.3 6647.0 6661.4 6691.0 6691.1 6432.8 6446.7 6480.8 6500.6 6521.8 04:19:18 INFO - PID 3559 | 04:19:18 INFO - PID 3559 | [#1] ext.html Cycles:180 Average:41861.38 Median:3545.76 stddev:62862.48 (1772.9%) stddev-sans-first:62963.50 04:19:18 INFO - PID 3559 | Values: 875.8 942.4 1206.2 1228.6 1232.1 33178.3 42236.0 42957.8 43033.8 43110.6 42936.8 43314.1 43424.6 43487.6 43496.3 7348.4 7455.3 7480.1 7487.7 7488.6 7348.1 7424.7 7430.8 7438.6 7451.1 7427.3 7453.6 7455.6 7462.7 7463.7 7363.8 7405.7 7407.5 7434.1 7458.2 7294.8 7321.2 7326.2 7327.2 7332.5 38957.6 39348.0 39372.4 39430.4 39628.2 3502.8 3544.9 3546.6 3559.4 3567.7 31106.7 31106.7 31134.2 31173.8 31190.4 4989.7 4989.8 5025.0 5032.5 5063.7 208984.0 209561.0 209738.0 210988.0 211675.0 49311.5 49334.5 49394.5 49411.5 49590.0 50600.2 50993.0 51027.2 51048.5 51083.5 16099.1 16491.2 16495.8 16502.1 16505.6 13577.3 13591.7 13595.3 13624.9 13626.0 13067.3 13177.5 13402.9 13418.3 13613.3 5531.6 5547.5 5552.3 5568.6 5581.0 1080.3 1087.1 1106.9 1108.0 1111.8 23902.9 24203.4 24311.8 24322.9 24351.8 1197.3 1210.1 1210.3 1211.9 1217.8 12576.6 12888.7 12890.8 12943.2 12986.2 269368.0 270413.0 271716.0 271981.0 273661.0 56900.0 57328.7 57378.7 57387.0 57438.7 1497.2 1501.7 1511.9 1519.7 1520.1 28717.9 29016.9 29156.6 29487.0 29553.1 53170.5 53357.0 53640.0 53661.5 53687.0 238870.0 239188.0 239331.0 239791.0 240134.0 34760.3 34873.3 34876.7 35080.5 35110.6 45785.0 47773.5 48490.3 48753.5 49081.3 34633.1 34834.5 36022.8 36029.0 36212.0 35184.3 35398.8 35429.5 35592.5 35701.1 39210.2 40288.6 40614.0 40870.6 40874.8 33611.2 33736.5 33737.5 33771.3 33810.2 25695.2 25700.5 26364.6 26793.0 27014.9 04:19:18 INFO - PID 3559 | 04:19:18 INFO - PID 3559 | [#2] jquery.html Cycles:180 Average:40264.62 Median:12320.16 stddev:101459.72 (823.5%) stddev-sans-first:101700.51 04:19:18 INFO - PID 3559 | Values: 544.7 545.5 549.2 557.1 568.5 22394.9 22917.8 23584.9 23687.4 23708.4 27132.7 27683.7 27748.4 27755.2 27764.9 5990.2 6128.4 6138.3 6139.9 6160.2 5794.3 5996.5 6061.2 6072.7 6107.2 6010.7 6045.5 6046.8 6049.3 6062.6 6021.5 6025.8 6028.8 6033.8 6036.4 5560.6 5571.3 5577.1 5580.8 5620.9 30294.2 30588.2 30636.1 30704.4 32330.8 2213.1 2227.7 2245.4 2258.7 2267.2 19602.8 20167.6 20506.3 20946.7 21126.6 2406.3 2452.3 2454.5 2456.8 2474.4 159556.0 162695.0 163925.7 164055.0 164109.2 14087.5 14839.8 15000.5 15275.6 15508.3 23034.0 23043.7 23124.5 23125.8 23128.5 10163.3 10416.4 10606.7 10704.6 10780.3 8957.8 10001.0 10030.0 10110.6 10165.0 8371.1 8994.4 9288.2 9521.9 9658.3 2518.3 2559.5 2572.4 2675.3 2748.3 1010.9 1026.4 1045.9 1056.5 1062.4 21054.3 21637.8 21721.9 21808.5 22490.1 1055.0 1127.4 1129.6 1132.8 1134.5 11407.7 12232.9 12308.9 12384.9 12448.6 561549.0 570428.0 613120.0 627864.0 629335.0 138188.0 140604.3 143734.0 144406.3 144571.0 1281.3 1345.0 1348.0 1350.6 1353.2 19124.7 19367.8 19658.6 20331.7 20333.0 61427.0 63002.1 63268.4 64442.7 65953.3 83862.2 84491.2 84756.6 84951.6 86194.0 12501.6 14678.0 14741.6 14855.1 15164.0 25056.0 25077.7 25157.0 25185.6 25268.6 19947.9 19970.0 20043.7 20103.8 20490.6 16158.0 16229.8 16535.9 16591.7 16861.2 19451.3 20121.5 20299.1 20421.6 20584.8 14385.6 14460.3 14466.8 14499.4 14535.2 19818.4 19893.9 20054.3 20171.4 20213.5 04:19:18 INFO - PID 3559 | 04:19:18 INFO - PID 3559 | [#3] mootools.html Cycles:180 Average:10059.96 Median:23838.96 stddev:7346.79 (30.8%) stddev-sans-first:7339.05 04:19:18 INFO - PID 3559 | Values: 1469.9 1519.9 1527.0 1536.9 1541.4 15820.4 16385.0 16519.8 16545.3 16645.8 16773.4 17015.9 17023.7 17046.2 17052.8 2638.8 2690.8 2695.9 2697.4 2698.9 2426.1 2516.4 2519.3 2519.6 2522.3 2578.7 2611.0 2624.2 2624.6 2633.7 2572.9 2614.4 2622.8 2624.4 2632.1 2528.6 2563.8 2565.8 2566.2 2575.6 15800.1 16157.2 16172.9 16173.3 16188.8 7938.9 8328.4 8328.5 8338.9 8340.9 5166.4 5321.2 5402.4 5455.3 5467.4 1834.1 1834.4 1862.8 1885.3 1893.2 28923.9 29162.7 29184.0 29220.4 29226.0 6774.0 6902.3 6928.7 7062.7 7109.8 19112.0 19419.5 19424.5 19428.6 19440.2 8265.0 8452.8 8457.1 8472.0 8483.4 7715.2 7759.0 7808.3 7849.1 7861.4 5189.0 5319.7 5328.9 5342.5 5362.5 1493.9 1500.7 1503.7 1516.9 1519.4 927.4 972.6 979.2 981.8 991.2 9155.2 9211.2 9225.4 9239.0 9331.8 1031.8 1062.3 1072.0 1086.9 1099.4 5217.7 5722.9 5886.3 6014.2 6276.9 22152.7 22805.9 22966.5 23035.1 23220.7 23056.9 23063.9 23495.5 23776.5 23901.4 12247.8 12484.4 12646.8 12659.5 12788.0 9435.7 9891.3 9925.3 10022.3 10030.1 19825.3 19936.4 20666.4 20921.4 21215.5 20421.4 20551.7 20673.8 21204.5 21493.9 12770.9 12965.7 13089.6 13125.3 13153.1 14395.4 14649.0 14653.3 14656.7 14660.3 11343.4 11584.6 11610.4 11718.9 11943.3 11071.8 11086.0 11087.2 11369.9 11403.9 10203.8 10455.8 10468.9 10470.9 10481.7 7742.8 7823.0 7826.3 7916.2 7919.6 8245.9 8293.7 8296.2 8299.9 8310.3 04:19:18 INFO - PID 3559 | 04:19:18 INFO - PID 3559 | [#4] prototype.html Cycles:180 Average:5458.61 Median:6080.06 stddev:1571.76 (25.9%) stddev-sans-first:1531.24 04:19:18 INFO - PID 3559 | Values: 487.5 494.1 518.3 522.8 523.0 5985.6 6045.5 6048.1 6068.5 6091.6 5778.9 5902.4 5919.6 5927.5 5952.7 4656.9 4703.5 4718.5 4729.8 4739.1 4609.6 4719.1 4721.2 4728.5 4746.3 4633.7 4652.4 4660.3 4669.6 4706.9 4658.2 4659.8 4691.6 4716.0 4725.4 4216.6 4233.9 4236.2 4242.5 4256.7 5903.2 5919.5 5921.2 5960.5 5974.9 5601.6 5611.7 5625.2 5629.6 5692.2 6372.4 6380.8 6401.6 6402.9 6457.9 4814.7 4815.1 4830.0 4845.5 4849.8 6658.7 6694.2 6708.2 6744.4 6776.0 4902.3 4925.7 4954.1 4958.6 4961.1 4993.2 5028.6 5042.5 5042.9 5043.7 5527.5 5648.4 5667.8 5685.1 5716.4 6146.8 6363.9 6404.0 6443.5 6481.3 1645.0 1667.2 1701.8 1727.4 1729.9 1201.6 1213.8 1217.9 1220.4 1223.8 6033.8 6053.9 6094.4 6133.8 6159.2 6406.0 6488.3 6526.9 6561.8 6653.7 6122.0 6128.1 6153.3 6168.4 6299.5 3453.9 3489.5 3498.7 3499.3 3523.4 6849.4 6855.0 6878.3 6881.6 6990.0 6714.2 6720.5 6762.7 6799.9 6822.7 6970.8 6975.6 6985.3 6994.2 7003.0 6642.8 6667.8 6670.2 6692.4 6696.3 6590.4 6620.3 6620.5 6633.9 6641.3 6960.8 6961.2 6992.9 7028.3 7029.3 4932.7 4954.3 4957.3 4988.4 4998.5 6365.3 6504.2 6510.9 6545.5 6610.6 6257.2 6357.2 6394.9 6418.2 6424.9 6344.5 6377.8 6405.8 6415.0 6432.2 6322.3 6362.0 6380.9 6439.3 6473.4 6447.8 6458.2 6467.7 6498.6 6520.8 6280.3 6288.5 6290.6 6301.3 6346.6 04:19:18 INFO - PID 3559 | 04:19:18 INFO - PID 3559 | [#5] yui.html Cycles:180 Average:27644.52 Median:21335.47 stddev:38846.38 (182.1%) stddev-sans-first:38903.56 04:19:18 INFO - PID 3559 | Values: 930.8 942.0 956.1 959.4 964.0 18808.2 19718.7 19741.4 19747.8 22903.2 21501.9 22288.2 22467.2 22504.4 22505.8 1061.8 1082.8 1083.2 1083.5 1083.5 1053.5 1090.7 1092.1 1099.4 1100.8 1159.8 1162.5 1162.9 1163.0 1166.0 1138.6 1141.3 1141.9 1142.5 1145.8 836.2 836.4 839.3 840.2 840.6 20227.8 20284.9 20381.4 21388.9 21646.4 22708.2 23003.0 23275.1 23384.6 23490.4 17152.2 17377.3 17479.3 17755.7 17919.1 3729.0 3737.1 3771.2 3775.9 3785.8 135331.3 138252.0 138558.0 146050.3 147396.0 16873.0 17319.7 17504.0 17563.0 17654.4 33008.0 33658.7 34131.7 34218.5 34260.8 9376.7 9616.6 9622.5 9630.6 9632.2 4448.0 4520.3 4532.3 4533.0 4534.0 5463.3 5690.8 5739.9 5743.4 5754.9 1172.8 1201.6 1216.1 1218.0 1220.6 712.4 736.3 742.6 752.6 763.9 12843.6 13887.1 14728.4 14806.9 14822.9 711.5 721.6 729.1 733.2 743.0 5999.9 6029.4 6086.6 6243.7 6334.8 137946.0 138372.0 138689.0 140452.3 142589.0 125356.4 126203.0 126240.4 126536.0 126984.0 107865.0 107942.0 110330.0 110854.4 110942.0 11381.1 11392.6 11628.3 11649.7 11666.8 49995.8 50001.2 50176.0 50867.5 52536.7 65567.7 67025.7 67090.0 67498.7 67857.7 20078.0 21077.0 21143.8 21334.3 21336.7 22570.4 22871.8 23872.3 24279.5 25094.6 22173.6 22665.4 22840.3 22890.4 22912.4 19179.4 19217.2 19462.5 20082.9 20606.2 21673.2 22192.8 22318.2 22374.9 22450.4 15314.0 15479.1 15553.5 15632.6 15708.1 16065.9 16380.1 16566.2 16682.8 16758.8 04:19:18 INFO - PID 3559 | -------- Summary: end -------- 04:19:18 INFO - PID 3559 | 04:19:18 INFO - TEST-INFO | 3559: exit 0 04:19:19 INFO - TEST-OK | dromaeo_css | took 1113149ms 04:19:19 INFO - TEST-START | kraken 04:19:19 INFO - Initialising browser for kraken test... 04:19:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34354/getInfo.html -profile /tmp/tmpUlWSKE/profile 04:19:19 INFO - TEST-INFO | started process 3931 (/builds/slave/test/build/application/firefox/firefox http://localhost:34354/getInfo.html) 04:19:24 INFO - TEST-INFO | 3931: exit 0 04:19:25 INFO - Browser initialized. 04:19:25 INFO - Running cycle 1/1 for kraken test... 04:19:25 INFO - TEST-INFO | started process 4142 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUlWSKE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:19:25 INFO - PID 4142 | 04:19:25 INFO - PID 4142 | (/builds/slave/test/build/application/firefox/firefox:4191): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:19:25 INFO - PID 4142 | 04:19:36 INFO - PID 4142 | RSS: Main: 158244864 04:19:36 INFO - PID 4142 | 04:19:38 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34354/tests/kraken/driver.html?testName=audio-beat-detection) 04:19:39 INFO - PID 4142 | RSS: Main: 164368384 04:19:39 INFO - PID 4142 | 04:19:42 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34354/tests/kraken/driver.html?testName=audio-dft) 04:19:42 INFO - PID 4142 | RSS: Main: 168722432 04:19:42 INFO - PID 4142 | 04:19:45 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34354/tests/kraken/driver.html?testName=audio-fft) 04:19:46 INFO - PID 4142 | RSS: Main: 162230272 04:19:46 INFO - PID 4142 | 04:19:48 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34354/tests/kraken/driver.html?testName=audio-oscillator) 04:19:49 INFO - PID 4142 | RSS: Main: 163229696 04:19:49 INFO - PID 4142 | 04:19:51 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34354/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:19:51 INFO - PID 4142 | RSS: Main: 163008512 04:19:51 INFO - PID 4142 | 04:19:54 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34354/tests/kraken/driver.html?testName=imaging-darkroom) 04:19:55 INFO - PID 4142 | RSS: Main: 164601856 04:19:55 INFO - PID 4142 | 04:19:58 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34354/tests/kraken/driver.html?testName=imaging-desaturate) 04:19:59 INFO - PID 4142 | RSS: Main: 166535168 04:19:59 INFO - PID 4142 | 04:20:02 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34354/tests/kraken/driver.html?testName=json-parse-financial) 04:20:03 INFO - PID 4142 | RSS: Main: 165494784 04:20:03 INFO - PID 4142 | 04:20:04 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34354/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:20:05 INFO - PID 4142 | RSS: Main: 165158912 04:20:05 INFO - PID 4142 | 04:20:06 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:20:07 INFO - PID 4142 | RSS: Main: 165052416 04:20:07 INFO - PID 4142 | 04:20:09 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:20:10 INFO - PID 4142 | RSS: Main: 165281792 04:20:10 INFO - PID 4142 | 04:20:12 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:20:13 INFO - PID 4142 | RSS: Main: 165646336 04:20:13 INFO - PID 4142 | 04:20:16 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:20:16 INFO - PID 4142 | RSS: Main: 165621760 04:20:16 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | Cycle 1(1): loaded http://localhost:34354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34354/tests/kraken/driver.html?testName=ai-astar) 04:20:18 INFO - PID 4142 | RSS: Main: 166973440 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | __start_tp_report 04:20:18 INFO - PID 4142 | _x_x_mozilla_page_load 04:20:18 INFO - PID 4142 | _x_x_mozilla_page_load_details 04:20:18 INFO - PID 4142 | |i|pagename|runs| 04:20:18 INFO - PID 4142 | |0;ai-astar;97;105;99;106;106;109;110;98;107;109 04:20:18 INFO - PID 4142 | |1;audio-beat-detection;140;114;138;174;117;138;143;114;163;117 04:20:18 INFO - PID 4142 | |2;audio-dft;167;165;166;163;163;163;163;162;178;168 04:20:18 INFO - PID 4142 | |3;audio-fft;76;74;75;107;77;75;74;90;98;75 04:20:18 INFO - PID 4142 | |4;audio-oscillator;78;78;131;78;78;80;125;78;78;126 04:20:18 INFO - PID 4142 | |5;imaging-gaussian-blur;114;114;113;114;113;115;114;114;115;115 04:20:18 INFO - PID 4142 | |6;imaging-darkroom;148;149;149;149;148;151;149;149;149;150 04:20:18 INFO - PID 4142 | |7;imaging-desaturate;94;94;94;95;94;95;95;94;95;94 04:20:18 INFO - PID 4142 | |8;json-parse-financial;49;48;48;49;48;52;48;51;48;48 04:20:18 INFO - PID 4142 | |9;json-stringify-tinderbox;54;54;54;55;55;53;54;55;53;58 04:20:18 INFO - PID 4142 | |10;stanford-crypto-aes;74;81;83;81;74;74;84;83;76;74 04:20:18 INFO - PID 4142 | |11;stanford-crypto-ccm;120;126;119;121;119;119;134;118;130;148 04:20:18 INFO - PID 4142 | |12;stanford-crypto-pbkdf2;161;159;161;158;160;167;159;170;166;161 04:20:18 INFO - PID 4142 | |13;stanford-crypto-sha256-iterative;65;61;60;62;64;62;61;61;68;63 04:20:18 INFO - PID 4142 | __end_tp_report 04:20:18 INFO - PID 4142 | __start_cc_report 04:20:18 INFO - PID 4142 | _x_x_mozilla_cycle_collect,870 04:20:18 INFO - PID 4142 | __end_cc_report 04:20:18 INFO - PID 4142 | __startTimestamp1502450418831__endTimestamp 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | ------- Summary: start ------- 04:20:18 INFO - PID 4142 | Number of tests: 14 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#0] ai-astar Cycles:10 Average:104.60 Median:109.50 stddev:4.84 (4.4%) stddev-sans-first:4.28 04:20:18 INFO - PID 4142 | Values: 97.0 105.0 99.0 106.0 106.0 109.0 110.0 98.0 107.0 109.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:139.00 stddev:20.91 (15.0%) stddev-sans-first:22.12 04:20:18 INFO - PID 4142 | Values: 140.0 114.0 138.0 174.0 117.0 138.0 143.0 114.0 163.0 117.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:4.73 (2.9%) stddev-sans-first:5.00 04:20:18 INFO - PID 4142 | Values: 167.0 165.0 166.0 163.0 163.0 163.0 163.0 162.0 178.0 168.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#3] audio-fft Cycles:10 Average:82.10 Median:75.50 stddev:11.93 (15.8%) stddev-sans-first:12.45 04:20:18 INFO - PID 4142 | Values: 76.0 74.0 75.0 107.0 77.0 75.0 74.0 90.0 98.0 75.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#4] audio-oscillator Cycles:10 Average:93.00 Median:78.00 stddev:23.75 (30.4%) stddev-sans-first:24.56 04:20:18 INFO - PID 4142 | Values: 78.0 78.0 131.0 78.0 78.0 80.0 125.0 78.0 78.0 126.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 04:20:18 INFO - PID 4142 | Values: 114.0 114.0 113.0 114.0 113.0 115.0 114.0 114.0 115.0 115.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#6] imaging-darkroom Cycles:10 Average:149.10 Median:149.00 stddev:0.88 (0.6%) stddev-sans-first:0.83 04:20:18 INFO - PID 4142 | Values: 148.0 149.0 149.0 149.0 148.0 151.0 149.0 149.0 149.0 150.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:20:18 INFO - PID 4142 | Values: 94.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#8] json-parse-financial Cycles:10 Average:48.90 Median:48.50 stddev:1.45 (3.0%) stddev-sans-first:1.54 04:20:18 INFO - PID 4142 | Values: 49.0 48.0 48.0 49.0 48.0 52.0 48.0 51.0 48.0 48.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#9] json-stringify-tinderbox Cycles:10 Average:54.50 Median:54.50 stddev:1.43 (2.6%) stddev-sans-first:1.51 04:20:18 INFO - PID 4142 | Values: 54.0 54.0 54.0 55.0 55.0 53.0 54.0 55.0 53.0 58.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:81.00 stddev:4.35 (5.4%) stddev-sans-first:4.31 04:20:18 INFO - PID 4142 | Values: 74.0 81.0 83.0 81.0 74.0 74.0 84.0 83.0 76.0 74.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:123.50 stddev:9.62 (7.8%) stddev-sans-first:10.00 04:20:18 INFO - PID 4142 | Values: 120.0 126.0 119.0 121.0 119.0 119.0 134.0 118.0 130.0 148.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:161.00 stddev:4.02 (2.5%) stddev-sans-first:4.24 04:20:18 INFO - PID 4142 | Values: 161.0 159.0 161.0 158.0 160.0 167.0 159.0 170.0 166.0 161.0 04:20:18 INFO - PID 4142 | 04:20:18 INFO - PID 4142 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:62.50 stddev:2.41 (3.8%) stddev-sans-first:2.40 04:20:18 INFO - PID 4142 | Values: 65.0 61.0 60.0 62.0 64.0 62.0 61.0 61.0 68.0 63.0 04:20:18 INFO - PID 4142 | -------- Summary: end -------- 04:20:18 INFO - PID 4142 | 04:20:19 INFO - PID 4142 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:20:19 INFO - TEST-INFO | 4142: exit 0 04:20:19 INFO - TEST-OK | kraken | took 60500ms 04:20:19 INFO - SUITE-END | took 1173s 04:20:19 INFO - Completed test suite (00:19:34) 04:20:19 INFO - javascript benchmark 04:20:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8919.95357523429, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3491.1272181954528, 3513.4202856528673, 3513.9648603513965, 3540.911477213071, 3543.8050907200095, 6151.784687535937, 6238.5321100917445, 6262.2172228471445, 6264.248290205171, 6292.276388215351, 6121.66330851803, 6180.134781130634, 6192.845178870531, 6200.10098535712, 6201.317855035943, 5446.1558458439, 5448.42791506892, 5451.945480545203, 5457.099578569531, 5547.223388725562, 5514.6139770216105, 5516.14499752537, 5528.226048353234, 5540.584456165783, 5578.079616863233, 5432.538234250054, 5476.315460567429, 5512.173174023888, 5593.468620481048, 5603.7478313475995, 5333.946660533384, 5368.892622147574, 5444.564434845203, 5461.808836690697, 5532.059549876531, 5419.945800542023, 5484.862878428032, 5487.917681234785, 5494.780208791643, 5502.5597952163735, 5969.552283578705, 6027.939720602782, 6048.213732214784, 6146.938530614681, 6235.189425374718, 6785.762498312535, 6791.830204244884, 6822.488313376467, 6827.795166144974, 6850.177978642545, 6791.3208679132185, 6801.4558835293055, 6810.863782724317, 6881.277465866062, 6889.345512176335, 6147.323794382614, 6307.936920630781, 6349.8412539686415, 6355.745770169187, 6356.300806911236, 6880.2431732509385, 6882.0, 6988.266232045664, 6990.860182796316, 6995.02069710241, 6564.409203171737, 6638.5684930479365, 6640.601563906181, 6712.664366781642, 6733.8653226935185, 6775.796726098225, 6783.762568310085, 6836.555623884432, 6836.897446538306, 6875.656217189121, 6534.248561415498, 6663.900041499382, 6685.632290223987, 6739.898901516482, 6767.086443330186, 6735.831604209934, 6782.152230971129, 6812.14848143982, 6819.863602727918, 6823.624700641512, 4821.156297647968, 4840.636952228597, 4848.369711937426, 4887.877803054881, 4920.138975679241, 4312.525622181557, 4332.718373305725, 4351.456067991501, 4384.539623339567, 4459.509453960061, 6372.267189273293, 6423.518236132309, 6443.065755465525, 6448.065030570541, 6472.35276472349, 6717.764878229238, 6733.023711561894, 6758.594484330956, 6802.387785099365, 6826.624535650587, 6241.843953901098, 6327.557071004985, 6345.33373995733, 6345.428911397904, 6421.51838612106, 5401.513863752202, 5445.0, 5451.727413629303, 5455.9454405455435, 5465.535429488458, 7080.327368899946, 7092.468064895051, 7112.35988761014, 7179.820504487325, 7182.748603798842, 6763.560368576027, 6767.154105736685, 6768.627725475146, 6851.45188384918, 6852.6231057292325, 6963.268856769966, 7011.123609548807, 7016.614086225307, 7017.05269788572, 7043.823904402431, 6626.304238055128, 6653.9667301663185, 6701.597904125768, 6721.831954201184, 6750.35871592198, 6751.223609284995, 6770.763023294161, 6806.217285012287, 6832.965835170792, 6856.142982127234, 6500.122483464672, 6524.771632992823, 6529.7061632227615, 6601.504887133388, 6605.603663780189, 6471.870562588816, 6558.967205163944, 6559.967200163968, 6565.310642382481, 6567.408933196035, 6515.934840651533, 6524.510661700297, 6528.118703974903, 6540.607563546202, 6546.738130474918, 6546.312637173219, 6646.966765166143, 6661.4004739573675, 6691.0, 6691.063251144747, 6432.774852880127, 6446.742130314735, 6480.773172938924, 6500.577462464925, 6521.836954076186], "value": 6141.124175918062, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [875.8272663019034, 942.4345392764341, 1206.2400687566837, 1228.6007047709497, 1232.0697873105803, 33178.33643327132, 42236.0, 42957.78521107398, 43033.7848310758, 43110.56889431109, 42936.78531607338, 43314.13371732563, 43424.565754342446, 43487.565124348745, 43496.347554786706, 7348.412127029838, 7455.291747283999, 7480.139783924837, 7487.663055162504, 7488.625568721569, 7348.081489813773, 7424.665890034961, 7430.814229644275, 7438.628068596576, 7451.068616422947, 7427.257274272583, 7453.627318634074, 7455.552666840007, 7462.7014919403155, 7463.701451941915, 7363.815904602374, 7405.666744996488, 7407.518511296748, 7434.070741157356, 7458.216887226818, 7294.781156565312, 7321.231270716605, 7326.157491888448, 7327.194008659043, 7332.523385979895, 38957.61042389597, 39348.0, 39372.40941385881, 39430.40854387187, 39628.20743585112, 3502.824858757052, 3544.929101417957, 3546.592141903688, 3559.4482855157494, 3567.661072198137, 31106.688933110832, 31106.688933110832, 31134.221644458845, 31173.844130779427, 31190.376192476022, 4989.65072444929, 4989.775460104304, 5025.0, 5032.521910418504, 5063.721495317793, 208984.0, 209560.95219523957, 209738.0, 210988.0, 211675.0, 49311.50688493069, 49334.506654933706, 49394.50605493971, 49411.50588494141, 49590.0, 50600.24099638508, 50993.0, 51027.23459148116, 51048.489515104375, 51083.48916510787, 16099.1145486997, 16491.17544122813, 16495.83504164967, 16502.092384918946, 16505.587360315847, 13577.321133943264, 13591.660208494866, 13595.320233988261, 13624.931875340759, 13626.0, 13067.281299528428, 13177.496275707585, 13402.865971340358, 13418.329083545783, 13613.319334033258, 5531.640443371168, 5547.528460080857, 5552.250446189712, 5568.582356323292, 5581.023320918823, 1080.3140006096185, 1087.1194332590626, 1106.9003789658968, 1107.9944600276947, 1111.77208672222, 23902.88048559746, 24203.39491512726, 24311.75688243095, 24322.878385608314, 24351.75648243495, 1197.275648232824, 1210.1226610707167, 1210.3282678113555, 1211.8848709372771, 1217.8173274008793, 12576.559820406243, 12888.742225155444, 12890.80663790044, 12943.158694684815, 12986.220826750425, 269368.0, 270413.0, 271716.0, 271981.0, 273661.0, 56900.0, 57328.71335643295, 57378.71310643503, 57387.0, 57438.7128064357, 1497.161589509878, 1501.7071671024046, 1511.863932246103, 1519.6580769327034, 1520.0803513874168, 28717.856410717814, 29016.854915725286, 29156.56265155982, 29487.0, 29553.113406597837, 53170.468295316554, 53357.0, 53640.0, 53661.46338536565, 53687.0, 238870.0, 239188.0, 239331.0, 239791.0, 240134.0, 34760.304793904485, 34873.30253394969, 34876.65123348734, 35080.47379289364, 35110.64889351176, 45785.0, 47773.522264776904, 48490.27264590964, 48753.5124648749, 49081.26378104403, 34633.1341716449, 34834.47748283829, 36022.819885900404, 36029.0, 36212.0, 35184.29631407409, 35398.823005884806, 35429.46855797114, 35592.46611300781, 35701.1074723134, 39210.2157956845, 40288.59711402848, 40614.0, 40870.59129408668, 40874.79562602168, 33611.159721006195, 33736.49395259024, 33737.493937590465, 33771.324573508886, 33810.15474613154, 25695.229143125736, 25700.485990280464, 26364.60453093167, 26793.0, 27014.864925675247], "value": 18197.182495699515, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.7385255077563, 545.4654438650122, 549.2283341904625, 557.0613516225159, 568.5338022821286, 22394.88802555989, 22917.77082229177, 23584.88207558964, 23687.407814804617, 23708.407289817762, 27132.728672713267, 27683.723162768365, 27748.445031099418, 27755.167344979633, 27764.861175694143, 5990.191324171246, 6128.356522565134, 6138.324784273748, 6139.938600613981, 6160.19917410736, 5794.304683437993, 5996.460318571328, 6061.242344706911, 6072.726727297282, 6107.175531303284, 6010.699465026753, 6045.546584006195, 6046.758129674808, 6049.30433000204, 6062.636241825482, 6021.518278537728, 6025.8192254232445, 6028.849278768044, 6033.849153771147, 6036.396360363972, 5560.610757246995, 5571.275734154575, 5577.107662773978, 5580.804671836466, 5620.859478513029, 30294.242643933856, 30588.235294117825, 30636.080917572508, 30704.385912281854, 32330.838345808355, 2213.103693004336, 2227.654713519407, 2245.4274160089235, 2258.7402448718444, 2267.2178098555974, 19602.803971960242, 20167.596648067105, 20506.282280120126, 20946.685799713017, 21126.577468450698, 2406.338256979327, 2452.3133522613516, 2454.5459090068216, 2456.803455723538, 2474.381404648838, 159556.0, 162695.0, 163925.7214855708, 164055.0, 164109.17945410198, 14087.520810314974, 14839.812814974775, 15000.549983500512, 15275.61810954735, 15508.302126404338, 23034.0, 23043.654345184837, 23124.53750924972, 23125.7687423127, 23128.537429251322, 10163.288569800043, 10416.375017498975, 10606.734831629272, 10704.625338113285, 10780.29928054674, 8957.776055598531, 10001.0, 10030.0, 10110.646127385506, 10165.0, 8371.111966371593, 8994.425975454269, 9288.164065234161, 9521.904780952102, 9658.275629327829, 2518.28228954747, 2559.5264875998, 2572.4340645058055, 2675.250929739676, 2748.2579703480346, 1010.9477760146914, 1026.373911913732, 1045.926785125034, 1056.5192837259028, 1062.4422178356424, 21054.2631007914, 21637.78362216389, 21721.891390542947, 21808.510638297797, 22490.100395984304, 1054.99472502637, 1127.3517727306833, 1129.5820546397886, 1132.7904337697553, 1134.489479734123, 11407.714807129889, 12232.877671223352, 12308.876911230953, 12384.938075309747, 12448.564300249447, 561549.0, 570428.0, 613120.0, 627864.0, 629335.0, 138188.0, 140604.2969785165, 143734.0, 144406.27796860947, 144571.0, 1281.3208999230424, 1344.9865501345057, 1348.0, 1350.5610676530166, 1353.208373101727, 19124.713129302792, 19367.806321937165, 19658.606827863077, 20331.695024574346, 20332.983350832103, 61427.0, 63002.054969174584, 63268.36731632625, 64442.677786610766, 65953.34046659664, 83862.16137838544, 84491.15508844833, 84756.576217121, 84951.57524212587, 86194.0, 12501.56244531437, 14678.0, 14741.55775326742, 14855.108693478425, 15164.0, 25056.0, 25077.74922250754, 25157.0, 25185.622215667147, 25268.620970685086, 19947.900260498605, 19970.0, 20043.699344509554, 20103.798962010194, 20490.590188195856, 16158.0, 16229.837701622833, 16535.917320413322, 16591.66816663636, 16861.241244144287, 19451.3192038278, 20121.496962576053, 20299.08654110539, 20421.59156816885, 20584.764914105202, 14385.64035899111, 14460.27698615086, 14466.770324522113, 14499.420023199376, 14535.200563969083, 19818.405447836587, 19893.900530497835, 20054.29809956703, 20171.39485815428, 20213.49466263355], "value": 12533.218005152497, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1469.9118052916826, 1519.8708109810666, 1526.9618259543504, 1536.9001014934029, 1541.4450797712825, 15820.367185312589, 16385.0, 16519.83480165198, 16545.25546350414, 16645.83354166458, 16773.4129305474, 17015.91492042538, 17023.744643830352, 17046.23291951862, 17052.829471705278, 2638.828476149049, 2690.811643184978, 2695.878685459159, 2697.4200546882416, 2698.8650567471645, 2426.1265944260053, 2516.358328626198, 2519.282004628681, 2519.59686450168, 2522.3441905104623, 2578.6518819959347, 2610.9738902611016, 2624.2258533732593, 2624.619430182622, 2633.683957925052, 2572.858492782896, 2614.424826538168, 2622.777063949557, 2624.4488657381876, 2632.144553020276, 2528.608065749812, 2563.8077144214258, 2565.756253155966, 2566.1788227767124, 2575.58790593506, 15800.130992795392, 16157.192140392934, 16172.919135404365, 16173.272202750904, 16188.83811161885, 7938.920610793876, 8328.417010809246, 8328.541930193836, 8338.916610833874, 8340.916590834075, 5166.354205724285, 5321.2284218788445, 5402.432744561843, 5455.263539422207, 5467.371252305996, 1834.092124398418, 1834.4038187588953, 1862.832345088935, 1885.255324146968, 1893.2237782509105, 28923.855380723173, 29162.70837291621, 29183.978560750485, 29220.41559168826, 29226.0, 6773.983902414579, 6902.275261097613, 6928.653567321614, 7062.71749130029, 7109.82225444368, 19112.0, 19419.514512137026, 19424.514387140152, 19428.611427771364, 19440.18117372973, 8265.0, 8452.788680283042, 8457.069722330538, 8472.0, 8483.406161568755, 7715.1899050600005, 7759.0, 7808.258215469521, 7849.058113026359, 7861.410394220342, 5188.9740551297755, 5319.654222475527, 5328.92006619901, 5342.519173274424, 5362.544183744425, 1493.9028963117362, 1500.7298686236581, 1503.7368460519365, 1516.8862335324895, 1519.3694616734153, 927.4296307770672, 972.6401231544232, 979.1530326267728, 981.788915383196, 991.177322822056, 9155.22180614642, 9211.170994610517, 9225.446473211628, 9239.029901860342, 9331.766705832408, 1031.7626945802508, 1062.2882668612049, 1071.9732006699894, 1086.9076128529164, 1099.4118146791427, 5217.686938783685, 5722.942770572325, 5886.293644762656, 6014.1580178775, 6276.937230627726, 22152.667709984362, 22805.88597057004, 22966.540669186856, 23035.078596856274, 23220.65169022466, 23056.88471557665, 23063.88468057649, 23495.530089398115, 23776.52446951086, 23901.402464938168, 12247.816282755766, 12484.438200281009, 12646.810297845539, 12659.493620255087, 12788.0, 9435.716928491882, 9891.258155638212, 9925.255605829447, 10022.3485473444, 10030.147437467896, 19825.30611428593, 19936.401907942785, 20666.380008599164, 20921.37235882926, 21215.469613259793, 20421.387358379274, 20551.691724623844, 20673.79326206779, 21204.4698882523, 21493.892530537247, 12770.872291276968, 12965.740685186433, 13089.60731178028, 13125.278109704059, 13153.079284449997, 14395.352209150404, 14649.0, 14653.267336632913, 14656.706865862836, 14660.266986650839, 11343.432828358715, 11584.594539191088, 11610.419479026184, 11718.88281117212, 11943.283402995849, 11071.778564428505, 11086.0, 11087.22389432732, 11369.886301136883, 11403.885961140282, 10203.84694229602, 10455.84316235242, 10468.947655261674, 10470.895291046992, 10481.737956551147, 7742.8451430969935, 7822.9608851957655, 7826.334761545332, 7916.168802275678, 7919.604019798871, 8245.917540824516, 8293.668253269801, 8296.170382961656, 8299.917000829915, 8310.33517318601], "value": 7061.519337161099, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.5383116728839, 494.1224138868162, 518.2666526864487, 522.8248536740192, 522.9660072095314, 5985.610935289204, 6045.546584006195, 6048.09278608209, 6068.510606401326, 6091.604045737035, 5778.884422311551, 5902.3507414184405, 5919.556033297498, 5927.496162826165, 5952.672603006833, 4656.8602941911795, 4703.5061318561575, 4718.4809670936165, 4729.810807567693, 4739.123262196487, 4609.585137337639, 4719.126961512131, 4721.173794585951, 4728.527147285278, 4746.335513028179, 4633.6524760642915, 4652.418447694038, 4660.277656963159, 4669.649776266777, 4706.905861882778, 4658.231391820345, 4659.790309436084, 4691.648126390517, 4715.952840471586, 4725.385699858996, 4216.599423054805, 4233.894152646178, 4236.173946080516, 4242.490901091889, 4256.659152366995, 5903.2325797646035, 5919.526437884959, 5921.230240068763, 5960.523158147338, 5974.910376344358, 5601.60788744788, 5611.691356975365, 5625.212470254127, 5629.577781666391, 5692.174634677948, 6372.394622510854, 6380.840478988016, 6401.551891367606, 6402.93597064028, 6457.870842583122, 4814.711117332936, 4815.109204797123, 4829.975850120762, 4845.466998630148, 4849.75751212438, 6658.700358483879, 6694.230163531159, 6708.228553716288, 6744.426723728489, 6776.017477465789, 4902.338184345139, 4925.655204135676, 4954.058728841508, 4958.553730164303, 4961.131801934647, 4993.226049962262, 5028.572571331478, 5042.495750424928, 5042.899142017212, 5043.672161309503, 5527.474889885454, 5648.378678345379, 5667.773289068474, 5685.118806584986, 5716.399778023248, 6146.815595532141, 6363.936360636334, 6403.96798016007, 6443.48452123829, 6481.319461456574, 1644.9753253701203, 1667.241405160649, 1701.778768760078, 1727.421313859871, 1729.904855232949, 1201.5794471934753, 1213.7997230456876, 1217.8612996847976, 1220.4020030185322, 1223.7858374784378, 6033.78881739137, 6053.878922421527, 6094.390560943959, 6133.754649813957, 6159.19930409044, 6405.967970160213, 6488.28628850826, 6526.934730652632, 6561.80314590563, 6653.73385064592, 6121.96939015311, 6128.142060111588, 6153.261608606996, 6168.383161683885, 6299.5275354348605, 3453.9481907771406, 3489.476578513243, 3498.7026102781037, 3499.2826470573473, 3523.436250199956, 6849.4177994871, 6855.040294358794, 6878.27778083294, 6881.587104773629, 6989.965050174818, 6714.160729908762, 6720.513410038219, 6762.661866906635, 6799.864002719918, 6822.714390679079, 6970.79087627372, 6975.581465112109, 6985.266547012592, 6994.195667498201, 7002.964985175042, 6642.83392915181, 6667.799966001027, 6670.199576050905, 6692.431143352869, 6696.296888826603, 6590.439812615981, 6620.304867988792, 6620.470362371095, 6633.900491492535, 6641.33586641332, 6960.756373526902, 6961.234264231032, 6992.8811390177325, 7028.262032486516, 7029.29707029293, 4932.654714169974, 4954.281629163823, 4957.330760347307, 4988.42633097184, 4998.4501704813165, 6365.331640177715, 6504.1869766279215, 6510.869782604226, 6545.527256367279, 6610.603363797995, 6257.21438529683, 6357.205349331333, 6394.872102558016, 6418.165638467156, 6424.9036264455135, 6344.524160687874, 6377.7767778127545, 6405.807825765234, 6415.005674120519, 6432.163818703539, 6322.33615470369, 6361.982082866719, 6380.872382552416, 6439.291677915519, 6473.352664733489, 6447.774327898501, 6458.22501299847, 6467.708953097216, 6498.602800397937, 6520.836979075371, 6280.277768056732, 6288.490762217127, 6290.622562646256, 6301.338359472189, 6346.587471814318], "value": 4996.427230219272, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [930.8138372325536, 941.9997308572198, 956.1108169402453, 959.4339339789527, 964.0263334032625, 18808.15363308651, 19718.70421943672, 19741.407757767272, 19747.802521974776, 22903.198388056422, 21501.892490537564, 22288.219912303073, 22467.21364752234, 22504.437389065282, 22505.774942250573, 1061.7717190803994, 1082.83216101504, 1083.2309060566968, 1083.496174278964, 1083.5070043130397, 1053.5206481051102, 1090.6891535912266, 1092.088106431127, 1099.433791597328, 1100.8128618134897, 1159.8318243854635, 1162.517555214585, 1162.8720840707558, 1163.0114402757672, 1166.049669519339, 1138.6071805227184, 1141.3095077478172, 1141.8972292493715, 1142.4915912418976, 1145.8453108830286, 836.1763662792144, 836.4019725895953, 839.341117222977, 840.1766269056359, 840.5881118252013, 20227.79772202274, 20284.898575507177, 20381.388558343275, 21388.89305553478, 21646.350609481742, 22708.205212817473, 23003.0, 23275.06899724009, 23384.64923026156, 23490.412739681473, 17152.22814973329, 17377.3049078038, 17479.300827966865, 17755.73366399505, 17919.104044797707, 3729.0490924814, 3737.0657335666083, 3771.1891943232336, 3775.924481510382, 3785.848566057382, 135331.32334338364, 138252.0, 138558.0, 146050.26974865058, 147396.0, 16873.0, 17319.65360692779, 17504.0, 17563.0, 17654.382096626814, 33008.0, 33658.66341336555, 34131.65868341285, 34218.48672269918, 34260.82869585636, 9376.67181648639, 9616.615335386507, 9622.51887405627, 9630.566624501915, 9632.181264592587, 4448.0, 4520.276755719135, 4532.252178390595, 4533.0, 4533.954660453353, 5463.31708536433, 5690.829275121753, 5739.8565035874435, 5743.368229494752, 5754.856128596819, 1172.7654469106042, 1201.645514573203, 1216.1486959128645, 1218.0, 1220.5850010996126, 712.3731116617447, 736.3262614707482, 742.5730205132071, 752.6274494125333, 763.8815983522563, 12843.550475733491, 13887.097338672955, 14728.410863565552, 14806.851931480547, 14822.851771482363, 711.5019486359569, 721.6247551273309, 729.1141263365037, 733.2174398159, 742.9777106686809, 5999.910001349983, 6029.427204415573, 6086.573939824169, 6243.656598887105, 6334.809955701337, 137946.0, 138372.0, 138689.0, 140452.29773851065, 142589.0, 125356.37321813333, 126203.0, 126240.36879815542, 126536.0, 126984.0, 107865.0, 107942.0, 110330.0, 110854.44572777084, 110942.0, 11381.146414019147, 11392.601258955896, 11628.302301861915, 11649.650510484698, 11666.824997624874, 49995.75002124966, 50001.24998124958, 50176.0, 50867.491325086274, 52536.73731631317, 65567.67216163888, 67025.66487167533, 67090.0, 67498.66250668715, 67857.66071169612, 20078.0, 21077.0, 21143.788562114183, 21334.253301135006, 21336.679949801077, 22570.435739106655, 22871.77128228763, 23872.28383148508, 24279.51440971206, 25094.62358064594, 22173.55652886901, 22665.433364166027, 22840.31479055631, 22890.42773930665, 22912.4271893204, 19179.424617261506, 19217.231310747415, 19462.513437164183, 20082.89958550198, 20606.175752969713, 21673.241436549644, 22192.778072219717, 22318.21886233974, 22374.888125559268, 22450.438739031655, 15314.0, 15479.148646824533, 15553.533393998197, 15632.609184770017, 15708.13605251722, 16065.919670401574, 16380.11628662719, 16566.17169141562, 16682.833171668615, 16758.832411676216], "value": 10192.367796394425, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1471.0000000000005, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 105.0, 99.0, 106.0, 106.0, 109.0, 110.0, 98.0, 107.0, 109.0], "value": 104.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 114.0, 138.0, 174.0, 117.0, 138.0, 143.0, 114.0, 163.0, 117.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 166.0, 163.0, 163.0, 163.0, 163.0, 162.0, 178.0, 168.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 107.0, 77.0, 75.0, 74.0, 90.0, 98.0, 75.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 131.0, 78.0, 78.0, 80.0, 125.0, 78.0, 78.0, 126.0], "value": 93.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 113.0, 115.0, 114.0, 114.0, 115.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 149.0, 148.0, 151.0, 149.0, 149.0, 149.0, 150.0], "value": 149.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 48.0, 49.0, 48.0, 52.0, 48.0, 51.0, 48.0, 48.0], "value": 48.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 55.0, 53.0, 54.0, 55.0, 53.0, 58.0], "value": 54.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 81.0, 83.0, 81.0, 74.0, 74.0, 84.0, 83.0, 76.0, 74.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 126.0, 119.0, 121.0, 119.0, 119.0, 134.0, 118.0, 130.0, 148.0], "value": 125.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 161.0, 158.0, 160.0, 167.0, 159.0, 170.0, 166.0, 161.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 61.0, 60.0, 62.0, 64.0, 62.0, 61.0, 61.0, 68.0, 63.0], "value": 62.7, "unit": "score"}]}]} 04:20:20 INFO - Return code: 0 04:20:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:20:20 INFO - # TBPL SUCCESS # 04:20:20 INFO - Running post-action listener: _package_coverage_data 04:20:20 INFO - Running post-action listener: _resource_record_post_action 04:20:20 INFO - [mozharness: 2017-08-11 11:20:20.143465Z] Finished run-tests step (success) 04:20:20 INFO - Running post-run listener: _resource_record_post_run 04:20:20 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 7532544; Write bytes: 440172544; Read time: 4164; Write time: 313236 04:20:20 INFO - TinderboxPrint: CPU usage
13.1% 04:20:20 INFO - TinderboxPrint: I/O read bytes / time
7,532,544 / 4,164 04:20:20 INFO - TinderboxPrint: I/O write bytes / time
440,172,544 / 313,236 04:20:20 INFO - TinderboxPrint: CPU idle
8,258.4 (86.9%) 04:20:20 INFO - TinderboxPrint: CPU user
1,190.7 (12.5%) 04:20:20 INFO - TinderboxPrint: Swap in / out
0 / 0 04:20:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 120213504; Read time: 0; Write time: 86100 04:20:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:20:20 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 5160960; Write bytes: 319959040; Read time: 3548; Write time: 227136 04:20:20 INFO - Running post-run listener: _upload_blobber_files 04:20:20 INFO - Blob upload gear active. 04:20:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:20:20 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 04:20:20 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'] 04:20:20 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 04:20:21 INFO - (blobuploader) - INFO - Open directory for files ... 04:20:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:20:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:20:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:22 INFO - (blobuploader) - INFO - Done attempting. 04:20:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:20:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:20:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:23 INFO - (blobuploader) - INFO - Done attempting. 04:20:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:20:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:20:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:29 INFO - (blobuploader) - INFO - Done attempting. 04:20:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:20:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:20:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:20:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:20:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:20:30 INFO - (blobuploader) - INFO - Done attempting. 04:20:30 INFO - (blobuploader) - INFO - Iteration through files over. 04:20:30 INFO - Return code: 0 04:20:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:20:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:20:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c76d7a713c76008c0c2036c4d8d65f9755aa62df1ed086258730098a59416625b9123c980686227040ca301904e6e02ab324defb7657c6ed0bdcf4f7529d8141", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2078f00c6f5a1fd79e6a5771b4dcb4ca20c966c73091d89c90be1351cad70dc665bad6f5c289f802c984ccb45a0e4fd5d81d83e4d74d05e05eb659fab6fc211", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d9cac6581cb168153edf0bc8d539a4e687d6383223d133032c8d9c715fd689f46bc44ac7935e84e686180c66c7afaa71f9ab91855c155d4ef573497d9db3d37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a38ed28e65ab75fa4f3899f41defd2805bf36aba8f969d938fd1ca1929542cf85cb971bdfa37fe11217e9ad0a97a5c9e04d3da86c69a74201bde67426ccfce01"} 04:20:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:20:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:20:30 INFO - Contents: 04:20:30 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c76d7a713c76008c0c2036c4d8d65f9755aa62df1ed086258730098a59416625b9123c980686227040ca301904e6e02ab324defb7657c6ed0bdcf4f7529d8141", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2078f00c6f5a1fd79e6a5771b4dcb4ca20c966c73091d89c90be1351cad70dc665bad6f5c289f802c984ccb45a0e4fd5d81d83e4d74d05e05eb659fab6fc211", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d9cac6581cb168153edf0bc8d539a4e687d6383223d133032c8d9c715fd689f46bc44ac7935e84e686180c66c7afaa71f9ab91855c155d4ef573497d9db3d37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a38ed28e65ab75fa4f3899f41defd2805bf36aba8f969d938fd1ca1929542cf85cb971bdfa37fe11217e9ad0a97a5c9e04d3da86c69a74201bde67426ccfce01"} 04:20:30 INFO - Running post-run listener: copy_logs_to_upload_dir 04:20:30 INFO - Copying logs to upload dir... 04:20:30 INFO - mkdir: /builds/slave/test/build/upload/logs 04:20:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.957069 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-11 04:20:30.591791) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:30.596049) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133 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/c76d7a713c76008c0c2036c4d8d65f9755aa62df1ed086258730098a59416625b9123c980686227040ca301904e6e02ab324defb7657c6ed0bdcf4f7529d8141", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2078f00c6f5a1fd79e6a5771b4dcb4ca20c966c73091d89c90be1351cad70dc665bad6f5c289f802c984ccb45a0e4fd5d81d83e4d74d05e05eb659fab6fc211", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d9cac6581cb168153edf0bc8d539a4e687d6383223d133032c8d9c715fd689f46bc44ac7935e84e686180c66c7afaa71f9ab91855c155d4ef573497d9db3d37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a38ed28e65ab75fa4f3899f41defd2805bf36aba8f969d938fd1ca1929542cf85cb971bdfa37fe11217e9ad0a97a5c9e04d3da86c69a74201bde67426ccfce01"} build_url:https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/G0j-mfVvREuhlU_NxFAAYA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c76d7a713c76008c0c2036c4d8d65f9755aa62df1ed086258730098a59416625b9123c980686227040ca301904e6e02ab324defb7657c6ed0bdcf4f7529d8141", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a2078f00c6f5a1fd79e6a5771b4dcb4ca20c966c73091d89c90be1351cad70dc665bad6f5c289f802c984ccb45a0e4fd5d81d83e4d74d05e05eb659fab6fc211", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8d9cac6581cb168153edf0bc8d539a4e687d6383223d133032c8d9c715fd689f46bc44ac7935e84e686180c66c7afaa71f9ab91855c155d4ef573497d9db3d37", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a38ed28e65ab75fa4f3899f41defd2805bf36aba8f969d938fd1ca1929542cf85cb971bdfa37fe11217e9ad0a97a5c9e04d3da86c69a74201bde67426ccfce01"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:30.628711) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:30.629071) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1502449105.768325-1722699133 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 04:20:30.713286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 04:20:30.713845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 04:20:30.714378) ========= ========= Total master_lag: 0.54 =========