builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1502483799.0 results: success (0) revision: e7dc8329e2d478087314605e8184627489eef636 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 13:36:39.004944) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-11 13:36:39.005392) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 13:36:39.005747) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-11 13:36:39.021779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:36:39.022080) ========= 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=20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-11 13:36:39-- 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% 46.1M=0s 2017-08-11 13:36:39 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116821 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:36:39.152015) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:36:39.152356) ========= 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=20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020798 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:36:39.204499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-11 13:36:39.207866) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e7dc8329e2d478087314605e8184627489eef636 --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 e7dc8329e2d478087314605e8184627489eef636 --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=20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-11 13:36:39,428 truncating revision to first 12 chars 2017-08-11 13:36:39,429 Setting DEBUG logging. 2017-08-11 13:36:39,429 attempt 1/10 2017-08-11 13:36:39,429 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e7dc8329e2d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-11 13:36:40,694 unpacking tar archive at: mozilla-central-e7dc8329e2d4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.574495 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-11 13:36:40.797790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 13:36:40.798109) ========= script_repo_revision: e7dc8329e2d478087314605e8184627489eef636 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-11 13:36:40.798467) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 13:36:40.798741) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-11 13:36:40.808532) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-11 13:36:40.808808) ========= /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=20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:36:41 INFO - MultiFileLogger online at 20170811 13:36:41 in /builds/slave/test 13:36:41 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 13:36:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:36:41 INFO - {'append_to_log': False, 13:36:41 INFO - 'base_work_dir': '/builds/slave/test', 13:36:41 INFO - 'blob_upload_branch': 'Firefox', 13:36:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:36:41 INFO - 'branch': 'Firefox', 13:36:41 INFO - 'buildbot_json_path': 'buildprops.json', 13:36:41 INFO - 'code_coverage': False, 13:36:41 INFO - 'config_files': ('talos/linux_config.py',), 13:36:41 INFO - 'default_actions': ('clobber', 13:36:41 INFO - 'read-buildbot-config', 13:36:41 INFO - 'download-and-extract', 13:36:41 INFO - 'populate-webroot', 13:36:41 INFO - 'create-virtualenv', 13:36:41 INFO - 'install', 13:36:41 INFO - 'setup-mitmproxy', 13:36:41 INFO - 'run-tests'), 13:36:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:36:41 INFO - 'disable_ccov_upload': False, 13:36:41 INFO - 'download_minidump_stackwalk': True, 13:36:41 INFO - 'download_symbols': 'ondemand', 13:36:41 INFO - 'enable_stylo': False, 13:36:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:36:41 INFO - 'tooltool.py': '/tools/tooltool.py', 13:36:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:36:41 INFO - '/tools/misc-python/virtualenv.py')}, 13:36:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:36:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:36:41 INFO - 'gecko_profile': False, 13:36:41 INFO - 'gecko_profile_interval': 0, 13:36:41 INFO - 'installer_path': 'installer.exe', 13:36:41 INFO - 'log_level': 'info', 13:36:41 INFO - 'log_name': 'talos', 13:36:41 INFO - 'log_to_console': True, 13:36:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:36:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:36:41 INFO - 'opt_config_files': (), 13:36:41 INFO - 'pip_index': False, 13:36:41 INFO - 'suite': 'dromaeojs-e10s', 13:36:41 INFO - 'system_bits': '32', 13:36:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:36:41 INFO - 'title': 'talos-linux64-ix-015', 13:36:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:36:41 INFO - 'use_talos_json': True, 13:36:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:36:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:36:41 INFO - 'work_dir': 'build'} 13:36:41 INFO - [mozharness: 2017-08-11 20:36:41.134896Z] Running clobber step. 13:36:41 INFO - Running pre-action listener: _resource_record_pre_action 13:36:41 INFO - Running main action method: clobber 13:36:41 INFO - rmtree: /builds/slave/test/build 13:36:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:36:42 INFO - Running post-action listener: _resource_record_post_action 13:36:42 INFO - [mozharness: 2017-08-11 20:36:42.735391Z] Finished clobber step (success) 13:36:42 INFO - [mozharness: 2017-08-11 20:36:42.735491Z] Running read-buildbot-config step. 13:36:42 INFO - Running pre-action listener: _resource_record_pre_action 13:36:42 INFO - Running main action method: read_buildbot_config 13:36:42 INFO - Using buildbot properties: 13:36:42 INFO - { 13:36:42 INFO - "project": "", 13:36:42 INFO - "product": "firefox", 13:36:42 INFO - "who": "kwierso@gmail.com", 13:36:42 INFO - "installer_path": "public/build/target.tar.bz2", 13:36:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 13:36:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 13:36:42 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 13:36:42 INFO - "stage_platform": "linux64-stylosequential", 13:36:42 INFO - "basedir": "/builds/slave/test", 13:36:42 INFO - "buildnumber": 144, 13:36:42 INFO - "platform": "ubuntu64_hw_styloseq", 13:36:42 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:36:42 INFO - "slavebuilddir": "test", 13:36:42 INFO - "taskId": "R49txElyTj-ErOoCiOgwYQ", 13:36:42 INFO - "branch": "mozilla-central", 13:36:42 INFO - "script_repo_revision": "production", 13:36:42 INFO - "revision": "e7dc8329e2d478087314605e8184627489eef636", 13:36:42 INFO - "slavename": "talos-linux64-ix-015", 13:36:42 INFO - "repo_path": "mozilla-central" 13:36:42 INFO - } 13:36:42 INFO - Finding installer, test and symbols from parent task. 13:36:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R49txElyTj-ErOoCiOgwYQ'}, attempt #1 13:36:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R49txElyTj-ErOoCiOgwYQ'}, attempt #1 13:36:43 INFO - Task dependencies: RpnxFEWaSluJ4sP8X5FZcg 13:36:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg'}, attempt #1 13:36:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2 13:36:44 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.test_packages.json 13:36:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.crashreporter-symbols.zip 13:36:44 INFO - Running post-action listener: _resource_record_post_action 13:36:44 INFO - [mozharness: 2017-08-11 20:36:44.099291Z] Finished read-buildbot-config step (success) 13:36:44 INFO - [mozharness: 2017-08-11 20:36:44.099511Z] Running download-and-extract step. 13:36:44 INFO - Running pre-action listener: _resource_record_pre_action 13:36:44 INFO - Running main action method: download_and_extract 13:36:44 INFO - mkdir: /builds/slave/test/build/tests 13:36:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:36:44 INFO - trying https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.test_packages.json 13:36:44 INFO - Downloading https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 13:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 13:36:44 INFO - Downloaded 989 bytes. 13:36:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 13:36:44 INFO - Using the following test package requirements: 13:36:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 13:36:44 INFO - u'common': [u'target.common.tests.zip'], 13:36:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 13:36:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 13:36:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 13:36:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 13:36:44 INFO - u'mozbase': [u'target.common.tests.zip'], 13:36:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 13:36:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 13:36:44 INFO - u'web-platform': [u'target.common.tests.zip', 13:36:44 INFO - u'target.web-platform.tests.tar.gz'], 13:36:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 13:36:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 13:36:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.common.tests.zip 13:36:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:36:44 INFO - Fetch https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.common.tests.zip into memory 13:36:45 INFO - Content-Length response header: 54036652 13:36:45 INFO - Bytes received: 54036652 13:36:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 13:36:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.common.tests.zip 13:36:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.common.tests.zip'}, attempt #1 13:36:56 INFO - Fetch https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.common.tests.zip into memory 13:36:57 INFO - Content-Length response header: 54036652 13:36:57 INFO - Bytes received: 54036652 13:37:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.talos.tests.zip 13:37:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 13:37:09 INFO - Fetch https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.talos.tests.zip into memory 13:37:10 INFO - Content-Length response header: 14496050 13:37:10 INFO - Bytes received: 14496050 13:37: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')]} 13:37:10 INFO - trying https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2 13:37:10 INFO - Downloading https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 13:37:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 13:37:11 INFO - Downloaded 61924881 bytes. 13:37:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2 13:37:11 INFO - mkdir: /builds/slave/test/properties 13:37:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:37:11 INFO - Writing to file /builds/slave/test/properties/build_url 13:37:11 INFO - Contents: 13:37:11 INFO - build_url:https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2 13:37:11 INFO - Running post-action listener: _resource_record_post_action 13:37:11 INFO - Running post-action listener: set_extra_try_arguments 13:37:11 INFO - [mozharness: 2017-08-11 20:37:11.782873Z] Finished download-and-extract step (success) 13:37:11 INFO - [mozharness: 2017-08-11 20:37:11.782970Z] Running populate-webroot step. 13:37:11 INFO - Running pre-action listener: _resource_record_pre_action 13:37:11 INFO - Running main action method: populate_webroot 13:37:11 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:37:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:37:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:37:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:37:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:37:11 INFO - 'tests': ['damp', 'tps']}, 13:37:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:37:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 13:37:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 13:37:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 13:37:11 INFO - 'other-e10s': {'tests': ['a11yr', 13:37:11 INFO - 'ts_paint', 13:37:11 INFO - 'tpaint', 13:37:11 INFO - 'sessionrestore', 13:37:11 INFO - 'sessionrestore_many_windows', 13:37:11 INFO - 'sessionrestore_no_auto_restore', 13:37:11 INFO - 'tabpaint']}, 13:37:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 13:37:11 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 13:37:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:37:11 INFO - 'tsvgr_opacity', 13:37:11 INFO - 'tart', 13:37:11 INFO - 'tscrollx', 13:37:11 INFO - 'tsvg_static']}, 13:37:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:37:11 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:37:11 INFO - 'talos_options': ['--mitmproxy', 13:37:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:37:11 INFO - '--firstNonBlankPaint'], 13:37:11 INFO - 'tests': ['tp6_google', 13:37:11 INFO - 'tp6_youtube', 13:37:11 INFO - 'tp6_amazon', 13:37:11 INFO - 'tp6_facebook']}, 13:37:11 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:37:11 INFO - 'talos_options': ['--stylo', 13:37:11 INFO - '--mitmproxy', 13:37:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:37:11 INFO - '--firstNonBlankPaint'], 13:37:11 INFO - 'tests': ['tp6_google', 13:37:11 INFO - 'tp6_youtube', 13:37:11 INFO - 'tp6_amazon', 13:37:11 INFO - 'tp6_facebook']}, 13:37:11 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 13:37:11 INFO - 'talos_options': ['--stylo', 13:37:11 INFO - '--stylo-threads=1', 13:37:11 INFO - '--mitmproxy', 13:37:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 13:37:11 INFO - '--firstNonBlankPaint'], 13:37:11 INFO - 'tests': ['tp6_google', 13:37:11 INFO - 'tp6_youtube', 13:37:11 INFO - 'tp6_amazon', 13:37:11 INFO - 'tp6_facebook']}, 13:37:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:37:11 INFO - 'talos_options': ['--xperf_path', 13:37:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:37:11 INFO - 'tests': ['tp5n']}}} 13:37:11 INFO - Running post-action listener: _resource_record_post_action 13:37:11 INFO - [mozharness: 2017-08-11 20:37:11.791338Z] Finished populate-webroot step (success) 13:37:11 INFO - [mozharness: 2017-08-11 20:37:11.791427Z] Running create-virtualenv step. 13:37:11 INFO - Running pre-action listener: _resource_record_pre_action 13:37:11 INFO - Running main action method: create_virtualenv 13:37:11 INFO - Creating virtualenv /builds/slave/test/build/venv 13:37:11 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 13:37:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:37:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 13:37:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:37:11 INFO - Using real prefix '/usr' 13:37:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:37:12 INFO - Installing distribute.............................................................................................................................................................................................done. 13:37:14 INFO - Installing pip.................done. 13:37:14 INFO - Return code: 0 13:37:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:37:14 INFO - Reading from file tmpfile_stdout 13:37:14 INFO - Output received: 13:37:14 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) 13:37:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:37:14 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')]} 13:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:14 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')]} 13:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:14 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 0x18b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c208a0>, '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 0x1c217a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21c30>, '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': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', '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 13:37:14 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 13:37:14 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 13:37:14 INFO - Using env: {'DISPLAY': ':0', 13:37:14 INFO - 'HOME': '/home/cltbld', 13:37:14 INFO - 'LANG': 'en_US.UTF-8', 13:37:14 INFO - 'LANGUAGE': 'en_US:en', 13:37:14 INFO - 'LOGNAME': 'cltbld', 13:37:14 INFO - 'MAIL': '/var/mail/cltbld', 13:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:14 INFO - 'MOZ_NO_REMOTE': '1', 13:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:14 INFO - 'NO_EM_RESTART': '1', 13:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:14 INFO - 'PWD': '/builds/slave/test', 13:37:14 INFO - 'SHELL': '/bin/bash', 13:37:14 INFO - 'SHLVL': '1', 13:37:14 INFO - 'TERM': 'linux', 13:37:14 INFO - 'TMOUT': '86400', 13:37:14 INFO - 'USER': 'cltbld', 13:37:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', 13:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:14 INFO - '_': '/tools/buildbot/bin/python'} 13:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:14 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 13:37:14 INFO - Cleaning up... 13:37:14 INFO - Return code: 0 13:37:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:37:14 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')]} 13:37:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:14 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')]} 13:37:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:14 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 0x18b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c208a0>, '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 0x1c217a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21c30>, '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': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', '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 13:37:14 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 13:37:14 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 13:37:14 INFO - Using env: {'DISPLAY': ':0', 13:37:14 INFO - 'HOME': '/home/cltbld', 13:37:14 INFO - 'LANG': 'en_US.UTF-8', 13:37:14 INFO - 'LANGUAGE': 'en_US:en', 13:37:14 INFO - 'LOGNAME': 'cltbld', 13:37:14 INFO - 'MAIL': '/var/mail/cltbld', 13:37:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:14 INFO - 'MOZ_NO_REMOTE': '1', 13:37:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:14 INFO - 'NO_EM_RESTART': '1', 13:37:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:14 INFO - 'PWD': '/builds/slave/test', 13:37:14 INFO - 'SHELL': '/bin/bash', 13:37:14 INFO - 'SHLVL': '1', 13:37:14 INFO - 'TERM': 'linux', 13:37:14 INFO - 'TMOUT': '86400', 13:37:14 INFO - 'USER': 'cltbld', 13:37:14 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', 13:37:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:14 INFO - '_': '/tools/buildbot/bin/python'} 13:37:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:14 INFO - Downloading/unpacking psutil>=3.1.1 13:37:14 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 13:37:14 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 13:37:14 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 13:37:14 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 13:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:37:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:37:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:37:16 INFO - Installing collected packages: psutil 13:37:16 INFO - Running setup.py install for psutil 13:37:16 INFO - building 'psutil._psutil_linux' extension 13:37:16 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 13:37:16 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 13:37:16 INFO - building 'psutil._psutil_posix' extension 13:37:16 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 13:37:16 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 13:37:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:37:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:37:16 INFO - Successfully installed psutil 13:37:16 INFO - Cleaning up... 13:37:16 INFO - Return code: 0 13:37:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:37:16 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')]} 13:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:16 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')]} 13:37:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:16 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 0x18b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c208a0>, '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 0x1c217a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21c30>, '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': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', '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 13:37:16 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 13:37:16 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 13:37:16 INFO - Using env: {'DISPLAY': ':0', 13:37:16 INFO - 'HOME': '/home/cltbld', 13:37:16 INFO - 'LANG': 'en_US.UTF-8', 13:37:16 INFO - 'LANGUAGE': 'en_US:en', 13:37:16 INFO - 'LOGNAME': 'cltbld', 13:37:16 INFO - 'MAIL': '/var/mail/cltbld', 13:37:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:16 INFO - 'MOZ_NO_REMOTE': '1', 13:37:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:16 INFO - 'NO_EM_RESTART': '1', 13:37:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:16 INFO - 'PWD': '/builds/slave/test', 13:37:16 INFO - 'SHELL': '/bin/bash', 13:37:16 INFO - 'SHLVL': '1', 13:37:16 INFO - 'TERM': 'linux', 13:37:16 INFO - 'TMOUT': '86400', 13:37:16 INFO - 'USER': 'cltbld', 13:37:16 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', 13:37:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:16 INFO - '_': '/tools/buildbot/bin/python'} 13:37:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:37:16 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 13:37:16 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 13:37:16 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 13:37:16 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 13:37:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:37:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:37:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:37:18 INFO - Installing collected packages: mozsystemmonitor 13:37:18 INFO - Running setup.py install for mozsystemmonitor 13:37:18 INFO - Successfully installed mozsystemmonitor 13:37:18 INFO - Cleaning up... 13:37:18 INFO - Return code: 0 13:37:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:18 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 0x18b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c208a0>, '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 0x1c217a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21c30>, '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': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', '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 13:37:18 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 13:37:18 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 13:37:18 INFO - Using env: {'DISPLAY': ':0', 13:37:18 INFO - 'HOME': '/home/cltbld', 13:37:18 INFO - 'LANG': 'en_US.UTF-8', 13:37:18 INFO - 'LANGUAGE': 'en_US:en', 13:37:18 INFO - 'LOGNAME': 'cltbld', 13:37:18 INFO - 'MAIL': '/var/mail/cltbld', 13:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:18 INFO - 'MOZ_NO_REMOTE': '1', 13:37:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:18 INFO - 'NO_EM_RESTART': '1', 13:37:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:18 INFO - 'PWD': '/builds/slave/test', 13:37:18 INFO - 'SHELL': '/bin/bash', 13:37:18 INFO - 'SHLVL': '1', 13:37:18 INFO - 'TERM': 'linux', 13:37:18 INFO - 'TMOUT': '86400', 13:37:18 INFO - 'USER': 'cltbld', 13:37:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', 13:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:18 INFO - '_': '/tools/buildbot/bin/python'} 13:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:18 INFO - Downloading/unpacking jsonschema==2.5.1 13:37:18 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 13:37:18 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 13:37:18 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 13:37:18 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 13:37:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:37:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:37:19 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 13:37:19 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 13:37:19 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 13:37:19 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 13:37:19 INFO - Downloading functools32-3.2.3-2.tar.gz 13:37:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:37:19 INFO - warning: no files found matching '*.txt' 13:37:19 INFO - no previously-included directories found matching 'build' 13:37:19 INFO - no previously-included directories found matching 'dist' 13:37:19 INFO - no previously-included directories found matching '.git*' 13:37:19 INFO - Installing collected packages: jsonschema, functools32 13:37:19 INFO - Running setup.py install for functools32 13:37:19 INFO - warning: no files found matching '*.txt' 13:37:19 INFO - no previously-included directories found matching 'build' 13:37:19 INFO - no previously-included directories found matching 'dist' 13:37:19 INFO - no previously-included directories found matching '.git*' 13:37:19 INFO - Successfully installed jsonschema functools32 13:37:19 INFO - Cleaning up... 13:37:19 INFO - Return code: 0 13:37:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:37:19 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')]} 13:37:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:19 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')]} 13:37:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:19 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 0x18b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c208a0>, '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 0x1c217a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21c30>, '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': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', '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 13:37:19 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 13:37:19 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 13:37:19 INFO - Using env: {'DISPLAY': ':0', 13:37:19 INFO - 'HOME': '/home/cltbld', 13:37:19 INFO - 'LANG': 'en_US.UTF-8', 13:37:19 INFO - 'LANGUAGE': 'en_US:en', 13:37:19 INFO - 'LOGNAME': 'cltbld', 13:37:19 INFO - 'MAIL': '/var/mail/cltbld', 13:37:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:19 INFO - 'MOZ_NO_REMOTE': '1', 13:37:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:19 INFO - 'NO_EM_RESTART': '1', 13:37:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:19 INFO - 'PWD': '/builds/slave/test', 13:37:19 INFO - 'SHELL': '/bin/bash', 13:37:19 INFO - 'SHLVL': '1', 13:37:19 INFO - 'TERM': 'linux', 13:37:19 INFO - 'TMOUT': '86400', 13:37:19 INFO - 'USER': 'cltbld', 13:37:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', 13:37:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:19 INFO - '_': '/tools/buildbot/bin/python'} 13:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:37:20 INFO - Cleaning up... 13:37:20 INFO - Return code: 0 13:37:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:37:20 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')]} 13:37:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:20 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')]} 13:37:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:20 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 0x18b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c208a0>, '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 0x1c217a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21c30>, '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': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', '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 13:37:20 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 13:37:20 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 13:37:20 INFO - Using env: {'DISPLAY': ':0', 13:37:20 INFO - 'HOME': '/home/cltbld', 13:37:20 INFO - 'LANG': 'en_US.UTF-8', 13:37:20 INFO - 'LANGUAGE': 'en_US:en', 13:37:20 INFO - 'LOGNAME': 'cltbld', 13:37:20 INFO - 'MAIL': '/var/mail/cltbld', 13:37:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:20 INFO - 'MOZ_NO_REMOTE': '1', 13:37:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:20 INFO - 'NO_EM_RESTART': '1', 13:37:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:20 INFO - 'PWD': '/builds/slave/test', 13:37:20 INFO - 'SHELL': '/bin/bash', 13:37:20 INFO - 'SHLVL': '1', 13:37:20 INFO - 'TERM': 'linux', 13:37:20 INFO - 'TMOUT': '86400', 13:37:20 INFO - 'USER': 'cltbld', 13:37:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', 13:37:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:20 INFO - '_': '/tools/buildbot/bin/python'} 13:37:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:20 INFO - Downloading/unpacking blobuploader==1.2.4 13:37:20 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 13:37:20 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 13:37:20 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 13:37:20 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 13:37:21 INFO - Downloading blobuploader-1.2.4.tar.gz 13:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:37:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:37:21 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 13:37:21 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 13:37:21 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 13:37:21 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 13:37:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:37:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:37:21 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 13:37:21 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 13:37:21 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 13:37:21 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 13:37:21 INFO - Downloading docopt-0.6.1.tar.gz 13:37:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:37:22 INFO - Installing collected packages: blobuploader, requests, docopt 13:37:22 INFO - Running setup.py install for blobuploader 13:37:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:37:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:37:22 INFO - Running setup.py install for requests 13:37:22 INFO - Running setup.py install for docopt 13:37:22 INFO - Successfully installed blobuploader requests docopt 13:37:22 INFO - Cleaning up... 13:37:22 INFO - Return code: 0 13:37:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:37:22 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')]} 13:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:22 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')]} 13:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:22 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 0x18b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c208a0>, '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 0x1c217a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21c30>, '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': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', '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 13:37:22 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 13:37:22 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 13:37:22 INFO - Using env: {'DISPLAY': ':0', 13:37:22 INFO - 'HOME': '/home/cltbld', 13:37:22 INFO - 'LANG': 'en_US.UTF-8', 13:37:22 INFO - 'LANGUAGE': 'en_US:en', 13:37:22 INFO - 'LOGNAME': 'cltbld', 13:37:22 INFO - 'MAIL': '/var/mail/cltbld', 13:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:22 INFO - 'MOZ_NO_REMOTE': '1', 13:37:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:22 INFO - 'NO_EM_RESTART': '1', 13:37:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:22 INFO - 'PWD': '/builds/slave/test', 13:37:22 INFO - 'SHELL': '/bin/bash', 13:37:22 INFO - 'SHLVL': '1', 13:37:22 INFO - 'TERM': 'linux', 13:37:22 INFO - 'TMOUT': '86400', 13:37:22 INFO - 'USER': 'cltbld', 13:37:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', 13:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:22 INFO - '_': '/tools/buildbot/bin/python'} 13:37:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:37:22 INFO - Running setup.py (path:/tmp/pip-3GH2Br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:37:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:37:22 INFO - Running setup.py (path:/tmp/pip-UFShxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:37:23 INFO - Running setup.py (path:/tmp/pip-Qx_RDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:37:23 INFO - Running setup.py (path:/tmp/pip-f6xOmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:37:23 INFO - Running setup.py (path:/tmp/pip-hqbVAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:37:23 INFO - Running setup.py (path:/tmp/pip-YHhIrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:37:23 INFO - Running setup.py (path:/tmp/pip-dVCPIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:37:23 INFO - Running setup.py (path:/tmp/pip-9_1C4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:37:23 INFO - Running setup.py (path:/tmp/pip-a02b3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:37:23 INFO - Running setup.py (path:/tmp/pip-_ZSE8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:37:23 INFO - Running setup.py (path:/tmp/pip-IH6RUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:37:23 INFO - Running setup.py (path:/tmp/pip-D1hrrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:37:23 INFO - Running setup.py (path:/tmp/pip-z7_l6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:37:23 INFO - Running setup.py (path:/tmp/pip-EKkj9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:23 INFO - Running setup.py (path:/tmp/pip-883vrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:37:23 INFO - Running setup.py (path:/tmp/pip-Rhjnzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:37:24 INFO - Running setup.py (path:/tmp/pip-8nEqvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:37:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:37:24 INFO - Running setup.py install for manifestparser 13:37:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:37:24 INFO - Running setup.py install for mozcrash 13:37:24 INFO - Running setup.py install for mozdebug 13:37:24 INFO - Running setup.py install for mozdevice 13:37:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:37:24 INFO - Running setup.py install for mozfile 13:37:24 INFO - Running setup.py install for mozhttpd 13:37:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:37:24 INFO - Running setup.py install for mozinfo 13:37:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:37:24 INFO - Running setup.py install for mozInstall 13:37:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:37:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:37:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:37:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:37:24 INFO - Running setup.py install for mozleak 13:37:25 INFO - Running setup.py install for mozlog 13:37:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:37:25 INFO - Running setup.py install for moznetwork 13:37:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:37:25 INFO - Running setup.py install for mozprocess 13:37:25 INFO - Running setup.py install for mozprofile 13:37:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:37:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:37:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:37:25 INFO - Running setup.py install for mozrunner 13:37:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:37:25 INFO - Running setup.py install for mozscreenshot 13:37:25 INFO - Running setup.py install for moztest 13:37:25 INFO - Running setup.py install for mozversion 13:37:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:37:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:37:25 INFO - Cleaning up... 13:37:25 INFO - Return code: 0 13:37:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:37: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')]} 13:37:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37: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')]} 13:37:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:25 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 0x18b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c208a0>, '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 0x1c217a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21c30>, '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': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', '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 13:37:25 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 13:37:25 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 13:37:25 INFO - Using env: {'DISPLAY': ':0', 13:37:25 INFO - 'HOME': '/home/cltbld', 13:37:25 INFO - 'LANG': 'en_US.UTF-8', 13:37:25 INFO - 'LANGUAGE': 'en_US:en', 13:37:25 INFO - 'LOGNAME': 'cltbld', 13:37:25 INFO - 'MAIL': '/var/mail/cltbld', 13:37:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:25 INFO - 'MOZ_NO_REMOTE': '1', 13:37:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:25 INFO - 'NO_EM_RESTART': '1', 13:37:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:25 INFO - 'PWD': '/builds/slave/test', 13:37:25 INFO - 'SHELL': '/bin/bash', 13:37:25 INFO - 'SHLVL': '1', 13:37:25 INFO - 'TERM': 'linux', 13:37:25 INFO - 'TMOUT': '86400', 13:37:25 INFO - 'USER': 'cltbld', 13:37:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', 13:37:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:25 INFO - '_': '/tools/buildbot/bin/python'} 13:37:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:37:26 INFO - Running setup.py (path:/tmp/pip-TmwQGs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:37:26 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)) 13:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:37:26 INFO - Running setup.py (path:/tmp/pip-qGRMGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:37:26 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)) 13:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:37:26 INFO - Running setup.py (path:/tmp/pip-KeSZSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:37:26 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)) 13:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:37:26 INFO - Running setup.py (path:/tmp/pip-t6VIz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:37:26 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)) 13:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:37:26 INFO - Running setup.py (path:/tmp/pip-WhasAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:37:26 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)) 13:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:37:26 INFO - Running setup.py (path:/tmp/pip-49Hn78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:37:26 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)) 13:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:37:26 INFO - Running setup.py (path:/tmp/pip-SiA2a4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:37:26 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)) 13:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:37:26 INFO - Running setup.py (path:/tmp/pip-l4U0L1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:37:26 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)) 13:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:37:26 INFO - Running setup.py (path:/tmp/pip-7dMf56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:37:26 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)) 13:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:37:26 INFO - Running setup.py (path:/tmp/pip-nNjqOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:37:26 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)) 13:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:37:26 INFO - Running setup.py (path:/tmp/pip-QV88k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:37:26 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)) 13:37:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:37:26 INFO - Running setup.py (path:/tmp/pip-AtGQ8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:37:27 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)) 13:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:37:27 INFO - Running setup.py (path:/tmp/pip-bRylVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:37:27 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)) 13:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:37:27 INFO - Running setup.py (path:/tmp/pip-2miqiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:37:27 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)) 13:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:27 INFO - Running setup.py (path:/tmp/pip-7JD4Mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:37:27 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)) 13:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:37:27 INFO - Running setup.py (path:/tmp/pip-G0YT6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:37:27 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)) 13:37:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:37:27 INFO - Running setup.py (path:/tmp/pip-3KU3pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:37:27 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)) 13:37:27 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)) 13:37:27 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)) 13:37:27 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)) 13:37:27 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)) 13:37:27 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)) 13:37:27 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)) 13:37:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:37:27 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 13:37:27 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 13:37:27 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 13:37:27 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 13:37:28 INFO - Downloading blessings-1.6.tar.gz 13:37:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:37:28 INFO - Installing collected packages: blessings 13:37:28 INFO - Running setup.py install for blessings 13:37:28 INFO - Successfully installed blessings 13:37:28 INFO - Cleaning up... 13:37:28 INFO - Return code: 0 13:37:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:37:28 INFO - Reading from file tmpfile_stdout 13:37:28 INFO - Current package versions: 13:37:28 INFO - argparse == 1.2.1 13:37:28 INFO - blessings == 1.6 13:37:28 INFO - blobuploader == 1.2.4 13:37:28 INFO - docopt == 0.6.1 13:37:28 INFO - functools32 == 3.2.3-2 13:37:28 INFO - jsonschema == 2.5.1 13:37:28 INFO - manifestparser == 1.1 13:37:28 INFO - mozInstall == 1.13 13:37:28 INFO - mozcrash == 1.0 13:37:28 INFO - mozdebug == 0.1 13:37:28 INFO - mozdevice == 0.51 13:37:28 INFO - mozfile == 1.2 13:37:28 INFO - mozhttpd == 0.7 13:37:28 INFO - mozinfo == 0.10 13:37:28 INFO - mozleak == 0.1 13:37:28 INFO - mozlog == 3.5 13:37:28 INFO - moznetwork == 0.27 13:37:28 INFO - mozprocess == 0.25 13:37:28 INFO - mozprofile == 0.28 13:37:28 INFO - mozrunner == 6.13 13:37:28 INFO - mozscreenshot == 0.1 13:37:28 INFO - mozsystemmonitor == 0.3 13:37:28 INFO - moztest == 0.8 13:37:28 INFO - mozversion == 1.4 13:37:28 INFO - psutil == 3.1.1 13:37:28 INFO - requests == 1.2.3 13:37:28 INFO - wsgiref == 0.1.2 13:37:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:37:28 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')]} 13:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37:28 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')]} 13:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:28 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 0x18b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c208a0>, '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 0x1c217a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21c30>, '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': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', '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 13:37:28 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 13:37:28 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 13:37:28 INFO - Using env: {'DISPLAY': ':0', 13:37:28 INFO - 'HOME': '/home/cltbld', 13:37:28 INFO - 'LANG': 'en_US.UTF-8', 13:37:28 INFO - 'LANGUAGE': 'en_US:en', 13:37:28 INFO - 'LOGNAME': 'cltbld', 13:37:28 INFO - 'MAIL': '/var/mail/cltbld', 13:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:28 INFO - 'MOZ_NO_REMOTE': '1', 13:37:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:28 INFO - 'NO_EM_RESTART': '1', 13:37:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:28 INFO - 'PWD': '/builds/slave/test', 13:37:28 INFO - 'SHELL': '/bin/bash', 13:37:28 INFO - 'SHLVL': '1', 13:37:28 INFO - 'TERM': 'linux', 13:37:28 INFO - 'TMOUT': '86400', 13:37:28 INFO - 'USER': 'cltbld', 13:37:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', 13:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:28 INFO - '_': '/tools/buildbot/bin/python'} 13:37:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:29 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)) 13:37:29 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)) 13:37:29 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)) 13:37:29 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)) 13:37:29 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)) 13:37:29 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)) 13:37:29 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)) 13:37:29 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)) 13:37:29 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)) 13:37:29 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 13:37:29 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 13:37:29 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 13:37:29 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 13:37:29 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 13:37:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 13:37:30 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)) 13:37:30 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)) 13:37:30 INFO - Installing collected packages: simplejson 13:37:30 INFO - Running setup.py install for simplejson 13:37:30 INFO - building 'simplejson._speedups' extension 13:37:30 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 13:37:31 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 13:37:31 INFO - Successfully installed simplejson 13:37:31 INFO - Cleaning up... 13:37:31 INFO - Return code: 0 13:37:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:37: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')]} 13:37:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:37: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')]} 13:37:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:37:31 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 0x18b41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a80a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c23700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c208a0>, '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 0x1c217a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21c30>, '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': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', '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 13:37:31 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 13:37:31 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 13:37:31 INFO - Using env: {'DISPLAY': ':0', 13:37:31 INFO - 'HOME': '/home/cltbld', 13:37:31 INFO - 'LANG': 'en_US.UTF-8', 13:37:31 INFO - 'LANGUAGE': 'en_US:en', 13:37:31 INFO - 'LOGNAME': 'cltbld', 13:37:31 INFO - 'MAIL': '/var/mail/cltbld', 13:37:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:31 INFO - 'MOZ_NO_REMOTE': '1', 13:37:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:31 INFO - 'NO_EM_RESTART': '1', 13:37:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:31 INFO - 'PWD': '/builds/slave/test', 13:37:31 INFO - 'SHELL': '/bin/bash', 13:37:31 INFO - 'SHLVL': '1', 13:37:31 INFO - 'TERM': 'linux', 13:37:31 INFO - 'TMOUT': '86400', 13:37:31 INFO - 'USER': 'cltbld', 13:37:31 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', 13:37:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:31 INFO - '_': '/tools/buildbot/bin/python'} 13:37:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:37:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:37:31 INFO - Cleaning up... 13:37:31 INFO - Return code: 0 13:37:31 INFO - Running post-action listener: _resource_record_post_action 13:37:31 INFO - Running post-action listener: _start_resource_monitoring 13:37:31 INFO - Starting resource monitoring. 13:37:31 INFO - [mozharness: 2017-08-11 20:37:31.655288Z] Finished create-virtualenv step (success) 13:37:31 INFO - [mozharness: 2017-08-11 20:37:31.655802Z] Running install step. 13:37:31 INFO - Running pre-action listener: _resource_record_pre_action 13:37:31 INFO - Running main action method: install 13:37:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:37:31 INFO - Reading from file tmpfile_stdout 13:37:31 INFO - Detecting whether we're running mozinstall >=1.0... 13:37:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:37:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:37:32 INFO - Reading from file tmpfile_stdout 13:37:32 INFO - Output received: 13:37:32 INFO - Usage: mozinstall [options] installer 13:37:32 INFO - Options: 13:37:32 INFO - -h, --help show this help message and exit 13:37:32 INFO - -d DEST, --destination=DEST 13:37:32 INFO - Directory to install application into. [default: 13:37:32 INFO - "/builds/slave/test"] 13:37:32 INFO - --app=APP Application being installed. [default: firefox] 13:37:32 INFO - mkdir: /builds/slave/test/build/application 13:37:32 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'] 13:37:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 13:37:49 INFO - Reading from file tmpfile_stdout 13:37:49 INFO - Output received: 13:37:49 INFO - /builds/slave/test/build/application/firefox/firefox 13:37:49 INFO - Running post-action listener: _resource_record_post_action 13:37:49 INFO - [mozharness: 2017-08-11 20:37:49.944908Z] Finished install step (success) 13:37:49 INFO - [mozharness: 2017-08-11 20:37:49.945118Z] Running setup-mitmproxy step. 13:37:49 INFO - Running pre-action listener: _resource_record_pre_action 13:37:49 INFO - Running main action method: setup_mitmproxy 13:37:49 INFO - Skipping: mitmproxy is not required 13:37:49 INFO - Running post-action listener: _resource_record_post_action 13:37:49 INFO - [mozharness: 2017-08-11 20:37:49.946257Z] Finished setup-mitmproxy step (success) 13:37:49 INFO - [mozharness: 2017-08-11 20:37:49.946475Z] Running run-tests step. 13:37:49 INFO - Running pre-action listener: _resource_record_pre_action 13:37:49 INFO - Running pre-action listener: _set_gcov_prefix 13:37:49 INFO - Running main action method: run_tests 13:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:37:49 INFO - Python 2.7.3 13:37:49 INFO - Return code: 0 13:37:49 INFO - grabbing minidump binary from tooltool 13:37:49 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')]} 13:37:49 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 0x1c208a0>, '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 0x1c217a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c21c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:37:49 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 13:37:49 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 13:37:49 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 13:37:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:37:50 INFO - Return code: 0 13:37:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:37:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:37:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:37:50 INFO - ENV: RUST_BACKTRACE is now full 13:37:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:37:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:37:50 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/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 13:37:50 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/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 13:37:50 INFO - Using env: {'DISPLAY': ':0', 13:37:50 INFO - 'HOME': '/home/cltbld', 13:37:50 INFO - 'LANG': 'en_US.UTF-8', 13:37:50 INFO - 'LANGUAGE': 'en_US:en', 13:37:50 INFO - 'LOGNAME': 'cltbld', 13:37:50 INFO - 'MAIL': '/var/mail/cltbld', 13:37:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:37:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:37:50 INFO - 'MOZ_NO_REMOTE': '1', 13:37:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:37:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:37:50 INFO - 'NO_EM_RESTART': '1', 13:37:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:37:50 INFO - 'PWD': '/builds/slave/test', 13:37:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:37:50 INFO - 'RUST_BACKTRACE': 'full', 13:37:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 13:37:50 INFO - 'SHELL': '/bin/bash', 13:37:50 INFO - 'SHLVL': '1', 13:37:50 INFO - 'STYLO_FORCE_ENABLED': '1', 13:37:50 INFO - 'TERM': 'linux', 13:37:50 INFO - 'TMOUT': '86400', 13:37:50 INFO - 'USER': 'cltbld', 13:37:50 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141', 13:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:37:50 INFO - '_': '/tools/buildbot/bin/python'} 13:37:50 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/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 13:37:50 INFO - mozversion application_buildid: 20170811194712 13:37:50 INFO - mozversion application_changeset: e7dc8329e2d478087314605e8184627489eef636 13:37:50 INFO - mozversion application_display_name: Nightly 13:37:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:37:50 INFO - mozversion application_name: Firefox 13:37:50 INFO - mozversion application_remotingname: firefox 13:37:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 13:37:50 INFO - mozversion application_vendor: Mozilla 13:37:50 INFO - mozversion application_version: 57.0a1 13:37:50 INFO - mozversion platform_buildid: 20170811194712 13:37:50 INFO - mozversion platform_changeset: e7dc8329e2d478087314605e8184627489eef636 13:37:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 13:37:50 INFO - mozversion platform_version: 57.0a1 13:37:50 INFO - using testdate: 1502483870 13:37:50 INFO - actual date: 1502483870 13:37:50 INFO - starting webserver on 'localhost:44426' 13:37:50 INFO - SUITE-START | Running 2 tests 13:37:50 INFO - TEST-START | dromaeo_css 13:37:50 INFO - Initialising browser for dromaeo_css test... 13:37:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44426/getInfo.html -profile /tmp/tmpY4oaVb/profile 13:37:50 INFO - TEST-INFO | started process 13595 (/builds/slave/test/build/application/firefox/firefox http://localhost:44426/getInfo.html) 13:37:56 INFO - TEST-INFO | 13595: exit 0 13:37:56 INFO - Browser initialized. 13:37:56 INFO - Running cycle 1/1 for dromaeo_css test... 13:37:56 INFO - TEST-INFO | started process 13832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpY4oaVb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:57 INFO - PID 13832 | 13:37:57 INFO - PID 13832 | (/builds/slave/test/build/application/firefox/firefox:13885): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:37:57 INFO - PID 13832 | 13:38:07 INFO - PID 13832 | RSS: Main: 167796736 13:38:07 INFO - PID 13832 | 13:41:06 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:44426/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44426/tests/dromaeo/cssquery-ext.html) 13:41:07 INFO - PID 13832 | RSS: Main: 175427584 13:41:07 INFO - PID 13832 | 13:44:09 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:44426/tests/dromaeo/cssquery-ext.html (next: http://localhost:44426/tests/dromaeo/cssquery-jquery.html) 13:44:10 INFO - PID 13832 | RSS: Main: 172716032 13:44:10 INFO - PID 13832 | 13:47:11 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:44426/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44426/tests/dromaeo/cssquery-mootools.html) 13:47:12 INFO - PID 13832 | RSS: Main: 174460928 13:47:12 INFO - PID 13832 | 13:50:14 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:44426/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44426/tests/dromaeo/cssquery-prototype.html) 13:50:14 INFO - PID 13832 | RSS: Main: 173256704 13:50:14 INFO - PID 13832 | 13:53:18 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:44426/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44426/tests/dromaeo/cssquery-yui.html) 13:53:19 INFO - PID 13832 | RSS: Main: 174669824 13:53:19 INFO - PID 13832 | 13:56:21 INFO - PID 13832 | Cycle 1(1): loaded http://localhost:44426/tests/dromaeo/cssquery-yui.html (next: http://localhost:44426/tests/dromaeo/cssquery-dojo.html) 13:56:21 INFO - PID 13832 | RSS: Main: 176750592 13:56:21 INFO - PID 13832 | 13:56:21 INFO - PID 13832 | __start_tp_report 13:56:21 INFO - PID 13832 | _x_x_mozilla_page_load 13:56:21 INFO - PID 13832 | _x_x_mozilla_page_load_details 13:56:21 INFO - PID 13832 | |i|pagename|runs| 13:56:21 INFO - PID 13832 | |0;dojo.html;3146.3549972255682;3161.7944833585816;3174.730147937425;3189.9521507177383;3192.984035079824;6153.323134455206;6232.314445411007;6252.968735156323;6271.216097987752;6299.716512756925;6135.233095863017;6201.627902325864;6210.316865144841;6215.3784621537825;6244.438000579947;5686.31764188297;5690.800821971232;5715.514181294595;5741.368449470576;5831.446012628793;5805.12923061542;5807.954568177726;5829.708514574276;5831.825045248649;5835.183074369592;5707.258056452655;5779.566532510057;5787.13193021046;5791.739371728261;5795.913061304083;123.14840970333292;5250.80205977559;5656.971715141439;5758.222639943596;5777.59556831022;5662.348829884533;5684.8010319639025;5760.82717518471;5764.769409223626;5765.4522820332;6108.267007959073;6146.200993870812;6179.969100154515;6208.627482351028;6266.467350275232;6554.901676474857;6642.501812364092;6657.76697815579;6726.159230096238;6760.290169532177;6604.141461610008;6750.257471678112;6834;6839.487038472134;6844.726210951556;6161.045038019114;6165.630062196283;6169.598976066586;6177.505799536027;6184.412480814315;6879.6560171991205;6882.277360877036;6921.653917304115;6922.896156557656;6945;6583.308752581006;6592.17597800275;6603;6609.20689517261;6620.933790662032;6640.634765087966;6645.634490103091;6740.4270636995425;6748.966255168692;6753.662316884234;6459.773907913201;6638.4689224861895;6642.1033160523675;6704.229013663394;6732.562383445158;6601.768938087144;6639.070530125786;6641.701123449457;6643.40209381158;6648;5413.404525502192;5424.918626220609;5435.537979271806;5436.91844622331;5467.835964921059;4678.134545109166;4684.391029166187;4693.22561777303;4761.880952976203;4783.904321913542;5798.82603521895;5808.3901190375245;5864.44287792659;5875.50058245054;5878.764849406061;6547.607143571401;6670.39966403026;6709.228438729511;6798.76204332846;6810.455163586901;5754.309482862083;5811.186433899257;5839.591228613956;5844.386339434298;5844.649321040666;5928.525717942554;5991.4907232884825;5995.370486098984;6004.939950600526;6023.939760602426;6487.124238227873;6554.934450655433;6590.143281373486;6598.901016484757;6600.471962243105;6706.83232919181;6712.563683360566;6730.125083739083;6809.625470599066;6822.658867056528;6338.176037115146;6437.356264373712;6439.034144878306;6446.226452825504;6581.407673309425;6407.455366293917;6489.772857949949;6493.902591461037;6498.480121590167;6515.641639709862;6668.433183179484;6670.132882725215;6671.432928201158;6678.065070890177;6785.558938668971;6551.246606640107;6556.770513032212;6557.573757705733;6559.672016399257;6561.737530498726;6500.187476565429;6528.836779080561;6597.571157874723;6615.272320044695;6617.239017513048;6340;6366.076918846648;6380.9042864358;6425.678716064272;6429.164208652845;6503.707333170113;6529.118568993125;6572.441342485942;6575.736970521317;6689.063531105747;6228;6316.652584107918;6373.458256048288;6375.649339286384;6423.132877061724 13:56:21 INFO - PID 13832 | |1;ext.html;827.193486350808;870.5864714260726;871.7994861181932;896.453163570222;1162.058732426734;31617.84191079044;32246.83876580617;43335;43483.13033739323;43866.56133438665;42329.15341693172;42807;42840.78579607097;42881.142377152435;42887;7371.631418429098;7845.68617255312;7849.921500784976;7853.136155022943;7857.449978501507;7710.113336966265;7745.070591529025;7746.4190185736015;7825.647845846951;7832.1776213497615;7763.728269510569;7778.961105194466;7819.6872125115215;7864.685412583518;7877;7829.17793631669;7846.097698764658;7853.489523180975;7865.370770338359;7869.252421019994;7738.690452381898;7768.922310776877;7770.689172433096;7772.300492955605;7817.101033381177;37970.62029379726;38028.239435211144;38301;38404;38461.80769096137;3559.341521818472;3578.731595130376;3615.313090512794;3620.275944811022;3626.601073881871;32039;32091.35817283641;32259.35481290361;32275;32310.353792924245;5066.265391518209;5119.25770763241;5122;5141.048905952373;5144.588432925394;197515;197537;199687;199945;200127;50152;50777.238341424905;50809;50815;52774;56141.438585614436;56214.156787648215;56214.156787648215;56245.156322655195;56321.43678563244;15283.541493755205;15515.45695900638;17017.91491042537;17258.13709314529;17294.221760020577;13904.4438222472;14180.149191048364;14184.787228191586;14191.929040354938;14196.361163747657;15092.773608395883;15199.240037998055;15206.315715792594;15268.465603704039;15333.693326133414;5608.803691870765;5653.208550802891;5674.177244299553;5677.403872593401;5683.658980461186;987.7431867714446;997.2470784557613;1002.7844013537125;1004.6835246897203;1008.1682611845257;22336.888315558317;22884;22915.7708422917;23336.416589585395;29728.405431891242;1075.0593230922943;1081.5835903177176;1084.1218612923558;1088.385062439719;1088.9455527223606;12362.949149322229;12477.126601137834;12508.437120329607;12564.497420103093;12632.621021369374;244056;246663;247423;247748;247834;58488.83022339529;58511.414885850594;59057.704711476166;59225;59307.11039334413;1438.0221449414498;1470.6838029823425;1472.1829384691598;1481.5333170051615;1483.5994281543922;27098.593521097595;27739;27994;28325.57511637286;28445.573316400685;39810.20379592334;40047;40173.99565010781;40184.799076004434;40231.396529051504;208653;209073;209941;210334;210340;32518.187045324055;32663.67336326606;32775;32933.67066329306;36286.63713362833;46879.76560117178;47097.2935405976;47269.2909606363;47633.76183119062;47864.282035768796;33428;33441.331173376886;33498.66501334956;33583.328333432706;34532.136696582784;33377.33245335031;33590.664093358755;33782.8310858454;34247.31505369829;34528.48207276943;36136.4579531302;36172.27655446929;36178;36178.09554761152;36394.636053640184;32843.34313313768;33234;34563.30873382569;34982.65017349794;35017;25116.372090697878;25145.371365716004;25258.737063147135;25468.745312546638;25475.853546728526 13:56:21 INFO - PID 13832 | |2;jquery.html;572.1874937588624;579.6232448908206;585.9003969325214;590.4744777148337;597.719072036143;22512.437189070282;22889.313320600366;23301;23322.65016024761;23324.06703731851;26192.476150476978;26672.19983400496;26822.329441763966;26833.463330733375;26862.5970610441;6426.582272152307;6584.473242140617;6586.209654841426;6587.769428070019;6589.472842172615;6289.276733175698;6565.704543295563;6613.470922326226;6620.735170593171;6633.668316584151;6586.604803711769;6587.703553340088;6592.835179120536;6594.4065034146915;6598.175228096488;6552.082708420825;6559.048937904025;6561.671916404161;6565.343465653445;6596.7691130810435;6075.301340345828;6082.391760823926;6122.846928826815;6125.754969801203;6129.570930034899;29701.257468563243;29877.701222987926;30374.69625303763;30886.38227235465;31077.689223107707;1976.090998140857;2012.1448384436703;2012.2554654777825;2022.0496366707623;2023.7773844877051;19860.503487412785;20399.89800051005;20466.795332046637;20524.281650142173;20529;2287.1880482428664;2319.756425575324;2350.9882450587806;2357.834951553392;2364.609839376501;129645;135148;135739;135829;135965;14472.927635361755;15011.474598389004;15371.310020746549;15544.844551554566;15841.287142078403;23565.7643423567;23609.881950590137;23641.40896477602;23725.644115338284;23738.881305593706;10652.786944261072;10721.517531711092;10755.300905441121;10773.791372768721;10923.399213043358;9804.411735295906;9960.850587241197;10053.346532475365;10053.798924021625;10159.542820572944;7732.819011262468;9088.727338179866;9191.402558833654;9546.90453095474;9731.805363892825;2622.632831403605;2642.8017898657677;2720.727927207303;2741.35340597685;2761.613374127624;964.3683387381277;972.3728195314125;982.2436723722693;983.2625530851861;995.7809281958102;18703.690741648225;18708;18884;19296.22815087409;19582.31461898827;1024.533837104116;1025.9025392587841;1036.2021243642353;1036.2073014144187;1046.9685909422728;10398.532066056894;10574.682759517227;10581.206409519316;10590.629327973484;10614.734631634117;469991;471364;473455;475903;478759;116205;117867.41066294785;119322.40338798425;120572.39713801375;120667;1199.976000480003;1211.3646577120992;1233.53125812189;1233.6422437493027;1243.0739099371026;16853.410130645367;21261.149554018284;22186.1125554976;22249.22127725522;22279;62541;63587.364126358145;63824;64281.357186429406;65509.67245163744;73546;74530;74640.62679686784;74703.62648186725;75162.24837751771;12769.170003949714;13182.80225796633;13208.207507549578;14933.10401375921;15379.23103844781;23551;24479.877600611882;24642.137525186532;24785.1325203617;24817.62773558362;18249;18596.721049184;18751;18887.433376998713;18925.43223703291;16955.152242387583;17163.91418042902;17226.65546689034;17559.972447115575;17689.38087166943;18046.819531804515;19207.8079219206;19303.4208973731;19444.611107778048;19567.70648440246;14684.559463216121;14704.338304776526;14710.190939498003;14784.852151478777;14807.25963701789;18434.723479147557;18491.260349585868;18548.629027419647;18707.719384208976;18794.872307661582 13:56:21 INFO - PID 13832 | |3;mootools.html;1318.8615195404482;1362.4618275781067;1365.5015919189498;1373.0388727890472;1393.2685340196397;13877.653058673526;14419.567412977627;14460.987730858844;14541;14559.344829482672;14009.859901400983;14523.854761452383;14526.983111182222;14529;14553.272336383165;2645.65606471159;2685.1541764344265;2691.7981151413724;2692.9192124236206;2694.5015172193107;2670.052131493311;2699.6625421822273;2702.7567518923292;2703.3917368592106;2706.039356028611;2595.0917178987297;2633.1705512763515;2637.9604305935427;2638.4854953284116;2638.6569745933;2482.453860150764;2503.6369726389753;2607.4785042991384;2614.228802503247;2616.3589920469417;2542.224621490445;2542.7711505964367;2555.9616605750743;2578.419855532509;2578.419855532509;13640.317984100755;13711.657208569866;13758.793618095737;13777.104488208335;13784.517541886085;7407.333339999426;7648.694052237904;7706.306432421109;7708.267714567107;7711.961440192763;4970.726610036447;5128.640825220403;5140.563052140573;5171.663841850268;5278.261043453919;1902.3722171683312;1904.266857259951;1913.645975494524;1924.7946133233916;1979.6436641404541;21466;21991.99999999984;22706.432339191488;22839.42901427461;23237.53524929492;6510.902336464862;6575.145231119924;6575.4410875076155;6648.401643852077;6682.3317668232785;18414.723779143325;18474.63050738978;18482.722759158623;18486.81513184878;18487.445376638723;7410.184879663233;7630.8092297693;7644.312011918954;7661.195574464712;7669.578173200416;6781.050652908597;6862.3823855852215;6898.689558969859;6977.79066628002;6978.511504194657;5208.609354298443;5338.172583249602;5344.412114667383;5365.463453654604;5371.221172929903;1631.331154226785;1649.125963239485;1654.1315809200266;1667.9166041697868;1691.644754601523;870.6343335798853;882.2324577617386;883.0992387764444;885.2519620920312;897.2552781191596;7300.9634951825965;7305.232950540223;7306.465642215195;7316.6341682915645;7332.633368331562;710.499098135813;719.7085180501905;722.4040166862254;725.804032911111;727.9526830755984;5179.766910489037;5365.892682146336;5438.510534051954;5449.727513624303;5522.061249587499;18972.241110355706;19285.807141928683;19303.613927721646;19561.315353962542;19687.606247874963;18703.625927481375;18784.436466906016;19042;19447.902760486108;19451.80548194528;9536;9797.020297970146;10369.74075648115;10574.101201397814;10752.247342686092;8248.958755206186;8347.332213423033;8393.118722534045;8454;8485.448445851;15493.457728979432;16008.8399116012;16384.180790960643;16454.259558320144;16460.588485287484;16552.503424897273;16588.917055414644;16989.320427182774;17370.82629173692;17473.301067957138;11045.613403530839;11218.046466050477;11240.775184496428;11243.156763242952;11246.493907774333;12683.619491415273;12754.808677870025;12822.935885320514;12869.35653217354;12924.870751292367;10385.221108416748;10572.312799667998;10615.628453004108;10686.198535109743;10849.45752712377;10367.170626349724;10478.109360704426;10500.212484063573;10516.474176291002;10800.567977281135;9207.263418926605;9303.813923721624;9344.486053267136;9347.485888276211;9353.719388418358;7143.321384468467;7219.60292183935;7230.566166030055;7239.8552028960175;7289.343959043712;7247;7250.129984401906;7321.084864391951;7322.267773222635;7438.070241219848 13:56:21 INFO - PID 13832 | |4;prototype.html;497.19854983756306;498.26257139433636;519.1719207863457;522.6419902366879;528.5296086483029;6146.385361463851;6177.629342239463;6205.348438413969;6231.3145553989025;6318.336574659657;6083.604565703226;6096.847578810532;6156.507479401648;6160.537959653033;6203.255609326887;5125.974370128144;5172.431032586413;5187.1181899077155;5199.844004679866;5206.7917283308625;4940.629452791037;5025.623078269126;5083.618728595352;5093.923591146136;5144.22836574515;5056.84829455117;5079.1365467870555;5105.770240339194;5109.846704598868;5150.072986862382;5069.504496173619;5097.337346145015;5112.693238405707;5145.897082058356;5187.273781670569;4689.62483001359;4764.118638051971;4780.832670856504;4801.8079276828885;4828.927566086511;5975.820725378246;6004.697416420995;6021.879562408771;6101.389861013908;6129.20320358355;5958.553108516879;5963.197297270276;5972.850678733023;5996.760129594811;6003.579749417542;6556.344365563453;6560.573562718408;6583.637899915503;6586.27550969393;6669.799906002828;5249.42256351801;5263.710495922723;5280.392754833205;5303.549198318147;5335.62564658727;6630.535862489628;6675.833104172386;6726.730930762764;6800.31996800316;6938.895916561256;5480.91778623321;5485.780568777284;5506.559475241971;5515.779368825202;5531.865967476658;5575.69333686643;5581.023320918823;5617;5624.62522486513;5629.211910332557;6016.939830601726;6038.215032045806;6046.758129674852;6060.787872424444;6081.847953801191;6561.770338038145;6601.438877695449;6618.900716489256;6641.173677238798;6643.837328467499;1905.561720804223;1935.5838494723703;1945.9318923837882;1961.8234358907766;1962.5486138188296;1380.9435781627064;1444.4799872046055;1447.5946734914241;1454.4909281751302;1460.2477027566963;5727.914081288784;5733.856653583611;5807.274090738658;5816.5055970243;5823.796167134215;6604.702788374535;6693.196816382066;6696.732130714717;6718.596884186964;6791.660416979132;5709.115087161496;5810.1865738796605;5818.5054270386645;5820.285568689375;5876.764929402776;3545.680888719976;3566.2154326048226;3601.85592576294;3605.603383627799;3625.3655610268097;6527.738890444424;6557.278699343068;6562.770303039466;6581.967090164519;6612.933870661232;6843.8973415398805;6858.6570671467225;6890.311873590902;6969.930300697029;7014.579125252501;6546.312637173219;6573.778848364363;6586.143801305895;6597.340265973365;6626.271110177877;6669.633170175687;6697.598144111369;6768.0863083485065;6828.556143850634;6856.040154378491;6639.767608133692;6660.433863121495;6662.800115996528;6681.697069071679;6684.43182329488;6465.256495502889;6486.189226346707;6535.183102112236;6591.6374599397495;6600.0099985002635;4984.675996060245;5009.198528235464;5049.2173713074535;5059.19052951526;5066.341375621293;6406.935930640634;6543.803685889431;6667.66661666905;6672.899906501503;6702.262751097278;6515.771947981798;6530.183727034121;6544.770933017321;6556.98366753154;6557.475401967736;6456.354364563506;6494.577852439576;6502.967485162544;6527.801377325171;6584.242812076673;6433.613983161025;6445.774397896051;6499.28507864144;6506.512011599054;6546.934530654633;6542.607443553402;6587.374199451045;6615.709936562324;6689.230738464944;6691.364320389555;6309.779157729641;6356.396142366468;6356.9193237148875;6375.58558693702;6397.38547720555 13:56:21 INFO - PID 13832 | |5;yui.html;903.1465265324272;912.3841407050242;917.2570218123317;921.6635927886324;935.752025713186;18544.258229670813;19533.609327813436;19543.609127817435;19598.70601940972;20311.289104881333;21260.14959401622;21512.139514419403;21719.239826606074;21850.89074554629;21951.780482195172;1025.5436330832763;1064.6060957445757;1065.1638463805914;1065.2383545764776;1070.2561719604878;1016.3495362967707;1058.5554067291716;1063.7978784031009;1067.215596536545;1075.8278675411937;1054.8312270036795;1055.6938487838518;1056.2183983851933;1056.466484425368;1112.2158877991037;1053.1048608682597;1053.1048608682636;1055.430067763407;1060.48566445274;1108.7616162525055;769.9422543309274;770.0874463760462;770.3375097416217;780.7618676303725;811.5333683132163;19127.713084303745;19382.4185274442;19393.709094363596;19437.22251109954;20840.374788756362;21593;22192.667109993363;22637.660435093323;22648.88675556628;22696.773032269797;15737.606559835982;15786.447474338343;15949.44176953801;15960.76058859118;16126.75809862853;3678.0437086357474;3687.0413692439893;3687.4100143977103;3697.9075523112137;3703.759255648374;128308;128859;129243;132558.99999999904;134251;15545;15842.44551440694;16034.358625655077;16343.918280408521;16508.17459127039;31389.215269618442;31886.84056579702;32531.837340813618;32652.183695407806;32816.1795955103;7951.085625153066;8312.293455056268;8425.157484251526;8785.428947118417;8962.73111806647;4283.293256612624;4370.7159034662645;4398.274284743045;4400.075984043387;4404.581564751344;5024.321716568216;5046.091703493333;5103.209002604603;5240;5277.498637629419;1045.17953406577;1058.9046985771317;1068.1828401273033;1073.6456969200144;1078.9028987391173;652.1456891472187;671.9428848547831;679.1239301301266;682.6518475577491;690.8721886451023;11128.944355278334;11531.596394126165;11641.88358116408;11909.166358354832;12457.0034397248;683.0778449093684;687.5737043033251;712.1987763765763;723.7177500774702;726.0525014855558;5437.293151890229;5531.363893152258;5775.797847075416;5854.648721076749;5859.20900678403;109228.4538577302;109847.45076274728;113712;116485;120873;96946.51526742321;103431.4828425853;103823;106577;108028.45985770178;87964;89690.10369837595;90655.09344906466;91658.08341916629;93324.53337733404;11974.401279936143;12187.634370968884;12192.451339689558;12320.568780092653;12348.197367171106;40670.59329406668;41305.793471032455;41605.58394416138;41886.79056604698;41914.1617167661;51758;53246.73376633092;74214;74908;76701;19706.60586788285;19765.901170494057;19985;20004.59990800205;20040.198392064736;21255.57488850245;22740.4314892129;23084.769152308934;23213.18753843675;23395.298141055795;17855.107244637456;18704.251829926652;19221.32725354606;19620.901895491003;20038;18598.628027439645;18671.81328186701;19059.237630494627;20218;20386.184552617728;18008.549786255448;18691.719624205376;18797.530061748566;19794.90102549478;19903.800961990775;13483.258420786951;14536.781948270573;14605.269736513344;14643;14769.852301477278;14820.258987050389;14850.77723834165;14897.851021489647;14939.925300373428;14977.101373917163 13:56:21 INFO - PID 13832 | __end_tp_report 13:56:21 INFO - PID 13832 | __start_cc_report 13:56:21 INFO - PID 13832 | _x_x_mozilla_cycle_collect,384 13:56:21 INFO - PID 13832 | __end_cc_report 13:56:21 INFO - PID 13832 | __startTimestamp1502484981431__endTimestamp 13:56:21 INFO - PID 13832 | 13:56:21 INFO - PID 13832 | ------- Summary: start ------- 13:56:21 INFO - PID 13832 | Number of tests: 6 13:56:21 INFO - PID 13832 | 13:56:21 INFO - PID 13832 | [#0] dojo.html Cycles:165 Average:6132.34 Median:6380.90 stddev:856.25 (13.4%) stddev-sans-first:826.21 13:56:21 INFO - PID 13832 | Values: 3146.4 3161.8 3174.7 3190.0 3193.0 6153.3 6232.3 6253.0 6271.2 6299.7 6135.2 6201.6 6210.3 6215.4 6244.4 5686.3 5690.8 5715.5 5741.4 5831.4 5805.1 5808.0 5829.7 5831.8 5835.2 5707.3 5779.6 5787.1 5791.7 5795.9 123.1 5250.8 5657.0 5758.2 5777.6 5662.3 5684.8 5760.8 5764.8 5765.5 6108.3 6146.2 6180.0 6208.6 6266.5 6554.9 6642.5 6657.8 6726.2 6760.3 6604.1 6750.3 6834.0 6839.5 6844.7 6161.0 6165.6 6169.6 6177.5 6184.4 6879.7 6882.3 6921.7 6922.9 6945.0 6583.3 6592.2 6603.0 6609.2 6620.9 6640.6 6645.6 6740.4 6749.0 6753.7 6459.8 6638.5 6642.1 6704.2 6732.6 6601.8 6639.1 6641.7 6643.4 6648.0 5413.4 5424.9 5435.5 5436.9 5467.8 4678.1 4684.4 4693.2 4761.9 4783.9 5798.8 5808.4 5864.4 5875.5 5878.8 6547.6 6670.4 6709.2 6798.8 6810.5 5754.3 5811.2 5839.6 5844.4 5844.6 5928.5 5991.5 5995.4 6004.9 6023.9 6487.1 6554.9 6590.1 6598.9 6600.5 6706.8 6712.6 6730.1 6809.6 6822.7 6338.2 6437.4 6439.0 6446.2 6581.4 6407.5 6489.8 6493.9 6498.5 6515.6 6668.4 6670.1 6671.4 6678.1 6785.6 6551.2 6556.8 6557.6 6559.7 6561.7 6500.2 6528.8 6597.6 6615.3 6617.2 6340.0 6366.1 6380.9 6425.7 6429.2 6503.7 6529.1 6572.4 6575.7 6689.1 6228.0 6316.7 6373.5 6375.6 6423.1 13:56:21 INFO - PID 13832 | 13:56:21 INFO - PID 13832 | [#1] ext.html Cycles:180 Average:39614.12 Median:3569.04 stddev:56932.74 (1595.2%) stddev-sans-first:57017.96 13:56:21 INFO - PID 13832 | Values: 827.2 870.6 871.8 896.5 1162.1 31617.8 32246.8 43335.0 43483.1 43866.6 42329.2 42807.0 42840.8 42881.1 42887.0 7371.6 7845.7 7849.9 7853.1 7857.4 7710.1 7745.1 7746.4 7825.6 7832.2 7763.7 7779.0 7819.7 7864.7 7877.0 7829.2 7846.1 7853.5 7865.4 7869.3 7738.7 7768.9 7770.7 7772.3 7817.1 37970.6 38028.2 38301.0 38404.0 38461.8 3559.3 3578.7 3615.3 3620.3 3626.6 32039.0 32091.4 32259.4 32275.0 32310.4 5066.3 5119.3 5122.0 5141.0 5144.6 197515.0 197537.0 199687.0 199945.0 200127.0 50152.0 50777.2 50809.0 50815.0 52774.0 56141.4 56214.2 56214.2 56245.2 56321.4 15283.5 15515.5 17017.9 17258.1 17294.2 13904.4 14180.1 14184.8 14191.9 14196.4 15092.8 15199.2 15206.3 15268.5 15333.7 5608.8 5653.2 5674.2 5677.4 5683.7 987.7 997.2 1002.8 1004.7 1008.2 22336.9 22884.0 22915.8 23336.4 29728.4 1075.1 1081.6 1084.1 1088.4 1088.9 12362.9 12477.1 12508.4 12564.5 12632.6 244056.0 246663.0 247423.0 247748.0 247834.0 58488.8 58511.4 59057.7 59225.0 59307.1 1438.0 1470.7 1472.2 1481.5 1483.6 27098.6 27739.0 27994.0 28325.6 28445.6 39810.2 40047.0 40174.0 40184.8 40231.4 208653.0 209073.0 209941.0 210334.0 210340.0 32518.2 32663.7 32775.0 32933.7 36286.6 46879.8 47097.3 47269.3 47633.8 47864.3 33428.0 33441.3 33498.7 33583.3 34532.1 33377.3 33590.7 33782.8 34247.3 34528.5 36136.5 36172.3 36178.0 36178.1 36394.6 32843.3 33234.0 34563.3 34982.7 35017.0 25116.4 25145.4 25258.7 25468.7 25475.9 13:56:21 INFO - PID 13832 | 13:56:21 INFO - PID 13832 | [#2] jquery.html Cycles:180 Average:34876.54 Median:12604.53 stddev:80129.81 (635.7%) stddev-sans-first:80313.20 13:56:21 INFO - PID 13832 | Values: 572.2 579.6 585.9 590.5 597.7 22512.4 22889.3 23301.0 23322.7 23324.1 26192.5 26672.2 26822.3 26833.5 26862.6 6426.6 6584.5 6586.2 6587.8 6589.5 6289.3 6565.7 6613.5 6620.7 6633.7 6586.6 6587.7 6592.8 6594.4 6598.2 6552.1 6559.0 6561.7 6565.3 6596.8 6075.3 6082.4 6122.8 6125.8 6129.6 29701.3 29877.7 30374.7 30886.4 31077.7 1976.1 2012.1 2012.3 2022.0 2023.8 19860.5 20399.9 20466.8 20524.3 20529.0 2287.2 2319.8 2351.0 2357.8 2364.6 129645.0 135148.0 135739.0 135829.0 135965.0 14472.9 15011.5 15371.3 15544.8 15841.3 23565.8 23609.9 23641.4 23725.6 23738.9 10652.8 10721.5 10755.3 10773.8 10923.4 9804.4 9960.9 10053.3 10053.8 10159.5 7732.8 9088.7 9191.4 9546.9 9731.8 2622.6 2642.8 2720.7 2741.4 2761.6 964.4 972.4 982.2 983.3 995.8 18703.7 18708.0 18884.0 19296.2 19582.3 1024.5 1025.9 1036.2 1036.2 1047.0 10398.5 10574.7 10581.2 10590.6 10614.7 469991.0 471364.0 473455.0 475903.0 478759.0 116205.0 117867.4 119322.4 120572.4 120667.0 1200.0 1211.4 1233.5 1233.6 1243.1 16853.4 21261.1 22186.1 22249.2 22279.0 62541.0 63587.4 63824.0 64281.4 65509.7 73546.0 74530.0 74640.6 74703.6 75162.2 12769.2 13182.8 13208.2 14933.1 15379.2 23551.0 24479.9 24642.1 24785.1 24817.6 18249.0 18596.7 18751.0 18887.4 18925.4 16955.2 17163.9 17226.7 17560.0 17689.4 18046.8 19207.8 19303.4 19444.6 19567.7 14684.6 14704.3 14710.2 14784.9 14807.3 18434.7 18491.3 18548.6 18707.7 18794.9 13:56:21 INFO - PID 13832 | 13:56:21 INFO - PID 13832 | [#3] mootools.html Cycles:180 Average:8729.19 Median:2601.29 stddev:5943.38 (228.5%) stddev-sans-first:5933.96 13:56:21 INFO - PID 13832 | Values: 1318.9 1362.5 1365.5 1373.0 1393.3 13877.7 14419.6 14461.0 14541.0 14559.3 14009.9 14523.9 14527.0 14529.0 14553.3 2645.7 2685.2 2691.8 2692.9 2694.5 2670.1 2699.7 2702.8 2703.4 2706.0 2595.1 2633.2 2638.0 2638.5 2638.7 2482.5 2503.6 2607.5 2614.2 2616.4 2542.2 2542.8 2556.0 2578.4 2578.4 13640.3 13711.7 13758.8 13777.1 13784.5 7407.3 7648.7 7706.3 7708.3 7712.0 4970.7 5128.6 5140.6 5171.7 5278.3 1902.4 1904.3 1913.6 1924.8 1979.6 21466.0 21992.0 22706.4 22839.4 23237.5 6510.9 6575.1 6575.4 6648.4 6682.3 18414.7 18474.6 18482.7 18486.8 18487.4 7410.2 7630.8 7644.3 7661.2 7669.6 6781.1 6862.4 6898.7 6977.8 6978.5 5208.6 5338.2 5344.4 5365.5 5371.2 1631.3 1649.1 1654.1 1667.9 1691.6 870.6 882.2 883.1 885.3 897.3 7301.0 7305.2 7306.5 7316.6 7332.6 710.5 719.7 722.4 725.8 728.0 5179.8 5365.9 5438.5 5449.7 5522.1 18972.2 19285.8 19303.6 19561.3 19687.6 18703.6 18784.4 19042.0 19447.9 19451.8 9536.0 9797.0 10369.7 10574.1 10752.2 8249.0 8347.3 8393.1 8454.0 8485.4 15493.5 16008.8 16384.2 16454.3 16460.6 16552.5 16588.9 16989.3 17370.8 17473.3 11045.6 11218.0 11240.8 11243.2 11246.5 12683.6 12754.8 12822.9 12869.4 12924.9 10385.2 10572.3 10615.6 10686.2 10849.5 10367.2 10478.1 10500.2 10516.5 10800.6 9207.3 9303.8 9344.5 9347.5 9353.7 7143.3 7219.6 7230.6 7239.9 7289.3 7247.0 7250.1 7321.1 7322.3 7438.1 13:56:21 INFO - PID 13832 | 13:56:21 INFO - PID 13832 | [#4] prototype.html Cycles:180 Average:5610.63 Median:6115.30 stddev:1501.84 (24.6%) stddev-sans-first:1456.19 13:56:21 INFO - PID 13832 | Values: 497.2 498.3 519.2 522.6 528.5 6146.4 6177.6 6205.3 6231.3 6318.3 6083.6 6096.8 6156.5 6160.5 6203.3 5126.0 5172.4 5187.1 5199.8 5206.8 4940.6 5025.6 5083.6 5093.9 5144.2 5056.8 5079.1 5105.8 5109.8 5150.1 5069.5 5097.3 5112.7 5145.9 5187.3 4689.6 4764.1 4780.8 4801.8 4828.9 5975.8 6004.7 6021.9 6101.4 6129.2 5958.6 5963.2 5972.9 5996.8 6003.6 6556.3 6560.6 6583.6 6586.3 6669.8 5249.4 5263.7 5280.4 5303.5 5335.6 6630.5 6675.8 6726.7 6800.3 6938.9 5480.9 5485.8 5506.6 5515.8 5531.9 5575.7 5581.0 5617.0 5624.6 5629.2 6016.9 6038.2 6046.8 6060.8 6081.8 6561.8 6601.4 6618.9 6641.2 6643.8 1905.6 1935.6 1945.9 1961.8 1962.5 1380.9 1444.5 1447.6 1454.5 1460.2 5727.9 5733.9 5807.3 5816.5 5823.8 6604.7 6693.2 6696.7 6718.6 6791.7 5709.1 5810.2 5818.5 5820.3 5876.8 3545.7 3566.2 3601.9 3605.6 3625.4 6527.7 6557.3 6562.8 6582.0 6612.9 6843.9 6858.7 6890.3 6969.9 7014.6 6546.3 6573.8 6586.1 6597.3 6626.3 6669.6 6697.6 6768.1 6828.6 6856.0 6639.8 6660.4 6662.8 6681.7 6684.4 6465.3 6486.2 6535.2 6591.6 6600.0 4984.7 5009.2 5049.2 5059.2 5066.3 6406.9 6543.8 6667.7 6672.9 6702.3 6515.8 6530.2 6544.8 6557.0 6557.5 6456.4 6494.6 6503.0 6527.8 6584.2 6433.6 6445.8 6499.3 6506.5 6546.9 6542.6 6587.4 6615.7 6689.2 6691.4 6309.8 6356.4 6356.9 6375.6 6397.4 13:56:21 INFO - PID 13832 | 13:56:21 INFO - PID 13832 | [#5] yui.html Cycles:180 Average:24535.57 Median:19944.40 stddev:33360.95 (167.3%) stddev-sans-first:33407.34 13:56:21 INFO - PID 13832 | Values: 903.1 912.4 917.3 921.7 935.8 18544.3 19533.6 19543.6 19598.7 20311.3 21260.1 21512.1 21719.2 21850.9 21951.8 1025.5 1064.6 1065.2 1065.2 1070.3 1016.3 1058.6 1063.8 1067.2 1075.8 1054.8 1055.7 1056.2 1056.5 1112.2 1053.1 1053.1 1055.4 1060.5 1108.8 769.9 770.1 770.3 780.8 811.5 19127.7 19382.4 19393.7 19437.2 20840.4 21593.0 22192.7 22637.7 22648.9 22696.8 15737.6 15786.4 15949.4 15960.8 16126.8 3678.0 3687.0 3687.4 3697.9 3703.8 128308.0 128859.0 129243.0 132559.0 134251.0 15545.0 15842.4 16034.4 16343.9 16508.2 31389.2 31886.8 32531.8 32652.2 32816.2 7951.1 8312.3 8425.2 8785.4 8962.7 4283.3 4370.7 4398.3 4400.1 4404.6 5024.3 5046.1 5103.2 5240.0 5277.5 1045.2 1058.9 1068.2 1073.6 1078.9 652.1 671.9 679.1 682.7 690.9 11128.9 11531.6 11641.9 11909.2 12457.0 683.1 687.6 712.2 723.7 726.1 5437.3 5531.4 5775.8 5854.6 5859.2 109228.5 109847.5 113712.0 116485.0 120873.0 96946.5 103431.5 103823.0 106577.0 108028.5 87964.0 89690.1 90655.1 91658.1 93324.5 11974.4 12187.6 12192.5 12320.6 12348.2 40670.6 41305.8 41605.6 41886.8 41914.2 51758.0 53246.7 74214.0 74908.0 76701.0 19706.6 19765.9 19985.0 20004.6 20040.2 21255.6 22740.4 23084.8 23213.2 23395.3 17855.1 18704.3 19221.3 19620.9 20038.0 18598.6 18671.8 19059.2 20218.0 20386.2 18008.5 18691.7 18797.5 19794.9 19903.8 13483.3 14536.8 14605.3 14643.0 14769.9 14820.3 14850.8 14897.9 14939.9 14977.1 13:56:21 INFO - PID 13832 | -------- Summary: end -------- 13:56:21 INFO - PID 13832 | 13:56:22 INFO - TEST-INFO | 13832: exit 0 13:56:22 INFO - TEST-OK | dromaeo_css | took 1111818ms 13:56:22 INFO - TEST-START | kraken 13:56:22 INFO - Initialising browser for kraken test... 13:56:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44426/getInfo.html -profile /tmp/tmpOgpdvH/profile 13:56:22 INFO - TEST-INFO | started process 14203 (/builds/slave/test/build/application/firefox/firefox http://localhost:44426/getInfo.html) 13:56:27 INFO - TEST-INFO | 14203: exit 0 13:56:27 INFO - Browser initialized. 13:56:27 INFO - Running cycle 1/1 for kraken test... 13:56:27 INFO - TEST-INFO | started process 14444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOgpdvH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 13:56:28 INFO - PID 14444 | 13:56:28 INFO - PID 14444 | (/builds/slave/test/build/application/firefox/firefox:14498): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 13:56:28 INFO - PID 14444 | 13:56:39 INFO - PID 14444 | RSS: Main: 168108032 13:56:39 INFO - PID 14444 | 13:56:41 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44426/tests/kraken/driver.html?testName=audio-beat-detection) 13:56:42 INFO - PID 14444 | RSS: Main: 174321664 13:56:42 INFO - PID 14444 | 13:56:45 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44426/tests/kraken/driver.html?testName=audio-dft) 13:56:46 INFO - PID 14444 | RSS: Main: 174882816 13:56:46 INFO - PID 14444 | 13:56:49 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44426/tests/kraken/driver.html?testName=audio-fft) 13:56:49 INFO - PID 14444 | RSS: Main: 169783296 13:56:49 INFO - PID 14444 | 13:56:52 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44426/tests/kraken/driver.html?testName=audio-oscillator) 13:56:52 INFO - PID 14444 | RSS: Main: 170659840 13:56:52 INFO - PID 14444 | 13:56:55 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44426/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:56:55 INFO - PID 14444 | RSS: Main: 170151936 13:56:55 INFO - PID 14444 | 13:56:58 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44426/tests/kraken/driver.html?testName=imaging-darkroom) 13:56:59 INFO - PID 14444 | RSS: Main: 172572672 13:56:59 INFO - PID 14444 | 13:57:03 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44426/tests/kraken/driver.html?testName=imaging-desaturate) 13:57:03 INFO - PID 14444 | RSS: Main: 172498944 13:57:03 INFO - PID 14444 | 13:57:06 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44426/tests/kraken/driver.html?testName=json-parse-financial) 13:57:07 INFO - PID 14444 | RSS: Main: 173686784 13:57:07 INFO - PID 14444 | 13:57:08 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44426/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:57:09 INFO - PID 14444 | RSS: Main: 173387776 13:57:09 INFO - PID 14444 | 13:57:11 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44426/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:57:11 INFO - PID 14444 | RSS: Main: 173748224 13:57:11 INFO - PID 14444 | 13:57:14 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44426/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:57:14 INFO - PID 14444 | RSS: Main: 173703168 13:57:14 INFO - PID 14444 | 13:57:17 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:57:18 INFO - PID 14444 | RSS: Main: 174276608 13:57:18 INFO - PID 14444 | 13:57:21 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:57:21 INFO - PID 14444 | RSS: Main: 174075904 13:57:21 INFO - PID 14444 | 13:57:23 INFO - PID 14444 | Cycle 1(1): loaded http://localhost:44426/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44426/tests/kraken/driver.html?testName=ai-astar) 13:57:24 INFO - PID 14444 | RSS: Main: 175099904 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | __start_tp_report 13:57:24 INFO - PID 14444 | _x_x_mozilla_page_load 13:57:24 INFO - PID 14444 | _x_x_mozilla_page_load_details 13:57:24 INFO - PID 14444 | |i|pagename|runs| 13:57:24 INFO - PID 14444 | |0;ai-astar;98;113;109;107;114;111;109;103;107;108 13:57:24 INFO - PID 14444 | |1;audio-beat-detection;151;117;147;166;120;149;152;116;174;127 13:57:24 INFO - PID 14444 | |2;audio-dft;165;173;170;170;163;175;169;169;166;164 13:57:24 INFO - PID 14444 | |3;audio-fft;90;76;76;172;75;76;76;76;177;77 13:57:24 INFO - PID 14444 | |4;audio-oscillator;81;84;128;79;79;79;131;83;80;127 13:57:24 INFO - PID 14444 | |5;imaging-gaussian-blur;113;114;121;114;114;125;121;124;114;114 13:57:24 INFO - PID 14444 | |6;imaging-darkroom;150;149;152;153;150;157;152;150;152;156 13:57:24 INFO - PID 14444 | |7;imaging-desaturate;94;93;99;99;94;94;94;94;96;94 13:57:24 INFO - PID 14444 | |8;json-parse-financial;57;61;60;58;65;56;57;56;56;56 13:57:24 INFO - PID 14444 | |9;json-stringify-tinderbox;54;60;53;54;58;54;56;55;55;56 13:57:24 INFO - PID 14444 | |10;stanford-crypto-aes;80;81;78;90;78;81;78;89;83;77 13:57:24 INFO - PID 14444 | |11;stanford-crypto-ccm;123;136;128;126;124;132;122;128;126;179 13:57:24 INFO - PID 14444 | |12;stanford-crypto-pbkdf2;174;177;178;172;185;187;173;192;175;173 13:57:24 INFO - PID 14444 | |13;stanford-crypto-sha256-iterative;70;68;75;66;66;77;68;71;70;69 13:57:24 INFO - PID 14444 | __end_tp_report 13:57:24 INFO - PID 14444 | __start_cc_report 13:57:24 INFO - PID 14444 | _x_x_mozilla_cycle_collect,975 13:57:24 INFO - PID 14444 | __end_cc_report 13:57:24 INFO - PID 14444 | __startTimestamp1502485044056__endTimestamp 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | ------- Summary: start ------- 13:57:24 INFO - PID 14444 | Number of tests: 14 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.00 stddev:4.70 (4.3%) stddev-sans-first:3.35 13:57:24 INFO - PID 14444 | Values: 98.0 113.0 109.0 107.0 114.0 111.0 109.0 103.0 107.0 108.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#1] audio-beat-detection Cycles:10 Average:141.90 Median:150.00 stddev:20.72 (13.8%) stddev-sans-first:21.72 13:57:24 INFO - PID 14444 | Values: 151.0 117.0 147.0 166.0 120.0 149.0 152.0 116.0 174.0 127.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#2] audio-dft Cycles:10 Average:168.40 Median:169.50 stddev:3.89 (2.3%) stddev-sans-first:3.93 13:57:24 INFO - PID 14444 | Values: 165.0 173.0 170.0 170.0 163.0 175.0 169.0 169.0 166.0 164.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#3] audio-fft Cycles:10 Average:97.10 Median:76.00 stddev:41.05 (54.0%) stddev-sans-first:43.46 13:57:24 INFO - PID 14444 | Values: 90.0 76.0 76.0 172.0 75.0 76.0 76.0 76.0 177.0 77.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:79.50 stddev:23.24 (29.2%) stddev-sans-first:24.09 13:57:24 INFO - PID 14444 | Values: 81.0 84.0 128.0 79.0 79.0 79.0 131.0 83.0 80.0 127.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:4.77 (4.1%) stddev-sans-first:4.78 13:57:24 INFO - PID 14444 | Values: 113.0 114.0 121.0 114.0 114.0 125.0 121.0 124.0 114.0 114.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#6] imaging-darkroom Cycles:10 Average:152.10 Median:152.00 stddev:2.64 (1.7%) stddev-sans-first:2.69 13:57:24 INFO - PID 14444 | Values: 150.0 149.0 152.0 153.0 150.0 157.0 152.0 150.0 152.0 156.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.00 stddev:2.18 (2.3%) stddev-sans-first:2.28 13:57:24 INFO - PID 14444 | Values: 94.0 93.0 99.0 99.0 94.0 94.0 94.0 94.0 96.0 94.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:57.50 stddev:2.97 (5.2%) stddev-sans-first:3.12 13:57:24 INFO - PID 14444 | Values: 57.0 61.0 60.0 58.0 65.0 56.0 57.0 56.0 56.0 56.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.50 stddev:2.12 (3.8%) stddev-sans-first:2.18 13:57:24 INFO - PID 14444 | Values: 54.0 60.0 53.0 54.0 58.0 54.0 56.0 55.0 55.0 56.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#10] stanford-crypto-aes Cycles:10 Average:81.50 Median:81.00 stddev:4.60 (5.7%) stddev-sans-first:4.85 13:57:24 INFO - PID 14444 | Values: 80.0 81.0 78.0 90.0 78.0 81.0 78.0 89.0 83.0 77.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#11] stanford-crypto-ccm Cycles:10 Average:132.40 Median:128.00 stddev:16.91 (13.2%) stddev-sans-first:17.59 13:57:24 INFO - PID 14444 | Values: 123.0 136.0 128.0 126.0 124.0 132.0 122.0 128.0 126.0 179.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:177.50 stddev:6.95 (3.9%) stddev-sans-first:7.17 13:57:24 INFO - PID 14444 | Values: 174.0 177.0 178.0 172.0 185.0 187.0 173.0 192.0 175.0 173.0 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:3.59 (5.1%) stddev-sans-first:3.81 13:57:24 INFO - PID 14444 | Values: 70.0 68.0 75.0 66.0 66.0 77.0 68.0 71.0 70.0 69.0 13:57:24 INFO - PID 14444 | -------- Summary: end -------- 13:57:24 INFO - PID 14444 | 13:57:24 INFO - PID 14444 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 13:57:24 INFO - TEST-INFO | 14444: exit 0 13:57:24 INFO - TEST-OK | kraken | took 62661ms 13:57:24 INFO - SUITE-END | took 1174s 13:57:25 INFO - Completed test suite (00:19:34) 13:57:25 INFO - javascript benchmark 13:57:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8611.169838020656, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.3549972255682, 3161.7944833585816, 3174.730147937425, 3189.9521507177383, 3192.984035079824, 6153.323134455206, 6232.314445411007, 6252.968735156323, 6271.216097987752, 6299.716512756925, 6135.233095863017, 6201.627902325864, 6210.316865144841, 6215.3784621537825, 6244.438000579947, 5686.31764188297, 5690.800821971232, 5715.514181294595, 5741.368449470576, 5831.446012628793, 5805.12923061542, 5807.954568177726, 5829.708514574276, 5831.825045248649, 5835.183074369592, 5707.258056452655, 5779.566532510057, 5787.13193021046, 5791.739371728261, 5795.913061304083, 123.14840970333292, 5250.80205977559, 5656.971715141439, 5758.222639943596, 5777.59556831022, 5662.348829884533, 5684.8010319639025, 5760.82717518471, 5764.769409223626, 5765.4522820332, 6108.267007959073, 6146.200993870812, 6179.969100154515, 6208.627482351028, 6266.467350275232, 6554.901676474857, 6642.501812364092, 6657.76697815579, 6726.159230096238, 6760.290169532177, 6604.141461610008, 6750.257471678112, 6834.0, 6839.487038472134, 6844.726210951556, 6161.045038019114, 6165.630062196283, 6169.598976066586, 6177.505799536027, 6184.412480814315, 6879.6560171991205, 6882.277360877036, 6921.653917304115, 6922.896156557656, 6945.0, 6583.308752581006, 6592.17597800275, 6603.0, 6609.20689517261, 6620.933790662032, 6640.634765087966, 6645.634490103091, 6740.4270636995425, 6748.966255168692, 6753.662316884234, 6459.773907913201, 6638.4689224861895, 6642.1033160523675, 6704.229013663394, 6732.562383445158, 6601.768938087144, 6639.070530125786, 6641.701123449457, 6643.40209381158, 6648.0, 5413.404525502192, 5424.918626220609, 5435.537979271806, 5436.91844622331, 5467.835964921059, 4678.134545109166, 4684.391029166187, 4693.22561777303, 4761.880952976203, 4783.904321913542, 5798.82603521895, 5808.3901190375245, 5864.44287792659, 5875.50058245054, 5878.764849406061, 6547.607143571401, 6670.39966403026, 6709.228438729511, 6798.76204332846, 6810.455163586901, 5754.309482862083, 5811.186433899257, 5839.591228613956, 5844.386339434298, 5844.649321040666, 5928.525717942554, 5991.4907232884825, 5995.370486098984, 6004.939950600526, 6023.939760602426, 6487.124238227873, 6554.934450655433, 6590.143281373486, 6598.901016484757, 6600.471962243105, 6706.83232919181, 6712.563683360566, 6730.125083739083, 6809.625470599066, 6822.658867056528, 6338.176037115146, 6437.356264373712, 6439.034144878306, 6446.226452825504, 6581.407673309425, 6407.455366293917, 6489.772857949949, 6493.902591461037, 6498.480121590167, 6515.641639709862, 6668.433183179484, 6670.132882725215, 6671.432928201158, 6678.065070890177, 6785.558938668971, 6551.246606640107, 6556.770513032212, 6557.573757705733, 6559.672016399257, 6561.737530498726, 6500.187476565429, 6528.836779080561, 6597.571157874723, 6615.272320044695, 6617.239017513048, 6340.0, 6366.076918846648, 6380.9042864358, 6425.678716064272, 6429.164208652845, 6503.707333170113, 6529.118568993125, 6572.441342485942, 6575.736970521317, 6689.063531105747, 6228.0, 6316.652584107918, 6373.458256048288, 6375.649339286384, 6423.132877061724], "value": 6072.409189313709, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.193486350808, 870.5864714260726, 871.7994861181932, 896.453163570222, 1162.058732426734, 31617.84191079044, 32246.83876580617, 43335.0, 43483.13033739323, 43866.56133438665, 42329.15341693172, 42807.0, 42840.78579607097, 42881.142377152435, 42887.0, 7371.631418429098, 7845.68617255312, 7849.921500784976, 7853.136155022943, 7857.449978501507, 7710.113336966265, 7745.070591529025, 7746.4190185736015, 7825.647845846951, 7832.1776213497615, 7763.728269510569, 7778.961105194466, 7819.6872125115215, 7864.685412583518, 7877.0, 7829.17793631669, 7846.097698764658, 7853.489523180975, 7865.370770338359, 7869.252421019994, 7738.690452381898, 7768.922310776877, 7770.689172433096, 7772.300492955605, 7817.101033381177, 37970.62029379726, 38028.239435211144, 38301.0, 38404.0, 38461.80769096137, 3559.341521818472, 3578.731595130376, 3615.313090512794, 3620.275944811022, 3626.601073881871, 32039.0, 32091.35817283641, 32259.35481290361, 32275.0, 32310.353792924245, 5066.265391518209, 5119.25770763241, 5122.0, 5141.048905952373, 5144.588432925394, 197515.0, 197537.0, 199687.0, 199945.0, 200127.0, 50152.0, 50777.238341424905, 50809.0, 50815.0, 52774.0, 56141.438585614436, 56214.156787648215, 56214.156787648215, 56245.156322655195, 56321.43678563244, 15283.541493755205, 15515.45695900638, 17017.91491042537, 17258.13709314529, 17294.221760020577, 13904.4438222472, 14180.149191048364, 14184.787228191586, 14191.929040354938, 14196.361163747657, 15092.773608395883, 15199.240037998055, 15206.315715792594, 15268.465603704039, 15333.693326133414, 5608.803691870765, 5653.208550802891, 5674.177244299553, 5677.403872593401, 5683.658980461186, 987.7431867714446, 997.2470784557613, 1002.7844013537125, 1004.6835246897203, 1008.1682611845257, 22336.888315558317, 22884.0, 22915.7708422917, 23336.416589585395, 29728.405431891242, 1075.0593230922943, 1081.5835903177176, 1084.1218612923558, 1088.385062439719, 1088.9455527223606, 12362.949149322229, 12477.126601137834, 12508.437120329607, 12564.497420103093, 12632.621021369374, 244056.0, 246663.0, 247423.0, 247748.0, 247834.0, 58488.83022339529, 58511.414885850594, 59057.704711476166, 59225.0, 59307.11039334413, 1438.0221449414498, 1470.6838029823425, 1472.1829384691598, 1481.5333170051615, 1483.5994281543922, 27098.593521097595, 27739.0, 27994.0, 28325.57511637286, 28445.573316400685, 39810.20379592334, 40047.0, 40173.99565010781, 40184.799076004434, 40231.396529051504, 208653.0, 209073.0, 209941.0, 210334.0, 210340.0, 32518.187045324055, 32663.67336326606, 32775.0, 32933.67066329306, 36286.63713362833, 46879.76560117178, 47097.2935405976, 47269.2909606363, 47633.76183119062, 47864.282035768796, 33428.0, 33441.331173376886, 33498.66501334956, 33583.328333432706, 34532.136696582784, 33377.33245335031, 33590.664093358755, 33782.8310858454, 34247.31505369829, 34528.48207276943, 36136.4579531302, 36172.27655446929, 36178.0, 36178.09554761152, 36394.636053640184, 32843.34313313768, 33234.0, 34563.30873382569, 34982.65017349794, 35017.0, 25116.372090697878, 25145.371365716004, 25258.737063147135, 25468.745312546638, 25475.853546728526], "value": 17819.077176681356, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.1874937588624, 579.6232448908206, 585.9003969325214, 590.4744777148337, 597.719072036143, 22512.437189070282, 22889.313320600366, 23301.0, 23322.65016024761, 23324.06703731851, 26192.476150476978, 26672.19983400496, 26822.329441763966, 26833.463330733375, 26862.5970610441, 6426.582272152307, 6584.473242140617, 6586.209654841426, 6587.769428070019, 6589.472842172615, 6289.276733175698, 6565.704543295563, 6613.470922326226, 6620.735170593171, 6633.668316584151, 6586.604803711769, 6587.703553340088, 6592.835179120536, 6594.4065034146915, 6598.175228096488, 6552.082708420825, 6559.048937904025, 6561.671916404161, 6565.343465653445, 6596.7691130810435, 6075.301340345828, 6082.391760823926, 6122.846928826815, 6125.754969801203, 6129.570930034899, 29701.257468563243, 29877.701222987926, 30374.69625303763, 30886.38227235465, 31077.689223107707, 1976.090998140857, 2012.1448384436703, 2012.2554654777825, 2022.0496366707623, 2023.7773844877051, 19860.503487412785, 20399.89800051005, 20466.795332046637, 20524.281650142173, 20529.0, 2287.1880482428664, 2319.756425575324, 2350.9882450587806, 2357.834951553392, 2364.609839376501, 129645.0, 135148.0, 135739.0, 135829.0, 135965.0, 14472.927635361755, 15011.474598389004, 15371.310020746549, 15544.844551554566, 15841.287142078403, 23565.7643423567, 23609.881950590137, 23641.40896477602, 23725.644115338284, 23738.881305593706, 10652.786944261072, 10721.517531711092, 10755.300905441121, 10773.791372768721, 10923.399213043358, 9804.411735295906, 9960.850587241197, 10053.346532475365, 10053.798924021625, 10159.542820572944, 7732.819011262468, 9088.727338179866, 9191.402558833654, 9546.90453095474, 9731.805363892825, 2622.632831403605, 2642.8017898657677, 2720.727927207303, 2741.35340597685, 2761.613374127624, 964.3683387381277, 972.3728195314125, 982.2436723722693, 983.2625530851861, 995.7809281958102, 18703.690741648225, 18708.0, 18884.0, 19296.22815087409, 19582.31461898827, 1024.533837104116, 1025.9025392587841, 1036.2021243642353, 1036.2073014144187, 1046.9685909422728, 10398.532066056894, 10574.682759517227, 10581.206409519316, 10590.629327973484, 10614.734631634117, 469991.0, 471364.0, 473455.0, 475903.0, 478759.0, 116205.0, 117867.41066294785, 119322.40338798425, 120572.39713801375, 120667.0, 1199.976000480003, 1211.3646577120992, 1233.53125812189, 1233.6422437493027, 1243.0739099371026, 16853.410130645367, 21261.149554018284, 22186.1125554976, 22249.22127725522, 22279.0, 62541.0, 63587.364126358145, 63824.0, 64281.357186429406, 65509.67245163744, 73546.0, 74530.0, 74640.62679686784, 74703.62648186725, 75162.24837751771, 12769.170003949714, 13182.80225796633, 13208.207507549578, 14933.10401375921, 15379.23103844781, 23551.0, 24479.877600611882, 24642.137525186532, 24785.1325203617, 24817.62773558362, 18249.0, 18596.721049184, 18751.0, 18887.433376998713, 18925.43223703291, 16955.152242387583, 17163.91418042902, 17226.65546689034, 17559.972447115575, 17689.38087166943, 18046.819531804515, 19207.8079219206, 19303.4208973731, 19444.611107778048, 19567.70648440246, 14684.559463216121, 14704.338304776526, 14710.190939498003, 14784.852151478777, 14807.25963701789, 18434.723479147557, 18491.260349585868, 18548.629027419647, 18707.719384208976, 18794.872307661582], "value": 12184.823887922248, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.8615195404482, 1362.4618275781067, 1365.5015919189498, 1373.0388727890472, 1393.2685340196397, 13877.653058673526, 14419.567412977627, 14460.987730858844, 14541.0, 14559.344829482672, 14009.859901400983, 14523.854761452383, 14526.983111182222, 14529.0, 14553.272336383165, 2645.65606471159, 2685.1541764344265, 2691.7981151413724, 2692.9192124236206, 2694.5015172193107, 2670.052131493311, 2699.6625421822273, 2702.7567518923292, 2703.3917368592106, 2706.039356028611, 2595.0917178987297, 2633.1705512763515, 2637.9604305935427, 2638.4854953284116, 2638.6569745933, 2482.453860150764, 2503.6369726389753, 2607.4785042991384, 2614.228802503247, 2616.3589920469417, 2542.224621490445, 2542.7711505964367, 2555.9616605750743, 2578.419855532509, 2578.419855532509, 13640.317984100755, 13711.657208569866, 13758.793618095737, 13777.104488208335, 13784.517541886085, 7407.333339999426, 7648.694052237904, 7706.306432421109, 7708.267714567107, 7711.961440192763, 4970.726610036447, 5128.640825220403, 5140.563052140573, 5171.663841850268, 5278.261043453919, 1902.3722171683312, 1904.266857259951, 1913.645975494524, 1924.7946133233916, 1979.6436641404541, 21466.0, 21991.99999999984, 22706.432339191488, 22839.42901427461, 23237.53524929492, 6510.902336464862, 6575.145231119924, 6575.4410875076155, 6648.401643852077, 6682.3317668232785, 18414.723779143325, 18474.63050738978, 18482.722759158623, 18486.81513184878, 18487.445376638723, 7410.184879663233, 7630.8092297693, 7644.312011918954, 7661.195574464712, 7669.578173200416, 6781.050652908597, 6862.3823855852215, 6898.689558969859, 6977.79066628002, 6978.511504194657, 5208.609354298443, 5338.172583249602, 5344.412114667383, 5365.463453654604, 5371.221172929903, 1631.331154226785, 1649.125963239485, 1654.1315809200266, 1667.9166041697868, 1691.644754601523, 870.6343335798853, 882.2324577617386, 883.0992387764444, 885.2519620920312, 897.2552781191596, 7300.9634951825965, 7305.232950540223, 7306.465642215195, 7316.6341682915645, 7332.633368331562, 710.499098135813, 719.7085180501905, 722.4040166862254, 725.804032911111, 727.9526830755984, 5179.766910489037, 5365.892682146336, 5438.510534051954, 5449.727513624303, 5522.061249587499, 18972.241110355706, 19285.807141928683, 19303.613927721646, 19561.315353962542, 19687.606247874963, 18703.625927481375, 18784.436466906016, 19042.0, 19447.902760486108, 19451.80548194528, 9536.0, 9797.020297970146, 10369.74075648115, 10574.101201397814, 10752.247342686092, 8248.958755206186, 8347.332213423033, 8393.118722534045, 8454.0, 8485.448445851, 15493.457728979432, 16008.8399116012, 16384.180790960643, 16454.259558320144, 16460.588485287484, 16552.503424897273, 16588.917055414644, 16989.320427182774, 17370.82629173692, 17473.301067957138, 11045.613403530839, 11218.046466050477, 11240.775184496428, 11243.156763242952, 11246.493907774333, 12683.619491415273, 12754.808677870025, 12822.935885320514, 12869.35653217354, 12924.870751292367, 10385.221108416748, 10572.312799667998, 10615.628453004108, 10686.198535109743, 10849.45752712377, 10367.170626349724, 10478.109360704426, 10500.212484063573, 10516.474176291002, 10800.567977281135, 9207.263418926605, 9303.813923721624, 9344.486053267136, 9347.485888276211, 9353.719388418358, 7143.321384468467, 7219.60292183935, 7230.566166030055, 7239.8552028960175, 7289.343959043712, 7247.0, 7250.129984401906, 7321.084864391951, 7322.267773222635, 7438.070241219848], "value": 6351.805194517485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.19854983756306, 498.26257139433636, 519.1719207863457, 522.6419902366879, 528.5296086483029, 6146.385361463851, 6177.629342239463, 6205.348438413969, 6231.3145553989025, 6318.336574659657, 6083.604565703226, 6096.847578810532, 6156.507479401648, 6160.537959653033, 6203.255609326887, 5125.974370128144, 5172.431032586413, 5187.1181899077155, 5199.844004679866, 5206.7917283308625, 4940.629452791037, 5025.623078269126, 5083.618728595352, 5093.923591146136, 5144.22836574515, 5056.84829455117, 5079.1365467870555, 5105.770240339194, 5109.846704598868, 5150.072986862382, 5069.504496173619, 5097.337346145015, 5112.693238405707, 5145.897082058356, 5187.273781670569, 4689.62483001359, 4764.118638051971, 4780.832670856504, 4801.8079276828885, 4828.927566086511, 5975.820725378246, 6004.697416420995, 6021.879562408771, 6101.389861013908, 6129.20320358355, 5958.553108516879, 5963.197297270276, 5972.850678733023, 5996.760129594811, 6003.579749417542, 6556.344365563453, 6560.573562718408, 6583.637899915503, 6586.27550969393, 6669.799906002828, 5249.42256351801, 5263.710495922723, 5280.392754833205, 5303.549198318147, 5335.62564658727, 6630.535862489628, 6675.833104172386, 6726.730930762764, 6800.31996800316, 6938.895916561256, 5480.91778623321, 5485.780568777284, 5506.559475241971, 5515.779368825202, 5531.865967476658, 5575.69333686643, 5581.023320918823, 5617.0, 5624.62522486513, 5629.211910332557, 6016.939830601726, 6038.215032045806, 6046.758129674852, 6060.787872424444, 6081.847953801191, 6561.770338038145, 6601.438877695449, 6618.900716489256, 6641.173677238798, 6643.837328467499, 1905.561720804223, 1935.5838494723703, 1945.9318923837882, 1961.8234358907766, 1962.5486138188296, 1380.9435781627064, 1444.4799872046055, 1447.5946734914241, 1454.4909281751302, 1460.2477027566963, 5727.914081288784, 5733.856653583611, 5807.274090738658, 5816.5055970243, 5823.796167134215, 6604.702788374535, 6693.196816382066, 6696.732130714717, 6718.596884186964, 6791.660416979132, 5709.115087161496, 5810.1865738796605, 5818.5054270386645, 5820.285568689375, 5876.764929402776, 3545.680888719976, 3566.2154326048226, 3601.85592576294, 3605.603383627799, 3625.3655610268097, 6527.738890444424, 6557.278699343068, 6562.770303039466, 6581.967090164519, 6612.933870661232, 6843.8973415398805, 6858.6570671467225, 6890.311873590902, 6969.930300697029, 7014.579125252501, 6546.312637173219, 6573.778848364363, 6586.143801305895, 6597.340265973365, 6626.271110177877, 6669.633170175687, 6697.598144111369, 6768.0863083485065, 6828.556143850634, 6856.040154378491, 6639.767608133692, 6660.433863121495, 6662.800115996528, 6681.697069071679, 6684.43182329488, 6465.256495502889, 6486.189226346707, 6535.183102112236, 6591.6374599397495, 6600.0099985002635, 4984.675996060245, 5009.198528235464, 5049.2173713074535, 5059.19052951526, 5066.341375621293, 6406.935930640634, 6543.803685889431, 6667.66661666905, 6672.899906501503, 6702.262751097278, 6515.771947981798, 6530.183727034121, 6544.770933017321, 6556.98366753154, 6557.475401967736, 6456.354364563506, 6494.577852439576, 6502.967485162544, 6527.801377325171, 6584.242812076673, 6433.613983161025, 6445.774397896051, 6499.28507864144, 6506.512011599054, 6546.934530654633, 6542.607443553402, 6587.374199451045, 6615.709936562324, 6689.230738464944, 6691.364320389555, 6309.779157729641, 6356.396142366468, 6356.9193237148875, 6375.58558693702, 6397.38547720555], "value": 5179.294924033647, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.1465265324272, 912.3841407050242, 917.2570218123317, 921.6635927886324, 935.752025713186, 18544.258229670813, 19533.609327813436, 19543.609127817435, 19598.70601940972, 20311.289104881333, 21260.14959401622, 21512.139514419403, 21719.239826606074, 21850.89074554629, 21951.780482195172, 1025.5436330832763, 1064.6060957445757, 1065.1638463805914, 1065.2383545764776, 1070.2561719604878, 1016.3495362967707, 1058.5554067291716, 1063.7978784031009, 1067.215596536545, 1075.8278675411937, 1054.8312270036795, 1055.6938487838518, 1056.2183983851933, 1056.466484425368, 1112.2158877991037, 1053.1048608682597, 1053.1048608682636, 1055.430067763407, 1060.48566445274, 1108.7616162525055, 769.9422543309274, 770.0874463760462, 770.3375097416217, 780.7618676303725, 811.5333683132163, 19127.713084303745, 19382.4185274442, 19393.709094363596, 19437.22251109954, 20840.374788756362, 21593.0, 22192.667109993363, 22637.660435093323, 22648.88675556628, 22696.773032269797, 15737.606559835982, 15786.447474338343, 15949.44176953801, 15960.76058859118, 16126.75809862853, 3678.0437086357474, 3687.0413692439893, 3687.4100143977103, 3697.9075523112137, 3703.759255648374, 128308.0, 128859.0, 129243.0, 132558.99999999904, 134251.0, 15545.0, 15842.44551440694, 16034.358625655077, 16343.918280408521, 16508.17459127039, 31389.215269618442, 31886.84056579702, 32531.837340813618, 32652.183695407806, 32816.1795955103, 7951.085625153066, 8312.293455056268, 8425.157484251526, 8785.428947118417, 8962.73111806647, 4283.293256612624, 4370.7159034662645, 4398.274284743045, 4400.075984043387, 4404.581564751344, 5024.321716568216, 5046.091703493333, 5103.209002604603, 5240.0, 5277.498637629419, 1045.17953406577, 1058.9046985771317, 1068.1828401273033, 1073.6456969200144, 1078.9028987391173, 652.1456891472187, 671.9428848547831, 679.1239301301266, 682.6518475577491, 690.8721886451023, 11128.944355278334, 11531.596394126165, 11641.88358116408, 11909.166358354832, 12457.0034397248, 683.0778449093684, 687.5737043033251, 712.1987763765763, 723.7177500774702, 726.0525014855558, 5437.293151890229, 5531.363893152258, 5775.797847075416, 5854.648721076749, 5859.20900678403, 109228.4538577302, 109847.45076274728, 113712.0, 116485.0, 120873.0, 96946.51526742321, 103431.4828425853, 103823.0, 106577.0, 108028.45985770178, 87964.0, 89690.10369837595, 90655.09344906466, 91658.08341916629, 93324.53337733404, 11974.401279936143, 12187.634370968884, 12192.451339689558, 12320.568780092653, 12348.197367171106, 40670.59329406668, 41305.793471032455, 41605.58394416138, 41886.79056604698, 41914.1617167661, 51758.0, 53246.73376633092, 74214.0, 74908.0, 76701.0, 19706.60586788285, 19765.901170494057, 19985.0, 20004.59990800205, 20040.198392064736, 21255.57488850245, 22740.4314892129, 23084.769152308934, 23213.18753843675, 23395.298141055795, 17855.107244637456, 18704.251829926652, 19221.32725354606, 19620.901895491003, 20038.0, 18598.628027439645, 18671.81328186701, 19059.237630494627, 20218.0, 20386.184552617728, 18008.549786255448, 18691.719624205376, 18797.530061748566, 19794.90102549478, 19903.800961990775, 13483.258420786951, 14536.781948270573, 14605.269736513344, 14643.0, 14769.852301477278, 14820.258987050389, 14850.77723834165, 14897.851021489647, 14939.925300373428, 14977.101373917163], "value": 9399.662716690495, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 113.0, 109.0, 107.0, 114.0, 111.0, 109.0, 103.0, 107.0, 108.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 117.0, 147.0, 166.0, 120.0, 149.0, 152.0, 116.0, 174.0, 127.0], "value": 141.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 173.0, 170.0, 170.0, 163.0, 175.0, 169.0, 169.0, 166.0, 164.0], "value": 168.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 76.0, 76.0, 172.0, 75.0, 76.0, 76.0, 76.0, 177.0, 77.0], "value": 97.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 128.0, 79.0, 79.0, 79.0, 131.0, 83.0, 80.0, 127.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 121.0, 114.0, 114.0, 125.0, 121.0, 124.0, 114.0, 114.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 152.0, 153.0, 150.0, 157.0, 152.0, 150.0, 152.0, 156.0], "value": 152.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 99.0, 99.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 60.0, 58.0, 65.0, 56.0, 57.0, 56.0, 56.0, 56.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 60.0, 53.0, 54.0, 58.0, 54.0, 56.0, 55.0, 55.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 78.0, 90.0, 78.0, 81.0, 78.0, 89.0, 83.0, 77.0], "value": 81.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 136.0, 128.0, 126.0, 124.0, 132.0, 122.0, 128.0, 126.0, 179.0], "value": 132.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 177.0, 178.0, 172.0, 185.0, 187.0, 173.0, 192.0, 175.0, 173.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 75.0, 66.0, 66.0, 77.0, 68.0, 71.0, 70.0, 69.0], "value": 70.0, "unit": "score"}]}]} 13:57:25 INFO - Return code: 0 13:57:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:57:25 INFO - # TBPL SUCCESS # 13:57:25 INFO - Running post-action listener: _package_coverage_data 13:57:25 INFO - Running post-action listener: _resource_record_post_action 13:57:25 INFO - [mozharness: 2017-08-11 20:57:25.316464Z] Finished run-tests step (success) 13:57:25 INFO - Running post-run listener: _resource_record_post_run 13:57:25 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 433299456; Read time: 172; Write time: 316600 13:57:25 INFO - TinderboxPrint: CPU usage
13.2% 13:57:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 172 13:57:25 INFO - TinderboxPrint: I/O write bytes / time
433,299,456 / 316,600 13:57:25 INFO - TinderboxPrint: CPU idle
8,257.3 (86.8%) 13:57:25 INFO - TinderboxPrint: CPU user
1,203.7 (12.7%) 13:57:25 INFO - TinderboxPrint: Swap in / out
0 / 0 13:57:25 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106196992; Read time: 0; Write time: 99860 13:57:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 13:57:25 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 326078464; Read time: 172; Write time: 216688 13:57:25 INFO - Running post-run listener: _upload_blobber_files 13:57:25 INFO - Blob upload gear active. 13:57:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:57:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:57:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:57:26 INFO - (blobuploader) - INFO - Open directory for files ... 13:57:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:57:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:57:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:57:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:57:27 INFO - (blobuploader) - INFO - Done attempting. 13:57:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:57:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:57:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:57:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:57:30 INFO - (blobuploader) - INFO - Done attempting. 13:57:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:57:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:57:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:57:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:57:31 INFO - (blobuploader) - INFO - Done attempting. 13:57:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:57:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:57:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:57:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:57:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:57:31 INFO - (blobuploader) - INFO - Done attempting. 13:57:31 INFO - (blobuploader) - INFO - Iteration through files over. 13:57:31 INFO - Return code: 0 13:57:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:57:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:57:31 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecdda7785a896a4c68884ea80f2019dba1e77ca1fdc8d9501ddb140cf331cd2abe7fc44c5a6c3dfb5865c6ff53e30a01323fe96fed0462793c2b935b20f06e6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63446d3819a9924a1d5b888ce6f97075bc7ee3d005533966d226098a6e382bbeeda822be5fc80a4f4007113877013f9791e16cc8d3c3272169fd2af0068b43de", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e5647b33a7ded90e66a9d549679ef0aed1037eadd61c9304710d7b07ef76fc4b99a26757d1a1267e281f8c90bb19ccdb12e33df286208bd4a600b7d4e327762", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/167f333fd08b8af776ae631890cf34fae5ddb4b82045aadea022250f4c8154b91145f9189280edcae93b55f0d71d725bf15c255dadefd5d3ecad7177a69f4fb1"} 13:57:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:57:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:57:31 INFO - Contents: 13:57:31 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecdda7785a896a4c68884ea80f2019dba1e77ca1fdc8d9501ddb140cf331cd2abe7fc44c5a6c3dfb5865c6ff53e30a01323fe96fed0462793c2b935b20f06e6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63446d3819a9924a1d5b888ce6f97075bc7ee3d005533966d226098a6e382bbeeda822be5fc80a4f4007113877013f9791e16cc8d3c3272169fd2af0068b43de", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e5647b33a7ded90e66a9d549679ef0aed1037eadd61c9304710d7b07ef76fc4b99a26757d1a1267e281f8c90bb19ccdb12e33df286208bd4a600b7d4e327762", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/167f333fd08b8af776ae631890cf34fae5ddb4b82045aadea022250f4c8154b91145f9189280edcae93b55f0d71d725bf15c255dadefd5d3ecad7177a69f4fb1"} 13:57:31 INFO - Running post-run listener: copy_logs_to_upload_dir 13:57:31 INFO - Copying logs to upload dir... 13:57:31 INFO - mkdir: /builds/slave/test/build/upload/logs 13:57:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.945601 ========= master_lag: -0.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-08-11 13:57:31.633130) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 13:57:31.638035) ========= 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=20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141 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/ecdda7785a896a4c68884ea80f2019dba1e77ca1fdc8d9501ddb140cf331cd2abe7fc44c5a6c3dfb5865c6ff53e30a01323fe96fed0462793c2b935b20f06e6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63446d3819a9924a1d5b888ce6f97075bc7ee3d005533966d226098a6e382bbeeda822be5fc80a4f4007113877013f9791e16cc8d3c3272169fd2af0068b43de", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e5647b33a7ded90e66a9d549679ef0aed1037eadd61c9304710d7b07ef76fc4b99a26757d1a1267e281f8c90bb19ccdb12e33df286208bd4a600b7d4e327762", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/167f333fd08b8af776ae631890cf34fae5ddb4b82045aadea022250f4c8154b91145f9189280edcae93b55f0d71d725bf15c255dadefd5d3ecad7177a69f4fb1"} build_url:https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/RpnxFEWaSluJ4sP8X5FZcg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ecdda7785a896a4c68884ea80f2019dba1e77ca1fdc8d9501ddb140cf331cd2abe7fc44c5a6c3dfb5865c6ff53e30a01323fe96fed0462793c2b935b20f06e6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63446d3819a9924a1d5b888ce6f97075bc7ee3d005533966d226098a6e382bbeeda822be5fc80a4f4007113877013f9791e16cc8d3c3272169fd2af0068b43de", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8e5647b33a7ded90e66a9d549679ef0aed1037eadd61c9304710d7b07ef76fc4b99a26757d1a1267e281f8c90bb19ccdb12e33df286208bd4a600b7d4e327762", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/167f333fd08b8af776ae631890cf34fae5ddb4b82045aadea022250f4c8154b91145f9189280edcae93b55f0d71d725bf15c255dadefd5d3ecad7177a69f4fb1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-11 13:57:31.665673) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:57:31.666019) ========= 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=20e666a3d4cfbb71505a330e000001b4-1502483798.562873-1282973141 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-11 13:57:31.750626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 13:57:31.750952) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-11 13:57:31.751255) ========= ========= Total master_lag: 0.03 =========