builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1502732970.78 results: success (0) revision: 6213fec03a47275d8fcbf79b951547e3993d677f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:30.776607) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:30.777004) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:30.777292) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:30.793348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:30.793629) ========= 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=cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 10:49:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-08-14 10:49:30 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154385 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:30.986458) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:30.986738) ========= 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=cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023194 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:31.047952) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:31.048253) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6213fec03a47275d8fcbf79b951547e3993d677f --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 6213fec03a47275d8fcbf79b951547e3993d677f --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=cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 10:49:31,034 truncating revision to first 12 chars 2017-08-14 10:49:31,034 Setting DEBUG logging. 2017-08-14 10:49:31,034 attempt 1/10 2017-08-14 10:49:31,034 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6213fec03a47?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 10:49:31,383 unpacking tar archive at: mozilla-central-6213fec03a47/testing/mozharness/ program finished with exit code 0 elapsedTime=0.633139 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:31.705748) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:31.706033) ========= script_repo_revision: 6213fec03a47275d8fcbf79b951547e3993d677f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:31.706487) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:31.706763) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 10:49:31.725959) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-08-14 10:49:31.726248) ========= /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=cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:49:31 INFO - MultiFileLogger online at 20170814 10:49:31 in /builds/slave/test 10:49:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:49:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:49:31 INFO - {'append_to_log': False, 10:49:31 INFO - 'base_work_dir': '/builds/slave/test', 10:49:31 INFO - 'blob_upload_branch': 'Firefox', 10:49:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:49:31 INFO - 'branch': 'Firefox', 10:49:31 INFO - 'buildbot_json_path': 'buildprops.json', 10:49:31 INFO - 'code_coverage': False, 10:49:31 INFO - 'config_files': ('talos/linux_config.py',), 10:49:31 INFO - 'default_actions': ('clobber', 10:49:31 INFO - 'read-buildbot-config', 10:49:31 INFO - 'download-and-extract', 10:49:31 INFO - 'populate-webroot', 10:49:31 INFO - 'create-virtualenv', 10:49:31 INFO - 'install', 10:49:31 INFO - 'setup-mitmproxy', 10:49:31 INFO - 'run-tests'), 10:49:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:49:31 INFO - 'disable_ccov_upload': False, 10:49:31 INFO - 'download_minidump_stackwalk': True, 10:49:31 INFO - 'download_symbols': 'ondemand', 10:49:31 INFO - 'enable_stylo': False, 10:49:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:49:31 INFO - 'tooltool.py': '/tools/tooltool.py', 10:49:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:49:31 INFO - '/tools/misc-python/virtualenv.py')}, 10:49:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:49:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:49:31 INFO - 'gecko_profile': False, 10:49:31 INFO - 'gecko_profile_interval': 0, 10:49:31 INFO - 'installer_path': 'installer.exe', 10:49:31 INFO - 'log_level': 'info', 10:49:31 INFO - 'log_name': 'talos', 10:49:31 INFO - 'log_to_console': True, 10:49:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:49:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:49:31 INFO - 'opt_config_files': (), 10:49:31 INFO - 'pip_index': False, 10:49:31 INFO - 'suite': 'dromaeojs-e10s', 10:49:31 INFO - 'system_bits': '32', 10:49:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:49:31 INFO - 'title': 'talos-linux64-ix-054', 10:49:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:49:31 INFO - 'use_talos_json': True, 10:49:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:49:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:49:31 INFO - 'work_dir': 'build'} 10:49:31 INFO - [mozharness: 2017-08-14 17:49:31.819548Z] Running clobber step. 10:49:31 INFO - Running pre-action listener: _resource_record_pre_action 10:49:31 INFO - Running main action method: clobber 10:49:31 INFO - rmtree: /builds/slave/test/build 10:49:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:49:32 INFO - Running post-action listener: _resource_record_post_action 10:49:32 INFO - [mozharness: 2017-08-14 17:49:32.848141Z] Finished clobber step (success) 10:49:32 INFO - [mozharness: 2017-08-14 17:49:32.848243Z] Running read-buildbot-config step. 10:49:32 INFO - Running pre-action listener: _resource_record_pre_action 10:49:32 INFO - Running main action method: read_buildbot_config 10:49:32 INFO - Using buildbot properties: 10:49:32 INFO - { 10:49:32 INFO - "project": "", 10:49:32 INFO - "product": "firefox", 10:49:32 INFO - "who": "ffxbld@noreply.mozilla.org", 10:49:32 INFO - "installer_path": "public/build/target.tar.bz2", 10:49:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:49:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:49:32 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:49:32 INFO - "stage_platform": "linux64-stylosequential", 10:49:32 INFO - "basedir": "/builds/slave/test", 10:49:32 INFO - "buildnumber": 147, 10:49:32 INFO - "platform": "ubuntu64_hw_styloseq", 10:49:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:49:32 INFO - "slavebuilddir": "test", 10:49:32 INFO - "taskId": "IK4E0uvkQzSLxdFo9CS8fQ", 10:49:32 INFO - "branch": "mozilla-central", 10:49:32 INFO - "script_repo_revision": "production", 10:49:32 INFO - "revision": "6213fec03a47275d8fcbf79b951547e3993d677f", 10:49:32 INFO - "slavename": "talos-linux64-ix-054", 10:49:32 INFO - "repo_path": "mozilla-central" 10:49:32 INFO - } 10:49:32 INFO - Finding installer, test and symbols from parent task. 10:49:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IK4E0uvkQzSLxdFo9CS8fQ'}, attempt #1 10:49:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IK4E0uvkQzSLxdFo9CS8fQ'}, attempt #1 10:49:33 INFO - Task dependencies: EbW8bYmORB6jS9ruD6W6qg 10:49:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg'}, attempt #1 10:49:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2 10:49:34 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.test_packages.json 10:49:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.crashreporter-symbols.zip 10:49:34 INFO - Running post-action listener: _resource_record_post_action 10:49:34 INFO - [mozharness: 2017-08-14 17:49:34.201603Z] Finished read-buildbot-config step (success) 10:49:34 INFO - [mozharness: 2017-08-14 17:49:34.201823Z] Running download-and-extract step. 10:49:34 INFO - Running pre-action listener: _resource_record_pre_action 10:49:34 INFO - Running main action method: download_and_extract 10:49:34 INFO - mkdir: /builds/slave/test/build/tests 10:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:49:34 INFO - trying https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.test_packages.json 10:49:34 INFO - Downloading https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:49:34 INFO - Downloaded 989 bytes. 10:49:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:49:34 INFO - Using the following test package requirements: 10:49:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:49:34 INFO - u'common': [u'target.common.tests.zip'], 10:49:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:49:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:49:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:49:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:49:34 INFO - u'mozbase': [u'target.common.tests.zip'], 10:49:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:49:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:49:34 INFO - u'web-platform': [u'target.common.tests.zip', 10:49:34 INFO - u'target.web-platform.tests.tar.gz'], 10:49:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:49:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:49:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.common.tests.zip 10:49:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:49:34 INFO - Fetch https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.common.tests.zip into memory 10:49:39 INFO - Content-Length response header: 54034742 10:49:39 INFO - Bytes received: 54034742 10:49:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:49:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.common.tests.zip 10:49:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:49:49 INFO - Fetch https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.common.tests.zip into memory 10:49:52 INFO - Content-Length response header: 54034742 10:49:52 INFO - Bytes received: 54034742 10:50:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.talos.tests.zip 10:50:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:50:06 INFO - Fetch https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.talos.tests.zip into memory 10:50:07 INFO - Content-Length response header: 14496050 10:50:07 INFO - Bytes received: 14496050 10:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:07 INFO - trying https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2 10:50:07 INFO - Downloading https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:50:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:50:09 INFO - Downloaded 61721141 bytes. 10:50:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2 10:50:09 INFO - mkdir: /builds/slave/test/properties 10:50:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:50:09 INFO - Writing to file /builds/slave/test/properties/build_url 10:50:09 INFO - Contents: 10:50:09 INFO - build_url:https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2 10:50:09 INFO - Running post-action listener: _resource_record_post_action 10:50:09 INFO - Running post-action listener: set_extra_try_arguments 10:50:09 INFO - [mozharness: 2017-08-14 17:50:09.330299Z] Finished download-and-extract step (success) 10:50:09 INFO - [mozharness: 2017-08-14 17:50:09.330528Z] Running populate-webroot step. 10:50:09 INFO - Running pre-action listener: _resource_record_pre_action 10:50:09 INFO - Running main action method: populate_webroot 10:50:09 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:50:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:50:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:50:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:50:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:50:09 INFO - 'tests': ['damp', 'tps']}, 10:50:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:50:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:50:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:50:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:50:09 INFO - 'other-e10s': {'tests': ['a11yr', 10:50:09 INFO - 'ts_paint', 10:50:09 INFO - 'tpaint', 10:50:09 INFO - 'sessionrestore', 10:50:09 INFO - 'sessionrestore_many_windows', 10:50:09 INFO - 'sessionrestore_no_auto_restore', 10:50:09 INFO - 'tabpaint']}, 10:50:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:50:09 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:50:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:50:09 INFO - 'tsvgr_opacity', 10:50:09 INFO - 'tart', 10:50:09 INFO - 'tscrollx', 10:50:09 INFO - 'tsvg_static']}, 10:50:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:50:09 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:50:09 INFO - 'talos_options': ['--mitmproxy', 10:50:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:50:09 INFO - '--firstNonBlankPaint'], 10:50:09 INFO - 'tests': ['tp6_google', 10:50:09 INFO - 'tp6_youtube', 10:50:09 INFO - 'tp6_amazon', 10:50:09 INFO - 'tp6_facebook']}, 10:50:09 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:50:09 INFO - 'talos_options': ['--stylo', 10:50:09 INFO - '--mitmproxy', 10:50:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:50:09 INFO - '--firstNonBlankPaint'], 10:50:09 INFO - 'tests': ['tp6_google', 10:50:09 INFO - 'tp6_youtube', 10:50:09 INFO - 'tp6_amazon', 10:50:09 INFO - 'tp6_facebook']}, 10:50:09 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:50:09 INFO - 'talos_options': ['--stylo', 10:50:09 INFO - '--stylo-threads=1', 10:50:09 INFO - '--mitmproxy', 10:50:09 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:50:09 INFO - '--firstNonBlankPaint'], 10:50:09 INFO - 'tests': ['tp6_google', 10:50:09 INFO - 'tp6_youtube', 10:50:09 INFO - 'tp6_amazon', 10:50:09 INFO - 'tp6_facebook']}, 10:50:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:50:09 INFO - 'talos_options': ['--xperf_path', 10:50:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:50:09 INFO - 'tests': ['tp5n']}}} 10:50:09 INFO - Running post-action listener: _resource_record_post_action 10:50:09 INFO - [mozharness: 2017-08-14 17:50:09.344205Z] Finished populate-webroot step (success) 10:50:09 INFO - [mozharness: 2017-08-14 17:50:09.344295Z] Running create-virtualenv step. 10:50:09 INFO - Running pre-action listener: _resource_record_pre_action 10:50:09 INFO - Running main action method: create_virtualenv 10:50:09 INFO - Creating virtualenv /builds/slave/test/build/venv 10:50:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:50:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:50:09 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:50:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:50:09 INFO - Using real prefix '/usr' 10:50:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:50:09 INFO - Installing distribute.............................................................................................................................................................................................done. 10:50:11 INFO - Installing pip.................done. 10:50:11 INFO - Return code: 0 10:50:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:50:12 INFO - Reading from file tmpfile_stdout 10:50:12 INFO - Output received: 10:50:12 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:50:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2053700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, '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 0x20517a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2051c30>, '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': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:50:12 INFO - Using env: {'DISPLAY': ':0', 10:50:12 INFO - 'HOME': '/home/cltbld', 10:50:12 INFO - 'LANG': 'en_US.UTF-8', 10:50:12 INFO - 'LANGUAGE': 'en_US:en', 10:50:12 INFO - 'LOGNAME': 'cltbld', 10:50:12 INFO - 'MAIL': '/var/mail/cltbld', 10:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:12 INFO - 'MOZ_NO_REMOTE': '1', 10:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:12 INFO - 'NO_EM_RESTART': '1', 10:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:12 INFO - 'PWD': '/builds/slave/test', 10:50:12 INFO - 'SHELL': '/bin/bash', 10:50:12 INFO - 'SHLVL': '1', 10:50:12 INFO - 'TERM': 'linux', 10:50:12 INFO - 'TMOUT': '86400', 10:50:12 INFO - 'USER': 'cltbld', 10:50:12 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 10:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:12 INFO - '_': '/tools/buildbot/bin/python'} 10:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:50:12 INFO - Cleaning up... 10:50:12 INFO - Return code: 0 10:50:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ce41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2053700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, '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 0x20517a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2051c30>, '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': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:50:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:50:12 INFO - Using env: {'DISPLAY': ':0', 10:50:12 INFO - 'HOME': '/home/cltbld', 10:50:12 INFO - 'LANG': 'en_US.UTF-8', 10:50:12 INFO - 'LANGUAGE': 'en_US:en', 10:50:12 INFO - 'LOGNAME': 'cltbld', 10:50:12 INFO - 'MAIL': '/var/mail/cltbld', 10:50:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:12 INFO - 'MOZ_NO_REMOTE': '1', 10:50:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:12 INFO - 'NO_EM_RESTART': '1', 10:50:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:12 INFO - 'PWD': '/builds/slave/test', 10:50:12 INFO - 'SHELL': '/bin/bash', 10:50:12 INFO - 'SHLVL': '1', 10:50:12 INFO - 'TERM': 'linux', 10:50:12 INFO - 'TMOUT': '86400', 10:50:12 INFO - 'USER': 'cltbld', 10:50:12 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 10:50:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:12 INFO - '_': '/tools/buildbot/bin/python'} 10:50:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:12 INFO - Downloading/unpacking psutil>=3.1.1 10:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:50:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:13 INFO - Installing collected packages: psutil 10:50:13 INFO - Running setup.py install for psutil 10:50:13 INFO - building 'psutil._psutil_linux' extension 10:50:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:50:13 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:50:14 INFO - building 'psutil._psutil_posix' extension 10:50:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:50:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:50:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:50:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:50:14 INFO - Successfully installed psutil 10:50:14 INFO - Cleaning up... 10:50:14 INFO - Return code: 0 10:50:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:50: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')]} 10:50:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50: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')]} 10:50:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2053700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, '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 0x20517a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2051c30>, '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': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:50: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 mozsystemmonitor==0.3 10:50:14 INFO - Using env: {'DISPLAY': ':0', 10:50:14 INFO - 'HOME': '/home/cltbld', 10:50:14 INFO - 'LANG': 'en_US.UTF-8', 10:50:14 INFO - 'LANGUAGE': 'en_US:en', 10:50:14 INFO - 'LOGNAME': 'cltbld', 10:50:14 INFO - 'MAIL': '/var/mail/cltbld', 10:50:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:14 INFO - 'MOZ_NO_REMOTE': '1', 10:50:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:14 INFO - 'NO_EM_RESTART': '1', 10:50:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:14 INFO - 'PWD': '/builds/slave/test', 10:50:14 INFO - 'SHELL': '/bin/bash', 10:50:14 INFO - 'SHLVL': '1', 10:50:14 INFO - 'TERM': 'linux', 10:50:14 INFO - 'TMOUT': '86400', 10:50:14 INFO - 'USER': 'cltbld', 10:50:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 10:50:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:14 INFO - '_': '/tools/buildbot/bin/python'} 10:50:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:50: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 10:50: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 10:50: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 10:50: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 10:50:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:50:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:50:15 INFO - Installing collected packages: mozsystemmonitor 10:50:15 INFO - Running setup.py install for mozsystemmonitor 10:50:15 INFO - Successfully installed mozsystemmonitor 10:50:15 INFO - Cleaning up... 10:50:15 INFO - Return code: 0 10:50:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1ce41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2053700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, '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 0x20517a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2051c30>, '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': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:50:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:50:15 INFO - Using env: {'DISPLAY': ':0', 10:50:15 INFO - 'HOME': '/home/cltbld', 10:50:15 INFO - 'LANG': 'en_US.UTF-8', 10:50:15 INFO - 'LANGUAGE': 'en_US:en', 10:50:15 INFO - 'LOGNAME': 'cltbld', 10:50:15 INFO - 'MAIL': '/var/mail/cltbld', 10:50:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:15 INFO - 'MOZ_NO_REMOTE': '1', 10:50:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:15 INFO - 'NO_EM_RESTART': '1', 10:50:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:15 INFO - 'PWD': '/builds/slave/test', 10:50:15 INFO - 'SHELL': '/bin/bash', 10:50:15 INFO - 'SHLVL': '1', 10:50:15 INFO - 'TERM': 'linux', 10:50:15 INFO - 'TMOUT': '86400', 10:50:15 INFO - 'USER': 'cltbld', 10:50:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 10:50:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:15 INFO - '_': '/tools/buildbot/bin/python'} 10:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:16 INFO - Downloading/unpacking jsonschema==2.5.1 10:50: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 10:50: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 10:50: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 10:50: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 10:50:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:50:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:17 INFO - Downloading functools32-3.2.3-2.tar.gz 10:50:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:50:17 INFO - warning: no files found matching '*.txt' 10:50:17 INFO - no previously-included directories found matching 'build' 10:50:17 INFO - no previously-included directories found matching 'dist' 10:50:17 INFO - no previously-included directories found matching '.git*' 10:50:17 INFO - Installing collected packages: jsonschema, functools32 10:50:17 INFO - Running setup.py install for functools32 10:50:17 INFO - warning: no files found matching '*.txt' 10:50:17 INFO - no previously-included directories found matching 'build' 10:50:17 INFO - no previously-included directories found matching 'dist' 10:50:17 INFO - no previously-included directories found matching '.git*' 10:50:17 INFO - Successfully installed jsonschema functools32 10:50:17 INFO - Cleaning up... 10:50:17 INFO - Return code: 0 10:50:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:17 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 0x1ce41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2053700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, '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 0x20517a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2051c30>, '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': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:50:17 INFO - Using env: {'DISPLAY': ':0', 10:50:17 INFO - 'HOME': '/home/cltbld', 10:50:17 INFO - 'LANG': 'en_US.UTF-8', 10:50:17 INFO - 'LANGUAGE': 'en_US:en', 10:50:17 INFO - 'LOGNAME': 'cltbld', 10:50:17 INFO - 'MAIL': '/var/mail/cltbld', 10:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:17 INFO - 'MOZ_NO_REMOTE': '1', 10:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:17 INFO - 'NO_EM_RESTART': '1', 10:50:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:17 INFO - 'PWD': '/builds/slave/test', 10:50:17 INFO - 'SHELL': '/bin/bash', 10:50:17 INFO - 'SHLVL': '1', 10:50:17 INFO - 'TERM': 'linux', 10:50:17 INFO - 'TMOUT': '86400', 10:50:17 INFO - 'USER': 'cltbld', 10:50:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 10:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:17 INFO - '_': '/tools/buildbot/bin/python'} 10:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:50:17 INFO - Cleaning up... 10:50:17 INFO - Return code: 0 10:50:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:17 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 0x1ce41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2053700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, '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 0x20517a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2051c30>, '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': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:50:17 INFO - Using env: {'DISPLAY': ':0', 10:50:17 INFO - 'HOME': '/home/cltbld', 10:50:17 INFO - 'LANG': 'en_US.UTF-8', 10:50:17 INFO - 'LANGUAGE': 'en_US:en', 10:50:17 INFO - 'LOGNAME': 'cltbld', 10:50:17 INFO - 'MAIL': '/var/mail/cltbld', 10:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:17 INFO - 'MOZ_NO_REMOTE': '1', 10:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:17 INFO - 'NO_EM_RESTART': '1', 10:50:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:17 INFO - 'PWD': '/builds/slave/test', 10:50:17 INFO - 'SHELL': '/bin/bash', 10:50:17 INFO - 'SHLVL': '1', 10:50:17 INFO - 'TERM': 'linux', 10:50:17 INFO - 'TMOUT': '86400', 10:50:17 INFO - 'USER': 'cltbld', 10:50:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 10:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:17 INFO - '_': '/tools/buildbot/bin/python'} 10:50:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:18 INFO - Downloading/unpacking blobuploader==1.2.4 10:50: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 10:50: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 10:50: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 10:50: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 10:50:19 INFO - Downloading blobuploader-1.2.4.tar.gz 10:50:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:50:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:50: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 10:50: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 10:50: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 10:50: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 10:50:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:50:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:50: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 10:50: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 10:50: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 10:50: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 10:50:19 INFO - Downloading docopt-0.6.1.tar.gz 10:50:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:50:19 INFO - Installing collected packages: blobuploader, requests, docopt 10:50:19 INFO - Running setup.py install for blobuploader 10:50:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:50:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:50:19 INFO - Running setup.py install for requests 10:50:20 INFO - Running setup.py install for docopt 10:50:20 INFO - Successfully installed blobuploader requests docopt 10:50:20 INFO - Cleaning up... 10:50:20 INFO - Return code: 0 10:50:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50: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')]} 10:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50: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')]} 10:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:20 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 0x1ce41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2053700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, '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 0x20517a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2051c30>, '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': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:50:20 INFO - Using env: {'DISPLAY': ':0', 10:50:20 INFO - 'HOME': '/home/cltbld', 10:50:20 INFO - 'LANG': 'en_US.UTF-8', 10:50:20 INFO - 'LANGUAGE': 'en_US:en', 10:50:20 INFO - 'LOGNAME': 'cltbld', 10:50:20 INFO - 'MAIL': '/var/mail/cltbld', 10:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:20 INFO - 'MOZ_NO_REMOTE': '1', 10:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:20 INFO - 'NO_EM_RESTART': '1', 10:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:20 INFO - 'PWD': '/builds/slave/test', 10:50:20 INFO - 'SHELL': '/bin/bash', 10:50:20 INFO - 'SHLVL': '1', 10:50:20 INFO - 'TERM': 'linux', 10:50:20 INFO - 'TMOUT': '86400', 10:50:20 INFO - 'USER': 'cltbld', 10:50:20 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 10:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:20 INFO - '_': '/tools/buildbot/bin/python'} 10:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:20 INFO - Running setup.py (path:/tmp/pip-Cww1dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:20 INFO - Running setup.py (path:/tmp/pip-WqP8k1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:20 INFO - Running setup.py (path:/tmp/pip-fNTQvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:20 INFO - Running setup.py (path:/tmp/pip-r0USgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:20 INFO - Running setup.py (path:/tmp/pip-EGyD1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:20 INFO - Running setup.py (path:/tmp/pip-JSlFtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:21 INFO - Running setup.py (path:/tmp/pip-cjiMif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:21 INFO - Running setup.py (path:/tmp/pip-cqE9Ce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:21 INFO - Running setup.py (path:/tmp/pip-raTwl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:21 INFO - Running setup.py (path:/tmp/pip-ticffT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:21 INFO - Running setup.py (path:/tmp/pip-Rxw9wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:21 INFO - Running setup.py (path:/tmp/pip-DdVTSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:21 INFO - Running setup.py (path:/tmp/pip-K5ttzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:21 INFO - Running setup.py (path:/tmp/pip-NE9D7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:21 INFO - Running setup.py (path:/tmp/pip-TaE07W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:21 INFO - Running setup.py (path:/tmp/pip-VkWRn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:21 INFO - Running setup.py (path:/tmp/pip-nqUu3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:50:21 INFO - Running setup.py install for manifestparser 10:50:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:50:21 INFO - Running setup.py install for mozcrash 10:50:22 INFO - Running setup.py install for mozdebug 10:50:22 INFO - Running setup.py install for mozdevice 10:50:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:50:22 INFO - Running setup.py install for mozfile 10:50:22 INFO - Running setup.py install for mozhttpd 10:50:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:50:22 INFO - Running setup.py install for mozinfo 10:50:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:50:22 INFO - Running setup.py install for mozInstall 10:50:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:50:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:50:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:50:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:50:22 INFO - Running setup.py install for mozleak 10:50:22 INFO - Running setup.py install for mozlog 10:50:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:50:22 INFO - Running setup.py install for moznetwork 10:50:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:50:22 INFO - Running setup.py install for mozprocess 10:50:23 INFO - Running setup.py install for mozprofile 10:50:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:50:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:50:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:50:23 INFO - Running setup.py install for mozrunner 10:50:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:50:23 INFO - Running setup.py install for mozscreenshot 10:50:23 INFO - Running setup.py install for moztest 10:50:23 INFO - Running setup.py install for mozversion 10:50:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:50:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:50:23 INFO - Cleaning up... 10:50:23 INFO - Return code: 0 10:50:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:23 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 0x1ce41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2053700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, '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 0x20517a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2051c30>, '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': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:50:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:50:23 INFO - Using env: {'DISPLAY': ':0', 10:50:23 INFO - 'HOME': '/home/cltbld', 10:50:23 INFO - 'LANG': 'en_US.UTF-8', 10:50:23 INFO - 'LANGUAGE': 'en_US:en', 10:50:23 INFO - 'LOGNAME': 'cltbld', 10:50:23 INFO - 'MAIL': '/var/mail/cltbld', 10:50:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:23 INFO - 'MOZ_NO_REMOTE': '1', 10:50:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:23 INFO - 'NO_EM_RESTART': '1', 10:50:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:23 INFO - 'PWD': '/builds/slave/test', 10:50:23 INFO - 'SHELL': '/bin/bash', 10:50:23 INFO - 'SHLVL': '1', 10:50:23 INFO - 'TERM': 'linux', 10:50:23 INFO - 'TMOUT': '86400', 10:50:23 INFO - 'USER': 'cltbld', 10:50:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 10:50:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:23 INFO - '_': '/tools/buildbot/bin/python'} 10:50:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:50:23 INFO - Running setup.py (path:/tmp/pip-yaLfvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:50:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:50:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:50:23 INFO - Running setup.py (path:/tmp/pip-q3tc3U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:50:24 INFO - Running setup.py (path:/tmp/pip-mZv9BY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:50:24 INFO - Running setup.py (path:/tmp/pip-tpcdDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:50:24 INFO - Running setup.py (path:/tmp/pip-_FTGDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:50:24 INFO - Running setup.py (path:/tmp/pip-WW5XB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:50:24 INFO - Running setup.py (path:/tmp/pip-GBZOYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:50:24 INFO - Running setup.py (path:/tmp/pip-eoliIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:50:24 INFO - Running setup.py (path:/tmp/pip-Ur8oeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:50:24 INFO - Running setup.py (path:/tmp/pip-HQLHUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:50:24 INFO - Running setup.py (path:/tmp/pip-3P2Vkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:50:24 INFO - Running setup.py (path:/tmp/pip-ESOsae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:50:24 INFO - Running setup.py (path:/tmp/pip-5Nq87c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:50:24 INFO - Running setup.py (path:/tmp/pip-iz3O_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:24 INFO - Running setup.py (path:/tmp/pip-qgOXCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:50:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:50:24 INFO - Running setup.py (path:/tmp/pip-XIclwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:50:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:50:25 INFO - Running setup.py (path:/tmp/pip-a7uI9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:50:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:26 INFO - Downloading blessings-1.6.tar.gz 10:50:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:50:26 INFO - Installing collected packages: blessings 10:50:26 INFO - Running setup.py install for blessings 10:50:26 INFO - Successfully installed blessings 10:50:26 INFO - Cleaning up... 10:50:26 INFO - Return code: 0 10:50:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:50:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:50:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:50:26 INFO - Reading from file tmpfile_stdout 10:50:26 INFO - Current package versions: 10:50:26 INFO - argparse == 1.2.1 10:50:26 INFO - blessings == 1.6 10:50:26 INFO - blobuploader == 1.2.4 10:50:26 INFO - docopt == 0.6.1 10:50:26 INFO - functools32 == 3.2.3-2 10:50:26 INFO - jsonschema == 2.5.1 10:50:26 INFO - manifestparser == 1.1 10:50:26 INFO - mozInstall == 1.13 10:50:26 INFO - mozcrash == 1.0 10:50:26 INFO - mozdebug == 0.1 10:50:26 INFO - mozdevice == 0.51 10:50:26 INFO - mozfile == 1.2 10:50:26 INFO - mozhttpd == 0.7 10:50:26 INFO - mozinfo == 0.10 10:50:26 INFO - mozleak == 0.1 10:50:26 INFO - mozlog == 3.5 10:50:26 INFO - moznetwork == 0.27 10:50:26 INFO - mozprocess == 0.25 10:50:26 INFO - mozprofile == 0.28 10:50:26 INFO - mozrunner == 6.13 10:50:26 INFO - mozscreenshot == 0.1 10:50:26 INFO - mozsystemmonitor == 0.3 10:50:26 INFO - moztest == 0.8 10:50:26 INFO - mozversion == 1.4 10:50:26 INFO - psutil == 3.1.1 10:50:26 INFO - requests == 1.2.3 10:50:26 INFO - wsgiref == 0.1.2 10:50:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:26 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 0x1ce41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2053700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, '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 0x20517a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2051c30>, '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': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:50:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:50:26 INFO - Using env: {'DISPLAY': ':0', 10:50:26 INFO - 'HOME': '/home/cltbld', 10:50:26 INFO - 'LANG': 'en_US.UTF-8', 10:50:26 INFO - 'LANGUAGE': 'en_US:en', 10:50:26 INFO - 'LOGNAME': 'cltbld', 10:50:26 INFO - 'MAIL': '/var/mail/cltbld', 10:50:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:26 INFO - 'MOZ_NO_REMOTE': '1', 10:50:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:26 INFO - 'NO_EM_RESTART': '1', 10:50:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:26 INFO - 'PWD': '/builds/slave/test', 10:50:26 INFO - 'SHELL': '/bin/bash', 10:50:26 INFO - 'SHLVL': '1', 10:50:26 INFO - 'TERM': 'linux', 10:50:26 INFO - 'TMOUT': '86400', 10:50:26 INFO - 'USER': 'cltbld', 10:50:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 10:50:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:26 INFO - '_': '/tools/buildbot/bin/python'} 10:50:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:50:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:50:26 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:50:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:50:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:50:28 INFO - Installing collected packages: simplejson 10:50:28 INFO - Running setup.py install for simplejson 10:50:28 INFO - building 'simplejson._speedups' extension 10:50:28 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 10:50:28 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 10:50:29 INFO - Successfully installed simplejson 10:50:29 INFO - Cleaning up... 10:50:29 INFO - Return code: 0 10:50:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:50:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:50:29 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 0x1ce41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eb0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2053700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20508a0>, '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 0x20517a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2051c30>, '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': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:50:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:50:29 INFO - Using env: {'DISPLAY': ':0', 10:50:29 INFO - 'HOME': '/home/cltbld', 10:50:29 INFO - 'LANG': 'en_US.UTF-8', 10:50:29 INFO - 'LANGUAGE': 'en_US:en', 10:50:29 INFO - 'LOGNAME': 'cltbld', 10:50:29 INFO - 'MAIL': '/var/mail/cltbld', 10:50:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:29 INFO - 'MOZ_NO_REMOTE': '1', 10:50:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:29 INFO - 'NO_EM_RESTART': '1', 10:50:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:29 INFO - 'PWD': '/builds/slave/test', 10:50:29 INFO - 'SHELL': '/bin/bash', 10:50:29 INFO - 'SHLVL': '1', 10:50:29 INFO - 'TERM': 'linux', 10:50:29 INFO - 'TMOUT': '86400', 10:50:29 INFO - 'USER': 'cltbld', 10:50:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 10:50:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:29 INFO - '_': '/tools/buildbot/bin/python'} 10:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:50:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:50:29 INFO - Cleaning up... 10:50:29 INFO - Return code: 0 10:50:29 INFO - Running post-action listener: _resource_record_post_action 10:50:29 INFO - Running post-action listener: _start_resource_monitoring 10:50:29 INFO - Starting resource monitoring. 10:50:29 INFO - [mozharness: 2017-08-14 17:50:29.357175Z] Finished create-virtualenv step (success) 10:50:29 INFO - [mozharness: 2017-08-14 17:50:29.357693Z] Running install step. 10:50:29 INFO - Running pre-action listener: _resource_record_pre_action 10:50:29 INFO - Running main action method: install 10:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:50:29 INFO - Reading from file tmpfile_stdout 10:50:29 INFO - Detecting whether we're running mozinstall >=1.0... 10:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:50:29 INFO - Reading from file tmpfile_stdout 10:50:29 INFO - Output received: 10:50:29 INFO - Usage: mozinstall [options] installer 10:50:29 INFO - Options: 10:50:29 INFO - -h, --help show this help message and exit 10:50:29 INFO - -d DEST, --destination=DEST 10:50:29 INFO - Directory to install application into. [default: 10:50:29 INFO - "/builds/slave/test"] 10:50:29 INFO - --app=APP Application being installed. [default: firefox] 10:50:29 INFO - mkdir: /builds/slave/test/build/application 10:50:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:50:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:50:47 INFO - Reading from file tmpfile_stdout 10:50:47 INFO - Output received: 10:50:47 INFO - /builds/slave/test/build/application/firefox/firefox 10:50:47 INFO - Running post-action listener: _resource_record_post_action 10:50:47 INFO - [mozharness: 2017-08-14 17:50:47.628931Z] Finished install step (success) 10:50:47 INFO - [mozharness: 2017-08-14 17:50:47.629183Z] Running setup-mitmproxy step. 10:50:47 INFO - Running pre-action listener: _resource_record_pre_action 10:50:47 INFO - Running main action method: setup_mitmproxy 10:50:47 INFO - Skipping: mitmproxy is not required 10:50:47 INFO - Running post-action listener: _resource_record_post_action 10:50:47 INFO - [mozharness: 2017-08-14 17:50:47.630312Z] Finished setup-mitmproxy step (success) 10:50:47 INFO - [mozharness: 2017-08-14 17:50:47.630531Z] Running run-tests step. 10:50:47 INFO - Running pre-action listener: _resource_record_pre_action 10:50:47 INFO - Running pre-action listener: _set_gcov_prefix 10:50:47 INFO - Running main action method: run_tests 10:50:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:50:47 INFO - Python 2.7.3 10:50:47 INFO - Return code: 0 10:50:47 INFO - grabbing minidump binary from tooltool 10:50:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:50:47 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 0x20508a0>, '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 0x20517a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2051c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:50:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:50:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:50:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:50:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:50:47 INFO - Return code: 0 10:50:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:50:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:50:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:50:47 INFO - ENV: RUST_BACKTRACE is now full 10:50:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:50:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:50:47 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/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 10:50:47 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/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 10:50:47 INFO - Using env: {'DISPLAY': ':0', 10:50:47 INFO - 'HOME': '/home/cltbld', 10:50:47 INFO - 'LANG': 'en_US.UTF-8', 10:50:47 INFO - 'LANGUAGE': 'en_US:en', 10:50:47 INFO - 'LOGNAME': 'cltbld', 10:50:47 INFO - 'MAIL': '/var/mail/cltbld', 10:50:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:50:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:50:47 INFO - 'MOZ_NO_REMOTE': '1', 10:50:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:50:47 INFO - 'NO_EM_RESTART': '1', 10:50:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:50:47 INFO - 'PWD': '/builds/slave/test', 10:50:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:50:47 INFO - 'RUST_BACKTRACE': 'full', 10:50:47 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:50:47 INFO - 'SHELL': '/bin/bash', 10:50:47 INFO - 'SHLVL': '1', 10:50:47 INFO - 'STYLO_FORCE_ENABLED': '1', 10:50:47 INFO - 'TERM': 'linux', 10:50:47 INFO - 'TMOUT': '86400', 10:50:47 INFO - 'USER': 'cltbld', 10:50:47 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766', 10:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:50:47 INFO - '_': '/tools/buildbot/bin/python'} 10:50:47 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/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 10:50:47 INFO - mozversion application_buildid: 20170814165937 10:50:47 INFO - mozversion application_changeset: 6213fec03a47275d8fcbf79b951547e3993d677f 10:50:47 INFO - mozversion application_display_name: Nightly 10:50:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:50:47 INFO - mozversion application_name: Firefox 10:50:47 INFO - mozversion application_remotingname: firefox 10:50:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:50:47 INFO - mozversion application_vendor: Mozilla 10:50:47 INFO - mozversion application_version: 57.0a1 10:50:47 INFO - mozversion platform_buildid: 20170814165937 10:50:47 INFO - mozversion platform_changeset: 6213fec03a47275d8fcbf79b951547e3993d677f 10:50:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:50:47 INFO - mozversion platform_version: 57.0a1 10:50:48 INFO - using testdate: 1502733047 10:50:48 INFO - actual date: 1502733047 10:50:48 INFO - starting webserver on 'localhost:38606' 10:50:48 INFO - SUITE-START | Running 2 tests 10:50:48 INFO - TEST-START | dromaeo_css 10:50:48 INFO - Initialising browser for dromaeo_css test... 10:50:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38606/getInfo.html -profile /tmp/tmpLY2X9n/profile 10:50:48 INFO - TEST-INFO | started process 14254 (/builds/slave/test/build/application/firefox/firefox http://localhost:38606/getInfo.html) 10:50:54 INFO - TEST-INFO | 14254: exit 0 10:50:54 INFO - Browser initialized. 10:50:54 INFO - Running cycle 1/1 for dromaeo_css test... 10:50:54 INFO - TEST-INFO | started process 14489 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLY2X9n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:50:55 INFO - PID 14489 | 10:50:55 INFO - PID 14489 | (/builds/slave/test/build/application/firefox/firefox:14543): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 10:50:55 INFO - PID 14489 | 10:51:06 INFO - PID 14489 | RSS: Main: 168230912 10:51:06 INFO - PID 14489 | 10:54:05 INFO - PID 14489 | Cycle 1(1): loaded http://localhost:38606/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38606/tests/dromaeo/cssquery-ext.html) 10:54:07 INFO - PID 14489 | RSS: Main: 175030272 10:54:07 INFO - PID 14489 | 10:57:08 INFO - PID 14489 | Cycle 1(1): loaded http://localhost:38606/tests/dromaeo/cssquery-ext.html (next: http://localhost:38606/tests/dromaeo/cssquery-jquery.html) 10:57:09 INFO - PID 14489 | RSS: Main: 173240320 10:57:09 INFO - PID 14489 | 11:00:11 INFO - PID 14489 | Cycle 1(1): loaded http://localhost:38606/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38606/tests/dromaeo/cssquery-mootools.html) 11:00:11 INFO - PID 14489 | RSS: Main: 172896256 11:00:11 INFO - PID 14489 | 11:03:13 INFO - PID 14489 | Cycle 1(1): loaded http://localhost:38606/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38606/tests/dromaeo/cssquery-prototype.html) 11:03:14 INFO - PID 14489 | RSS: Main: 173158400 11:03:14 INFO - PID 14489 | 11:06:17 INFO - PID 14489 | Cycle 1(1): loaded http://localhost:38606/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38606/tests/dromaeo/cssquery-yui.html) 11:06:18 INFO - PID 14489 | RSS: Main: 177201152 11:06:18 INFO - PID 14489 | 11:09:20 INFO - PID 14489 | Cycle 1(1): loaded http://localhost:38606/tests/dromaeo/cssquery-yui.html (next: http://localhost:38606/tests/dromaeo/cssquery-dojo.html) 11:09:20 INFO - PID 14489 | RSS: Main: 177303552 11:09:20 INFO - PID 14489 | 11:09:20 INFO - PID 14489 | __start_tp_report 11:09:20 INFO - PID 14489 | _x_x_mozilla_page_load 11:09:20 INFO - PID 14489 | _x_x_mozilla_page_load_details 11:09:20 INFO - PID 14489 | |i|pagename|runs| 11:09:20 INFO - PID 14489 | |0;dojo.html;3142.1045002174383;3175.1744546417926;3177.031005543309;3201.503766916129;3205.7435405167575;6135.938640613593;6138.355472675372;6141.938580614193;6146.416090471398;6150.477209437197;6040.637561746287;6105.511559075275;6108.053251745975;6113.480354169889;6133.723982420791;5595.8601034974145;5596.300462442195;5602.887942241153;5603.99999999998;5712.22884910538;5672.34768001681;5676.829695109153;5684.175794509793;5690.032694441934;5697.259356283677;5515.889682206373;5594.9720251398885;5627.240322556443;5734.827955161331;5754.108113242433;5585.776568937237;5625.268715067056;5677.829665110054;5680.034394153004;5706.029974904276;5592.077307244341;5602.523785478239;5677.176809362661;5679.574031947621;5682.573806964453;5955.37468565803;6011.27864656244;6075.817725468243;6089.756409743605;6150.323464418911;6571.211454625428;6581.473482121419;6595.439387652055;6597.571157874723;6607.603543787388;6657.966710166466;6733.696983635699;6733.8989915151315;6741.93258067418;6772.72909083641;6115;6133.570650054543;6217.316095229567;6226.750929962751;6248.656323902229;6592.373724496165;6669.4330981866115;6673.566218195801;6679.298673639198;6818.863622727517;6320.652364120017;6381.617102973743;6403.48772098231;6415.037744338387;6424.036394540856;6523.347665233438;6528.445082167974;6533.24867640218;6536.477081833442;6541.934580654132;6479.643619600967;6484.092227088211;6485.286618472059;6486.935130648728;6486.967565162144;6576.638284894281;6621.271660117383;6668.699908504129;6670.099536562599;6683.398494135551;5335.653182543122;5366.892662146735;5398.703071331114;5399.1091469907815;5399.622026458111;4546.863594092182;4585.312203169551;4603.033362993742;4615.746133962597;4633.953660463352;5724.484796368263;5739.196512488255;5806.390329015477;5824.679642619697;5843.503302219274;6598.802035938929;6610.933890661032;6723.529352945345;6730.0577919091365;6730.259671436138;5644.858878527987;5698.373178950312;5723.370429252779;5760.36635970043;5768.538516918637;5794.855128621818;5877.9118313225335;5888.676122813286;5888.764449422061;5896.115582662549;6367.745290188341;6372.426481616491;6375.2987171411105;6458.354164583598;6481.967590162019;6529.281779004401;6567.868642627216;6654.434373078343;6681.031250468752;6693.497987650849;6224.875502489835;6229.283632382334;6376.330485298977;6377.904331434939;6378.74485020594;6283.088952101828;6311.274203466476;6401.167848179707;6421;6433.935660643334;6495.545311828127;6564;6610.9669451652435;6634.137562116894;6658.6337751424135;6282.497400207881;6346.4605508532295;6361.713722882574;6363.6818159090935;6406.103145559532;6424.325445828307;6433.260175079926;6438.710258038306;6463.806085817245;6485.902711459426;6347;6362.045693146065;6362.809115726535;6420.165378500765;6464.2889282177985;6430.839229019312;6472.35276472349;6515.446187073962;6570.375814297634;6575.4410875076155;6209.96895015522;6215.689215539295;6216.968915155576;6222.657753823583;6280.874382512233 11:09:20 INFO - PID 14489 | |1;ext.html;811.6753298680527;854.7393045121239;870.9695160669374;873.3449912565578;1142.742882851358;31842.68157318426;42581.36127958079;42789.78605106974;43261.35107973383;43294.56705432945;43258.351124733155;43485.34771978423;43636.56363436364;43644.345334820006;43747.34378984318;7483.214262502441;7595.506292090997;7812.101608315032;7821.335186509154;7858.803529911741;7597.126330471983;7705.8844117338285;7709.036370453693;7710.730124445646;7713.8071548211465;7690.5770182639935;7727.459077864552;7749.070111586618;7751.961240193791;7752.030996125484;7645.655945482466;7649.31156195945;7649.38804895607;7660.731874384398;7694.807629809272;7519.962400188018;7568.735094271674;7569.129550101698;7633.427492938052;7653.196414376522;40044.59955400438;40316.39525407121;40328.79835600803;40397.394039089435;40483.595164048274;3466.289410670832;3518.138056176253;3537.168765340143;3545.69861561765;3548.574171099459;31545;31936.680633193602;31985;31985.680143198504;32047.359052818814;5096.286519887219;5123.487651234884;5162.948370516285;5174.793008279665;5179.171332586806;194200;194319;195039;195599;196290;49399;49589;49646.75176624094;49773.50226497761;49857.50142498528;52078.47921520812;52141.47858521442;52153;52160.73919630454;52219.21671174935;14875.553733388017;15101.622459438602;16789.076600787073;17129.201433849266;17176.656466870594;12530.310832904095;12675.112742107964;12747.936260318638;12776.488940442277;12867.42096605655;14793.260336983109;14804.111753294621;14837.703245935021;14866.851331486547;14963.251837408086;5597.272354593877;5682.147677848356;5682.886342273131;5698.116791897262;5949.672767997802;1019.5463018956493;1025.8512515685184;1031.4687935713114;1033.3283365812283;1040.95836166554;22727;22991.425214369774;23223.303300901;23269.41826454352;23279;1115.2193464574668;1130.6890605083504;1131.1007748839693;1144.9084073274119;1153.7288737146932;12185.634430967086;12206.816897746541;12315.261084334968;12331.815022774666;12349.814752778715;218956;222458;222617;222868;223031;54642;54694.45305546893;55187.17219241714;55194;55314.72342638261;1503.5940296120204;1521.5891709238444;1531.5022617649308;1543.9073655580476;1544.3359355477028;22280.66579001349;22416.77583224147;22424.327270181922;22908.541829163656;22924.19765308206;37651.81174094222;37957.24085518329;37957.430638540995;38065.23869522649;38163.42754858624;190539;191249;191791;192368;192387;34925.126871828405;35652.46521302235;36143.277134456635;36220.09449763777;36302.27395452129;47318;47324.52675473201;47493.287600685326;48288;49058.264126038855;35224.11939701528;35311;35536.28927421386;35627.46558801672;35850.28299434049;34504;34582;34873.65126348704;34884.30231395409;35026.474602880466;38023;38169.427458588696;38353.616463835;38370.80814596021;38470.42294365643;33683.15792105217;33800.1549961253;33837.492437612964;34114.31771364609;34425.13937151491;23727.1695490657;23856.64215036741;24471.265862024167;24480.87759561262;24778.87610562008 11:09:20 INFO - PID 14489 | |2;jquery.html;573.5440324941671;574.4456599381597;578.7424596054757;581.2066529187657;606.4966078155131;22276.443088922784;23015.42461438465;23185.18851840186;23236.535269294625;23288.184913528028;27884;28396.148115556516;28579.714202857966;28581.714182858166;28614.42771144581;7229.710811567544;7342.4493163012985;7358.043454350927;7387.039684840963;7419;6357;6997.82505437363;7018.719251229944;7036.190838053638;7039.120109986252;6965.26864679209;7015.964920175417;7034.753783617574;7045.084139061914;7048;6961.895571566431;6984.650767461632;7014.298570142996;7017.228104908456;7035.050268213802;6884.793456196322;6885.2770459101575;6885.380315771605;6894.310568943116;6916.827079323007;30692.386152277053;31069.689303106905;32324.353512929843;32557.6744232557;32598.18504537382;1990.7810140884492;2016.8890711010888;2018.4045706516613;2018.8586798924082;2020.464576887126;20533.691994620094;21159.04784284711;21216.787832121634;21266.36200913975;21301.68047479289;2462.655228268026;2594.792416606686;2597.6882774067044;2626.908058217953;2631.5526360518566;145945.27027364902;150961.24519377333;151774;151819;151884;22303;22577.88711056434;23107.653385199235;23473.53052938966;24030.7596924032;45397.319040214425;45617;45686;45709.77145114253;45781.77109114433;12320.199187052813;12401.93799030999;12424.875751242553;12528.310942898046;12556.372181391076;8994.910050899407;9407.670731524364;10328.554002439665;10371;10528.842067368996;11253.943730281297;11772.764544709058;12036.338001410006;12040.675525692166;12125.333106679218;4366.628836548929;4467.754273514923;4598.195315819718;4602.493725690171;4629.213033784265;951.8762560867182;963.8169545978225;979.3732011512637;986.3539381704994;986.5757724178673;19570.510737231398;20287.391378258675;20497.18011279562;20566.58866822655;20823.1670733172;1035.3529044347283;1042.3172821801732;1046.4401545173296;1047.5435104679514;1048.5229220704562;11078.201715173476;11505.827412588818;13390.330483475787;14347.426102955973;14586.562403127711;521683;539689;541969;546848;547603;126412;128022.35988819996;129611;131581.34209328893;133848;1235.234154823997;1265.1207410849556;1292.9224246545236;1301.8112373705949;1304.8303720516271;21386.259176269232;21604.67592986075;21690.783092169506;21719;21912.12351505922;58034.7098264506;59141.70429147999;59883.700581496814;61544.38455615386;61778.073328901;76050.6197469009;76774.616126919;77410.12949352397;77489.61255193688;78477;12162.452689628812;14818.407263709762;15215.011024283385;15323.233838308262;15427.151506667242;24222.273331800076;24285.51428971446;24309.39226519351;24425.26724198277;24597.877010614833;18703.625927481102;18880.43358699241;19038.809611903704;19196.520086997938;19214;16658.58353541171;17079.48761537156;17252.654946901243;17326.653466930842;17428.47714568565;18860.05699714981;19252.614947701248;19519.512012199808;19536.511587210432;19587.412377628694;14928.328225230109;14929.10425374481;14959.925200374364;14973.176475293527;15101.169435681142;18488.722669159706;18700.251989920795;18835.90582047136;19022.144003520152;19079.427617171506 11:09:20 INFO - PID 14489 | |3;mootools.html;1388.4376827384906;1444.0541445353297;1446.1467734036917;1454.0475988227715;1459.2266098967543;14153.504627338045;14734.263286835669;14748.705025899475;14771.926140369296;15089.39642414305;14905.850941490582;15143;15177.392904283815;15186.240687965612;15192.164430956293;2708.756211940925;2740.5204089284293;2740.6163137160715;2742.149933520605;2742.2184677366954;2589.469158822437;2689.5024420482273;2736.233854520737;2739.4794988952135;2739.917802465929;2708.729127087285;2722.3194201449637;2747.409306998995;2747.6290700755344;2749.752522272995;2672.665916760405;2695.811293209476;2699.784017278613;2714.5656694928916;2715.1447294102395;2590.7927365810688;2595.065776320523;2602.245348848832;2602.3364042169314;2602.973970260311;14198.787018194735;14542.054766440147;14552.636184095481;14567;14574.489892853699;7417.443691723142;7700.4609677322605;7726.575038372887;7750.496217745828;7760.534367937886;5043.218301163325;5150.922736158961;5355.4912283333415;5359.330083739533;5372.91940620891;1895.3082125024266;1924.028365675339;1940.3499827557785;1976.1107501624326;1985.900704964746;22429;22479.66280505794;22522.21172258963;22547.098116075336;22610.20864269759;6569.310222426577;6575.243846957565;6597.30728273534;6742.258351581322;6779.9322006780285;16115.033098014157;16210.675786484204;16240.187990600423;16249.431269905497;16281.837181628032;7593.544387336778;7716.614169291513;7719.884201736979;7744.535327880345;7746.961265193638;5982.252218472691;7075.575465472089;7105.964470177616;7132.572045677276;7302.707891684379;4734;5160.354955630546;5161.612879034087;5260.342457192851;5310.097283461821;1471.3373887507262;1481.977770333446;1488.9106653600818;1489.9255037248095;1505.8042454481067;824.9422540422113;839.1063517353998;852.8763329317214;862.6247582301594;869.891263592051;8361.83276334482;8510.446820956742;8543.914560854311;8620.439671421338;8641.351898607629;983.4640121133999;984.5667906121283;992.667456402099;997.5860018092555;997.7256254530063;4719.362886010414;4748.715077095385;5651.660900345993;5665.688387138664;5723.6851973141875;20406.591868162555;20596.485087872923;20698.68951965722;20740.58518829615;20958.952052397624;20540.383788486368;20884.37346879596;20906.37280881576;20998.685019724715;20999.265025724333;10171.338862974031;10768.192385571114;10776.92230776916;11017.953294437015;11025.393603351733;8034.196580341919;8057.355411566943;8707.651693932172;8905.777355566162;8934.687285944961;17387.478375648752;17430.564235893697;17439.651206975537;18277.908610456863;18290;16919.323227070778;16942.322307107577;16945.32218711238;17382;17410.825891740922;10821.242513024014;11986.64040078799;12237.632871013884;12247.938760306142;12253.938730306292;11065.778684426428;11473.827892581785;13357.933210333886;13415.396307166397;13461.798073029107;10760.139188865029;10826.458677065957;10846.837297440386;10975.615853445091;11192.888071119185;10512.316699414514;10842.349459032483;10944.264947490848;10977.12183025372;11050.447477625925;8747.60635771379;9484.383515071499;9582.616695332108;9610.327277090537;9748.415095094317;6704.752401147562;6810.693518791765;6839.829004274734;6873.690683919136;6876.106106206161;7128.857422851617;7135.215126336203;7145.46409019336;7189.784306470814;7190.784276471714 11:09:20 INFO - PID 14489 | |4;prototype.html;488.85857207821715;513.3172880069508;517.5161224255321;523.9214117882315;534.2307077807956;6194.845128871775;6208.441240288374;6247.68798552304;6256.217972753406;6360.809175724724;6106.603070800395;6142.53930955179;6163.764023887461;6168.722407491662;6225.501959843213;5031.32077169581;5142.151544995071;5153.330067091273;5159.690418574879;5208.5572726318305;4847.781849816767;4999.275250038749;5011.749412529377;5094.261332106842;5147.536721695046;4866.537678920497;4897.4123105227245;4902.117618828609;4946.752662366867;4980.153373926423;4908.386451693538;4930.901381972359;4938.753062346868;4961.7022978621035;4963.776630051656;4356.520782713899;4389.495208051083;4411.1618792429335;4423.380726698265;4477.395551600524;5920.171176035358;5961.463468287875;5964.717585719091;6005.789797357115;6038.547108966845;5690.374058853523;5697.629654072513;5704.8859022819315;5715.171300161495;5758.251427314464;6570.080188773575;6575.276719560892;6612.338766123397;6618.503612229102;6652.93347066528;4832.855014349575;4855.271709243606;4885.7068575885205;4911.214205727102;4916.53292937174;6580.795433529774;6603.768868089642;6738.730450782012;6822.488313376467;6853.109095817512;4945.975270123627;4959.429665588504;4997.275395067695;4998.6753510319795;5031.471695471996;5036.874078148002;5047.772850221749;5072.264521644414;5079.257201111433;5082.085224659597;5616.747246373923;5729.7708091676695;5734.053881109654;5745.310562732415;5764.827055188351;6670.299618540081;6673.332666733288;6675.7997260082275;6677.632730199788;6697.464202863759;1767.9558011049826;1772.56572139824;1773.804881463038;1787.7675902132898;1791.5162906015564;1177.2230327983489;1214.7266864955313;1225.338317308661;1236.8763123687738;1257.5975687779824;5753.539716822645;5791.3339965903615;5816.389279125631;5816.709164541756;5852.590318677737;6589.17635295588;6687.531872768859;6737.494687898427;6750.291219421988;6782.559133656297;5786.681732504669;5817;5821.359650438449;5829.15477255804;5832.125181222766;3548.822558872046;3569.94645080324;3593.94609080864;3595.6044835068124;3631.782093074424;6571.441427478718;6598.538102332791;6607.273199948002;6611.900821487681;6613.2394774601535;6934.133233345832;6951.852944264241;6966.9651651741415;6981.30186981308;6988.475864310197;6536.803895883131;6539.346065393518;6573.671316434255;6575.605463672195;6596.835079122964;6192.566520343533;6732.8653426930205;6732.899006514808;6800.693968771318;6805.761798337035;6726.8654626908165;6729;6780.796576102724;6792.456603471612;6814.182298124257;6475.125858009108;6497.577657452251;6504.869902601827;6531.869362612816;6592.241892182268;4954.232094025432;4976.278439626161;4999.325091112653;5026.321446604661;5065.265536497261;6442.8389290268115;6616.8345791355605;6644.734210631521;6816.386525212754;6825.054859365057;6407.583507072025;6415.599732141972;6486.578372405778;6506.284308725942;6507.446867016167;6443.903341449788;6480.675966201766;6493.415592596689;6497.772577959749;6531.738730450728;6396.904046439214;6400.967995159995;6478.708458119301;6540.738370465128;6541.313162117909;6616;6639.568428052161;6641.468682505291;6647.401733843977;6660.000999850061;6354;6461.709223084878;6468.773592924225;6476.057182845034;6497.18785151856 11:09:20 INFO - PID 14489 | |5;yui.html;901.1484147480634;903.7017784131237;922.3359181389402;926.2173463423405;930.6789157740577;17917;18590.16344264508;18635.906820465894;18636.62726745464;21806.563868722656;21457.248996285132;21823.781762182374;21848.8907555462;22016.119355225812;22049.559008819815;1016.6848277034106;1055.7835643693063;1061.0132576703663;1061.029158320136;1061.4904845674082;1009.6621975881949;1049.8582691336649;1058.4866339825178;1059.9205059620522;1067.4182570499097;1115.33080151909;1117.25144153417;1125.0718157520039;1127.6278827986744;1127.7969965406223;1117.2402766119035;1123.0285802780577;1124.235519846504;1126.054114543783;1126.2735535579586;812.7358608452217;816.9183081691842;819.2831272636444;820.3642177312571;822.6914906909909;19869.20523179071;20035;20062.398128056182;20288.594228115355;20901.268455603982;21387.786122138736;21474.46313842151;21912.89043554788;22568.66147007796;22890.88554557233;16984.235709393106;17131.486055418358;17202.741958870625;17298.82701172985;17330.653386932318;3649.178934739689;3663.4687970244167;3676.117731744362;3678.6137455567045;3679.6136405677285;126818.36590817079;128477.35761321227;129166;131035.34482327527;131903.34048329698;17147.571310717332;17175.570610734583;17301.134943252786;17674;17696.203670834842;31676.30634224163;31811.840940795148;31857.362852742815;32158;32187.195320116716;7508.211637778064;7873.5275883447175;8490.915090849136;8523.190296921783;8621.698240561676;4273.465816772903;4399.450068741407;4400.603945644843;4401.1417773534495;4401.273789824643;5212.218167274939;5322.733863306819;5360.303160589098;5368.436314186954;5381.730913454312;1083.712816103733;1096.4901320885826;1105.7125147461718;1106.5463160104318;1111.5053801058614;697.2191145916504;709.974087443639;711.1608302203347;720.2833180984953;732.3006528765017;12121.212121212093;12336.321502317458;12433.72242803078;12845.357732113356;13199;694.4687314204638;697.4699228586311;700.719712115158;705.3369832357567;716.913970323554;5619.129034999582;5649.745761440745;5692.516136128393;5783.652980821164;5871.853203669857;104495;107232;109933;110572.4471377638;113831;94066;96849.54725679121;97131;97744;99054.50472747734;81699;88478.11521884828;90102.54948725346;91028.08971910196;91487.08512914786;11962;12120.151589388659;12341.691457713629;12354.25874447536;12421;39487.21025579415;40005.79997100112;40054;40698.38952415657;41129;51394.74302628463;51439.742801285756;52027;52451.73774131257;52733.209001864234;18713.064346782878;18771.155298011894;18843.340483083026;19089;19179.520511987314;17712.46862594124;20435.795642043387;21076.789232107483;21457.57084858263;21810.56378872382;18824.435266942015;18958.24167033303;19106.7133992993;19108.044597770335;19175.32886348971;17517.21172547213;17523.474295771146;17524.82475175232;17635.823641763418;17672.381466648607;17285.481435556954;17420.216090276223;17446;17458.30166793314;17622.735658965383;14084.78872816888;14109.6472588182;14181.787273190705;14377;14449.422023118957;13166.802497962346;13334.733305334034;13495.325233738471;13514.797278041035;13537.390817413043 11:09:20 INFO - PID 14489 | __end_tp_report 11:09:20 INFO - PID 14489 | __start_cc_report 11:09:20 INFO - PID 14489 | _x_x_mozilla_cycle_collect,383 11:09:20 INFO - PID 14489 | __end_cc_report 11:09:20 INFO - PID 14489 | __startTimestamp1502734160706__endTimestamp 11:09:20 INFO - PID 14489 | 11:09:20 INFO - PID 14489 | ------- Summary: start ------- 11:09:20 INFO - PID 14489 | Number of tests: 6 11:09:20 INFO - PID 14489 | 11:09:20 INFO - PID 14489 | [#0] dojo.html Cycles:165 Average:6068.49 Median:6282.50 stddev:695.81 (11.1%) stddev-sans-first:658.99 11:09:20 INFO - PID 14489 | Values: 3142.1 3175.2 3177.0 3201.5 3205.7 6135.9 6138.4 6141.9 6146.4 6150.5 6040.6 6105.5 6108.1 6113.5 6133.7 5595.9 5596.3 5602.9 5604.0 5712.2 5672.3 5676.8 5684.2 5690.0 5697.3 5515.9 5595.0 5627.2 5734.8 5754.1 5585.8 5625.3 5677.8 5680.0 5706.0 5592.1 5602.5 5677.2 5679.6 5682.6 5955.4 6011.3 6075.8 6089.8 6150.3 6571.2 6581.5 6595.4 6597.6 6607.6 6658.0 6733.7 6733.9 6741.9 6772.7 6115.0 6133.6 6217.3 6226.8 6248.7 6592.4 6669.4 6673.6 6679.3 6818.9 6320.7 6381.6 6403.5 6415.0 6424.0 6523.3 6528.4 6533.2 6536.5 6541.9 6479.6 6484.1 6485.3 6486.9 6487.0 6576.6 6621.3 6668.7 6670.1 6683.4 5335.7 5366.9 5398.7 5399.1 5399.6 4546.9 4585.3 4603.0 4615.7 4634.0 5724.5 5739.2 5806.4 5824.7 5843.5 6598.8 6610.9 6723.5 6730.1 6730.3 5644.9 5698.4 5723.4 5760.4 5768.5 5794.9 5877.9 5888.7 5888.8 5896.1 6367.7 6372.4 6375.3 6458.4 6482.0 6529.3 6567.9 6654.4 6681.0 6693.5 6224.9 6229.3 6376.3 6377.9 6378.7 6283.1 6311.3 6401.2 6421.0 6433.9 6495.5 6564.0 6611.0 6634.1 6658.6 6282.5 6346.5 6361.7 6363.7 6406.1 6424.3 6433.3 6438.7 6463.8 6485.9 6347.0 6362.0 6362.8 6420.2 6464.3 6430.8 6472.4 6515.4 6570.4 6575.4 6210.0 6215.7 6217.0 6222.7 6280.9 11:09:20 INFO - PID 14489 | 11:09:20 INFO - PID 14489 | [#1] ext.html Cycles:180 Average:38047.53 Median:35581.88 stddev:52668.22 (148.0%) stddev-sans-first:52741.75 11:09:20 INFO - PID 14489 | Values: 811.7 854.7 871.0 873.3 1142.7 31842.7 42581.4 42789.8 43261.4 43294.6 43258.4 43485.3 43636.6 43644.3 43747.3 7483.2 7595.5 7812.1 7821.3 7858.8 7597.1 7705.9 7709.0 7710.7 7713.8 7690.6 7727.5 7749.1 7752.0 7752.0 7645.7 7649.3 7649.4 7660.7 7694.8 7520.0 7568.7 7569.1 7633.4 7653.2 40044.6 40316.4 40328.8 40397.4 40483.6 3466.3 3518.1 3537.2 3545.7 3548.6 31545.0 31936.7 31985.0 31985.7 32047.4 5096.3 5123.5 5162.9 5174.8 5179.2 194200.0 194319.0 195039.0 195599.0 196290.0 49399.0 49589.0 49646.8 49773.5 49857.5 52078.5 52141.5 52153.0 52160.7 52219.2 14875.6 15101.6 16789.1 17129.2 17176.7 12530.3 12675.1 12747.9 12776.5 12867.4 14793.3 14804.1 14837.7 14866.9 14963.3 5597.3 5682.1 5682.9 5698.1 5949.7 1019.5 1025.9 1031.5 1033.3 1041.0 22727.0 22991.4 23223.3 23269.4 23279.0 1115.2 1130.7 1131.1 1144.9 1153.7 12185.6 12206.8 12315.3 12331.8 12349.8 218956.0 222458.0 222617.0 222868.0 223031.0 54642.0 54694.5 55187.2 55194.0 55314.7 1503.6 1521.6 1531.5 1543.9 1544.3 22280.7 22416.8 22424.3 22908.5 22924.2 37651.8 37957.2 37957.4 38065.2 38163.4 190539.0 191249.0 191791.0 192368.0 192387.0 34925.1 35652.5 36143.3 36220.1 36302.3 47318.0 47324.5 47493.3 48288.0 49058.3 35224.1 35311.0 35536.3 35627.5 35850.3 34504.0 34582.0 34873.7 34884.3 35026.5 38023.0 38169.4 38353.6 38370.8 38470.4 33683.2 33800.2 33837.5 34114.3 34425.1 23727.2 23856.6 24471.3 24480.9 24778.9 11:09:20 INFO - PID 14489 | 11:09:20 INFO - PID 14489 | [#2] jquery.html Cycles:180 Average:38777.30 Median:22796.66 stddev:90890.50 (398.7%) stddev-sans-first:91100.21 11:09:20 INFO - PID 14489 | Values: 573.5 574.4 578.7 581.2 606.5 22276.4 23015.4 23185.2 23236.5 23288.2 27884.0 28396.1 28579.7 28581.7 28614.4 7229.7 7342.4 7358.0 7387.0 7419.0 6357.0 6997.8 7018.7 7036.2 7039.1 6965.3 7016.0 7034.8 7045.1 7048.0 6961.9 6984.7 7014.3 7017.2 7035.1 6884.8 6885.3 6885.4 6894.3 6916.8 30692.4 31069.7 32324.4 32557.7 32598.2 1990.8 2016.9 2018.4 2018.9 2020.5 20533.7 21159.0 21216.8 21266.4 21301.7 2462.7 2594.8 2597.7 2626.9 2631.6 145945.3 150961.2 151774.0 151819.0 151884.0 22303.0 22577.9 23107.7 23473.5 24030.8 45397.3 45617.0 45686.0 45709.8 45781.8 12320.2 12401.9 12424.9 12528.3 12556.4 8994.9 9407.7 10328.6 10371.0 10528.8 11253.9 11772.8 12036.3 12040.7 12125.3 4366.6 4467.8 4598.2 4602.5 4629.2 951.9 963.8 979.4 986.4 986.6 19570.5 20287.4 20497.2 20566.6 20823.2 1035.4 1042.3 1046.4 1047.5 1048.5 11078.2 11505.8 13390.3 14347.4 14586.6 521683.0 539689.0 541969.0 546848.0 547603.0 126412.0 128022.4 129611.0 131581.3 133848.0 1235.2 1265.1 1292.9 1301.8 1304.8 21386.3 21604.7 21690.8 21719.0 21912.1 58034.7 59141.7 59883.7 61544.4 61778.1 76050.6 76774.6 77410.1 77489.6 78477.0 12162.5 14818.4 15215.0 15323.2 15427.2 24222.3 24285.5 24309.4 24425.3 24597.9 18703.6 18880.4 19038.8 19196.5 19214.0 16658.6 17079.5 17252.7 17326.7 17428.5 18860.1 19252.6 19519.5 19536.5 19587.4 14928.3 14929.1 14959.9 14973.2 15101.2 18488.7 18700.3 18835.9 19022.1 19079.4 11:09:20 INFO - PID 14489 | 11:09:20 INFO - PID 14489 | [#3] mootools.html Cycles:180 Average:8937.92 Median:2637.82 stddev:6132.90 (232.5%) stddev-sans-first:6123.87 11:09:20 INFO - PID 14489 | Values: 1388.4 1444.1 1446.1 1454.0 1459.2 14153.5 14734.3 14748.7 14771.9 15089.4 14905.9 15143.0 15177.4 15186.2 15192.2 2708.8 2740.5 2740.6 2742.1 2742.2 2589.5 2689.5 2736.2 2739.5 2739.9 2708.7 2722.3 2747.4 2747.6 2749.8 2672.7 2695.8 2699.8 2714.6 2715.1 2590.8 2595.1 2602.2 2602.3 2603.0 14198.8 14542.1 14552.6 14567.0 14574.5 7417.4 7700.5 7726.6 7750.5 7760.5 5043.2 5150.9 5355.5 5359.3 5372.9 1895.3 1924.0 1940.3 1976.1 1985.9 22429.0 22479.7 22522.2 22547.1 22610.2 6569.3 6575.2 6597.3 6742.3 6779.9 16115.0 16210.7 16240.2 16249.4 16281.8 7593.5 7716.6 7719.9 7744.5 7747.0 5982.3 7075.6 7106.0 7132.6 7302.7 4734.0 5160.4 5161.6 5260.3 5310.1 1471.3 1482.0 1488.9 1489.9 1505.8 824.9 839.1 852.9 862.6 869.9 8361.8 8510.4 8543.9 8620.4 8641.4 983.5 984.6 992.7 997.6 997.7 4719.4 4748.7 5651.7 5665.7 5723.7 20406.6 20596.5 20698.7 20740.6 20959.0 20540.4 20884.4 20906.4 20998.7 20999.3 10171.3 10768.2 10776.9 11018.0 11025.4 8034.2 8057.4 8707.7 8905.8 8934.7 17387.5 17430.6 17439.7 18277.9 18290.0 16919.3 16942.3 16945.3 17382.0 17410.8 10821.2 11986.6 12237.6 12247.9 12253.9 11065.8 11473.8 13357.9 13415.4 13461.8 10760.1 10826.5 10846.8 10975.6 11192.9 10512.3 10842.3 10944.3 10977.1 11050.4 8747.6 9484.4 9582.6 9610.3 9748.4 6704.8 6810.7 6839.8 6873.7 6876.1 7128.9 7135.2 7145.5 7189.8 7190.8 11:09:20 INFO - PID 14489 | 11:09:20 INFO - PID 14489 | [#4] prototype.html Cycles:180 Average:5524.73 Median:6124.57 stddev:1550.14 (25.3%) stddev-sans-first:1507.71 11:09:20 INFO - PID 14489 | Values: 488.9 513.3 517.5 523.9 534.2 6194.8 6208.4 6247.7 6256.2 6360.8 6106.6 6142.5 6163.8 6168.7 6225.5 5031.3 5142.2 5153.3 5159.7 5208.6 4847.8 4999.3 5011.7 5094.3 5147.5 4866.5 4897.4 4902.1 4946.8 4980.2 4908.4 4930.9 4938.8 4961.7 4963.8 4356.5 4389.5 4411.2 4423.4 4477.4 5920.2 5961.5 5964.7 6005.8 6038.5 5690.4 5697.6 5704.9 5715.2 5758.3 6570.1 6575.3 6612.3 6618.5 6652.9 4832.9 4855.3 4885.7 4911.2 4916.5 6580.8 6603.8 6738.7 6822.5 6853.1 4946.0 4959.4 4997.3 4998.7 5031.5 5036.9 5047.8 5072.3 5079.3 5082.1 5616.7 5729.8 5734.1 5745.3 5764.8 6670.3 6673.3 6675.8 6677.6 6697.5 1768.0 1772.6 1773.8 1787.8 1791.5 1177.2 1214.7 1225.3 1236.9 1257.6 5753.5 5791.3 5816.4 5816.7 5852.6 6589.2 6687.5 6737.5 6750.3 6782.6 5786.7 5817.0 5821.4 5829.2 5832.1 3548.8 3569.9 3593.9 3595.6 3631.8 6571.4 6598.5 6607.3 6611.9 6613.2 6934.1 6951.9 6967.0 6981.3 6988.5 6536.8 6539.3 6573.7 6575.6 6596.8 6192.6 6732.9 6732.9 6800.7 6805.8 6726.9 6729.0 6780.8 6792.5 6814.2 6475.1 6497.6 6504.9 6531.9 6592.2 4954.2 4976.3 4999.3 5026.3 5065.3 6442.8 6616.8 6644.7 6816.4 6825.1 6407.6 6415.6 6486.6 6506.3 6507.4 6443.9 6480.7 6493.4 6497.8 6531.7 6396.9 6401.0 6478.7 6540.7 6541.3 6616.0 6639.6 6641.5 6647.4 6660.0 6354.0 6461.7 6468.8 6476.1 6497.2 11:09:20 INFO - PID 14489 | 11:09:20 INFO - PID 14489 | [#5] yui.html Cycles:180 Average:23558.81 Median:19952.10 stddev:31838.13 (159.6%) stddev-sans-first:31881.98 11:09:20 INFO - PID 14489 | Values: 901.1 903.7 922.3 926.2 930.7 17917.0 18590.2 18635.9 18636.6 21806.6 21457.2 21823.8 21848.9 22016.1 22049.6 1016.7 1055.8 1061.0 1061.0 1061.5 1009.7 1049.9 1058.5 1059.9 1067.4 1115.3 1117.3 1125.1 1127.6 1127.8 1117.2 1123.0 1124.2 1126.1 1126.3 812.7 816.9 819.3 820.4 822.7 19869.2 20035.0 20062.4 20288.6 20901.3 21387.8 21474.5 21912.9 22568.7 22890.9 16984.2 17131.5 17202.7 17298.8 17330.7 3649.2 3663.5 3676.1 3678.6 3679.6 126818.4 128477.4 129166.0 131035.3 131903.3 17147.6 17175.6 17301.1 17674.0 17696.2 31676.3 31811.8 31857.4 32158.0 32187.2 7508.2 7873.5 8490.9 8523.2 8621.7 4273.5 4399.5 4400.6 4401.1 4401.3 5212.2 5322.7 5360.3 5368.4 5381.7 1083.7 1096.5 1105.7 1106.5 1111.5 697.2 710.0 711.2 720.3 732.3 12121.2 12336.3 12433.7 12845.4 13199.0 694.5 697.5 700.7 705.3 716.9 5619.1 5649.7 5692.5 5783.7 5871.9 104495.0 107232.0 109933.0 110572.4 113831.0 94066.0 96849.5 97131.0 97744.0 99054.5 81699.0 88478.1 90102.5 91028.1 91487.1 11962.0 12120.2 12341.7 12354.3 12421.0 39487.2 40005.8 40054.0 40698.4 41129.0 51394.7 51439.7 52027.0 52451.7 52733.2 18713.1 18771.2 18843.3 19089.0 19179.5 17712.5 20435.8 21076.8 21457.6 21810.6 18824.4 18958.2 19106.7 19108.0 19175.3 17517.2 17523.5 17524.8 17635.8 17672.4 17285.5 17420.2 17446.0 17458.3 17622.7 14084.8 14109.6 14181.8 14377.0 14449.4 13166.8 13334.7 13495.3 13514.8 13537.4 11:09:20 INFO - PID 14489 | -------- Summary: end -------- 11:09:20 INFO - PID 14489 | 11:09:21 INFO - TEST-INFO | 14489: exit 0 11:09:21 INFO - TEST-OK | dromaeo_css | took 1113426ms 11:09:21 INFO - TEST-START | kraken 11:09:21 INFO - Initialising browser for kraken test... 11:09:21 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38606/getInfo.html -profile /tmp/tmpSYAXC3/profile 11:09:21 INFO - TEST-INFO | started process 14863 (/builds/slave/test/build/application/firefox/firefox http://localhost:38606/getInfo.html) 11:09:27 INFO - TEST-INFO | 14863: exit 0 11:09:27 INFO - Browser initialized. 11:09:27 INFO - Running cycle 1/1 for kraken test... 11:09:27 INFO - TEST-INFO | started process 15102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSYAXC3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:28 INFO - PID 15102 | 11:09:28 INFO - PID 15102 | (/builds/slave/test/build/application/firefox/firefox:15157): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:09:28 INFO - PID 15102 | 11:09:39 INFO - PID 15102 | RSS: Main: 167596032 11:09:39 INFO - PID 15102 | 11:09:41 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38606/tests/kraken/driver.html?testName=audio-beat-detection) 11:09:42 INFO - PID 15102 | RSS: Main: 174141440 11:09:42 INFO - PID 15102 | 11:09:45 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38606/tests/kraken/driver.html?testName=audio-dft) 11:09:46 INFO - PID 15102 | RSS: Main: 177979392 11:09:46 INFO - PID 15102 | 11:09:49 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38606/tests/kraken/driver.html?testName=audio-fft) 11:09:49 INFO - PID 15102 | RSS: Main: 172097536 11:09:49 INFO - PID 15102 | 11:09:52 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38606/tests/kraken/driver.html?testName=audio-oscillator) 11:09:52 INFO - PID 15102 | RSS: Main: 172929024 11:09:52 INFO - PID 15102 | 11:09:54 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38606/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:09:55 INFO - PID 15102 | RSS: Main: 172941312 11:09:55 INFO - PID 15102 | 11:09:58 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38606/tests/kraken/driver.html?testName=imaging-darkroom) 11:09:59 INFO - PID 15102 | RSS: Main: 173985792 11:09:59 INFO - PID 15102 | 11:10:02 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38606/tests/kraken/driver.html?testName=imaging-desaturate) 11:10:03 INFO - PID 15102 | RSS: Main: 173432832 11:10:03 INFO - PID 15102 | 11:10:06 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38606/tests/kraken/driver.html?testName=json-parse-financial) 11:10:07 INFO - PID 15102 | RSS: Main: 174338048 11:10:07 INFO - PID 15102 | 11:10:08 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38606/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:10:09 INFO - PID 15102 | RSS: Main: 174387200 11:10:09 INFO - PID 15102 | 11:10:11 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:10:11 INFO - PID 15102 | RSS: Main: 174428160 11:10:11 INFO - PID 15102 | 11:10:13 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:10:14 INFO - PID 15102 | RSS: Main: 173977600 11:10:14 INFO - PID 15102 | 11:10:17 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:10:18 INFO - PID 15102 | RSS: Main: 174747648 11:10:18 INFO - PID 15102 | 11:10:21 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:10:21 INFO - PID 15102 | RSS: Main: 174854144 11:10:21 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | Cycle 1(1): loaded http://localhost:38606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38606/tests/kraken/driver.html?testName=ai-astar) 11:10:23 INFO - PID 15102 | RSS: Main: 176447488 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | __start_tp_report 11:10:23 INFO - PID 15102 | _x_x_mozilla_page_load 11:10:23 INFO - PID 15102 | _x_x_mozilla_page_load_details 11:10:23 INFO - PID 15102 | |i|pagename|runs| 11:10:23 INFO - PID 15102 | |0;ai-astar;98;108;108;107;116;113;114;100;107;113 11:10:23 INFO - PID 15102 | |1;audio-beat-detection;143;124;141;177;120;149;150;120;175;125 11:10:23 INFO - PID 15102 | |2;audio-dft;163;162;162;164;164;164;170;168;165;164 11:10:23 INFO - PID 15102 | |3;audio-fft;76;75;75;185;76;74;75;89;95;81 11:10:23 INFO - PID 15102 | |4;audio-oscillator;79;79;129;85;79;80;127;79;78;139 11:10:23 INFO - PID 15102 | |5;imaging-gaussian-blur;114;118;114;113;115;115;115;114;116;114 11:10:23 INFO - PID 15102 | |6;imaging-darkroom;149;149;150;150;151;149;150;150;150;153 11:10:23 INFO - PID 15102 | |7;imaging-desaturate;94;94;96;94;94;95;98;99;98;98 11:10:23 INFO - PID 15102 | |8;json-parse-financial;55;54;59;54;62;62;55;57;53;55 11:10:23 INFO - PID 15102 | |9;json-stringify-tinderbox;60;54;55;55;54;54;56;54;59;54 11:10:23 INFO - PID 15102 | |10;stanford-crypto-aes;77;76;78;79;77;77;78;79;88;77 11:10:23 INFO - PID 15102 | |11;stanford-crypto-ccm;124;134;122;131;133;125;124;121;126;164 11:10:23 INFO - PID 15102 | |12;stanford-crypto-pbkdf2;184;172;175;188;193;175;175;182;177;172 11:10:23 INFO - PID 15102 | |13;stanford-crypto-sha256-iterative;68;69;66;68;68;66;67;65;69;67 11:10:23 INFO - PID 15102 | __end_tp_report 11:10:23 INFO - PID 15102 | __start_cc_report 11:10:23 INFO - PID 15102 | _x_x_mozilla_cycle_collect,969 11:10:23 INFO - PID 15102 | __end_cc_report 11:10:23 INFO - PID 15102 | __startTimestamp1502734223907__endTimestamp 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | ------- Summary: start ------- 11:10:23 INFO - PID 15102 | Number of tests: 14 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#0] ai-astar Cycles:10 Average:108.40 Median:113.00 stddev:5.91 (5.2%) stddev-sans-first:4.93 11:10:23 INFO - PID 15102 | Values: 98.0 108.0 108.0 107.0 116.0 113.0 114.0 100.0 107.0 113.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:146.00 stddev:21.10 (14.5%) stddev-sans-first:22.38 11:10:23 INFO - PID 15102 | Values: 143.0 124.0 141.0 177.0 120.0 149.0 150.0 120.0 175.0 125.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:2.55 (1.6%) stddev-sans-first:2.64 11:10:23 INFO - PID 15102 | Values: 163.0 162.0 162.0 164.0 164.0 164.0 170.0 168.0 165.0 164.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#3] audio-fft Cycles:10 Average:90.10 Median:76.00 stddev:34.08 (44.8%) stddev-sans-first:35.77 11:10:23 INFO - PID 15102 | Values: 76.0 75.0 75.0 185.0 76.0 74.0 75.0 89.0 95.0 81.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:79.00 stddev:25.28 (32.0%) stddev-sans-first:26.11 11:10:23 INFO - PID 15102 | Values: 79.0 79.0 129.0 85.0 79.0 80.0 127.0 79.0 78.0 139.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:1.40 (1.2%) stddev-sans-first:1.45 11:10:23 INFO - PID 15102 | Values: 114.0 118.0 114.0 113.0 115.0 115.0 115.0 114.0 116.0 114.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#6] imaging-darkroom Cycles:10 Average:150.10 Median:150.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 11:10:23 INFO - PID 15102 | Values: 149.0 149.0 150.0 150.0 151.0 149.0 150.0 150.0 150.0 153.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:97.00 stddev:2.05 (2.1%) stddev-sans-first:2.05 11:10:23 INFO - PID 15102 | Values: 94.0 94.0 96.0 94.0 94.0 95.0 98.0 99.0 98.0 98.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:3.31 (5.9%) stddev-sans-first:3.46 11:10:23 INFO - PID 15102 | Values: 55.0 54.0 59.0 54.0 62.0 62.0 55.0 57.0 53.0 55.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.00 stddev:2.22 (4.0%) stddev-sans-first:1.66 11:10:23 INFO - PID 15102 | Values: 60.0 54.0 55.0 55.0 54.0 54.0 56.0 54.0 59.0 54.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:78.00 stddev:3.44 (4.4%) stddev-sans-first:3.60 11:10:23 INFO - PID 15102 | Values: 77.0 76.0 78.0 79.0 77.0 77.0 78.0 79.0 88.0 77.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:128.50 stddev:12.64 (9.8%) stddev-sans-first:13.20 11:10:23 INFO - PID 15102 | Values: 124.0 134.0 122.0 131.0 133.0 125.0 124.0 121.0 126.0 164.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:179.50 stddev:7.15 (4.0%) stddev-sans-first:7.38 11:10:23 INFO - PID 15102 | Values: 184.0 172.0 175.0 188.0 193.0 175.0 175.0 182.0 177.0 172.0 11:10:23 INFO - PID 15102 | 11:10:23 INFO - PID 15102 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:1.34 (2.0%) stddev-sans-first:1.39 11:10:23 INFO - PID 15102 | Values: 68.0 69.0 66.0 68.0 68.0 66.0 67.0 65.0 69.0 67.0 11:10:23 INFO - PID 15102 | -------- Summary: end -------- 11:10:23 INFO - PID 15102 | 11:10:24 INFO - PID 15102 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:10:24 INFO - TEST-INFO | 15102: exit 0 11:10:24 INFO - TEST-OK | kraken | took 63245ms 11:10:24 INFO - SUITE-END | took 1176s 11:10:25 INFO - Completed test suite (00:19:37) 11:10:25 INFO - javascript benchmark 11:10:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8698.440575563665, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3142.1045002174383, 3175.1744546417926, 3177.031005543309, 3201.503766916129, 3205.7435405167575, 6135.938640613593, 6138.355472675372, 6141.938580614193, 6146.416090471398, 6150.477209437197, 6040.637561746287, 6105.511559075275, 6108.053251745975, 6113.480354169889, 6133.723982420791, 5595.8601034974145, 5596.300462442195, 5602.887942241153, 5603.99999999998, 5712.22884910538, 5672.34768001681, 5676.829695109153, 5684.175794509793, 5690.032694441934, 5697.259356283677, 5515.889682206373, 5594.9720251398885, 5627.240322556443, 5734.827955161331, 5754.108113242433, 5585.776568937237, 5625.268715067056, 5677.829665110054, 5680.034394153004, 5706.029974904276, 5592.077307244341, 5602.523785478239, 5677.176809362661, 5679.574031947621, 5682.573806964453, 5955.37468565803, 6011.27864656244, 6075.817725468243, 6089.756409743605, 6150.323464418911, 6571.211454625428, 6581.473482121419, 6595.439387652055, 6597.571157874723, 6607.603543787388, 6657.966710166466, 6733.696983635699, 6733.8989915151315, 6741.93258067418, 6772.72909083641, 6115.0, 6133.570650054543, 6217.316095229567, 6226.750929962751, 6248.656323902229, 6592.373724496165, 6669.4330981866115, 6673.566218195801, 6679.298673639198, 6818.863622727517, 6320.652364120017, 6381.617102973743, 6403.48772098231, 6415.037744338387, 6424.036394540856, 6523.347665233438, 6528.445082167974, 6533.24867640218, 6536.477081833442, 6541.934580654132, 6479.643619600967, 6484.092227088211, 6485.286618472059, 6486.935130648728, 6486.967565162144, 6576.638284894281, 6621.271660117383, 6668.699908504129, 6670.099536562599, 6683.398494135551, 5335.653182543122, 5366.892662146735, 5398.703071331114, 5399.1091469907815, 5399.622026458111, 4546.863594092182, 4585.312203169551, 4603.033362993742, 4615.746133962597, 4633.953660463352, 5724.484796368263, 5739.196512488255, 5806.390329015477, 5824.679642619697, 5843.503302219274, 6598.802035938929, 6610.933890661032, 6723.529352945345, 6730.0577919091365, 6730.259671436138, 5644.858878527987, 5698.373178950312, 5723.370429252779, 5760.36635970043, 5768.538516918637, 5794.855128621818, 5877.9118313225335, 5888.676122813286, 5888.764449422061, 5896.115582662549, 6367.745290188341, 6372.426481616491, 6375.2987171411105, 6458.354164583598, 6481.967590162019, 6529.281779004401, 6567.868642627216, 6654.434373078343, 6681.031250468752, 6693.497987650849, 6224.875502489835, 6229.283632382334, 6376.330485298977, 6377.904331434939, 6378.74485020594, 6283.088952101828, 6311.274203466476, 6401.167848179707, 6421.0, 6433.935660643334, 6495.545311828127, 6564.0, 6610.9669451652435, 6634.137562116894, 6658.6337751424135, 6282.497400207881, 6346.4605508532295, 6361.713722882574, 6363.6818159090935, 6406.103145559532, 6424.325445828307, 6433.260175079926, 6438.710258038306, 6463.806085817245, 6485.902711459426, 6347.0, 6362.045693146065, 6362.809115726535, 6420.165378500765, 6464.2889282177985, 6430.839229019312, 6472.35276472349, 6515.446187073962, 6570.375814297634, 6575.4410875076155, 6209.96895015522, 6215.689215539295, 6216.968915155576, 6222.657753823583, 6280.874382512233], "value": 6017.958205490864, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [811.6753298680527, 854.7393045121239, 870.9695160669374, 873.3449912565578, 1142.742882851358, 31842.68157318426, 42581.36127958079, 42789.78605106974, 43261.35107973383, 43294.56705432945, 43258.351124733155, 43485.34771978423, 43636.56363436364, 43644.345334820006, 43747.34378984318, 7483.214262502441, 7595.506292090997, 7812.101608315032, 7821.335186509154, 7858.803529911741, 7597.126330471983, 7705.8844117338285, 7709.036370453693, 7710.730124445646, 7713.8071548211465, 7690.5770182639935, 7727.459077864552, 7749.070111586618, 7751.961240193791, 7752.030996125484, 7645.655945482466, 7649.31156195945, 7649.38804895607, 7660.731874384398, 7694.807629809272, 7519.962400188018, 7568.735094271674, 7569.129550101698, 7633.427492938052, 7653.196414376522, 40044.59955400438, 40316.39525407121, 40328.79835600803, 40397.394039089435, 40483.595164048274, 3466.289410670832, 3518.138056176253, 3537.168765340143, 3545.69861561765, 3548.574171099459, 31545.0, 31936.680633193602, 31985.0, 31985.680143198504, 32047.359052818814, 5096.286519887219, 5123.487651234884, 5162.948370516285, 5174.793008279665, 5179.171332586806, 194200.0, 194319.0, 195039.0, 195599.0, 196290.0, 49399.0, 49589.0, 49646.75176624094, 49773.50226497761, 49857.50142498528, 52078.47921520812, 52141.47858521442, 52153.0, 52160.73919630454, 52219.21671174935, 14875.553733388017, 15101.622459438602, 16789.076600787073, 17129.201433849266, 17176.656466870594, 12530.310832904095, 12675.112742107964, 12747.936260318638, 12776.488940442277, 12867.42096605655, 14793.260336983109, 14804.111753294621, 14837.703245935021, 14866.851331486547, 14963.251837408086, 5597.272354593877, 5682.147677848356, 5682.886342273131, 5698.116791897262, 5949.672767997802, 1019.5463018956493, 1025.8512515685184, 1031.4687935713114, 1033.3283365812283, 1040.95836166554, 22727.0, 22991.425214369774, 23223.303300901, 23269.41826454352, 23279.0, 1115.2193464574668, 1130.6890605083504, 1131.1007748839693, 1144.9084073274119, 1153.7288737146932, 12185.634430967086, 12206.816897746541, 12315.261084334968, 12331.815022774666, 12349.814752778715, 218956.0, 222458.0, 222617.0, 222868.0, 223031.0, 54642.0, 54694.45305546893, 55187.17219241714, 55194.0, 55314.72342638261, 1503.5940296120204, 1521.5891709238444, 1531.5022617649308, 1543.9073655580476, 1544.3359355477028, 22280.66579001349, 22416.77583224147, 22424.327270181922, 22908.541829163656, 22924.19765308206, 37651.81174094222, 37957.24085518329, 37957.430638540995, 38065.23869522649, 38163.42754858624, 190539.0, 191249.0, 191791.0, 192368.0, 192387.0, 34925.126871828405, 35652.46521302235, 36143.277134456635, 36220.09449763777, 36302.27395452129, 47318.0, 47324.52675473201, 47493.287600685326, 48288.0, 49058.264126038855, 35224.11939701528, 35311.0, 35536.28927421386, 35627.46558801672, 35850.28299434049, 34504.0, 34582.0, 34873.65126348704, 34884.30231395409, 35026.474602880466, 38023.0, 38169.427458588696, 38353.616463835, 38370.80814596021, 38470.42294365643, 33683.15792105217, 33800.1549961253, 33837.492437612964, 34114.31771364609, 34425.13937151491, 23727.1695490657, 23856.64215036741, 24471.265862024167, 24480.87759561262, 24778.87610562008], "value": 17538.78683261403, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.5440324941671, 574.4456599381597, 578.7424596054757, 581.2066529187657, 606.4966078155131, 22276.443088922784, 23015.42461438465, 23185.18851840186, 23236.535269294625, 23288.184913528028, 27884.0, 28396.148115556516, 28579.714202857966, 28581.714182858166, 28614.42771144581, 7229.710811567544, 7342.4493163012985, 7358.043454350927, 7387.039684840963, 7419.0, 6357.0, 6997.82505437363, 7018.719251229944, 7036.190838053638, 7039.120109986252, 6965.26864679209, 7015.964920175417, 7034.753783617574, 7045.084139061914, 7048.0, 6961.895571566431, 6984.650767461632, 7014.298570142996, 7017.228104908456, 7035.050268213802, 6884.793456196322, 6885.2770459101575, 6885.380315771605, 6894.310568943116, 6916.827079323007, 30692.386152277053, 31069.689303106905, 32324.353512929843, 32557.6744232557, 32598.18504537382, 1990.7810140884492, 2016.8890711010888, 2018.4045706516613, 2018.8586798924082, 2020.464576887126, 20533.691994620094, 21159.04784284711, 21216.787832121634, 21266.36200913975, 21301.68047479289, 2462.655228268026, 2594.792416606686, 2597.6882774067044, 2626.908058217953, 2631.5526360518566, 145945.27027364902, 150961.24519377333, 151774.0, 151819.0, 151884.0, 22303.0, 22577.88711056434, 23107.653385199235, 23473.53052938966, 24030.7596924032, 45397.319040214425, 45617.0, 45686.0, 45709.77145114253, 45781.77109114433, 12320.199187052813, 12401.93799030999, 12424.875751242553, 12528.310942898046, 12556.372181391076, 8994.910050899407, 9407.670731524364, 10328.554002439665, 10371.0, 10528.842067368996, 11253.943730281297, 11772.764544709058, 12036.338001410006, 12040.675525692166, 12125.333106679218, 4366.628836548929, 4467.754273514923, 4598.195315819718, 4602.493725690171, 4629.213033784265, 951.8762560867182, 963.8169545978225, 979.3732011512637, 986.3539381704994, 986.5757724178673, 19570.510737231398, 20287.391378258675, 20497.18011279562, 20566.58866822655, 20823.1670733172, 1035.3529044347283, 1042.3172821801732, 1046.4401545173296, 1047.5435104679514, 1048.5229220704562, 11078.201715173476, 11505.827412588818, 13390.330483475787, 14347.426102955973, 14586.562403127711, 521683.0, 539689.0, 541969.0, 546848.0, 547603.0, 126412.0, 128022.35988819996, 129611.0, 131581.34209328893, 133848.0, 1235.234154823997, 1265.1207410849556, 1292.9224246545236, 1301.8112373705949, 1304.8303720516271, 21386.259176269232, 21604.67592986075, 21690.783092169506, 21719.0, 21912.12351505922, 58034.7098264506, 59141.70429147999, 59883.700581496814, 61544.38455615386, 61778.073328901, 76050.6197469009, 76774.616126919, 77410.12949352397, 77489.61255193688, 78477.0, 12162.452689628812, 14818.407263709762, 15215.011024283385, 15323.233838308262, 15427.151506667242, 24222.273331800076, 24285.51428971446, 24309.39226519351, 24425.26724198277, 24597.877010614833, 18703.625927481102, 18880.43358699241, 19038.809611903704, 19196.520086997938, 19214.0, 16658.58353541171, 17079.48761537156, 17252.654946901243, 17326.653466930842, 17428.47714568565, 18860.05699714981, 19252.614947701248, 19519.512012199808, 19536.511587210432, 19587.412377628694, 14928.328225230109, 14929.10425374481, 14959.925200374364, 14973.176475293527, 15101.169435681142, 18488.722669159706, 18700.251989920795, 18835.90582047136, 19022.144003520152, 19079.427617171506], "value": 13393.050573597588, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.4376827384906, 1444.0541445353297, 1446.1467734036917, 1454.0475988227715, 1459.2266098967543, 14153.504627338045, 14734.263286835669, 14748.705025899475, 14771.926140369296, 15089.39642414305, 14905.850941490582, 15143.0, 15177.392904283815, 15186.240687965612, 15192.164430956293, 2708.756211940925, 2740.5204089284293, 2740.6163137160715, 2742.149933520605, 2742.2184677366954, 2589.469158822437, 2689.5024420482273, 2736.233854520737, 2739.4794988952135, 2739.917802465929, 2708.729127087285, 2722.3194201449637, 2747.409306998995, 2747.6290700755344, 2749.752522272995, 2672.665916760405, 2695.811293209476, 2699.784017278613, 2714.5656694928916, 2715.1447294102395, 2590.7927365810688, 2595.065776320523, 2602.245348848832, 2602.3364042169314, 2602.973970260311, 14198.787018194735, 14542.054766440147, 14552.636184095481, 14567.0, 14574.489892853699, 7417.443691723142, 7700.4609677322605, 7726.575038372887, 7750.496217745828, 7760.534367937886, 5043.218301163325, 5150.922736158961, 5355.4912283333415, 5359.330083739533, 5372.91940620891, 1895.3082125024266, 1924.028365675339, 1940.3499827557785, 1976.1107501624326, 1985.900704964746, 22429.0, 22479.66280505794, 22522.21172258963, 22547.098116075336, 22610.20864269759, 6569.310222426577, 6575.243846957565, 6597.30728273534, 6742.258351581322, 6779.9322006780285, 16115.033098014157, 16210.675786484204, 16240.187990600423, 16249.431269905497, 16281.837181628032, 7593.544387336778, 7716.614169291513, 7719.884201736979, 7744.535327880345, 7746.961265193638, 5982.252218472691, 7075.575465472089, 7105.964470177616, 7132.572045677276, 7302.707891684379, 4734.0, 5160.354955630546, 5161.612879034087, 5260.342457192851, 5310.097283461821, 1471.3373887507262, 1481.977770333446, 1488.9106653600818, 1489.9255037248095, 1505.8042454481067, 824.9422540422113, 839.1063517353998, 852.8763329317214, 862.6247582301594, 869.891263592051, 8361.83276334482, 8510.446820956742, 8543.914560854311, 8620.439671421338, 8641.351898607629, 983.4640121133999, 984.5667906121283, 992.667456402099, 997.5860018092555, 997.7256254530063, 4719.362886010414, 4748.715077095385, 5651.660900345993, 5665.688387138664, 5723.6851973141875, 20406.591868162555, 20596.485087872923, 20698.68951965722, 20740.58518829615, 20958.952052397624, 20540.383788486368, 20884.37346879596, 20906.37280881576, 20998.685019724715, 20999.265025724333, 10171.338862974031, 10768.192385571114, 10776.92230776916, 11017.953294437015, 11025.393603351733, 8034.196580341919, 8057.355411566943, 8707.651693932172, 8905.777355566162, 8934.687285944961, 17387.478375648752, 17430.564235893697, 17439.651206975537, 18277.908610456863, 18290.0, 16919.323227070778, 16942.322307107577, 16945.32218711238, 17382.0, 17410.825891740922, 10821.242513024014, 11986.64040078799, 12237.632871013884, 12247.938760306142, 12253.938730306292, 11065.778684426428, 11473.827892581785, 13357.933210333886, 13415.396307166397, 13461.798073029107, 10760.139188865029, 10826.458677065957, 10846.837297440386, 10975.615853445091, 11192.888071119185, 10512.316699414514, 10842.349459032483, 10944.264947490848, 10977.12183025372, 11050.447477625925, 8747.60635771379, 9484.383515071499, 9582.616695332108, 9610.327277090537, 9748.415095094317, 6704.752401147562, 6810.693518791765, 6839.829004274734, 6873.690683919136, 6876.106106206161, 7128.857422851617, 7135.215126336203, 7145.46409019336, 7189.784306470814, 7190.784276471714], "value": 6506.740785170351, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.85857207821715, 513.3172880069508, 517.5161224255321, 523.9214117882315, 534.2307077807956, 6194.845128871775, 6208.441240288374, 6247.68798552304, 6256.217972753406, 6360.809175724724, 6106.603070800395, 6142.53930955179, 6163.764023887461, 6168.722407491662, 6225.501959843213, 5031.32077169581, 5142.151544995071, 5153.330067091273, 5159.690418574879, 5208.5572726318305, 4847.781849816767, 4999.275250038749, 5011.749412529377, 5094.261332106842, 5147.536721695046, 4866.537678920497, 4897.4123105227245, 4902.117618828609, 4946.752662366867, 4980.153373926423, 4908.386451693538, 4930.901381972359, 4938.753062346868, 4961.7022978621035, 4963.776630051656, 4356.520782713899, 4389.495208051083, 4411.1618792429335, 4423.380726698265, 4477.395551600524, 5920.171176035358, 5961.463468287875, 5964.717585719091, 6005.789797357115, 6038.547108966845, 5690.374058853523, 5697.629654072513, 5704.8859022819315, 5715.171300161495, 5758.251427314464, 6570.080188773575, 6575.276719560892, 6612.338766123397, 6618.503612229102, 6652.93347066528, 4832.855014349575, 4855.271709243606, 4885.7068575885205, 4911.214205727102, 4916.53292937174, 6580.795433529774, 6603.768868089642, 6738.730450782012, 6822.488313376467, 6853.109095817512, 4945.975270123627, 4959.429665588504, 4997.275395067695, 4998.6753510319795, 5031.471695471996, 5036.874078148002, 5047.772850221749, 5072.264521644414, 5079.257201111433, 5082.085224659597, 5616.747246373923, 5729.7708091676695, 5734.053881109654, 5745.310562732415, 5764.827055188351, 6670.299618540081, 6673.332666733288, 6675.7997260082275, 6677.632730199788, 6697.464202863759, 1767.9558011049826, 1772.56572139824, 1773.804881463038, 1787.7675902132898, 1791.5162906015564, 1177.2230327983489, 1214.7266864955313, 1225.338317308661, 1236.8763123687738, 1257.5975687779824, 5753.539716822645, 5791.3339965903615, 5816.389279125631, 5816.709164541756, 5852.590318677737, 6589.17635295588, 6687.531872768859, 6737.494687898427, 6750.291219421988, 6782.559133656297, 5786.681732504669, 5817.0, 5821.359650438449, 5829.15477255804, 5832.125181222766, 3548.822558872046, 3569.94645080324, 3593.94609080864, 3595.6044835068124, 3631.782093074424, 6571.441427478718, 6598.538102332791, 6607.273199948002, 6611.900821487681, 6613.2394774601535, 6934.133233345832, 6951.852944264241, 6966.9651651741415, 6981.30186981308, 6988.475864310197, 6536.803895883131, 6539.346065393518, 6573.671316434255, 6575.605463672195, 6596.835079122964, 6192.566520343533, 6732.8653426930205, 6732.899006514808, 6800.693968771318, 6805.761798337035, 6726.8654626908165, 6729.0, 6780.796576102724, 6792.456603471612, 6814.182298124257, 6475.125858009108, 6497.577657452251, 6504.869902601827, 6531.869362612816, 6592.241892182268, 4954.232094025432, 4976.278439626161, 4999.325091112653, 5026.321446604661, 5065.265536497261, 6442.8389290268115, 6616.8345791355605, 6644.734210631521, 6816.386525212754, 6825.054859365057, 6407.583507072025, 6415.599732141972, 6486.578372405778, 6506.284308725942, 6507.446867016167, 6443.903341449788, 6480.675966201766, 6493.415592596689, 6497.772577959749, 6531.738730450728, 6396.904046439214, 6400.967995159995, 6478.708458119301, 6540.738370465128, 6541.313162117909, 6616.0, 6639.568428052161, 6641.468682505291, 6647.401733843977, 6660.000999850061, 6354.0, 6461.709223084878, 6468.773592924225, 6476.057182845034, 6497.18785151856], "value": 5069.305164730522, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.1484147480634, 903.7017784131237, 922.3359181389402, 926.2173463423405, 930.6789157740577, 17917.0, 18590.16344264508, 18635.906820465894, 18636.62726745464, 21806.563868722656, 21457.248996285132, 21823.781762182374, 21848.8907555462, 22016.119355225812, 22049.559008819815, 1016.6848277034106, 1055.7835643693063, 1061.0132576703663, 1061.029158320136, 1061.4904845674082, 1009.6621975881949, 1049.8582691336649, 1058.4866339825178, 1059.9205059620522, 1067.4182570499097, 1115.33080151909, 1117.25144153417, 1125.0718157520039, 1127.6278827986744, 1127.7969965406223, 1117.2402766119035, 1123.0285802780577, 1124.235519846504, 1126.054114543783, 1126.2735535579586, 812.7358608452217, 816.9183081691842, 819.2831272636444, 820.3642177312571, 822.6914906909909, 19869.20523179071, 20035.0, 20062.398128056182, 20288.594228115355, 20901.268455603982, 21387.786122138736, 21474.46313842151, 21912.89043554788, 22568.66147007796, 22890.88554557233, 16984.235709393106, 17131.486055418358, 17202.741958870625, 17298.82701172985, 17330.653386932318, 3649.178934739689, 3663.4687970244167, 3676.117731744362, 3678.6137455567045, 3679.6136405677285, 126818.36590817079, 128477.35761321227, 129166.0, 131035.34482327527, 131903.34048329698, 17147.571310717332, 17175.570610734583, 17301.134943252786, 17674.0, 17696.203670834842, 31676.30634224163, 31811.840940795148, 31857.362852742815, 32158.0, 32187.195320116716, 7508.211637778064, 7873.5275883447175, 8490.915090849136, 8523.190296921783, 8621.698240561676, 4273.465816772903, 4399.450068741407, 4400.603945644843, 4401.1417773534495, 4401.273789824643, 5212.218167274939, 5322.733863306819, 5360.303160589098, 5368.436314186954, 5381.730913454312, 1083.712816103733, 1096.4901320885826, 1105.7125147461718, 1106.5463160104318, 1111.5053801058614, 697.2191145916504, 709.974087443639, 711.1608302203347, 720.2833180984953, 732.3006528765017, 12121.212121212093, 12336.321502317458, 12433.72242803078, 12845.357732113356, 13199.0, 694.4687314204638, 697.4699228586311, 700.719712115158, 705.3369832357567, 716.913970323554, 5619.129034999582, 5649.745761440745, 5692.516136128393, 5783.652980821164, 5871.853203669857, 104495.0, 107232.0, 109933.0, 110572.4471377638, 113831.0, 94066.0, 96849.54725679121, 97131.0, 97744.0, 99054.50472747734, 81699.0, 88478.11521884828, 90102.54948725346, 91028.08971910196, 91487.08512914786, 11962.0, 12120.151589388659, 12341.691457713629, 12354.25874447536, 12421.0, 39487.21025579415, 40005.79997100112, 40054.0, 40698.38952415657, 41129.0, 51394.74302628463, 51439.742801285756, 52027.0, 52451.73774131257, 52733.209001864234, 18713.064346782878, 18771.155298011894, 18843.340483083026, 19089.0, 19179.520511987314, 17712.46862594124, 20435.795642043387, 21076.789232107483, 21457.57084858263, 21810.56378872382, 18824.435266942015, 18958.24167033303, 19106.7133992993, 19108.044597770335, 19175.32886348971, 17517.21172547213, 17523.474295771146, 17524.82475175232, 17635.823641763418, 17672.381466648607, 17285.481435556954, 17420.216090276223, 17446.0, 17458.30166793314, 17622.735658965383, 14084.78872816888, 14109.6472588182, 14181.787273190705, 14377.0, 14449.422023118957, 13166.802497962346, 13334.733305334034, 13495.325233738471, 13514.797278041035, 13537.390817413043], "value": 9289.220831197366, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 108.0, 107.0, 116.0, 113.0, 114.0, 100.0, 107.0, 113.0], "value": 108.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 124.0, 141.0, 177.0, 120.0, 149.0, 150.0, 120.0, 175.0, 125.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 164.0, 164.0, 164.0, 170.0, 168.0, 165.0, 164.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 185.0, 76.0, 74.0, 75.0, 89.0, 95.0, 81.0], "value": 90.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 129.0, 85.0, 79.0, 80.0, 127.0, 79.0, 78.0, 139.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 118.0, 114.0, 113.0, 115.0, 115.0, 115.0, 114.0, 116.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 150.0, 151.0, 149.0, 150.0, 150.0, 150.0, 153.0], "value": 150.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 96.0, 94.0, 94.0, 95.0, 98.0, 99.0, 98.0, 98.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 59.0, 54.0, 62.0, 62.0, 55.0, 57.0, 53.0, 55.0], "value": 56.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 54.0, 55.0, 55.0, 54.0, 54.0, 56.0, 54.0, 59.0, 54.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 79.0, 77.0, 77.0, 78.0, 79.0, 88.0, 77.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 134.0, 122.0, 131.0, 133.0, 125.0, 124.0, 121.0, 126.0, 164.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 172.0, 175.0, 188.0, 193.0, 175.0, 175.0, 182.0, 177.0, 172.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 66.0, 68.0, 68.0, 66.0, 67.0, 65.0, 69.0, 67.0], "value": 67.3, "unit": "score"}]}]} 11:10:25 INFO - Return code: 0 11:10:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:10:25 INFO - # TBPL SUCCESS # 11:10:25 INFO - Running post-action listener: _package_coverage_data 11:10:25 INFO - Running post-action listener: _resource_record_post_action 11:10:25 INFO - [mozharness: 2017-08-14 18:10:25.170978Z] Finished run-tests step (success) 11:10:25 INFO - Running post-run listener: _resource_record_post_run 11:10:25 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 364544; Write bytes: 440799232; Read time: 632; Write time: 410340 11:10:25 INFO - TinderboxPrint: CPU usage
13.1% 11:10:25 INFO - TinderboxPrint: I/O read bytes / time
364,544 / 632 11:10:25 INFO - TinderboxPrint: I/O write bytes / time
440,799,232 / 410,340 11:10:25 INFO - TinderboxPrint: CPU idle
8,273.6 (86.8%) 11:10:25 INFO - TinderboxPrint: CPU user
1,201.6 (12.6%) 11:10:25 INFO - TinderboxPrint: Swap in / out
0 / 0 11:10:25 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 12288; Write bytes: 118099968; Read time: 308; Write time: 101152 11:10:25 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:10:25 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 348160; Write bytes: 322154496; Read time: 312; Write time: 309156 11:10:25 INFO - Running post-run listener: _upload_blobber_files 11:10:25 INFO - Blob upload gear active. 11:10:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:10: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 11:10: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'] 11:10: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 11:10:26 INFO - (blobuploader) - INFO - Open directory for files ... 11:10:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:10:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:10:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:32 INFO - (blobuploader) - INFO - Done attempting. 11:10:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:10:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:10:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:33 INFO - (blobuploader) - INFO - Done attempting. 11:10:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:10:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:10:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:34 INFO - (blobuploader) - INFO - Done attempting. 11:10:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:10:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:10:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:10:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:10:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:10:34 INFO - (blobuploader) - INFO - Done attempting. 11:10:34 INFO - (blobuploader) - INFO - Iteration through files over. 11:10:34 INFO - Return code: 0 11:10:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:10:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:10:34 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da9b3d8a73685bfbb7294d4bad4c1ea3ba4d48f66f007e48ae2bc1db8a8af25525d60048bc8931ecabfe474f72392b7b125417971d15891337dc443c810783e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6117abb935bf31b9d812e8e720077a3d82926aff33158aa79910bde92766eb0661f3d7cb52d6b55b40a1c46b277bcd3041c7aa2c2ad22bdbf3daa6eed8839df", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fecce9c1ce9b5e26aa0938dc793a76670b3f178877ad663a37bed2ff733f999509f84c48a14dac8576570501682169d39b07ba6ecbc747b7de6504d9ba8e19bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a242210c8045c06c1f8c0764037f53d0b7c4d1aa5dc3151f444e9dcd8ae63a41c90131f9b0c5a521cf2b10a6257199b92030ae2bf932f886ab0e8adb24a639e"} 11:10:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:10:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:10:34 INFO - Contents: 11:10:34 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da9b3d8a73685bfbb7294d4bad4c1ea3ba4d48f66f007e48ae2bc1db8a8af25525d60048bc8931ecabfe474f72392b7b125417971d15891337dc443c810783e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6117abb935bf31b9d812e8e720077a3d82926aff33158aa79910bde92766eb0661f3d7cb52d6b55b40a1c46b277bcd3041c7aa2c2ad22bdbf3daa6eed8839df", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fecce9c1ce9b5e26aa0938dc793a76670b3f178877ad663a37bed2ff733f999509f84c48a14dac8576570501682169d39b07ba6ecbc747b7de6504d9ba8e19bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a242210c8045c06c1f8c0764037f53d0b7c4d1aa5dc3151f444e9dcd8ae63a41c90131f9b0c5a521cf2b10a6257199b92030ae2bf932f886ab0e8adb24a639e"} 11:10:34 INFO - Running post-run listener: copy_logs_to_upload_dir 11:10:34 INFO - Copying logs to upload dir... 11:10:34 INFO - mkdir: /builds/slave/test/build/upload/logs 11:10:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.194052 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-08-14 11:10:34.952793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 11:10:34.959898) ========= 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=cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766 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/da9b3d8a73685bfbb7294d4bad4c1ea3ba4d48f66f007e48ae2bc1db8a8af25525d60048bc8931ecabfe474f72392b7b125417971d15891337dc443c810783e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6117abb935bf31b9d812e8e720077a3d82926aff33158aa79910bde92766eb0661f3d7cb52d6b55b40a1c46b277bcd3041c7aa2c2ad22bdbf3daa6eed8839df", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fecce9c1ce9b5e26aa0938dc793a76670b3f178877ad663a37bed2ff733f999509f84c48a14dac8576570501682169d39b07ba6ecbc747b7de6504d9ba8e19bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a242210c8045c06c1f8c0764037f53d0b7c4d1aa5dc3151f444e9dcd8ae63a41c90131f9b0c5a521cf2b10a6257199b92030ae2bf932f886ab0e8adb24a639e"} build_url:https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/EbW8bYmORB6jS9ruD6W6qg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da9b3d8a73685bfbb7294d4bad4c1ea3ba4d48f66f007e48ae2bc1db8a8af25525d60048bc8931ecabfe474f72392b7b125417971d15891337dc443c810783e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6117abb935bf31b9d812e8e720077a3d82926aff33158aa79910bde92766eb0661f3d7cb52d6b55b40a1c46b277bcd3041c7aa2c2ad22bdbf3daa6eed8839df", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fecce9c1ce9b5e26aa0938dc793a76670b3f178877ad663a37bed2ff733f999509f84c48a14dac8576570501682169d39b07ba6ecbc747b7de6504d9ba8e19bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6a242210c8045c06c1f8c0764037f53d0b7c4d1aa5dc3151f444e9dcd8ae63a41c90131f9b0c5a521cf2b10a6257199b92030ae2bf932f886ab0e8adb24a639e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 11:10:34.989498) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 11:10:34.989831) ========= 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=cbe409c6de289db6ac707de3000001d4-1502731867.704865-1961127766 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 11:10:35.070362) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 11:10:35.073712) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 11:10:35.074018) ========= ========= Total master_lag: 0.23 =========