builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-075 starttime: 1502878760.76 results: success (0) revision: 0aa944d3ac94757842143a13fe66f6534817383f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:19:20.763113) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:19:20.763563) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:19:20.763839) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:19:20.782900) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:19:20.783301) ========= 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=fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 03:19:21-- 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% 101M=0s 2017-08-16 03:19:21 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:19:20.938707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:19:20.939022) ========= 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=fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015193 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:19:20.988459) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 03:19:20.991804) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0aa944d3ac94757842143a13fe66f6534817383f --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 0aa944d3ac94757842143a13fe66f6534817383f --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=fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 03:19:21,523 truncating revision to first 12 chars 2017-08-16 03:19:21,523 Setting DEBUG logging. 2017-08-16 03:19:21,523 attempt 1/10 2017-08-16 03:19:21,523 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0aa944d3ac94?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 03:19:22,576 unpacking tar archive at: mozilla-central-0aa944d3ac94/testing/mozharness/ program finished with exit code 0 elapsedTime=1.381410 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 03:19:22.390835) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:19:22.391178) ========= script_repo_revision: 0aa944d3ac94757842143a13fe66f6534817383f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:19:22.391560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:19:22.391824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:19:22.403755) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-16 03:19:22.404191) ========= /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=fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:19:23 INFO - MultiFileLogger online at 20170816 03:19:23 in /builds/slave/test 03:19:23 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:19:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:19:23 INFO - {'append_to_log': False, 03:19:23 INFO - 'base_work_dir': '/builds/slave/test', 03:19:23 INFO - 'blob_upload_branch': 'Firefox', 03:19:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:19:23 INFO - 'branch': 'Firefox', 03:19:23 INFO - 'buildbot_json_path': 'buildprops.json', 03:19:23 INFO - 'code_coverage': False, 03:19:23 INFO - 'config_files': ('talos/linux_config.py',), 03:19:23 INFO - 'default_actions': ('clobber', 03:19:23 INFO - 'read-buildbot-config', 03:19:23 INFO - 'download-and-extract', 03:19:23 INFO - 'populate-webroot', 03:19:23 INFO - 'create-virtualenv', 03:19:23 INFO - 'install', 03:19:23 INFO - 'setup-mitmproxy', 03:19:23 INFO - 'run-tests'), 03:19:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:19:23 INFO - 'disable_ccov_upload': False, 03:19:23 INFO - 'download_minidump_stackwalk': True, 03:19:23 INFO - 'download_symbols': 'ondemand', 03:19:23 INFO - 'enable_stylo': False, 03:19:23 INFO - 'enable_webrender': False, 03:19:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:19:23 INFO - 'tooltool.py': '/tools/tooltool.py', 03:19:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:19:23 INFO - '/tools/misc-python/virtualenv.py')}, 03:19:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:19:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:19:23 INFO - 'gecko_profile': False, 03:19:23 INFO - 'gecko_profile_interval': 0, 03:19:23 INFO - 'installer_path': 'installer.exe', 03:19:23 INFO - 'log_level': 'info', 03:19:23 INFO - 'log_name': 'talos', 03:19:23 INFO - 'log_to_console': True, 03:19:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:19:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:19:23 INFO - 'opt_config_files': (), 03:19:23 INFO - 'pip_index': False, 03:19:23 INFO - 'suite': 'dromaeojs-e10s', 03:19:23 INFO - 'system_bits': '32', 03:19:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:19:23 INFO - 'title': 'talos-linux64-ix-075', 03:19:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:19:23 INFO - 'use_talos_json': True, 03:19:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:19:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:19:23 INFO - 'work_dir': 'build'} 03:19:23 INFO - [mozharness: 2017-08-16 10:19:23.041537Z] Running clobber step. 03:19:23 INFO - Running pre-action listener: _resource_record_pre_action 03:19:23 INFO - Running main action method: clobber 03:19:23 INFO - rmtree: /builds/slave/test/build 03:19:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:19:24 INFO - Running post-action listener: _resource_record_post_action 03:19:24 INFO - [mozharness: 2017-08-16 10:19:24.108917Z] Finished clobber step (success) 03:19:24 INFO - [mozharness: 2017-08-16 10:19:24.109021Z] Running read-buildbot-config step. 03:19:24 INFO - Running pre-action listener: _resource_record_pre_action 03:19:24 INFO - Running main action method: read_buildbot_config 03:19:24 INFO - Using buildbot properties: 03:19:24 INFO - { 03:19:24 INFO - "project": "", 03:19:24 INFO - "product": "firefox", 03:19:24 INFO - "who": "cbook@mozilla.com", 03:19:24 INFO - "installer_path": "public/build/target.tar.bz2", 03:19:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:19:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:19:24 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:19:24 INFO - "stage_platform": "linux64-stylosequential", 03:19:24 INFO - "basedir": "/builds/slave/test", 03:19:24 INFO - "buildnumber": 151, 03:19:24 INFO - "platform": "ubuntu64_hw_styloseq", 03:19:24 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:19:24 INFO - "slavebuilddir": "test", 03:19:24 INFO - "taskId": "NUF7A8ZYSQ6gMatqxpwZAg", 03:19:24 INFO - "branch": "mozilla-central", 03:19:24 INFO - "script_repo_revision": "production", 03:19:24 INFO - "revision": "0aa944d3ac94757842143a13fe66f6534817383f", 03:19:24 INFO - "slavename": "talos-linux64-ix-075", 03:19:24 INFO - "repo_path": "mozilla-central" 03:19:24 INFO - } 03:19:24 INFO - Finding installer, test and symbols from parent task. 03:19:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NUF7A8ZYSQ6gMatqxpwZAg'}, attempt #1 03:19:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NUF7A8ZYSQ6gMatqxpwZAg'}, attempt #1 03:19:25 INFO - Task dependencies: AhttepjMRduMG8XVM9dp6A 03:19:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A'}, attempt #1 03:19:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2 03:19:25 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.test_packages.json 03:19:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.crashreporter-symbols.zip 03:19:25 INFO - Running post-action listener: _resource_record_post_action 03:19:25 INFO - [mozharness: 2017-08-16 10:19:25.481232Z] Finished read-buildbot-config step (success) 03:19:25 INFO - [mozharness: 2017-08-16 10:19:25.481454Z] Running download-and-extract step. 03:19:25 INFO - Running pre-action listener: _resource_record_pre_action 03:19:25 INFO - Running main action method: download_and_extract 03:19:25 INFO - mkdir: /builds/slave/test/build/tests 03:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:25 INFO - trying https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.test_packages.json 03:19:25 INFO - Downloading https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:19:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:19:26 INFO - Downloaded 989 bytes. 03:19:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:19:26 INFO - Using the following test package requirements: 03:19:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:19:26 INFO - u'common': [u'target.common.tests.zip'], 03:19:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:19:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:19:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:19:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:19:26 INFO - u'mozbase': [u'target.common.tests.zip'], 03:19:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:19:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:19:26 INFO - u'web-platform': [u'target.common.tests.zip', 03:19:26 INFO - u'target.web-platform.tests.tar.gz'], 03:19:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:19:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:19:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.common.tests.zip 03:19:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:19:26 INFO - Fetch https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.common.tests.zip into memory 03:19:27 INFO - Content-Length response header: 54003731 03:19:27 INFO - Bytes received: 54003731 03:19:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:19:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.common.tests.zip 03:19:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:19:37 INFO - Fetch https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.common.tests.zip into memory 03:19:38 INFO - Content-Length response header: 54003731 03:19:38 INFO - Bytes received: 54003731 03:19:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.talos.tests.zip 03:19:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:19:50 INFO - Fetch https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.talos.tests.zip into memory 03:19:51 INFO - Content-Length response header: 14496050 03:19:51 INFO - Bytes received: 14496050 03:19:51 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:19:51 INFO - trying https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2 03:19:51 INFO - Downloading https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:19:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:19:52 INFO - Downloaded 61888398 bytes. 03:19:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2 03:19:52 INFO - mkdir: /builds/slave/test/properties 03:19:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:19:52 INFO - Writing to file /builds/slave/test/properties/build_url 03:19:52 INFO - Contents: 03:19:52 INFO - build_url:https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2 03:19:52 INFO - Running post-action listener: _resource_record_post_action 03:19:52 INFO - Running post-action listener: set_extra_try_arguments 03:19:52 INFO - [mozharness: 2017-08-16 10:19:52.922693Z] Finished download-and-extract step (success) 03:19:52 INFO - [mozharness: 2017-08-16 10:19:52.922810Z] Running populate-webroot step. 03:19:52 INFO - Running pre-action listener: _resource_record_pre_action 03:19:52 INFO - Running main action method: populate_webroot 03:19:52 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:19:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:19:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:19:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:19:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:19:52 INFO - 'tests': ['damp', 'tps']}, 03:19:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:19:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:19:52 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:19:52 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:19:52 INFO - 'other-e10s': {'tests': ['a11yr', 03:19:52 INFO - 'ts_paint', 03:19:52 INFO - 'tpaint', 03:19:52 INFO - 'sessionrestore', 03:19:52 INFO - 'sessionrestore_many_windows', 03:19:52 INFO - 'sessionrestore_no_auto_restore', 03:19:52 INFO - 'tabpaint']}, 03:19:52 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:19:52 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:19:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:19:52 INFO - 'tsvgr_opacity', 03:19:52 INFO - 'tart', 03:19:52 INFO - 'tscrollx', 03:19:52 INFO - 'tsvg_static']}, 03:19:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:19:52 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:19:52 INFO - 'talos_options': ['--mitmproxy', 03:19:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:19:52 INFO - '--firstNonBlankPaint'], 03:19:52 INFO - 'tests': ['tp6_google', 03:19:52 INFO - 'tp6_youtube', 03:19:52 INFO - 'tp6_amazon', 03:19:52 INFO - 'tp6_facebook']}, 03:19:52 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:19:52 INFO - 'talos_options': ['--stylo', 03:19:52 INFO - '--mitmproxy', 03:19:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:19:52 INFO - '--firstNonBlankPaint'], 03:19:52 INFO - 'tests': ['tp6_google', 03:19:52 INFO - 'tp6_youtube', 03:19:52 INFO - 'tp6_amazon', 03:19:52 INFO - 'tp6_facebook']}, 03:19:52 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:19:52 INFO - 'talos_options': ['--stylo', 03:19:52 INFO - '--stylo-threads=1', 03:19:52 INFO - '--mitmproxy', 03:19:52 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:19:52 INFO - '--firstNonBlankPaint'], 03:19:52 INFO - 'tests': ['tp6_google', 03:19:52 INFO - 'tp6_youtube', 03:19:52 INFO - 'tp6_amazon', 03:19:52 INFO - 'tp6_facebook']}, 03:19:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:19:52 INFO - 'talos_options': ['--xperf_path', 03:19:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:19:52 INFO - 'tests': ['tp5n']}}} 03:19:52 INFO - Running post-action listener: _resource_record_post_action 03:19:52 INFO - [mozharness: 2017-08-16 10:19:52.933506Z] Finished populate-webroot step (success) 03:19:52 INFO - [mozharness: 2017-08-16 10:19:52.933616Z] Running create-virtualenv step. 03:19:52 INFO - Running pre-action listener: _resource_record_pre_action 03:19:52 INFO - Running main action method: create_virtualenv 03:19:52 INFO - Creating virtualenv /builds/slave/test/build/venv 03:19:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:19:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:19:52 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:19:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:19:53 INFO - Using real prefix '/usr' 03:19:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:19:53 INFO - Installing distribute.............................................................................................................................................................................................done. 03:19:55 INFO - Installing pip.................done. 03:19:55 INFO - Return code: 0 03:19:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:19:55 INFO - Reading from file tmpfile_stdout 03:19:55 INFO - Output received: 03:19:55 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:19:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:19:55 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:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:55 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:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:55 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 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e880b0>, '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 0x1e88fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:19:55 INFO - Using env: {'DISPLAY': ':0', 03:19:55 INFO - 'HOME': '/home/cltbld', 03:19:55 INFO - 'LANG': 'en_US.UTF-8', 03:19:55 INFO - 'LANGUAGE': 'en_US:en', 03:19:55 INFO - 'LOGNAME': 'cltbld', 03:19:55 INFO - 'MAIL': '/var/mail/cltbld', 03:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:55 INFO - 'MOZ_NO_REMOTE': '1', 03:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:55 INFO - 'NO_EM_RESTART': '1', 03:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:55 INFO - 'PWD': '/builds/slave/test', 03:19:55 INFO - 'SHELL': '/bin/bash', 03:19:55 INFO - 'SHLVL': '1', 03:19:55 INFO - 'TERM': 'linux', 03:19:55 INFO - 'TMOUT': '86400', 03:19:55 INFO - 'USER': 'cltbld', 03:19:55 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 03:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:55 INFO - '_': '/tools/buildbot/bin/python'} 03:19:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:55 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:19:55 INFO - Cleaning up... 03:19:55 INFO - Return code: 0 03:19:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:19:55 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:19:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:55 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:19:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:55 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 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e880b0>, '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 0x1e88fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:19:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:19:55 INFO - Using env: {'DISPLAY': ':0', 03:19:55 INFO - 'HOME': '/home/cltbld', 03:19:55 INFO - 'LANG': 'en_US.UTF-8', 03:19:55 INFO - 'LANGUAGE': 'en_US:en', 03:19:55 INFO - 'LOGNAME': 'cltbld', 03:19:55 INFO - 'MAIL': '/var/mail/cltbld', 03:19:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:55 INFO - 'MOZ_NO_REMOTE': '1', 03:19:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:55 INFO - 'NO_EM_RESTART': '1', 03:19:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:55 INFO - 'PWD': '/builds/slave/test', 03:19:55 INFO - 'SHELL': '/bin/bash', 03:19:55 INFO - 'SHLVL': '1', 03:19:55 INFO - 'TERM': 'linux', 03:19:55 INFO - 'TMOUT': '86400', 03:19:55 INFO - 'USER': 'cltbld', 03:19:55 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 03:19:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:55 INFO - '_': '/tools/buildbot/bin/python'} 03:19:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:56 INFO - Downloading/unpacking psutil>=3.1.1 03:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:19:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:57 INFO - Installing collected packages: psutil 03:19:57 INFO - Running setup.py install for psutil 03:19:57 INFO - building 'psutil._psutil_linux' extension 03:19:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:19:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:19:57 INFO - building 'psutil._psutil_posix' extension 03:19:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:19:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:19:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:19:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:19:57 INFO - Successfully installed psutil 03:19:57 INFO - Cleaning up... 03:19:57 INFO - Return code: 0 03:19:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:57 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 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e880b0>, '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 0x1e88fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:19:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:19:57 INFO - Using env: {'DISPLAY': ':0', 03:19:57 INFO - 'HOME': '/home/cltbld', 03:19:57 INFO - 'LANG': 'en_US.UTF-8', 03:19:57 INFO - 'LANGUAGE': 'en_US:en', 03:19:57 INFO - 'LOGNAME': 'cltbld', 03:19:57 INFO - 'MAIL': '/var/mail/cltbld', 03:19:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:57 INFO - 'MOZ_NO_REMOTE': '1', 03:19:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:57 INFO - 'NO_EM_RESTART': '1', 03:19:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:57 INFO - 'PWD': '/builds/slave/test', 03:19:57 INFO - 'SHELL': '/bin/bash', 03:19:57 INFO - 'SHLVL': '1', 03:19:57 INFO - 'TERM': 'linux', 03:19:57 INFO - 'TMOUT': '86400', 03:19:57 INFO - 'USER': 'cltbld', 03:19:57 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 03:19:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:57 INFO - '_': '/tools/buildbot/bin/python'} 03:19:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:19:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:19:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:19:59 INFO - Installing collected packages: mozsystemmonitor 03:19:59 INFO - Running setup.py install for mozsystemmonitor 03:19:59 INFO - Successfully installed mozsystemmonitor 03:19:59 INFO - Cleaning up... 03:19:59 INFO - Return code: 0 03:19:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:19:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:19:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:19:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e880b0>, '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 0x1e88fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:19:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:19:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:19:59 INFO - Using env: {'DISPLAY': ':0', 03:19:59 INFO - 'HOME': '/home/cltbld', 03:19:59 INFO - 'LANG': 'en_US.UTF-8', 03:19:59 INFO - 'LANGUAGE': 'en_US:en', 03:19:59 INFO - 'LOGNAME': 'cltbld', 03:19:59 INFO - 'MAIL': '/var/mail/cltbld', 03:19:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:19:59 INFO - 'MOZ_NO_REMOTE': '1', 03:19:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:19:59 INFO - 'NO_EM_RESTART': '1', 03:19:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:19:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:19:59 INFO - 'PWD': '/builds/slave/test', 03:19:59 INFO - 'SHELL': '/bin/bash', 03:19:59 INFO - 'SHLVL': '1', 03:19:59 INFO - 'TERM': 'linux', 03:19:59 INFO - 'TMOUT': '86400', 03:19:59 INFO - 'USER': 'cltbld', 03:19:59 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 03:19:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:19:59 INFO - '_': '/tools/buildbot/bin/python'} 03:19:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:19:59 INFO - Downloading/unpacking jsonschema==2.5.1 03:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:19:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:19:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:20:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:00 INFO - Downloading functools32-3.2.3-2.tar.gz 03:20:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:20:00 INFO - warning: no files found matching '*.txt' 03:20:00 INFO - no previously-included directories found matching 'build' 03:20:00 INFO - no previously-included directories found matching 'dist' 03:20:00 INFO - no previously-included directories found matching '.git*' 03:20:00 INFO - Installing collected packages: jsonschema, functools32 03:20:01 INFO - Running setup.py install for functools32 03:20:01 INFO - warning: no files found matching '*.txt' 03:20:01 INFO - no previously-included directories found matching 'build' 03:20:01 INFO - no previously-included directories found matching 'dist' 03:20:01 INFO - no previously-included directories found matching '.git*' 03:20:01 INFO - Successfully installed jsonschema functools32 03:20:01 INFO - Cleaning up... 03:20:01 INFO - Return code: 0 03:20:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:20:01 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:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:01 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:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:01 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 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e880b0>, '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 0x1e88fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:20:01 INFO - Using env: {'DISPLAY': ':0', 03:20:01 INFO - 'HOME': '/home/cltbld', 03:20:01 INFO - 'LANG': 'en_US.UTF-8', 03:20:01 INFO - 'LANGUAGE': 'en_US:en', 03:20:01 INFO - 'LOGNAME': 'cltbld', 03:20:01 INFO - 'MAIL': '/var/mail/cltbld', 03:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:01 INFO - 'MOZ_NO_REMOTE': '1', 03:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:01 INFO - 'NO_EM_RESTART': '1', 03:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:01 INFO - 'PWD': '/builds/slave/test', 03:20:01 INFO - 'SHELL': '/bin/bash', 03:20:01 INFO - 'SHLVL': '1', 03:20:01 INFO - 'TERM': 'linux', 03:20:01 INFO - 'TMOUT': '86400', 03:20:01 INFO - 'USER': 'cltbld', 03:20:01 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 03:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:01 INFO - '_': '/tools/buildbot/bin/python'} 03:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:20:01 INFO - Cleaning up... 03:20:01 INFO - Return code: 0 03:20:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:20:01 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:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:01 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:20:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:01 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 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e880b0>, '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 0x1e88fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:20:01 INFO - Using env: {'DISPLAY': ':0', 03:20:01 INFO - 'HOME': '/home/cltbld', 03:20:01 INFO - 'LANG': 'en_US.UTF-8', 03:20:01 INFO - 'LANGUAGE': 'en_US:en', 03:20:01 INFO - 'LOGNAME': 'cltbld', 03:20:01 INFO - 'MAIL': '/var/mail/cltbld', 03:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:01 INFO - 'MOZ_NO_REMOTE': '1', 03:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:01 INFO - 'NO_EM_RESTART': '1', 03:20:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:01 INFO - 'PWD': '/builds/slave/test', 03:20:01 INFO - 'SHELL': '/bin/bash', 03:20:01 INFO - 'SHLVL': '1', 03:20:01 INFO - 'TERM': 'linux', 03:20:01 INFO - 'TMOUT': '86400', 03:20:01 INFO - 'USER': 'cltbld', 03:20:01 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 03:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:01 INFO - '_': '/tools/buildbot/bin/python'} 03:20:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:01 INFO - Downloading/unpacking blobuploader==1.2.4 03:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:02 INFO - Downloading blobuploader-1.2.4.tar.gz 03:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:20:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:20:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:03 INFO - Downloading docopt-0.6.1.tar.gz 03:20:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:20:03 INFO - Installing collected packages: blobuploader, requests, docopt 03:20:03 INFO - Running setup.py install for blobuploader 03:20:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:20:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:20:03 INFO - Running setup.py install for requests 03:20:03 INFO - Running setup.py install for docopt 03:20:03 INFO - Successfully installed blobuploader requests docopt 03:20:03 INFO - Cleaning up... 03:20:03 INFO - Return code: 0 03:20:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:03 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:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:03 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:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:03 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 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e880b0>, '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 0x1e88fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:20:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:03 INFO - Using env: {'DISPLAY': ':0', 03:20:03 INFO - 'HOME': '/home/cltbld', 03:20:03 INFO - 'LANG': 'en_US.UTF-8', 03:20:03 INFO - 'LANGUAGE': 'en_US:en', 03:20:03 INFO - 'LOGNAME': 'cltbld', 03:20:03 INFO - 'MAIL': '/var/mail/cltbld', 03:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:03 INFO - 'MOZ_NO_REMOTE': '1', 03:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:03 INFO - 'NO_EM_RESTART': '1', 03:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:03 INFO - 'PWD': '/builds/slave/test', 03:20:03 INFO - 'SHELL': '/bin/bash', 03:20:03 INFO - 'SHLVL': '1', 03:20:03 INFO - 'TERM': 'linux', 03:20:03 INFO - 'TMOUT': '86400', 03:20:03 INFO - 'USER': 'cltbld', 03:20:03 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 03:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:03 INFO - '_': '/tools/buildbot/bin/python'} 03:20:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:04 INFO - Running setup.py (path:/tmp/pip-w7_ZrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:04 INFO - Running setup.py (path:/tmp/pip-BGEWfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:04 INFO - Running setup.py (path:/tmp/pip-7LiPKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:04 INFO - Running setup.py (path:/tmp/pip-gyRRYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:04 INFO - Running setup.py (path:/tmp/pip-dnE9rY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:04 INFO - Running setup.py (path:/tmp/pip-4IKa6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:04 INFO - Running setup.py (path:/tmp/pip-CuSuXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:04 INFO - Running setup.py (path:/tmp/pip-mVPe3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:04 INFO - Running setup.py (path:/tmp/pip-ZMgw7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:04 INFO - Running setup.py (path:/tmp/pip-NM8Xw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:04 INFO - Running setup.py (path:/tmp/pip-zrthZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:04 INFO - Running setup.py (path:/tmp/pip-SBmDjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:04 INFO - Running setup.py (path:/tmp/pip-4eQFCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:05 INFO - Running setup.py (path:/tmp/pip-6WdnNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:05 INFO - Running setup.py (path:/tmp/pip-ySkVj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:05 INFO - Running setup.py (path:/tmp/pip-o75vkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:05 INFO - Running setup.py (path:/tmp/pip-N9NhGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:20:05 INFO - Running setup.py install for manifestparser 03:20:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:20:05 INFO - Running setup.py install for mozcrash 03:20:05 INFO - Running setup.py install for mozdebug 03:20:05 INFO - Running setup.py install for mozdevice 03:20:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:20:05 INFO - Running setup.py install for mozfile 03:20:05 INFO - Running setup.py install for mozhttpd 03:20:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:20:05 INFO - Running setup.py install for mozinfo 03:20:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Running setup.py install for mozInstall 03:20:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Running setup.py install for mozleak 03:20:06 INFO - Running setup.py install for mozlog 03:20:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Running setup.py install for moznetwork 03:20:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Running setup.py install for mozprocess 03:20:06 INFO - Running setup.py install for mozprofile 03:20:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Running setup.py install for mozrunner 03:20:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:20:06 INFO - Running setup.py install for mozscreenshot 03:20:06 INFO - Running setup.py install for moztest 03:20:06 INFO - Running setup.py install for mozversion 03:20:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:20:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:20:07 INFO - Cleaning up... 03:20:07 INFO - Return code: 0 03:20:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:07 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:20:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:07 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:20:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:07 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 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e880b0>, '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 0x1e88fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:20:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:07 INFO - Using env: {'DISPLAY': ':0', 03:20:07 INFO - 'HOME': '/home/cltbld', 03:20:07 INFO - 'LANG': 'en_US.UTF-8', 03:20:07 INFO - 'LANGUAGE': 'en_US:en', 03:20:07 INFO - 'LOGNAME': 'cltbld', 03:20:07 INFO - 'MAIL': '/var/mail/cltbld', 03:20:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:07 INFO - 'MOZ_NO_REMOTE': '1', 03:20:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:07 INFO - 'NO_EM_RESTART': '1', 03:20:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:07 INFO - 'PWD': '/builds/slave/test', 03:20:07 INFO - 'SHELL': '/bin/bash', 03:20:07 INFO - 'SHLVL': '1', 03:20:07 INFO - 'TERM': 'linux', 03:20:07 INFO - 'TMOUT': '86400', 03:20:07 INFO - 'USER': 'cltbld', 03:20:07 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 03:20:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:07 INFO - '_': '/tools/buildbot/bin/python'} 03:20:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:20:07 INFO - Running setup.py (path:/tmp/pip-m8h6dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:20:07 INFO - Running setup.py (path:/tmp/pip-QPsiCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:20:07 INFO - Running setup.py (path:/tmp/pip-DcF0ou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:20:07 INFO - Running setup.py (path:/tmp/pip-RffYEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:20:07 INFO - Running setup.py (path:/tmp/pip-NZGzi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:20:07 INFO - Running setup.py (path:/tmp/pip-hTkFgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:20:07 INFO - Running setup.py (path:/tmp/pip-N9TVF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:20:07 INFO - Running setup.py (path:/tmp/pip-Ge5cRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:20:07 INFO - Running setup.py (path:/tmp/pip-TF5OoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:20:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:20:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:20:07 INFO - Running setup.py (path:/tmp/pip-dus8Bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:20:08 INFO - Running setup.py (path:/tmp/pip-WRYyxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:20:08 INFO - Running setup.py (path:/tmp/pip-O4tI72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:20:08 INFO - Running setup.py (path:/tmp/pip-JVYTVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:20:08 INFO - Running setup.py (path:/tmp/pip-RoMMau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:08 INFO - Running setup.py (path:/tmp/pip-CgXki8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:20:08 INFO - Running setup.py (path:/tmp/pip-k7ShS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:20:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:20:08 INFO - Running setup.py (path:/tmp/pip-NzM96N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:20:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:09 INFO - Downloading blessings-1.6.tar.gz 03:20:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:20:09 INFO - Installing collected packages: blessings 03:20:09 INFO - Running setup.py install for blessings 03:20:09 INFO - Successfully installed blessings 03:20:09 INFO - Cleaning up... 03:20:09 INFO - Return code: 0 03:20:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:20:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:10 INFO - Reading from file tmpfile_stdout 03:20:10 INFO - Current package versions: 03:20:10 INFO - argparse == 1.2.1 03:20:10 INFO - blessings == 1.6 03:20:10 INFO - blobuploader == 1.2.4 03:20:10 INFO - docopt == 0.6.1 03:20:10 INFO - functools32 == 3.2.3-2 03:20:10 INFO - jsonschema == 2.5.1 03:20:10 INFO - manifestparser == 1.1 03:20:10 INFO - mozInstall == 1.13 03:20:10 INFO - mozcrash == 1.0 03:20:10 INFO - mozdebug == 0.1 03:20:10 INFO - mozdevice == 0.51 03:20:10 INFO - mozfile == 1.2 03:20:10 INFO - mozhttpd == 0.7 03:20:10 INFO - mozinfo == 0.10 03:20:10 INFO - mozleak == 0.1 03:20:10 INFO - mozlog == 3.5 03:20:10 INFO - moznetwork == 0.27 03:20:10 INFO - mozprocess == 0.25 03:20:10 INFO - mozprofile == 0.28 03:20:10 INFO - mozrunner == 6.13 03:20:10 INFO - mozscreenshot == 0.1 03:20:10 INFO - mozsystemmonitor == 0.3 03:20:10 INFO - moztest == 0.8 03:20:10 INFO - mozversion == 1.4 03:20:10 INFO - psutil == 3.1.1 03:20:10 INFO - requests == 1.2.3 03:20:10 INFO - wsgiref == 0.1.2 03:20:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:20:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20:10 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 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e880b0>, '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 0x1e88fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:20:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:20:10 INFO - Using env: {'DISPLAY': ':0', 03:20:10 INFO - 'HOME': '/home/cltbld', 03:20:10 INFO - 'LANG': 'en_US.UTF-8', 03:20:10 INFO - 'LANGUAGE': 'en_US:en', 03:20:10 INFO - 'LOGNAME': 'cltbld', 03:20:10 INFO - 'MAIL': '/var/mail/cltbld', 03:20:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:10 INFO - 'MOZ_NO_REMOTE': '1', 03:20:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:10 INFO - 'NO_EM_RESTART': '1', 03:20:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:10 INFO - 'PWD': '/builds/slave/test', 03:20:10 INFO - 'SHELL': '/bin/bash', 03:20:10 INFO - 'SHLVL': '1', 03:20:10 INFO - 'TERM': 'linux', 03:20:10 INFO - 'TMOUT': '86400', 03:20:10 INFO - 'USER': 'cltbld', 03:20:10 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 03:20:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:10 INFO - '_': '/tools/buildbot/bin/python'} 03:20:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:20:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:20:10 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:20:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:20:11 INFO - Installing collected packages: simplejson 03:20:11 INFO - Running setup.py install for simplejson 03:20:11 INFO - building 'simplejson._speedups' extension 03:20:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:20:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:20:12 INFO - Successfully installed simplejson 03:20:12 INFO - Cleaning up... 03:20:12 INFO - Return code: 0 03:20:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:20: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')]} 03:20:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:20: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')]} 03:20:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:20: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1be31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e8aef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e880b0>, '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 0x1e88fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89440>, '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': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:20: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', 'jsonschema'] in /builds/slave/test/build 03:20: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 jsonschema 03:20:12 INFO - Using env: {'DISPLAY': ':0', 03:20:12 INFO - 'HOME': '/home/cltbld', 03:20:12 INFO - 'LANG': 'en_US.UTF-8', 03:20:12 INFO - 'LANGUAGE': 'en_US:en', 03:20:12 INFO - 'LOGNAME': 'cltbld', 03:20:12 INFO - 'MAIL': '/var/mail/cltbld', 03:20:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:12 INFO - 'MOZ_NO_REMOTE': '1', 03:20:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:12 INFO - 'NO_EM_RESTART': '1', 03:20:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:12 INFO - 'PWD': '/builds/slave/test', 03:20:12 INFO - 'SHELL': '/bin/bash', 03:20:12 INFO - 'SHLVL': '1', 03:20:12 INFO - 'TERM': 'linux', 03:20:12 INFO - 'TMOUT': '86400', 03:20:12 INFO - 'USER': 'cltbld', 03:20:12 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 03:20:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:12 INFO - '_': '/tools/buildbot/bin/python'} 03:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:20:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:20:12 INFO - Cleaning up... 03:20:12 INFO - Return code: 0 03:20:12 INFO - Running post-action listener: _resource_record_post_action 03:20:12 INFO - Running post-action listener: _start_resource_monitoring 03:20:12 INFO - Starting resource monitoring. 03:20:12 INFO - [mozharness: 2017-08-16 10:20:12.829783Z] Finished create-virtualenv step (success) 03:20:12 INFO - [mozharness: 2017-08-16 10:20:12.830258Z] Running install step. 03:20:12 INFO - Running pre-action listener: _resource_record_pre_action 03:20:12 INFO - Running main action method: install 03:20:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:20:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:20:13 INFO - Reading from file tmpfile_stdout 03:20:13 INFO - Detecting whether we're running mozinstall >=1.0... 03:20:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:20:13 INFO - Reading from file tmpfile_stdout 03:20:13 INFO - Output received: 03:20:13 INFO - Usage: mozinstall [options] installer 03:20:13 INFO - Options: 03:20:13 INFO - -h, --help show this help message and exit 03:20:13 INFO - -d DEST, --destination=DEST 03:20:13 INFO - Directory to install application into. [default: 03:20:13 INFO - "/builds/slave/test"] 03:20:13 INFO - --app=APP Application being installed. [default: firefox] 03:20:13 INFO - mkdir: /builds/slave/test/build/application 03:20:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:20:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:20:31 INFO - Reading from file tmpfile_stdout 03:20:31 INFO - Output received: 03:20:31 INFO - /builds/slave/test/build/application/firefox/firefox 03:20:31 INFO - Running post-action listener: _resource_record_post_action 03:20:31 INFO - [mozharness: 2017-08-16 10:20:31.145534Z] Finished install step (success) 03:20:31 INFO - [mozharness: 2017-08-16 10:20:31.145880Z] Running setup-mitmproxy step. 03:20:31 INFO - Running pre-action listener: _resource_record_pre_action 03:20:31 INFO - Running main action method: setup_mitmproxy 03:20:31 INFO - Skipping: mitmproxy is not required 03:20:31 INFO - Running post-action listener: _resource_record_post_action 03:20:31 INFO - [mozharness: 2017-08-16 10:20:31.147506Z] Finished setup-mitmproxy step (success) 03:20:31 INFO - [mozharness: 2017-08-16 10:20:31.147817Z] Running run-tests step. 03:20:31 INFO - Running pre-action listener: _resource_record_pre_action 03:20:31 INFO - Running pre-action listener: _set_gcov_prefix 03:20:31 INFO - Running main action method: run_tests 03:20:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:20:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:20:31 INFO - Python 2.7.3 03:20:31 INFO - Return code: 0 03:20:31 INFO - grabbing minidump binary from tooltool 03:20:31 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:20:31 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 0x1e880b0>, '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 0x1e88fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e89440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:20:31 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:20:31 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:20:31 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:20:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:20:31 INFO - Return code: 0 03:20:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:20:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:20:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:20:31 INFO - ENV: RUST_BACKTRACE is now full 03:20:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:20:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:20:31 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/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:20:31 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/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-075 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:20:31 INFO - Using env: {'DISPLAY': ':0', 03:20:31 INFO - 'HOME': '/home/cltbld', 03:20:31 INFO - 'LANG': 'en_US.UTF-8', 03:20:31 INFO - 'LANGUAGE': 'en_US:en', 03:20:31 INFO - 'LOGNAME': 'cltbld', 03:20:31 INFO - 'MAIL': '/var/mail/cltbld', 03:20:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:20:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:20:31 INFO - 'MOZ_NO_REMOTE': '1', 03:20:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:20:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:20:31 INFO - 'NO_EM_RESTART': '1', 03:20:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:20:31 INFO - 'PWD': '/builds/slave/test', 03:20:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:20:31 INFO - 'RUST_BACKTRACE': 'full', 03:20:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:20:31 INFO - 'SHELL': '/bin/bash', 03:20:31 INFO - 'SHLVL': '1', 03:20:31 INFO - 'STYLO_FORCE_ENABLED': '1', 03:20:31 INFO - 'TERM': 'linux', 03:20:31 INFO - 'TMOUT': '86400', 03:20:31 INFO - 'USER': 'cltbld', 03:20:31 INFO - 'XDG_SESSION_COOKIE': 'fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977', 03:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:20:31 INFO - '_': '/tools/buildbot/bin/python'} 03:20:31 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/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:20:31 INFO - mozversion application_buildid: 20170816092056 03:20:31 INFO - mozversion application_changeset: 0aa944d3ac94757842143a13fe66f6534817383f 03:20:31 INFO - mozversion application_display_name: Nightly 03:20:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:20:31 INFO - mozversion application_name: Firefox 03:20:31 INFO - mozversion application_remotingname: firefox 03:20:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:20:31 INFO - mozversion application_vendor: Mozilla 03:20:31 INFO - mozversion application_version: 57.0a1 03:20:31 INFO - mozversion platform_buildid: 20170816092056 03:20:31 INFO - mozversion platform_changeset: 0aa944d3ac94757842143a13fe66f6534817383f 03:20:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:20:31 INFO - mozversion platform_version: 57.0a1 03:20:31 INFO - using testdate: 1502878831 03:20:31 INFO - actual date: 1502878831 03:20:31 INFO - starting webserver on 'localhost:51409' 03:20:31 INFO - SUITE-START | Running 2 tests 03:20:31 INFO - TEST-START | dromaeo_css 03:20:31 INFO - Initialising browser for dromaeo_css test... 03:20:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51409/getInfo.html -profile /tmp/tmpkUjq3f/profile 03:20:31 INFO - TEST-INFO | started process 351 (/builds/slave/test/build/application/firefox/firefox http://localhost:51409/getInfo.html) 03:20:38 INFO - TEST-INFO | 351: exit 0 03:20:38 INFO - Browser initialized. 03:20:38 INFO - Running cycle 1/1 for dromaeo_css test... 03:20:38 INFO - TEST-INFO | started process 589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkUjq3f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:39 INFO - PID 589 | 03:20:39 INFO - PID 589 | (/builds/slave/test/build/application/firefox/firefox:644): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:20:39 INFO - PID 589 | 03:20:49 INFO - PID 589 | RSS: Main: 167825408 03:20:49 INFO - PID 589 | 03:23:48 INFO - PID 589 | Cycle 1(1): loaded http://localhost:51409/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51409/tests/dromaeo/cssquery-ext.html) 03:23:50 INFO - PID 589 | RSS: Main: 175419392 03:23:50 INFO - PID 589 | 03:26:52 INFO - PID 589 | Cycle 1(1): loaded http://localhost:51409/tests/dromaeo/cssquery-ext.html (next: http://localhost:51409/tests/dromaeo/cssquery-jquery.html) 03:26:53 INFO - PID 589 | RSS: Main: 172511232 03:26:53 INFO - PID 589 | 03:29:54 INFO - PID 589 | Cycle 1(1): loaded http://localhost:51409/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51409/tests/dromaeo/cssquery-mootools.html) 03:29:55 INFO - PID 589 | RSS: Main: 174387200 03:29:55 INFO - PID 589 | 03:32:57 INFO - PID 589 | Cycle 1(1): loaded http://localhost:51409/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51409/tests/dromaeo/cssquery-prototype.html) 03:32:57 INFO - PID 589 | RSS: Main: 171053056 03:32:57 INFO - PID 589 | 03:36:01 INFO - PID 589 | Cycle 1(1): loaded http://localhost:51409/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51409/tests/dromaeo/cssquery-yui.html) 03:36:01 INFO - PID 589 | RSS: Main: 176304128 03:36:01 INFO - PID 589 | 03:39:03 INFO - PID 589 | Cycle 1(1): loaded http://localhost:51409/tests/dromaeo/cssquery-yui.html (next: http://localhost:51409/tests/dromaeo/cssquery-dojo.html) 03:39:03 INFO - PID 589 | RSS: Main: 176889856 03:39:03 INFO - PID 589 | 03:39:03 INFO - PID 589 | __start_tp_report 03:39:03 INFO - PID 589 | _x_x_mozilla_page_load 03:39:03 INFO - PID 589 | _x_x_mozilla_page_load_details 03:39:03 INFO - PID 589 | |i|pagename|runs| 03:39:03 INFO - PID 589 | |0;dojo.html;3156.7001134892193;3166.2559298564834;3178.4914413693805;3205.743540516759;3210.0851257391632;6084.2090528231265;6173.32093469718;6177.598456100351;6199.597026193294;6265.843353916154;6077.544184186193;6187.226596675416;6191.659458729768;6197.101420294066;6209.751609935597;5613.270274864262;5637.210790489335;5669.603127781057;5675.2054712340305;5756.251687280647;5705.457981491772;5707.600467967223;5725.2843394575675;5740.913886291709;5762.97118514409;5474.72626368684;5635.8591035224035;5637.830865074055;5764.25064741583;5775.075987841946;5629;5640.971795141039;5702.087665973466;5712.171735098387;5715.742791574389;5593;5626.690532020737;5656.943430565683;5680.488756011938;5692.943070569324;5975.551833612496;6068.241469816273;6068.6358818471035;6105.175801266817;6123.632582045091;6525.3800888915475;6527.902081468782;6537.150170477855;6538.640374779386;6538.6730663467115;6585.440237579812;6603.306652801435;6609.20689517261;6624.735010599618;6630.502712296597;6121.204243448367;6194.039923811816;6217.067439884008;6223.222097237845;6242.968785156045;6817.761378351833;6817.795466136024;6820.454363650896;6917.9654101730175;6960.3039696031;6429.260635027032;6513.804585862432;6524.478041756743;6552.344765523505;6650.467962562983;6574;6623.834404139839;6632.8673426531195;6634.933650663432;6649.202095748541;6443.903341449882;6576.276609572943;6599.274079851212;6611.73553057882;6618.503612229006;6649.567778094505;6662.83342916431;6682.63245521501;6693.263740988487;6746;5273.551748101454;5361.08861493547;5408.8377348679605;5490.203920431595;5499.422560631157;4594.897224666056;4627.282771170474;4627.444706635225;4669.859904202879;4676.321933319718;5740.397258287903;5766.855828604234;5766.971165144148;5779.595428320062;5790.160426738099;6379.872402551923;6556.573822701509;6649.335066493409;6658.267590565034;6667.399934005963;5615.2700148980375;5669.518090962314;5724.742386592613;5731.197632331477;5735.11105778605;5773.740181691834;5826.417358264224;5859.648421094663;5865.677387743715;5890.293164820163;6449.451796597248;6490.026496025634;6502.992036234391;6529.54293199481;6533.18335208099;6540.051692504655;6624.271330153776;6632.204135503771;6700.93299067003;6750.1562304711915;6298.433141017331;6378.87242255143;6384.521160912857;6405.871882562229;6502.447291980235;6559.147310849559;6560.803175904731;6589.044588534732;6590.373914478117;6604.438622717123;6644.46844252449;6686.5653732507235;6715.328467153246;6716.664166791543;6725.125733654593;6478.5465017450215;6483.7730679425995;6494.1232933553365;6495.935040649533;6502.284748677547;6436.324185960407;6448.806535803933;6449.903251451138;6493.707783149675;6500.382463665944;5636.408177141341;6375.7449702013255;6430.164078669743;6430.485561155003;6475.3200913903365;6459.709313081016;6469.4824414045825;6510.21877374718;6554.737810487718;6556.63938483388;6194.628322300677;6270.059491076375;6274.529410294155;6311.431971122437;6341.699951509837 03:39:03 INFO - PID 589 | |1;ext.html;800.6797281087564;853.8292341531694;868.535333596526;874.908134645862;1166.206979254107;32174.517382239257;43077.78461107694;44111;44158.55841441585;44275.33586996198;44528.777356113256;44629.7768511157;44802;44894.10211795762;44920.55079449205;7623.656935437891;7816.531008139501;7839.843203135933;7840.372770178401;7847.64685589147;7665.808354791119;7715.845683086335;7738.535687858718;7759.883601745978;7764.456488045839;7244.203137654854;7820.921790782077;7824.256695613907;7845.411594130434;7850.842983140334;7735.961320193419;7763.611819409007;7771.339436147934;7789.298963093349;7794.688212471494;7633.274838890296;7692.4615276930635;7709.922900770976;7719.729809456699;7722.420818438583;39801.60198398008;40213;40271.79864100661;40308.798456007535;40309.59690403088;3539.239063601338;3561.269939662389;3582.0865679251883;3590.5691317042124;3591.6587924147166;32084.839575802205;32148.517772233434;32160.517592236134;32192.35615287681;32300.353992920245;4971.328870602459;4973.552380285755;5052.242163675442;5062.873428164288;5077.517635824591;191855;192484;192692;192745;193120;50799.492005079475;50878.49121508738;50916.49083509117;50921.490785092414;50991.235131473055;52677.209841852404;52709.47290527046;52783;52825.471745282826;52839;14617.634559135893;14867.330970106372;14919.850801492063;15011.699766004836;15033.098014119189;12030.15788894769;12031.15781895259;12065.819012714815;12103.092268079929;12107.636770896886;13351;13640.317984100755;14705.92647036758;14789.11265324084;15045.699086018438;5525.834224973257;5925.229720136354;6063.907407222348;6102.481289090389;6185.628862268279;987.437160818341;987.437160818341;999.81003609314;1014.5688082564881;1016.872890888639;23097.307080787603;23339.533209335717;23454.179103731287;23471.295861124192;23666.7633323668;1080.1583300472832;1084.1001968366238;1092.8852470490642;1105.6682995101437;1113.1540029577418;12466.5013399463;16351.918240408722;16536.255868485947;16611.83388166103;16737.581560460843;246101;246830;247112;247357;247645;60104.39895600988;60789.69605151946;60790.69604652037;61199.38800612026;61248.387516125156;1429.2686327825495;1452.7094581083825;1463.2025546077414;1469.426923499836;1473.661057956676;27073;28056.859715701292;28366;29012;29122.27194320159;40231.79884100678;40380.798096009334;40389.1922161561;40420.79789601033;40516.594834051284;156080;156108;157309;157317;158014;35900.10249743777;36383.636163638024;36508.45237321389;36519.08702282464;36523.08692282714;40711;41538.37692434555;41978.580214198686;45616.54383456256;47486.76256618833;33605;33695.494567582;33808;33891.66108338984;34410.48384274188;32815.8359208212;33369.33261334808;33516;33544.66455335415;33653;36686.449703255006;36791.44812827756;36834.63165368312;36943.261134776614;39744;35549.46675799813;35647.28705425929;35873.28253434969;35882.8205858969;36019.45970810492;25281.87359063193;25607;25741;25817;26019.609705854808 03:39:03 INFO - PID 589 | |2;jquery.html;574.1359254322244;582.8222392170386;587.9559033072518;592.786596825143;597.131174141624;22446.55106897861;22542;23280.767192328094;23305.184318548854;23341.18305859291;25648.487030259384;25973.350666233353;26098.608520872203;26131.085412010583;26217.34456638585;6256.217972753395;6398.488120950313;6399.968000159993;6400.807975760735;6401.327860574619;5903.88192236155;6368.586041907284;6398.648074355909;6453.354664533533;6523.771667991621;6334.841628959267;6341.936580634181;6342.587731797442;6349.206349206349;6352.205974253218;6356.237251529799;6359.300476947532;6360.141380913564;6366.649834259114;6369.07648390983;5923.763049478016;5926.436988486087;5934.050551911673;5937;5942.554308426842;29517.262068448246;30240.546391804142;30667.07998760041;30840.845795771103;30883.382332353453;1962.7840937496865;2008.8493362997833;2009.8492613053934;2010.3868320162344;2010.7587089549347;19479.90260048705;20006.499837504034;20094.095765690578;20100.597988040157;20129.09419076145;2363.881805909715;2376.6435034744754;2441.07239249086;2447.2535876557645;2462.0398044762555;139357;142271.28864355612;142482.2875885614;142714;142851;14341.067830590979;15103.697926041417;15267.465638702592;15272.31274592646;15856.92071539658;24205.51588968246;24207.878960605085;24214.51570968606;24249.272521824372;24263.878680606485;9983.800323993479;10006.249531285182;10052.346597471142;10067.496625168713;10154.187664986783;8928.821423571491;9008.909910900808;9022.729318120468;9121.498317592595;9180.770480738034;7670;9107.772305692279;9339.252859771203;9360.251179905592;9414.388064775767;2540.7459254074442;2565.396122935222;2653.840769553833;2658.9601155982677;2681.115231973444;945.8155659646441;953.9013970328583;964.3346091197192;968.8788901387327;973.9366941148803;18837.340693075676;19117.713234301496;19447.902760486108;19604.509887252934;19778.50553736168;998.031909048222;1013.3919648211014;1017.0897047142765;1029.4389557691077;1029.8867124616286;10700.678979630624;10867.728306792234;10994.945025274823;11007.339559626447;11020.283681560833;483363;523773;532789;534069;542126;122340.38829805794;123577.38211309066;124470;124601;125005.37497312455;1224.0085530720146;1230.8522977242787;1297.6626077219992;1298.8766067223787;1302.3423171298434;20539;20601.690974635094;20695.79304206999;20997.475063123544;21253.89373053125;58142;58911.41088589059;59198;60013.399866002525;60677;66269;66482.33517664761;68460.31539684739;70120.29879701341;70675.64662176656;14762.114273143647;15021.849781502482;15099.849001509845;15166.620834478785;15172.848271517585;23420.414489637897;23625.500191853946;23738.169164079176;23986.760132398453;24280.51438971246;18697.71953420727;18733.53166170802;18814.811851881852;19024.904875475535;19041.238350465825;16502.75245871337;16712.41506547265;17403.564910876823;17456.91271543634;17528.211230494915;19201;19206.807931920503;19407.12667929975;19593;19694.310699126036;14841.628959276104;14930.701385972437;15005;15005.399784008518;15026.023308484913;18880.716789248447;18909;18986;19008.23967041303;19011.524711882314 03:39:03 INFO - PID 589 | |3;mootools.html;1370.6778906956863;1401.8528054554272;1424.2522675595317;1432.5487471446488;1435.468876515689;14219.71560568788;14361.784573231409;14826.925865370671;14863.256837158126;14863.33115009823;14506.782398264007;14799.33402996865;14805.777913331282;14807.925960370183;14812.925935370307;2746.8901243950268;2774.7225277472194;2787.484315401647;2802.929926751827;2805.7895657825643;2614.16346769034;2720.6735191777016;2815.155453363993;2815.6058151858756;2815.9718402815915;2741.0954385052883;2768.878604165316;2799.8180118292244;2801.7618502427217;2805.270629636299;2723.196656986194;2734.3300891281665;2750.8487033213164;2780.7636350910198;2785.7353551412684;2646.2325925481587;2663.653725015755;2680.8525531095784;2694.286014206237;2700.648915640954;14520.854791452055;14581.125132491978;14612.634684132876;14638.780418293734;14663.046901951446;7403.481756277063;7443.144038435595;7759.495632783851;7767.922320776776;7786.377089832799;5278.1291086970605;5381.354237491487;5525.392206857243;5553.333599967989;5553.944460555384;1747.187557785623;1755.5347832824311;1762.2334284586245;1827.2234300422267;1831.7985021647742;24571.508569828682;24820.751792482206;24992.375190620198;25026.49947001068;25054.248372548853;6968.581885086911;7102.181841448626;7182.497225194291;7244.348008679139;7281.1990681025045;16243.51269461918;16402.343906243856;16530.917345413196;16552.172391380383;16558.66882662364;7488.026556547614;7579.583122928292;7632.618369081635;7636.770896873103;7642.8089297768;6193.783217587363;6931.6880740366805;7082.433405327562;7093.467989900675;7118.857622847514;4801.903961920742;5113.8721531961255;5287.259783630295;5297.496737809902;5298.947010529845;1454.70178613384;1502.241368109098;1506.0361368723807;1518.7569988801959;1520.9695806084037;937.6249500199974;953.7997020625746;962.8603852441497;964.1997142371814;964.3249725192394;8501.362397820189;8579.613917373734;8581.871271930926;8629.43908645936;8639.222469977607;1009.5305682857506;1012.1649639047815;1024.1039090795555;1031.8297480915564;1042.4266653340633;4712.034033023222;4942.9011419771405;5505.504504594525;5574.191742197439;5609.663420194802;19079.713804292947;19721.30975415882;19784.109715062856;19892.90053549723;20036.69944950827;20806.43951703598;21169.470763231042;21178.78821211799;21210.25764098249;21211.78788212098;10684.89315106839;11104.722381940355;11163.106951443864;11382;11387.487563059516;8314.6674133034;8771.824563508822;8808.779780505538;8914.153155450222;8983.685571004984;17550.210240538952;17781.555461113574;17946.282148713904;18204.089795509906;18491.72262416038;17937.730934036263;18133.818661813213;18211.635767284846;18305.26778928828;18310.176042077874;11788;12011.819822702491;12104.213226140273;12111.75776484483;12119.636410907688;12159.939200304296;12509.499620015098;13252.469901203844;13495.865041349462;13629.727405451637;10594.841077383999;10703.625373111903;10737.624183153865;10911.127109831035;11088.223824332543;9960;10026.448545330077;10065.144462720751;10415.062644362044;10428.895711042793;9853.753656158653;9929.156021738234;9969.30214884951;9969.30214884951;9975.45135017552;7165.7850264492145;7347.375473084848;7380.889286660597;7395.667194976131;7406.037215161994;7410.407167426701;7436.442266830118;7490.438217133627;7516;7614.543127412373 03:39:03 INFO - PID 589 | |4;prototype.html;504.341833906752;514.4495389932771;521.4654978646887;534.9644602288294;535.357570914902;6229.314775374711;6259.968700156504;6309.5267854910835;6324.766670499249;6347.857385670583;6188.690565471731;6218.284897236819;6244.281907580618;6253.343398943114;6266.498680105592;5069.188929771238;5113.923291150636;5117.362444017916;5117.641765076455;5137.845864624067;4736.431628204603;4938.678985865908;5055.646104772667;5090;5099.4900509949075;4907.386576677915;4909.435414927293;4919.1637421638225;4919.704817710931;4925.236588328797;4920.630952678528;4940.530649588283;4940.975295123501;4950.727709975949;4974.602031837444;4343.457067866517;4416.447944006999;4437.46750389952;4451.464244835559;4472.351509031172;6064.935064935065;6073.817785466443;6099.939000610026;6103.328633850273;6115.755369785204;5699.316082070137;5701.57238207132;5701.885962280772;5707.885842283173;5746.79886203985;6672.833179170511;6711.731530738764;6720.689465554219;6723.159605049369;6729.596224226562;4856.562909338177;4863.829765958175;4893.730844803535;4896.951030489685;4919.385076865392;6576.276609572991;6680.0313954476815;6765.594064356154;6920.653967301615;6956.373926346653;4948.134076536592;4953.777080031407;4965.90068198634;4970.701757894538;5019.924701129486;4919.262110683355;4996.675216110941;5021.4225364083595;5058.595312375001;5090.567301779316;5639;5639.971800140973;5690.6301090429815;5712.257406537124;5713.885722285531;6691.431228345547;6698.866022679616;6703.497237707192;6725;6756.628385438848;1729.5589624645636;1749.99375359169;1751.991240043817;1765.4993255732782;1779.5284249673846;1174.277819141239;1210.727586293077;1215.8784121587948;1218.3238302741886;1244.5519612939336;5765.913511297334;5784.2769653793275;5813.09896965971;5833.562482813721;5841.211436456024;6684.732610695518;6717.932820671828;6745.561538499982;6754.18949726036;6846.418054465426;5737.020727848885;5739.741711622987;5788.305403351541;5790.594658373873;5802.274715660543;3596.1300123935407;3606;3608.9458658119624;3618.6381361863605;3669.798161101165;6596.769113081019;6600.339966003361;6658.602902954933;6665.766698165541;6679.499037572202;6911.274316196727;6936.79189624312;6959.965200173967;6971.965140174369;6985;6429.453496452854;6526.771562995273;6589.8467768141345;6602.7028783704845;6635.369639884203;6731.899021514583;6760.425363843931;6774.898376524257;6781.627010514272;6795.354441328066;6128.356522565245;6676.49926255523;6680.331966803281;6735.932640673531;6796.558223715443;6529.706163222571;6550.377714117151;6558.245801732862;6570.868582628416;6651.933480665131;4808.663393562557;4909.26361045846;4945.901081978413;4982.676126051795;4992.525710057539;6558.737650493927;6587.868242635216;6679.328268692562;6783.898241526283;6839.760608378683;6375.840603984938;6397;6536.3136870627895;6587.341265873374;6622.4702023838945;6472.190976127984;6537.803865884031;6567.620799632131;6604.14146160996;6611.504137189826;6430.64631445275;6504.447121994684;6519.152510173647;6519.217693876765;6525.869482610226;6585.835354116185;6617.305182955721;6628.6022838627905;6633.535652504278;6710.932890671226;6306.590071645328;6325.240971083499;6398.5201109916015;6418.827761954767;6420.711068001858 03:39:03 INFO - PID 589 | |5;yui.html;883.6112110671301;900.9864852027221;901.463629140661;914.4513292024782;924.5192499900054;20205.39383818486;21722.239721609745;21725.565488690256;21801.563968720635;21817.345479635598;21455;22111;22249.777502224973;22280.88859555704;22314.88842555785;976.0386019770538;992.1913640383101;994.2940512236321;994.8607194992707;1024.5491983527224;1061.368485750977;1063.2982231727024;1065.4459680965892;1068.7221322456178;1069.1713921710698;1122.7922834275644;1124.7413094988158;1125.2517076144354;1125.2685754259714;1127.109583429094;1119.1774046076127;1121.2319561100592;1121.5625905896707;1121.5962253588702;1123.6292023632182;816.7794695432259;817.65249768848;817.7710241132493;818.2431251092775;818.251300060444;20021.399358019284;20293.492662683402;20347.796522034885;20447.897760511252;20657.070431830605;21985.780142198535;22065.558688826135;22145.114195432325;22312.330630081124;22386.552268954692;17052.48842534726;17175.141242937803;17329.653406931917;17653.646927061385;17655.73516397255;3631.5642122945414;3633.182533929845;3653.890383288479;3655.597884232732;3656.8171591420587;118370.40814795958;121776;125656.37171814175;125942.37028814889;126812;17512.29950801979;18145.63708725818;18205.089745512672;18234.908825456052;18241.543961400806;24101.598213438;30728.69271307258;30910.690893091232;31441;31881;8829.867551986725;8884.244839188612;9116.544172791333;9120.680776172801;9125.04187060349;4232.746035237896;4352.238358287287;4355.60799528044;4360.869173924787;4363.214621368184;5352.116900711339;5422.593305502103;5457.072297709319;5458.754356053987;5484.149956756709;1103.564092183583;1113.3820729495208;1116.151724689242;1116.2799994003985;1116.609186784635;586.8914250863604;594.5659668442062;600.1088383750127;601.6119602856221;614.0819474884986;12410.81383779244;12624.853774858297;12631.557895473798;12687.376060819544;13512.324383780771;696.7108649910332;705.1009962298111;706.9257727938492;711.1146622454974;720.8522252938135;5679.403662615448;5745.166950792195;5884.58807883444;5935.1987481690285;6082.992612437885;113004;113124;113561;114547.42726286316;116188.41905790586;94319;94783;97072;97729.51135244279;102232;83633.58183209045;85266.1473385283;85324.14675853286;86642;86660;11100.500477478694;11217.55129794799;11309.491072901574;11417;11595.072394208612;39030.80484597559;39195.21609567736;39698.206035879695;40687.59312406838;41352;51401.7429912848;51454;52087.479125208265;52819.47180528299;53965.460345397616;16133.596660083122;19328.61342773165;19937.10283037238;20342;20405.387838364873;21889.233876814236;22033.889830550746;22604.66093008639;22615.208467703553;22683;19771.308004219783;19916.90041549783;20195;20274;20647.8967605161;19825;20223.19107235753;20295.391138265877;20379;20413.59172816565;19203;19270.90364548168;19906.800931991074;20178.79821201828;20525.589488209855;13773;13864.722705546033;14316.785248221076;14541.200233986809;14827.629309267355;14873.47942821996;15079.698406032037;15262.160581168142;15385.923070384577;15431 03:39:03 INFO - PID 589 | __end_tp_report 03:39:03 INFO - PID 589 | __start_cc_report 03:39:03 INFO - PID 589 | _x_x_mozilla_cycle_collect,366 03:39:03 INFO - PID 589 | __end_cc_report 03:39:03 INFO - PID 589 | __startTimestamp1502879943947__endTimestamp 03:39:03 INFO - PID 589 | 03:39:03 INFO - PID 589 | ------- Summary: start ------- 03:39:03 INFO - PID 589 | Number of tests: 6 03:39:03 INFO - PID 589 | 03:39:03 INFO - PID 589 | [#0] dojo.html Cycles:165 Average:6102.68 Median:6375.74 stddev:709.57 (11.1%) stddev-sans-first:673.06 03:39:03 INFO - PID 589 | Values: 3156.7 3166.3 3178.5 3205.7 3210.1 6084.2 6173.3 6177.6 6199.6 6265.8 6077.5 6187.2 6191.7 6197.1 6209.8 5613.3 5637.2 5669.6 5675.2 5756.3 5705.5 5707.6 5725.3 5740.9 5763.0 5474.7 5635.9 5637.8 5764.3 5775.1 5629.0 5641.0 5702.1 5712.2 5715.7 5593.0 5626.7 5656.9 5680.5 5692.9 5975.6 6068.2 6068.6 6105.2 6123.6 6525.4 6527.9 6537.2 6538.6 6538.7 6585.4 6603.3 6609.2 6624.7 6630.5 6121.2 6194.0 6217.1 6223.2 6243.0 6817.8 6817.8 6820.5 6918.0 6960.3 6429.3 6513.8 6524.5 6552.3 6650.5 6574.0 6623.8 6632.9 6634.9 6649.2 6443.9 6576.3 6599.3 6611.7 6618.5 6649.6 6662.8 6682.6 6693.3 6746.0 5273.6 5361.1 5408.8 5490.2 5499.4 4594.9 4627.3 4627.4 4669.9 4676.3 5740.4 5766.9 5767.0 5779.6 5790.2 6379.9 6556.6 6649.3 6658.3 6667.4 5615.3 5669.5 5724.7 5731.2 5735.1 5773.7 5826.4 5859.6 5865.7 5890.3 6449.5 6490.0 6503.0 6529.5 6533.2 6540.1 6624.3 6632.2 6700.9 6750.2 6298.4 6378.9 6384.5 6405.9 6502.4 6559.1 6560.8 6589.0 6590.4 6604.4 6644.5 6686.6 6715.3 6716.7 6725.1 6478.5 6483.8 6494.1 6495.9 6502.3 6436.3 6448.8 6449.9 6493.7 6500.4 5636.4 6375.7 6430.2 6430.5 6475.3 6459.7 6469.5 6510.2 6554.7 6556.6 6194.6 6270.1 6274.5 6311.4 6341.7 03:39:03 INFO - PID 589 | 03:39:03 INFO - PID 589 | [#1] ext.html Cycles:180 Average:38126.74 Median:36446.04 stddev:52558.02 (144.2%) stddev-sans-first:52630.73 03:39:03 INFO - PID 589 | Values: 800.7 853.8 868.5 874.9 1166.2 32174.5 43077.8 44111.0 44158.6 44275.3 44528.8 44629.8 44802.0 44894.1 44920.6 7623.7 7816.5 7839.8 7840.4 7847.6 7665.8 7715.8 7738.5 7759.9 7764.5 7244.2 7820.9 7824.3 7845.4 7850.8 7736.0 7763.6 7771.3 7789.3 7794.7 7633.3 7692.5 7709.9 7719.7 7722.4 39801.6 40213.0 40271.8 40308.8 40309.6 3539.2 3561.3 3582.1 3590.6 3591.7 32084.8 32148.5 32160.5 32192.4 32300.4 4971.3 4973.6 5052.2 5062.9 5077.5 191855.0 192484.0 192692.0 192745.0 193120.0 50799.5 50878.5 50916.5 50921.5 50991.2 52677.2 52709.5 52783.0 52825.5 52839.0 14617.6 14867.3 14919.9 15011.7 15033.1 12030.2 12031.2 12065.8 12103.1 12107.6 13351.0 13640.3 14705.9 14789.1 15045.7 5525.8 5925.2 6063.9 6102.5 6185.6 987.4 987.4 999.8 1014.6 1016.9 23097.3 23339.5 23454.2 23471.3 23666.8 1080.2 1084.1 1092.9 1105.7 1113.2 12466.5 16351.9 16536.3 16611.8 16737.6 246101.0 246830.0 247112.0 247357.0 247645.0 60104.4 60789.7 60790.7 61199.4 61248.4 1429.3 1452.7 1463.2 1469.4 1473.7 27073.0 28056.9 28366.0 29012.0 29122.3 40231.8 40380.8 40389.2 40420.8 40516.6 156080.0 156108.0 157309.0 157317.0 158014.0 35900.1 36383.6 36508.5 36519.1 36523.1 40711.0 41538.4 41978.6 45616.5 47486.8 33605.0 33695.5 33808.0 33891.7 34410.5 32815.8 33369.3 33516.0 33544.7 33653.0 36686.4 36791.4 36834.6 36943.3 39744.0 35549.5 35647.3 35873.3 35882.8 36019.5 25281.9 25607.0 25741.0 25817.0 26019.6 03:39:03 INFO - PID 589 | 03:39:03 INFO - PID 589 | [#2] jquery.html Cycles:180 Average:36258.47 Median:13051.03 stddev:88083.07 (674.9%) stddev-sans-first:88289.42 03:39:03 INFO - PID 589 | Values: 574.1 582.8 588.0 592.8 597.1 22446.6 22542.0 23280.8 23305.2 23341.2 25648.5 25973.4 26098.6 26131.1 26217.3 6256.2 6398.5 6400.0 6400.8 6401.3 5903.9 6368.6 6398.6 6453.4 6523.8 6334.8 6341.9 6342.6 6349.2 6352.2 6356.2 6359.3 6360.1 6366.6 6369.1 5923.8 5926.4 5934.1 5937.0 5942.6 29517.3 30240.5 30667.1 30840.8 30883.4 1962.8 2008.8 2009.8 2010.4 2010.8 19479.9 20006.5 20094.1 20100.6 20129.1 2363.9 2376.6 2441.1 2447.3 2462.0 139357.0 142271.3 142482.3 142714.0 142851.0 14341.1 15103.7 15267.5 15272.3 15856.9 24205.5 24207.9 24214.5 24249.3 24263.9 9983.8 10006.2 10052.3 10067.5 10154.2 8928.8 9008.9 9022.7 9121.5 9180.8 7670.0 9107.8 9339.3 9360.3 9414.4 2540.7 2565.4 2653.8 2659.0 2681.1 945.8 953.9 964.3 968.9 973.9 18837.3 19117.7 19447.9 19604.5 19778.5 998.0 1013.4 1017.1 1029.4 1029.9 10700.7 10867.7 10994.9 11007.3 11020.3 483363.0 523773.0 532789.0 534069.0 542126.0 122340.4 123577.4 124470.0 124601.0 125005.4 1224.0 1230.9 1297.7 1298.9 1302.3 20539.0 20601.7 20695.8 20997.5 21253.9 58142.0 58911.4 59198.0 60013.4 60677.0 66269.0 66482.3 68460.3 70120.3 70675.6 14762.1 15021.8 15099.8 15166.6 15172.8 23420.4 23625.5 23738.2 23986.8 24280.5 18697.7 18733.5 18814.8 19024.9 19041.2 16502.8 16712.4 17403.6 17456.9 17528.2 19201.0 19206.8 19407.1 19593.0 19694.3 14841.6 14930.7 15005.0 15005.4 15026.0 18880.7 18909.0 18986.0 19008.2 19011.5 03:39:03 INFO - PID 589 | 03:39:03 INFO - PID 589 | [#3] mootools.html Cycles:180 Average:9088.72 Median:2654.94 stddev:6286.52 (236.8%) stddev-sans-first:6277.41 03:39:03 INFO - PID 589 | Values: 1370.7 1401.9 1424.3 1432.5 1435.5 14219.7 14361.8 14826.9 14863.3 14863.3 14506.8 14799.3 14805.8 14807.9 14812.9 2746.9 2774.7 2787.5 2802.9 2805.8 2614.2 2720.7 2815.2 2815.6 2816.0 2741.1 2768.9 2799.8 2801.8 2805.3 2723.2 2734.3 2750.8 2780.8 2785.7 2646.2 2663.7 2680.9 2694.3 2700.6 14520.9 14581.1 14612.6 14638.8 14663.0 7403.5 7443.1 7759.5 7767.9 7786.4 5278.1 5381.4 5525.4 5553.3 5553.9 1747.2 1755.5 1762.2 1827.2 1831.8 24571.5 24820.8 24992.4 25026.5 25054.2 6968.6 7102.2 7182.5 7244.3 7281.2 16243.5 16402.3 16530.9 16552.2 16558.7 7488.0 7579.6 7632.6 7636.8 7642.8 6193.8 6931.7 7082.4 7093.5 7118.9 4801.9 5113.9 5287.3 5297.5 5298.9 1454.7 1502.2 1506.0 1518.8 1521.0 937.6 953.8 962.9 964.2 964.3 8501.4 8579.6 8581.9 8629.4 8639.2 1009.5 1012.2 1024.1 1031.8 1042.4 4712.0 4942.9 5505.5 5574.2 5609.7 19079.7 19721.3 19784.1 19892.9 20036.7 20806.4 21169.5 21178.8 21210.3 21211.8 10684.9 11104.7 11163.1 11382.0 11387.5 8314.7 8771.8 8808.8 8914.2 8983.7 17550.2 17781.6 17946.3 18204.1 18491.7 17937.7 18133.8 18211.6 18305.3 18310.2 11788.0 12011.8 12104.2 12111.8 12119.6 12159.9 12509.5 13252.5 13495.9 13629.7 10594.8 10703.6 10737.6 10911.1 11088.2 9960.0 10026.4 10065.1 10415.1 10428.9 9853.8 9929.2 9969.3 9969.3 9975.5 7165.8 7347.4 7380.9 7395.7 7406.0 7410.4 7436.4 7490.4 7516.0 7614.5 03:39:03 INFO - PID 589 | 03:39:03 INFO - PID 589 | [#4] prototype.html Cycles:180 Average:5533.23 Median:6158.52 stddev:1561.48 (25.4%) stddev-sans-first:1519.55 03:39:03 INFO - PID 589 | Values: 504.3 514.4 521.5 535.0 535.4 6229.3 6260.0 6309.5 6324.8 6347.9 6188.7 6218.3 6244.3 6253.3 6266.5 5069.2 5113.9 5117.4 5117.6 5137.8 4736.4 4938.7 5055.6 5090.0 5099.5 4907.4 4909.4 4919.2 4919.7 4925.2 4920.6 4940.5 4941.0 4950.7 4974.6 4343.5 4416.4 4437.5 4451.5 4472.4 6064.9 6073.8 6099.9 6103.3 6115.8 5699.3 5701.6 5701.9 5707.9 5746.8 6672.8 6711.7 6720.7 6723.2 6729.6 4856.6 4863.8 4893.7 4897.0 4919.4 6576.3 6680.0 6765.6 6920.7 6956.4 4948.1 4953.8 4965.9 4970.7 5019.9 4919.3 4996.7 5021.4 5058.6 5090.6 5639.0 5640.0 5690.6 5712.3 5713.9 6691.4 6698.9 6703.5 6725.0 6756.6 1729.6 1750.0 1752.0 1765.5 1779.5 1174.3 1210.7 1215.9 1218.3 1244.6 5765.9 5784.3 5813.1 5833.6 5841.2 6684.7 6717.9 6745.6 6754.2 6846.4 5737.0 5739.7 5788.3 5790.6 5802.3 3596.1 3606.0 3608.9 3618.6 3669.8 6596.8 6600.3 6658.6 6665.8 6679.5 6911.3 6936.8 6960.0 6972.0 6985.0 6429.5 6526.8 6589.8 6602.7 6635.4 6731.9 6760.4 6774.9 6781.6 6795.4 6128.4 6676.5 6680.3 6735.9 6796.6 6529.7 6550.4 6558.2 6570.9 6651.9 4808.7 4909.3 4945.9 4982.7 4992.5 6558.7 6587.9 6679.3 6783.9 6839.8 6375.8 6397.0 6536.3 6587.3 6622.5 6472.2 6537.8 6567.6 6604.1 6611.5 6430.6 6504.4 6519.2 6519.2 6525.9 6585.8 6617.3 6628.6 6633.5 6710.9 6306.6 6325.2 6398.5 6418.8 6420.7 03:39:03 INFO - PID 589 | 03:39:03 INFO - PID 589 | [#5] yui.html Cycles:180 Average:23786.37 Median:21763.56 stddev:31468.37 (144.6%) stddev-sans-first:31509.66 03:39:03 INFO - PID 589 | Values: 883.6 901.0 901.5 914.5 924.5 20205.4 21722.2 21725.6 21801.6 21817.3 21455.0 22111.0 22249.8 22280.9 22314.9 976.0 992.2 994.3 994.9 1024.5 1061.4 1063.3 1065.4 1068.7 1069.2 1122.8 1124.7 1125.3 1125.3 1127.1 1119.2 1121.2 1121.6 1121.6 1123.6 816.8 817.7 817.8 818.2 818.3 20021.4 20293.5 20347.8 20447.9 20657.1 21985.8 22065.6 22145.1 22312.3 22386.6 17052.5 17175.1 17329.7 17653.6 17655.7 3631.6 3633.2 3653.9 3655.6 3656.8 118370.4 121776.0 125656.4 125942.4 126812.0 17512.3 18145.6 18205.1 18234.9 18241.5 24101.6 30728.7 30910.7 31441.0 31881.0 8829.9 8884.2 9116.5 9120.7 9125.0 4232.7 4352.2 4355.6 4360.9 4363.2 5352.1 5422.6 5457.1 5458.8 5484.1 1103.6 1113.4 1116.2 1116.3 1116.6 586.9 594.6 600.1 601.6 614.1 12410.8 12624.9 12631.6 12687.4 13512.3 696.7 705.1 706.9 711.1 720.9 5679.4 5745.2 5884.6 5935.2 6083.0 113004.0 113124.0 113561.0 114547.4 116188.4 94319.0 94783.0 97072.0 97729.5 102232.0 83633.6 85266.1 85324.1 86642.0 86660.0 11100.5 11217.6 11309.5 11417.0 11595.1 39030.8 39195.2 39698.2 40687.6 41352.0 51401.7 51454.0 52087.5 52819.5 53965.5 16133.6 19328.6 19937.1 20342.0 20405.4 21889.2 22033.9 22604.7 22615.2 22683.0 19771.3 19916.9 20195.0 20274.0 20647.9 19825.0 20223.2 20295.4 20379.0 20413.6 19203.0 19270.9 19906.8 20178.8 20525.6 13773.0 13864.7 14316.8 14541.2 14827.6 14873.5 15079.7 15262.2 15385.9 15431.0 03:39:03 INFO - PID 589 | -------- Summary: end -------- 03:39:03 INFO - PID 589 | 03:39:04 INFO - TEST-INFO | 589: exit 0 03:39:04 INFO - TEST-OK | dromaeo_css | took 1113306ms 03:39:04 INFO - TEST-START | kraken 03:39:04 INFO - Initialising browser for kraken test... 03:39:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51409/getInfo.html -profile /tmp/tmpRp8iWl/profile 03:39:04 INFO - TEST-INFO | started process 973 (/builds/slave/test/build/application/firefox/firefox http://localhost:51409/getInfo.html) 03:39:10 INFO - TEST-INFO | 973: exit 0 03:39:11 INFO - Browser initialized. 03:39:11 INFO - Running cycle 1/1 for kraken test... 03:39:11 INFO - TEST-INFO | started process 1290 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRp8iWl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:12 INFO - PID 1290 | 03:39:12 INFO - PID 1290 | (/builds/slave/test/build/application/firefox/firefox:1345): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:39:12 INFO - PID 1290 | 03:39:22 INFO - PID 1290 | RSS: Main: 167804928 03:39:22 INFO - PID 1290 | 03:39:25 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51409/tests/kraken/driver.html?testName=audio-beat-detection) 03:39:26 INFO - PID 1290 | RSS: Main: 174006272 03:39:26 INFO - PID 1290 | 03:39:28 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51409/tests/kraken/driver.html?testName=audio-dft) 03:39:29 INFO - PID 1290 | RSS: Main: 177610752 03:39:29 INFO - PID 1290 | 03:39:32 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51409/tests/kraken/driver.html?testName=audio-fft) 03:39:33 INFO - PID 1290 | RSS: Main: 171921408 03:39:33 INFO - PID 1290 | 03:39:35 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51409/tests/kraken/driver.html?testName=audio-oscillator) 03:39:35 INFO - PID 1290 | RSS: Main: 172568576 03:39:35 INFO - PID 1290 | 03:39:38 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51409/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:39:38 INFO - PID 1290 | RSS: Main: 173010944 03:39:38 INFO - PID 1290 | 03:39:41 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51409/tests/kraken/driver.html?testName=imaging-darkroom) 03:39:42 INFO - PID 1290 | RSS: Main: 173916160 03:39:42 INFO - PID 1290 | 03:39:46 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51409/tests/kraken/driver.html?testName=imaging-desaturate) 03:39:46 INFO - PID 1290 | RSS: Main: 173256704 03:39:46 INFO - PID 1290 | 03:39:49 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51409/tests/kraken/driver.html?testName=json-parse-financial) 03:39:50 INFO - PID 1290 | RSS: Main: 174137344 03:39:50 INFO - PID 1290 | 03:39:51 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51409/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:39:52 INFO - PID 1290 | RSS: Main: 174067712 03:39:52 INFO - PID 1290 | 03:39:54 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:39:55 INFO - PID 1290 | RSS: Main: 175235072 03:39:55 INFO - PID 1290 | 03:39:57 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:39:57 INFO - PID 1290 | RSS: Main: 174395392 03:39:57 INFO - PID 1290 | 03:40:00 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:40:01 INFO - PID 1290 | RSS: Main: 174252032 03:40:01 INFO - PID 1290 | 03:40:04 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:40:04 INFO - PID 1290 | RSS: Main: 174788608 03:40:04 INFO - PID 1290 | 03:40:06 INFO - PID 1290 | Cycle 1(1): loaded http://localhost:51409/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51409/tests/kraken/driver.html?testName=ai-astar) 03:40:07 INFO - PID 1290 | RSS: Main: 175915008 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | __start_tp_report 03:40:07 INFO - PID 1290 | _x_x_mozilla_page_load 03:40:07 INFO - PID 1290 | _x_x_mozilla_page_load_details 03:40:07 INFO - PID 1290 | |i|pagename|runs| 03:40:07 INFO - PID 1290 | |0;ai-astar;102;108;103;108;114;115;110;109;115;122 03:40:07 INFO - PID 1290 | |1;audio-beat-detection;144;121;147;178;116;166;148;121;172;118 03:40:07 INFO - PID 1290 | |2;audio-dft;163;163;162;163;164;163;169;163;165;166 03:40:07 INFO - PID 1290 | |3;audio-fft;78;78;74;168;78;78;78;81;160;86 03:40:07 INFO - PID 1290 | |4;audio-oscillator;78;79;136;78;79;80;125;79;78;130 03:40:07 INFO - PID 1290 | |5;imaging-gaussian-blur;118;117;114;117;117;117;117;114;118;118 03:40:07 INFO - PID 1290 | |6;imaging-darkroom;150;150;154;151;149;150;150;151;150;149 03:40:07 INFO - PID 1290 | |7;imaging-desaturate;94;94;93;94;101;99;94;94;94;104 03:40:07 INFO - PID 1290 | |8;json-parse-financial;60;56;59;56;59;59;55;59;55;56 03:40:07 INFO - PID 1290 | |9;json-stringify-tinderbox;53;54;54;55;55;56;58;59;60;58 03:40:07 INFO - PID 1290 | |10;stanford-crypto-aes;77;80;76;77;77;75;79;87;76;76 03:40:07 INFO - PID 1290 | |11;stanford-crypto-ccm;138;127;128;129;134;122;124;127;123;173 03:40:07 INFO - PID 1290 | |12;stanford-crypto-pbkdf2;192;177;172;182;175;179;174;174;173;173 03:40:07 INFO - PID 1290 | |13;stanford-crypto-sha256-iterative;75;72;69;73;69;71;71;68;72;68 03:40:07 INFO - PID 1290 | __end_tp_report 03:40:07 INFO - PID 1290 | __start_cc_report 03:40:07 INFO - PID 1290 | _x_x_mozilla_cycle_collect,953 03:40:07 INFO - PID 1290 | __end_cc_report 03:40:07 INFO - PID 1290 | __startTimestamp1502880007116__endTimestamp 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | ------- Summary: start ------- 03:40:07 INFO - PID 1290 | Number of tests: 14 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:6.04 (5.4%) stddev-sans-first:5.55 03:40:07 INFO - PID 1290 | Values: 102.0 108.0 103.0 108.0 114.0 115.0 110.0 109.0 115.0 122.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:147.50 stddev:23.47 (15.9%) stddev-sans-first:24.89 03:40:07 INFO - PID 1290 | Values: 144.0 121.0 147.0 178.0 116.0 166.0 148.0 121.0 172.0 118.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:2.08 (1.3%) stddev-sans-first:2.17 03:40:07 INFO - PID 1290 | Values: 163.0 163.0 162.0 163.0 164.0 163.0 169.0 163.0 165.0 166.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#3] audio-fft Cycles:10 Average:95.90 Median:78.00 stddev:36.07 (46.2%) stddev-sans-first:37.67 03:40:07 INFO - PID 1290 | Values: 78.0 78.0 74.0 168.0 78.0 78.0 78.0 81.0 160.0 86.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:78.50 stddev:25.08 (31.9%) stddev-sans-first:25.90 03:40:07 INFO - PID 1290 | Values: 78.0 79.0 136.0 78.0 79.0 80.0 125.0 79.0 78.0 130.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:1.49 (1.3%) stddev-sans-first:1.51 03:40:07 INFO - PID 1290 | Values: 118.0 117.0 114.0 117.0 117.0 117.0 117.0 114.0 118.0 118.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:1.43 (1.0%) stddev-sans-first:1.51 03:40:07 INFO - PID 1290 | Values: 150.0 150.0 154.0 151.0 149.0 150.0 150.0 151.0 150.0 149.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:94.00 stddev:3.81 (4.1%) stddev-sans-first:3.97 03:40:07 INFO - PID 1290 | Values: 94.0 94.0 93.0 94.0 101.0 99.0 94.0 94.0 94.0 104.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:59.00 stddev:1.96 (3.3%) stddev-sans-first:1.83 03:40:07 INFO - PID 1290 | Values: 60.0 56.0 59.0 56.0 59.0 59.0 55.0 59.0 55.0 56.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:57.00 stddev:2.39 (4.2%) stddev-sans-first:2.24 03:40:07 INFO - PID 1290 | Values: 53.0 54.0 54.0 55.0 55.0 56.0 58.0 59.0 60.0 58.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:77.00 stddev:3.50 (4.5%) stddev-sans-first:3.69 03:40:07 INFO - PID 1290 | Values: 77.0 80.0 76.0 77.0 77.0 75.0 79.0 87.0 76.0 76.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:128.50 stddev:15.05 (11.7%) stddev-sans-first:15.83 03:40:07 INFO - PID 1290 | Values: 138.0 127.0 128.0 129.0 134.0 122.0 124.0 127.0 123.0 173.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.10 Median:176.00 stddev:6.08 (3.5%) stddev-sans-first:3.28 03:40:07 INFO - PID 1290 | Values: 192.0 177.0 172.0 182.0 175.0 179.0 174.0 174.0 173.0 173.0 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.50 stddev:2.30 (3.2%) stddev-sans-first:1.87 03:40:07 INFO - PID 1290 | Values: 75.0 72.0 69.0 73.0 69.0 71.0 71.0 68.0 72.0 68.0 03:40:07 INFO - PID 1290 | -------- Summary: end -------- 03:40:07 INFO - PID 1290 | 03:40:07 INFO - PID 1290 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:40:07 INFO - TEST-INFO | 1290: exit 0 03:40:07 INFO - TEST-OK | kraken | took 62981ms 03:40:07 INFO - SUITE-END | took 1176s 03:40:08 INFO - Completed test suite (00:19:36) 03:40:08 INFO - javascript benchmark 03:40:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8620.929243261844, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3156.7001134892193, 3166.2559298564834, 3178.4914413693805, 3205.743540516759, 3210.0851257391632, 6084.2090528231265, 6173.32093469718, 6177.598456100351, 6199.597026193294, 6265.843353916154, 6077.544184186193, 6187.226596675416, 6191.659458729768, 6197.101420294066, 6209.751609935597, 5613.270274864262, 5637.210790489335, 5669.603127781057, 5675.2054712340305, 5756.251687280647, 5705.457981491772, 5707.600467967223, 5725.2843394575675, 5740.913886291709, 5762.97118514409, 5474.72626368684, 5635.8591035224035, 5637.830865074055, 5764.25064741583, 5775.075987841946, 5629.0, 5640.971795141039, 5702.087665973466, 5712.171735098387, 5715.742791574389, 5593.0, 5626.690532020737, 5656.943430565683, 5680.488756011938, 5692.943070569324, 5975.551833612496, 6068.241469816273, 6068.6358818471035, 6105.175801266817, 6123.632582045091, 6525.3800888915475, 6527.902081468782, 6537.150170477855, 6538.640374779386, 6538.6730663467115, 6585.440237579812, 6603.306652801435, 6609.20689517261, 6624.735010599618, 6630.502712296597, 6121.204243448367, 6194.039923811816, 6217.067439884008, 6223.222097237845, 6242.968785156045, 6817.761378351833, 6817.795466136024, 6820.454363650896, 6917.9654101730175, 6960.3039696031, 6429.260635027032, 6513.804585862432, 6524.478041756743, 6552.344765523505, 6650.467962562983, 6574.0, 6623.834404139839, 6632.8673426531195, 6634.933650663432, 6649.202095748541, 6443.903341449882, 6576.276609572943, 6599.274079851212, 6611.73553057882, 6618.503612229006, 6649.567778094505, 6662.83342916431, 6682.63245521501, 6693.263740988487, 6746.0, 5273.551748101454, 5361.08861493547, 5408.8377348679605, 5490.203920431595, 5499.422560631157, 4594.897224666056, 4627.282771170474, 4627.444706635225, 4669.859904202879, 4676.321933319718, 5740.397258287903, 5766.855828604234, 5766.971165144148, 5779.595428320062, 5790.160426738099, 6379.872402551923, 6556.573822701509, 6649.335066493409, 6658.267590565034, 6667.399934005963, 5615.2700148980375, 5669.518090962314, 5724.742386592613, 5731.197632331477, 5735.11105778605, 5773.740181691834, 5826.417358264224, 5859.648421094663, 5865.677387743715, 5890.293164820163, 6449.451796597248, 6490.026496025634, 6502.992036234391, 6529.54293199481, 6533.18335208099, 6540.051692504655, 6624.271330153776, 6632.204135503771, 6700.93299067003, 6750.1562304711915, 6298.433141017331, 6378.87242255143, 6384.521160912857, 6405.871882562229, 6502.447291980235, 6559.147310849559, 6560.803175904731, 6589.044588534732, 6590.373914478117, 6604.438622717123, 6644.46844252449, 6686.5653732507235, 6715.328467153246, 6716.664166791543, 6725.125733654593, 6478.5465017450215, 6483.7730679425995, 6494.1232933553365, 6495.935040649533, 6502.284748677547, 6436.324185960407, 6448.806535803933, 6449.903251451138, 6493.707783149675, 6500.382463665944, 5636.408177141341, 6375.7449702013255, 6430.164078669743, 6430.485561155003, 6475.3200913903365, 6459.709313081016, 6469.4824414045825, 6510.21877374718, 6554.737810487718, 6556.63938483388, 6194.628322300677, 6270.059491076375, 6274.529410294155, 6311.431971122437, 6341.699951509837], "value": 6050.880351284155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [800.6797281087564, 853.8292341531694, 868.535333596526, 874.908134645862, 1166.206979254107, 32174.517382239257, 43077.78461107694, 44111.0, 44158.55841441585, 44275.33586996198, 44528.777356113256, 44629.7768511157, 44802.0, 44894.10211795762, 44920.55079449205, 7623.656935437891, 7816.531008139501, 7839.843203135933, 7840.372770178401, 7847.64685589147, 7665.808354791119, 7715.845683086335, 7738.535687858718, 7759.883601745978, 7764.456488045839, 7244.203137654854, 7820.921790782077, 7824.256695613907, 7845.411594130434, 7850.842983140334, 7735.961320193419, 7763.611819409007, 7771.339436147934, 7789.298963093349, 7794.688212471494, 7633.274838890296, 7692.4615276930635, 7709.922900770976, 7719.729809456699, 7722.420818438583, 39801.60198398008, 40213.0, 40271.79864100661, 40308.798456007535, 40309.59690403088, 3539.239063601338, 3561.269939662389, 3582.0865679251883, 3590.5691317042124, 3591.6587924147166, 32084.839575802205, 32148.517772233434, 32160.517592236134, 32192.35615287681, 32300.353992920245, 4971.328870602459, 4973.552380285755, 5052.242163675442, 5062.873428164288, 5077.517635824591, 191855.0, 192484.0, 192692.0, 192745.0, 193120.0, 50799.492005079475, 50878.49121508738, 50916.49083509117, 50921.490785092414, 50991.235131473055, 52677.209841852404, 52709.47290527046, 52783.0, 52825.471745282826, 52839.0, 14617.634559135893, 14867.330970106372, 14919.850801492063, 15011.699766004836, 15033.098014119189, 12030.15788894769, 12031.15781895259, 12065.819012714815, 12103.092268079929, 12107.636770896886, 13351.0, 13640.317984100755, 14705.92647036758, 14789.11265324084, 15045.699086018438, 5525.834224973257, 5925.229720136354, 6063.907407222348, 6102.481289090389, 6185.628862268279, 987.437160818341, 987.437160818341, 999.81003609314, 1014.5688082564881, 1016.872890888639, 23097.307080787603, 23339.533209335717, 23454.179103731287, 23471.295861124192, 23666.7633323668, 1080.1583300472832, 1084.1001968366238, 1092.8852470490642, 1105.6682995101437, 1113.1540029577418, 12466.5013399463, 16351.918240408722, 16536.255868485947, 16611.83388166103, 16737.581560460843, 246101.0, 246830.0, 247112.0, 247357.0, 247645.0, 60104.39895600988, 60789.69605151946, 60790.69604652037, 61199.38800612026, 61248.387516125156, 1429.2686327825495, 1452.7094581083825, 1463.2025546077414, 1469.426923499836, 1473.661057956676, 27073.0, 28056.859715701292, 28366.0, 29012.0, 29122.27194320159, 40231.79884100678, 40380.798096009334, 40389.1922161561, 40420.79789601033, 40516.594834051284, 156080.0, 156108.0, 157309.0, 157317.0, 158014.0, 35900.10249743777, 36383.636163638024, 36508.45237321389, 36519.08702282464, 36523.08692282714, 40711.0, 41538.37692434555, 41978.580214198686, 45616.54383456256, 47486.76256618833, 33605.0, 33695.494567582, 33808.0, 33891.66108338984, 34410.48384274188, 32815.8359208212, 33369.33261334808, 33516.0, 33544.66455335415, 33653.0, 36686.449703255006, 36791.44812827756, 36834.63165368312, 36943.261134776614, 39744.0, 35549.46675799813, 35647.28705425929, 35873.28253434969, 35882.8205858969, 36019.45970810492, 25281.87359063193, 25607.0, 25741.0, 25817.0, 26019.609705854808], "value": 17703.83289752532, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.1359254322244, 582.8222392170386, 587.9559033072518, 592.786596825143, 597.131174141624, 22446.55106897861, 22542.0, 23280.767192328094, 23305.184318548854, 23341.18305859291, 25648.487030259384, 25973.350666233353, 26098.608520872203, 26131.085412010583, 26217.34456638585, 6256.217972753395, 6398.488120950313, 6399.968000159993, 6400.807975760735, 6401.327860574619, 5903.88192236155, 6368.586041907284, 6398.648074355909, 6453.354664533533, 6523.771667991621, 6334.841628959267, 6341.936580634181, 6342.587731797442, 6349.206349206349, 6352.205974253218, 6356.237251529799, 6359.300476947532, 6360.141380913564, 6366.649834259114, 6369.07648390983, 5923.763049478016, 5926.436988486087, 5934.050551911673, 5937.0, 5942.554308426842, 29517.262068448246, 30240.546391804142, 30667.07998760041, 30840.845795771103, 30883.382332353453, 1962.7840937496865, 2008.8493362997833, 2009.8492613053934, 2010.3868320162344, 2010.7587089549347, 19479.90260048705, 20006.499837504034, 20094.095765690578, 20100.597988040157, 20129.09419076145, 2363.881805909715, 2376.6435034744754, 2441.07239249086, 2447.2535876557645, 2462.0398044762555, 139357.0, 142271.28864355612, 142482.2875885614, 142714.0, 142851.0, 14341.067830590979, 15103.697926041417, 15267.465638702592, 15272.31274592646, 15856.92071539658, 24205.51588968246, 24207.878960605085, 24214.51570968606, 24249.272521824372, 24263.878680606485, 9983.800323993479, 10006.249531285182, 10052.346597471142, 10067.496625168713, 10154.187664986783, 8928.821423571491, 9008.909910900808, 9022.729318120468, 9121.498317592595, 9180.770480738034, 7670.0, 9107.772305692279, 9339.252859771203, 9360.251179905592, 9414.388064775767, 2540.7459254074442, 2565.396122935222, 2653.840769553833, 2658.9601155982677, 2681.115231973444, 945.8155659646441, 953.9013970328583, 964.3346091197192, 968.8788901387327, 973.9366941148803, 18837.340693075676, 19117.713234301496, 19447.902760486108, 19604.509887252934, 19778.50553736168, 998.031909048222, 1013.3919648211014, 1017.0897047142765, 1029.4389557691077, 1029.8867124616286, 10700.678979630624, 10867.728306792234, 10994.945025274823, 11007.339559626447, 11020.283681560833, 483363.0, 523773.0, 532789.0, 534069.0, 542126.0, 122340.38829805794, 123577.38211309066, 124470.0, 124601.0, 125005.37497312455, 1224.0085530720146, 1230.8522977242787, 1297.6626077219992, 1298.8766067223787, 1302.3423171298434, 20539.0, 20601.690974635094, 20695.79304206999, 20997.475063123544, 21253.89373053125, 58142.0, 58911.41088589059, 59198.0, 60013.399866002525, 60677.0, 66269.0, 66482.33517664761, 68460.31539684739, 70120.29879701341, 70675.64662176656, 14762.114273143647, 15021.849781502482, 15099.849001509845, 15166.620834478785, 15172.848271517585, 23420.414489637897, 23625.500191853946, 23738.169164079176, 23986.760132398453, 24280.51438971246, 18697.71953420727, 18733.53166170802, 18814.811851881852, 19024.904875475535, 19041.238350465825, 16502.75245871337, 16712.41506547265, 17403.564910876823, 17456.91271543634, 17528.211230494915, 19201.0, 19206.807931920503, 19407.12667929975, 19593.0, 19694.310699126036, 14841.628959276104, 14930.701385972437, 15005.0, 15005.399784008518, 15026.023308484913, 18880.716789248447, 18909.0, 18986.0, 19008.23967041303, 19011.524711882314], "value": 12124.091507699848, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.6778906956863, 1401.8528054554272, 1424.2522675595317, 1432.5487471446488, 1435.468876515689, 14219.71560568788, 14361.784573231409, 14826.925865370671, 14863.256837158126, 14863.33115009823, 14506.782398264007, 14799.33402996865, 14805.777913331282, 14807.925960370183, 14812.925935370307, 2746.8901243950268, 2774.7225277472194, 2787.484315401647, 2802.929926751827, 2805.7895657825643, 2614.16346769034, 2720.6735191777016, 2815.155453363993, 2815.6058151858756, 2815.9718402815915, 2741.0954385052883, 2768.878604165316, 2799.8180118292244, 2801.7618502427217, 2805.270629636299, 2723.196656986194, 2734.3300891281665, 2750.8487033213164, 2780.7636350910198, 2785.7353551412684, 2646.2325925481587, 2663.653725015755, 2680.8525531095784, 2694.286014206237, 2700.648915640954, 14520.854791452055, 14581.125132491978, 14612.634684132876, 14638.780418293734, 14663.046901951446, 7403.481756277063, 7443.144038435595, 7759.495632783851, 7767.922320776776, 7786.377089832799, 5278.1291086970605, 5381.354237491487, 5525.392206857243, 5553.333599967989, 5553.944460555384, 1747.187557785623, 1755.5347832824311, 1762.2334284586245, 1827.2234300422267, 1831.7985021647742, 24571.508569828682, 24820.751792482206, 24992.375190620198, 25026.49947001068, 25054.248372548853, 6968.581885086911, 7102.181841448626, 7182.497225194291, 7244.348008679139, 7281.1990681025045, 16243.51269461918, 16402.343906243856, 16530.917345413196, 16552.172391380383, 16558.66882662364, 7488.026556547614, 7579.583122928292, 7632.618369081635, 7636.770896873103, 7642.8089297768, 6193.783217587363, 6931.6880740366805, 7082.433405327562, 7093.467989900675, 7118.857622847514, 4801.903961920742, 5113.8721531961255, 5287.259783630295, 5297.496737809902, 5298.947010529845, 1454.70178613384, 1502.241368109098, 1506.0361368723807, 1518.7569988801959, 1520.9695806084037, 937.6249500199974, 953.7997020625746, 962.8603852441497, 964.1997142371814, 964.3249725192394, 8501.362397820189, 8579.613917373734, 8581.871271930926, 8629.43908645936, 8639.222469977607, 1009.5305682857506, 1012.1649639047815, 1024.1039090795555, 1031.8297480915564, 1042.4266653340633, 4712.034033023222, 4942.9011419771405, 5505.504504594525, 5574.191742197439, 5609.663420194802, 19079.713804292947, 19721.30975415882, 19784.109715062856, 19892.90053549723, 20036.69944950827, 20806.43951703598, 21169.470763231042, 21178.78821211799, 21210.25764098249, 21211.78788212098, 10684.89315106839, 11104.722381940355, 11163.106951443864, 11382.0, 11387.487563059516, 8314.6674133034, 8771.824563508822, 8808.779780505538, 8914.153155450222, 8983.685571004984, 17550.210240538952, 17781.555461113574, 17946.282148713904, 18204.089795509906, 18491.72262416038, 17937.730934036263, 18133.818661813213, 18211.635767284846, 18305.26778928828, 18310.176042077874, 11788.0, 12011.819822702491, 12104.213226140273, 12111.75776484483, 12119.636410907688, 12159.939200304296, 12509.499620015098, 13252.469901203844, 13495.865041349462, 13629.727405451637, 10594.841077383999, 10703.625373111903, 10737.624183153865, 10911.127109831035, 11088.223824332543, 9960.0, 10026.448545330077, 10065.144462720751, 10415.062644362044, 10428.895711042793, 9853.753656158653, 9929.156021738234, 9969.30214884951, 9969.30214884951, 9975.45135017552, 7165.7850264492145, 7347.375473084848, 7380.889286660597, 7395.667194976131, 7406.037215161994, 7410.407167426701, 7436.442266830118, 7490.438217133627, 7516.0, 7614.543127412373], "value": 6613.76784357692, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [504.341833906752, 514.4495389932771, 521.4654978646887, 534.9644602288294, 535.357570914902, 6229.314775374711, 6259.968700156504, 6309.5267854910835, 6324.766670499249, 6347.857385670583, 6188.690565471731, 6218.284897236819, 6244.281907580618, 6253.343398943114, 6266.498680105592, 5069.188929771238, 5113.923291150636, 5117.362444017916, 5117.641765076455, 5137.845864624067, 4736.431628204603, 4938.678985865908, 5055.646104772667, 5090.0, 5099.4900509949075, 4907.386576677915, 4909.435414927293, 4919.1637421638225, 4919.704817710931, 4925.236588328797, 4920.630952678528, 4940.530649588283, 4940.975295123501, 4950.727709975949, 4974.602031837444, 4343.457067866517, 4416.447944006999, 4437.46750389952, 4451.464244835559, 4472.351509031172, 6064.935064935065, 6073.817785466443, 6099.939000610026, 6103.328633850273, 6115.755369785204, 5699.316082070137, 5701.57238207132, 5701.885962280772, 5707.885842283173, 5746.79886203985, 6672.833179170511, 6711.731530738764, 6720.689465554219, 6723.159605049369, 6729.596224226562, 4856.562909338177, 4863.829765958175, 4893.730844803535, 4896.951030489685, 4919.385076865392, 6576.276609572991, 6680.0313954476815, 6765.594064356154, 6920.653967301615, 6956.373926346653, 4948.134076536592, 4953.777080031407, 4965.90068198634, 4970.701757894538, 5019.924701129486, 4919.262110683355, 4996.675216110941, 5021.4225364083595, 5058.595312375001, 5090.567301779316, 5639.0, 5639.971800140973, 5690.6301090429815, 5712.257406537124, 5713.885722285531, 6691.431228345547, 6698.866022679616, 6703.497237707192, 6725.0, 6756.628385438848, 1729.5589624645636, 1749.99375359169, 1751.991240043817, 1765.4993255732782, 1779.5284249673846, 1174.277819141239, 1210.727586293077, 1215.8784121587948, 1218.3238302741886, 1244.5519612939336, 5765.913511297334, 5784.2769653793275, 5813.09896965971, 5833.562482813721, 5841.211436456024, 6684.732610695518, 6717.932820671828, 6745.561538499982, 6754.18949726036, 6846.418054465426, 5737.020727848885, 5739.741711622987, 5788.305403351541, 5790.594658373873, 5802.274715660543, 3596.1300123935407, 3606.0, 3608.9458658119624, 3618.6381361863605, 3669.798161101165, 6596.769113081019, 6600.339966003361, 6658.602902954933, 6665.766698165541, 6679.499037572202, 6911.274316196727, 6936.79189624312, 6959.965200173967, 6971.965140174369, 6985.0, 6429.453496452854, 6526.771562995273, 6589.8467768141345, 6602.7028783704845, 6635.369639884203, 6731.899021514583, 6760.425363843931, 6774.898376524257, 6781.627010514272, 6795.354441328066, 6128.356522565245, 6676.49926255523, 6680.331966803281, 6735.932640673531, 6796.558223715443, 6529.706163222571, 6550.377714117151, 6558.245801732862, 6570.868582628416, 6651.933480665131, 4808.663393562557, 4909.26361045846, 4945.901081978413, 4982.676126051795, 4992.525710057539, 6558.737650493927, 6587.868242635216, 6679.328268692562, 6783.898241526283, 6839.760608378683, 6375.840603984938, 6397.0, 6536.3136870627895, 6587.341265873374, 6622.4702023838945, 6472.190976127984, 6537.803865884031, 6567.620799632131, 6604.14146160996, 6611.504137189826, 6430.64631445275, 6504.447121994684, 6519.152510173647, 6519.217693876765, 6525.869482610226, 6585.835354116185, 6617.305182955721, 6628.6022838627905, 6633.535652504278, 6710.932890671226, 6306.590071645328, 6325.240971083499, 6398.5201109916015, 6418.827761954767, 6420.711068001858], "value": 5074.637761170702, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [883.6112110671301, 900.9864852027221, 901.463629140661, 914.4513292024782, 924.5192499900054, 20205.39383818486, 21722.239721609745, 21725.565488690256, 21801.563968720635, 21817.345479635598, 21455.0, 22111.0, 22249.777502224973, 22280.88859555704, 22314.88842555785, 976.0386019770538, 992.1913640383101, 994.2940512236321, 994.8607194992707, 1024.5491983527224, 1061.368485750977, 1063.2982231727024, 1065.4459680965892, 1068.7221322456178, 1069.1713921710698, 1122.7922834275644, 1124.7413094988158, 1125.2517076144354, 1125.2685754259714, 1127.109583429094, 1119.1774046076127, 1121.2319561100592, 1121.5625905896707, 1121.5962253588702, 1123.6292023632182, 816.7794695432259, 817.65249768848, 817.7710241132493, 818.2431251092775, 818.251300060444, 20021.399358019284, 20293.492662683402, 20347.796522034885, 20447.897760511252, 20657.070431830605, 21985.780142198535, 22065.558688826135, 22145.114195432325, 22312.330630081124, 22386.552268954692, 17052.48842534726, 17175.141242937803, 17329.653406931917, 17653.646927061385, 17655.73516397255, 3631.5642122945414, 3633.182533929845, 3653.890383288479, 3655.597884232732, 3656.8171591420587, 118370.40814795958, 121776.0, 125656.37171814175, 125942.37028814889, 126812.0, 17512.29950801979, 18145.63708725818, 18205.089745512672, 18234.908825456052, 18241.543961400806, 24101.598213438, 30728.69271307258, 30910.690893091232, 31441.0, 31881.0, 8829.867551986725, 8884.244839188612, 9116.544172791333, 9120.680776172801, 9125.04187060349, 4232.746035237896, 4352.238358287287, 4355.60799528044, 4360.869173924787, 4363.214621368184, 5352.116900711339, 5422.593305502103, 5457.072297709319, 5458.754356053987, 5484.149956756709, 1103.564092183583, 1113.3820729495208, 1116.151724689242, 1116.2799994003985, 1116.609186784635, 586.8914250863604, 594.5659668442062, 600.1088383750127, 601.6119602856221, 614.0819474884986, 12410.81383779244, 12624.853774858297, 12631.557895473798, 12687.376060819544, 13512.324383780771, 696.7108649910332, 705.1009962298111, 706.9257727938492, 711.1146622454974, 720.8522252938135, 5679.403662615448, 5745.166950792195, 5884.58807883444, 5935.1987481690285, 6082.992612437885, 113004.0, 113124.0, 113561.0, 114547.42726286316, 116188.41905790586, 94319.0, 94783.0, 97072.0, 97729.51135244279, 102232.0, 83633.58183209045, 85266.1473385283, 85324.14675853286, 86642.0, 86660.0, 11100.500477478694, 11217.55129794799, 11309.491072901574, 11417.0, 11595.072394208612, 39030.80484597559, 39195.21609567736, 39698.206035879695, 40687.59312406838, 41352.0, 51401.7429912848, 51454.0, 52087.479125208265, 52819.47180528299, 53965.460345397616, 16133.596660083122, 19328.61342773165, 19937.10283037238, 20342.0, 20405.387838364873, 21889.233876814236, 22033.889830550746, 22604.66093008639, 22615.208467703553, 22683.0, 19771.308004219783, 19916.90041549783, 20195.0, 20274.0, 20647.8967605161, 19825.0, 20223.19107235753, 20295.391138265877, 20379.0, 20413.59172816565, 19203.0, 19270.90364548168, 19906.800931991074, 20178.79821201828, 20525.589488209855, 13773.0, 13864.722705546033, 14316.785248221076, 14541.200233986809, 14827.629309267355, 14873.47942821996, 15079.698406032037, 15262.160581168142, 15385.923070384577, 15431.0], "value": 9416.905106182265, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 108.0, 103.0, 108.0, 114.0, 115.0, 110.0, 109.0, 115.0, 122.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 121.0, 147.0, 178.0, 116.0, 166.0, 148.0, 121.0, 172.0, 118.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 162.0, 163.0, 164.0, 163.0, 169.0, 163.0, 165.0, 166.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 74.0, 168.0, 78.0, 78.0, 78.0, 81.0, 160.0, 86.0], "value": 95.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 136.0, 78.0, 79.0, 80.0, 125.0, 79.0, 78.0, 130.0], "value": 94.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 114.0, 117.0, 117.0, 117.0, 117.0, 114.0, 118.0, 118.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 154.0, 151.0, 149.0, 150.0, 150.0, 151.0, 150.0, 149.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 94.0, 101.0, 99.0, 94.0, 94.0, 94.0, 104.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 56.0, 59.0, 56.0, 59.0, 59.0, 55.0, 59.0, 55.0, 56.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 54.0, 55.0, 55.0, 56.0, 58.0, 59.0, 60.0, 58.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 80.0, 76.0, 77.0, 77.0, 75.0, 79.0, 87.0, 76.0, 76.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 127.0, 128.0, 129.0, 134.0, 122.0, 124.0, 127.0, 123.0, 173.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 177.0, 172.0, 182.0, 175.0, 179.0, 174.0, 174.0, 173.0, 173.0], "value": 177.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 69.0, 73.0, 69.0, 71.0, 71.0, 68.0, 72.0, 68.0], "value": 70.8, "unit": "score"}]}]} 03:40:08 INFO - Return code: 0 03:40:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:40:08 INFO - # TBPL SUCCESS # 03:40:08 INFO - Running post-action listener: _package_coverage_data 03:40:08 INFO - Running post-action listener: _resource_record_post_action 03:40:08 INFO - [mozharness: 2017-08-16 10:40:08.428892Z] Finished run-tests step (success) 03:40:08 INFO - Running post-run listener: _resource_record_post_run 03:40:08 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 16384; Write bytes: 431988736; Read time: 244; Write time: 376644 03:40:08 INFO - TinderboxPrint: CPU usage
13.1% 03:40:08 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 244 03:40:08 INFO - TinderboxPrint: I/O write bytes / time
431,988,736 / 376,644 03:40:08 INFO - TinderboxPrint: CPU idle
8,275.1 (86.8%) 03:40:08 INFO - TinderboxPrint: CPU user
1,201.1 (12.6%) 03:40:08 INFO - TinderboxPrint: Swap in / out
0 / 0 03:40:08 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 106659840; Read time: 68; Write time: 107220 03:40:08 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:40:08 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 8192; Write bytes: 325328896; Read time: 160; Write time: 269424 03:40:09 INFO - Running post-run listener: _upload_blobber_files 03:40:09 INFO - Blob upload gear active. 03:40:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:40:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:40:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:40:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:40:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:40:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:40:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:10 INFO - (blobuploader) - INFO - Done attempting. 03:40:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:40:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:40:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:11 INFO - (blobuploader) - INFO - Done attempting. 03:40:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:40:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:40:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:18 INFO - (blobuploader) - INFO - Done attempting. 03:40:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:40:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:40:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:40:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:40:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:40:19 INFO - (blobuploader) - INFO - Done attempting. 03:40:19 INFO - (blobuploader) - INFO - Iteration through files over. 03:40:19 INFO - Return code: 0 03:40:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:40:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:40:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9736e892c089852a0ca25c005cded6a30dcdb76d283e3599da78064b933499a0cc471494cfddd7033265acfd6f6f69b35a816c3a5152cbb584a65df765a0e660", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b67178c349f08fbf379c049fae0b9eeb4b708122829dc6cbf9fb2cddc7c50fff906fd897c18dc2cfc02d40c58cf5b96829578945b403725768b9cb9830987cee", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad06c6e9f02886b89818223f5f5387273c44e5ae3c15f1afbd66e94ecb997c56c4f97b436716e1c5b82c68af14024108a51b4869a3a0639b6cdd9ae49e26e2b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82e96d8c176ad1d17a13af34b5cc263b92e438d4d0b38f22b1cb124296e54ca3de996dec853c5fb743fb6b218bfd73eb9b9a6a67a08d1063a39939c1ef186d3b"} 03:40:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:40:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:40:19 INFO - Contents: 03:40:19 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9736e892c089852a0ca25c005cded6a30dcdb76d283e3599da78064b933499a0cc471494cfddd7033265acfd6f6f69b35a816c3a5152cbb584a65df765a0e660", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b67178c349f08fbf379c049fae0b9eeb4b708122829dc6cbf9fb2cddc7c50fff906fd897c18dc2cfc02d40c58cf5b96829578945b403725768b9cb9830987cee", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad06c6e9f02886b89818223f5f5387273c44e5ae3c15f1afbd66e94ecb997c56c4f97b436716e1c5b82c68af14024108a51b4869a3a0639b6cdd9ae49e26e2b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82e96d8c176ad1d17a13af34b5cc263b92e438d4d0b38f22b1cb124296e54ca3de996dec853c5fb743fb6b218bfd73eb9b9a6a67a08d1063a39939c1ef186d3b"} 03:40:19 INFO - Running post-run listener: copy_logs_to_upload_dir 03:40:19 INFO - Copying logs to upload dir... 03:40:19 INFO - mkdir: /builds/slave/test/build/upload/logs 03:40:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.464983 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-16 03:40:18.884005) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:40:18.888941) ========= 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=fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977 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/9736e892c089852a0ca25c005cded6a30dcdb76d283e3599da78064b933499a0cc471494cfddd7033265acfd6f6f69b35a816c3a5152cbb584a65df765a0e660", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b67178c349f08fbf379c049fae0b9eeb4b708122829dc6cbf9fb2cddc7c50fff906fd897c18dc2cfc02d40c58cf5b96829578945b403725768b9cb9830987cee", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad06c6e9f02886b89818223f5f5387273c44e5ae3c15f1afbd66e94ecb997c56c4f97b436716e1c5b82c68af14024108a51b4869a3a0639b6cdd9ae49e26e2b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82e96d8c176ad1d17a13af34b5cc263b92e438d4d0b38f22b1cb124296e54ca3de996dec853c5fb743fb6b218bfd73eb9b9a6a67a08d1063a39939c1ef186d3b"} build_url:https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011387 build_url: 'https://queue.taskcluster.net/v1/task/AhttepjMRduMG8XVM9dp6A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9736e892c089852a0ca25c005cded6a30dcdb76d283e3599da78064b933499a0cc471494cfddd7033265acfd6f6f69b35a816c3a5152cbb584a65df765a0e660", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b67178c349f08fbf379c049fae0b9eeb4b708122829dc6cbf9fb2cddc7c50fff906fd897c18dc2cfc02d40c58cf5b96829578945b403725768b9cb9830987cee", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad06c6e9f02886b89818223f5f5387273c44e5ae3c15f1afbd66e94ecb997c56c4f97b436716e1c5b82c68af14024108a51b4869a3a0639b6cdd9ae49e26e2b4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82e96d8c176ad1d17a13af34b5cc263b92e438d4d0b38f22b1cb124296e54ca3de996dec853c5fb743fb6b218bfd73eb9b9a6a67a08d1063a39939c1ef186d3b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:40:18.918781) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:40:18.919063) ========= 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=fcadb68e09dcf59683000ff6000001dc-1502878760.312506-1407535977 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004774 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:40:18.999241) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:40:19.002599) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:40:19.002871) ========= ========= Total master_lag: 0.18 =========