builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1502906345.39 results: success (0) revision: 07ce8c96222d533fc89c02802143d35d7c351f9c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:05.395225) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:05.395739) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:05.396032) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:05.412246) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:05.412631) ========= 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=4300f881736b422476174874000001bc-1502906344.671227-876597425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 10:59:05-- 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% 221M=0s 2017-08-16 10:59:05 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110730 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:05.538631) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:05.538960) ========= 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=4300f881736b422476174874000001bc-1502906344.671227-876597425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019484 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:05.589038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:05.589385) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 07ce8c96222d533fc89c02802143d35d7c351f9c --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 07ce8c96222d533fc89c02802143d35d7c351f9c --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=4300f881736b422476174874000001bc-1502906344.671227-876597425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 10:59:05,654 truncating revision to first 12 chars 2017-08-16 10:59:05,654 Setting DEBUG logging. 2017-08-16 10:59:05,654 attempt 1/10 2017-08-16 10:59:05,654 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/07ce8c96222d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 10:59:06,117 unpacking tar archive at: mozilla-central-07ce8c96222d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.775505 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:06.379870) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:06.380190) ========= script_repo_revision: 07ce8c96222d533fc89c02802143d35d7c351f9c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:06.380562) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:06.380839) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 10:59:06.391645) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-16 10:59:06.391929) ========= /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=4300f881736b422476174874000001bc-1502906344.671227-876597425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:59:06 INFO - MultiFileLogger online at 20170816 10:59:06 in /builds/slave/test 10:59:06 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:59:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:59:06 INFO - {'append_to_log': False, 10:59:06 INFO - 'base_work_dir': '/builds/slave/test', 10:59:06 INFO - 'blob_upload_branch': 'Firefox', 10:59:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:59:06 INFO - 'branch': 'Firefox', 10:59:06 INFO - 'buildbot_json_path': 'buildprops.json', 10:59:06 INFO - 'code_coverage': False, 10:59:06 INFO - 'config_files': ('talos/linux_config.py',), 10:59:06 INFO - 'default_actions': ('clobber', 10:59:06 INFO - 'read-buildbot-config', 10:59:06 INFO - 'download-and-extract', 10:59:06 INFO - 'populate-webroot', 10:59:06 INFO - 'create-virtualenv', 10:59:06 INFO - 'install', 10:59:06 INFO - 'setup-mitmproxy', 10:59:06 INFO - 'run-tests'), 10:59:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:59:06 INFO - 'disable_ccov_upload': False, 10:59:06 INFO - 'download_minidump_stackwalk': True, 10:59:06 INFO - 'download_symbols': 'ondemand', 10:59:06 INFO - 'enable_stylo': False, 10:59:06 INFO - 'enable_webrender': False, 10:59:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:59:06 INFO - 'tooltool.py': '/tools/tooltool.py', 10:59:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:59:06 INFO - '/tools/misc-python/virtualenv.py')}, 10:59:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:59:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:59:06 INFO - 'gecko_profile': False, 10:59:06 INFO - 'gecko_profile_interval': 0, 10:59:06 INFO - 'installer_path': 'installer.exe', 10:59:06 INFO - 'log_level': 'info', 10:59:06 INFO - 'log_name': 'talos', 10:59:06 INFO - 'log_to_console': True, 10:59:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:59:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:59:06 INFO - 'opt_config_files': (), 10:59:06 INFO - 'pip_index': False, 10:59:06 INFO - 'suite': 'dromaeojs-e10s', 10:59:06 INFO - 'system_bits': '32', 10:59:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:59:06 INFO - 'title': 'talos-linux64-ix-045', 10:59:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:59:06 INFO - 'use_talos_json': True, 10:59:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:59:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:59:06 INFO - 'work_dir': 'build'} 10:59:06 INFO - [mozharness: 2017-08-16 17:59:06.557799Z] Running clobber step. 10:59:06 INFO - Running pre-action listener: _resource_record_pre_action 10:59:06 INFO - Running main action method: clobber 10:59:06 INFO - rmtree: /builds/slave/test/build 10:59:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:59:08 INFO - Running post-action listener: _resource_record_post_action 10:59:08 INFO - [mozharness: 2017-08-16 17:59:08.242319Z] Finished clobber step (success) 10:59:08 INFO - [mozharness: 2017-08-16 17:59:08.242421Z] Running read-buildbot-config step. 10:59:08 INFO - Running pre-action listener: _resource_record_pre_action 10:59:08 INFO - Running main action method: read_buildbot_config 10:59:08 INFO - Using buildbot properties: 10:59:08 INFO - { 10:59:08 INFO - "project": "", 10:59:08 INFO - "product": "firefox", 10:59:08 INFO - "who": "ffxbld@noreply.mozilla.org", 10:59:08 INFO - "installer_path": "public/build/target.tar.bz2", 10:59:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 10:59:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 10:59:08 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 10:59:08 INFO - "stage_platform": "linux64-stylosequential", 10:59:08 INFO - "basedir": "/builds/slave/test", 10:59:08 INFO - "buildnumber": 192, 10:59:08 INFO - "platform": "ubuntu64_hw_styloseq", 10:59:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:59:08 INFO - "slavebuilddir": "test", 10:59:08 INFO - "taskId": "biN94NdjTF-JiM3UNxz4iA", 10:59:08 INFO - "branch": "mozilla-central", 10:59:08 INFO - "script_repo_revision": "production", 10:59:08 INFO - "revision": "07ce8c96222d533fc89c02802143d35d7c351f9c", 10:59:08 INFO - "slavename": "talos-linux64-ix-045", 10:59:08 INFO - "repo_path": "mozilla-central" 10:59:08 INFO - } 10:59:08 INFO - Finding installer, test and symbols from parent task. 10:59:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/biN94NdjTF-JiM3UNxz4iA'}, attempt #1 10:59:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/biN94NdjTF-JiM3UNxz4iA'}, attempt #1 10:59:09 INFO - Task dependencies: YbqntiLNQ_uKrat-Wa379w 10:59:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w'}, attempt #1 10:59:09 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2 10:59:09 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.test_packages.json 10:59:09 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.crashreporter-symbols.zip 10:59:09 INFO - Running post-action listener: _resource_record_post_action 10:59:09 INFO - [mozharness: 2017-08-16 17:59:09.595033Z] Finished read-buildbot-config step (success) 10:59:09 INFO - [mozharness: 2017-08-16 17:59:09.595256Z] Running download-and-extract step. 10:59:09 INFO - Running pre-action listener: _resource_record_pre_action 10:59:09 INFO - Running main action method: download_and_extract 10:59:09 INFO - mkdir: /builds/slave/test/build/tests 10:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:09 INFO - trying https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.test_packages.json 10:59:09 INFO - Downloading https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:59:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:59:10 INFO - Downloaded 989 bytes. 10:59:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:59:10 INFO - Using the following test package requirements: 10:59:10 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:59:10 INFO - u'common': [u'target.common.tests.zip'], 10:59:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:59:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:59:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:59:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:59:10 INFO - u'mozbase': [u'target.common.tests.zip'], 10:59:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:59:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:59:10 INFO - u'web-platform': [u'target.common.tests.zip', 10:59:10 INFO - u'target.web-platform.tests.tar.gz'], 10:59:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:59:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:59:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.common.tests.zip 10:59:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:59:10 INFO - Fetch https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.common.tests.zip into memory 10:59:11 INFO - Content-Length response header: 54003849 10:59:11 INFO - Bytes received: 54003849 10:59:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:59:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.common.tests.zip 10:59:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:59:22 INFO - Fetch https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.common.tests.zip into memory 10:59:23 INFO - Content-Length response header: 54003849 10:59:23 INFO - Bytes received: 54003849 10:59:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.talos.tests.zip 10:59:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:59:35 INFO - Fetch https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.talos.tests.zip into memory 10:59:35 INFO - Content-Length response header: 14496050 10:59:35 INFO - Bytes received: 14496050 10:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:36 INFO - trying https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2 10:59:36 INFO - Downloading https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:59:38 INFO - Downloaded 61902147 bytes. 10:59:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2 10:59:38 INFO - mkdir: /builds/slave/test/properties 10:59:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:59:38 INFO - Writing to file /builds/slave/test/properties/build_url 10:59:38 INFO - Contents: 10:59:38 INFO - build_url:https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2 10:59:38 INFO - Running post-action listener: _resource_record_post_action 10:59:38 INFO - Running post-action listener: set_extra_try_arguments 10:59:38 INFO - [mozharness: 2017-08-16 17:59:38.339293Z] Finished download-and-extract step (success) 10:59:38 INFO - [mozharness: 2017-08-16 17:59:38.339527Z] Running populate-webroot step. 10:59:38 INFO - Running pre-action listener: _resource_record_pre_action 10:59:38 INFO - Running main action method: populate_webroot 10:59:38 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:59:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:59:38 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:59:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:59:38 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:59:38 INFO - 'tests': ['damp', 'tps']}, 10:59:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:59:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:59:38 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:59:38 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:59:38 INFO - 'other-e10s': {'tests': ['a11yr', 10:59:38 INFO - 'ts_paint', 10:59:38 INFO - 'tpaint', 10:59:38 INFO - 'sessionrestore', 10:59:38 INFO - 'sessionrestore_many_windows', 10:59:38 INFO - 'sessionrestore_no_auto_restore', 10:59:38 INFO - 'tabpaint']}, 10:59:38 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:59:38 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:59:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:59:38 INFO - 'tsvgr_opacity', 10:59:38 INFO - 'tart', 10:59:38 INFO - 'tscrollx', 10:59:38 INFO - 'tsvg_static']}, 10:59:38 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:59:38 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:59:38 INFO - 'talos_options': ['--mitmproxy', 10:59:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:59:38 INFO - '--firstNonBlankPaint'], 10:59:38 INFO - 'tests': ['tp6_google', 10:59:38 INFO - 'tp6_youtube', 10:59:38 INFO - 'tp6_amazon', 10:59:38 INFO - 'tp6_facebook']}, 10:59:38 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:59:38 INFO - 'talos_options': ['--stylo', 10:59:38 INFO - '--mitmproxy', 10:59:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:59:38 INFO - '--firstNonBlankPaint'], 10:59:38 INFO - 'tests': ['tp6_google', 10:59:38 INFO - 'tp6_youtube', 10:59:38 INFO - 'tp6_amazon', 10:59:38 INFO - 'tp6_facebook']}, 10:59:38 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:59:38 INFO - 'talos_options': ['--stylo', 10:59:38 INFO - '--stylo-threads=1', 10:59:38 INFO - '--mitmproxy', 10:59:38 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:59:38 INFO - '--firstNonBlankPaint'], 10:59:38 INFO - 'tests': ['tp6_google', 10:59:38 INFO - 'tp6_youtube', 10:59:38 INFO - 'tp6_amazon', 10:59:38 INFO - 'tp6_facebook']}, 10:59:38 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:59:38 INFO - 'talos_options': ['--xperf_path', 10:59:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:59:38 INFO - 'tests': ['tp5n']}}} 10:59:38 INFO - Running post-action listener: _resource_record_post_action 10:59:38 INFO - [mozharness: 2017-08-16 17:59:38.356597Z] Finished populate-webroot step (success) 10:59:38 INFO - [mozharness: 2017-08-16 17:59:38.356688Z] Running create-virtualenv step. 10:59:38 INFO - Running pre-action listener: _resource_record_pre_action 10:59:38 INFO - Running main action method: create_virtualenv 10:59:38 INFO - Creating virtualenv /builds/slave/test/build/venv 10:59:38 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:59:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:59:38 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:59:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:59:38 INFO - Using real prefix '/usr' 10:59:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:59:38 INFO - Installing distribute.............................................................................................................................................................................................done. 10:59:40 INFO - Installing pip.................done. 10:59:40 INFO - Return code: 0 10:59:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:59:41 INFO - Reading from file tmpfile_stdout 10:59:41 INFO - Output received: 10:59:41 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:59:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:59:41 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:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:41 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:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:41 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 0x1a641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d090b0>, '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 0x1d09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a440>, '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': '4300f881736b422476174874000001bc-1502906344.671227-876597425', '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:59:41 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:59:41 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:59:41 INFO - Using env: {'DISPLAY': ':0', 10:59:41 INFO - 'HOME': '/home/cltbld', 10:59:41 INFO - 'LANG': 'en_US.UTF-8', 10:59:41 INFO - 'LANGUAGE': 'en_US:en', 10:59:41 INFO - 'LOGNAME': 'cltbld', 10:59:41 INFO - 'MAIL': '/var/mail/cltbld', 10:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:41 INFO - 'MOZ_NO_REMOTE': '1', 10:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:41 INFO - 'NO_EM_RESTART': '1', 10:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:41 INFO - 'PWD': '/builds/slave/test', 10:59:41 INFO - 'SHELL': '/bin/bash', 10:59:41 INFO - 'SHLVL': '1', 10:59:41 INFO - 'TERM': 'linux', 10:59:41 INFO - 'TMOUT': '86400', 10:59:41 INFO - 'USER': 'cltbld', 10:59:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502906344.671227-876597425', 10:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:41 INFO - '_': '/tools/buildbot/bin/python'} 10:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:41 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:59:41 INFO - Cleaning up... 10:59:41 INFO - Return code: 0 10:59:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:59:41 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:59:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:41 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:59:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:41 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 0x1a641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d090b0>, '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 0x1d09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a440>, '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': '4300f881736b422476174874000001bc-1502906344.671227-876597425', '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:59:41 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:59:41 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:59:41 INFO - Using env: {'DISPLAY': ':0', 10:59:41 INFO - 'HOME': '/home/cltbld', 10:59:41 INFO - 'LANG': 'en_US.UTF-8', 10:59:41 INFO - 'LANGUAGE': 'en_US:en', 10:59:41 INFO - 'LOGNAME': 'cltbld', 10:59:41 INFO - 'MAIL': '/var/mail/cltbld', 10:59:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:41 INFO - 'MOZ_NO_REMOTE': '1', 10:59:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:41 INFO - 'NO_EM_RESTART': '1', 10:59:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:41 INFO - 'PWD': '/builds/slave/test', 10:59:41 INFO - 'SHELL': '/bin/bash', 10:59:41 INFO - 'SHLVL': '1', 10:59:41 INFO - 'TERM': 'linux', 10:59:41 INFO - 'TMOUT': '86400', 10:59:41 INFO - 'USER': 'cltbld', 10:59:41 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502906344.671227-876597425', 10:59:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:41 INFO - '_': '/tools/buildbot/bin/python'} 10:59:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:41 INFO - Downloading/unpacking psutil>=3.1.1 10:59:41 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:59:41 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:59:41 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:59:41 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:59:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:59:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:42 INFO - Installing collected packages: psutil 10:59:42 INFO - Running setup.py install for psutil 10:59:42 INFO - building 'psutil._psutil_linux' extension 10:59:42 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:59:43 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:59:43 INFO - building 'psutil._psutil_posix' extension 10:59:43 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:59:43 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:59:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:59:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:59:43 INFO - Successfully installed psutil 10:59:43 INFO - Cleaning up... 10:59:43 INFO - Return code: 0 10:59:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:59:43 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:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:43 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:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:43 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 0x1a641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d090b0>, '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 0x1d09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a440>, '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': '4300f881736b422476174874000001bc-1502906344.671227-876597425', '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:59:43 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:59:43 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:59:43 INFO - Using env: {'DISPLAY': ':0', 10:59:43 INFO - 'HOME': '/home/cltbld', 10:59:43 INFO - 'LANG': 'en_US.UTF-8', 10:59:43 INFO - 'LANGUAGE': 'en_US:en', 10:59:43 INFO - 'LOGNAME': 'cltbld', 10:59:43 INFO - 'MAIL': '/var/mail/cltbld', 10:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:43 INFO - 'MOZ_NO_REMOTE': '1', 10:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:43 INFO - 'NO_EM_RESTART': '1', 10:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:43 INFO - 'PWD': '/builds/slave/test', 10:59:43 INFO - 'SHELL': '/bin/bash', 10:59:43 INFO - 'SHLVL': '1', 10:59:43 INFO - 'TERM': 'linux', 10:59:43 INFO - 'TMOUT': '86400', 10:59:43 INFO - 'USER': 'cltbld', 10:59:43 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502906344.671227-876597425', 10:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:43 INFO - '_': '/tools/buildbot/bin/python'} 10:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:59:43 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:59:43 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:59:43 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:59:43 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:59:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:59:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:59:44 INFO - Installing collected packages: mozsystemmonitor 10:59:44 INFO - Running setup.py install for mozsystemmonitor 10:59:44 INFO - Successfully installed mozsystemmonitor 10:59:44 INFO - Cleaning up... 10:59:44 INFO - Return code: 0 10:59:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d090b0>, '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 0x1d09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a440>, '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': '4300f881736b422476174874000001bc-1502906344.671227-876597425', '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:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:59:44 INFO - Using env: {'DISPLAY': ':0', 10:59:44 INFO - 'HOME': '/home/cltbld', 10:59:44 INFO - 'LANG': 'en_US.UTF-8', 10:59:44 INFO - 'LANGUAGE': 'en_US:en', 10:59:44 INFO - 'LOGNAME': 'cltbld', 10:59:44 INFO - 'MAIL': '/var/mail/cltbld', 10:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:44 INFO - 'MOZ_NO_REMOTE': '1', 10:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:44 INFO - 'NO_EM_RESTART': '1', 10:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:44 INFO - 'PWD': '/builds/slave/test', 10:59:44 INFO - 'SHELL': '/bin/bash', 10:59:44 INFO - 'SHLVL': '1', 10:59:44 INFO - 'TERM': 'linux', 10:59:44 INFO - 'TMOUT': '86400', 10:59:44 INFO - 'USER': 'cltbld', 10:59:44 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502906344.671227-876597425', 10:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:44 INFO - '_': '/tools/buildbot/bin/python'} 10:59:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:45 INFO - Downloading/unpacking jsonschema==2.5.1 10:59:45 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:59:45 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:59:45 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:59:45 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:59:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:59:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:46 INFO - Downloading functools32-3.2.3-2.tar.gz 10:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:59:46 INFO - warning: no files found matching '*.txt' 10:59:46 INFO - no previously-included directories found matching 'build' 10:59:46 INFO - no previously-included directories found matching 'dist' 10:59:46 INFO - no previously-included directories found matching '.git*' 10:59:46 INFO - Installing collected packages: jsonschema, functools32 10:59:46 INFO - Running setup.py install for functools32 10:59:46 INFO - warning: no files found matching '*.txt' 10:59:46 INFO - no previously-included directories found matching 'build' 10:59:46 INFO - no previously-included directories found matching 'dist' 10:59:46 INFO - no previously-included directories found matching '.git*' 10:59:46 INFO - Successfully installed jsonschema functools32 10:59:46 INFO - Cleaning up... 10:59:46 INFO - Return code: 0 10:59:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d090b0>, '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 0x1d09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a440>, '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': '4300f881736b422476174874000001bc-1502906344.671227-876597425', '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:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:59:46 INFO - Using env: {'DISPLAY': ':0', 10:59:46 INFO - 'HOME': '/home/cltbld', 10:59:46 INFO - 'LANG': 'en_US.UTF-8', 10:59:46 INFO - 'LANGUAGE': 'en_US:en', 10:59:46 INFO - 'LOGNAME': 'cltbld', 10:59:46 INFO - 'MAIL': '/var/mail/cltbld', 10:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:46 INFO - 'MOZ_NO_REMOTE': '1', 10:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:46 INFO - 'NO_EM_RESTART': '1', 10:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:46 INFO - 'PWD': '/builds/slave/test', 10:59:46 INFO - 'SHELL': '/bin/bash', 10:59:46 INFO - 'SHLVL': '1', 10:59:46 INFO - 'TERM': 'linux', 10:59:46 INFO - 'TMOUT': '86400', 10:59:46 INFO - 'USER': 'cltbld', 10:59:46 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502906344.671227-876597425', 10:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:46 INFO - '_': '/tools/buildbot/bin/python'} 10:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:59:46 INFO - Cleaning up... 10:59:46 INFO - Return code: 0 10:59:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d090b0>, '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 0x1d09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a440>, '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': '4300f881736b422476174874000001bc-1502906344.671227-876597425', '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:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:59:46 INFO - Using env: {'DISPLAY': ':0', 10:59:46 INFO - 'HOME': '/home/cltbld', 10:59:46 INFO - 'LANG': 'en_US.UTF-8', 10:59:46 INFO - 'LANGUAGE': 'en_US:en', 10:59:46 INFO - 'LOGNAME': 'cltbld', 10:59:46 INFO - 'MAIL': '/var/mail/cltbld', 10:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:46 INFO - 'MOZ_NO_REMOTE': '1', 10:59:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:46 INFO - 'NO_EM_RESTART': '1', 10:59:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:46 INFO - 'PWD': '/builds/slave/test', 10:59:46 INFO - 'SHELL': '/bin/bash', 10:59:46 INFO - 'SHLVL': '1', 10:59:46 INFO - 'TERM': 'linux', 10:59:46 INFO - 'TMOUT': '86400', 10:59:46 INFO - 'USER': 'cltbld', 10:59:46 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502906344.671227-876597425', 10:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:46 INFO - '_': '/tools/buildbot/bin/python'} 10:59:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:46 INFO - Downloading/unpacking blobuploader==1.2.4 10:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:48 INFO - Downloading blobuploader-1.2.4.tar.gz 10:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:59:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:59:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:48 INFO - Downloading docopt-0.6.1.tar.gz 10:59:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:59:48 INFO - Installing collected packages: blobuploader, requests, docopt 10:59:48 INFO - Running setup.py install for blobuploader 10:59:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:59:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:59:48 INFO - Running setup.py install for requests 10:59:49 INFO - Running setup.py install for docopt 10:59:49 INFO - Successfully installed blobuploader requests docopt 10:59:49 INFO - Cleaning up... 10:59:49 INFO - Return code: 0 10:59:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:49 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 0x1a641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d090b0>, '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 0x1d09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a440>, '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': '4300f881736b422476174874000001bc-1502906344.671227-876597425', '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:59:49 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:59:49 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:59:49 INFO - Using env: {'DISPLAY': ':0', 10:59:49 INFO - 'HOME': '/home/cltbld', 10:59:49 INFO - 'LANG': 'en_US.UTF-8', 10:59:49 INFO - 'LANGUAGE': 'en_US:en', 10:59:49 INFO - 'LOGNAME': 'cltbld', 10:59:49 INFO - 'MAIL': '/var/mail/cltbld', 10:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:49 INFO - 'MOZ_NO_REMOTE': '1', 10:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:49 INFO - 'NO_EM_RESTART': '1', 10:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:49 INFO - 'PWD': '/builds/slave/test', 10:59:49 INFO - 'SHELL': '/bin/bash', 10:59:49 INFO - 'SHLVL': '1', 10:59:49 INFO - 'TERM': 'linux', 10:59:49 INFO - 'TMOUT': '86400', 10:59:49 INFO - 'USER': 'cltbld', 10:59:49 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502906344.671227-876597425', 10:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:49 INFO - '_': '/tools/buildbot/bin/python'} 10:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:49 INFO - Running setup.py (path:/tmp/pip-1gUwFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:49 INFO - Running setup.py (path:/tmp/pip-5lfkDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:49 INFO - Running setup.py (path:/tmp/pip-UL5i5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:49 INFO - Running setup.py (path:/tmp/pip-Gmd5TH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:49 INFO - Running setup.py (path:/tmp/pip-2d8dXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:50 INFO - Running setup.py (path:/tmp/pip-enxy1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:50 INFO - Running setup.py (path:/tmp/pip-2wNGMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:50 INFO - Running setup.py (path:/tmp/pip-lUtUWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:50 INFO - Running setup.py (path:/tmp/pip-D26nRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:50 INFO - Running setup.py (path:/tmp/pip-419iUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:50 INFO - Running setup.py (path:/tmp/pip-FqJNR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:50 INFO - Running setup.py (path:/tmp/pip-ktMPs5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:50 INFO - Running setup.py (path:/tmp/pip-j4dItI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:50 INFO - Running setup.py (path:/tmp/pip-vIFeOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:50 INFO - Running setup.py (path:/tmp/pip-EaJ0CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:50 INFO - Running setup.py (path:/tmp/pip-RNZffi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:50 INFO - Running setup.py (path:/tmp/pip-8KUW1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:59:50 INFO - Running setup.py install for manifestparser 10:59:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:59:50 INFO - Running setup.py install for mozcrash 10:59:51 INFO - Running setup.py install for mozdebug 10:59:51 INFO - Running setup.py install for mozdevice 10:59:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:59:51 INFO - Running setup.py install for mozfile 10:59:51 INFO - Running setup.py install for mozhttpd 10:59:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:59:51 INFO - Running setup.py install for mozinfo 10:59:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:59:51 INFO - Running setup.py install for mozInstall 10:59:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:59:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:59:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:59:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:59:51 INFO - Running setup.py install for mozleak 10:59:51 INFO - Running setup.py install for mozlog 10:59:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:59:51 INFO - Running setup.py install for moznetwork 10:59:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:59:52 INFO - Running setup.py install for mozprocess 10:59:52 INFO - Running setup.py install for mozprofile 10:59:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:59:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:59:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:59:52 INFO - Running setup.py install for mozrunner 10:59:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:59:52 INFO - Running setup.py install for mozscreenshot 10:59:52 INFO - Running setup.py install for moztest 10:59:52 INFO - Running setup.py install for mozversion 10:59:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:59:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:59:52 INFO - Cleaning up... 10:59:52 INFO - Return code: 0 10:59:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:52 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:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:52 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:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:52 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 0x1a641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d090b0>, '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 0x1d09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a440>, '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': '4300f881736b422476174874000001bc-1502906344.671227-876597425', '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:59:52 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:59:52 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:59:52 INFO - Using env: {'DISPLAY': ':0', 10:59:52 INFO - 'HOME': '/home/cltbld', 10:59:52 INFO - 'LANG': 'en_US.UTF-8', 10:59:52 INFO - 'LANGUAGE': 'en_US:en', 10:59:52 INFO - 'LOGNAME': 'cltbld', 10:59:52 INFO - 'MAIL': '/var/mail/cltbld', 10:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:52 INFO - 'MOZ_NO_REMOTE': '1', 10:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:52 INFO - 'NO_EM_RESTART': '1', 10:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:52 INFO - 'PWD': '/builds/slave/test', 10:59:52 INFO - 'SHELL': '/bin/bash', 10:59:52 INFO - 'SHLVL': '1', 10:59:52 INFO - 'TERM': 'linux', 10:59:52 INFO - 'TMOUT': '86400', 10:59:52 INFO - 'USER': 'cltbld', 10:59:52 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502906344.671227-876597425', 10:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:52 INFO - '_': '/tools/buildbot/bin/python'} 10:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:59:52 INFO - Running setup.py (path:/tmp/pip-bC2LWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:59:52 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:59:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:59:52 INFO - Running setup.py (path:/tmp/pip-ppvrvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:59:53 INFO - Running setup.py (path:/tmp/pip-cR6Wzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:59:53 INFO - Running setup.py (path:/tmp/pip-PmikGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:59:53 INFO - Running setup.py (path:/tmp/pip-D7xlhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:59:53 INFO - Running setup.py (path:/tmp/pip-5HSjc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:59:53 INFO - Running setup.py (path:/tmp/pip-xz0fZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:59:53 INFO - Running setup.py (path:/tmp/pip-ezuFu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:59:53 INFO - Running setup.py (path:/tmp/pip-j4n6NL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:59:53 INFO - Running setup.py (path:/tmp/pip-v_g04e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:59:53 INFO - Running setup.py (path:/tmp/pip-lA5gjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:59:53 INFO - Running setup.py (path:/tmp/pip-qa_Q_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:59:53 INFO - Running setup.py (path:/tmp/pip-nVoOR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:59:53 INFO - Running setup.py (path:/tmp/pip-8HPN9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:53 INFO - Running setup.py (path:/tmp/pip-eyftls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:59:53 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:59:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:59:53 INFO - Running setup.py (path:/tmp/pip-w49ElP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:59:54 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:59:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:59:54 INFO - Running setup.py (path:/tmp/pip-_aTCxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:59:54 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:59:54 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:59:54 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:59:54 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:59:54 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:59:54 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:59:54 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:59:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:59:54 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:59:54 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:59:54 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:59:54 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:59:55 INFO - Downloading blessings-1.6.tar.gz 10:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:59:55 INFO - Installing collected packages: blessings 10:59:55 INFO - Running setup.py install for blessings 10:59:55 INFO - Successfully installed blessings 10:59:55 INFO - Cleaning up... 10:59:55 INFO - Return code: 0 10:59:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:59:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:55 INFO - Reading from file tmpfile_stdout 10:59:55 INFO - Current package versions: 10:59:55 INFO - argparse == 1.2.1 10:59:55 INFO - blessings == 1.6 10:59:55 INFO - blobuploader == 1.2.4 10:59:55 INFO - docopt == 0.6.1 10:59:55 INFO - functools32 == 3.2.3-2 10:59:55 INFO - jsonschema == 2.5.1 10:59:55 INFO - manifestparser == 1.1 10:59:55 INFO - mozInstall == 1.13 10:59:55 INFO - mozcrash == 1.0 10:59:55 INFO - mozdebug == 0.1 10:59:55 INFO - mozdevice == 0.51 10:59:55 INFO - mozfile == 1.2 10:59:55 INFO - mozhttpd == 0.7 10:59:55 INFO - mozinfo == 0.10 10:59:55 INFO - mozleak == 0.1 10:59:55 INFO - mozlog == 3.5 10:59:55 INFO - moznetwork == 0.27 10:59:55 INFO - mozprocess == 0.25 10:59:55 INFO - mozprofile == 0.28 10:59:55 INFO - mozrunner == 6.13 10:59:55 INFO - mozscreenshot == 0.1 10:59:55 INFO - mozsystemmonitor == 0.3 10:59:55 INFO - moztest == 0.8 10:59:55 INFO - mozversion == 1.4 10:59:55 INFO - psutil == 3.1.1 10:59:55 INFO - requests == 1.2.3 10:59:55 INFO - wsgiref == 0.1.2 10:59:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:55 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 0x1a641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d090b0>, '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 0x1d09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a440>, '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': '4300f881736b422476174874000001bc-1502906344.671227-876597425', '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:59:55 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:59:55 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:59:55 INFO - Using env: {'DISPLAY': ':0', 10:59:55 INFO - 'HOME': '/home/cltbld', 10:59:55 INFO - 'LANG': 'en_US.UTF-8', 10:59:55 INFO - 'LANGUAGE': 'en_US:en', 10:59:55 INFO - 'LOGNAME': 'cltbld', 10:59:55 INFO - 'MAIL': '/var/mail/cltbld', 10:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:55 INFO - 'MOZ_NO_REMOTE': '1', 10:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:55 INFO - 'NO_EM_RESTART': '1', 10:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:55 INFO - 'PWD': '/builds/slave/test', 10:59:55 INFO - 'SHELL': '/bin/bash', 10:59:55 INFO - 'SHLVL': '1', 10:59:55 INFO - 'TERM': 'linux', 10:59:55 INFO - 'TMOUT': '86400', 10:59:55 INFO - 'USER': 'cltbld', 10:59:55 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502906344.671227-876597425', 10:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:55 INFO - '_': '/tools/buildbot/bin/python'} 10:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:55 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:59:55 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:59:55 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:59:55 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:59:55 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:59:55 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:59:55 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:59:55 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:59:55 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:59:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:59:57 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:59:57 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:59:57 INFO - Installing collected packages: simplejson 10:59:57 INFO - Running setup.py install for simplejson 10:59:57 INFO - building 'simplejson._speedups' extension 10:59:57 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:59:57 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:59:58 INFO - Successfully installed simplejson 10:59:58 INFO - Cleaning up... 10:59:58 INFO - Return code: 0 10:59:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:59:58 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:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:59:58 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:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:59:58 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 0x1a641f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b68a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0bef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d090b0>, '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 0x1d09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a440>, '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': '4300f881736b422476174874000001bc-1502906344.671227-876597425', '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:59:58 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:59:58 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:59:58 INFO - Using env: {'DISPLAY': ':0', 10:59:58 INFO - 'HOME': '/home/cltbld', 10:59:58 INFO - 'LANG': 'en_US.UTF-8', 10:59:58 INFO - 'LANGUAGE': 'en_US:en', 10:59:58 INFO - 'LOGNAME': 'cltbld', 10:59:58 INFO - 'MAIL': '/var/mail/cltbld', 10:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:59:58 INFO - 'MOZ_NO_REMOTE': '1', 10:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:59:58 INFO - 'NO_EM_RESTART': '1', 10:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:59:58 INFO - 'PWD': '/builds/slave/test', 10:59:58 INFO - 'SHELL': '/bin/bash', 10:59:58 INFO - 'SHLVL': '1', 10:59:58 INFO - 'TERM': 'linux', 10:59:58 INFO - 'TMOUT': '86400', 10:59:58 INFO - 'USER': 'cltbld', 10:59:58 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502906344.671227-876597425', 10:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:59:58 INFO - '_': '/tools/buildbot/bin/python'} 10:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:59:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:59:58 INFO - Cleaning up... 10:59:58 INFO - Return code: 0 10:59:58 INFO - Running post-action listener: _resource_record_post_action 10:59:58 INFO - Running post-action listener: _start_resource_monitoring 10:59:58 INFO - Starting resource monitoring. 10:59:58 INFO - [mozharness: 2017-08-16 17:59:58.395293Z] Finished create-virtualenv step (success) 10:59:58 INFO - [mozharness: 2017-08-16 17:59:58.395767Z] Running install step. 10:59:58 INFO - Running pre-action listener: _resource_record_pre_action 10:59:58 INFO - Running main action method: install 10:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:59:58 INFO - Reading from file tmpfile_stdout 10:59:58 INFO - Detecting whether we're running mozinstall >=1.0... 10:59:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:59:58 INFO - Reading from file tmpfile_stdout 10:59:58 INFO - Output received: 10:59:58 INFO - Usage: mozinstall [options] installer 10:59:58 INFO - Options: 10:59:58 INFO - -h, --help show this help message and exit 10:59:58 INFO - -d DEST, --destination=DEST 10:59:58 INFO - Directory to install application into. [default: 10:59:58 INFO - "/builds/slave/test"] 10:59:58 INFO - --app=APP Application being installed. [default: firefox] 10:59:58 INFO - mkdir: /builds/slave/test/build/application 10:59:58 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:59:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:00:16 INFO - Reading from file tmpfile_stdout 11:00:16 INFO - Output received: 11:00:16 INFO - /builds/slave/test/build/application/firefox/firefox 11:00:16 INFO - Running post-action listener: _resource_record_post_action 11:00:16 INFO - [mozharness: 2017-08-16 18:00:16.874818Z] Finished install step (success) 11:00:16 INFO - [mozharness: 2017-08-16 18:00:16.875070Z] Running setup-mitmproxy step. 11:00:16 INFO - Running pre-action listener: _resource_record_pre_action 11:00:16 INFO - Running main action method: setup_mitmproxy 11:00:16 INFO - Skipping: mitmproxy is not required 11:00:16 INFO - Running post-action listener: _resource_record_post_action 11:00:16 INFO - [mozharness: 2017-08-16 18:00:16.876202Z] Finished setup-mitmproxy step (success) 11:00:16 INFO - [mozharness: 2017-08-16 18:00:16.876423Z] Running run-tests step. 11:00:16 INFO - Running pre-action listener: _resource_record_pre_action 11:00:16 INFO - Running pre-action listener: _set_gcov_prefix 11:00:16 INFO - Running main action method: run_tests 11:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:00:16 INFO - Python 2.7.3 11:00:16 INFO - Return code: 0 11:00:16 INFO - grabbing minidump binary from tooltool 11:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:00:16 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 0x1d090b0>, '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 0x1d09fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:00:16 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 11:00:16 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 11:00:16 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 11:00:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:00:17 INFO - Return code: 0 11:00:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:00:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:00:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:00:17 INFO - ENV: RUST_BACKTRACE is now full 11:00:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:00:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:00:17 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/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 11:00:17 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/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 11:00:17 INFO - Using env: {'DISPLAY': ':0', 11:00:17 INFO - 'HOME': '/home/cltbld', 11:00:17 INFO - 'LANG': 'en_US.UTF-8', 11:00:17 INFO - 'LANGUAGE': 'en_US:en', 11:00:17 INFO - 'LOGNAME': 'cltbld', 11:00:17 INFO - 'MAIL': '/var/mail/cltbld', 11:00:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:00:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:00:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:00:17 INFO - 'MOZ_NO_REMOTE': '1', 11:00:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:00:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:00:17 INFO - 'NO_EM_RESTART': '1', 11:00:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:00:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:00:17 INFO - 'PWD': '/builds/slave/test', 11:00:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:00:17 INFO - 'RUST_BACKTRACE': 'full', 11:00:17 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:00:17 INFO - 'SHELL': '/bin/bash', 11:00:17 INFO - 'SHLVL': '1', 11:00:17 INFO - 'STYLO_FORCE_ENABLED': '1', 11:00:17 INFO - 'TERM': 'linux', 11:00:17 INFO - 'TMOUT': '86400', 11:00:17 INFO - 'USER': 'cltbld', 11:00:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1502906344.671227-876597425', 11:00:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:00:17 INFO - '_': '/tools/buildbot/bin/python'} 11:00:17 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/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 11:00:17 INFO - mozversion application_buildid: 20170816171050 11:00:17 INFO - mozversion application_changeset: 07ce8c96222d533fc89c02802143d35d7c351f9c 11:00:17 INFO - mozversion application_display_name: Nightly 11:00:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:00:17 INFO - mozversion application_name: Firefox 11:00:17 INFO - mozversion application_remotingname: firefox 11:00:17 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:00:17 INFO - mozversion application_vendor: Mozilla 11:00:17 INFO - mozversion application_version: 57.0a1 11:00:17 INFO - mozversion platform_buildid: 20170816171050 11:00:17 INFO - mozversion platform_changeset: 07ce8c96222d533fc89c02802143d35d7c351f9c 11:00:17 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:00:17 INFO - mozversion platform_version: 57.0a1 11:00:17 INFO - using testdate: 1502906417 11:00:17 INFO - actual date: 1502906417 11:00:17 INFO - starting webserver on 'localhost:35154' 11:00:17 INFO - SUITE-START | Running 2 tests 11:00:17 INFO - TEST-START | dromaeo_css 11:00:17 INFO - Initialising browser for dromaeo_css test... 11:00:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35154/getInfo.html -profile /tmp/tmpIcJmLg/profile 11:00:17 INFO - TEST-INFO | started process 19908 (/builds/slave/test/build/application/firefox/firefox http://localhost:35154/getInfo.html) 11:00:23 INFO - TEST-INFO | 19908: exit 0 11:00:23 INFO - Browser initialized. 11:00:23 INFO - Running cycle 1/1 for dromaeo_css test... 11:00:23 INFO - TEST-INFO | started process 20144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIcJmLg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:00:24 INFO - PID 20144 | 11:00:24 INFO - PID 20144 | (/builds/slave/test/build/application/firefox/firefox:20197): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:00:24 INFO - PID 20144 | 11:00:35 INFO - PID 20144 | RSS: Main: 168079360 11:00:35 INFO - PID 20144 | 11:03:34 INFO - PID 20144 | Cycle 1(1): loaded http://localhost:35154/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35154/tests/dromaeo/cssquery-ext.html) 11:03:35 INFO - PID 20144 | RSS: Main: 175448064 11:03:35 INFO - PID 20144 | 11:06:37 INFO - PID 20144 | Cycle 1(1): loaded http://localhost:35154/tests/dromaeo/cssquery-ext.html (next: http://localhost:35154/tests/dromaeo/cssquery-jquery.html) 11:06:37 INFO - PID 20144 | RSS: Main: 172642304 11:06:37 INFO - PID 20144 | 11:09:39 INFO - PID 20144 | Cycle 1(1): loaded http://localhost:35154/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35154/tests/dromaeo/cssquery-mootools.html) 11:09:40 INFO - PID 20144 | RSS: Main: 174624768 11:09:40 INFO - PID 20144 | 11:12:42 INFO - PID 20144 | Cycle 1(1): loaded http://localhost:35154/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35154/tests/dromaeo/cssquery-prototype.html) 11:12:42 INFO - PID 20144 | RSS: Main: 172642304 11:12:42 INFO - PID 20144 | 11:15:46 INFO - PID 20144 | Cycle 1(1): loaded http://localhost:35154/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35154/tests/dromaeo/cssquery-yui.html) 11:15:47 INFO - PID 20144 | RSS: Main: 176553984 11:15:47 INFO - PID 20144 | 11:18:49 INFO - PID 20144 | Cycle 1(1): loaded http://localhost:35154/tests/dromaeo/cssquery-yui.html (next: http://localhost:35154/tests/dromaeo/cssquery-dojo.html) 11:18:49 INFO - PID 20144 | RSS: Main: 177139712 11:18:49 INFO - PID 20144 | 11:18:49 INFO - PID 20144 | __start_tp_report 11:18:49 INFO - PID 20144 | _x_x_mozilla_page_load 11:18:49 INFO - PID 20144 | _x_x_mozilla_page_load_details 11:18:49 INFO - PID 20144 | |i|pagename|runs| 11:18:49 INFO - PID 20144 | |0;dojo.html;3133.0757426559167;3149.2441813964656;3159.6366417861936;3184.952225716613;3218.82296473694;6086.604370715901;6128.988716861712;6137.079438084284;6177.505799536038;6184.257889053314;6015.789447369343;6133.969330153343;6151.261848578177;6169.043798211284;6173.691315434233;5542.224088627595;5571.916421253684;5575.749091290892;5583.078791999315;5588.385277619459;5609.8597535061745;5624.6625202487985;5624.859378515549;5680.176374425706;5702.743376548045;5606.775728970836;5677.744501497422;5690.487856092951;5734.225879506255;5761.971190144043;5592.664440133605;5629.802956896509;5655.0386434306265;5677.261955945742;5731.111677689923;5433.1035379162395;5449.482299181572;5532.834014979557;5564.276644036249;5640.689762063085;5964.552658550582;6063.848403789896;6122.387761223842;6136.048912418582;6155.692215389213;6488.059231411419;6551.344865513458;6574.211094668671;6658.700358483879;6661.400473957318;6631.27056023837;6645.734170633169;6676;6688.799336019927;6689.531732778707;6167.444929956326;6184.103305020792;6237.75048998035;6264.5301602380005;6267.5299352548745;6802.727890884309;6822.897656535156;6898.517103802786;6909.689063992132;6931.896021559681;6294.0558916162945;6391.42477177047;6459.806205813833;6511.772087976898;6602.6698665067515;6624.668766561653;6653.367930046637;6674.998750187414;6683.6658167091455;6708.027336036345;6590.9670451647435;6605.108310378134;6648;6678.3989440950545;6708.496862735315;6632.8673426531195;6643.40209381158;6719.126513553207;6721.193456785119;6731.225909020427;5288.92066619001;5378.838634840961;5385.003774301688;5455.345358556999;5457.781688732485;4666.8133274668635;4690.390249267573;4699.154152252559;4706.811727530929;4728.05438912219;5625.971870140623;5642.153676948491;5691.402402747734;5866.149408335853;5875.471207591338;6576.76981305652;6597.50518711089;6600.735970561123;6602.2407423146;6603.966980165068;5716.828495145152;5738.770449181986;5742.7415766290615;5747.942520574741;5748.051571490741;5750.654960702372;5808.07070868659;5880.852978675482;5919.082542205965;5950.19672344228;6387.457066149336;6393.808185754435;6448.774292899726;6470.611763294218;6548.148740663683;6429.003504456817;6586.967065164644;6676.432503237085;6679.098321726699;6726.091977583062;6369.49044076482;6392.968035159794;6396.392342727433;6405.2313722351755;6406.583572067801;5393.379761327341;6446.613203207822;6451.6774161290805;6454.031895215755;6454.67726613658;6668.233153187445;6675.666216689243;6773.322667733188;6776.051352810512;6795.966020169867;6388.9041664376;6438.130852334875;6473.8705225896165;6480.708368123352;6514.771982980573;6247.843803904757;6356.300806911328;6419.069234960998;6496.317886622026;6508.479321654161;6335.271443784024;6366.554341196257;6384.138141351044;6406.775762848278;6412.35876412355;6473.579217350857;6512.446442052478;6583.374579414948;6610.6694665267505;6617.470602351897;6294.8111556653375;6324.810255692337;6329.5569310149685;6400.775972840928;6437.163168788027 11:18:49 INFO - PID 20144 | |1;ext.html;793.6666600027992;844.5144042175749;872.8908886389199;873.1050673060113;1160.5415860735004;31856.36287274253;32397.352052958955;38750.99999999996;43122.13755724884;43210;42885.35671964915;43085.569144308545;43203.78398108013;43242.135157296834;43367.566324336745;7156.85686286274;7558.319751222402;7695.461317707734;7730.613469326539;7733.883991740128;7536.284053014982;7638.732644357448;7643.923560764405;7648.770536883874;7651.617419129049;7642.235776422341;7684.884726729104;7696.692132314729;7697.2302769722855;7700.075990881074;7554.244575542457;7608.391328693691;7611.2388761124;7654.196309387517;7671.654775535114;7530.359919406857;7596.088469383654;7624.771256862303;7636.045494313211;7636.732714354971;38600;38601.227975440335;38699.61300386988;38717.80641096805;38899.416508752394;3563.8574457021687;3596.352656521825;3600.513930619359;3603.0992251937014;3604.4232922732235;31347.37305253905;31378.843105784326;31461.213469663213;31489.21276968071;31554.842225788954;5070.214116811863;5077.543021128079;5082.1360368737405;5109.259157422191;5131.794728210867;194076;194629;194858;195002.02498987556;195668;48688;49027.26459103116;49206.75396623066;49396;49532.50467495279;50739;50748.74625626922;50876;50949.490505095215;51048.744756275984;16744.58138546522;16925.322987080624;16966.406175784035;16972.83027169737;16986.575335616708;10790.78418431627;10947.56209751601;13938.790918136236;14105.506307279196;14123.081999670194;14380.85619143816;14381.352839122264;14390.352434140488;14475;14581;5652.74562644682;5713.5714821388565;5726.77092916287;5795.594308398456;5804.506616937523;1000.0999100809184;1012.104287705386;1012.4532752313668;1024.538957469127;1031.582209205273;22762.886185568965;23324.067037318655;23551.764482354956;23641.527169456516;23796.52406951886;1115.1580556679817;1122.4443900269418;1126.7464820415505;1132.6035887439496;1145.873953865074;12195.695107622381;12257.325847078318;12351.567695130807;12446.626601201979;12516.49934002648;234648;235232;235271;235718;236181;54102;54106;54225.45774542204;54566;54660.72669636706;1422.5803388000566;1425.5723283015054;1444.4366696988184;1450.8113945187058;1456.0171883978273;22490.66264006074;22552.661710074033;22577.322680319616;22702.432439189153;22780.088796447955;38316.42525362066;38346.80826595849;38431.80784096062;38437.23125537418;38456.423153653275;197348;197917;198026;198244;199058;33872;36135.45796812997;36876.26247474982;36891.63108368989;36999.445008325434;47116;47758.76120619375;47876.28185577149;47919.5208047929;48040.75979620079;33471.66528334783;33809.66190338065;33918.66081339155;34204;34325;33241.667583323855;33604.32791344208;33706.3258734819;33737.83131084329;34271.65728342784;35782.105447364025;37247;37356;37380.81309593435;37500.06249843776;32759.34481310313;33018.504722428705;33100;33566.32867342591;33686.326273473904;24029.27912162638;24058.75941240635;24541.38646533851;24892.37769055788;24915 11:18:49 INFO - PID 20144 | |2;jquery.html;564.9830505084849;564.9999999999998;580.2485780913717;580.2775544447163;585.221655198586;22049.33851984439;22550.097996080138;23195.884020579895;23225.535489290203;23262.069517219334;27743.44513109742;27873.442531149365;27972;27978;27986.860065699642;6962.199347075088;7077.823054423655;7115.181754098293;7120.572765634079;7125.216226215112;6460.321666225026;6911.861762764742;7045.048918396028;7065.6113913734725;7072;7042.260562640926;7053.682584283694;7054.3651071403565;7059.9647001764915;7060.29397060295;7052.506324557257;7052.858942821166;7054.894176587355;7055.188653304885;7057.717691292342;6917.100776899021;6924.4114250288785;6932.306769323078;6939.548929319578;6961.338672826073;30244.243893902607;31076.533851992237;31482.842585787155;31602;31617;1972.980270197294;2006.3278801601482;2011.8390528757664;2014.7582290125279;2014.8992550372423;20452.181912723474;21027.26404575848;21070;21373.145074197015;21383.144674213014;2398.424378149249;2425.987870060656;2536.606825941982;2537.378342306128;2556.2842404126873;140452;143100.28449857788;143460.99999999895;143477;143947;19895.801041989394;21269.78730212709;21634.459138521663;21654.675179872316;22900.31299061031;44753.32870006953;44756.77621611936;44790.55209447864;44875;44993.325100123526;10900.618478353219;11039.503222355013;11075;11110.166737494721;11305.49125289364;7873.842523149505;9126.45241285525;9149.313801464918;9232.753578266982;9383.108604682544;10215.642452514126;10829.83755243672;11394;11542.307461552333;12239.265644061385;3906.99161645537;4065.390191471303;4088.9591104089172;4127.772972486542;4451.666125040635;964.0744884910424;985.1281615770096;987.7777500062429;1009.2027298434301;1009.5406590001531;19710.40868773939;19984.50038749043;20201.090950907244;20556.794432055787;20942.47643808917;1046.4558429616557;1066.4987455895716;1069.0378659206776;1076.6931424543968;1087.836824476319;11070.667879963614;11195.4962026709;11219.270747401393;11324;11517.884821151849;491538;498442;503164;503733;512626;110940;112847;114519;116258.41870790592;116908.41545792216;1212.8532744563206;1216.689744115245;1242.8881400673984;1242.9564965226173;1253.141598005351;17445.214965326337;17474.563135921704;17665.116744163;17866.285348585912;17931.910340448216;53475;55047.449525505835;57258;58506;58652.70673646775;67602;67678.3232167672;67912.3208767906;68265.31734682788;68648.31351686618;11925.582604608797;12545.560905368267;13129.277889716157;14835.554933352018;15210.847891520943;23904.40238994039;24109.879450602635;24271.635925460778;24298;24497.51004979926;18414.079296034877;18895.716564251823;18941.621167576297;19027.71458428097;19139.043047847274;16816.663666726843;16931.238094286033;17240.137993100547;17475.47573572795;17753;17808.10959452048;18024.188911498753;18125.909370453064;19190.752601080883;19403.223871045564;14712.19082950448;14968.850311496746;14982.550523484313;14993.100413975197;14997.775033374726;18313.175907083947;18339.358122466183;18587.07064646789;18599.16303766361;18624 11:18:49 INFO - PID 20144 | |3;mootools.html;1337.1709540085146;1345.286997891118;1368.4184221705773;1373.663452454149;1413.1097408632563;14060.929695351522;14782.113073215614;14807.407703691853;14824.925875370634;14826.925865370658;12401.317927513983;12517.561885334015;12622.431990560424;14120.43518259271;14487.855121448782;2648.907288244912;2715.8777854996474;2717.6738791345065;2719.7960152988603;2723;2443.511297740459;2520.9873950630313;2607.3220962549685;2650.045983445958;2685.1139124089004;2676.51822671919;2714.687810901742;2716.1172618898936;2730.1263595649402;2749.024096445763;2561.897524099034;2609.321576390152;2648.655674762278;2651.973480265192;2667.933301667464;2545.325488745484;2566.3199252198183;2569.8843552040203;2571.5885458326766;2595.558755011634;13955.162690238618;14071.85928140726;14109.941754368361;14118.788218176736;14151.85848141526;7480.214577469396;7652.273034061755;7782.610869456505;7784.494007889469;7792.9220707792765;4688.460827004904;4932.975335123338;5015.673981191211;5069.315642388267;5079.085764562377;1746.903920284384;1758.6218962922906;1783.3847322673657;1791.8476929461012;1879.981200188008;24032.759672403226;24092.638610420858;24263.63604545933;24279.514409711883;24293;6522.15212022434;6541.34586541342;6842.692078856463;6851.1778586568935;6919.861602767916;16207.675846483004;16221;16344.591385215226;16355.59111022234;16368.67262654764;7244.529105608119;7369.668364923591;7383.2985866342615;7396.778096657109;7420.109586849612;6700.731970721116;6898.0687607173395;7001.36987671112;7006.439484841302;7046.330598593126;5020.397552293748;5188.766505507261;5199.1161502544655;5219.173289348698;5265.999460102568;1325.1850112181132;1377.3595278195687;1390.242317936727;1434.8278206615273;1474.6608280095638;882.1178821178821;892.2861710631469;892.8571428571397;902.5919565477875;911.8541033434618;8269.503829770232;8610.741677749678;8648.697295594624;8722.476651400937;8794.208521232991;974.6345120579782;976.0434773921596;980.1227901028682;992.3004281981185;998.236349192868;5076.771545280398;5360.678359298455;5383.246345511631;5387.380451248078;5406.594505412031;19534.413967580997;19735.111919963638;20390.388288351372;20401.795982040287;20446.591068178554;19977;19989.500262493264;19991.800081998994;20043.29848455297;20105.19579216815;9905.81130264373;10311.639092631873;10551.366917984946;10654;10663.946680266705;8399.70601028961;8460.280876125353;8662.220400164015;8682.652693892174;8802.38383313162;17505.21226544783;17929.910350448165;17939.641207175522;18073.909630451762;18273.3604323848;17847.46457606274;18237.179326930585;18321.908390457964;18391.264349425874;18481.815181848546;11040.779184416106;11329.69708483535;11517.424128793695;11574;11574.88425115738;13448.260345681081;13467.191968481922;13494.055416120776;13508.39212235432;13525;10817.837732433862;10866.836997445203;10888.61889833852;10978.615748448767;11100.61147859821;10873.945630272114;10932.234743567873;11047.889521104686;11141.498632561392;11275;9759.75600609962;9836.163926066365;9919.950400247953;9949.801003980025;9952.950235248778;6988.545744526589;7083.82290442743;7100.7573674607775;7123.180834204133;7137.2149063604;7350.632468376667;7363.595002274927;7402.29678180572;7404.740834070782;7465.776026719207 11:18:49 INFO - PID 20144 | |4;prototype.html;476.92846073089055;501.9102920961359;508.9033083714092;509.9082165210262;514.4444000479483;6010.218671572689;6111.663858487781;6153.169322141515;6167.845803854906;6219.409156130166;5884.205632239647;6002.819915402534;6052.455279024887;6102.511799056076;6111.938880611204;5109.974450127754;5155.149400348938;5171.37943446785;5189.974050129744;5211.993382547727;5056.84829455117;5087.5421212090905;5100.41345245296;5153.6392452528335;5207.765650545734;5086.237064440345;5091.261767043777;5112.446849439641;5142.537171654551;5152;5089.160288552384;5097;5116.846494605149;5137.460566640505;5169.407261952944;4765.714057156547;4767.356406885061;4826.166056898392;4857.465678775332;4872.3909511311085;5977.970110149465;5992.161097446361;6013.609115407485;6028.96985515074;6055;5929.258842644669;5937.970310148422;5940.732667029994;5975.282966044103;6026.8493287667725;6404.967975160094;6432.485401167942;6441.742330306782;6449.516286278501;6480.967595161994;5271.894562108775;5306.97346513265;5351.545118664918;5353.652012619167;5360.16917377807;6928.549644273106;6934.618595977219;6940.7917762467205;7006.369426751566;7031.929680703128;5337.492938170868;5348.893022139536;5376.548331950352;5401.756920938567;5418.376886658085;5449.972750136224;5450.209719590716;5515.117581186991;5517.062099443105;5528.917066244009;5880.852978675567;5963.5527335450015;5973.402659733992;5979.1629171915965;5988.730507127189;6506.479481641457;6523.249826269945;6553.246376666649;6574.506911981621;6585.209774826955;1783.9474709921208;1882.8117188281062;1886.283212379287;1922.84617230624;1933.4489670443857;1403.6069900427897;1410.4146779086564;1434.956951291463;1455.9417623295162;1456.8834493240515;5624.746886390122;5657.811859509467;5658.74535645897;5701;5722.141678748221;6380.776672816429;6573.441257493071;6657.20113586363;6732.326767323327;6762.729490820312;5722.828315150552;5774.162746401748;5779.162021506858;5827.213326200908;5842.152887831241;3518.4546395308766;3581.606023337431;3596.9100772480374;3599.4240921452965;3602.1354874829854;6624.304448032887;6625.536212465177;6639.302873198341;6651.401373876278;6663.833404164935;6909.689063992132;6924.757633482804;6941.305869413019;6949.30506949301;6979.742357162127;6530.379613936669;6602.702878370389;6603.405693487609;6614.966925165343;6622.96688516564;6679.432248258952;6718.656268746368;6726.159230096238;6748.73005079811;6779.423748981392;6568.21181458209;6650.769607622606;6668.433183179484;6699.631520266432;6714.328567143247;6500.219973603198;6505.786973440258;6553.705083271359;6555.3772391622715;6565.638889861103;4873.220284754422;4876.2932973459;4898.53463920927;4921.753912304442;4932.679375840559;6363.122878750873;6513.348665133449;6615.37153970372;6665.566738162004;6705.1283333166375;5996.910046349395;6324.861524925557;6461.289258181502;6488.870222595616;6529.51028672861;6394.561223724811;6406.679666016774;6415.82416703716;6499.6750162492635;6522.836929076811;6360.459360954371;6375.968120159369;6427.971524556048;6439.130717353098;6442;6428.742850286123;6438;6458.515611329075;6531.804045878441;6538;6267.874642507216;6268.122462855295;6309.90535141964;6368.64972426521;6425.678716064272 11:18:49 INFO - PID 20144 | |5;yui.html;863.6631713631684;882.7307671160294;889.2352576783965;892.3575025981294;900.2707806676592;19180.040997950116;20129.899350503245;20137.798622013775;20157.99999999998;20202.19191232349;17835.64328713425;17948.10259487027;18078.638427231446;22820.08719651212;22898.427539311524;1053.2416660004785;1078.245228340161;1078.6278733836814;1078.7087486378712;1079.023483747206;981.9607215711363;1059.348500672089;1072.447689439939;1074.2426589254558;1074.7635520185547;1106.5131342209402;1118.949647265875;1119.1941801902617;1119.5577746790013;1124.9493772780204;1112.7106952192407;1112.9888701113048;1113.8217885138379;1118.2563595209217;1118.6867677050398;812.358236992775;813.3615112137003;813.8616435206029;814.1695470619994;815.4617952151551;19857.304994325128;20050.598988020305;20077.698834517494;20183.39449816508;20945.685814712793;20145.294914677917;20819.479513012146;21952.670709939364;22239.55520889573;22296;17201.569960750956;17271.56821079483;18953.052347382574;20068.598628027357;20109.39671809848;3630.3465376232266;3661.487391765155;3688.5942546319884;3692.4276737105793;3700.5929347771726;132456.3377183108;132587;133799.33100334535;135083.32458337743;136254.31872840572;16967.236474358684;17438;17916.10419479021;17963.550911227063;17992.640147196984;31353;31493.212669683442;31996.520052199237;32086.518702219484;32092.03723888287;8625.525596092275;8724.781880452912;8865.024847266925;8892.555372231363;8919.643214271486;4017.4777278954134;4041.939370909439;4097.959020409818;4102.384642303678;4126.154138401621;5332.466753324714;5351.678899266057;5367.490088441592;5423.18652202165;5423.240746295522;1030.283952652899;1054.130342467452;1055.9894401055892;1056.1339701444895;1059.1950117910444;630.5901164243279;631.955763096588;632.6330728177646;637.1144109687538;651.8337823854887;11569.479373428216;12450.688732781753;12527.93736031314;13130.080894337496;13188.47246110164;682.9829254268683;686.8557602903346;691.7405972760215;696.9651517424109;700.8948657701386;5734.971325143431;5928.229330187048;5957.344692083867;6125.295591007002;6234.314225435199;110686.44656776664;110895;113084;113492;115663;99076;99706;99929.50035249922;102264;104074.4796276029;88295.11704882869;88531;89111;90272.48637568226;90724.54637726901;12462.626121216377;12668.66978967232;12756.808647870104;12903.06533613217;13074.346282686018;39226;40500.79749601233;40548.1890362197;41401.585984139776;42053.57946420619;73538.63230683812;74358.62820685862;76895.61552192204;78461.46923388576;79766.60116699379;17941.910290448464;19144.904275478533;20051.799482004993;20078.799212007692;20129.496762581053;21580;22179.889100554396;22196.334109976728;22208.888955555118;22588.435289117904;19706.90146549258;20199.8990005049;20217.29239476611;20275.493112672302;20507.077181527166;19030.143643535797;19533.413997580094;19844.50388740293;20217.89891050535;20663.276785312442;15145.469908553148;15211.467598633995;15338.463153789564;18586.25654973786;19648.329891958772;13219.339033048502;13965.720685586028;14333.211673357648;14616.66491730532;14635.780463293273;14760.409583616965;14784.677516093983;15245.390184392943;15342.23288835576;15697.450589229778 11:18:49 INFO - PID 20144 | __end_tp_report 11:18:49 INFO - PID 20144 | __start_cc_report 11:18:49 INFO - PID 20144 | _x_x_mozilla_cycle_collect,383 11:18:49 INFO - PID 20144 | __end_cc_report 11:18:49 INFO - PID 20144 | __startTimestamp1502907529534__endTimestamp 11:18:49 INFO - PID 20144 | 11:18:49 INFO - PID 20144 | ------- Summary: start ------- 11:18:49 INFO - PID 20144 | Number of tests: 6 11:18:49 INFO - PID 20144 | 11:18:49 INFO - PID 20144 | [#0] dojo.html Cycles:165 Average:6092.89 Median:6356.30 stddev:716.22 (11.3%) stddev-sans-first:679.74 11:18:49 INFO - PID 20144 | Values: 3133.1 3149.2 3159.6 3185.0 3218.8 6086.6 6129.0 6137.1 6177.5 6184.3 6015.8 6134.0 6151.3 6169.0 6173.7 5542.2 5571.9 5575.7 5583.1 5588.4 5609.9 5624.7 5624.9 5680.2 5702.7 5606.8 5677.7 5690.5 5734.2 5762.0 5592.7 5629.8 5655.0 5677.3 5731.1 5433.1 5449.5 5532.8 5564.3 5640.7 5964.6 6063.8 6122.4 6136.0 6155.7 6488.1 6551.3 6574.2 6658.7 6661.4 6631.3 6645.7 6676.0 6688.8 6689.5 6167.4 6184.1 6237.8 6264.5 6267.5 6802.7 6822.9 6898.5 6909.7 6931.9 6294.1 6391.4 6459.8 6511.8 6602.7 6624.7 6653.4 6675.0 6683.7 6708.0 6591.0 6605.1 6648.0 6678.4 6708.5 6632.9 6643.4 6719.1 6721.2 6731.2 5288.9 5378.8 5385.0 5455.3 5457.8 4666.8 4690.4 4699.2 4706.8 4728.1 5626.0 5642.2 5691.4 5866.1 5875.5 6576.8 6597.5 6600.7 6602.2 6604.0 5716.8 5738.8 5742.7 5747.9 5748.1 5750.7 5808.1 5880.9 5919.1 5950.2 6387.5 6393.8 6448.8 6470.6 6548.1 6429.0 6587.0 6676.4 6679.1 6726.1 6369.5 6393.0 6396.4 6405.2 6406.6 5393.4 6446.6 6451.7 6454.0 6454.7 6668.2 6675.7 6773.3 6776.1 6796.0 6388.9 6438.1 6473.9 6480.7 6514.8 6247.8 6356.3 6419.1 6496.3 6508.5 6335.3 6366.6 6384.1 6406.8 6412.4 6473.6 6512.4 6583.4 6610.7 6617.5 6294.8 6324.8 6329.6 6400.8 6437.2 11:18:49 INFO - PID 20144 | 11:18:49 INFO - PID 20144 | [#1] ext.html Cycles:180 Average:38283.42 Median:19689.23 stddev:54493.06 (276.8%) stddev-sans-first:54573.22 11:18:49 INFO - PID 20144 | Values: 793.7 844.5 872.9 873.1 1160.5 31856.4 32397.4 38751.0 43122.1 43210.0 42885.4 43085.6 43203.8 43242.1 43367.6 7156.9 7558.3 7695.5 7730.6 7733.9 7536.3 7638.7 7643.9 7648.8 7651.6 7642.2 7684.9 7696.7 7697.2 7700.1 7554.2 7608.4 7611.2 7654.2 7671.7 7530.4 7596.1 7624.8 7636.0 7636.7 38600.0 38601.2 38699.6 38717.8 38899.4 3563.9 3596.4 3600.5 3603.1 3604.4 31347.4 31378.8 31461.2 31489.2 31554.8 5070.2 5077.5 5082.1 5109.3 5131.8 194076.0 194629.0 194858.0 195002.0 195668.0 48688.0 49027.3 49206.8 49396.0 49532.5 50739.0 50748.7 50876.0 50949.5 51048.7 16744.6 16925.3 16966.4 16972.8 16986.6 10790.8 10947.6 13938.8 14105.5 14123.1 14380.9 14381.4 14390.4 14475.0 14581.0 5652.7 5713.6 5726.8 5795.6 5804.5 1000.1 1012.1 1012.5 1024.5 1031.6 22762.9 23324.1 23551.8 23641.5 23796.5 1115.2 1122.4 1126.7 1132.6 1145.9 12195.7 12257.3 12351.6 12446.6 12516.5 234648.0 235232.0 235271.0 235718.0 236181.0 54102.0 54106.0 54225.5 54566.0 54660.7 1422.6 1425.6 1444.4 1450.8 1456.0 22490.7 22552.7 22577.3 22702.4 22780.1 38316.4 38346.8 38431.8 38437.2 38456.4 197348.0 197917.0 198026.0 198244.0 199058.0 33872.0 36135.5 36876.3 36891.6 36999.4 47116.0 47758.8 47876.3 47919.5 48040.8 33471.7 33809.7 33918.7 34204.0 34325.0 33241.7 33604.3 33706.3 33737.8 34271.7 35782.1 37247.0 37356.0 37380.8 37500.1 32759.3 33018.5 33100.0 33566.3 33686.3 24029.3 24058.8 24541.4 24892.4 24915.0 11:18:49 INFO - PID 20144 | 11:18:49 INFO - PID 20144 | [#2] jquery.html Cycles:180 Average:36301.89 Median:21852.01 stddev:84366.30 (386.1%) stddev-sans-first:84560.30 11:18:49 INFO - PID 20144 | Values: 565.0 565.0 580.2 580.3 585.2 22049.3 22550.1 23195.9 23225.5 23262.1 27743.4 27873.4 27972.0 27978.0 27986.9 6962.2 7077.8 7115.2 7120.6 7125.2 6460.3 6911.9 7045.0 7065.6 7072.0 7042.3 7053.7 7054.4 7060.0 7060.3 7052.5 7052.9 7054.9 7055.2 7057.7 6917.1 6924.4 6932.3 6939.5 6961.3 30244.2 31076.5 31482.8 31602.0 31617.0 1973.0 2006.3 2011.8 2014.8 2014.9 20452.2 21027.3 21070.0 21373.1 21383.1 2398.4 2426.0 2536.6 2537.4 2556.3 140452.0 143100.3 143461.0 143477.0 143947.0 19895.8 21269.8 21634.5 21654.7 22900.3 44753.3 44756.8 44790.6 44875.0 44993.3 10900.6 11039.5 11075.0 11110.2 11305.5 7873.8 9126.5 9149.3 9232.8 9383.1 10215.6 10829.8 11394.0 11542.3 12239.3 3907.0 4065.4 4089.0 4127.8 4451.7 964.1 985.1 987.8 1009.2 1009.5 19710.4 19984.5 20201.1 20556.8 20942.5 1046.5 1066.5 1069.0 1076.7 1087.8 11070.7 11195.5 11219.3 11324.0 11517.9 491538.0 498442.0 503164.0 503733.0 512626.0 110940.0 112847.0 114519.0 116258.4 116908.4 1212.9 1216.7 1242.9 1243.0 1253.1 17445.2 17474.6 17665.1 17866.3 17931.9 53475.0 55047.4 57258.0 58506.0 58652.7 67602.0 67678.3 67912.3 68265.3 68648.3 11925.6 12545.6 13129.3 14835.6 15210.8 23904.4 24109.9 24271.6 24298.0 24497.5 18414.1 18895.7 18941.6 19027.7 19139.0 16816.7 16931.2 17240.1 17475.5 17753.0 17808.1 18024.2 18125.9 19190.8 19403.2 14712.2 14968.9 14982.6 14993.1 14997.8 18313.2 18339.4 18587.1 18599.2 18624.0 11:18:49 INFO - PID 20144 | 11:18:49 INFO - PID 20144 | [#3] mootools.html Cycles:180 Average:8930.33 Median:2583.57 stddev:6193.28 (239.7%) stddev-sans-first:6184.37 11:18:49 INFO - PID 20144 | Values: 1337.2 1345.3 1368.4 1373.7 1413.1 14060.9 14782.1 14807.4 14824.9 14826.9 12401.3 12517.6 12622.4 14120.4 14487.9 2648.9 2715.9 2717.7 2719.8 2723.0 2443.5 2521.0 2607.3 2650.0 2685.1 2676.5 2714.7 2716.1 2730.1 2749.0 2561.9 2609.3 2648.7 2652.0 2667.9 2545.3 2566.3 2569.9 2571.6 2595.6 13955.2 14071.9 14109.9 14118.8 14151.9 7480.2 7652.3 7782.6 7784.5 7792.9 4688.5 4933.0 5015.7 5069.3 5079.1 1746.9 1758.6 1783.4 1791.8 1880.0 24032.8 24092.6 24263.6 24279.5 24293.0 6522.2 6541.3 6842.7 6851.2 6919.9 16207.7 16221.0 16344.6 16355.6 16368.7 7244.5 7369.7 7383.3 7396.8 7420.1 6700.7 6898.1 7001.4 7006.4 7046.3 5020.4 5188.8 5199.1 5219.2 5266.0 1325.2 1377.4 1390.2 1434.8 1474.7 882.1 892.3 892.9 902.6 911.9 8269.5 8610.7 8648.7 8722.5 8794.2 974.6 976.0 980.1 992.3 998.2 5076.8 5360.7 5383.2 5387.4 5406.6 19534.4 19735.1 20390.4 20401.8 20446.6 19977.0 19989.5 19991.8 20043.3 20105.2 9905.8 10311.6 10551.4 10654.0 10663.9 8399.7 8460.3 8662.2 8682.7 8802.4 17505.2 17929.9 17939.6 18073.9 18273.4 17847.5 18237.2 18321.9 18391.3 18481.8 11040.8 11329.7 11517.4 11574.0 11574.9 13448.3 13467.2 13494.1 13508.4 13525.0 10817.8 10866.8 10888.6 10978.6 11100.6 10873.9 10932.2 11047.9 11141.5 11275.0 9759.8 9836.2 9920.0 9949.8 9953.0 6988.5 7083.8 7100.8 7123.2 7137.2 7350.6 7363.6 7402.3 7404.7 7465.8 11:18:49 INFO - PID 20144 | 11:18:49 INFO - PID 20144 | [#4] prototype.html Cycles:180 Average:5574.41 Median:6020.23 stddev:1497.58 (24.9%) stddev-sans-first:1452.09 11:18:49 INFO - PID 20144 | Values: 476.9 501.9 508.9 509.9 514.4 6010.2 6111.7 6153.2 6167.8 6219.4 5884.2 6002.8 6052.5 6102.5 6111.9 5110.0 5155.1 5171.4 5190.0 5212.0 5056.8 5087.5 5100.4 5153.6 5207.8 5086.2 5091.3 5112.4 5142.5 5152.0 5089.2 5097.0 5116.8 5137.5 5169.4 4765.7 4767.4 4826.2 4857.5 4872.4 5978.0 5992.2 6013.6 6029.0 6055.0 5929.3 5938.0 5940.7 5975.3 6026.8 6405.0 6432.5 6441.7 6449.5 6481.0 5271.9 5307.0 5351.5 5353.7 5360.2 6928.5 6934.6 6940.8 7006.4 7031.9 5337.5 5348.9 5376.5 5401.8 5418.4 5450.0 5450.2 5515.1 5517.1 5528.9 5880.9 5963.6 5973.4 5979.2 5988.7 6506.5 6523.2 6553.2 6574.5 6585.2 1783.9 1882.8 1886.3 1922.8 1933.4 1403.6 1410.4 1435.0 1455.9 1456.9 5624.7 5657.8 5658.7 5701.0 5722.1 6380.8 6573.4 6657.2 6732.3 6762.7 5722.8 5774.2 5779.2 5827.2 5842.2 3518.5 3581.6 3596.9 3599.4 3602.1 6624.3 6625.5 6639.3 6651.4 6663.8 6909.7 6924.8 6941.3 6949.3 6979.7 6530.4 6602.7 6603.4 6615.0 6623.0 6679.4 6718.7 6726.2 6748.7 6779.4 6568.2 6650.8 6668.4 6699.6 6714.3 6500.2 6505.8 6553.7 6555.4 6565.6 4873.2 4876.3 4898.5 4921.8 4932.7 6363.1 6513.3 6615.4 6665.6 6705.1 5996.9 6324.9 6461.3 6488.9 6529.5 6394.6 6406.7 6415.8 6499.7 6522.8 6360.5 6376.0 6428.0 6439.1 6442.0 6428.7 6438.0 6458.5 6531.8 6538.0 6267.9 6268.1 6309.9 6368.6 6425.7 11:18:49 INFO - PID 20144 | 11:18:49 INFO - PID 20144 | [#5] yui.html Cycles:180 Average:24827.85 Median:20170.70 stddev:33621.15 (166.7%) stddev-sans-first:33667.31 11:18:49 INFO - PID 20144 | Values: 863.7 882.7 889.2 892.4 900.3 19180.0 20129.9 20137.8 20158.0 20202.2 17835.6 17948.1 18078.6 22820.1 22898.4 1053.2 1078.2 1078.6 1078.7 1079.0 982.0 1059.3 1072.4 1074.2 1074.8 1106.5 1118.9 1119.2 1119.6 1124.9 1112.7 1113.0 1113.8 1118.3 1118.7 812.4 813.4 813.9 814.2 815.5 19857.3 20050.6 20077.7 20183.4 20945.7 20145.3 20819.5 21952.7 22239.6 22296.0 17201.6 17271.6 18953.1 20068.6 20109.4 3630.3 3661.5 3688.6 3692.4 3700.6 132456.3 132587.0 133799.3 135083.3 136254.3 16967.2 17438.0 17916.1 17963.6 17992.6 31353.0 31493.2 31996.5 32086.5 32092.0 8625.5 8724.8 8865.0 8892.6 8919.6 4017.5 4041.9 4098.0 4102.4 4126.2 5332.5 5351.7 5367.5 5423.2 5423.2 1030.3 1054.1 1056.0 1056.1 1059.2 630.6 632.0 632.6 637.1 651.8 11569.5 12450.7 12527.9 13130.1 13188.5 683.0 686.9 691.7 697.0 700.9 5735.0 5928.2 5957.3 6125.3 6234.3 110686.4 110895.0 113084.0 113492.0 115663.0 99076.0 99706.0 99929.5 102264.0 104074.5 88295.1 88531.0 89111.0 90272.5 90724.5 12462.6 12668.7 12756.8 12903.1 13074.3 39226.0 40500.8 40548.2 41401.6 42053.6 73538.6 74358.6 76895.6 78461.5 79766.6 17941.9 19144.9 20051.8 20078.8 20129.5 21580.0 22179.9 22196.3 22208.9 22588.4 19706.9 20199.9 20217.3 20275.5 20507.1 19030.1 19533.4 19844.5 20217.9 20663.3 15145.5 15211.5 15338.5 18586.3 19648.3 13219.3 13965.7 14333.2 14616.7 14635.8 14760.4 14784.7 15245.4 15342.2 15697.5 11:18:49 INFO - PID 20144 | -------- Summary: end -------- 11:18:49 INFO - PID 20144 | 11:18:50 INFO - TEST-INFO | 20144: exit 0 11:18:50 INFO - TEST-OK | dromaeo_css | took 1113010ms 11:18:50 INFO - TEST-START | kraken 11:18:50 INFO - Initialising browser for kraken test... 11:18:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35154/getInfo.html -profile /tmp/tmpL6VbOo/profile 11:18:50 INFO - TEST-INFO | started process 20526 (/builds/slave/test/build/application/firefox/firefox http://localhost:35154/getInfo.html) 11:18:56 INFO - TEST-INFO | 20526: exit 0 11:18:56 INFO - Browser initialized. 11:18:56 INFO - Running cycle 1/1 for kraken test... 11:18:56 INFO - TEST-INFO | started process 20764 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpL6VbOo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:57 INFO - PID 20764 | 11:18:57 INFO - PID 20764 | (/builds/slave/test/build/application/firefox/firefox:20818): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:18:57 INFO - PID 20764 | 11:19:07 INFO - PID 20764 | RSS: Main: 171286528 11:19:07 INFO - PID 20764 | 11:19:10 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35154/tests/kraken/driver.html?testName=audio-beat-detection) 11:19:11 INFO - PID 20764 | RSS: Main: 178618368 11:19:11 INFO - PID 20764 | 11:19:13 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35154/tests/kraken/driver.html?testName=audio-dft) 11:19:14 INFO - PID 20764 | RSS: Main: 182431744 11:19:14 INFO - PID 20764 | 11:19:17 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35154/tests/kraken/driver.html?testName=audio-fft) 11:19:18 INFO - PID 20764 | RSS: Main: 174968832 11:19:18 INFO - PID 20764 | 11:19:20 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35154/tests/kraken/driver.html?testName=audio-oscillator) 11:19:21 INFO - PID 20764 | RSS: Main: 175525888 11:19:21 INFO - PID 20764 | 11:19:23 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35154/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:19:23 INFO - PID 20764 | RSS: Main: 175747072 11:19:23 INFO - PID 20764 | 11:19:27 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35154/tests/kraken/driver.html?testName=imaging-darkroom) 11:19:27 INFO - PID 20764 | RSS: Main: 177041408 11:19:27 INFO - PID 20764 | 11:19:31 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35154/tests/kraken/driver.html?testName=imaging-desaturate) 11:19:31 INFO - PID 20764 | RSS: Main: 177082368 11:19:31 INFO - PID 20764 | 11:19:34 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35154/tests/kraken/driver.html?testName=json-parse-financial) 11:19:35 INFO - PID 20764 | RSS: Main: 177729536 11:19:35 INFO - PID 20764 | 11:19:36 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35154/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:19:37 INFO - PID 20764 | RSS: Main: 177598464 11:19:37 INFO - PID 20764 | 11:19:39 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35154/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:19:40 INFO - PID 20764 | RSS: Main: 174845952 11:19:40 INFO - PID 20764 | 11:19:42 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35154/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:19:42 INFO - PID 20764 | RSS: Main: 174170112 11:19:42 INFO - PID 20764 | 11:19:45 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:19:46 INFO - PID 20764 | RSS: Main: 174919680 11:19:46 INFO - PID 20764 | 11:19:49 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:19:50 INFO - PID 20764 | RSS: Main: 174886912 11:19:50 INFO - PID 20764 | 11:19:51 INFO - PID 20764 | Cycle 1(1): loaded http://localhost:35154/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35154/tests/kraken/driver.html?testName=ai-astar) 11:19:52 INFO - PID 20764 | RSS: Main: 176144384 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | __start_tp_report 11:19:52 INFO - PID 20764 | _x_x_mozilla_page_load 11:19:52 INFO - PID 20764 | _x_x_mozilla_page_load_details 11:19:52 INFO - PID 20764 | |i|pagename|runs| 11:19:52 INFO - PID 20764 | |0;ai-astar;97;108;101;109;110;107;108;105;110;108 11:19:52 INFO - PID 20764 | |1;audio-beat-detection;152;116;139;166;123;145;144;115;175;122 11:19:52 INFO - PID 20764 | |2;audio-dft;162;173;166;166;161;162;170;165;164;164 11:19:52 INFO - PID 20764 | |3;audio-fft;78;77;74;172;77;76;78;82;171;76 11:19:52 INFO - PID 20764 | |4;audio-oscillator;78;83;135;78;80;78;132;80;80;134 11:19:52 INFO - PID 20764 | |5;imaging-gaussian-blur;114;117;117;116;114;117;122;114;115;117 11:19:52 INFO - PID 20764 | |6;imaging-darkroom;150;150;150;151;152;149;151;149;152;150 11:19:52 INFO - PID 20764 | |7;imaging-desaturate;93;94;94;95;95;94;97;94;94;94 11:19:52 INFO - PID 20764 | |8;json-parse-financial;54;57;53;54;56;65;55;53;57;54 11:19:52 INFO - PID 20764 | |9;json-stringify-tinderbox;53;55;53;54;54;54;54;54;62;58 11:19:52 INFO - PID 20764 | |10;stanford-crypto-aes;80;77;77;76;77;79;77;76;78;78 11:19:52 INFO - PID 20764 | |11;stanford-crypto-ccm;128;129;123;127;120;120;129;128;132;164 11:19:52 INFO - PID 20764 | |12;stanford-crypto-pbkdf2;183;175;183;180;177;180;181;181;172;176 11:19:52 INFO - PID 20764 | |13;stanford-crypto-sha256-iterative;71;71;69;69;69;67;68;67;72;67 11:19:52 INFO - PID 20764 | __end_tp_report 11:19:52 INFO - PID 20764 | __start_cc_report 11:19:52 INFO - PID 20764 | _x_x_mozilla_cycle_collect,971 11:19:52 INFO - PID 20764 | __end_cc_report 11:19:52 INFO - PID 20764 | __startTimestamp1502907592139__endTimestamp 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | ------- Summary: start ------- 11:19:52 INFO - PID 20764 | Number of tests: 14 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#0] ai-astar Cycles:10 Average:106.30 Median:108.50 stddev:4.22 (3.9%) stddev-sans-first:2.83 11:19:52 INFO - PID 20764 | Values: 97.0 108.0 101.0 109.0 110.0 107.0 108.0 105.0 110.0 108.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:144.50 stddev:20.82 (14.4%) stddev-sans-first:21.60 11:19:52 INFO - PID 20764 | Values: 152.0 116.0 139.0 166.0 123.0 145.0 144.0 115.0 175.0 122.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.50 stddev:3.74 (2.3%) stddev-sans-first:3.77 11:19:52 INFO - PID 20764 | Values: 162.0 173.0 166.0 166.0 161.0 162.0 170.0 165.0 164.0 164.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#3] audio-fft Cycles:10 Average:96.10 Median:77.00 stddev:39.79 (51.7%) stddev-sans-first:41.66 11:19:52 INFO - PID 20764 | Values: 78.0 77.0 74.0 172.0 77.0 76.0 78.0 82.0 171.0 76.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:79.00 stddev:26.18 (33.1%) stddev-sans-first:26.97 11:19:52 INFO - PID 20764 | Values: 78.0 83.0 135.0 78.0 80.0 78.0 132.0 80.0 80.0 134.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:117.00 stddev:2.41 (2.1%) stddev-sans-first:2.40 11:19:52 INFO - PID 20764 | Values: 114.0 117.0 117.0 116.0 114.0 117.0 122.0 114.0 115.0 117.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 11:19:52 INFO - PID 20764 | Values: 150.0 150.0 150.0 151.0 152.0 149.0 151.0 149.0 152.0 150.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.07 (1.1%) stddev-sans-first:1.01 11:19:52 INFO - PID 20764 | Values: 93.0 94.0 94.0 95.0 95.0 94.0 97.0 94.0 94.0 94.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:3.55 (6.4%) stddev-sans-first:3.71 11:19:52 INFO - PID 20764 | Values: 54.0 57.0 53.0 54.0 56.0 65.0 55.0 53.0 57.0 54.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#9] json-stringify-tinderbox Cycles:10 Average:55.10 Median:54.00 stddev:2.81 (5.2%) stddev-sans-first:2.87 11:19:52 INFO - PID 20764 | Values: 53.0 55.0 53.0 54.0 54.0 54.0 54.0 54.0 62.0 58.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.50 stddev:1.27 (1.6%) stddev-sans-first:0.97 11:19:52 INFO - PID 20764 | Values: 80.0 77.0 77.0 76.0 77.0 79.0 77.0 76.0 78.0 78.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:128.50 stddev:12.60 (9.8%) stddev-sans-first:13.34 11:19:52 INFO - PID 20764 | Values: 128.0 129.0 123.0 127.0 120.0 120.0 129.0 128.0 132.0 164.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.80 Median:180.50 stddev:3.65 (2.0%) stddev-sans-first:3.54 11:19:52 INFO - PID 20764 | Values: 183.0 175.0 183.0 180.0 177.0 180.0 181.0 181.0 172.0 176.0 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.83 (2.6%) stddev-sans-first:1.79 11:19:52 INFO - PID 20764 | Values: 71.0 71.0 69.0 69.0 69.0 67.0 68.0 67.0 72.0 67.0 11:19:52 INFO - PID 20764 | -------- Summary: end -------- 11:19:52 INFO - PID 20764 | 11:19:52 INFO - PID 20764 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:19:52 INFO - TEST-INFO | 20764: exit 0 11:19:52 INFO - TEST-OK | kraken | took 62660ms 11:19:52 INFO - SUITE-END | took 1175s 11:19:53 INFO - Completed test suite (00:19:36) 11:19:53 INFO - javascript benchmark 11:19:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8675.375300056674, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.0757426559167, 3149.2441813964656, 3159.6366417861936, 3184.952225716613, 3218.82296473694, 6086.604370715901, 6128.988716861712, 6137.079438084284, 6177.505799536038, 6184.257889053314, 6015.789447369343, 6133.969330153343, 6151.261848578177, 6169.043798211284, 6173.691315434233, 5542.224088627595, 5571.916421253684, 5575.749091290892, 5583.078791999315, 5588.385277619459, 5609.8597535061745, 5624.6625202487985, 5624.859378515549, 5680.176374425706, 5702.743376548045, 5606.775728970836, 5677.744501497422, 5690.487856092951, 5734.225879506255, 5761.971190144043, 5592.664440133605, 5629.802956896509, 5655.0386434306265, 5677.261955945742, 5731.111677689923, 5433.1035379162395, 5449.482299181572, 5532.834014979557, 5564.276644036249, 5640.689762063085, 5964.552658550582, 6063.848403789896, 6122.387761223842, 6136.048912418582, 6155.692215389213, 6488.059231411419, 6551.344865513458, 6574.211094668671, 6658.700358483879, 6661.400473957318, 6631.27056023837, 6645.734170633169, 6676.0, 6688.799336019927, 6689.531732778707, 6167.444929956326, 6184.103305020792, 6237.75048998035, 6264.5301602380005, 6267.5299352548745, 6802.727890884309, 6822.897656535156, 6898.517103802786, 6909.689063992132, 6931.896021559681, 6294.0558916162945, 6391.42477177047, 6459.806205813833, 6511.772087976898, 6602.6698665067515, 6624.668766561653, 6653.367930046637, 6674.998750187414, 6683.6658167091455, 6708.027336036345, 6590.9670451647435, 6605.108310378134, 6648.0, 6678.3989440950545, 6708.496862735315, 6632.8673426531195, 6643.40209381158, 6719.126513553207, 6721.193456785119, 6731.225909020427, 5288.92066619001, 5378.838634840961, 5385.003774301688, 5455.345358556999, 5457.781688732485, 4666.8133274668635, 4690.390249267573, 4699.154152252559, 4706.811727530929, 4728.05438912219, 5625.971870140623, 5642.153676948491, 5691.402402747734, 5866.149408335853, 5875.471207591338, 6576.76981305652, 6597.50518711089, 6600.735970561123, 6602.2407423146, 6603.966980165068, 5716.828495145152, 5738.770449181986, 5742.7415766290615, 5747.942520574741, 5748.051571490741, 5750.654960702372, 5808.07070868659, 5880.852978675482, 5919.082542205965, 5950.19672344228, 6387.457066149336, 6393.808185754435, 6448.774292899726, 6470.611763294218, 6548.148740663683, 6429.003504456817, 6586.967065164644, 6676.432503237085, 6679.098321726699, 6726.091977583062, 6369.49044076482, 6392.968035159794, 6396.392342727433, 6405.2313722351755, 6406.583572067801, 5393.379761327341, 6446.613203207822, 6451.6774161290805, 6454.031895215755, 6454.67726613658, 6668.233153187445, 6675.666216689243, 6773.322667733188, 6776.051352810512, 6795.966020169867, 6388.9041664376, 6438.130852334875, 6473.8705225896165, 6480.708368123352, 6514.771982980573, 6247.843803904757, 6356.300806911328, 6419.069234960998, 6496.317886622026, 6508.479321654161, 6335.271443784024, 6366.554341196257, 6384.138141351044, 6406.775762848278, 6412.35876412355, 6473.579217350857, 6512.446442052478, 6583.374579414948, 6610.6694665267505, 6617.470602351897, 6294.8111556653375, 6324.810255692337, 6329.5569310149685, 6400.775972840928, 6437.163168788027], "value": 6040.543764543529, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [793.6666600027992, 844.5144042175749, 872.8908886389199, 873.1050673060113, 1160.5415860735004, 31856.36287274253, 32397.352052958955, 38750.99999999996, 43122.13755724884, 43210.0, 42885.35671964915, 43085.569144308545, 43203.78398108013, 43242.135157296834, 43367.566324336745, 7156.85686286274, 7558.319751222402, 7695.461317707734, 7730.613469326539, 7733.883991740128, 7536.284053014982, 7638.732644357448, 7643.923560764405, 7648.770536883874, 7651.617419129049, 7642.235776422341, 7684.884726729104, 7696.692132314729, 7697.2302769722855, 7700.075990881074, 7554.244575542457, 7608.391328693691, 7611.2388761124, 7654.196309387517, 7671.654775535114, 7530.359919406857, 7596.088469383654, 7624.771256862303, 7636.045494313211, 7636.732714354971, 38600.0, 38601.227975440335, 38699.61300386988, 38717.80641096805, 38899.416508752394, 3563.8574457021687, 3596.352656521825, 3600.513930619359, 3603.0992251937014, 3604.4232922732235, 31347.37305253905, 31378.843105784326, 31461.213469663213, 31489.21276968071, 31554.842225788954, 5070.214116811863, 5077.543021128079, 5082.1360368737405, 5109.259157422191, 5131.794728210867, 194076.0, 194629.0, 194858.0, 195002.02498987556, 195668.0, 48688.0, 49027.26459103116, 49206.75396623066, 49396.0, 49532.50467495279, 50739.0, 50748.74625626922, 50876.0, 50949.490505095215, 51048.744756275984, 16744.58138546522, 16925.322987080624, 16966.406175784035, 16972.83027169737, 16986.575335616708, 10790.78418431627, 10947.56209751601, 13938.790918136236, 14105.506307279196, 14123.081999670194, 14380.85619143816, 14381.352839122264, 14390.352434140488, 14475.0, 14581.0, 5652.74562644682, 5713.5714821388565, 5726.77092916287, 5795.594308398456, 5804.506616937523, 1000.0999100809184, 1012.104287705386, 1012.4532752313668, 1024.538957469127, 1031.582209205273, 22762.886185568965, 23324.067037318655, 23551.764482354956, 23641.527169456516, 23796.52406951886, 1115.1580556679817, 1122.4443900269418, 1126.7464820415505, 1132.6035887439496, 1145.873953865074, 12195.695107622381, 12257.325847078318, 12351.567695130807, 12446.626601201979, 12516.49934002648, 234648.0, 235232.0, 235271.0, 235718.0, 236181.0, 54102.0, 54106.0, 54225.45774542204, 54566.0, 54660.72669636706, 1422.5803388000566, 1425.5723283015054, 1444.4366696988184, 1450.8113945187058, 1456.0171883978273, 22490.66264006074, 22552.661710074033, 22577.322680319616, 22702.432439189153, 22780.088796447955, 38316.42525362066, 38346.80826595849, 38431.80784096062, 38437.23125537418, 38456.423153653275, 197348.0, 197917.0, 198026.0, 198244.0, 199058.0, 33872.0, 36135.45796812997, 36876.26247474982, 36891.63108368989, 36999.445008325434, 47116.0, 47758.76120619375, 47876.28185577149, 47919.5208047929, 48040.75979620079, 33471.66528334783, 33809.66190338065, 33918.66081339155, 34204.0, 34325.0, 33241.667583323855, 33604.32791344208, 33706.3258734819, 33737.83131084329, 34271.65728342784, 35782.105447364025, 37247.0, 37356.0, 37380.81309593435, 37500.06249843776, 32759.34481310313, 33018.504722428705, 33100.0, 33566.32867342591, 33686.326273473904, 24029.27912162638, 24058.75941240635, 24541.38646533851, 24892.37769055788, 24915.0], "value": 17410.775476050723, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.9830505084849, 564.9999999999998, 580.2485780913717, 580.2775544447163, 585.221655198586, 22049.33851984439, 22550.097996080138, 23195.884020579895, 23225.535489290203, 23262.069517219334, 27743.44513109742, 27873.442531149365, 27972.0, 27978.0, 27986.860065699642, 6962.199347075088, 7077.823054423655, 7115.181754098293, 7120.572765634079, 7125.216226215112, 6460.321666225026, 6911.861762764742, 7045.048918396028, 7065.6113913734725, 7072.0, 7042.260562640926, 7053.682584283694, 7054.3651071403565, 7059.9647001764915, 7060.29397060295, 7052.506324557257, 7052.858942821166, 7054.894176587355, 7055.188653304885, 7057.717691292342, 6917.100776899021, 6924.4114250288785, 6932.306769323078, 6939.548929319578, 6961.338672826073, 30244.243893902607, 31076.533851992237, 31482.842585787155, 31602.0, 31617.0, 1972.980270197294, 2006.3278801601482, 2011.8390528757664, 2014.7582290125279, 2014.8992550372423, 20452.181912723474, 21027.26404575848, 21070.0, 21373.145074197015, 21383.144674213014, 2398.424378149249, 2425.987870060656, 2536.606825941982, 2537.378342306128, 2556.2842404126873, 140452.0, 143100.28449857788, 143460.99999999895, 143477.0, 143947.0, 19895.801041989394, 21269.78730212709, 21634.459138521663, 21654.675179872316, 22900.31299061031, 44753.32870006953, 44756.77621611936, 44790.55209447864, 44875.0, 44993.325100123526, 10900.618478353219, 11039.503222355013, 11075.0, 11110.166737494721, 11305.49125289364, 7873.842523149505, 9126.45241285525, 9149.313801464918, 9232.753578266982, 9383.108604682544, 10215.642452514126, 10829.83755243672, 11394.0, 11542.307461552333, 12239.265644061385, 3906.99161645537, 4065.390191471303, 4088.9591104089172, 4127.772972486542, 4451.666125040635, 964.0744884910424, 985.1281615770096, 987.7777500062429, 1009.2027298434301, 1009.5406590001531, 19710.40868773939, 19984.50038749043, 20201.090950907244, 20556.794432055787, 20942.47643808917, 1046.4558429616557, 1066.4987455895716, 1069.0378659206776, 1076.6931424543968, 1087.836824476319, 11070.667879963614, 11195.4962026709, 11219.270747401393, 11324.0, 11517.884821151849, 491538.0, 498442.0, 503164.0, 503733.0, 512626.0, 110940.0, 112847.0, 114519.0, 116258.41870790592, 116908.41545792216, 1212.8532744563206, 1216.689744115245, 1242.8881400673984, 1242.9564965226173, 1253.141598005351, 17445.214965326337, 17474.563135921704, 17665.116744163, 17866.285348585912, 17931.910340448216, 53475.0, 55047.449525505835, 57258.0, 58506.0, 58652.70673646775, 67602.0, 67678.3232167672, 67912.3208767906, 68265.31734682788, 68648.31351686618, 11925.582604608797, 12545.560905368267, 13129.277889716157, 14835.554933352018, 15210.847891520943, 23904.40238994039, 24109.879450602635, 24271.635925460778, 24298.0, 24497.51004979926, 18414.079296034877, 18895.716564251823, 18941.621167576297, 19027.71458428097, 19139.043047847274, 16816.663666726843, 16931.238094286033, 17240.137993100547, 17475.47573572795, 17753.0, 17808.10959452048, 18024.188911498753, 18125.909370453064, 19190.752601080883, 19403.223871045564, 14712.19082950448, 14968.850311496746, 14982.550523484313, 14993.100413975197, 14997.775033374726, 18313.175907083947, 18339.358122466183, 18587.07064646789, 18599.16303766361, 18624.0], "value": 12845.703070901915, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.1709540085146, 1345.286997891118, 1368.4184221705773, 1373.663452454149, 1413.1097408632563, 14060.929695351522, 14782.113073215614, 14807.407703691853, 14824.925875370634, 14826.925865370658, 12401.317927513983, 12517.561885334015, 12622.431990560424, 14120.43518259271, 14487.855121448782, 2648.907288244912, 2715.8777854996474, 2717.6738791345065, 2719.7960152988603, 2723.0, 2443.511297740459, 2520.9873950630313, 2607.3220962549685, 2650.045983445958, 2685.1139124089004, 2676.51822671919, 2714.687810901742, 2716.1172618898936, 2730.1263595649402, 2749.024096445763, 2561.897524099034, 2609.321576390152, 2648.655674762278, 2651.973480265192, 2667.933301667464, 2545.325488745484, 2566.3199252198183, 2569.8843552040203, 2571.5885458326766, 2595.558755011634, 13955.162690238618, 14071.85928140726, 14109.941754368361, 14118.788218176736, 14151.85848141526, 7480.214577469396, 7652.273034061755, 7782.610869456505, 7784.494007889469, 7792.9220707792765, 4688.460827004904, 4932.975335123338, 5015.673981191211, 5069.315642388267, 5079.085764562377, 1746.903920284384, 1758.6218962922906, 1783.3847322673657, 1791.8476929461012, 1879.981200188008, 24032.759672403226, 24092.638610420858, 24263.63604545933, 24279.514409711883, 24293.0, 6522.15212022434, 6541.34586541342, 6842.692078856463, 6851.1778586568935, 6919.861602767916, 16207.675846483004, 16221.0, 16344.591385215226, 16355.59111022234, 16368.67262654764, 7244.529105608119, 7369.668364923591, 7383.2985866342615, 7396.778096657109, 7420.109586849612, 6700.731970721116, 6898.0687607173395, 7001.36987671112, 7006.439484841302, 7046.330598593126, 5020.397552293748, 5188.766505507261, 5199.1161502544655, 5219.173289348698, 5265.999460102568, 1325.1850112181132, 1377.3595278195687, 1390.242317936727, 1434.8278206615273, 1474.6608280095638, 882.1178821178821, 892.2861710631469, 892.8571428571397, 902.5919565477875, 911.8541033434618, 8269.503829770232, 8610.741677749678, 8648.697295594624, 8722.476651400937, 8794.208521232991, 974.6345120579782, 976.0434773921596, 980.1227901028682, 992.3004281981185, 998.236349192868, 5076.771545280398, 5360.678359298455, 5383.246345511631, 5387.380451248078, 5406.594505412031, 19534.413967580997, 19735.111919963638, 20390.388288351372, 20401.795982040287, 20446.591068178554, 19977.0, 19989.500262493264, 19991.800081998994, 20043.29848455297, 20105.19579216815, 9905.81130264373, 10311.639092631873, 10551.366917984946, 10654.0, 10663.946680266705, 8399.70601028961, 8460.280876125353, 8662.220400164015, 8682.652693892174, 8802.38383313162, 17505.21226544783, 17929.910350448165, 17939.641207175522, 18073.909630451762, 18273.3604323848, 17847.46457606274, 18237.179326930585, 18321.908390457964, 18391.264349425874, 18481.815181848546, 11040.779184416106, 11329.69708483535, 11517.424128793695, 11574.0, 11574.88425115738, 13448.260345681081, 13467.191968481922, 13494.055416120776, 13508.39212235432, 13525.0, 10817.837732433862, 10866.836997445203, 10888.61889833852, 10978.615748448767, 11100.61147859821, 10873.945630272114, 10932.234743567873, 11047.889521104686, 11141.498632561392, 11275.0, 9759.75600609962, 9836.163926066365, 9919.950400247953, 9949.801003980025, 9952.950235248778, 6988.545744526589, 7083.82290442743, 7100.7573674607775, 7123.180834204133, 7137.2149063604, 7350.632468376667, 7363.595002274927, 7402.29678180572, 7404.740834070782, 7465.776026719207], "value": 6461.384250707072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [476.92846073089055, 501.9102920961359, 508.9033083714092, 509.9082165210262, 514.4444000479483, 6010.218671572689, 6111.663858487781, 6153.169322141515, 6167.845803854906, 6219.409156130166, 5884.205632239647, 6002.819915402534, 6052.455279024887, 6102.511799056076, 6111.938880611204, 5109.974450127754, 5155.149400348938, 5171.37943446785, 5189.974050129744, 5211.993382547727, 5056.84829455117, 5087.5421212090905, 5100.41345245296, 5153.6392452528335, 5207.765650545734, 5086.237064440345, 5091.261767043777, 5112.446849439641, 5142.537171654551, 5152.0, 5089.160288552384, 5097.0, 5116.846494605149, 5137.460566640505, 5169.407261952944, 4765.714057156547, 4767.356406885061, 4826.166056898392, 4857.465678775332, 4872.3909511311085, 5977.970110149465, 5992.161097446361, 6013.609115407485, 6028.96985515074, 6055.0, 5929.258842644669, 5937.970310148422, 5940.732667029994, 5975.282966044103, 6026.8493287667725, 6404.967975160094, 6432.485401167942, 6441.742330306782, 6449.516286278501, 6480.967595161994, 5271.894562108775, 5306.97346513265, 5351.545118664918, 5353.652012619167, 5360.16917377807, 6928.549644273106, 6934.618595977219, 6940.7917762467205, 7006.369426751566, 7031.929680703128, 5337.492938170868, 5348.893022139536, 5376.548331950352, 5401.756920938567, 5418.376886658085, 5449.972750136224, 5450.209719590716, 5515.117581186991, 5517.062099443105, 5528.917066244009, 5880.852978675567, 5963.5527335450015, 5973.402659733992, 5979.1629171915965, 5988.730507127189, 6506.479481641457, 6523.249826269945, 6553.246376666649, 6574.506911981621, 6585.209774826955, 1783.9474709921208, 1882.8117188281062, 1886.283212379287, 1922.84617230624, 1933.4489670443857, 1403.6069900427897, 1410.4146779086564, 1434.956951291463, 1455.9417623295162, 1456.8834493240515, 5624.746886390122, 5657.811859509467, 5658.74535645897, 5701.0, 5722.141678748221, 6380.776672816429, 6573.441257493071, 6657.20113586363, 6732.326767323327, 6762.729490820312, 5722.828315150552, 5774.162746401748, 5779.162021506858, 5827.213326200908, 5842.152887831241, 3518.4546395308766, 3581.606023337431, 3596.9100772480374, 3599.4240921452965, 3602.1354874829854, 6624.304448032887, 6625.536212465177, 6639.302873198341, 6651.401373876278, 6663.833404164935, 6909.689063992132, 6924.757633482804, 6941.305869413019, 6949.30506949301, 6979.742357162127, 6530.379613936669, 6602.702878370389, 6603.405693487609, 6614.966925165343, 6622.96688516564, 6679.432248258952, 6718.656268746368, 6726.159230096238, 6748.73005079811, 6779.423748981392, 6568.21181458209, 6650.769607622606, 6668.433183179484, 6699.631520266432, 6714.328567143247, 6500.219973603198, 6505.786973440258, 6553.705083271359, 6555.3772391622715, 6565.638889861103, 4873.220284754422, 4876.2932973459, 4898.53463920927, 4921.753912304442, 4932.679375840559, 6363.122878750873, 6513.348665133449, 6615.37153970372, 6665.566738162004, 6705.1283333166375, 5996.910046349395, 6324.861524925557, 6461.289258181502, 6488.870222595616, 6529.51028672861, 6394.561223724811, 6406.679666016774, 6415.82416703716, 6499.6750162492635, 6522.836929076811, 6360.459360954371, 6375.968120159369, 6427.971524556048, 6439.130717353098, 6442.0, 6428.742850286123, 6438.0, 6458.515611329075, 6531.804045878441, 6538.0, 6267.874642507216, 6268.122462855295, 6309.90535141964, 6368.64972426521, 6425.678716064272], "value": 5141.949608337685, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [863.6631713631684, 882.7307671160294, 889.2352576783965, 892.3575025981294, 900.2707806676592, 19180.040997950116, 20129.899350503245, 20137.798622013775, 20157.99999999998, 20202.19191232349, 17835.64328713425, 17948.10259487027, 18078.638427231446, 22820.08719651212, 22898.427539311524, 1053.2416660004785, 1078.245228340161, 1078.6278733836814, 1078.7087486378712, 1079.023483747206, 981.9607215711363, 1059.348500672089, 1072.447689439939, 1074.2426589254558, 1074.7635520185547, 1106.5131342209402, 1118.949647265875, 1119.1941801902617, 1119.5577746790013, 1124.9493772780204, 1112.7106952192407, 1112.9888701113048, 1113.8217885138379, 1118.2563595209217, 1118.6867677050398, 812.358236992775, 813.3615112137003, 813.8616435206029, 814.1695470619994, 815.4617952151551, 19857.304994325128, 20050.598988020305, 20077.698834517494, 20183.39449816508, 20945.685814712793, 20145.294914677917, 20819.479513012146, 21952.670709939364, 22239.55520889573, 22296.0, 17201.569960750956, 17271.56821079483, 18953.052347382574, 20068.598628027357, 20109.39671809848, 3630.3465376232266, 3661.487391765155, 3688.5942546319884, 3692.4276737105793, 3700.5929347771726, 132456.3377183108, 132587.0, 133799.33100334535, 135083.32458337743, 136254.31872840572, 16967.236474358684, 17438.0, 17916.10419479021, 17963.550911227063, 17992.640147196984, 31353.0, 31493.212669683442, 31996.520052199237, 32086.518702219484, 32092.03723888287, 8625.525596092275, 8724.781880452912, 8865.024847266925, 8892.555372231363, 8919.643214271486, 4017.4777278954134, 4041.939370909439, 4097.959020409818, 4102.384642303678, 4126.154138401621, 5332.466753324714, 5351.678899266057, 5367.490088441592, 5423.18652202165, 5423.240746295522, 1030.283952652899, 1054.130342467452, 1055.9894401055892, 1056.1339701444895, 1059.1950117910444, 630.5901164243279, 631.955763096588, 632.6330728177646, 637.1144109687538, 651.8337823854887, 11569.479373428216, 12450.688732781753, 12527.93736031314, 13130.080894337496, 13188.47246110164, 682.9829254268683, 686.8557602903346, 691.7405972760215, 696.9651517424109, 700.8948657701386, 5734.971325143431, 5928.229330187048, 5957.344692083867, 6125.295591007002, 6234.314225435199, 110686.44656776664, 110895.0, 113084.0, 113492.0, 115663.0, 99076.0, 99706.0, 99929.50035249922, 102264.0, 104074.4796276029, 88295.11704882869, 88531.0, 89111.0, 90272.48637568226, 90724.54637726901, 12462.626121216377, 12668.66978967232, 12756.808647870104, 12903.06533613217, 13074.346282686018, 39226.0, 40500.79749601233, 40548.1890362197, 41401.585984139776, 42053.57946420619, 73538.63230683812, 74358.62820685862, 76895.61552192204, 78461.46923388576, 79766.60116699379, 17941.910290448464, 19144.904275478533, 20051.799482004993, 20078.799212007692, 20129.496762581053, 21580.0, 22179.889100554396, 22196.334109976728, 22208.888955555118, 22588.435289117904, 19706.90146549258, 20199.8990005049, 20217.29239476611, 20275.493112672302, 20507.077181527166, 19030.143643535797, 19533.413997580094, 19844.50388740293, 20217.89891050535, 20663.276785312442, 15145.469908553148, 15211.467598633995, 15338.463153789564, 18586.25654973786, 19648.329891958772, 13219.339033048502, 13965.720685586028, 14333.211673357648, 14616.66491730532, 14635.780463293273, 14760.409583616965, 14784.677516093983, 15245.390184392943, 15342.23288835576, 15697.450589229778], "value": 9497.220754368675, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 108.0, 101.0, 109.0, 110.0, 107.0, 108.0, 105.0, 110.0, 108.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 116.0, 139.0, 166.0, 123.0, 145.0, 144.0, 115.0, 175.0, 122.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 173.0, 166.0, 166.0, 161.0, 162.0, 170.0, 165.0, 164.0, 164.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 74.0, 172.0, 77.0, 76.0, 78.0, 82.0, 171.0, 76.0], "value": 96.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 135.0, 78.0, 80.0, 78.0, 132.0, 80.0, 80.0, 134.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 117.0, 116.0, 114.0, 117.0, 122.0, 114.0, 115.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 152.0, 149.0, 151.0, 149.0, 152.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 95.0, 95.0, 94.0, 97.0, 94.0, 94.0, 94.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 53.0, 54.0, 56.0, 65.0, 55.0, 53.0, 57.0, 54.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 62.0, 58.0], "value": 55.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 77.0, 76.0, 77.0, 79.0, 77.0, 76.0, 78.0, 78.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 129.0, 123.0, 127.0, 120.0, 120.0, 129.0, 128.0, 132.0, 164.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 175.0, 183.0, 180.0, 177.0, 180.0, 181.0, 181.0, 172.0, 176.0], "value": 178.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 69.0, 69.0, 69.0, 67.0, 68.0, 67.0, 72.0, 67.0], "value": 69.0, "unit": "score"}]}]} 11:19:53 INFO - Return code: 0 11:19:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:19:53 INFO - # TBPL SUCCESS # 11:19:53 INFO - Running post-action listener: _package_coverage_data 11:19:53 INFO - Running post-action listener: _resource_record_post_action 11:19:53 INFO - [mozharness: 2017-08-16 18:19:53.407650Z] Finished run-tests step (success) 11:19:53 INFO - Running post-run listener: _resource_record_post_run 11:19:53 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 12288; Write bytes: 440131584; Read time: 272; Write time: 321756 11:19:53 INFO - TinderboxPrint: CPU usage
13.1% 11:19:53 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 272 11:19:53 INFO - TinderboxPrint: I/O write bytes / time
440,131,584 / 321,756 11:19:53 INFO - TinderboxPrint: CPU idle
8,267.6 (86.8%) 11:19:53 INFO - TinderboxPrint: CPU user
1,200.7 (12.6%) 11:19:53 INFO - TinderboxPrint: Swap in / out
0 / 0 11:19:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 115130368; Read time: 88; Write time: 88364 11:19:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:19:53 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 324575232; Read time: 172; Write time: 233352 11:19:54 INFO - Running post-run listener: _upload_blobber_files 11:19:54 INFO - Blob upload gear active. 11:19:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:19:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:19:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:19:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:19:54 INFO - (blobuploader) - INFO - Open directory for files ... 11:19:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:19:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:19:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:19:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:19:55 INFO - (blobuploader) - INFO - Done attempting. 11:19:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:19:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:19:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:20:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:01 INFO - (blobuploader) - INFO - Done attempting. 11:20:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:20:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:20:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:02 INFO - (blobuploader) - INFO - Done attempting. 11:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:20:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:20:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:20:03 INFO - (blobuploader) - INFO - Done attempting. 11:20:03 INFO - (blobuploader) - INFO - Iteration through files over. 11:20:03 INFO - Return code: 0 11:20:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:20:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:20:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/239a0a164db435a5bb501671901fdf6c6e0f46abf9524fe395a2c70a3169142c247d63868035fe4fd762dbaf361b78209b9e5687a0026b0134c68782dacc9a09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3ff4e266688284438f0ee74dbbe245ec944c098b44ff24db37412ccbd3cbf7e38c66f100b5c8d226a84d4b684dc58c03f77451c5e5660827273f385843af073", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/594ceaeda31624b7270b492155fb338c7fa342e7f7b858765c99e8895349fa7828355ea58b161091b994119516c04bf38c2d2ebf023d346b0482d6713012570d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bdb0d5f0e1abd6edb744e5ce2bf1bc00443c3d4bd73e594d3ad0517d5f247dd76e3d312d5a9fde64d7b05ae2a522785ea39dd0607dfa202589d07c4aeb390bf"} 11:20:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:20:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:20:03 INFO - Contents: 11:20:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/239a0a164db435a5bb501671901fdf6c6e0f46abf9524fe395a2c70a3169142c247d63868035fe4fd762dbaf361b78209b9e5687a0026b0134c68782dacc9a09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3ff4e266688284438f0ee74dbbe245ec944c098b44ff24db37412ccbd3cbf7e38c66f100b5c8d226a84d4b684dc58c03f77451c5e5660827273f385843af073", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/594ceaeda31624b7270b492155fb338c7fa342e7f7b858765c99e8895349fa7828355ea58b161091b994119516c04bf38c2d2ebf023d346b0482d6713012570d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bdb0d5f0e1abd6edb744e5ce2bf1bc00443c3d4bd73e594d3ad0517d5f247dd76e3d312d5a9fde64d7b05ae2a522785ea39dd0607dfa202589d07c4aeb390bf"} 11:20:03 INFO - Running post-run listener: copy_logs_to_upload_dir 11:20:03 INFO - Copying logs to upload dir... 11:20:03 INFO - mkdir: /builds/slave/test/build/upload/logs 11:20:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.951910 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-16 11:20:03.359539) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 11:20:03.363200) ========= 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=4300f881736b422476174874000001bc-1502906344.671227-876597425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/239a0a164db435a5bb501671901fdf6c6e0f46abf9524fe395a2c70a3169142c247d63868035fe4fd762dbaf361b78209b9e5687a0026b0134c68782dacc9a09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3ff4e266688284438f0ee74dbbe245ec944c098b44ff24db37412ccbd3cbf7e38c66f100b5c8d226a84d4b684dc58c03f77451c5e5660827273f385843af073", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/594ceaeda31624b7270b492155fb338c7fa342e7f7b858765c99e8895349fa7828355ea58b161091b994119516c04bf38c2d2ebf023d346b0482d6713012570d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bdb0d5f0e1abd6edb744e5ce2bf1bc00443c3d4bd73e594d3ad0517d5f247dd76e3d312d5a9fde64d7b05ae2a522785ea39dd0607dfa202589d07c4aeb390bf"} build_url:https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/YbqntiLNQ_uKrat-Wa379w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/239a0a164db435a5bb501671901fdf6c6e0f46abf9524fe395a2c70a3169142c247d63868035fe4fd762dbaf361b78209b9e5687a0026b0134c68782dacc9a09", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3ff4e266688284438f0ee74dbbe245ec944c098b44ff24db37412ccbd3cbf7e38c66f100b5c8d226a84d4b684dc58c03f77451c5e5660827273f385843af073", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/594ceaeda31624b7270b492155fb338c7fa342e7f7b858765c99e8895349fa7828355ea58b161091b994119516c04bf38c2d2ebf023d346b0482d6713012570d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7bdb0d5f0e1abd6edb744e5ce2bf1bc00443c3d4bd73e594d3ad0517d5f247dd76e3d312d5a9fde64d7b05ae2a522785ea39dd0607dfa202589d07c4aeb390bf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 11:20:03.389818) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 11:20:03.390160) ========= 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=4300f881736b422476174874000001bc-1502906344.671227-876597425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 11:20:03.474861) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 11:20:03.475171) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 11:20:03.475454) ========= ========= Total master_lag: 0.17 =========