builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1502760002.82 results: success (0) revision: 92f3de33d97f55d54b2baad585b87e76aaa5ec58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 18:20:02.817747) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 18:20:02.818180) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 18:20:02.818474) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 18:20:02.871684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 18:20:02.871951) ========= 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=00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 18:20:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.2M=0s 2017-08-14 18:20:03 (34.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109042 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 18:20:03.019252) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 18:20:03.019525) ========= 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=00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021280 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 18:20:03.096770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-14 18:20:03.097054) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 92f3de33d97f55d54b2baad585b87e76aaa5ec58 --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 92f3de33d97f55d54b2baad585b87e76aaa5ec58 --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=00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 18:20:03,532 truncating revision to first 12 chars 2017-08-14 18:20:03,532 Setting DEBUG logging. 2017-08-14 18:20:03,532 attempt 1/10 2017-08-14 18:20:03,533 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/92f3de33d97f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 18:20:04,395 unpacking tar archive at: mozilla-central-92f3de33d97f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.186052 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-14 18:20:04.317424) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 18:20:04.317722) ========= script_repo_revision: 92f3de33d97f55d54b2baad585b87e76aaa5ec58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 18:20:04.321173) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 18:20:04.321432) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 18:20:04.339101) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-08-14 18:20:04.339356) ========= /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=00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:20:04 INFO - MultiFileLogger online at 20170814 18:20:04 in /builds/slave/test 18:20:04 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 18:20:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:20:04 INFO - {'append_to_log': False, 18:20:04 INFO - 'base_work_dir': '/builds/slave/test', 18:20:04 INFO - 'blob_upload_branch': 'Firefox', 18:20:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:20:04 INFO - 'branch': 'Firefox', 18:20:04 INFO - 'buildbot_json_path': 'buildprops.json', 18:20:04 INFO - 'code_coverage': False, 18:20:04 INFO - 'config_files': ('talos/linux_config.py',), 18:20:04 INFO - 'default_actions': ('clobber', 18:20:04 INFO - 'read-buildbot-config', 18:20:04 INFO - 'download-and-extract', 18:20:04 INFO - 'populate-webroot', 18:20:04 INFO - 'create-virtualenv', 18:20:04 INFO - 'install', 18:20:04 INFO - 'setup-mitmproxy', 18:20:04 INFO - 'run-tests'), 18:20:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:20:04 INFO - 'disable_ccov_upload': False, 18:20:04 INFO - 'download_minidump_stackwalk': True, 18:20:04 INFO - 'download_symbols': 'ondemand', 18:20:04 INFO - 'enable_stylo': False, 18:20:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:20:04 INFO - 'tooltool.py': '/tools/tooltool.py', 18:20:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:20:04 INFO - '/tools/misc-python/virtualenv.py')}, 18:20:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:20:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:20:04 INFO - 'gecko_profile': False, 18:20:04 INFO - 'gecko_profile_interval': 0, 18:20:04 INFO - 'installer_path': 'installer.exe', 18:20:04 INFO - 'log_level': 'info', 18:20:04 INFO - 'log_name': 'talos', 18:20:04 INFO - 'log_to_console': True, 18:20:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:20:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:20:04 INFO - 'opt_config_files': (), 18:20:04 INFO - 'pip_index': False, 18:20:04 INFO - 'suite': 'dromaeojs-e10s', 18:20:04 INFO - 'system_bits': '32', 18:20:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:20:04 INFO - 'title': 'talos-linux64-ix-016', 18:20:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:20:04 INFO - 'use_talos_json': True, 18:20:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:20:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:20:04 INFO - 'work_dir': 'build'} 18:20:04 INFO - [mozharness: 2017-08-15 01:20:04.866240Z] Running clobber step. 18:20:04 INFO - Running pre-action listener: _resource_record_pre_action 18:20:04 INFO - Running main action method: clobber 18:20:04 INFO - rmtree: /builds/slave/test/build 18:20:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:20:05 INFO - Running post-action listener: _resource_record_post_action 18:20:05 INFO - [mozharness: 2017-08-15 01:20:05.922398Z] Finished clobber step (success) 18:20:05 INFO - [mozharness: 2017-08-15 01:20:05.922500Z] Running read-buildbot-config step. 18:20:05 INFO - Running pre-action listener: _resource_record_pre_action 18:20:05 INFO - Running main action method: read_buildbot_config 18:20:05 INFO - Using buildbot properties: 18:20:05 INFO - { 18:20:05 INFO - "project": "", 18:20:05 INFO - "product": "firefox", 18:20:05 INFO - "who": "kwierso@gmail.com", 18:20:05 INFO - "installer_path": "public/build/target.tar.bz2", 18:20:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:20:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:20:05 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:20:05 INFO - "stage_platform": "linux64-stylosequential", 18:20:05 INFO - "basedir": "/builds/slave/test", 18:20:05 INFO - "buildnumber": 31, 18:20:05 INFO - "platform": "ubuntu64_hw_styloseq", 18:20:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:20:05 INFO - "slavebuilddir": "test", 18:20:05 INFO - "taskId": "DIzTer_mTrmz7ZHkD9SIyA", 18:20:05 INFO - "branch": "mozilla-central", 18:20:05 INFO - "script_repo_revision": "production", 18:20:05 INFO - "revision": "92f3de33d97f55d54b2baad585b87e76aaa5ec58", 18:20:05 INFO - "slavename": "talos-linux64-ix-016", 18:20:05 INFO - "repo_path": "mozilla-central" 18:20:05 INFO - } 18:20:05 INFO - Finding installer, test and symbols from parent task. 18:20:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DIzTer_mTrmz7ZHkD9SIyA'}, attempt #1 18:20:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DIzTer_mTrmz7ZHkD9SIyA'}, attempt #1 18:20:06 INFO - Task dependencies: QxuElLloREiYtzE68JGu4g 18:20:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g'}, attempt #1 18:20:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.tar.bz2 18:20:07 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.test_packages.json 18:20:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.crashreporter-symbols.zip 18:20:07 INFO - Running post-action listener: _resource_record_post_action 18:20:07 INFO - [mozharness: 2017-08-15 01:20:07.339292Z] Finished read-buildbot-config step (success) 18:20:07 INFO - [mozharness: 2017-08-15 01:20:07.339514Z] Running download-and-extract step. 18:20:07 INFO - Running pre-action listener: _resource_record_pre_action 18:20:07 INFO - Running main action method: download_and_extract 18:20:07 INFO - mkdir: /builds/slave/test/build/tests 18:20:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:07 INFO - trying https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.test_packages.json 18:20:07 INFO - Downloading https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:20:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:20:08 INFO - Downloaded 989 bytes. 18:20:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:20:08 INFO - Using the following test package requirements: 18:20:08 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:20:08 INFO - u'common': [u'target.common.tests.zip'], 18:20:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:20:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:20:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:20:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:20:08 INFO - u'mozbase': [u'target.common.tests.zip'], 18:20:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:20:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:20:08 INFO - u'web-platform': [u'target.common.tests.zip', 18:20:08 INFO - u'target.web-platform.tests.tar.gz'], 18:20:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:20:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:20:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.common.tests.zip 18:20:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:20:08 INFO - Fetch https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.common.tests.zip into memory 18:20:15 INFO - Content-Length response header: 54034585 18:20:15 INFO - Bytes received: 54034585 18:20:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:20:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.common.tests.zip 18:20:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:20:26 INFO - Fetch https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.common.tests.zip into memory 18:20:31 INFO - Content-Length response header: 54034585 18:20:31 INFO - Bytes received: 54034585 18:20:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.talos.tests.zip 18:20:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:20:43 INFO - Fetch https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.talos.tests.zip into memory 18:20:44 INFO - Content-Length response header: 14496050 18:20:44 INFO - Bytes received: 14496050 18:20: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')]} 18:20:44 INFO - trying https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.tar.bz2 18:20:44 INFO - Downloading https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:20:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:20:50 INFO - Downloaded 61778025 bytes. 18:20:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.tar.bz2 18:20:50 INFO - mkdir: /builds/slave/test/properties 18:20:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:20:50 INFO - Writing to file /builds/slave/test/properties/build_url 18:20:50 INFO - Contents: 18:20:50 INFO - build_url:https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.tar.bz2 18:20:50 INFO - Running post-action listener: _resource_record_post_action 18:20:50 INFO - Running post-action listener: set_extra_try_arguments 18:20:50 INFO - [mozharness: 2017-08-15 01:20:50.421452Z] Finished download-and-extract step (success) 18:20:50 INFO - [mozharness: 2017-08-15 01:20:50.421682Z] Running populate-webroot step. 18:20:50 INFO - Running pre-action listener: _resource_record_pre_action 18:20:50 INFO - Running main action method: populate_webroot 18:20:50 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:20:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:20:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:20:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:20:50 INFO - 'tests': ['damp', 'tps']}, 18:20:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:20:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:20:50 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:20:50 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:20:50 INFO - 'other-e10s': {'tests': ['a11yr', 18:20:50 INFO - 'ts_paint', 18:20:50 INFO - 'tpaint', 18:20:50 INFO - 'sessionrestore', 18:20:50 INFO - 'sessionrestore_many_windows', 18:20:50 INFO - 'sessionrestore_no_auto_restore', 18:20:50 INFO - 'tabpaint']}, 18:20:50 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:20:50 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:20:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:20:50 INFO - 'tsvgr_opacity', 18:20:50 INFO - 'tart', 18:20:50 INFO - 'tscrollx', 18:20:50 INFO - 'tsvg_static']}, 18:20:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:20:50 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:20:50 INFO - 'talos_options': ['--mitmproxy', 18:20:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:20:50 INFO - '--firstNonBlankPaint'], 18:20:50 INFO - 'tests': ['tp6_google', 18:20:50 INFO - 'tp6_youtube', 18:20:50 INFO - 'tp6_amazon', 18:20:50 INFO - 'tp6_facebook']}, 18:20:50 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:20:50 INFO - 'talos_options': ['--stylo', 18:20:50 INFO - '--mitmproxy', 18:20:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:20:50 INFO - '--firstNonBlankPaint'], 18:20:50 INFO - 'tests': ['tp6_google', 18:20:50 INFO - 'tp6_youtube', 18:20:50 INFO - 'tp6_amazon', 18:20:50 INFO - 'tp6_facebook']}, 18:20:50 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:20:50 INFO - 'talos_options': ['--stylo', 18:20:50 INFO - '--stylo-threads=1', 18:20:50 INFO - '--mitmproxy', 18:20:50 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:20:50 INFO - '--firstNonBlankPaint'], 18:20:50 INFO - 'tests': ['tp6_google', 18:20:50 INFO - 'tp6_youtube', 18:20:50 INFO - 'tp6_amazon', 18:20:50 INFO - 'tp6_facebook']}, 18:20:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:20:50 INFO - 'talos_options': ['--xperf_path', 18:20:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:50 INFO - 'tests': ['tp5n']}}} 18:20:50 INFO - Running post-action listener: _resource_record_post_action 18:20:50 INFO - [mozharness: 2017-08-15 01:20:50.434855Z] Finished populate-webroot step (success) 18:20:50 INFO - [mozharness: 2017-08-15 01:20:50.434945Z] Running create-virtualenv step. 18:20:50 INFO - Running pre-action listener: _resource_record_pre_action 18:20:50 INFO - Running main action method: create_virtualenv 18:20:50 INFO - Creating virtualenv /builds/slave/test/build/venv 18:20:50 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 18:20:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:20:50 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:20:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:20:50 INFO - Using real prefix '/usr' 18:20:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:20:51 INFO - Installing distribute.............................................................................................................................................................................................done. 18:20:53 INFO - Installing pip.................done. 18:20:53 INFO - Return code: 0 18:20:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:20:53 INFO - Reading from file tmpfile_stdout 18:20:53 INFO - Output received: 18:20:53 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) 18:20:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:20:53 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')]} 18:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:53 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')]} 18:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:53 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 0x1c401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fadb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb0f00>, '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 0x1fabba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac050>, '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': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', '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 18:20:53 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 18:20:53 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 18:20:53 INFO - Using env: {'DISPLAY': ':0', 18:20:53 INFO - 'HOME': '/home/cltbld', 18:20:53 INFO - 'LANG': 'en_US.UTF-8', 18:20:53 INFO - 'LANGUAGE': 'en_US:en', 18:20:53 INFO - 'LOGNAME': 'cltbld', 18:20:53 INFO - 'MAIL': '/var/mail/cltbld', 18:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:53 INFO - 'MOZ_NO_REMOTE': '1', 18:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:53 INFO - 'NO_EM_RESTART': '1', 18:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:53 INFO - 'PWD': '/builds/slave/test', 18:20:53 INFO - 'SHELL': '/bin/bash', 18:20:53 INFO - 'SHLVL': '1', 18:20:53 INFO - 'TERM': 'linux', 18:20:53 INFO - 'TMOUT': '86400', 18:20:53 INFO - 'USER': 'cltbld', 18:20:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', 18:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:53 INFO - '_': '/tools/buildbot/bin/python'} 18:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:53 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 18:20:53 INFO - Cleaning up... 18:20:53 INFO - Return code: 0 18:20:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:20:53 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')]} 18:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:53 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')]} 18:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:53 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 0x1c401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fadb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb0f00>, '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 0x1fabba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac050>, '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': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', '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 18:20:53 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 18:20:53 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 18:20:53 INFO - Using env: {'DISPLAY': ':0', 18:20:53 INFO - 'HOME': '/home/cltbld', 18:20:53 INFO - 'LANG': 'en_US.UTF-8', 18:20:53 INFO - 'LANGUAGE': 'en_US:en', 18:20:53 INFO - 'LOGNAME': 'cltbld', 18:20:53 INFO - 'MAIL': '/var/mail/cltbld', 18:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:53 INFO - 'MOZ_NO_REMOTE': '1', 18:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:53 INFO - 'NO_EM_RESTART': '1', 18:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:53 INFO - 'PWD': '/builds/slave/test', 18:20:53 INFO - 'SHELL': '/bin/bash', 18:20:53 INFO - 'SHLVL': '1', 18:20:53 INFO - 'TERM': 'linux', 18:20:53 INFO - 'TMOUT': '86400', 18:20:53 INFO - 'USER': 'cltbld', 18:20:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', 18:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:53 INFO - '_': '/tools/buildbot/bin/python'} 18:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:53 INFO - Downloading/unpacking psutil>=3.1.1 18:20:53 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 18:20:53 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 18:20:53 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 18:20:53 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 18:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:20:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:54 INFO - Installing collected packages: psutil 18:20:54 INFO - Running setup.py install for psutil 18:20:54 INFO - building 'psutil._psutil_linux' extension 18:20:54 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 18:20:55 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 18:20:55 INFO - building 'psutil._psutil_posix' extension 18:20:55 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 18:20:55 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 18:20:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:55 INFO - Successfully installed psutil 18:20:55 INFO - Cleaning up... 18:20:55 INFO - Return code: 0 18:20:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20: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')]} 18:20:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fadb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb0f00>, '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 0x1fabba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac050>, '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': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', '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 18:20:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:20:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:20:55 INFO - Using env: {'DISPLAY': ':0', 18:20:55 INFO - 'HOME': '/home/cltbld', 18:20:55 INFO - 'LANG': 'en_US.UTF-8', 18:20:55 INFO - 'LANGUAGE': 'en_US:en', 18:20:55 INFO - 'LOGNAME': 'cltbld', 18:20:55 INFO - 'MAIL': '/var/mail/cltbld', 18:20:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:55 INFO - 'MOZ_NO_REMOTE': '1', 18:20:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:55 INFO - 'NO_EM_RESTART': '1', 18:20:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:55 INFO - 'PWD': '/builds/slave/test', 18:20:55 INFO - 'SHELL': '/bin/bash', 18:20:55 INFO - 'SHLVL': '1', 18:20:55 INFO - 'TERM': 'linux', 18:20:55 INFO - 'TMOUT': '86400', 18:20:55 INFO - 'USER': 'cltbld', 18:20:55 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', 18:20:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:55 INFO - '_': '/tools/buildbot/bin/python'} 18:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:20: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 18:20: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 18:20: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 18:20: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 18:20:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:20:56 INFO - Installing collected packages: mozsystemmonitor 18:20:56 INFO - Running setup.py install for mozsystemmonitor 18:20:56 INFO - Successfully installed mozsystemmonitor 18:20:56 INFO - Cleaning up... 18:20:56 INFO - Return code: 0 18:20:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:20:56 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')]} 18:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:56 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')]} 18:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:56 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 0x1c401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fadb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb0f00>, '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 0x1fabba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac050>, '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': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', '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 18:20:56 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 18:20:56 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 18:20:56 INFO - Using env: {'DISPLAY': ':0', 18:20:56 INFO - 'HOME': '/home/cltbld', 18:20:56 INFO - 'LANG': 'en_US.UTF-8', 18:20:56 INFO - 'LANGUAGE': 'en_US:en', 18:20:56 INFO - 'LOGNAME': 'cltbld', 18:20:56 INFO - 'MAIL': '/var/mail/cltbld', 18:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:56 INFO - 'MOZ_NO_REMOTE': '1', 18:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:56 INFO - 'NO_EM_RESTART': '1', 18:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:56 INFO - 'PWD': '/builds/slave/test', 18:20:56 INFO - 'SHELL': '/bin/bash', 18:20:56 INFO - 'SHLVL': '1', 18:20:56 INFO - 'TERM': 'linux', 18:20:56 INFO - 'TMOUT': '86400', 18:20:56 INFO - 'USER': 'cltbld', 18:20:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', 18:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:56 INFO - '_': '/tools/buildbot/bin/python'} 18:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:57 INFO - Downloading/unpacking jsonschema==2.5.1 18:20:57 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 18:20:57 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 18:20:57 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 18:20:57 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 18:20:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:20:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:58 INFO - Downloading functools32-3.2.3-2.tar.gz 18:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:20:58 INFO - warning: no files found matching '*.txt' 18:20:58 INFO - no previously-included directories found matching 'build' 18:20:58 INFO - no previously-included directories found matching 'dist' 18:20:58 INFO - no previously-included directories found matching '.git*' 18:20:58 INFO - Installing collected packages: jsonschema, functools32 18:20:58 INFO - Running setup.py install for functools32 18:20:58 INFO - warning: no files found matching '*.txt' 18:20:58 INFO - no previously-included directories found matching 'build' 18:20:58 INFO - no previously-included directories found matching 'dist' 18:20:58 INFO - no previously-included directories found matching '.git*' 18:20:58 INFO - Successfully installed jsonschema functools32 18:20:58 INFO - Cleaning up... 18:20:58 INFO - Return code: 0 18:20:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20: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')]} 18:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20: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', '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 0x1c401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fadb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb0f00>, '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 0x1fabba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac050>, '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': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', '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 18:20: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:20: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 functools32==3.2.3-2 18:20:58 INFO - Using env: {'DISPLAY': ':0', 18:20:58 INFO - 'HOME': '/home/cltbld', 18:20:58 INFO - 'LANG': 'en_US.UTF-8', 18:20:58 INFO - 'LANGUAGE': 'en_US:en', 18:20:58 INFO - 'LOGNAME': 'cltbld', 18:20:58 INFO - 'MAIL': '/var/mail/cltbld', 18:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:58 INFO - 'MOZ_NO_REMOTE': '1', 18:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:58 INFO - 'NO_EM_RESTART': '1', 18:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:58 INFO - 'PWD': '/builds/slave/test', 18:20:58 INFO - 'SHELL': '/bin/bash', 18:20:58 INFO - 'SHLVL': '1', 18:20:58 INFO - 'TERM': 'linux', 18:20:58 INFO - 'TMOUT': '86400', 18:20:58 INFO - 'USER': 'cltbld', 18:20:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', 18:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:58 INFO - '_': '/tools/buildbot/bin/python'} 18:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:20:58 INFO - Cleaning up... 18:20:58 INFO - Return code: 0 18:20:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20: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')]} 18:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20: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', '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 0x1c401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fadb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb0f00>, '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 0x1fabba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac050>, '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': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', '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 18:20: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:20: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 blobuploader==1.2.4 18:20:58 INFO - Using env: {'DISPLAY': ':0', 18:20:58 INFO - 'HOME': '/home/cltbld', 18:20:58 INFO - 'LANG': 'en_US.UTF-8', 18:20:58 INFO - 'LANGUAGE': 'en_US:en', 18:20:58 INFO - 'LOGNAME': 'cltbld', 18:20:58 INFO - 'MAIL': '/var/mail/cltbld', 18:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:58 INFO - 'MOZ_NO_REMOTE': '1', 18:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:58 INFO - 'NO_EM_RESTART': '1', 18:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:58 INFO - 'PWD': '/builds/slave/test', 18:20:58 INFO - 'SHELL': '/bin/bash', 18:20:58 INFO - 'SHLVL': '1', 18:20:58 INFO - 'TERM': 'linux', 18:20:58 INFO - 'TMOUT': '86400', 18:20:58 INFO - 'USER': 'cltbld', 18:20:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', 18:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:58 INFO - '_': '/tools/buildbot/bin/python'} 18:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:58 INFO - Downloading/unpacking blobuploader==1.2.4 18:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:00 INFO - Downloading blobuploader-1.2.4.tar.gz 18:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:21:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:21:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:21:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:21:00 INFO - Downloading docopt-0.6.1.tar.gz 18:21:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:21:00 INFO - Installing collected packages: blobuploader, requests, docopt 18:21:00 INFO - Running setup.py install for blobuploader 18:21:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:21:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:21:00 INFO - Running setup.py install for requests 18:21:01 INFO - Running setup.py install for docopt 18:21:01 INFO - Successfully installed blobuploader requests docopt 18:21:01 INFO - Cleaning up... 18:21:01 INFO - Return code: 0 18:21:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:01 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 0x1c401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fadb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb0f00>, '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 0x1fabba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac050>, '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': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', '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 18:21:01 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 18:21:01 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 18:21:01 INFO - Using env: {'DISPLAY': ':0', 18:21:01 INFO - 'HOME': '/home/cltbld', 18:21:01 INFO - 'LANG': 'en_US.UTF-8', 18:21:01 INFO - 'LANGUAGE': 'en_US:en', 18:21:01 INFO - 'LOGNAME': 'cltbld', 18:21:01 INFO - 'MAIL': '/var/mail/cltbld', 18:21:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:01 INFO - 'MOZ_NO_REMOTE': '1', 18:21:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:01 INFO - 'NO_EM_RESTART': '1', 18:21:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:01 INFO - 'PWD': '/builds/slave/test', 18:21:01 INFO - 'SHELL': '/bin/bash', 18:21:01 INFO - 'SHLVL': '1', 18:21:01 INFO - 'TERM': 'linux', 18:21:01 INFO - 'TMOUT': '86400', 18:21:01 INFO - 'USER': 'cltbld', 18:21:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', 18:21:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:01 INFO - '_': '/tools/buildbot/bin/python'} 18:21:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:01 INFO - Running setup.py (path:/tmp/pip-b6iBl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:01 INFO - Running setup.py (path:/tmp/pip-Mk9ltP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:01 INFO - Running setup.py (path:/tmp/pip-pcesL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:01 INFO - Running setup.py (path:/tmp/pip-rMY6Nf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:01 INFO - Running setup.py (path:/tmp/pip-eDym9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:01 INFO - Running setup.py (path:/tmp/pip-6_H0BR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:01 INFO - Running setup.py (path:/tmp/pip-QU18Ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:01 INFO - Running setup.py (path:/tmp/pip-bXe8n6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:02 INFO - Running setup.py (path:/tmp/pip-LknTI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:02 INFO - Running setup.py (path:/tmp/pip-14Pf9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:02 INFO - Running setup.py (path:/tmp/pip-v_XB_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:02 INFO - Running setup.py (path:/tmp/pip-7AerVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:02 INFO - Running setup.py (path:/tmp/pip-4XKI4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:02 INFO - Running setup.py (path:/tmp/pip-puWj7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:02 INFO - Running setup.py (path:/tmp/pip-K9Z9FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:02 INFO - Running setup.py (path:/tmp/pip-fnm87N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:02 INFO - Running setup.py (path:/tmp/pip-VqfwS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:21:02 INFO - Running setup.py install for manifestparser 18:21:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:21:02 INFO - Running setup.py install for mozcrash 18:21:02 INFO - Running setup.py install for mozdebug 18:21:02 INFO - Running setup.py install for mozdevice 18:21:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:21:03 INFO - Running setup.py install for mozfile 18:21:03 INFO - Running setup.py install for mozhttpd 18:21:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:21:03 INFO - Running setup.py install for mozinfo 18:21:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:21:03 INFO - Running setup.py install for mozInstall 18:21:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:21:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:21:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:21:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:21:03 INFO - Running setup.py install for mozleak 18:21:03 INFO - Running setup.py install for mozlog 18:21:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:21:03 INFO - Running setup.py install for moznetwork 18:21:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:21:03 INFO - Running setup.py install for mozprocess 18:21:03 INFO - Running setup.py install for mozprofile 18:21:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:21:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:21:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:21:04 INFO - Running setup.py install for mozrunner 18:21:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:21:04 INFO - Running setup.py install for mozscreenshot 18:21:04 INFO - Running setup.py install for moztest 18:21:04 INFO - Running setup.py install for mozversion 18:21:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:21:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:21:04 INFO - Cleaning up... 18:21:04 INFO - Return code: 0 18:21:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:04 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 0x1c401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fadb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb0f00>, '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 0x1fabba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac050>, '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': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', '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 18:21:04 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 18:21:04 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 18:21:04 INFO - Using env: {'DISPLAY': ':0', 18:21:04 INFO - 'HOME': '/home/cltbld', 18:21:04 INFO - 'LANG': 'en_US.UTF-8', 18:21:04 INFO - 'LANGUAGE': 'en_US:en', 18:21:04 INFO - 'LOGNAME': 'cltbld', 18:21:04 INFO - 'MAIL': '/var/mail/cltbld', 18:21:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:04 INFO - 'MOZ_NO_REMOTE': '1', 18:21:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:04 INFO - 'NO_EM_RESTART': '1', 18:21:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:04 INFO - 'PWD': '/builds/slave/test', 18:21:04 INFO - 'SHELL': '/bin/bash', 18:21:04 INFO - 'SHLVL': '1', 18:21:04 INFO - 'TERM': 'linux', 18:21:04 INFO - 'TMOUT': '86400', 18:21:04 INFO - 'USER': 'cltbld', 18:21:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', 18:21:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:04 INFO - '_': '/tools/buildbot/bin/python'} 18:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:21:04 INFO - Running setup.py (path:/tmp/pip-GDawHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:21:04 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)) 18:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:21:04 INFO - Running setup.py (path:/tmp/pip-2eH7_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:21:04 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)) 18:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:21:04 INFO - Running setup.py (path:/tmp/pip-jbneTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:21:04 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)) 18:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:21:04 INFO - Running setup.py (path:/tmp/pip-tuM2PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:21:04 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)) 18:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:21:04 INFO - Running setup.py (path:/tmp/pip-PK_VKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:21:05 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)) 18:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:21:05 INFO - Running setup.py (path:/tmp/pip-Y4uNV7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:21:05 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)) 18:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:21:05 INFO - Running setup.py (path:/tmp/pip-AZucSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:21:05 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)) 18:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:21:05 INFO - Running setup.py (path:/tmp/pip-cRMBlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:21:05 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)) 18:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:21:05 INFO - Running setup.py (path:/tmp/pip-vs0arT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:21:05 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)) 18:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:21:05 INFO - Running setup.py (path:/tmp/pip-H56Nu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:21:05 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)) 18:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:21:05 INFO - Running setup.py (path:/tmp/pip-EgoC90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:21:05 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)) 18:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:21:05 INFO - Running setup.py (path:/tmp/pip-oxS636-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:21:05 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)) 18:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:21:05 INFO - Running setup.py (path:/tmp/pip-eBGKLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:21:05 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)) 18:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:21:05 INFO - Running setup.py (path:/tmp/pip-kavKYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:21:05 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)) 18:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:05 INFO - Running setup.py (path:/tmp/pip-nYJiE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:21:05 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)) 18:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:21:05 INFO - Running setup.py (path:/tmp/pip-yPeJzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:21:05 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)) 18:21:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:21:05 INFO - Running setup.py (path:/tmp/pip-UUbHfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:21:05 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)) 18:21:05 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)) 18:21:05 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)) 18:21:05 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)) 18:21:05 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)) 18:21:05 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)) 18:21:05 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)) 18:21:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:21:05 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 18:21:05 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 18:21:05 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 18:21:05 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 18:21:07 INFO - Downloading blessings-1.6.tar.gz 18:21:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:21:07 INFO - Installing collected packages: blessings 18:21:07 INFO - Running setup.py install for blessings 18:21:07 INFO - Successfully installed blessings 18:21:07 INFO - Cleaning up... 18:21:07 INFO - Return code: 0 18:21:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:21:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:07 INFO - Reading from file tmpfile_stdout 18:21:07 INFO - Current package versions: 18:21:07 INFO - argparse == 1.2.1 18:21:07 INFO - blessings == 1.6 18:21:07 INFO - blobuploader == 1.2.4 18:21:07 INFO - docopt == 0.6.1 18:21:07 INFO - functools32 == 3.2.3-2 18:21:07 INFO - jsonschema == 2.5.1 18:21:07 INFO - manifestparser == 1.1 18:21:07 INFO - mozInstall == 1.13 18:21:07 INFO - mozcrash == 1.0 18:21:07 INFO - mozdebug == 0.1 18:21:07 INFO - mozdevice == 0.51 18:21:07 INFO - mozfile == 1.2 18:21:07 INFO - mozhttpd == 0.7 18:21:07 INFO - mozinfo == 0.10 18:21:07 INFO - mozleak == 0.1 18:21:07 INFO - mozlog == 3.5 18:21:07 INFO - moznetwork == 0.27 18:21:07 INFO - mozprocess == 0.25 18:21:07 INFO - mozprofile == 0.28 18:21:07 INFO - mozrunner == 6.13 18:21:07 INFO - mozscreenshot == 0.1 18:21:07 INFO - mozsystemmonitor == 0.3 18:21:07 INFO - moztest == 0.8 18:21:07 INFO - mozversion == 1.4 18:21:07 INFO - psutil == 3.1.1 18:21:07 INFO - requests == 1.2.3 18:21:07 INFO - wsgiref == 0.1.2 18:21:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:07 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 0x1c401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fadb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb0f00>, '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 0x1fabba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac050>, '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': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', '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 18:21:07 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 18:21:07 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 18:21:07 INFO - Using env: {'DISPLAY': ':0', 18:21:07 INFO - 'HOME': '/home/cltbld', 18:21:07 INFO - 'LANG': 'en_US.UTF-8', 18:21:07 INFO - 'LANGUAGE': 'en_US:en', 18:21:07 INFO - 'LOGNAME': 'cltbld', 18:21:07 INFO - 'MAIL': '/var/mail/cltbld', 18:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:07 INFO - 'MOZ_NO_REMOTE': '1', 18:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:07 INFO - 'NO_EM_RESTART': '1', 18:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:07 INFO - 'PWD': '/builds/slave/test', 18:21:07 INFO - 'SHELL': '/bin/bash', 18:21:07 INFO - 'SHLVL': '1', 18:21:07 INFO - 'TERM': 'linux', 18:21:07 INFO - 'TMOUT': '86400', 18:21:07 INFO - 'USER': 'cltbld', 18:21:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', 18:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:07 INFO - '_': '/tools/buildbot/bin/python'} 18:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:07 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)) 18:21:07 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)) 18:21:07 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)) 18:21:07 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)) 18:21:07 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)) 18:21:07 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)) 18:21:07 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)) 18:21:07 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)) 18:21:07 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)) 18:21:07 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:21:07 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 18:21:07 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 18:21:07 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 18:21:07 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 18:21:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:21:08 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)) 18:21:08 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)) 18:21:08 INFO - Installing collected packages: simplejson 18:21:08 INFO - Running setup.py install for simplejson 18:21:08 INFO - building 'simplejson._speedups' extension 18:21:08 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 18:21:09 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 18:21:09 INFO - Successfully installed simplejson 18:21:09 INFO - Cleaning up... 18:21:09 INFO - Return code: 0 18:21:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:21: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')]} 18:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:21: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')]} 18:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:21:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c401f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e0ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fadb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fb0f00>, '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 0x1fabba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac050>, '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': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', '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 18:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:21:09 INFO - Using env: {'DISPLAY': ':0', 18:21:09 INFO - 'HOME': '/home/cltbld', 18:21:09 INFO - 'LANG': 'en_US.UTF-8', 18:21:09 INFO - 'LANGUAGE': 'en_US:en', 18:21:09 INFO - 'LOGNAME': 'cltbld', 18:21:09 INFO - 'MAIL': '/var/mail/cltbld', 18:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:09 INFO - 'MOZ_NO_REMOTE': '1', 18:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:09 INFO - 'NO_EM_RESTART': '1', 18:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:09 INFO - 'PWD': '/builds/slave/test', 18:21:09 INFO - 'SHELL': '/bin/bash', 18:21:09 INFO - 'SHLVL': '1', 18:21:09 INFO - 'TERM': 'linux', 18:21:09 INFO - 'TMOUT': '86400', 18:21:09 INFO - 'USER': 'cltbld', 18:21:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', 18:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:09 INFO - '_': '/tools/buildbot/bin/python'} 18:21:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:21:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:21:10 INFO - Cleaning up... 18:21:10 INFO - Return code: 0 18:21:10 INFO - Running post-action listener: _resource_record_post_action 18:21:10 INFO - Running post-action listener: _start_resource_monitoring 18:21:10 INFO - Starting resource monitoring. 18:21:10 INFO - [mozharness: 2017-08-15 01:21:10.174515Z] Finished create-virtualenv step (success) 18:21:10 INFO - [mozharness: 2017-08-15 01:21:10.175036Z] Running install step. 18:21:10 INFO - Running pre-action listener: _resource_record_pre_action 18:21:10 INFO - Running main action method: install 18:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:21:10 INFO - Reading from file tmpfile_stdout 18:21:10 INFO - Detecting whether we're running mozinstall >=1.0... 18:21:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:21:10 INFO - Reading from file tmpfile_stdout 18:21:10 INFO - Output received: 18:21:10 INFO - Usage: mozinstall [options] installer 18:21:10 INFO - Options: 18:21:10 INFO - -h, --help show this help message and exit 18:21:10 INFO - -d DEST, --destination=DEST 18:21:10 INFO - Directory to install application into. [default: 18:21:10 INFO - "/builds/slave/test"] 18:21:10 INFO - --app=APP Application being installed. [default: firefox] 18:21:10 INFO - mkdir: /builds/slave/test/build/application 18:21:10 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'] 18:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:21:28 INFO - Reading from file tmpfile_stdout 18:21:28 INFO - Output received: 18:21:28 INFO - /builds/slave/test/build/application/firefox/firefox 18:21:28 INFO - Running post-action listener: _resource_record_post_action 18:21:28 INFO - [mozharness: 2017-08-15 01:21:28.494089Z] Finished install step (success) 18:21:28 INFO - [mozharness: 2017-08-15 01:21:28.494343Z] Running setup-mitmproxy step. 18:21:28 INFO - Running pre-action listener: _resource_record_pre_action 18:21:28 INFO - Running main action method: setup_mitmproxy 18:21:28 INFO - Skipping: mitmproxy is not required 18:21:28 INFO - Running post-action listener: _resource_record_post_action 18:21:28 INFO - [mozharness: 2017-08-15 01:21:28.495498Z] Finished setup-mitmproxy step (success) 18:21:28 INFO - [mozharness: 2017-08-15 01:21:28.495719Z] Running run-tests step. 18:21:28 INFO - Running pre-action listener: _resource_record_pre_action 18:21:28 INFO - Running pre-action listener: _set_gcov_prefix 18:21:28 INFO - Running main action method: run_tests 18:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:21:28 INFO - Python 2.7.3 18:21:28 INFO - Return code: 0 18:21:28 INFO - grabbing minidump binary from tooltool 18:21:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:21:28 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 0x1fb0f00>, '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 0x1fabba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fac050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:21:28 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 18:21:28 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 18:21:28 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 18:21:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:21:28 INFO - Return code: 0 18:21:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:21:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:21:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:21:28 INFO - ENV: RUST_BACKTRACE is now full 18:21:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:21:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:21:28 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/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 18:21:28 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/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 18:21:28 INFO - Using env: {'DISPLAY': ':0', 18:21:28 INFO - 'HOME': '/home/cltbld', 18:21:28 INFO - 'LANG': 'en_US.UTF-8', 18:21:28 INFO - 'LANGUAGE': 'en_US:en', 18:21:28 INFO - 'LOGNAME': 'cltbld', 18:21:28 INFO - 'MAIL': '/var/mail/cltbld', 18:21:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:21:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:21:28 INFO - 'MOZ_NO_REMOTE': '1', 18:21:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:21:28 INFO - 'NO_EM_RESTART': '1', 18:21:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:21:28 INFO - 'PWD': '/builds/slave/test', 18:21:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:21:28 INFO - 'RUST_BACKTRACE': 'full', 18:21:28 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:21:28 INFO - 'SHELL': '/bin/bash', 18:21:28 INFO - 'SHLVL': '1', 18:21:28 INFO - 'STYLO_FORCE_ENABLED': '1', 18:21:28 INFO - 'TERM': 'linux', 18:21:28 INFO - 'TMOUT': '86400', 18:21:28 INFO - 'USER': 'cltbld', 18:21:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621', 18:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:21:28 INFO - '_': '/tools/buildbot/bin/python'} 18:21:28 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/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 18:21:28 INFO - mozversion application_buildid: 20170815002832 18:21:28 INFO - mozversion application_changeset: 92f3de33d97f55d54b2baad585b87e76aaa5ec58 18:21:28 INFO - mozversion application_display_name: Nightly 18:21:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:21:28 INFO - mozversion application_name: Firefox 18:21:28 INFO - mozversion application_remotingname: firefox 18:21:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:21:28 INFO - mozversion application_vendor: Mozilla 18:21:28 INFO - mozversion application_version: 57.0a1 18:21:28 INFO - mozversion platform_buildid: 20170815002832 18:21:28 INFO - mozversion platform_changeset: 92f3de33d97f55d54b2baad585b87e76aaa5ec58 18:21:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:21:28 INFO - mozversion platform_version: 57.0a1 18:21:28 INFO - using testdate: 1502760088 18:21:28 INFO - actual date: 1502760088 18:21:28 INFO - starting webserver on 'localhost:50903' 18:21:28 INFO - SUITE-START | Running 2 tests 18:21:28 INFO - TEST-START | dromaeo_css 18:21:28 INFO - Initialising browser for dromaeo_css test... 18:21:28 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50903/getInfo.html -profile /tmp/tmpaLHJ1f/profile 18:21:28 INFO - TEST-INFO | started process 10065 (/builds/slave/test/build/application/firefox/firefox http://localhost:50903/getInfo.html) 18:21:35 INFO - TEST-INFO | 10065: exit 0 18:21:35 INFO - Browser initialized. 18:21:35 INFO - Running cycle 1/1 for dromaeo_css test... 18:21:35 INFO - TEST-INFO | started process 10300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaLHJ1f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:21:36 INFO - PID 10300 | 18:21:36 INFO - PID 10300 | (/builds/slave/test/build/application/firefox/firefox:10354): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:21:36 INFO - PID 10300 | 18:21:46 INFO - PID 10300 | RSS: Main: 168402944 18:21:46 INFO - PID 10300 | 18:24:45 INFO - PID 10300 | Cycle 1(1): loaded http://localhost:50903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50903/tests/dromaeo/cssquery-ext.html) 18:24:47 INFO - PID 10300 | RSS: Main: 175263744 18:24:47 INFO - PID 10300 | 18:27:49 INFO - PID 10300 | Cycle 1(1): loaded http://localhost:50903/tests/dromaeo/cssquery-ext.html (next: http://localhost:50903/tests/dromaeo/cssquery-jquery.html) 18:27:49 INFO - PID 10300 | RSS: Main: 172621824 18:27:49 INFO - PID 10300 | 18:30:51 INFO - PID 10300 | Cycle 1(1): loaded http://localhost:50903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50903/tests/dromaeo/cssquery-mootools.html) 18:30:52 INFO - PID 10300 | RSS: Main: 173449216 18:30:52 INFO - PID 10300 | 18:33:53 INFO - PID 10300 | Cycle 1(1): loaded http://localhost:50903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50903/tests/dromaeo/cssquery-prototype.html) 18:33:54 INFO - PID 10300 | RSS: Main: 172818432 18:33:54 INFO - PID 10300 | 18:36:58 INFO - PID 10300 | Cycle 1(1): loaded http://localhost:50903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50903/tests/dromaeo/cssquery-yui.html) 18:36:59 INFO - PID 10300 | RSS: Main: 176177152 18:36:59 INFO - PID 10300 | 18:40:00 INFO - PID 10300 | Cycle 1(1): loaded http://localhost:50903/tests/dromaeo/cssquery-yui.html (next: http://localhost:50903/tests/dromaeo/cssquery-dojo.html) 18:40:01 INFO - PID 10300 | RSS: Main: 176627712 18:40:01 INFO - PID 10300 | 18:40:01 INFO - PID 10300 | __start_tp_report 18:40:01 INFO - PID 10300 | _x_x_mozilla_page_load 18:40:01 INFO - PID 10300 | _x_x_mozilla_page_load_details 18:40:01 INFO - PID 10300 | |i|pagename|runs| 18:40:01 INFO - PID 10300 | |0;dojo.html;3131.5928929239208;3164.4145833020884;3184.7929884557516;3190.9521357179638;3213.6946990035954;6240.719167637456;6283.717232724527;6325.399087086726;6338.334474880135;6382.744690212386;6147.385261473851;6156.969215153929;6159.476444502223;6200.565960382775;6226.346233645459;5639.15412688096;5660.886782264352;5668.631538949976;5670.68811215383;5708.971455142719;5715.428457154272;5716.771329146829;5753.395893431192;5780.104083866986;5786.045302525078;5726.942730572682;5765.4522820332;5771.076627739562;5800.042992906166;5803.535717142639;5543.307086614173;5667.376588575254;5735.569832262597;5782.768689252425;5818.796342128006;5553.389127196006;5556.888862222733;5578.721063946787;5608.831735047955;5661.46216109469;6087;6096;6133.509319254449;6231.750729970796;6253.6873156342;6605.801825945229;6676.432503237231;6724.596524208514;6737.966310168418;6827.146606674166;6708.530402871801;6766.391024807742;6769.0861733665815;6772.525923185379;6776.2546119926765;6242.438180563771;6247.718852651642;6248.250209974832;6252.6561039142825;6255.030470277115;6873.793786186422;6877.828054298582;6883.759068432681;6894.896576551356;6903.861922761516;6391.936080639227;6466.870662586816;6551.672416379162;6564.5076619252795;6566.015097735378;6784.694688739019;6802.97955306708;6804.455643548505;6844.726210951606;6851.07510486078;6722.428593569602;6738.191417029988;6808.08090907731;6818.965905170442;6820.6930688119155;6750.122484077038;6754.155730533684;6824.931750682529;6848.520603557703;6854.9657251713425;4950.504949505021;5009.574186194214;5083.186690129562;5119.59043276537;5121.103806833789;4430.3575981483145;4440.400545926259;4466.1067786442845;4483.529229430928;4498.797554110073;5794.62334948227;5864.091065884794;5864.824055278348;5867.325257595346;5935.050391937356;6683.365080317362;6687.996800479869;6690.063391125246;6701.664916754143;6735.494837887178;5741.741621626953;5832.387599302097;5867.207926929896;5868.295804503487;5904.439078287556;5876.559258055663;5955.493783028491;5962.2249107615735;5967.045272756338;5986.3714309997695;6497;6524.64114473699;6592.077109204619;6595.637239951849;6640.800775976729;6604.405603495708;6627.701753421204;6706.899396509154;6708.631025293461;6720.798376048726;6403.487720982217;6477.060826180272;6488.675566221765;6493.642849643126;6572.375624315682;6616.867662646624;6652.068710380648;6710.362515561014;6734.696938637871;6758.121444212221;6762.256151823394;6764.5603035802515;6863.588184708933;6876.071730316343;6883.380495755406;6396.168498095218;6447.774327898501;6454.128692626436;6465.806025819233;6492.415682588589;6477.514186435942;6541.215054193527;6557.475401967927;6561.573497722633;6567.179102612174;6475.481961443167;6500.70746816385;6500.7399704013205;6503.219613646393;6506.41442270198;5918.319393269829;6508.08886755864;6554.115194448688;6598;6763.256041835296;6395.968020159869;6404.167458230587;6489.059086432347;6489.059086432535;6490.967545162244 18:40:01 INFO - PID 10300 | |1;ext.html;775.4339332287431;831.3972370031724;852.4586887326548;874.0210963720634;876.1501343696616;40104.79947600265;40798.18403631925;40944.181116377695;40969.59030409695;40976.59023409769;37527.812360938224;37756.62243377566;37842.8107859461;37856.81071594638;37931.24137517248;6807.353301436368;6906.482013848957;6910.2053263874795;6936.72253109875;6938.479614028943;7421.0723659542555;7609.543427394374;7609.733659321925;7616.847663046736;7618.809529761745;7617.504862183968;7622.809429764245;7641.465097443182;7682.116556595979;7684.615769211545;7307.89038164428;7549.735759248428;7589.506682065648;7593.392528597727;7602.961985190039;7446.66490007951;7491.625418729096;7493.288137626917;7497.550146991143;7511.511751736174;37361.81319093415;37684.62315376866;37713.622863771285;37778.24443511114;37813.24373512542;3457.11843479911;3499.7550171488006;3501.6673416025437;3504.1414853360834;3511.736619753529;30065.549016764548;30085;30199;30242;30261.848690756404;4836.540528649773;4837.540433658797;4851.878703032417;4876.4879687633;4897.1674815281485;220413;223248;224695;224887;225457;49139;49298.75350623224;49449.50550494521;49495;49559.256611150864;53736;54311.72844135754;54533;54577.181342279895;54577.45422545803;16892.57768555796;17011.574710632085;17023.233954472078;17025.23386447613;17049.14754262282;13892.235927023909;13897.930510347383;13927.512537061155;13980.720385592434;13992.86007139936;14222;14256.85743142576;14311.069780464237;14409.279536023367;14450.494232701805;5738.8278351649515;5802.709864506758;5837.3870743571315;5943.64338139713;6038.909416358758;988.2193067476613;998.5406712911996;1003.6437064841876;1009.2279406254221;1025.9794804103876;22867.771322286895;29066.41867162645;29171.854140729585;29655.110346689202;30039.399212015636;1091.4597274349248;1095.9945200274108;1100.7688385439149;1103.420704130338;1114.9442527873573;12279.440400227582;12532.937335313265;12567.811482827765;12639.873601264053;12778.552750653682;250010;250875;251868;251893;252207;50776;51033.234501482504;53677.463225367246;57626.7118664404;57656.71171644115;1448.8840892728556;1470.170772885514;1479.5339468067525;1479.8372179060295;1484.8663620274226;27395;27443.86278068597;27924.30189245285;28155.71844281531;28554.571681425212;36736.08159795919;36951.26097478089;37027.81486092552;37180.25639487249;37222.627773723;214065;215015;215912;216548;217154;34745.65254347424;34833.30333393368;34985.30029399347;35011.47482787709;35072.29855402929;40863.1827363457;42541.14917701691;42810.78594607007;42814;42848.57151428446;31078;31147.688523114477;31191.376172476877;31334.529982050743;31350.843245783624;30910.38179236448;30974;30986.69013309928;31687.52468713017;31886;34319.828400857834;34382.31235375329;34409.48385774165;34466;34660.30679386348;32738.836305818317;32832.83583582162;32849.34301314008;32877.34245315128;32932.83533582317;23293.855329530295;24323.39191520226;24643.630345544472;25086.247412577653;25290.620640690773 18:40:01 INFO - PID 10300 | |2;jquery.html;558.8546977785777;565.705832966857;570.2102587915738;576.5013263527048;578.8234588450521;21914.671279930815;22369.55260894781;22670;22687.886560567196;22707.318780436573;24740.50518989619;26271.211863644072;26486.735132648668;26576;26656.866715666394;6272.874542509147;6356.936430635704;6358.364163583651;6372.745090196387;6422.646754428504;5928.525717942576;6430.742770289183;6460;6472.029195620671;6544.9345506544805;6420.486361091102;6453.225612926455;6454.160959075313;6459.9031014534585;6460.030995350688;6417.133686952248;6447.645379504125;6451.967740161293;6453.16108905844;6464.288928217892;5999.73001214942;6007.699615019232;6018.548608854353;6025;6033.698315084228;27776.861115694493;28237;28868.422631547463;29644.703552964627;29910.252243693863;1824.9452516424396;1826.3242600237998;1826.4338055202797;1828.6891228491188;1833.4591295567839;17186.74219886703;17706.026168560726;17811.287548498043;17837.732434013502;17857.196426160855;2278.9658155127686;2298.1037395415633;2330.603797354454;2334.3463830127594;2371.2530552875787;137036.31481842627;140353;140367;140407;140502.29748851294;14212.786808197885;14915;14954.327055282321;14968.625784355478;15475.84524154744;23257;23452.882735586212;23473.88263058708;23491.060357585506;23498.53002939966;10400.891647799228;10614.522346494427;10633.096186824207;10655.147588192925;10754.408507532004;9874;9954.71041660422;10000.249981251436;10090.09189172978;10122.190224782;7680.930585813337;9045.140711632384;9077.68228112013;9117.589708463134;9328.813423731488;2556.4120252342063;2623.5671114265933;2656.043824223278;2716.3752336962216;2746.093789049609;947.0718695678274;949.093615597103;952.2382094324513;953.8569214617725;964.0600414595854;19905;20040.89979550093;20273.79726202719;20637.896810515853;24165;975.5219942228399;996.8704068471052;1019.6176433837311;1032.963846265377;1034.446571084466;11188.216824822348;11687.065034797195;13530.526431574848;14487.130772153494;14637.780433293296;502814;523637;528089;550939;551094;104229.47885260677;106688;106984;109408;112482.43758781154;1251.6307689231699;1262.6212136359056;1287.137617796079;1295.391166151907;1295.8963282937532;21316;21488.462788429788;21812.127514899224;21929.890350548147;22049.22827701023;57219.42780572141;57810.710946445;58364.70817646055;58578.7071064659;58949.41050589611;68686.65656671685;69406.65296673484;69539.30460695531;69631.6518417425;69689.30310697031;12266.202696824677;12386.81419778722;14839.33223004989;14966.251687415368;15008.774868376764;22969.196078137185;22994.885025574764;23064.538709226057;23352;23353.182638607566;18291.359802406852;18369.26522939121;18376.448706538824;18538.443846684622;18548.350807721665;16680.41536054073;16806.495805125865;16893.577660558094;17379;17654.029028403562;17161.656766864344;18608.44174674762;18768.718469223244;18816.905915470335;18828.811711882707;14581.489647862274;14583.85416145825;14597.489087881873;14651.12093274407;14664.046836955991;16579.336826527287;17478.91260543689;17496;17497.47507574775;17953.64092718112 18:40:01 INFO - PID 10300 | |3;mootools.html;1372.2384076837354;1391.819063521742;1403.873651371377;1413.025012741209;1430.9427622895084;13928;14505.92747036266;14530.63673408164;14538.781918271234;14553.781693274595;13956.44174233032;14496.637584060403;14934.850651493482;14972.101673899573;14986.325615347308;2613.3858543242322;2662.5739881618947;2668.7064422913463;2674.812763106583;2677.919662410121;2583.3670750666115;2608.9608655870084;2633.9736602634016;2739.575365818291;2741.383188782518;2737.7536021758137;2767.8754456049423;2769.4599553087155;2769.9169024929283;2770.265879541923;2603.2840968733562;2607.2829971757824;2633.683957925052;2647.324932142301;2664.8667566621593;2638.063487461962;2640.3531134871887;2644.4843255565174;2653.4427770168286;2699.2172270041665;14169.433222671081;14252.643683907881;14258.2157981311;14267.78598321026;14267.928660356736;7766.301032907066;8028.157043510406;8042.15557366474;8045.235702608243;8053.95973020137;5031.1950087986115;5075.720835354091;5177.844664660066;5205.167173252299;5263.421023687391;1754;1758.71860502319;1802.1439816087254;1806.4490330449207;1814.2470874587032;23800.523989520287;24169;24281.392965175834;24292.63561046586;24294.87852560726;6398.776042838478;6469.741210351627;6487.18910136233;6624.238212605515;6637.1703537057865;15895.761563576556;16060.277287522089;16061.598460038593;16070.75893861593;16078.678426431406;7527.849443011219;7671.53970761756;7675.117361503387;7677.616119194018;7678.270564296383;6841.315868413119;6904;7030.402415794612;7035.0150978863;7047.541909775849;5085.847424577269;5209.479052094836;5217.113090774577;5230.320058392461;5238.92141617876;1374.615107769826;1428.0931608428514;1438.8273407191205;1471.5144002479155;1520.1335238913714;858.2876212743408;869.7738587967174;873.702941000063;877.3639111644135;882.9470231786113;8270.586470676442;8324;8358.373122015752;8400.453970491899;8420.621072051772;962.7256231973994;969.8496733006396;989.218517371283;991.9008099190023;993.2302465589227;4393;4476.776161191928;4490.124425737015;4529.954700452953;4543.863684089482;19161.808381916282;19727.50681232952;19785.703214451794;19789.30737424183;19848.50378740543;19560.182874483442;20092.59814803696;20138.798612013692;20175.192992280437;20249.696254556195;10865.945670271756;11211.047060999743;11314.547418103184;11327.433628318551;11346.602868899714;8142;8194.877076843733;8215.301699355383;8223.21879421454;8262.091169971178;16959.660806784043;17067;17097.829021709622;17156.39952601653;17174.883632563844;18008.09959502046;18172.182251798964;18342.816571834646;18347.90826045861;18408.447746567625;10632.468376581295;10834.133269338592;10845.566177352817;11326.546938122383;11697.649070527557;13272.070955033056;13388.799168012292;13397.799033014318;13404.396802143732;13406.664833379244;10988.835167472655;10992.28550144238;11000.559977600806;11263.66209013731;11276.267042642203;10763.838542421714;10866.402347870942;10909.672709818718;10971.835422468828;11109.611163609236;9405.341626086381;9609.9039009609;9612.279079068958;9616.90383096188;9617.038296170327;6935.029095926675;6954.3393377629045;6959.61722105289;6970.721171153097;6996.230414654282;6780.72877084911;6785.694643740945;6846.554973926679;6914.723411063501;6947.548409353376 18:40:01 INFO - PID 10300 | |4;prototype.html;488.462691039856;500.217160144374;510.18879980830474;511.1540400636945;525.3957948359387;6160.691965401728;6180.774921028432;6250.374962503747;6250.84372890678;6300.7794727184555;5938.940610593892;6006.657403612595;6033;6119.908201376983;6143.754249830002;4823.56410012943;4875.829345972892;4928.753562321869;4937.432195297533;4946.3817022872145;4808.471068182497;4929.679570827902;4951.183054795954;4969.726665033421;4974.328465657144;4916.213405855064;4920.335754673127;4931.728754918478;4934.1365261079345;4943.6539442239055;4878.975605121987;4885;4915.26271059344;4929.186684197103;4958.950410495885;4399.38408622793;4457.465104187486;4471.39636149119;4473.642108631302;4479.886478897135;6048.788292409745;6064.151018857364;6085.908711369333;6100.176476175704;6114.7770445910555;5661.122526008434;5710.914336284959;5717.514011309044;5724.8282551523525;5747.913781293284;6435.452986496153;6465.612063276171;6468.159139311906;6513.250976137758;6555.278919318871;4897.4857639948;4898.877528061791;4909.239067944474;4927.211646136601;4928.1129396708575;6807.3873351398615;6882.69027893746;6907.930920690829;6908.412784913238;6938.785712500292;4915.459299477055;4962.330085438492;5017.774200161001;5024.974875125601;5026.773795179152;4988.6507944444265;5066.214736715815;5097.337346145052;5105.923411148836;5110.361204849394;5653.123765816305;5662.490375866109;5726.198332233491;5729.656220626775;5730.484256416942;6421.839454013687;6448.742050317935;6453.161089058486;6486.351364863476;6584.341565843377;1664.167916041979;1677.8993260404416;1709.9743503847453;1734.2022669572139;1742.1985886492355;1216.8235605837103;1237.1401875696486;1237.3751255615857;1241.5840693367822;1245.3212998915612;5709.371969083398;5710.315456940212;5762.320520957691;5839.591228614041;5847.514806207345;6505;6549.934500654933;6608.173978252718;6718.563293385914;6750.966245168743;5704.003598740408;5743.684097374685;5761.971190144106;5775.624584402;5806.477417032403;3519.641839967228;3546.538949936492;3561.6082230954576;3575.982120089435;3579.731520136;6485.383888530582;6517.576357536745;6535.836604084936;6539.967300163468;6547.9017814732815;6807.693653785592;6855.177378714487;6891.655417229219;6916.55042422241;6929.990302812128;6196.907046394308;6402.711877965596;6452.387023232785;6476;6588.748137853792;6680.231773346128;6706.195256569243;6721.697523611351;6747.359000894907;6754.696038678173;6632.635205063575;6672.633005184762;6691.587290481792;6701.195856497056;6763.526553141233;6439.581427207217;6444.45222156122;6514.54398192141;6537.136915978923;6580.868382632225;5371.435999220182;5509.669419834822;5517;5529.668219906818;5536.640118392292;6694.129763130762;6795.1845778506895;6816.352446517573;6822.624755638488;6876.793696189123;6421.5825971311715;6454.548181627429;6513.772017979538;6514;6619.900701489385;6253.249610046823;6342.8731425370315;6383.425491705769;6454.257760357619;6505.902411463737;6195.915714749991;6348.968255158695;6364.904526432199;6380.138681278154;6419.646919419477;6373.490120790419;6432.2281326241155;6450.677466126769;6469.805905822833;6496.902546461902;6093.817185484442;6127.816165515042;6189.535784816067;6250.406211409909;6281.330434565383 18:40:01 INFO - PID 10300 | |5;yui.html;893.3478560650725;921.2952091649885;927.253560883489;927.4667066436798;945.8344789661808;16889.23998420071;17646;17684.64630707387;18093.7285940711;18121.728174077365;20523;22024.779752202474;22235.777642223573;22306.21928232508;22406.663900041513;1019.816433042054;1051.7475805806628;1056.7252514346287;1057.249352959396;1058.5077938758475;1020.1481762728093;1049.874015118187;1054.8575942247815;1058.2169194795833;1062.049465728173;1107.6843099716582;1108.6064447121278;1109.328856042095;1109.9223054386196;1116.3692513729716;1102.818035024224;1103.7185517693017;1106.778644271149;1107.7618312062864;1114.2144787924494;809.2191035650567;810.0117856215408;810.440795850867;811.809224832164;819.3199644295221;19080.522986925298;19389.224431022743;19461;19577.412677619694;19614.215431382727;21744.34766956994;22014.559708805733;22318.88840555803;22354.776452235594;22491.325260242218;15582.220888955508;15721.606959825982;15764.975276606983;15945.441909533227;15947.92026039874;3512.2448673535314;3517.1383011162175;3536.7347448941173;3537.8054207018604;3567.7859328440377;126903;127182;129400.35299823535;130821;131498.99999999904;14140.363683634261;14277.286135693173;14537.92731036338;14663.780043299359;14692.559223223321;30100.24749381283;30404.847975759978;30614;30829.845850771053;30831;7926.603669816486;8112.959435202904;8122.431429799975;8124.106348301682;8159.918400816035;3955.64399204073;4109.219248342805;4192.140611174702;4193.685473589493;4202.852900148541;5318.680879147263;5430.321209848769;5432.348118225838;5452.91820622691;5452.972735136299;1048.528162326956;1087.2335003822286;1101.091599430473;1104.0229396983727;1105.8285965675334;582.7202942587581;593.6171169595586;594.6996766632823;624.1979056911847;652.0252222926661;11631.347461015492;12091.214071085351;12352.505899763908;12413.255204687748;12815.551455699006;610.5939550199157;621.3475850357107;637.1971316141695;643.6492111799081;658.808945405827;5816.592838501264;5857.472827445466;5885.352611212763;5979.6711180884595;6135.171751813537;103655.48172259242;104545;105002.47498762458;105963.4701826486;107013;93103.53448232716;96502;98277.50861245791;99388;100513;83303;83834.38910859961;84826.57586712026;88464.11535884559;89027.55486222656;10242.48787560604;10375.16998640122;10452.425116618659;10492.790144197226;10563.735906602089;39260.411093834184;39274;39604.80197598993;40643.7967810159;41475;49638.75180624074;50950.74524627353;51340.74329628328;69031;73414.26585734074;14608.185528174741;15208.315625797088;15432.459863904709;15539.611509712347;19407.2237110514;21664;21749.238776642742;22436.326910192067;22607.5478490426;22842.31473055811;18775.155118019447;19214.13536390838;19324.8067519323;19866.404007879788;20273.79726202719;19208.61582768309;20083.799162008778;20117.49706257355;20542.794572054685;20681.689774653092;19460.1242944065;19929.601407972048;19938.30215942435;20067;20453;13942.372593233125;13970.511032113827;14048.157110573398;14124.929375353058;14162.221077840406;13766.65583360424;13907.58277251684;13909.860901390857;14022.719545608827;14089.365978530786 18:40:01 INFO - PID 10300 | __end_tp_report 18:40:01 INFO - PID 10300 | __start_cc_report 18:40:01 INFO - PID 10300 | _x_x_mozilla_cycle_collect,372 18:40:01 INFO - PID 10300 | __end_cc_report 18:40:01 INFO - PID 10300 | __startTimestamp1502761201208__endTimestamp 18:40:01 INFO - PID 10300 | 18:40:01 INFO - PID 10300 | ------- Summary: start ------- 18:40:01 INFO - PID 10300 | Number of tests: 6 18:40:01 INFO - PID 10300 | 18:40:01 INFO - PID 10300 | [#0] dojo.html Cycles:165 Average:6163.41 Median:6454.13 stddev:763.71 (11.8%) stddev-sans-first:728.08 18:40:01 INFO - PID 10300 | Values: 3131.6 3164.4 3184.8 3191.0 3213.7 6240.7 6283.7 6325.4 6338.3 6382.7 6147.4 6157.0 6159.5 6200.6 6226.3 5639.2 5660.9 5668.6 5670.7 5709.0 5715.4 5716.8 5753.4 5780.1 5786.0 5726.9 5765.5 5771.1 5800.0 5803.5 5543.3 5667.4 5735.6 5782.8 5818.8 5553.4 5556.9 5578.7 5608.8 5661.5 6087.0 6096.0 6133.5 6231.8 6253.7 6605.8 6676.4 6724.6 6738.0 6827.1 6708.5 6766.4 6769.1 6772.5 6776.3 6242.4 6247.7 6248.3 6252.7 6255.0 6873.8 6877.8 6883.8 6894.9 6903.9 6391.9 6466.9 6551.7 6564.5 6566.0 6784.7 6803.0 6804.5 6844.7 6851.1 6722.4 6738.2 6808.1 6819.0 6820.7 6750.1 6754.2 6824.9 6848.5 6855.0 4950.5 5009.6 5083.2 5119.6 5121.1 4430.4 4440.4 4466.1 4483.5 4498.8 5794.6 5864.1 5864.8 5867.3 5935.1 6683.4 6688.0 6690.1 6701.7 6735.5 5741.7 5832.4 5867.2 5868.3 5904.4 5876.6 5955.5 5962.2 5967.0 5986.4 6497.0 6524.6 6592.1 6595.6 6640.8 6604.4 6627.7 6706.9 6708.6 6720.8 6403.5 6477.1 6488.7 6493.6 6572.4 6616.9 6652.1 6710.4 6734.7 6758.1 6762.3 6764.6 6863.6 6876.1 6883.4 6396.2 6447.8 6454.1 6465.8 6492.4 6477.5 6541.2 6557.5 6561.6 6567.2 6475.5 6500.7 6500.7 6503.2 6506.4 5918.3 6508.1 6554.1 6598.0 6763.3 6396.0 6404.2 6489.1 6489.1 6491.0 18:40:01 INFO - PID 10300 | 18:40:01 INFO - PID 10300 | [#1] ext.html Cycles:180 Average:39818.16 Median:34909.30 stddev:59901.21 (171.6%) stddev-sans-first:59997.51 18:40:01 INFO - PID 10300 | Values: 775.4 831.4 852.5 874.0 876.2 40104.8 40798.2 40944.2 40969.6 40976.6 37527.8 37756.6 37842.8 37856.8 37931.2 6807.4 6906.5 6910.2 6936.7 6938.5 7421.1 7609.5 7609.7 7616.8 7618.8 7617.5 7622.8 7641.5 7682.1 7684.6 7307.9 7549.7 7589.5 7593.4 7603.0 7446.7 7491.6 7493.3 7497.6 7511.5 37361.8 37684.6 37713.6 37778.2 37813.2 3457.1 3499.8 3501.7 3504.1 3511.7 30065.5 30085.0 30199.0 30242.0 30261.8 4836.5 4837.5 4851.9 4876.5 4897.2 220413.0 223248.0 224695.0 224887.0 225457.0 49139.0 49298.8 49449.5 49495.0 49559.3 53736.0 54311.7 54533.0 54577.2 54577.5 16892.6 17011.6 17023.2 17025.2 17049.1 13892.2 13897.9 13927.5 13980.7 13992.9 14222.0 14256.9 14311.1 14409.3 14450.5 5738.8 5802.7 5837.4 5943.6 6038.9 988.2 998.5 1003.6 1009.2 1026.0 22867.8 29066.4 29171.9 29655.1 30039.4 1091.5 1096.0 1100.8 1103.4 1114.9 12279.4 12532.9 12567.8 12639.9 12778.6 250010.0 250875.0 251868.0 251893.0 252207.0 50776.0 51033.2 53677.5 57626.7 57656.7 1448.9 1470.2 1479.5 1479.8 1484.9 27395.0 27443.9 27924.3 28155.7 28554.6 36736.1 36951.3 37027.8 37180.3 37222.6 214065.0 215015.0 215912.0 216548.0 217154.0 34745.7 34833.3 34985.3 35011.5 35072.3 40863.2 42541.1 42810.8 42814.0 42848.6 31078.0 31147.7 31191.4 31334.5 31350.8 30910.4 30974.0 30986.7 31687.5 31886.0 34319.8 34382.3 34409.5 34466.0 34660.3 32738.8 32832.8 32849.3 32877.3 32932.8 23293.9 24323.4 24643.6 25086.2 25290.6 18:40:01 INFO - PID 10300 | 18:40:01 INFO - PID 10300 | [#2] jquery.html Cycles:180 Average:35851.86 Median:12624.08 stddev:88858.87 (703.9%) stddev-sans-first:89068.63 18:40:01 INFO - PID 10300 | Values: 558.9 565.7 570.2 576.5 578.8 21914.7 22369.6 22670.0 22687.9 22707.3 24740.5 26271.2 26486.7 26576.0 26656.9 6272.9 6356.9 6358.4 6372.7 6422.6 5928.5 6430.7 6460.0 6472.0 6544.9 6420.5 6453.2 6454.2 6459.9 6460.0 6417.1 6447.6 6452.0 6453.2 6464.3 5999.7 6007.7 6018.5 6025.0 6033.7 27776.9 28237.0 28868.4 29644.7 29910.3 1824.9 1826.3 1826.4 1828.7 1833.5 17186.7 17706.0 17811.3 17837.7 17857.2 2279.0 2298.1 2330.6 2334.3 2371.3 137036.3 140353.0 140367.0 140407.0 140502.3 14212.8 14915.0 14954.3 14968.6 15475.8 23257.0 23452.9 23473.9 23491.1 23498.5 10400.9 10614.5 10633.1 10655.1 10754.4 9874.0 9954.7 10000.2 10090.1 10122.2 7680.9 9045.1 9077.7 9117.6 9328.8 2556.4 2623.6 2656.0 2716.4 2746.1 947.1 949.1 952.2 953.9 964.1 19905.0 20040.9 20273.8 20637.9 24165.0 975.5 996.9 1019.6 1033.0 1034.4 11188.2 11687.1 13530.5 14487.1 14637.8 502814.0 523637.0 528089.0 550939.0 551094.0 104229.5 106688.0 106984.0 109408.0 112482.4 1251.6 1262.6 1287.1 1295.4 1295.9 21316.0 21488.5 21812.1 21929.9 22049.2 57219.4 57810.7 58364.7 58578.7 58949.4 68686.7 69406.7 69539.3 69631.7 69689.3 12266.2 12386.8 14839.3 14966.3 15008.8 22969.2 22994.9 23064.5 23352.0 23353.2 18291.4 18369.3 18376.4 18538.4 18548.4 16680.4 16806.5 16893.6 17379.0 17654.0 17161.7 18608.4 18768.7 18816.9 18828.8 14581.5 14583.9 14597.5 14651.1 14664.0 16579.3 17478.9 17496.0 17497.5 17953.6 18:40:01 INFO - PID 10300 | 18:40:01 INFO - PID 10300 | [#3] mootools.html Cycles:180 Average:8889.89 Median:2633.83 stddev:6168.18 (234.2%) stddev-sans-first:6159.62 18:40:01 INFO - PID 10300 | Values: 1372.2 1391.8 1403.9 1413.0 1430.9 13928.0 14505.9 14530.6 14538.8 14553.8 13956.4 14496.6 14934.9 14972.1 14986.3 2613.4 2662.6 2668.7 2674.8 2677.9 2583.4 2609.0 2634.0 2739.6 2741.4 2737.8 2767.9 2769.5 2769.9 2770.3 2603.3 2607.3 2633.7 2647.3 2664.9 2638.1 2640.4 2644.5 2653.4 2699.2 14169.4 14252.6 14258.2 14267.8 14267.9 7766.3 8028.2 8042.2 8045.2 8054.0 5031.2 5075.7 5177.8 5205.2 5263.4 1754.0 1758.7 1802.1 1806.4 1814.2 23800.5 24169.0 24281.4 24292.6 24294.9 6398.8 6469.7 6487.2 6624.2 6637.2 15895.8 16060.3 16061.6 16070.8 16078.7 7527.8 7671.5 7675.1 7677.6 7678.3 6841.3 6904.0 7030.4 7035.0 7047.5 5085.8 5209.5 5217.1 5230.3 5238.9 1374.6 1428.1 1438.8 1471.5 1520.1 858.3 869.8 873.7 877.4 882.9 8270.6 8324.0 8358.4 8400.5 8420.6 962.7 969.8 989.2 991.9 993.2 4393.0 4476.8 4490.1 4530.0 4543.9 19161.8 19727.5 19785.7 19789.3 19848.5 19560.2 20092.6 20138.8 20175.2 20249.7 10865.9 11211.0 11314.5 11327.4 11346.6 8142.0 8194.9 8215.3 8223.2 8262.1 16959.7 17067.0 17097.8 17156.4 17174.9 18008.1 18172.2 18342.8 18347.9 18408.4 10632.5 10834.1 10845.6 11326.5 11697.6 13272.1 13388.8 13397.8 13404.4 13406.7 10988.8 10992.3 11000.6 11263.7 11276.3 10763.8 10866.4 10909.7 10971.8 11109.6 9405.3 9609.9 9612.3 9616.9 9617.0 6935.0 6954.3 6959.6 6970.7 6996.2 6780.7 6785.7 6846.6 6914.7 6947.5 18:40:01 INFO - PID 10300 | 18:40:01 INFO - PID 10300 | [#4] prototype.html Cycles:180 Average:5494.55 Median:6089.86 stddev:1535.86 (25.2%) stddev-sans-first:1493.50 18:40:01 INFO - PID 10300 | Values: 488.5 500.2 510.2 511.2 525.4 6160.7 6180.8 6250.4 6250.8 6300.8 5938.9 6006.7 6033.0 6119.9 6143.8 4823.6 4875.8 4928.8 4937.4 4946.4 4808.5 4929.7 4951.2 4969.7 4974.3 4916.2 4920.3 4931.7 4934.1 4943.7 4879.0 4885.0 4915.3 4929.2 4959.0 4399.4 4457.5 4471.4 4473.6 4479.9 6048.8 6064.2 6085.9 6100.2 6114.8 5661.1 5710.9 5717.5 5724.8 5747.9 6435.5 6465.6 6468.2 6513.3 6555.3 4897.5 4898.9 4909.2 4927.2 4928.1 6807.4 6882.7 6907.9 6908.4 6938.8 4915.5 4962.3 5017.8 5025.0 5026.8 4988.7 5066.2 5097.3 5105.9 5110.4 5653.1 5662.5 5726.2 5729.7 5730.5 6421.8 6448.7 6453.2 6486.4 6584.3 1664.2 1677.9 1710.0 1734.2 1742.2 1216.8 1237.1 1237.4 1241.6 1245.3 5709.4 5710.3 5762.3 5839.6 5847.5 6505.0 6549.9 6608.2 6718.6 6751.0 5704.0 5743.7 5762.0 5775.6 5806.5 3519.6 3546.5 3561.6 3576.0 3579.7 6485.4 6517.6 6535.8 6540.0 6547.9 6807.7 6855.2 6891.7 6916.6 6930.0 6196.9 6402.7 6452.4 6476.0 6588.7 6680.2 6706.2 6721.7 6747.4 6754.7 6632.6 6672.6 6691.6 6701.2 6763.5 6439.6 6444.5 6514.5 6537.1 6580.9 5371.4 5509.7 5517.0 5529.7 5536.6 6694.1 6795.2 6816.4 6822.6 6876.8 6421.6 6454.5 6513.8 6514.0 6619.9 6253.2 6342.9 6383.4 6454.3 6505.9 6195.9 6349.0 6364.9 6380.1 6419.6 6373.5 6432.2 6450.7 6469.8 6496.9 6093.8 6127.8 6189.5 6250.4 6281.3 18:40:01 INFO - PID 10300 | 18:40:01 INFO - PID 10300 | [#5] yui.html Cycles:180 Average:23411.93 Median:20100.65 stddev:31678.29 (157.6%) stddev-sans-first:31722.02 18:40:01 INFO - PID 10300 | Values: 893.3 921.3 927.3 927.5 945.8 16889.2 17646.0 17684.6 18093.7 18121.7 20523.0 22024.8 22235.8 22306.2 22406.7 1019.8 1051.7 1056.7 1057.2 1058.5 1020.1 1049.9 1054.9 1058.2 1062.0 1107.7 1108.6 1109.3 1109.9 1116.4 1102.8 1103.7 1106.8 1107.8 1114.2 809.2 810.0 810.4 811.8 819.3 19080.5 19389.2 19461.0 19577.4 19614.2 21744.3 22014.6 22318.9 22354.8 22491.3 15582.2 15721.6 15765.0 15945.4 15947.9 3512.2 3517.1 3536.7 3537.8 3567.8 126903.0 127182.0 129400.4 130821.0 131499.0 14140.4 14277.3 14537.9 14663.8 14692.6 30100.2 30404.8 30614.0 30829.8 30831.0 7926.6 8113.0 8122.4 8124.1 8159.9 3955.6 4109.2 4192.1 4193.7 4202.9 5318.7 5430.3 5432.3 5452.9 5453.0 1048.5 1087.2 1101.1 1104.0 1105.8 582.7 593.6 594.7 624.2 652.0 11631.3 12091.2 12352.5 12413.3 12815.6 610.6 621.3 637.2 643.6 658.8 5816.6 5857.5 5885.4 5979.7 6135.2 103655.5 104545.0 105002.5 105963.5 107013.0 93103.5 96502.0 98277.5 99388.0 100513.0 83303.0 83834.4 84826.6 88464.1 89027.6 10242.5 10375.2 10452.4 10492.8 10563.7 39260.4 39274.0 39604.8 40643.8 41475.0 49638.8 50950.7 51340.7 69031.0 73414.3 14608.2 15208.3 15432.5 15539.6 19407.2 21664.0 21749.2 22436.3 22607.5 22842.3 18775.2 19214.1 19324.8 19866.4 20273.8 19208.6 20083.8 20117.5 20542.8 20681.7 19460.1 19929.6 19938.3 20067.0 20453.0 13942.4 13970.5 14048.2 14124.9 14162.2 13766.7 13907.6 13909.9 14022.7 14089.4 18:40:01 INFO - PID 10300 | -------- Summary: end -------- 18:40:01 INFO - PID 10300 | 18:40:01 INFO - TEST-INFO | 10300: exit 0 18:40:01 INFO - TEST-OK | dromaeo_css | took 1112987ms 18:40:01 INFO - TEST-START | kraken 18:40:01 INFO - Initialising browser for kraken test... 18:40:01 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:50903/getInfo.html -profile /tmp/tmp0H616j/profile 18:40:01 INFO - TEST-INFO | started process 10677 (/builds/slave/test/build/application/firefox/firefox http://localhost:50903/getInfo.html) 18:40:07 INFO - TEST-INFO | 10677: exit 0 18:40:08 INFO - Browser initialized. 18:40:08 INFO - Running cycle 1/1 for kraken test... 18:40:08 INFO - TEST-INFO | started process 10912 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0H616j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:40:09 INFO - PID 10912 | 18:40:09 INFO - PID 10912 | (/builds/slave/test/build/application/firefox/firefox:10966): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:40:09 INFO - PID 10912 | 18:40:19 INFO - PID 10912 | RSS: Main: 168058880 18:40:19 INFO - PID 10912 | 18:40:22 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50903/tests/kraken/driver.html?testName=audio-beat-detection) 18:40:22 INFO - PID 10912 | RSS: Main: 174333952 18:40:22 INFO - PID 10912 | 18:40:25 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50903/tests/kraken/driver.html?testName=audio-dft) 18:40:26 INFO - PID 10912 | RSS: Main: 177643520 18:40:26 INFO - PID 10912 | 18:40:29 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50903/tests/kraken/driver.html?testName=audio-fft) 18:40:30 INFO - PID 10912 | RSS: Main: 171610112 18:40:30 INFO - PID 10912 | 18:40:32 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50903/tests/kraken/driver.html?testName=audio-oscillator) 18:40:32 INFO - PID 10912 | RSS: Main: 172249088 18:40:32 INFO - PID 10912 | 18:40:35 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:40:35 INFO - PID 10912 | RSS: Main: 172433408 18:40:35 INFO - PID 10912 | 18:40:38 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50903/tests/kraken/driver.html?testName=imaging-darkroom) 18:40:39 INFO - PID 10912 | RSS: Main: 173535232 18:40:39 INFO - PID 10912 | 18:40:43 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50903/tests/kraken/driver.html?testName=imaging-desaturate) 18:40:43 INFO - PID 10912 | RSS: Main: 173051904 18:40:43 INFO - PID 10912 | 18:40:46 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50903/tests/kraken/driver.html?testName=json-parse-financial) 18:40:47 INFO - PID 10912 | RSS: Main: 174432256 18:40:47 INFO - PID 10912 | 18:40:48 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:40:49 INFO - PID 10912 | RSS: Main: 174411776 18:40:49 INFO - PID 10912 | 18:40:51 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:40:52 INFO - PID 10912 | RSS: Main: 174317568 18:40:52 INFO - PID 10912 | 18:40:54 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:40:54 INFO - PID 10912 | RSS: Main: 174436352 18:40:54 INFO - PID 10912 | 18:40:57 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:40:58 INFO - PID 10912 | RSS: Main: 174559232 18:40:58 INFO - PID 10912 | 18:41:01 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:41:02 INFO - PID 10912 | RSS: Main: 174657536 18:41:02 INFO - PID 10912 | 18:41:03 INFO - PID 10912 | Cycle 1(1): loaded http://localhost:50903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50903/tests/kraken/driver.html?testName=ai-astar) 18:41:04 INFO - PID 10912 | RSS: Main: 175771648 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | __start_tp_report 18:41:04 INFO - PID 10912 | _x_x_mozilla_page_load 18:41:04 INFO - PID 10912 | _x_x_mozilla_page_load_details 18:41:04 INFO - PID 10912 | |i|pagename|runs| 18:41:04 INFO - PID 10912 | |0;ai-astar;103;113;100;108;108;109;109;99;115;109 18:41:04 INFO - PID 10912 | |1;audio-beat-detection;149;119;147;184;125;146;148;121;174;119 18:41:04 INFO - PID 10912 | |2;audio-dft;162;162;164;163;164;163;164;165;164;164 18:41:04 INFO - PID 10912 | |3;audio-fft;76;83;77;185;78;76;82;75;163;77 18:41:04 INFO - PID 10912 | |4;audio-oscillator;78;83;143;79;84;79;125;79;85;141 18:41:04 INFO - PID 10912 | |5;imaging-gaussian-blur;114;114;117;125;121;114;116;114;115;115 18:41:04 INFO - PID 10912 | |6;imaging-darkroom;150;151;152;151;151;156;152;153;153;151 18:41:04 INFO - PID 10912 | |7;imaging-desaturate;101;99;95;95;95;94;94;99;94;94 18:41:04 INFO - PID 10912 | |8;json-parse-financial;54;64;54;53;53;54;53;64;53;53 18:41:04 INFO - PID 10912 | |9;json-stringify-tinderbox;54;54;54;54;54;54;54;54;55;59 18:41:04 INFO - PID 10912 | |10;stanford-crypto-aes;78;77;84;79;78;78;78;80;80;77 18:41:04 INFO - PID 10912 | |11;stanford-crypto-ccm;143;124;124;128;124;131;133;126;132;179 18:41:04 INFO - PID 10912 | |12;stanford-crypto-pbkdf2;174;184;184;172;171;175;174;183;180;178 18:41:04 INFO - PID 10912 | |13;stanford-crypto-sha256-iterative;72;68;68;66;66;68;68;71;66;66 18:41:04 INFO - PID 10912 | __end_tp_report 18:41:04 INFO - PID 10912 | __start_cc_report 18:41:04 INFO - PID 10912 | _x_x_mozilla_cycle_collect,977 18:41:04 INFO - PID 10912 | __end_cc_report 18:41:04 INFO - PID 10912 | __startTimestamp1502761264183__endTimestamp 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | ------- Summary: start ------- 18:41:04 INFO - PID 10912 | Number of tests: 14 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#0] ai-astar Cycles:10 Average:107.30 Median:109.00 stddev:5.19 (4.8%) stddev-sans-first:5.26 18:41:04 INFO - PID 10912 | Values: 103.0 113.0 100.0 108.0 108.0 109.0 109.0 99.0 115.0 109.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:147.50 stddev:22.82 (15.5%) stddev-sans-first:24.11 18:41:04 INFO - PID 10912 | Values: 149.0 119.0 147.0 184.0 125.0 146.0 148.0 121.0 174.0 119.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:0.97 (0.6%) stddev-sans-first:0.87 18:41:04 INFO - PID 10912 | Values: 162.0 162.0 164.0 163.0 164.0 163.0 164.0 165.0 164.0 164.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#3] audio-fft Cycles:10 Average:97.20 Median:77.00 stddev:40.89 (53.1%) stddev-sans-first:42.64 18:41:04 INFO - PID 10912 | Values: 76.0 83.0 77.0 185.0 78.0 76.0 82.0 75.0 163.0 77.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:79.00 stddev:27.23 (34.5%) stddev-sans-first:27.95 18:41:04 INFO - PID 10912 | Values: 78.0 83.0 143.0 79.0 84.0 79.0 125.0 79.0 85.0 141.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:115.50 stddev:3.69 (3.2%) stddev-sans-first:3.80 18:41:04 INFO - PID 10912 | Values: 114.0 114.0 117.0 125.0 121.0 114.0 116.0 114.0 115.0 115.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:152.00 stddev:1.70 (1.1%) stddev-sans-first:1.64 18:41:04 INFO - PID 10912 | Values: 150.0 151.0 152.0 151.0 151.0 156.0 152.0 153.0 153.0 151.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:95.00 stddev:2.62 (2.8%) stddev-sans-first:2.07 18:41:04 INFO - PID 10912 | Values: 101.0 99.0 95.0 95.0 95.0 94.0 94.0 99.0 94.0 94.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.00 stddev:4.50 (8.3%) stddev-sans-first:4.74 18:41:04 INFO - PID 10912 | Values: 54.0 64.0 54.0 53.0 53.0 54.0 53.0 64.0 53.0 53.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#9] json-stringify-tinderbox Cycles:10 Average:54.60 Median:54.00 stddev:1.58 (2.9%) stddev-sans-first:1.66 18:41:04 INFO - PID 10912 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 55.0 59.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:78.50 stddev:2.08 (2.6%) stddev-sans-first:2.18 18:41:04 INFO - PID 10912 | Values: 78.0 77.0 84.0 79.0 78.0 78.0 78.0 80.0 80.0 77.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:131.50 stddev:16.73 (12.7%) stddev-sans-first:17.45 18:41:04 INFO - PID 10912 | Values: 143.0 124.0 124.0 128.0 124.0 131.0 133.0 126.0 132.0 179.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:179.00 stddev:4.99 (2.8%) stddev-sans-first:5.13 18:41:04 INFO - PID 10912 | Values: 174.0 184.0 184.0 172.0 171.0 175.0 174.0 183.0 180.0 178.0 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:2.13 (3.1%) stddev-sans-first:1.67 18:41:04 INFO - PID 10912 | Values: 72.0 68.0 68.0 66.0 66.0 68.0 68.0 71.0 66.0 66.0 18:41:04 INFO - PID 10912 | -------- Summary: end -------- 18:41:04 INFO - PID 10912 | 18:41:04 INFO - PID 10912 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:41:04 INFO - TEST-INFO | 10912: exit 0 18:41:04 INFO - TEST-OK | kraken | took 62982ms 18:41:04 INFO - SUITE-END | took 1175s 18:41:04 INFO - Completed test suite (00:19:35) 18:41:04 INFO - javascript benchmark 18:41:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8502.00006154399, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.5928929239208, 3164.4145833020884, 3184.7929884557516, 3190.9521357179638, 3213.6946990035954, 6240.719167637456, 6283.717232724527, 6325.399087086726, 6338.334474880135, 6382.744690212386, 6147.385261473851, 6156.969215153929, 6159.476444502223, 6200.565960382775, 6226.346233645459, 5639.15412688096, 5660.886782264352, 5668.631538949976, 5670.68811215383, 5708.971455142719, 5715.428457154272, 5716.771329146829, 5753.395893431192, 5780.104083866986, 5786.045302525078, 5726.942730572682, 5765.4522820332, 5771.076627739562, 5800.042992906166, 5803.535717142639, 5543.307086614173, 5667.376588575254, 5735.569832262597, 5782.768689252425, 5818.796342128006, 5553.389127196006, 5556.888862222733, 5578.721063946787, 5608.831735047955, 5661.46216109469, 6087.0, 6096.0, 6133.509319254449, 6231.750729970796, 6253.6873156342, 6605.801825945229, 6676.432503237231, 6724.596524208514, 6737.966310168418, 6827.146606674166, 6708.530402871801, 6766.391024807742, 6769.0861733665815, 6772.525923185379, 6776.2546119926765, 6242.438180563771, 6247.718852651642, 6248.250209974832, 6252.6561039142825, 6255.030470277115, 6873.793786186422, 6877.828054298582, 6883.759068432681, 6894.896576551356, 6903.861922761516, 6391.936080639227, 6466.870662586816, 6551.672416379162, 6564.5076619252795, 6566.015097735378, 6784.694688739019, 6802.97955306708, 6804.455643548505, 6844.726210951606, 6851.07510486078, 6722.428593569602, 6738.191417029988, 6808.08090907731, 6818.965905170442, 6820.6930688119155, 6750.122484077038, 6754.155730533684, 6824.931750682529, 6848.520603557703, 6854.9657251713425, 4950.504949505021, 5009.574186194214, 5083.186690129562, 5119.59043276537, 5121.103806833789, 4430.3575981483145, 4440.400545926259, 4466.1067786442845, 4483.529229430928, 4498.797554110073, 5794.62334948227, 5864.091065884794, 5864.824055278348, 5867.325257595346, 5935.050391937356, 6683.365080317362, 6687.996800479869, 6690.063391125246, 6701.664916754143, 6735.494837887178, 5741.741621626953, 5832.387599302097, 5867.207926929896, 5868.295804503487, 5904.439078287556, 5876.559258055663, 5955.493783028491, 5962.2249107615735, 5967.045272756338, 5986.3714309997695, 6497.0, 6524.64114473699, 6592.077109204619, 6595.637239951849, 6640.800775976729, 6604.405603495708, 6627.701753421204, 6706.899396509154, 6708.631025293461, 6720.798376048726, 6403.487720982217, 6477.060826180272, 6488.675566221765, 6493.642849643126, 6572.375624315682, 6616.867662646624, 6652.068710380648, 6710.362515561014, 6734.696938637871, 6758.121444212221, 6762.256151823394, 6764.5603035802515, 6863.588184708933, 6876.071730316343, 6883.380495755406, 6396.168498095218, 6447.774327898501, 6454.128692626436, 6465.806025819233, 6492.415682588589, 6477.514186435942, 6541.215054193527, 6557.475401967927, 6561.573497722633, 6567.179102612174, 6475.481961443167, 6500.70746816385, 6500.7399704013205, 6503.219613646393, 6506.41442270198, 5918.319393269829, 6508.08886755864, 6554.115194448688, 6598.0, 6763.256041835296, 6395.968020159869, 6404.167458230587, 6489.059086432347, 6489.059086432535, 6490.967545162244], "value": 6104.102643335435, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.4339332287431, 831.3972370031724, 852.4586887326548, 874.0210963720634, 876.1501343696616, 40104.79947600265, 40798.18403631925, 40944.181116377695, 40969.59030409695, 40976.59023409769, 37527.812360938224, 37756.62243377566, 37842.8107859461, 37856.81071594638, 37931.24137517248, 6807.353301436368, 6906.482013848957, 6910.2053263874795, 6936.72253109875, 6938.479614028943, 7421.0723659542555, 7609.543427394374, 7609.733659321925, 7616.847663046736, 7618.809529761745, 7617.504862183968, 7622.809429764245, 7641.465097443182, 7682.116556595979, 7684.615769211545, 7307.89038164428, 7549.735759248428, 7589.506682065648, 7593.392528597727, 7602.961985190039, 7446.66490007951, 7491.625418729096, 7493.288137626917, 7497.550146991143, 7511.511751736174, 37361.81319093415, 37684.62315376866, 37713.622863771285, 37778.24443511114, 37813.24373512542, 3457.11843479911, 3499.7550171488006, 3501.6673416025437, 3504.1414853360834, 3511.736619753529, 30065.549016764548, 30085.0, 30199.0, 30242.0, 30261.848690756404, 4836.540528649773, 4837.540433658797, 4851.878703032417, 4876.4879687633, 4897.1674815281485, 220413.0, 223248.0, 224695.0, 224887.0, 225457.0, 49139.0, 49298.75350623224, 49449.50550494521, 49495.0, 49559.256611150864, 53736.0, 54311.72844135754, 54533.0, 54577.181342279895, 54577.45422545803, 16892.57768555796, 17011.574710632085, 17023.233954472078, 17025.23386447613, 17049.14754262282, 13892.235927023909, 13897.930510347383, 13927.512537061155, 13980.720385592434, 13992.86007139936, 14222.0, 14256.85743142576, 14311.069780464237, 14409.279536023367, 14450.494232701805, 5738.8278351649515, 5802.709864506758, 5837.3870743571315, 5943.64338139713, 6038.909416358758, 988.2193067476613, 998.5406712911996, 1003.6437064841876, 1009.2279406254221, 1025.9794804103876, 22867.771322286895, 29066.41867162645, 29171.854140729585, 29655.110346689202, 30039.399212015636, 1091.4597274349248, 1095.9945200274108, 1100.7688385439149, 1103.420704130338, 1114.9442527873573, 12279.440400227582, 12532.937335313265, 12567.811482827765, 12639.873601264053, 12778.552750653682, 250010.0, 250875.0, 251868.0, 251893.0, 252207.0, 50776.0, 51033.234501482504, 53677.463225367246, 57626.7118664404, 57656.71171644115, 1448.8840892728556, 1470.170772885514, 1479.5339468067525, 1479.8372179060295, 1484.8663620274226, 27395.0, 27443.86278068597, 27924.30189245285, 28155.71844281531, 28554.571681425212, 36736.08159795919, 36951.26097478089, 37027.81486092552, 37180.25639487249, 37222.627773723, 214065.0, 215015.0, 215912.0, 216548.0, 217154.0, 34745.65254347424, 34833.30333393368, 34985.30029399347, 35011.47482787709, 35072.29855402929, 40863.1827363457, 42541.14917701691, 42810.78594607007, 42814.0, 42848.57151428446, 31078.0, 31147.688523114477, 31191.376172476877, 31334.529982050743, 31350.843245783624, 30910.38179236448, 30974.0, 30986.69013309928, 31687.52468713017, 31886.0, 34319.828400857834, 34382.31235375329, 34409.48385774165, 34466.0, 34660.30679386348, 32738.836305818317, 32832.83583582162, 32849.34301314008, 32877.34245315128, 32932.83533582317, 23293.855329530295, 24323.39191520226, 24643.630345544472, 25086.247412577653, 25290.620640690773], "value": 17419.705722010578, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.8546977785777, 565.705832966857, 570.2102587915738, 576.5013263527048, 578.8234588450521, 21914.671279930815, 22369.55260894781, 22670.0, 22687.886560567196, 22707.318780436573, 24740.50518989619, 26271.211863644072, 26486.735132648668, 26576.0, 26656.866715666394, 6272.874542509147, 6356.936430635704, 6358.364163583651, 6372.745090196387, 6422.646754428504, 5928.525717942576, 6430.742770289183, 6460.0, 6472.029195620671, 6544.9345506544805, 6420.486361091102, 6453.225612926455, 6454.160959075313, 6459.9031014534585, 6460.030995350688, 6417.133686952248, 6447.645379504125, 6451.967740161293, 6453.16108905844, 6464.288928217892, 5999.73001214942, 6007.699615019232, 6018.548608854353, 6025.0, 6033.698315084228, 27776.861115694493, 28237.0, 28868.422631547463, 29644.703552964627, 29910.252243693863, 1824.9452516424396, 1826.3242600237998, 1826.4338055202797, 1828.6891228491188, 1833.4591295567839, 17186.74219886703, 17706.026168560726, 17811.287548498043, 17837.732434013502, 17857.196426160855, 2278.9658155127686, 2298.1037395415633, 2330.603797354454, 2334.3463830127594, 2371.2530552875787, 137036.31481842627, 140353.0, 140367.0, 140407.0, 140502.29748851294, 14212.786808197885, 14915.0, 14954.327055282321, 14968.625784355478, 15475.84524154744, 23257.0, 23452.882735586212, 23473.88263058708, 23491.060357585506, 23498.53002939966, 10400.891647799228, 10614.522346494427, 10633.096186824207, 10655.147588192925, 10754.408507532004, 9874.0, 9954.71041660422, 10000.249981251436, 10090.09189172978, 10122.190224782, 7680.930585813337, 9045.140711632384, 9077.68228112013, 9117.589708463134, 9328.813423731488, 2556.4120252342063, 2623.5671114265933, 2656.043824223278, 2716.3752336962216, 2746.093789049609, 947.0718695678274, 949.093615597103, 952.2382094324513, 953.8569214617725, 964.0600414595854, 19905.0, 20040.89979550093, 20273.79726202719, 20637.896810515853, 24165.0, 975.5219942228399, 996.8704068471052, 1019.6176433837311, 1032.963846265377, 1034.446571084466, 11188.216824822348, 11687.065034797195, 13530.526431574848, 14487.130772153494, 14637.780433293296, 502814.0, 523637.0, 528089.0, 550939.0, 551094.0, 104229.47885260677, 106688.0, 106984.0, 109408.0, 112482.43758781154, 1251.6307689231699, 1262.6212136359056, 1287.137617796079, 1295.391166151907, 1295.8963282937532, 21316.0, 21488.462788429788, 21812.127514899224, 21929.890350548147, 22049.22827701023, 57219.42780572141, 57810.710946445, 58364.70817646055, 58578.7071064659, 58949.41050589611, 68686.65656671685, 69406.65296673484, 69539.30460695531, 69631.6518417425, 69689.30310697031, 12266.202696824677, 12386.81419778722, 14839.33223004989, 14966.251687415368, 15008.774868376764, 22969.196078137185, 22994.885025574764, 23064.538709226057, 23352.0, 23353.182638607566, 18291.359802406852, 18369.26522939121, 18376.448706538824, 18538.443846684622, 18548.350807721665, 16680.41536054073, 16806.495805125865, 16893.577660558094, 17379.0, 17654.029028403562, 17161.656766864344, 18608.44174674762, 18768.718469223244, 18816.905915470335, 18828.811711882707, 14581.489647862274, 14583.85416145825, 14597.489087881873, 14651.12093274407, 14664.046836955991, 16579.336826527287, 17478.91260543689, 17496.0, 17497.47507574775, 17953.64092718112], "value": 12010.179493300666, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.2384076837354, 1391.819063521742, 1403.873651371377, 1413.025012741209, 1430.9427622895084, 13928.0, 14505.92747036266, 14530.63673408164, 14538.781918271234, 14553.781693274595, 13956.44174233032, 14496.637584060403, 14934.850651493482, 14972.101673899573, 14986.325615347308, 2613.3858543242322, 2662.5739881618947, 2668.7064422913463, 2674.812763106583, 2677.919662410121, 2583.3670750666115, 2608.9608655870084, 2633.9736602634016, 2739.575365818291, 2741.383188782518, 2737.7536021758137, 2767.8754456049423, 2769.4599553087155, 2769.9169024929283, 2770.265879541923, 2603.2840968733562, 2607.2829971757824, 2633.683957925052, 2647.324932142301, 2664.8667566621593, 2638.063487461962, 2640.3531134871887, 2644.4843255565174, 2653.4427770168286, 2699.2172270041665, 14169.433222671081, 14252.643683907881, 14258.2157981311, 14267.78598321026, 14267.928660356736, 7766.301032907066, 8028.157043510406, 8042.15557366474, 8045.235702608243, 8053.95973020137, 5031.1950087986115, 5075.720835354091, 5177.844664660066, 5205.167173252299, 5263.421023687391, 1754.0, 1758.71860502319, 1802.1439816087254, 1806.4490330449207, 1814.2470874587032, 23800.523989520287, 24169.0, 24281.392965175834, 24292.63561046586, 24294.87852560726, 6398.776042838478, 6469.741210351627, 6487.18910136233, 6624.238212605515, 6637.1703537057865, 15895.761563576556, 16060.277287522089, 16061.598460038593, 16070.75893861593, 16078.678426431406, 7527.849443011219, 7671.53970761756, 7675.117361503387, 7677.616119194018, 7678.270564296383, 6841.315868413119, 6904.0, 7030.402415794612, 7035.0150978863, 7047.541909775849, 5085.847424577269, 5209.479052094836, 5217.113090774577, 5230.320058392461, 5238.92141617876, 1374.615107769826, 1428.0931608428514, 1438.8273407191205, 1471.5144002479155, 1520.1335238913714, 858.2876212743408, 869.7738587967174, 873.702941000063, 877.3639111644135, 882.9470231786113, 8270.586470676442, 8324.0, 8358.373122015752, 8400.453970491899, 8420.621072051772, 962.7256231973994, 969.8496733006396, 989.218517371283, 991.9008099190023, 993.2302465589227, 4393.0, 4476.776161191928, 4490.124425737015, 4529.954700452953, 4543.863684089482, 19161.808381916282, 19727.50681232952, 19785.703214451794, 19789.30737424183, 19848.50378740543, 19560.182874483442, 20092.59814803696, 20138.798612013692, 20175.192992280437, 20249.696254556195, 10865.945670271756, 11211.047060999743, 11314.547418103184, 11327.433628318551, 11346.602868899714, 8142.0, 8194.877076843733, 8215.301699355383, 8223.21879421454, 8262.091169971178, 16959.660806784043, 17067.0, 17097.829021709622, 17156.39952601653, 17174.883632563844, 18008.09959502046, 18172.182251798964, 18342.816571834646, 18347.90826045861, 18408.447746567625, 10632.468376581295, 10834.133269338592, 10845.566177352817, 11326.546938122383, 11697.649070527557, 13272.070955033056, 13388.799168012292, 13397.799033014318, 13404.396802143732, 13406.664833379244, 10988.835167472655, 10992.28550144238, 11000.559977600806, 11263.66209013731, 11276.267042642203, 10763.838542421714, 10866.402347870942, 10909.672709818718, 10971.835422468828, 11109.611163609236, 9405.341626086381, 9609.9039009609, 9612.279079068958, 9616.90383096188, 9617.038296170327, 6935.029095926675, 6954.3393377629045, 6959.61722105289, 6970.721171153097, 6996.230414654282, 6780.72877084911, 6785.694643740945, 6846.554973926679, 6914.723411063501, 6947.548409353376], "value": 6435.3773969918375, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [488.462691039856, 500.217160144374, 510.18879980830474, 511.1540400636945, 525.3957948359387, 6160.691965401728, 6180.774921028432, 6250.374962503747, 6250.84372890678, 6300.7794727184555, 5938.940610593892, 6006.657403612595, 6033.0, 6119.908201376983, 6143.754249830002, 4823.56410012943, 4875.829345972892, 4928.753562321869, 4937.432195297533, 4946.3817022872145, 4808.471068182497, 4929.679570827902, 4951.183054795954, 4969.726665033421, 4974.328465657144, 4916.213405855064, 4920.335754673127, 4931.728754918478, 4934.1365261079345, 4943.6539442239055, 4878.975605121987, 4885.0, 4915.26271059344, 4929.186684197103, 4958.950410495885, 4399.38408622793, 4457.465104187486, 4471.39636149119, 4473.642108631302, 4479.886478897135, 6048.788292409745, 6064.151018857364, 6085.908711369333, 6100.176476175704, 6114.7770445910555, 5661.122526008434, 5710.914336284959, 5717.514011309044, 5724.8282551523525, 5747.913781293284, 6435.452986496153, 6465.612063276171, 6468.159139311906, 6513.250976137758, 6555.278919318871, 4897.4857639948, 4898.877528061791, 4909.239067944474, 4927.211646136601, 4928.1129396708575, 6807.3873351398615, 6882.69027893746, 6907.930920690829, 6908.412784913238, 6938.785712500292, 4915.459299477055, 4962.330085438492, 5017.774200161001, 5024.974875125601, 5026.773795179152, 4988.6507944444265, 5066.214736715815, 5097.337346145052, 5105.923411148836, 5110.361204849394, 5653.123765816305, 5662.490375866109, 5726.198332233491, 5729.656220626775, 5730.484256416942, 6421.839454013687, 6448.742050317935, 6453.161089058486, 6486.351364863476, 6584.341565843377, 1664.167916041979, 1677.8993260404416, 1709.9743503847453, 1734.2022669572139, 1742.1985886492355, 1216.8235605837103, 1237.1401875696486, 1237.3751255615857, 1241.5840693367822, 1245.3212998915612, 5709.371969083398, 5710.315456940212, 5762.320520957691, 5839.591228614041, 5847.514806207345, 6505.0, 6549.934500654933, 6608.173978252718, 6718.563293385914, 6750.966245168743, 5704.003598740408, 5743.684097374685, 5761.971190144106, 5775.624584402, 5806.477417032403, 3519.641839967228, 3546.538949936492, 3561.6082230954576, 3575.982120089435, 3579.731520136, 6485.383888530582, 6517.576357536745, 6535.836604084936, 6539.967300163468, 6547.9017814732815, 6807.693653785592, 6855.177378714487, 6891.655417229219, 6916.55042422241, 6929.990302812128, 6196.907046394308, 6402.711877965596, 6452.387023232785, 6476.0, 6588.748137853792, 6680.231773346128, 6706.195256569243, 6721.697523611351, 6747.359000894907, 6754.696038678173, 6632.635205063575, 6672.633005184762, 6691.587290481792, 6701.195856497056, 6763.526553141233, 6439.581427207217, 6444.45222156122, 6514.54398192141, 6537.136915978923, 6580.868382632225, 5371.435999220182, 5509.669419834822, 5517.0, 5529.668219906818, 5536.640118392292, 6694.129763130762, 6795.1845778506895, 6816.352446517573, 6822.624755638488, 6876.793696189123, 6421.5825971311715, 6454.548181627429, 6513.772017979538, 6514.0, 6619.900701489385, 6253.249610046823, 6342.8731425370315, 6383.425491705769, 6454.257760357619, 6505.902411463737, 6195.915714749991, 6348.968255158695, 6364.904526432199, 6380.138681278154, 6419.646919419477, 6373.490120790419, 6432.2281326241155, 6450.677466126769, 6469.805905822833, 6496.902546461902, 6093.817185484442, 6127.816165515042, 6189.535784816067, 6250.406211409909, 6281.330434565383], "value": 5040.5945029407, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [893.3478560650725, 921.2952091649885, 927.253560883489, 927.4667066436798, 945.8344789661808, 16889.23998420071, 17646.0, 17684.64630707387, 18093.7285940711, 18121.728174077365, 20523.0, 22024.779752202474, 22235.777642223573, 22306.21928232508, 22406.663900041513, 1019.816433042054, 1051.7475805806628, 1056.7252514346287, 1057.249352959396, 1058.5077938758475, 1020.1481762728093, 1049.874015118187, 1054.8575942247815, 1058.2169194795833, 1062.049465728173, 1107.6843099716582, 1108.6064447121278, 1109.328856042095, 1109.9223054386196, 1116.3692513729716, 1102.818035024224, 1103.7185517693017, 1106.778644271149, 1107.7618312062864, 1114.2144787924494, 809.2191035650567, 810.0117856215408, 810.440795850867, 811.809224832164, 819.3199644295221, 19080.522986925298, 19389.224431022743, 19461.0, 19577.412677619694, 19614.215431382727, 21744.34766956994, 22014.559708805733, 22318.88840555803, 22354.776452235594, 22491.325260242218, 15582.220888955508, 15721.606959825982, 15764.975276606983, 15945.441909533227, 15947.92026039874, 3512.2448673535314, 3517.1383011162175, 3536.7347448941173, 3537.8054207018604, 3567.7859328440377, 126903.0, 127182.0, 129400.35299823535, 130821.0, 131498.99999999904, 14140.363683634261, 14277.286135693173, 14537.92731036338, 14663.780043299359, 14692.559223223321, 30100.24749381283, 30404.847975759978, 30614.0, 30829.845850771053, 30831.0, 7926.603669816486, 8112.959435202904, 8122.431429799975, 8124.106348301682, 8159.918400816035, 3955.64399204073, 4109.219248342805, 4192.140611174702, 4193.685473589493, 4202.852900148541, 5318.680879147263, 5430.321209848769, 5432.348118225838, 5452.91820622691, 5452.972735136299, 1048.528162326956, 1087.2335003822286, 1101.091599430473, 1104.0229396983727, 1105.8285965675334, 582.7202942587581, 593.6171169595586, 594.6996766632823, 624.1979056911847, 652.0252222926661, 11631.347461015492, 12091.214071085351, 12352.505899763908, 12413.255204687748, 12815.551455699006, 610.5939550199157, 621.3475850357107, 637.1971316141695, 643.6492111799081, 658.808945405827, 5816.592838501264, 5857.472827445466, 5885.352611212763, 5979.6711180884595, 6135.171751813537, 103655.48172259242, 104545.0, 105002.47498762458, 105963.4701826486, 107013.0, 93103.53448232716, 96502.0, 98277.50861245791, 99388.0, 100513.0, 83303.0, 83834.38910859961, 84826.57586712026, 88464.11535884559, 89027.55486222656, 10242.48787560604, 10375.16998640122, 10452.425116618659, 10492.790144197226, 10563.735906602089, 39260.411093834184, 39274.0, 39604.80197598993, 40643.7967810159, 41475.0, 49638.75180624074, 50950.74524627353, 51340.74329628328, 69031.0, 73414.26585734074, 14608.185528174741, 15208.315625797088, 15432.459863904709, 15539.611509712347, 19407.2237110514, 21664.0, 21749.238776642742, 22436.326910192067, 22607.5478490426, 22842.31473055811, 18775.155118019447, 19214.13536390838, 19324.8067519323, 19866.404007879788, 20273.79726202719, 19208.61582768309, 20083.799162008778, 20117.49706257355, 20542.794572054685, 20681.689774653092, 19460.1242944065, 19929.601407972048, 19938.30215942435, 20067.0, 20453.0, 13942.372593233125, 13970.511032113827, 14048.157110573398, 14124.929375353058, 14162.221077840406, 13766.65583360424, 13907.58277251684, 13909.860901390857, 14022.719545608827, 14089.365978530786], "value": 9116.574243112522, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1542.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 100.0, 108.0, 108.0, 109.0, 109.0, 99.0, 115.0, 109.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 147.0, 184.0, 125.0, 146.0, 148.0, 121.0, 174.0, 119.0], "value": 143.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 164.0, 163.0, 164.0, 163.0, 164.0, 165.0, 164.0, 164.0], "value": 163.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 77.0, 185.0, 78.0, 76.0, 82.0, 75.0, 163.0, 77.0], "value": 97.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 143.0, 79.0, 84.0, 79.0, 125.0, 79.0, 85.0, 141.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 117.0, 125.0, 121.0, 114.0, 116.0, 114.0, 115.0, 115.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 152.0, 151.0, 151.0, 156.0, 152.0, 153.0, 153.0, 151.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 99.0, 95.0, 95.0, 95.0, 94.0, 94.0, 99.0, 94.0, 94.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 64.0, 54.0, 53.0, 53.0, 54.0, 53.0, 64.0, 53.0, 53.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 59.0], "value": 54.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 84.0, 79.0, 78.0, 78.0, 78.0, 80.0, 80.0, 77.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 124.0, 124.0, 128.0, 124.0, 131.0, 133.0, 126.0, 132.0, 179.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 184.0, 184.0, 172.0, 171.0, 175.0, 174.0, 183.0, 180.0, 178.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 68.0, 66.0, 66.0, 68.0, 68.0, 71.0, 66.0, 66.0], "value": 67.9, "unit": "score"}]}]} 18:41:04 INFO - Return code: 0 18:41:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:41:04 INFO - # TBPL SUCCESS # 18:41:04 INFO - Running post-action listener: _package_coverage_data 18:41:04 INFO - Running post-action listener: _resource_record_post_action 18:41:04 INFO - [mozharness: 2017-08-15 01:41:04.979764Z] Finished run-tests step (success) 18:41:04 INFO - Running post-run listener: _resource_record_post_run 18:41:05 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 432246784; Read time: 160; Write time: 351176 18:41:05 INFO - TinderboxPrint: CPU usage
13.1% 18:41:05 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 160 18:41:05 INFO - TinderboxPrint: I/O write bytes / time
432,246,784 / 351,176 18:41:05 INFO - TinderboxPrint: CPU idle
8,266.7 (86.8%) 18:41:05 INFO - TinderboxPrint: CPU user
1,202.4 (12.6%) 18:41:05 INFO - TinderboxPrint: Swap in / out
0 / 0 18:41:05 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 110157824; Read time: 0; Write time: 107028 18:41:05 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:41:05 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 320692224; Read time: 148; Write time: 243988 18:41:05 INFO - Running post-run listener: _upload_blobber_files 18:41:05 INFO - Blob upload gear active. 18:41:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:41:05 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 18:41:05 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'] 18:41:05 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 18:41:06 INFO - (blobuploader) - INFO - Open directory for files ... 18:41:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:41:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:41:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:41:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:41:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:41:07 INFO - (blobuploader) - INFO - Done attempting. 18:41:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:41:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:41:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:41:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:41:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:41:08 INFO - (blobuploader) - INFO - Done attempting. 18:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:41:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:41:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:41:08 INFO - (blobuploader) - INFO - Done attempting. 18:41:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:41:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:41:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:41:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:41:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:41:17 INFO - (blobuploader) - INFO - Done attempting. 18:41:17 INFO - (blobuploader) - INFO - Iteration through files over. 18:41:17 INFO - Return code: 0 18:41:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:41:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:41:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b54bb2314905be94364bf8248fd88747c53a09c4152eba5d1f8d55f646bee6f6780ad595ef3de661c92c826c43fed39bddc55fae22e5d6af5d4e27e04c69e5d3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cac5a7121eaaaf8374e3e920e18ee508f51b9d37c3cf22a361256fcd4d7f36da1c662cc0eda16944f3fb2e6e5263f9d9870f0e2c0b4b876a82d22b21c3c6fca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34d081c00db1299d9060618149b8073d4d2a36faadf2f920b45a3b272fd3a822f8cf122fdaf0ff2e2fabc2ba34ecd49d2e8a0cc3a2c3999b1a53de1c004b40f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25ac211aea5628371b5626f4eb2b85ee1d5210185e77b11dcdbdccef4d52f6d2fb6f80e3466201949fca34afe0b6cba00eef8249618857a80402d304bfb6b759"} 18:41:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:41:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:41:17 INFO - Contents: 18:41:17 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b54bb2314905be94364bf8248fd88747c53a09c4152eba5d1f8d55f646bee6f6780ad595ef3de661c92c826c43fed39bddc55fae22e5d6af5d4e27e04c69e5d3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cac5a7121eaaaf8374e3e920e18ee508f51b9d37c3cf22a361256fcd4d7f36da1c662cc0eda16944f3fb2e6e5263f9d9870f0e2c0b4b876a82d22b21c3c6fca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34d081c00db1299d9060618149b8073d4d2a36faadf2f920b45a3b272fd3a822f8cf122fdaf0ff2e2fabc2ba34ecd49d2e8a0cc3a2c3999b1a53de1c004b40f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25ac211aea5628371b5626f4eb2b85ee1d5210185e77b11dcdbdccef4d52f6d2fb6f80e3466201949fca34afe0b6cba00eef8249618857a80402d304bfb6b759"} 18:41:17 INFO - Running post-run listener: copy_logs_to_upload_dir 18:41:17 INFO - Copying logs to upload dir... 18:41:17 INFO - mkdir: /builds/slave/test/build/upload/logs 18:41:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.236958 ========= master_lag: 0.27 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-08-14 18:41:17.843197) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 18:41:17.852181) ========= 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=00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b54bb2314905be94364bf8248fd88747c53a09c4152eba5d1f8d55f646bee6f6780ad595ef3de661c92c826c43fed39bddc55fae22e5d6af5d4e27e04c69e5d3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cac5a7121eaaaf8374e3e920e18ee508f51b9d37c3cf22a361256fcd4d7f36da1c662cc0eda16944f3fb2e6e5263f9d9870f0e2c0b4b876a82d22b21c3c6fca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34d081c00db1299d9060618149b8073d4d2a36faadf2f920b45a3b272fd3a822f8cf122fdaf0ff2e2fabc2ba34ecd49d2e8a0cc3a2c3999b1a53de1c004b40f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25ac211aea5628371b5626f4eb2b85ee1d5210185e77b11dcdbdccef4d52f6d2fb6f80e3466201949fca34afe0b6cba00eef8249618857a80402d304bfb6b759"} build_url:https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011574 build_url: 'https://queue.taskcluster.net/v1/task/QxuElLloREiYtzE68JGu4g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b54bb2314905be94364bf8248fd88747c53a09c4152eba5d1f8d55f646bee6f6780ad595ef3de661c92c826c43fed39bddc55fae22e5d6af5d4e27e04c69e5d3", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cac5a7121eaaaf8374e3e920e18ee508f51b9d37c3cf22a361256fcd4d7f36da1c662cc0eda16944f3fb2e6e5263f9d9870f0e2c0b4b876a82d22b21c3c6fca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/34d081c00db1299d9060618149b8073d4d2a36faadf2f920b45a3b272fd3a822f8cf122fdaf0ff2e2fabc2ba34ecd49d2e8a0cc3a2c3999b1a53de1c004b40f0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25ac211aea5628371b5626f4eb2b85ee1d5210185e77b11dcdbdccef4d52f6d2fb6f80e3466201949fca34afe0b6cba00eef8249618857a80402d304bfb6b759"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 18:41:17.880142) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 18:41:17.880506) ========= 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=00204705a9daa57ed339a427000001b9-1502759774.451486-1335588621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 18:41:17.933637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 18:41:17.936002) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 18:41:17.936300) ========= ========= Total master_lag: 0.46 =========