builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1502707803.1 results: success (0) revision: df9beb781895fcd0493c21e95ad313e0044515ec ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 03:50:03.099247) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 03:50:03.099945) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 03:50:03.100206) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 03:50:03.193152) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:50:03.193441) ========= 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=7de08804244eb36560b44971000001c3-1502705859.724837-544757484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 03:50: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% 41.0M=0s 2017-08-14 03:50:03 (41.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.237135 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:50:03.448548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:50:03.448830) ========= 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=7de08804244eb36560b44971000001c3-1502705859.724837-544757484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020324 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 03:50:03.507044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-14 03:50:03.507341) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev df9beb781895fcd0493c21e95ad313e0044515ec --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 df9beb781895fcd0493c21e95ad313e0044515ec --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=7de08804244eb36560b44971000001c3-1502705859.724837-544757484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 03:50:03,441 truncating revision to first 12 chars 2017-08-14 03:50:03,441 Setting DEBUG logging. 2017-08-14 03:50:03,441 attempt 1/10 2017-08-14 03:50:03,441 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/df9beb781895?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 03:50:04,139 unpacking tar archive at: mozilla-central-df9beb781895/testing/mozharness/ program finished with exit code 0 elapsedTime=1.069797 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-14 03:50:04.589293) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 03:50:04.589563) ========= script_repo_revision: df9beb781895fcd0493c21e95ad313e0044515ec ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 03:50:04.592921) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 03:50:04.593182) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 03:50:04.608623) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-14 03:50:04.608900) ========= /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=7de08804244eb36560b44971000001c3-1502705859.724837-544757484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:50:04 INFO - MultiFileLogger online at 20170814 03:50:04 in /builds/slave/test 03:50: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 03:50:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:50:04 INFO - {'append_to_log': False, 03:50:04 INFO - 'base_work_dir': '/builds/slave/test', 03:50:04 INFO - 'blob_upload_branch': 'Firefox', 03:50:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:50:04 INFO - 'branch': 'Firefox', 03:50:04 INFO - 'buildbot_json_path': 'buildprops.json', 03:50:04 INFO - 'code_coverage': False, 03:50:04 INFO - 'config_files': ('talos/linux_config.py',), 03:50:04 INFO - 'default_actions': ('clobber', 03:50:04 INFO - 'read-buildbot-config', 03:50:04 INFO - 'download-and-extract', 03:50:04 INFO - 'populate-webroot', 03:50:04 INFO - 'create-virtualenv', 03:50:04 INFO - 'install', 03:50:04 INFO - 'setup-mitmproxy', 03:50:04 INFO - 'run-tests'), 03:50:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:50:04 INFO - 'disable_ccov_upload': False, 03:50:04 INFO - 'download_minidump_stackwalk': True, 03:50:04 INFO - 'download_symbols': 'ondemand', 03:50:04 INFO - 'enable_stylo': False, 03:50:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:50:04 INFO - 'tooltool.py': '/tools/tooltool.py', 03:50:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:50:04 INFO - '/tools/misc-python/virtualenv.py')}, 03:50:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:50:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:50:04 INFO - 'gecko_profile': False, 03:50:04 INFO - 'gecko_profile_interval': 0, 03:50:04 INFO - 'installer_path': 'installer.exe', 03:50:04 INFO - 'log_level': 'info', 03:50:04 INFO - 'log_name': 'talos', 03:50:04 INFO - 'log_to_console': True, 03:50:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:50:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:50:04 INFO - 'opt_config_files': (), 03:50:04 INFO - 'pip_index': False, 03:50:04 INFO - 'suite': 'dromaeojs-e10s', 03:50:04 INFO - 'system_bits': '32', 03:50:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:50:04 INFO - 'title': 'talos-linux64-ix-003', 03:50:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:50:04 INFO - 'use_talos_json': True, 03:50:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:50:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:50:04 INFO - 'work_dir': 'build'} 03:50:04 INFO - [mozharness: 2017-08-14 10:50:04.653058Z] Running clobber step. 03:50:04 INFO - Running pre-action listener: _resource_record_pre_action 03:50:04 INFO - Running main action method: clobber 03:50:04 INFO - rmtree: /builds/slave/test/build 03:50:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:50:05 INFO - Running post-action listener: _resource_record_post_action 03:50:05 INFO - [mozharness: 2017-08-14 10:50:05.666854Z] Finished clobber step (success) 03:50:05 INFO - [mozharness: 2017-08-14 10:50:05.666956Z] Running read-buildbot-config step. 03:50:05 INFO - Running pre-action listener: _resource_record_pre_action 03:50:05 INFO - Running main action method: read_buildbot_config 03:50:05 INFO - Using buildbot properties: 03:50:05 INFO - { 03:50:05 INFO - "project": "", 03:50:05 INFO - "product": "firefox", 03:50:05 INFO - "who": "archaeopteryx@coole-files.de", 03:50:05 INFO - "installer_path": "public/build/target.tar.bz2", 03:50:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:50:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:50:05 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:50:05 INFO - "stage_platform": "linux64-stylosequential", 03:50:05 INFO - "basedir": "/builds/slave/test", 03:50:05 INFO - "buildnumber": 30, 03:50:05 INFO - "platform": "ubuntu64_hw_styloseq", 03:50:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:50:05 INFO - "slavebuilddir": "test", 03:50:05 INFO - "taskId": "Tge6ZbZ_Qmyns_q84jzfQw", 03:50:05 INFO - "branch": "mozilla-central", 03:50:05 INFO - "script_repo_revision": "production", 03:50:05 INFO - "revision": "df9beb781895fcd0493c21e95ad313e0044515ec", 03:50:05 INFO - "slavename": "talos-linux64-ix-003", 03:50:05 INFO - "repo_path": "mozilla-central" 03:50:05 INFO - } 03:50:05 INFO - Finding installer, test and symbols from parent task. 03:50:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tge6ZbZ_Qmyns_q84jzfQw'}, attempt #1 03:50:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tge6ZbZ_Qmyns_q84jzfQw'}, attempt #1 03:50:06 INFO - Task dependencies: a-GT4NhbSgyPIRge8EWYUw 03:50:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw'}, attempt #1 03:50:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2 03:50:07 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.test_packages.json 03:50:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.crashreporter-symbols.zip 03:50:07 INFO - Running post-action listener: _resource_record_post_action 03:50:07 INFO - [mozharness: 2017-08-14 10:50:07.026882Z] Finished read-buildbot-config step (success) 03:50:07 INFO - [mozharness: 2017-08-14 10:50:07.027103Z] Running download-and-extract step. 03:50:07 INFO - Running pre-action listener: _resource_record_pre_action 03:50:07 INFO - Running main action method: download_and_extract 03:50:07 INFO - mkdir: /builds/slave/test/build/tests 03:50:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:07 INFO - trying https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.test_packages.json 03:50:07 INFO - Downloading https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:50:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:50:07 INFO - Downloaded 989 bytes. 03:50:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:50:07 INFO - Using the following test package requirements: 03:50:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:50:07 INFO - u'common': [u'target.common.tests.zip'], 03:50:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:50:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:50:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:50:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:50:07 INFO - u'mozbase': [u'target.common.tests.zip'], 03:50:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:50:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:50:07 INFO - u'web-platform': [u'target.common.tests.zip', 03:50:07 INFO - u'target.web-platform.tests.tar.gz'], 03:50:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:50:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:50:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.common.tests.zip 03:50:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:50:07 INFO - Fetch https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.common.tests.zip into memory 03:50:08 INFO - Content-Length response header: 54034603 03:50:08 INFO - Bytes received: 54034603 03:50:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:50:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.common.tests.zip 03:50:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:50:19 INFO - Fetch https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.common.tests.zip into memory 03:50:20 INFO - Content-Length response header: 54034603 03:50:20 INFO - Bytes received: 54034603 03:50:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.talos.tests.zip 03:50:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:50:35 INFO - Fetch https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.talos.tests.zip into memory 03:50:36 INFO - Content-Length response header: 14496050 03:50:36 INFO - Bytes received: 14496050 03:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:36 INFO - trying https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2 03:50:36 INFO - Downloading https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:50:37 INFO - Downloaded 61800762 bytes. 03:50:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2 03:50:37 INFO - mkdir: /builds/slave/test/properties 03:50:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:50:37 INFO - Writing to file /builds/slave/test/properties/build_url 03:50:37 INFO - Contents: 03:50:37 INFO - build_url:https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2 03:50:37 INFO - Running post-action listener: _resource_record_post_action 03:50:37 INFO - Running post-action listener: set_extra_try_arguments 03:50:37 INFO - [mozharness: 2017-08-14 10:50:37.467340Z] Finished download-and-extract step (success) 03:50:37 INFO - [mozharness: 2017-08-14 10:50:37.467439Z] Running populate-webroot step. 03:50:37 INFO - Running pre-action listener: _resource_record_pre_action 03:50:37 INFO - Running main action method: populate_webroot 03:50:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:50:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:50:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:50:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:50:37 INFO - 'tests': ['damp', 'tps']}, 03:50:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:50:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:50:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:50:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:50:37 INFO - 'other-e10s': {'tests': ['a11yr', 03:50:37 INFO - 'ts_paint', 03:50:37 INFO - 'tpaint', 03:50:37 INFO - 'sessionrestore', 03:50:37 INFO - 'sessionrestore_many_windows', 03:50:37 INFO - 'sessionrestore_no_auto_restore', 03:50:37 INFO - 'tabpaint']}, 03:50:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:50:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:50:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:50:37 INFO - 'tsvgr_opacity', 03:50:37 INFO - 'tart', 03:50:37 INFO - 'tscrollx', 03:50:37 INFO - 'tsvg_static']}, 03:50:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:50:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:50:37 INFO - 'talos_options': ['--mitmproxy', 03:50:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:50:37 INFO - '--firstNonBlankPaint'], 03:50:37 INFO - 'tests': ['tp6_google', 03:50:37 INFO - 'tp6_youtube', 03:50:37 INFO - 'tp6_amazon', 03:50:37 INFO - 'tp6_facebook']}, 03:50:37 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:50:37 INFO - 'talos_options': ['--stylo', 03:50:37 INFO - '--mitmproxy', 03:50:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:50:37 INFO - '--firstNonBlankPaint'], 03:50:37 INFO - 'tests': ['tp6_google', 03:50:37 INFO - 'tp6_youtube', 03:50:37 INFO - 'tp6_amazon', 03:50:37 INFO - 'tp6_facebook']}, 03:50:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:50:37 INFO - 'talos_options': ['--stylo', 03:50:37 INFO - '--stylo-threads=1', 03:50:37 INFO - '--mitmproxy', 03:50:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:50:37 INFO - '--firstNonBlankPaint'], 03:50:37 INFO - 'tests': ['tp6_google', 03:50:37 INFO - 'tp6_youtube', 03:50:37 INFO - 'tp6_amazon', 03:50:37 INFO - 'tp6_facebook']}, 03:50:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:50:37 INFO - 'talos_options': ['--xperf_path', 03:50:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:37 INFO - 'tests': ['tp5n']}}} 03:50:37 INFO - Running post-action listener: _resource_record_post_action 03:50:37 INFO - [mozharness: 2017-08-14 10:50:37.475883Z] Finished populate-webroot step (success) 03:50:37 INFO - [mozharness: 2017-08-14 10:50:37.475975Z] Running create-virtualenv step. 03:50:37 INFO - Running pre-action listener: _resource_record_pre_action 03:50:37 INFO - Running main action method: create_virtualenv 03:50:37 INFO - Creating virtualenv /builds/slave/test/build/venv 03:50:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:50:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:50:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:50:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:50:37 INFO - Using real prefix '/usr' 03:50:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:50:38 INFO - Installing distribute.............................................................................................................................................................................................done. 03:50:40 INFO - Installing pip.................done. 03:50:40 INFO - Return code: 0 03:50:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:50:40 INFO - Reading from file tmpfile_stdout 03:50:40 INFO - Output received: 03:50:40 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:50:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:40 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 0x12bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1488a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16288a0>, '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 0x16297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1629c30>, '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': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:50:40 INFO - Using env: {'DISPLAY': ':0', 03:50:40 INFO - 'HOME': '/home/cltbld', 03:50:40 INFO - 'LANG': 'en_US.UTF-8', 03:50:40 INFO - 'LANGUAGE': 'en_US:en', 03:50:40 INFO - 'LOGNAME': 'cltbld', 03:50:40 INFO - 'MAIL': '/var/mail/cltbld', 03:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:40 INFO - 'MOZ_NO_REMOTE': '1', 03:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:40 INFO - 'NO_EM_RESTART': '1', 03:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:40 INFO - 'PWD': '/builds/slave/test', 03:50:40 INFO - 'SHELL': '/bin/bash', 03:50:40 INFO - 'SHLVL': '1', 03:50:40 INFO - 'TERM': 'linux', 03:50:40 INFO - 'TMOUT': '86400', 03:50:40 INFO - 'USER': 'cltbld', 03:50:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 03:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:40 INFO - '_': '/tools/buildbot/bin/python'} 03:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:50:40 INFO - Cleaning up... 03:50:40 INFO - Return code: 0 03:50:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:40 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 0x12bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1488a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16288a0>, '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 0x16297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1629c30>, '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': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:50:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:50:40 INFO - Using env: {'DISPLAY': ':0', 03:50:40 INFO - 'HOME': '/home/cltbld', 03:50:40 INFO - 'LANG': 'en_US.UTF-8', 03:50:40 INFO - 'LANGUAGE': 'en_US:en', 03:50:40 INFO - 'LOGNAME': 'cltbld', 03:50:40 INFO - 'MAIL': '/var/mail/cltbld', 03:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:40 INFO - 'MOZ_NO_REMOTE': '1', 03:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:40 INFO - 'NO_EM_RESTART': '1', 03:50:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:40 INFO - 'PWD': '/builds/slave/test', 03:50:40 INFO - 'SHELL': '/bin/bash', 03:50:40 INFO - 'SHLVL': '1', 03:50:40 INFO - 'TERM': 'linux', 03:50:40 INFO - 'TMOUT': '86400', 03:50:40 INFO - 'USER': 'cltbld', 03:50:40 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 03:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:40 INFO - '_': '/tools/buildbot/bin/python'} 03:50:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:40 INFO - Downloading/unpacking psutil>=3.1.1 03:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:50:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:41 INFO - Installing collected packages: psutil 03:50:41 INFO - Running setup.py install for psutil 03:50:42 INFO - building 'psutil._psutil_linux' extension 03:50:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:50:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:50:42 INFO - building 'psutil._psutil_posix' extension 03:50:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:50:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:50:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:42 INFO - Successfully installed psutil 03:50:42 INFO - Cleaning up... 03:50:42 INFO - Return code: 0 03:50:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:42 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 0x12bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1488a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16288a0>, '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 0x16297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1629c30>, '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': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:50:42 INFO - Using env: {'DISPLAY': ':0', 03:50:42 INFO - 'HOME': '/home/cltbld', 03:50:42 INFO - 'LANG': 'en_US.UTF-8', 03:50:42 INFO - 'LANGUAGE': 'en_US:en', 03:50:42 INFO - 'LOGNAME': 'cltbld', 03:50:42 INFO - 'MAIL': '/var/mail/cltbld', 03:50:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:42 INFO - 'MOZ_NO_REMOTE': '1', 03:50:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:42 INFO - 'NO_EM_RESTART': '1', 03:50:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:42 INFO - 'PWD': '/builds/slave/test', 03:50:42 INFO - 'SHELL': '/bin/bash', 03:50:42 INFO - 'SHLVL': '1', 03:50:42 INFO - 'TERM': 'linux', 03:50:42 INFO - 'TMOUT': '86400', 03:50:42 INFO - 'USER': 'cltbld', 03:50:42 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 03:50:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:42 INFO - '_': '/tools/buildbot/bin/python'} 03:50:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:50:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:50:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:50:43 INFO - Installing collected packages: mozsystemmonitor 03:50:43 INFO - Running setup.py install for mozsystemmonitor 03:50:43 INFO - Successfully installed mozsystemmonitor 03:50:43 INFO - Cleaning up... 03:50:43 INFO - Return code: 0 03:50:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1488a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16288a0>, '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 0x16297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1629c30>, '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': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:50:43 INFO - Using env: {'DISPLAY': ':0', 03:50:43 INFO - 'HOME': '/home/cltbld', 03:50:43 INFO - 'LANG': 'en_US.UTF-8', 03:50:43 INFO - 'LANGUAGE': 'en_US:en', 03:50:43 INFO - 'LOGNAME': 'cltbld', 03:50:43 INFO - 'MAIL': '/var/mail/cltbld', 03:50:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:43 INFO - 'MOZ_NO_REMOTE': '1', 03:50:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:43 INFO - 'NO_EM_RESTART': '1', 03:50:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:43 INFO - 'PWD': '/builds/slave/test', 03:50:43 INFO - 'SHELL': '/bin/bash', 03:50:43 INFO - 'SHLVL': '1', 03:50:43 INFO - 'TERM': 'linux', 03:50:43 INFO - 'TMOUT': '86400', 03:50:43 INFO - 'USER': 'cltbld', 03:50:43 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 03:50:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:43 INFO - '_': '/tools/buildbot/bin/python'} 03:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:44 INFO - Downloading/unpacking jsonschema==2.5.1 03:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:50:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:45 INFO - Downloading functools32-3.2.3-2.tar.gz 03:50:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:50:45 INFO - warning: no files found matching '*.txt' 03:50:45 INFO - no previously-included directories found matching 'build' 03:50:45 INFO - no previously-included directories found matching 'dist' 03:50:45 INFO - no previously-included directories found matching '.git*' 03:50:45 INFO - Installing collected packages: jsonschema, functools32 03:50:45 INFO - Running setup.py install for functools32 03:50:45 INFO - warning: no files found matching '*.txt' 03:50:45 INFO - no previously-included directories found matching 'build' 03:50:45 INFO - no previously-included directories found matching 'dist' 03:50:45 INFO - no previously-included directories found matching '.git*' 03:50:45 INFO - Successfully installed jsonschema functools32 03:50:45 INFO - Cleaning up... 03:50:45 INFO - Return code: 0 03:50:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:45 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 0x12bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1488a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16288a0>, '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 0x16297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1629c30>, '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': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:50:45 INFO - Using env: {'DISPLAY': ':0', 03:50:45 INFO - 'HOME': '/home/cltbld', 03:50:45 INFO - 'LANG': 'en_US.UTF-8', 03:50:45 INFO - 'LANGUAGE': 'en_US:en', 03:50:45 INFO - 'LOGNAME': 'cltbld', 03:50:45 INFO - 'MAIL': '/var/mail/cltbld', 03:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:45 INFO - 'MOZ_NO_REMOTE': '1', 03:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:45 INFO - 'NO_EM_RESTART': '1', 03:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:45 INFO - 'PWD': '/builds/slave/test', 03:50:45 INFO - 'SHELL': '/bin/bash', 03:50:45 INFO - 'SHLVL': '1', 03:50:45 INFO - 'TERM': 'linux', 03:50:45 INFO - 'TMOUT': '86400', 03:50:45 INFO - 'USER': 'cltbld', 03:50:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 03:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:45 INFO - '_': '/tools/buildbot/bin/python'} 03:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:50:45 INFO - Cleaning up... 03:50:45 INFO - Return code: 0 03:50:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:45 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 0x12bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1488a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16288a0>, '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 0x16297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1629c30>, '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': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:50:45 INFO - Using env: {'DISPLAY': ':0', 03:50:45 INFO - 'HOME': '/home/cltbld', 03:50:45 INFO - 'LANG': 'en_US.UTF-8', 03:50:45 INFO - 'LANGUAGE': 'en_US:en', 03:50:45 INFO - 'LOGNAME': 'cltbld', 03:50:45 INFO - 'MAIL': '/var/mail/cltbld', 03:50:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:45 INFO - 'MOZ_NO_REMOTE': '1', 03:50:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:45 INFO - 'NO_EM_RESTART': '1', 03:50:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:45 INFO - 'PWD': '/builds/slave/test', 03:50:45 INFO - 'SHELL': '/bin/bash', 03:50:45 INFO - 'SHLVL': '1', 03:50:45 INFO - 'TERM': 'linux', 03:50:45 INFO - 'TMOUT': '86400', 03:50:45 INFO - 'USER': 'cltbld', 03:50:45 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 03:50:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:45 INFO - '_': '/tools/buildbot/bin/python'} 03:50:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:46 INFO - Downloading/unpacking blobuploader==1.2.4 03:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:47 INFO - Downloading blobuploader-1.2.4.tar.gz 03:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:50:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:50:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:47 INFO - Downloading docopt-0.6.1.tar.gz 03:50:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:50:47 INFO - Installing collected packages: blobuploader, requests, docopt 03:50:47 INFO - Running setup.py install for blobuploader 03:50:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:50:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:50:48 INFO - Running setup.py install for requests 03:50:48 INFO - Running setup.py install for docopt 03:50:48 INFO - Successfully installed blobuploader requests docopt 03:50:48 INFO - Cleaning up... 03:50:48 INFO - Return code: 0 03:50:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:48 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 0x12bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1488a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16288a0>, '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 0x16297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1629c30>, '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': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:50:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:50:48 INFO - Using env: {'DISPLAY': ':0', 03:50:48 INFO - 'HOME': '/home/cltbld', 03:50:48 INFO - 'LANG': 'en_US.UTF-8', 03:50:48 INFO - 'LANGUAGE': 'en_US:en', 03:50:48 INFO - 'LOGNAME': 'cltbld', 03:50:48 INFO - 'MAIL': '/var/mail/cltbld', 03:50:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:48 INFO - 'MOZ_NO_REMOTE': '1', 03:50:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:48 INFO - 'NO_EM_RESTART': '1', 03:50:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:48 INFO - 'PWD': '/builds/slave/test', 03:50:48 INFO - 'SHELL': '/bin/bash', 03:50:48 INFO - 'SHLVL': '1', 03:50:48 INFO - 'TERM': 'linux', 03:50:48 INFO - 'TMOUT': '86400', 03:50:48 INFO - 'USER': 'cltbld', 03:50:48 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 03:50:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:48 INFO - '_': '/tools/buildbot/bin/python'} 03:50:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:48 INFO - Running setup.py (path:/tmp/pip-pjVF8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:48 INFO - Running setup.py (path:/tmp/pip-4NH56F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:48 INFO - Running setup.py (path:/tmp/pip-jYDstj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:48 INFO - Running setup.py (path:/tmp/pip-1JZqiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:49 INFO - Running setup.py (path:/tmp/pip-buABnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:49 INFO - Running setup.py (path:/tmp/pip-7yljge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:49 INFO - Running setup.py (path:/tmp/pip-MpfPd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:49 INFO - Running setup.py (path:/tmp/pip-VafDr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:49 INFO - Running setup.py (path:/tmp/pip-bFnpaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:49 INFO - Running setup.py (path:/tmp/pip-JZl__O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:49 INFO - Running setup.py (path:/tmp/pip-8RmvIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:49 INFO - Running setup.py (path:/tmp/pip-5YWNGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:49 INFO - Running setup.py (path:/tmp/pip-L95sOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:49 INFO - Running setup.py (path:/tmp/pip-bCpOmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:49 INFO - Running setup.py (path:/tmp/pip-XrCzyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:49 INFO - Running setup.py (path:/tmp/pip-yzkc8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:49 INFO - Running setup.py (path:/tmp/pip-DPPg1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:50:49 INFO - Running setup.py install for manifestparser 03:50:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Running setup.py install for mozcrash 03:50:50 INFO - Running setup.py install for mozdebug 03:50:50 INFO - Running setup.py install for mozdevice 03:50:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Running setup.py install for mozfile 03:50:50 INFO - Running setup.py install for mozhttpd 03:50:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Running setup.py install for mozinfo 03:50:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Running setup.py install for mozInstall 03:50:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Running setup.py install for mozleak 03:50:50 INFO - Running setup.py install for mozlog 03:50:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:50:50 INFO - Running setup.py install for moznetwork 03:50:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:50:51 INFO - Running setup.py install for mozprocess 03:50:51 INFO - Running setup.py install for mozprofile 03:50:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:50:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:50:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:50:51 INFO - Running setup.py install for mozrunner 03:50:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:50:51 INFO - Running setup.py install for mozscreenshot 03:50:51 INFO - Running setup.py install for moztest 03:50:51 INFO - Running setup.py install for mozversion 03:50:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:50:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:50:51 INFO - Cleaning up... 03:50:51 INFO - Return code: 0 03:50:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:51 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 0x12bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1488a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16288a0>, '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 0x16297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1629c30>, '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': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:50:51 INFO - Using env: {'DISPLAY': ':0', 03:50:51 INFO - 'HOME': '/home/cltbld', 03:50:51 INFO - 'LANG': 'en_US.UTF-8', 03:50:51 INFO - 'LANGUAGE': 'en_US:en', 03:50:51 INFO - 'LOGNAME': 'cltbld', 03:50:51 INFO - 'MAIL': '/var/mail/cltbld', 03:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:51 INFO - 'MOZ_NO_REMOTE': '1', 03:50:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:51 INFO - 'NO_EM_RESTART': '1', 03:50:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:51 INFO - 'PWD': '/builds/slave/test', 03:50:51 INFO - 'SHELL': '/bin/bash', 03:50:51 INFO - 'SHLVL': '1', 03:50:51 INFO - 'TERM': 'linux', 03:50:51 INFO - 'TMOUT': '86400', 03:50:51 INFO - 'USER': 'cltbld', 03:50:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 03:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:51 INFO - '_': '/tools/buildbot/bin/python'} 03:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:51 INFO - Running setup.py (path:/tmp/pip-A8f8gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:52 INFO - Running setup.py (path:/tmp/pip-yyd8CM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:52 INFO - Running setup.py (path:/tmp/pip-5XikC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:52 INFO - Running setup.py (path:/tmp/pip-W14ske-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:52 INFO - Running setup.py (path:/tmp/pip-Cd13UO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:52 INFO - Running setup.py (path:/tmp/pip-fQqIcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:52 INFO - Running setup.py (path:/tmp/pip-CKCu9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:52 INFO - Running setup.py (path:/tmp/pip-26pfdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:52 INFO - Running setup.py (path:/tmp/pip-Mp_JIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:52 INFO - Running setup.py (path:/tmp/pip-LLQZ6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:52 INFO - Running setup.py (path:/tmp/pip-pFKeSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:52 INFO - Running setup.py (path:/tmp/pip-H8leD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:52 INFO - Running setup.py (path:/tmp/pip-KsPu80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:52 INFO - Running setup.py (path:/tmp/pip-aZIB8n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:50:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:52 INFO - Running setup.py (path:/tmp/pip-cPv42d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:53 INFO - Running setup.py (path:/tmp/pip-RuGesk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:50:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:53 INFO - Running setup.py (path:/tmp/pip-2GXTMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:50:53 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:50:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:50: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 03:50: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 03:50: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 03:50: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 03:50:54 INFO - Downloading blessings-1.6.tar.gz 03:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:50:54 INFO - Installing collected packages: blessings 03:50:54 INFO - Running setup.py install for blessings 03:50:54 INFO - Successfully installed blessings 03:50:54 INFO - Cleaning up... 03:50:54 INFO - Return code: 0 03:50:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:50:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:54 INFO - Reading from file tmpfile_stdout 03:50:54 INFO - Current package versions: 03:50:54 INFO - argparse == 1.2.1 03:50:54 INFO - blessings == 1.6 03:50:54 INFO - blobuploader == 1.2.4 03:50:54 INFO - docopt == 0.6.1 03:50:54 INFO - functools32 == 3.2.3-2 03:50:54 INFO - jsonschema == 2.5.1 03:50:54 INFO - manifestparser == 1.1 03:50:54 INFO - mozInstall == 1.13 03:50:54 INFO - mozcrash == 1.0 03:50:54 INFO - mozdebug == 0.1 03:50:54 INFO - mozdevice == 0.51 03:50:54 INFO - mozfile == 1.2 03:50:54 INFO - mozhttpd == 0.7 03:50:54 INFO - mozinfo == 0.10 03:50:54 INFO - mozleak == 0.1 03:50:54 INFO - mozlog == 3.5 03:50:54 INFO - moznetwork == 0.27 03:50:54 INFO - mozprocess == 0.25 03:50:54 INFO - mozprofile == 0.28 03:50:54 INFO - mozrunner == 6.13 03:50:54 INFO - mozscreenshot == 0.1 03:50:54 INFO - mozsystemmonitor == 0.3 03:50:54 INFO - moztest == 0.8 03:50:54 INFO - mozversion == 1.4 03:50:54 INFO - psutil == 3.1.1 03:50:54 INFO - requests == 1.2.3 03:50:54 INFO - wsgiref == 0.1.2 03:50:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:54 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 0x12bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1488a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16288a0>, '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 0x16297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1629c30>, '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': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:50:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:50:54 INFO - Using env: {'DISPLAY': ':0', 03:50:54 INFO - 'HOME': '/home/cltbld', 03:50:54 INFO - 'LANG': 'en_US.UTF-8', 03:50:54 INFO - 'LANGUAGE': 'en_US:en', 03:50:54 INFO - 'LOGNAME': 'cltbld', 03:50:54 INFO - 'MAIL': '/var/mail/cltbld', 03:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:54 INFO - 'MOZ_NO_REMOTE': '1', 03:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:54 INFO - 'NO_EM_RESTART': '1', 03:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:54 INFO - 'PWD': '/builds/slave/test', 03:50:54 INFO - 'SHELL': '/bin/bash', 03:50:54 INFO - 'SHLVL': '1', 03:50:54 INFO - 'TERM': 'linux', 03:50:54 INFO - 'TMOUT': '86400', 03:50:54 INFO - 'USER': 'cltbld', 03:50:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 03:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:54 INFO - '_': '/tools/buildbot/bin/python'} 03:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:50:54 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:50:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:50:56 INFO - Installing collected packages: simplejson 03:50:56 INFO - Running setup.py install for simplejson 03:50:56 INFO - building 'simplejson._speedups' extension 03:50:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:50:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:50:57 INFO - Successfully installed simplejson 03:50:57 INFO - Cleaning up... 03:50:57 INFO - Return code: 0 03:50:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12bc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1488a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162b700>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16288a0>, '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 0x16297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1629c30>, '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': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:50:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:50:57 INFO - Using env: {'DISPLAY': ':0', 03:50:57 INFO - 'HOME': '/home/cltbld', 03:50:57 INFO - 'LANG': 'en_US.UTF-8', 03:50:57 INFO - 'LANGUAGE': 'en_US:en', 03:50:57 INFO - 'LOGNAME': 'cltbld', 03:50:57 INFO - 'MAIL': '/var/mail/cltbld', 03:50:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:57 INFO - 'MOZ_NO_REMOTE': '1', 03:50:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:50:57 INFO - 'NO_EM_RESTART': '1', 03:50:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:50:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:57 INFO - 'PWD': '/builds/slave/test', 03:50:57 INFO - 'SHELL': '/bin/bash', 03:50:57 INFO - 'SHLVL': '1', 03:50:57 INFO - 'TERM': 'linux', 03:50:57 INFO - 'TMOUT': '86400', 03:50:57 INFO - 'USER': 'cltbld', 03:50:57 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 03:50:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:57 INFO - '_': '/tools/buildbot/bin/python'} 03:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:50:57 INFO - Cleaning up... 03:50:57 INFO - Return code: 0 03:50:57 INFO - Running post-action listener: _resource_record_post_action 03:50:57 INFO - Running post-action listener: _start_resource_monitoring 03:50:57 INFO - Starting resource monitoring. 03:50:57 INFO - [mozharness: 2017-08-14 10:50:57.434021Z] Finished create-virtualenv step (success) 03:50:57 INFO - [mozharness: 2017-08-14 10:50:57.434535Z] Running install step. 03:50:57 INFO - Running pre-action listener: _resource_record_pre_action 03:50:57 INFO - Running main action method: install 03:50:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:57 INFO - Reading from file tmpfile_stdout 03:50:57 INFO - Detecting whether we're running mozinstall >=1.0... 03:50:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:50:57 INFO - Reading from file tmpfile_stdout 03:50:57 INFO - Output received: 03:50:57 INFO - Usage: mozinstall [options] installer 03:50:57 INFO - Options: 03:50:57 INFO - -h, --help show this help message and exit 03:50:57 INFO - -d DEST, --destination=DEST 03:50:57 INFO - Directory to install application into. [default: 03:50:57 INFO - "/builds/slave/test"] 03:50:57 INFO - --app=APP Application being installed. [default: firefox] 03:50:57 INFO - mkdir: /builds/slave/test/build/application 03:50:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:50:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:51:15 INFO - Reading from file tmpfile_stdout 03:51:15 INFO - Output received: 03:51:15 INFO - /builds/slave/test/build/application/firefox/firefox 03:51:15 INFO - Running post-action listener: _resource_record_post_action 03:51:15 INFO - [mozharness: 2017-08-14 10:51:15.747968Z] Finished install step (success) 03:51:15 INFO - [mozharness: 2017-08-14 10:51:15.748231Z] Running setup-mitmproxy step. 03:51:15 INFO - Running pre-action listener: _resource_record_pre_action 03:51:15 INFO - Running main action method: setup_mitmproxy 03:51:15 INFO - Skipping: mitmproxy is not required 03:51:15 INFO - Running post-action listener: _resource_record_post_action 03:51:15 INFO - [mozharness: 2017-08-14 10:51:15.749378Z] Finished setup-mitmproxy step (success) 03:51:15 INFO - [mozharness: 2017-08-14 10:51:15.749603Z] Running run-tests step. 03:51:15 INFO - Running pre-action listener: _resource_record_pre_action 03:51:15 INFO - Running pre-action listener: _set_gcov_prefix 03:51:15 INFO - Running main action method: run_tests 03:51:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:51:15 INFO - Python 2.7.3 03:51:15 INFO - Return code: 0 03:51:15 INFO - grabbing minidump binary from tooltool 03:51:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:15 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 0x16288a0>, '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 0x16297a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1629c30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:51:15 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:51:15 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:51:15 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:51:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:15 INFO - Return code: 0 03:51:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:51:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:51:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:51:15 INFO - ENV: RUST_BACKTRACE is now full 03:51:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:51:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:51:15 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/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:51:15 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/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:51:15 INFO - Using env: {'DISPLAY': ':0', 03:51:15 INFO - 'HOME': '/home/cltbld', 03:51:15 INFO - 'LANG': 'en_US.UTF-8', 03:51:15 INFO - 'LANGUAGE': 'en_US:en', 03:51:15 INFO - 'LOGNAME': 'cltbld', 03:51:15 INFO - 'MAIL': '/var/mail/cltbld', 03:51:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:15 INFO - 'MOZ_NO_REMOTE': '1', 03:51:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:51:15 INFO - 'NO_EM_RESTART': '1', 03:51:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:15 INFO - 'PWD': '/builds/slave/test', 03:51:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:15 INFO - 'RUST_BACKTRACE': 'full', 03:51:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:51:15 INFO - 'SHELL': '/bin/bash', 03:51:15 INFO - 'SHLVL': '1', 03:51:15 INFO - 'STYLO_FORCE_ENABLED': '1', 03:51:15 INFO - 'TERM': 'linux', 03:51:15 INFO - 'TMOUT': '86400', 03:51:15 INFO - 'USER': 'cltbld', 03:51:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1502705859.724837-544757484', 03:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:15 INFO - '_': '/tools/buildbot/bin/python'} 03:51:15 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/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:51:16 INFO - mozversion application_buildid: 20170814095736 03:51:16 INFO - mozversion application_changeset: df9beb781895fcd0493c21e95ad313e0044515ec 03:51:16 INFO - mozversion application_display_name: Nightly 03:51:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:16 INFO - mozversion application_name: Firefox 03:51:16 INFO - mozversion application_remotingname: firefox 03:51:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:51:16 INFO - mozversion application_vendor: Mozilla 03:51:16 INFO - mozversion application_version: 57.0a1 03:51:16 INFO - mozversion platform_buildid: 20170814095736 03:51:16 INFO - mozversion platform_changeset: df9beb781895fcd0493c21e95ad313e0044515ec 03:51:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:51:16 INFO - mozversion platform_version: 57.0a1 03:51:16 INFO - using testdate: 1502707876 03:51:16 INFO - actual date: 1502707876 03:51:16 INFO - starting webserver on 'localhost:42586' 03:51:16 INFO - SUITE-START | Running 2 tests 03:51:16 INFO - TEST-START | dromaeo_css 03:51:16 INFO - Initialising browser for dromaeo_css test... 03:51:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42586/getInfo.html -profile /tmp/tmpCy_6Z4/profile 03:51:16 INFO - TEST-INFO | started process 14286 (/builds/slave/test/build/application/firefox/firefox http://localhost:42586/getInfo.html) 03:51:21 INFO - TEST-INFO | 14286: exit 0 03:51:21 INFO - Browser initialized. 03:51:21 INFO - Running cycle 1/1 for dromaeo_css test... 03:51:21 INFO - TEST-INFO | started process 14521 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCy_6Z4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:22 INFO - PID 14521 | 03:51:22 INFO - PID 14521 | (/builds/slave/test/build/application/firefox/firefox:14576): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:51:22 INFO - PID 14521 | 03:51:33 INFO - PID 14521 | RSS: Main: 167870464 03:51:33 INFO - PID 14521 | 03:54:33 INFO - PID 14521 | Cycle 1(1): loaded http://localhost:42586/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42586/tests/dromaeo/cssquery-ext.html) 03:54:34 INFO - PID 14521 | RSS: Main: 175177728 03:54:34 INFO - PID 14521 | 03:57:36 INFO - PID 14521 | Cycle 1(1): loaded http://localhost:42586/tests/dromaeo/cssquery-ext.html (next: http://localhost:42586/tests/dromaeo/cssquery-jquery.html) 03:57:36 INFO - PID 14521 | RSS: Main: 173080576 03:57:36 INFO - PID 14521 | 04:00:38 INFO - PID 14521 | Cycle 1(1): loaded http://localhost:42586/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42586/tests/dromaeo/cssquery-mootools.html) 04:00:39 INFO - PID 14521 | RSS: Main: 174796800 04:00:39 INFO - PID 14521 | 04:03:41 INFO - PID 14521 | Cycle 1(1): loaded http://localhost:42586/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42586/tests/dromaeo/cssquery-prototype.html) 04:03:41 INFO - PID 14521 | RSS: Main: 173273088 04:03:41 INFO - PID 14521 | 04:06:45 INFO - PID 14521 | Cycle 1(1): loaded http://localhost:42586/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42586/tests/dromaeo/cssquery-yui.html) 04:06:45 INFO - PID 14521 | RSS: Main: 176693248 04:06:45 INFO - PID 14521 | 04:09:47 INFO - PID 14521 | Cycle 1(1): loaded http://localhost:42586/tests/dromaeo/cssquery-yui.html (next: http://localhost:42586/tests/dromaeo/cssquery-dojo.html) 04:09:47 INFO - PID 14521 | RSS: Main: 177643520 04:09:47 INFO - PID 14521 | 04:09:47 INFO - PID 14521 | __start_tp_report 04:09:47 INFO - PID 14521 | _x_x_mozilla_page_load 04:09:47 INFO - PID 14521 | _x_x_mozilla_page_load_details 04:09:47 INFO - PID 14521 | |i|pagename|runs| 04:09:47 INFO - PID 14521 | |0;dojo.html;3156.210947263184;3180.904572862815;3205.2627895584014;3211.598550181228;3221.0980925340914;6099.969500152493;6159.3224745277985;6179.505639548836;6189.257289125311;6255.374462553742;6182.938170618292;6210.254769427664;6254.655993920333;6257.687115644211;6275.4038366355235;5639.323281206251;5653.293338332708;5657.57568182388;5687.459691329317;5762.53899688026;5738;5747.425257474261;5748.482636562709;5762.366139724627;5765.971170144144;5687.800926967557;5766.711664416784;5772.913406298909;5800.216970708963;5802.245708057946;5466.781328746845;5580.386157522669;5629.043062679313;5661.405552416978;5760.8271751847515;5240.082985477527;5573.359063707685;5580.832575022756;5672.631278966854;5678.971605141989;5990.5507086968655;6057.485113765291;6120.418560236815;6127.969360153171;6149.262088549358;6563.3108523604815;6614.173228346457;6652.301508341651;6663.700133494004;6695.966520167417;6612.636305003223;6617.106690596756;6618.7021584028835;6627.469802415843;6650.4679625630315;6097.512199024068;6100.267967843843;6104.481119104837;6106.358832322587;6114.663693496811;6715.630640314829;6717.462602991846;6724.7646332378135;6739.865202696017;6743.865122697519;6373.235211774617;6420.165378500765;6541.869162616721;6584.703688334036;6618.271990081087;6667.133272674521;6740.359665831738;6741.056252124707;6741.662916854138;6745.8650826983185;6586.769463068866;6609.537332386687;6618.30507796684;6690.130283063268;6728.125343705287;6443.838904027437;6628.5691430056895;6646.8005959821285;6698.330166983263;6731.562448440934;5360.276362691065;5411.242426060355;5426;5453.827427103191;5464.9453505465235;4565.383673204141;4639.095376401569;4650.720956742606;4672.789724462407;4694.0611877624615;5745.540356771448;5752.712364381848;5752.849430113994;5756.94243057564;5759.568032397587;6598.1422415085735;6612.768553100618;6613.404793568602;6625.469962402996;6641.900371494431;5532.640378375393;5623.775048998076;5664.461876121762;5684.77260909559;5724.8282551523525;5915.40845915405;5966.015607424726;5968.731407086691;5974.103884417372;5991.191189189491;6491.350864913471;6519.445847102955;6581.045748366556;6599.307072757388;6601.042848786899;6583.44040756541;6657.6005439671835;6674.365935236145;6743.055972163803;6765.154355705537;6461.57999730016;6462.127612772216;6467.579607325509;6468.8059358219325;6472.967635161794;6501.804945851632;6536.738530458729;6582.473402127914;6593.868122637617;6613;6597.60414375139;6615.140031795836;6654.767083152066;6715.160604924385;6715.832104197434;6394.296627370893;6410.326915673973;6495.123158373559;6497.707603157964;6508.381703738138;6349.301576826453;6443.7744678936015;6475.967620161869;6498.610083395011;6541.443977261795;6448.5163612730175;6449.258335291502;6456.160699109086;6464.450521705708;6471.449926756279;6468.417842394207;6480.319566445455;6519.706613202512;6522.445592124723;6593.439557637655;6257.155284036597;6296.716647750771;6298.653574053471;6320.178376810985;6341.0805433212845 04:09:47 INFO - PID 14521 | |1;ext.html;823.8764185372194;870.1994165367861;882.0694167653123;886.03422269726;1164.3770582738236;30944.535831962512;31383.68616313836;40714.38928416076;41427;41542.79228603853;41761.373579396335;42146.57853421473;42215.36676949848;42259.78870105653;42296.577034229646;7174.533655312414;7572.129205141397;7660.119086305091;7730.304272615464;7747.72882949094;7562.735304264352;7648.158702542716;7649.770506884803;7675.462717609769;7678.769636910902;7663.655135518887;7681.539107653559;7723.575203363813;7724.9613751931165;7727.6522556484815;7659.540427574336;7662.770116896502;7685.5388676679295;7687.769366919029;7689.807754806175;7543.245675432413;7564.092308922909;7584.772456826304;7590.1650818409935;7610.961945190239;38918.610813891784;39093.609063909564;39114;39153.80423097866;39231.41152882709;3569.3218288525095;3607.7835329880027;3611.2777444511203;3614.765040272374;3618.0231337538717;32415.51376729351;32472.83763581167;32642.510362344583;32684.346313073842;32732.345353092805;4893.584045356149;5122.615803814729;5123.462036486189;5155.7679904404395;5156.871078223075;201366;202307;202577;202634;203110.99999999852;49137.75431122893;49261.75369123203;49319;49353;49433;51484.74257628688;51637.7418112907;51721.48278517242;51812.48187518152;51848.48151518512;16241.431549895697;16420.6715865682;16501.58746031359;16507.257173427224;16571.91714041422;12113.515459381702;12380.876191237972;13128.409221585052;13428.328583570783;13541.1198272112;14108.224047677271;14273.57179284623;14315.856841431661;14345.64135896611;14419.206943618201;5763.221965034667;5821.388754180834;5912.08362703773;5947.286325640865;5983.760649573968;1005.8290090684601;1014.9898501015043;1016.5781200801584;1017.2574020964589;1024.702836177515;23161.652575211385;23205.485750842076;23246.418839529146;23330.53338933212;23527.17654882071;1106.4633652678444;1115;1125.4035361258545;1129.1080046762966;1129.4860838318546;12001.879981200076;12209.450574723982;12302.569410070604;12391.62825115248;12456.81314780279;225029;226845;227073;227223;227482;53604.46395536073;53855.73072134614;53979.19031214535;54342.45657543374;54510.727446362514;1458.3073040305983;1471.4187895781106;1507.5854140111558;1508.6756347385365;1525.6872341170033;22523.32430027102;22662;22749.772502274765;22826.543469130193;22925.426864328525;38383.23233535369;38626.42060369153;38726.41910371403;38760;38840.22319553536;187906;189396;189731;190728;191606;33653.83173084217;34764.47853282253;36377.454338185475;36565.81717091398;36647.63352366442;47024.529754702016;47190;47191.52808471872;47205.52794472011;48381.5161848377;34844.477332839524;34968.475472868435;35206;35489.467657984635;35725.821370892976;34544.82727586346;34767.30465390627;34799.30401392009;34950.30099398048;35439.29121417506;37823.62176378201;37865.81067094647;37918.620813792615;37982.81008594939;38072.42891356577;33983.660163398046;34401.31197375988;34685.826570866986;35066;35782.105447362985;24477.265682028854;24613.87693061523;24698.50602987966;24818.751812481645;25027.749722502544 04:09:47 INFO - PID 14521 | |2;jquery.html;556.780758922832;558.7206396801599;569.1235497334104;573.8565358660333;586.991195132073;22672.659910101363;23341.533169336602;23664.290071297866;23667.881660591695;23696.289111326645;26719.19842404731;27345.04292349768;27396.452070958618;27447.45105097902;27548.586771198447;6662.233843108056;6834.2140653824945;6834.384905358516;6834.624095674761;6839.555428897131;6035.577509574309;6323.114763933053;6542.803715888531;6570.277269500351;6709.9329006709795;6486.805395838109;6540.051692504608;6559.639219842907;6565.34346565342;6565.835854103638;6552.180977377828;6561.901571476432;6562.409383155539;6563.048357988089;6564.770233041844;6101;6105.114758360058;6107.26712794463;6116.694165291718;6117.418845209698;29439.411211775645;29950.101496955125;30150.547741783892;30307.848460757774;30885.536716949264;1874.7937726850037;1917.1564511614984;1922.865399422041;1929.8842069475736;1933.6036112597023;19546.51133721654;20008.79991200084;20054.398368048984;20074.899625501926;20130.597388052305;2411.5900296949562;2413.5776239158254;2466.5930121529927;2478.3804048987754;2501.987490062538;139363;143816;143945;144004;144101;14581.416743330148;14928;14993;15212.543623691306;15654.843451565339;23203.53592928132;23320.53358932812;23328.416789580395;23329.066837326318;24039;10512.369257844553;10559.208059395576;10689.251752377415;10816.945915270373;10885.129189664807;9882.604695812232;9888.318985772436;10016.248781341428;10039.949800250952;10186.643467478603;9305.813883722287;9542.42745435276;9599.376040557341;9626.807463850824;9757.658481953098;2605.1403036997744;2633.934151646186;2750.188694335176;2751.5047291487326;2849.900253491159;980.3039841712464;1009.485162567096;1010.4897027001317;1012.2661070723814;1018.4347687033619;20744.170233190503;20781.58436831285;20790.58418831615;20966.16135354569;21000.264990725558;1037;1060.204846365226;1062.4581463453694;1063.4682658670665;1081.0756802933536;11032.869715582292;11505.309681419141;11606.339815721753;13590.38843252056;14240.786388204186;494226;518631;523513;526516;532740;129506;129597.35201323933;131628;133825;135456.32271838578;1226.6197478781605;1275.7384736129072;1299.564645843653;1302.3097758188176;1308.5943357559188;20722.79277207269;21485.35543933622;21695.891520542296;22015;22317.442063948532;58205.41794582;59742;60173.39826601678;61559.38440615716;61574.38425615687;72511.27488725045;73288.63355683188;73399.26600734139;73458.26541734514;74101;20716.274930377363;21517.892410537846;21605.78394216038;21617.243396481048;21656.458588535414;23458.882705586362;23488.412789680395;23490.647640285068;23614.29157125289;24074.51850963006;18527.53681157928;18676.719849202545;18784;19041;19190;16822.57943551421;17070;17128.743068853728;17289.48131556055;17812.46562603124;18506.44480665582;18987.43037708871;19022;19140.425787226406;19627.31304404339;20671.68992465084;21136.154553817676;21180;21212.15151393927;21237.256696015564;18707.34524291643;18799;18917;18919.716204257224;19069.713954290975 04:09:47 INFO - PID 14521 | |3;mootools.html;1364.3451143451143;1408.5844675820645;1408.985910140899;1419.6734751007268;1439.366678661389;13546.11950223236;14277.857221427783;14281.143131412122;14344.641383965407;14384.856151438482;14130.22283774392;15183.468578599752;15216.619584510392;15220.39118435264;15221.162836044014;2606.1530002749137;2662.4275780707144;2665.546857034299;2665.9200223993216;2667.039865648365;2586.6249393837884;2620.515204687139;2647.8278911870666;2654.190471906068;2654.8008899332626;2549.1587776033866;2566.486702659466;2609.569421045535;2665.133831504759;2672.0514217452815;2534.4677617700304;2552.119518766023;2561.6157576363507;2570.306017375317;2573.29234460523;2478.256523043098;2486.6021436570063;2503.674522312106;2505.924822255335;2509.04656230633;13987.860121398757;14044.859551404457;14188.503402380971;14230.786538201935;14252.287385630678;7280.089988751406;7450.552966822008;7489.550626962399;7494.288042635995;7520.586367749772;4975.577075948549;5045.669857893809;5089.41471730752;5172.120739474299;5175.637705360627;1923.7499125113786;1932.4202739178331;1941.5146213446637;1979.1094007696595;1983.6131954268924;24124;24130.638040429232;24180.516389672284;24265.514689706284;24297.1495997641;6298;6318.147050148171;6379.936200638027;6570.901436478457;6588.505862060365;15541.611459713598;16228.269727862275;16288.185590720417;16517.58706032359;16567.834321656872;7475.0656167979005;7709.190534993857;7720.073591169095;7721.227877212346;7727.92272077272;7096.574205547684;7131.500794944304;7167;7201.099862517185;7215.278472152848;5077.26379674945;5147.124988751922;5214.921776173361;5221.530062294411;5234.685918844805;1469.977950330746;1482.5181815909873;1491.0829839648538;1517.7647464642998;1518.9012714173543;825.859603867344;851.3657325292696;859.9828003439897;868.522312727997;879.7580665316962;6708.597484150967;6775.4240889524945;6780.593164410151;6790.8641827164165;6840.897386539206;658.3876994395258;692.6744430117836;703.145678001231;723.7503061443794;734.7097896331027;4384.693071484965;4515.661325400608;4769.403824521934;4843.927341089887;4871.050145221719;19602.411927641908;19856;20021;20067;20219.494512637302;18866;19682.70475942862;19731.210751570063;19743.506412339808;19880;11140.777184456265;11327.093832493545;11337.319760814213;11359;11415.42922853854;7719.189485103983;7903.091144518454;7972.601369931596;8026.237507436784;8169.55067471271;16833.074180920168;16889;17044.573885652957;17102.230399632295;17709.911450442665;16844.410445634345;17275.395361162802;17292.740608890625;17404.564885877953;17454.040027798084;13112.147710398793;13438.328083595585;13470;13487.32563371847;13487.662808429475;13143;13314.068015239227;13383.665408364479;13427.12723672958;13536.390862411019;10694.358338499715;10755.838662420227;10813.56745730162;10834.891651083388;11149.554017839195;10624.256302059091;10873.945630271797;10944.835827462754;11048.281861678965;11123.833142502706;9413.058694130532;9458.196053335543;9471.526423678926;9472.052794720474;9550.90449095528;6815.079964204769;6871.381575658214;6891.517593768388;6895.620740859301;6936.826579335557;6977.162740471176;7002.089728335284;7009.649517524205;7035.929640703732;7049.859002820018 04:09:47 INFO - PID 14521 | |4;prototype.html;499.4279460776999;505.5071305477158;521.6713470513577;531.5541726503908;531.8351311093559;6205;6278.623282603047;6293.37066293371;6316.115743795872;6317.431431171193;5942.88114237716;6045.609509812745;6095.542834287424;6112.327643959161;6130.344806902133;4862.902741945159;4919.786096256699;4963.419022108502;4992.375953005874;5023.899522009558;4852.175130227852;4953.727544985024;4961.231009193562;5024.799008039674;5039.44566097729;4931.334269873575;4933.506649335073;4944.33251511045;4991.151504244269;4996.925046124311;4976.4277108132665;4988.625853061035;5000.62495312853;5012.774425150877;5035.194368900977;4457.732536047847;4465.129299786543;4501.369808226851;4522.072975040109;4542.523035081335;6091.51267898567;6103.511719062464;6123.387661233841;6149.3235744068115;6167.259928808527;5711.600187986843;5737.569682273805;5765.250517432749;5767.682777447239;5780.797672081499;6482.805515834532;6484.805455836333;6499.2200935887995;6569.244536878273;6589.308122647149;4827.468978412372;4909.83315761332;4923.4091908970795;4928;4938.80244790208;6959.304069593;6992.405645520086;7013.123359580052;7059.2234854166;7073.151221853359;5034.194528875362;5038.345015148007;5042.747862606929;5050.72221027847;5051.823186188466;5110.8466745997675;5113.335266415416;5126.179811230185;5128.820131518482;5157.561607263349;5771.624844385102;5786.652800831964;5790.189373487715;5793.8841223175305;5795.304563452412;6610.735570577219;6611.305812889577;6627.966860165669;6648.33516648341;6676.699548520328;1687.8902871313326;1721.4663454329198;1741.4949664597377;1774.5360077935754;1780.5192597998469;1210.509743553862;1224.4918358881143;1240.8697086805937;1245.638764758228;1245.9439325230387;5780.942190578125;5806.1581070744505;5831.067029275296;5838.854028649318;5859.941400586024;6580.276169621337;6743.56166849163;6750.966245168743;6769.661516924134;6786.253512113663;5727.541796656257;5788.27646544182;5813.941860581424;5839.854003649858;5865.853353666193;3571.624979377128;3612.2414292998237;3616.4213725803747;3618.9638103619154;3636.2000359920776;6656;6665.200175978914;6666.933330666631;6681.331866813377;6688.331166883273;7009.369156775812;7014.859702805916;7018.684159212848;7039.894401583981;7082.087836284278;6555.475561955032;6592.439642630334;6634.767783127568;6650.667466626649;6651.66741662915;6783.525153239226;6829.897551536632;6830.282820303995;6837.589744615339;6855.451563874978;6720.193576770819;6723.865522689616;6739.460843132636;6775.728970841111;6823.1812182538415;6415.935840641534;6531.542792004514;6575;6577.63822989721;6645.408290766508;4988.201887697951;5038.345015148007;5051.74741262928;5066.670666406671;5076.715478034973;6461.224653041665;6864.450843932374;6867.725290988305;6881.002254673144;6913.619750913547;6450.161479007699;6509.088727578238;6514.185726784152;6554.180727409074;6563.868722625425;6527.11883895668;6538.607683539003;6595.472362211108;6616.437602803816;6635.236947750877;6488.188976377953;6505.154329937267;6520.119783829312;6534.738610455529;6544;6489.707963141575;6620.569662971891;6629.138212032405;6639.40245377899;6663.400293973566;6451.838634057455;6457.903131453126;6472.385123413268;6479.7408103675325;6494.707738151889 04:09:47 INFO - PID 14521 | |5;yui.html;888.6312180445116;892.7500299916023;908.6683360573388;923.7598224461638;926.1248120526097;18009.909950450245;18590.349337773147;18721.62556748864;18738;22681.886590567065;21418.357449276507;21904.671429928563;22051.33845984619;22158.113675453;22214.11143554256;934.4953724988499;942.2273735536862;946.4274114160937;946.8437707778243;951.1772316945827;956.3783540698532;1011.8482227665835;1022.1975749037008;1026.0867827633413;1027.6762819711766;1060.3796778884362;1065.477915821246;1067.1089640150483;1067.3489171605354;1070.4219721350462;1047.6176195688595;1053.8419237114417;1054.2936232724094;1059.6079450603288;1061;784.0865391818525;784.1296161260996;784.1726978038167;784.2745460449062;786.7325109462753;17869.46391608254;19067.332643357553;19115.235390584498;19158.425247242605;19180.520486987938;16920.492385228463;16959;17295.135243237786;17305.307787688478;17400.21699023547;16963.406280780237;16980.132185459588;17204.56988575283;17219.82780172195;17229.13854307292;3555.3955827509385;3640.0353906214873;3657.4513822926506;3658.798766067865;3660.432632941898;127144.36427817894;127569.36215318956;131220.99999999904;131319;132383;16654.83345166557;16848.157592120344;16917.238724257437;16926.15369231558;17008.404705835237;31510.842445788083;31578.684213158034;32146.83926580399;32150;32188.678113219037;7667;7992.480488768211;8184.877226841602;8284.917150828534;8335.208155225244;4106.301928672133;4124.711270211116;4186.581341865789;4216.388623649554;4224.028473451062;5255.421903590602;5353.170258609922;5356;5372.086745253317;5426.403095659474;1069.198101423932;1075.4676435164642;1088.5373716170595;1089.3463921646949;1090.9526854220037;688.18793823288;712.5760172697237;715.9785206443815;719.6221983458726;721.9927800721925;11991.100667449977;12411.255324680547;12581.433835477426;12659.11386202957;12992.870071299356;689.8447849233883;695.9443244540424;705.7247673407272;705.7388766156555;706.3042902740797;5409.026375252413;5410.513053825096;5448.42791506894;5496;5556.444355564411;114307;115264;116397.41801290939;118301;121381;95161;98908;99566;104161;104343;83803.8098095105;83994;84263;85238.14761852426;86801.13198868057;9610.231181505324;9741.756456088371;9818.214542836698;9818.312718109664;10006.249531285037;37793.62206377901;39265;39986.20027599374;40423.7978810104;41237.79381103075;49169.75415122901;49747.25379119244;49798.75100624474;50223.74888125536;51746.48253517417;15722.449714259947;16120.919395402949;16158.192090395198;16170.434034808724;16246.918765406097;17121.74317385265;17415.912920435316;17501.912490437466;17512.38706645261;17520;15060.774088388902;15143.242837857842;15168.620784480476;15237.847621524086;15240.923795381395;16290.266937987582;16660.250288736792;16680.66638667244;16949.661006780043;16986.15069246508;15448.073115613099;15510.767338490157;15547.611309717347;15784.60538486547;15823.050616963019;10827.67516974492;10938;11061.170412218955;11092.944535277273;11246.212765106364;11102.111831053335;11221.607243746756;11587.015103715941;14236.64408389757;14742 04:09:47 INFO - PID 14521 | __end_tp_report 04:09:47 INFO - PID 14521 | __start_cc_report 04:09:47 INFO - PID 14521 | _x_x_mozilla_cycle_collect,367 04:09:47 INFO - PID 14521 | __end_cc_report 04:09:47 INFO - PID 14521 | __startTimestamp1502708987869__endTimestamp 04:09:47 INFO - PID 14521 | 04:09:47 INFO - PID 14521 | ------- Summary: start ------- 04:09:47 INFO - PID 14521 | Number of tests: 6 04:09:47 INFO - PID 14521 | 04:09:47 INFO - PID 14521 | [#0] dojo.html Cycles:165 Average:6116.85 Median:6394.30 stddev:711.55 (11.1%) stddev-sans-first:674.77 04:09:47 INFO - PID 14521 | Values: 3156.2 3180.9 3205.3 3211.6 3221.1 6100.0 6159.3 6179.5 6189.3 6255.4 6182.9 6210.3 6254.7 6257.7 6275.4 5639.3 5653.3 5657.6 5687.5 5762.5 5738.0 5747.4 5748.5 5762.4 5766.0 5687.8 5766.7 5772.9 5800.2 5802.2 5466.8 5580.4 5629.0 5661.4 5760.8 5240.1 5573.4 5580.8 5672.6 5679.0 5990.6 6057.5 6120.4 6128.0 6149.3 6563.3 6614.2 6652.3 6663.7 6696.0 6612.6 6617.1 6618.7 6627.5 6650.5 6097.5 6100.3 6104.5 6106.4 6114.7 6715.6 6717.5 6724.8 6739.9 6743.9 6373.2 6420.2 6541.9 6584.7 6618.3 6667.1 6740.4 6741.1 6741.7 6745.9 6586.8 6609.5 6618.3 6690.1 6728.1 6443.8 6628.6 6646.8 6698.3 6731.6 5360.3 5411.2 5426.0 5453.8 5464.9 4565.4 4639.1 4650.7 4672.8 4694.1 5745.5 5752.7 5752.8 5756.9 5759.6 6598.1 6612.8 6613.4 6625.5 6641.9 5532.6 5623.8 5664.5 5684.8 5724.8 5915.4 5966.0 5968.7 5974.1 5991.2 6491.4 6519.4 6581.0 6599.3 6601.0 6583.4 6657.6 6674.4 6743.1 6765.2 6461.6 6462.1 6467.6 6468.8 6473.0 6501.8 6536.7 6582.5 6593.9 6613.0 6597.6 6615.1 6654.8 6715.2 6715.8 6394.3 6410.3 6495.1 6497.7 6508.4 6349.3 6443.8 6476.0 6498.6 6541.4 6448.5 6449.3 6456.2 6464.5 6471.4 6468.4 6480.3 6519.7 6522.4 6593.4 6257.2 6296.7 6298.7 6320.2 6341.1 04:09:47 INFO - PID 14521 | 04:09:47 INFO - PID 14521 | [#1] ext.html Cycles:180 Average:38156.45 Median:19694.94 stddev:53578.58 (272.0%) stddev-sans-first:53655.55 04:09:47 INFO - PID 14521 | Values: 823.9 870.2 882.1 886.0 1164.4 30944.5 31383.7 40714.4 41427.0 41542.8 41761.4 42146.6 42215.4 42259.8 42296.6 7174.5 7572.1 7660.1 7730.3 7747.7 7562.7 7648.2 7649.8 7675.5 7678.8 7663.7 7681.5 7723.6 7725.0 7727.7 7659.5 7662.8 7685.5 7687.8 7689.8 7543.2 7564.1 7584.8 7590.2 7611.0 38918.6 39093.6 39114.0 39153.8 39231.4 3569.3 3607.8 3611.3 3614.8 3618.0 32415.5 32472.8 32642.5 32684.3 32732.3 4893.6 5122.6 5123.5 5155.8 5156.9 201366.0 202307.0 202577.0 202634.0 203111.0 49137.8 49261.8 49319.0 49353.0 49433.0 51484.7 51637.7 51721.5 51812.5 51848.5 16241.4 16420.7 16501.6 16507.3 16571.9 12113.5 12380.9 13128.4 13428.3 13541.1 14108.2 14273.6 14315.9 14345.6 14419.2 5763.2 5821.4 5912.1 5947.3 5983.8 1005.8 1015.0 1016.6 1017.3 1024.7 23161.7 23205.5 23246.4 23330.5 23527.2 1106.5 1115.0 1125.4 1129.1 1129.5 12001.9 12209.5 12302.6 12391.6 12456.8 225029.0 226845.0 227073.0 227223.0 227482.0 53604.5 53855.7 53979.2 54342.5 54510.7 1458.3 1471.4 1507.6 1508.7 1525.7 22523.3 22662.0 22749.8 22826.5 22925.4 38383.2 38626.4 38726.4 38760.0 38840.2 187906.0 189396.0 189731.0 190728.0 191606.0 33653.8 34764.5 36377.5 36565.8 36647.6 47024.5 47190.0 47191.5 47205.5 48381.5 34844.5 34968.5 35206.0 35489.5 35725.8 34544.8 34767.3 34799.3 34950.3 35439.3 37823.6 37865.8 37918.6 37982.8 38072.4 33983.7 34401.3 34685.8 35066.0 35782.1 24477.3 24613.9 24698.5 24818.8 25027.7 04:09:47 INFO - PID 14521 | 04:09:47 INFO - PID 14521 | [#2] jquery.html Cycles:180 Average:37107.39 Median:22166.22 stddev:87614.77 (395.3%) stddev-sans-first:87817.57 04:09:47 INFO - PID 14521 | Values: 556.8 558.7 569.1 573.9 587.0 22672.7 23341.5 23664.3 23667.9 23696.3 26719.2 27345.0 27396.5 27447.5 27548.6 6662.2 6834.2 6834.4 6834.6 6839.6 6035.6 6323.1 6542.8 6570.3 6709.9 6486.8 6540.1 6559.6 6565.3 6565.8 6552.2 6561.9 6562.4 6563.0 6564.8 6101.0 6105.1 6107.3 6116.7 6117.4 29439.4 29950.1 30150.5 30307.8 30885.5 1874.8 1917.2 1922.9 1929.9 1933.6 19546.5 20008.8 20054.4 20074.9 20130.6 2411.6 2413.6 2466.6 2478.4 2502.0 139363.0 143816.0 143945.0 144004.0 144101.0 14581.4 14928.0 14993.0 15212.5 15654.8 23203.5 23320.5 23328.4 23329.1 24039.0 10512.4 10559.2 10689.3 10816.9 10885.1 9882.6 9888.3 10016.2 10039.9 10186.6 9305.8 9542.4 9599.4 9626.8 9757.7 2605.1 2633.9 2750.2 2751.5 2849.9 980.3 1009.5 1010.5 1012.3 1018.4 20744.2 20781.6 20790.6 20966.2 21000.3 1037.0 1060.2 1062.5 1063.5 1081.1 11032.9 11505.3 11606.3 13590.4 14240.8 494226.0 518631.0 523513.0 526516.0 532740.0 129506.0 129597.4 131628.0 133825.0 135456.3 1226.6 1275.7 1299.6 1302.3 1308.6 20722.8 21485.4 21695.9 22015.0 22317.4 58205.4 59742.0 60173.4 61559.4 61574.4 72511.3 73288.6 73399.3 73458.3 74101.0 20716.3 21517.9 21605.8 21617.2 21656.5 23458.9 23488.4 23490.6 23614.3 24074.5 18527.5 18676.7 18784.0 19041.0 19190.0 16822.6 17070.0 17128.7 17289.5 17812.5 18506.4 18987.4 19022.0 19140.4 19627.3 20671.7 21136.2 21180.0 21212.2 21237.3 18707.3 18799.0 18917.0 18919.7 19069.7 04:09:47 INFO - PID 14521 | 04:09:47 INFO - PID 14521 | [#3] mootools.html Cycles:180 Average:8850.53 Median:2541.81 stddev:6188.04 (243.4%) stddev-sans-first:6179.83 04:09:47 INFO - PID 14521 | Values: 1364.3 1408.6 1409.0 1419.7 1439.4 13546.1 14277.9 14281.1 14344.6 14384.9 14130.2 15183.5 15216.6 15220.4 15221.2 2606.2 2662.4 2665.5 2665.9 2667.0 2586.6 2620.5 2647.8 2654.2 2654.8 2549.2 2566.5 2609.6 2665.1 2672.1 2534.5 2552.1 2561.6 2570.3 2573.3 2478.3 2486.6 2503.7 2505.9 2509.0 13987.9 14044.9 14188.5 14230.8 14252.3 7280.1 7450.6 7489.6 7494.3 7520.6 4975.6 5045.7 5089.4 5172.1 5175.6 1923.7 1932.4 1941.5 1979.1 1983.6 24124.0 24130.6 24180.5 24265.5 24297.1 6298.0 6318.1 6379.9 6570.9 6588.5 15541.6 16228.3 16288.2 16517.6 16567.8 7475.1 7709.2 7720.1 7721.2 7727.9 7096.6 7131.5 7167.0 7201.1 7215.3 5077.3 5147.1 5214.9 5221.5 5234.7 1470.0 1482.5 1491.1 1517.8 1518.9 825.9 851.4 860.0 868.5 879.8 6708.6 6775.4 6780.6 6790.9 6840.9 658.4 692.7 703.1 723.8 734.7 4384.7 4515.7 4769.4 4843.9 4871.1 19602.4 19856.0 20021.0 20067.0 20219.5 18866.0 19682.7 19731.2 19743.5 19880.0 11140.8 11327.1 11337.3 11359.0 11415.4 7719.2 7903.1 7972.6 8026.2 8169.6 16833.1 16889.0 17044.6 17102.2 17709.9 16844.4 17275.4 17292.7 17404.6 17454.0 13112.1 13438.3 13470.0 13487.3 13487.7 13143.0 13314.1 13383.7 13427.1 13536.4 10694.4 10755.8 10813.6 10834.9 11149.6 10624.3 10873.9 10944.8 11048.3 11123.8 9413.1 9458.2 9471.5 9472.1 9550.9 6815.1 6871.4 6891.5 6895.6 6936.8 6977.2 7002.1 7009.6 7035.9 7049.9 04:09:47 INFO - PID 14521 | 04:09:47 INFO - PID 14521 | [#4] prototype.html Cycles:180 Average:5558.47 Median:6117.86 stddev:1568.28 (25.6%) stddev-sans-first:1526.02 04:09:47 INFO - PID 14521 | Values: 499.4 505.5 521.7 531.6 531.8 6205.0 6278.6 6293.4 6316.1 6317.4 5942.9 6045.6 6095.5 6112.3 6130.3 4862.9 4919.8 4963.4 4992.4 5023.9 4852.2 4953.7 4961.2 5024.8 5039.4 4931.3 4933.5 4944.3 4991.2 4996.9 4976.4 4988.6 5000.6 5012.8 5035.2 4457.7 4465.1 4501.4 4522.1 4542.5 6091.5 6103.5 6123.4 6149.3 6167.3 5711.6 5737.6 5765.3 5767.7 5780.8 6482.8 6484.8 6499.2 6569.2 6589.3 4827.5 4909.8 4923.4 4928.0 4938.8 6959.3 6992.4 7013.1 7059.2 7073.2 5034.2 5038.3 5042.7 5050.7 5051.8 5110.8 5113.3 5126.2 5128.8 5157.6 5771.6 5786.7 5790.2 5793.9 5795.3 6610.7 6611.3 6628.0 6648.3 6676.7 1687.9 1721.5 1741.5 1774.5 1780.5 1210.5 1224.5 1240.9 1245.6 1245.9 5780.9 5806.2 5831.1 5838.9 5859.9 6580.3 6743.6 6751.0 6769.7 6786.3 5727.5 5788.3 5813.9 5839.9 5865.9 3571.6 3612.2 3616.4 3619.0 3636.2 6656.0 6665.2 6666.9 6681.3 6688.3 7009.4 7014.9 7018.7 7039.9 7082.1 6555.5 6592.4 6634.8 6650.7 6651.7 6783.5 6829.9 6830.3 6837.6 6855.5 6720.2 6723.9 6739.5 6775.7 6823.2 6415.9 6531.5 6575.0 6577.6 6645.4 4988.2 5038.3 5051.7 5066.7 5076.7 6461.2 6864.5 6867.7 6881.0 6913.6 6450.2 6509.1 6514.2 6554.2 6563.9 6527.1 6538.6 6595.5 6616.4 6635.2 6488.2 6505.2 6520.1 6534.7 6544.0 6489.7 6620.6 6629.1 6639.4 6663.4 6451.8 6457.9 6472.4 6479.7 6494.7 04:09:47 INFO - PID 14521 | 04:09:47 INFO - PID 14521 | [#5] yui.html Cycles:180 Average:22982.24 Median:18729.81 stddev:32625.45 (174.2%) stddev-sans-first:32674.80 04:09:47 INFO - PID 14521 | Values: 888.6 892.8 908.7 923.8 926.1 18009.9 18590.3 18721.6 18738.0 22681.9 21418.4 21904.7 22051.3 22158.1 22214.1 934.5 942.2 946.4 946.8 951.2 956.4 1011.8 1022.2 1026.1 1027.7 1060.4 1065.5 1067.1 1067.3 1070.4 1047.6 1053.8 1054.3 1059.6 1061.0 784.1 784.1 784.2 784.3 786.7 17869.5 19067.3 19115.2 19158.4 19180.5 16920.5 16959.0 17295.1 17305.3 17400.2 16963.4 16980.1 17204.6 17219.8 17229.1 3555.4 3640.0 3657.5 3658.8 3660.4 127144.4 127569.4 131221.0 131319.0 132383.0 16654.8 16848.2 16917.2 16926.2 17008.4 31510.8 31578.7 32146.8 32150.0 32188.7 7667.0 7992.5 8184.9 8284.9 8335.2 4106.3 4124.7 4186.6 4216.4 4224.0 5255.4 5353.2 5356.0 5372.1 5426.4 1069.2 1075.5 1088.5 1089.3 1091.0 688.2 712.6 716.0 719.6 722.0 11991.1 12411.3 12581.4 12659.1 12992.9 689.8 695.9 705.7 705.7 706.3 5409.0 5410.5 5448.4 5496.0 5556.4 114307.0 115264.0 116397.4 118301.0 121381.0 95161.0 98908.0 99566.0 104161.0 104343.0 83803.8 83994.0 84263.0 85238.1 86801.1 9610.2 9741.8 9818.2 9818.3 10006.2 37793.6 39265.0 39986.2 40423.8 41237.8 49169.8 49747.3 49798.8 50223.7 51746.5 15722.4 16120.9 16158.2 16170.4 16246.9 17121.7 17415.9 17501.9 17512.4 17520.0 15060.8 15143.2 15168.6 15237.8 15240.9 16290.3 16660.3 16680.7 16949.7 16986.2 15448.1 15510.8 15547.6 15784.6 15823.1 10827.7 10938.0 11061.2 11092.9 11246.2 11102.1 11221.6 11587.0 14236.6 14742.0 04:09:47 INFO - PID 14521 | -------- Summary: end -------- 04:09:47 INFO - PID 14521 | 04:09:48 INFO - TEST-INFO | 14521: exit 0 04:09:48 INFO - TEST-OK | dromaeo_css | took 1112429ms 04:09:48 INFO - TEST-START | kraken 04:09:48 INFO - Initialising browser for kraken test... 04:09:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42586/getInfo.html -profile /tmp/tmpO6dhIb/profile 04:09:48 INFO - TEST-INFO | started process 14899 (/builds/slave/test/build/application/firefox/firefox http://localhost:42586/getInfo.html) 04:09:54 INFO - TEST-INFO | 14899: exit 0 04:09:54 INFO - Browser initialized. 04:09:54 INFO - Running cycle 1/1 for kraken test... 04:09:54 INFO - TEST-INFO | started process 15137 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO6dhIb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:55 INFO - PID 15137 | 04:09:55 INFO - PID 15137 | (/builds/slave/test/build/application/firefox/firefox:15191): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 04:09:55 INFO - PID 15137 | 04:10:05 INFO - PID 15137 | RSS: Main: 168009728 04:10:05 INFO - PID 15137 | 04:10:08 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42586/tests/kraken/driver.html?testName=audio-beat-detection) 04:10:09 INFO - PID 15137 | RSS: Main: 174272512 04:10:09 INFO - PID 15137 | 04:10:12 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42586/tests/kraken/driver.html?testName=audio-dft) 04:10:12 INFO - PID 15137 | RSS: Main: 178036736 04:10:12 INFO - PID 15137 | 04:10:15 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42586/tests/kraken/driver.html?testName=audio-fft) 04:10:16 INFO - PID 15137 | RSS: Main: 172216320 04:10:16 INFO - PID 15137 | 04:10:18 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42586/tests/kraken/driver.html?testName=audio-oscillator) 04:10:19 INFO - PID 15137 | RSS: Main: 172466176 04:10:19 INFO - PID 15137 | 04:10:21 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42586/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:22 INFO - PID 15137 | RSS: Main: 172949504 04:10:22 INFO - PID 15137 | 04:10:25 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42586/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:25 INFO - PID 15137 | RSS: Main: 174333952 04:10:25 INFO - PID 15137 | 04:10:29 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42586/tests/kraken/driver.html?testName=imaging-desaturate) 04:10:30 INFO - PID 15137 | RSS: Main: 173690880 04:10:30 INFO - PID 15137 | 04:10:32 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42586/tests/kraken/driver.html?testName=json-parse-financial) 04:10:33 INFO - PID 15137 | RSS: Main: 175157248 04:10:33 INFO - PID 15137 | 04:10:35 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42586/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:10:35 INFO - PID 15137 | RSS: Main: 174866432 04:10:35 INFO - PID 15137 | 04:10:37 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42586/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:10:38 INFO - PID 15137 | RSS: Main: 175005696 04:10:38 INFO - PID 15137 | 04:10:40 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42586/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:10:41 INFO - PID 15137 | RSS: Main: 174837760 04:10:41 INFO - PID 15137 | 04:10:43 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:10:44 INFO - PID 15137 | RSS: Main: 175218688 04:10:44 INFO - PID 15137 | 04:10:47 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:10:48 INFO - PID 15137 | RSS: Main: 175448064 04:10:48 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | Cycle 1(1): loaded http://localhost:42586/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42586/tests/kraken/driver.html?testName=ai-astar) 04:10:50 INFO - PID 15137 | RSS: Main: 176803840 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | __start_tp_report 04:10:50 INFO - PID 15137 | _x_x_mozilla_page_load 04:10:50 INFO - PID 15137 | _x_x_mozilla_page_load_details 04:10:50 INFO - PID 15137 | |i|pagename|runs| 04:10:50 INFO - PID 15137 | |0;ai-astar;99;108;103;107;107;112;110;100;114;109 04:10:50 INFO - PID 15137 | |1;audio-beat-detection;150;116;145;185;122;145;145;121;178;121 04:10:50 INFO - PID 15137 | |2;audio-dft;163;162;163;163;163;162;189;162;163;172 04:10:50 INFO - PID 15137 | |3;audio-fft;78;75;75;165;76;79;75;80;158;76 04:10:50 INFO - PID 15137 | |4;audio-oscillator;86;78;124;80;78;80;125;78;79;139 04:10:50 INFO - PID 15137 | |5;imaging-gaussian-blur;114;113;114;114;122;113;113;120;118;114 04:10:50 INFO - PID 15137 | |6;imaging-darkroom;153;150;152;150;150;151;150;150;152;150 04:10:50 INFO - PID 15137 | |7;imaging-desaturate;94;94;94;94;94;95;94;94;93;93 04:10:50 INFO - PID 15137 | |8;json-parse-financial;54;53;58;54;53;61;54;62;53;53 04:10:50 INFO - PID 15137 | |9;json-stringify-tinderbox;54;53;54;55;54;54;60;54;55;54 04:10:50 INFO - PID 15137 | |10;stanford-crypto-aes;78;79;81;78;79;77;78;78;78;79 04:10:50 INFO - PID 15137 | |11;stanford-crypto-ccm;135;133;129;122;122;125;129;128;129;163 04:10:50 INFO - PID 15137 | |12;stanford-crypto-pbkdf2;180;183;190;178;191;176;192;180;180;199 04:10:50 INFO - PID 15137 | |13;stanford-crypto-sha256-iterative;75;69;77;69;76;68;72;72;70;68 04:10:50 INFO - PID 15137 | __end_tp_report 04:10:50 INFO - PID 15137 | __start_cc_report 04:10:50 INFO - PID 15137 | _x_x_mozilla_cycle_collect,976 04:10:50 INFO - PID 15137 | __end_cc_report 04:10:50 INFO - PID 15137 | __startTimestamp1502709050482__endTimestamp 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | ------- Summary: start ------- 04:10:50 INFO - PID 15137 | Number of tests: 14 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#0] ai-astar Cycles:10 Average:106.90 Median:109.50 stddev:4.91 (4.5%) stddev-sans-first:4.29 04:10:50 INFO - PID 15137 | Values: 99.0 108.0 103.0 107.0 107.0 112.0 110.0 100.0 114.0 109.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:145.00 stddev:24.01 (16.6%) stddev-sans-first:25.32 04:10:50 INFO - PID 15137 | Values: 150.0 116.0 145.0 185.0 122.0 145.0 145.0 121.0 178.0 121.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#2] audio-dft Cycles:10 Average:166.20 Median:163.00 stddev:8.55 (5.2%) stddev-sans-first:8.99 04:10:50 INFO - PID 15137 | Values: 163.0 162.0 163.0 163.0 163.0 162.0 189.0 162.0 163.0 172.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#3] audio-fft Cycles:10 Average:93.70 Median:76.00 stddev:35.81 (47.1%) stddev-sans-first:37.53 04:10:50 INFO - PID 15137 | Values: 78.0 75.0 75.0 165.0 76.0 79.0 75.0 80.0 158.0 76.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:78.50 stddev:24.34 (31.0%) stddev-sans-first:25.61 04:10:50 INFO - PID 15137 | Values: 86.0 78.0 124.0 80.0 78.0 80.0 125.0 78.0 79.0 139.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#5] imaging-gaussian-blur Cycles:10 Average:115.50 Median:114.00 stddev:3.27 (2.9%) stddev-sans-first:3.43 04:10:50 INFO - PID 15137 | Values: 114.0 113.0 114.0 114.0 122.0 113.0 113.0 120.0 118.0 114.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.50 stddev:1.14 (0.8%) stddev-sans-first:0.88 04:10:50 INFO - PID 15137 | Values: 153.0 150.0 152.0 150.0 150.0 151.0 150.0 150.0 152.0 150.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 04:10:50 INFO - PID 15137 | Values: 94.0 94.0 94.0 94.0 94.0 95.0 94.0 94.0 93.0 93.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.00 stddev:3.50 (6.5%) stddev-sans-first:3.67 04:10:50 INFO - PID 15137 | Values: 54.0 53.0 58.0 54.0 53.0 61.0 54.0 62.0 53.0 53.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#9] json-stringify-tinderbox Cycles:10 Average:54.70 Median:54.00 stddev:1.95 (3.6%) stddev-sans-first:2.05 04:10:50 INFO - PID 15137 | Values: 54.0 53.0 54.0 55.0 54.0 54.0 60.0 54.0 55.0 54.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.50 stddev:1.08 (1.4%) stddev-sans-first:1.13 04:10:50 INFO - PID 15137 | Values: 78.0 79.0 81.0 78.0 79.0 77.0 78.0 78.0 78.0 79.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#11] stanford-crypto-ccm Cycles:10 Average:131.50 Median:129.00 stddev:11.83 (9.2%) stddev-sans-first:12.48 04:10:50 INFO - PID 15137 | Values: 135.0 133.0 129.0 122.0 122.0 125.0 129.0 128.0 129.0 163.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.90 Median:186.50 stddev:7.56 (4.1%) stddev-sans-first:7.81 04:10:50 INFO - PID 15137 | Values: 180.0 183.0 190.0 178.0 191.0 176.0 192.0 180.0 180.0 199.0 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:3.37 (4.7%) stddev-sans-first:3.35 04:10:50 INFO - PID 15137 | Values: 75.0 69.0 77.0 69.0 76.0 68.0 72.0 72.0 70.0 68.0 04:10:50 INFO - PID 15137 | -------- Summary: end -------- 04:10:50 INFO - PID 15137 | 04:10:50 INFO - PID 15137 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:10:51 INFO - TEST-INFO | 15137: exit 0 04:10:51 INFO - TEST-OK | kraken | took 62589ms 04:10:51 INFO - SUITE-END | took 1175s 04:10:51 INFO - Completed test suite (00:19:35) 04:10:51 INFO - javascript benchmark 04:10:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8514.354599367769, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3156.210947263184, 3180.904572862815, 3205.2627895584014, 3211.598550181228, 3221.0980925340914, 6099.969500152493, 6159.3224745277985, 6179.505639548836, 6189.257289125311, 6255.374462553742, 6182.938170618292, 6210.254769427664, 6254.655993920333, 6257.687115644211, 6275.4038366355235, 5639.323281206251, 5653.293338332708, 5657.57568182388, 5687.459691329317, 5762.53899688026, 5738.0, 5747.425257474261, 5748.482636562709, 5762.366139724627, 5765.971170144144, 5687.800926967557, 5766.711664416784, 5772.913406298909, 5800.216970708963, 5802.245708057946, 5466.781328746845, 5580.386157522669, 5629.043062679313, 5661.405552416978, 5760.8271751847515, 5240.082985477527, 5573.359063707685, 5580.832575022756, 5672.631278966854, 5678.971605141989, 5990.5507086968655, 6057.485113765291, 6120.418560236815, 6127.969360153171, 6149.262088549358, 6563.3108523604815, 6614.173228346457, 6652.301508341651, 6663.700133494004, 6695.966520167417, 6612.636305003223, 6617.106690596756, 6618.7021584028835, 6627.469802415843, 6650.4679625630315, 6097.512199024068, 6100.267967843843, 6104.481119104837, 6106.358832322587, 6114.663693496811, 6715.630640314829, 6717.462602991846, 6724.7646332378135, 6739.865202696017, 6743.865122697519, 6373.235211774617, 6420.165378500765, 6541.869162616721, 6584.703688334036, 6618.271990081087, 6667.133272674521, 6740.359665831738, 6741.056252124707, 6741.662916854138, 6745.8650826983185, 6586.769463068866, 6609.537332386687, 6618.30507796684, 6690.130283063268, 6728.125343705287, 6443.838904027437, 6628.5691430056895, 6646.8005959821285, 6698.330166983263, 6731.562448440934, 5360.276362691065, 5411.242426060355, 5426.0, 5453.827427103191, 5464.9453505465235, 4565.383673204141, 4639.095376401569, 4650.720956742606, 4672.789724462407, 4694.0611877624615, 5745.540356771448, 5752.712364381848, 5752.849430113994, 5756.94243057564, 5759.568032397587, 6598.1422415085735, 6612.768553100618, 6613.404793568602, 6625.469962402996, 6641.900371494431, 5532.640378375393, 5623.775048998076, 5664.461876121762, 5684.77260909559, 5724.8282551523525, 5915.40845915405, 5966.015607424726, 5968.731407086691, 5974.103884417372, 5991.191189189491, 6491.350864913471, 6519.445847102955, 6581.045748366556, 6599.307072757388, 6601.042848786899, 6583.44040756541, 6657.6005439671835, 6674.365935236145, 6743.055972163803, 6765.154355705537, 6461.57999730016, 6462.127612772216, 6467.579607325509, 6468.8059358219325, 6472.967635161794, 6501.804945851632, 6536.738530458729, 6582.473402127914, 6593.868122637617, 6613.0, 6597.60414375139, 6615.140031795836, 6654.767083152066, 6715.160604924385, 6715.832104197434, 6394.296627370893, 6410.326915673973, 6495.123158373559, 6497.707603157964, 6508.381703738138, 6349.301576826453, 6443.7744678936015, 6475.967620161869, 6498.610083395011, 6541.443977261795, 6448.5163612730175, 6449.258335291502, 6456.160699109086, 6464.450521705708, 6471.449926756279, 6468.417842394207, 6480.319566445455, 6519.706613202512, 6522.445592124723, 6593.439557637655, 6257.155284036597, 6296.716647750771, 6298.653574053471, 6320.178376810985, 6341.0805433212845], "value": 6064.663523939965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.8764185372194, 870.1994165367861, 882.0694167653123, 886.03422269726, 1164.3770582738236, 30944.535831962512, 31383.68616313836, 40714.38928416076, 41427.0, 41542.79228603853, 41761.373579396335, 42146.57853421473, 42215.36676949848, 42259.78870105653, 42296.577034229646, 7174.533655312414, 7572.129205141397, 7660.119086305091, 7730.304272615464, 7747.72882949094, 7562.735304264352, 7648.158702542716, 7649.770506884803, 7675.462717609769, 7678.769636910902, 7663.655135518887, 7681.539107653559, 7723.575203363813, 7724.9613751931165, 7727.6522556484815, 7659.540427574336, 7662.770116896502, 7685.5388676679295, 7687.769366919029, 7689.807754806175, 7543.245675432413, 7564.092308922909, 7584.772456826304, 7590.1650818409935, 7610.961945190239, 38918.610813891784, 39093.609063909564, 39114.0, 39153.80423097866, 39231.41152882709, 3569.3218288525095, 3607.7835329880027, 3611.2777444511203, 3614.765040272374, 3618.0231337538717, 32415.51376729351, 32472.83763581167, 32642.510362344583, 32684.346313073842, 32732.345353092805, 4893.584045356149, 5122.615803814729, 5123.462036486189, 5155.7679904404395, 5156.871078223075, 201366.0, 202307.0, 202577.0, 202634.0, 203110.99999999852, 49137.75431122893, 49261.75369123203, 49319.0, 49353.0, 49433.0, 51484.74257628688, 51637.7418112907, 51721.48278517242, 51812.48187518152, 51848.48151518512, 16241.431549895697, 16420.6715865682, 16501.58746031359, 16507.257173427224, 16571.91714041422, 12113.515459381702, 12380.876191237972, 13128.409221585052, 13428.328583570783, 13541.1198272112, 14108.224047677271, 14273.57179284623, 14315.856841431661, 14345.64135896611, 14419.206943618201, 5763.221965034667, 5821.388754180834, 5912.08362703773, 5947.286325640865, 5983.760649573968, 1005.8290090684601, 1014.9898501015043, 1016.5781200801584, 1017.2574020964589, 1024.702836177515, 23161.652575211385, 23205.485750842076, 23246.418839529146, 23330.53338933212, 23527.17654882071, 1106.4633652678444, 1115.0, 1125.4035361258545, 1129.1080046762966, 1129.4860838318546, 12001.879981200076, 12209.450574723982, 12302.569410070604, 12391.62825115248, 12456.81314780279, 225029.0, 226845.0, 227073.0, 227223.0, 227482.0, 53604.46395536073, 53855.73072134614, 53979.19031214535, 54342.45657543374, 54510.727446362514, 1458.3073040305983, 1471.4187895781106, 1507.5854140111558, 1508.6756347385365, 1525.6872341170033, 22523.32430027102, 22662.0, 22749.772502274765, 22826.543469130193, 22925.426864328525, 38383.23233535369, 38626.42060369153, 38726.41910371403, 38760.0, 38840.22319553536, 187906.0, 189396.0, 189731.0, 190728.0, 191606.0, 33653.83173084217, 34764.47853282253, 36377.454338185475, 36565.81717091398, 36647.63352366442, 47024.529754702016, 47190.0, 47191.52808471872, 47205.52794472011, 48381.5161848377, 34844.477332839524, 34968.475472868435, 35206.0, 35489.467657984635, 35725.821370892976, 34544.82727586346, 34767.30465390627, 34799.30401392009, 34950.30099398048, 35439.29121417506, 37823.62176378201, 37865.81067094647, 37918.620813792615, 37982.81008594939, 38072.42891356577, 33983.660163398046, 34401.31197375988, 34685.826570866986, 35066.0, 35782.105447362985, 24477.265682028854, 24613.87693061523, 24698.50602987966, 24818.751812481645, 25027.749722502544], "value": 17489.295967376464, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.780758922832, 558.7206396801599, 569.1235497334104, 573.8565358660333, 586.991195132073, 22672.659910101363, 23341.533169336602, 23664.290071297866, 23667.881660591695, 23696.289111326645, 26719.19842404731, 27345.04292349768, 27396.452070958618, 27447.45105097902, 27548.586771198447, 6662.233843108056, 6834.2140653824945, 6834.384905358516, 6834.624095674761, 6839.555428897131, 6035.577509574309, 6323.114763933053, 6542.803715888531, 6570.277269500351, 6709.9329006709795, 6486.805395838109, 6540.051692504608, 6559.639219842907, 6565.34346565342, 6565.835854103638, 6552.180977377828, 6561.901571476432, 6562.409383155539, 6563.048357988089, 6564.770233041844, 6101.0, 6105.114758360058, 6107.26712794463, 6116.694165291718, 6117.418845209698, 29439.411211775645, 29950.101496955125, 30150.547741783892, 30307.848460757774, 30885.536716949264, 1874.7937726850037, 1917.1564511614984, 1922.865399422041, 1929.8842069475736, 1933.6036112597023, 19546.51133721654, 20008.79991200084, 20054.398368048984, 20074.899625501926, 20130.597388052305, 2411.5900296949562, 2413.5776239158254, 2466.5930121529927, 2478.3804048987754, 2501.987490062538, 139363.0, 143816.0, 143945.0, 144004.0, 144101.0, 14581.416743330148, 14928.0, 14993.0, 15212.543623691306, 15654.843451565339, 23203.53592928132, 23320.53358932812, 23328.416789580395, 23329.066837326318, 24039.0, 10512.369257844553, 10559.208059395576, 10689.251752377415, 10816.945915270373, 10885.129189664807, 9882.604695812232, 9888.318985772436, 10016.248781341428, 10039.949800250952, 10186.643467478603, 9305.813883722287, 9542.42745435276, 9599.376040557341, 9626.807463850824, 9757.658481953098, 2605.1403036997744, 2633.934151646186, 2750.188694335176, 2751.5047291487326, 2849.900253491159, 980.3039841712464, 1009.485162567096, 1010.4897027001317, 1012.2661070723814, 1018.4347687033619, 20744.170233190503, 20781.58436831285, 20790.58418831615, 20966.16135354569, 21000.264990725558, 1037.0, 1060.204846365226, 1062.4581463453694, 1063.4682658670665, 1081.0756802933536, 11032.869715582292, 11505.309681419141, 11606.339815721753, 13590.38843252056, 14240.786388204186, 494226.0, 518631.0, 523513.0, 526516.0, 532740.0, 129506.0, 129597.35201323933, 131628.0, 133825.0, 135456.32271838578, 1226.6197478781605, 1275.7384736129072, 1299.564645843653, 1302.3097758188176, 1308.5943357559188, 20722.79277207269, 21485.35543933622, 21695.891520542296, 22015.0, 22317.442063948532, 58205.41794582, 59742.0, 60173.39826601678, 61559.38440615716, 61574.38425615687, 72511.27488725045, 73288.63355683188, 73399.26600734139, 73458.26541734514, 74101.0, 20716.274930377363, 21517.892410537846, 21605.78394216038, 21617.243396481048, 21656.458588535414, 23458.882705586362, 23488.412789680395, 23490.647640285068, 23614.29157125289, 24074.51850963006, 18527.53681157928, 18676.719849202545, 18784.0, 19041.0, 19190.0, 16822.57943551421, 17070.0, 17128.743068853728, 17289.48131556055, 17812.46562603124, 18506.44480665582, 18987.43037708871, 19022.0, 19140.425787226406, 19627.31304404339, 20671.68992465084, 21136.154553817676, 21180.0, 21212.15151393927, 21237.256696015564, 18707.34524291643, 18799.0, 18917.0, 18919.716204257224, 19069.713954290975], "value": 12656.761756581707, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1364.3451143451143, 1408.5844675820645, 1408.985910140899, 1419.6734751007268, 1439.366678661389, 13546.11950223236, 14277.857221427783, 14281.143131412122, 14344.641383965407, 14384.856151438482, 14130.22283774392, 15183.468578599752, 15216.619584510392, 15220.39118435264, 15221.162836044014, 2606.1530002749137, 2662.4275780707144, 2665.546857034299, 2665.9200223993216, 2667.039865648365, 2586.6249393837884, 2620.515204687139, 2647.8278911870666, 2654.190471906068, 2654.8008899332626, 2549.1587776033866, 2566.486702659466, 2609.569421045535, 2665.133831504759, 2672.0514217452815, 2534.4677617700304, 2552.119518766023, 2561.6157576363507, 2570.306017375317, 2573.29234460523, 2478.256523043098, 2486.6021436570063, 2503.674522312106, 2505.924822255335, 2509.04656230633, 13987.860121398757, 14044.859551404457, 14188.503402380971, 14230.786538201935, 14252.287385630678, 7280.089988751406, 7450.552966822008, 7489.550626962399, 7494.288042635995, 7520.586367749772, 4975.577075948549, 5045.669857893809, 5089.41471730752, 5172.120739474299, 5175.637705360627, 1923.7499125113786, 1932.4202739178331, 1941.5146213446637, 1979.1094007696595, 1983.6131954268924, 24124.0, 24130.638040429232, 24180.516389672284, 24265.514689706284, 24297.1495997641, 6298.0, 6318.147050148171, 6379.936200638027, 6570.901436478457, 6588.505862060365, 15541.611459713598, 16228.269727862275, 16288.185590720417, 16517.58706032359, 16567.834321656872, 7475.0656167979005, 7709.190534993857, 7720.073591169095, 7721.227877212346, 7727.92272077272, 7096.574205547684, 7131.500794944304, 7167.0, 7201.099862517185, 7215.278472152848, 5077.26379674945, 5147.124988751922, 5214.921776173361, 5221.530062294411, 5234.685918844805, 1469.977950330746, 1482.5181815909873, 1491.0829839648538, 1517.7647464642998, 1518.9012714173543, 825.859603867344, 851.3657325292696, 859.9828003439897, 868.522312727997, 879.7580665316962, 6708.597484150967, 6775.4240889524945, 6780.593164410151, 6790.8641827164165, 6840.897386539206, 658.3876994395258, 692.6744430117836, 703.145678001231, 723.7503061443794, 734.7097896331027, 4384.693071484965, 4515.661325400608, 4769.403824521934, 4843.927341089887, 4871.050145221719, 19602.411927641908, 19856.0, 20021.0, 20067.0, 20219.494512637302, 18866.0, 19682.70475942862, 19731.210751570063, 19743.506412339808, 19880.0, 11140.777184456265, 11327.093832493545, 11337.319760814213, 11359.0, 11415.42922853854, 7719.189485103983, 7903.091144518454, 7972.601369931596, 8026.237507436784, 8169.55067471271, 16833.074180920168, 16889.0, 17044.573885652957, 17102.230399632295, 17709.911450442665, 16844.410445634345, 17275.395361162802, 17292.740608890625, 17404.564885877953, 17454.040027798084, 13112.147710398793, 13438.328083595585, 13470.0, 13487.32563371847, 13487.662808429475, 13143.0, 13314.068015239227, 13383.665408364479, 13427.12723672958, 13536.390862411019, 10694.358338499715, 10755.838662420227, 10813.56745730162, 10834.891651083388, 11149.554017839195, 10624.256302059091, 10873.945630271797, 10944.835827462754, 11048.281861678965, 11123.833142502706, 9413.058694130532, 9458.196053335543, 9471.526423678926, 9472.052794720474, 9550.90449095528, 6815.079964204769, 6871.381575658214, 6891.517593768388, 6895.620740859301, 6936.826579335557, 6977.162740471176, 7002.089728335284, 7009.649517524205, 7035.929640703732, 7049.859002820018], "value": 6341.802493143915, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.4279460776999, 505.5071305477158, 521.6713470513577, 531.5541726503908, 531.8351311093559, 6205.0, 6278.623282603047, 6293.37066293371, 6316.115743795872, 6317.431431171193, 5942.88114237716, 6045.609509812745, 6095.542834287424, 6112.327643959161, 6130.344806902133, 4862.902741945159, 4919.786096256699, 4963.419022108502, 4992.375953005874, 5023.899522009558, 4852.175130227852, 4953.727544985024, 4961.231009193562, 5024.799008039674, 5039.44566097729, 4931.334269873575, 4933.506649335073, 4944.33251511045, 4991.151504244269, 4996.925046124311, 4976.4277108132665, 4988.625853061035, 5000.62495312853, 5012.774425150877, 5035.194368900977, 4457.732536047847, 4465.129299786543, 4501.369808226851, 4522.072975040109, 4542.523035081335, 6091.51267898567, 6103.511719062464, 6123.387661233841, 6149.3235744068115, 6167.259928808527, 5711.600187986843, 5737.569682273805, 5765.250517432749, 5767.682777447239, 5780.797672081499, 6482.805515834532, 6484.805455836333, 6499.2200935887995, 6569.244536878273, 6589.308122647149, 4827.468978412372, 4909.83315761332, 4923.4091908970795, 4928.0, 4938.80244790208, 6959.304069593, 6992.405645520086, 7013.123359580052, 7059.2234854166, 7073.151221853359, 5034.194528875362, 5038.345015148007, 5042.747862606929, 5050.72221027847, 5051.823186188466, 5110.8466745997675, 5113.335266415416, 5126.179811230185, 5128.820131518482, 5157.561607263349, 5771.624844385102, 5786.652800831964, 5790.189373487715, 5793.8841223175305, 5795.304563452412, 6610.735570577219, 6611.305812889577, 6627.966860165669, 6648.33516648341, 6676.699548520328, 1687.8902871313326, 1721.4663454329198, 1741.4949664597377, 1774.5360077935754, 1780.5192597998469, 1210.509743553862, 1224.4918358881143, 1240.8697086805937, 1245.638764758228, 1245.9439325230387, 5780.942190578125, 5806.1581070744505, 5831.067029275296, 5838.854028649318, 5859.941400586024, 6580.276169621337, 6743.56166849163, 6750.966245168743, 6769.661516924134, 6786.253512113663, 5727.541796656257, 5788.27646544182, 5813.941860581424, 5839.854003649858, 5865.853353666193, 3571.624979377128, 3612.2414292998237, 3616.4213725803747, 3618.9638103619154, 3636.2000359920776, 6656.0, 6665.200175978914, 6666.933330666631, 6681.331866813377, 6688.331166883273, 7009.369156775812, 7014.859702805916, 7018.684159212848, 7039.894401583981, 7082.087836284278, 6555.475561955032, 6592.439642630334, 6634.767783127568, 6650.667466626649, 6651.66741662915, 6783.525153239226, 6829.897551536632, 6830.282820303995, 6837.589744615339, 6855.451563874978, 6720.193576770819, 6723.865522689616, 6739.460843132636, 6775.728970841111, 6823.1812182538415, 6415.935840641534, 6531.542792004514, 6575.0, 6577.63822989721, 6645.408290766508, 4988.201887697951, 5038.345015148007, 5051.74741262928, 5066.670666406671, 5076.715478034973, 6461.224653041665, 6864.450843932374, 6867.725290988305, 6881.002254673144, 6913.619750913547, 6450.161479007699, 6509.088727578238, 6514.185726784152, 6554.180727409074, 6563.868722625425, 6527.11883895668, 6538.607683539003, 6595.472362211108, 6616.437602803816, 6635.236947750877, 6488.188976377953, 6505.154329937267, 6520.119783829312, 6534.738610455529, 6544.0, 6489.707963141575, 6620.569662971891, 6629.138212032405, 6639.40245377899, 6663.400293973566, 6451.838634057455, 6457.903131453126, 6472.385123413268, 6479.7408103675325, 6494.707738151889], "value": 5096.53201163188, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.6312180445116, 892.7500299916023, 908.6683360573388, 923.7598224461638, 926.1248120526097, 18009.909950450245, 18590.349337773147, 18721.62556748864, 18738.0, 22681.886590567065, 21418.357449276507, 21904.671429928563, 22051.33845984619, 22158.113675453, 22214.11143554256, 934.4953724988499, 942.2273735536862, 946.4274114160937, 946.8437707778243, 951.1772316945827, 956.3783540698532, 1011.8482227665835, 1022.1975749037008, 1026.0867827633413, 1027.6762819711766, 1060.3796778884362, 1065.477915821246, 1067.1089640150483, 1067.3489171605354, 1070.4219721350462, 1047.6176195688595, 1053.8419237114417, 1054.2936232724094, 1059.6079450603288, 1061.0, 784.0865391818525, 784.1296161260996, 784.1726978038167, 784.2745460449062, 786.7325109462753, 17869.46391608254, 19067.332643357553, 19115.235390584498, 19158.425247242605, 19180.520486987938, 16920.492385228463, 16959.0, 17295.135243237786, 17305.307787688478, 17400.21699023547, 16963.406280780237, 16980.132185459588, 17204.56988575283, 17219.82780172195, 17229.13854307292, 3555.3955827509385, 3640.0353906214873, 3657.4513822926506, 3658.798766067865, 3660.432632941898, 127144.36427817894, 127569.36215318956, 131220.99999999904, 131319.0, 132383.0, 16654.83345166557, 16848.157592120344, 16917.238724257437, 16926.15369231558, 17008.404705835237, 31510.842445788083, 31578.684213158034, 32146.83926580399, 32150.0, 32188.678113219037, 7667.0, 7992.480488768211, 8184.877226841602, 8284.917150828534, 8335.208155225244, 4106.301928672133, 4124.711270211116, 4186.581341865789, 4216.388623649554, 4224.028473451062, 5255.421903590602, 5353.170258609922, 5356.0, 5372.086745253317, 5426.403095659474, 1069.198101423932, 1075.4676435164642, 1088.5373716170595, 1089.3463921646949, 1090.9526854220037, 688.18793823288, 712.5760172697237, 715.9785206443815, 719.6221983458726, 721.9927800721925, 11991.100667449977, 12411.255324680547, 12581.433835477426, 12659.11386202957, 12992.870071299356, 689.8447849233883, 695.9443244540424, 705.7247673407272, 705.7388766156555, 706.3042902740797, 5409.026375252413, 5410.513053825096, 5448.42791506894, 5496.0, 5556.444355564411, 114307.0, 115264.0, 116397.41801290939, 118301.0, 121381.0, 95161.0, 98908.0, 99566.0, 104161.0, 104343.0, 83803.8098095105, 83994.0, 84263.0, 85238.14761852426, 86801.13198868057, 9610.231181505324, 9741.756456088371, 9818.214542836698, 9818.312718109664, 10006.249531285037, 37793.62206377901, 39265.0, 39986.20027599374, 40423.7978810104, 41237.79381103075, 49169.75415122901, 49747.25379119244, 49798.75100624474, 50223.74888125536, 51746.48253517417, 15722.449714259947, 16120.919395402949, 16158.192090395198, 16170.434034808724, 16246.918765406097, 17121.74317385265, 17415.912920435316, 17501.912490437466, 17512.38706645261, 17520.0, 15060.774088388902, 15143.242837857842, 15168.620784480476, 15237.847621524086, 15240.923795381395, 16290.266937987582, 16660.250288736792, 16680.66638667244, 16949.661006780043, 16986.15069246508, 15448.073115613099, 15510.767338490157, 15547.611309717347, 15784.60538486547, 15823.050616963019, 10827.67516974492, 10938.0, 11061.170412218955, 11092.944535277273, 11246.212765106364, 11102.111831053335, 11221.607243746756, 11587.015103715941, 14236.64408389757, 14742.0], "value": 8779.977922479511, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1541.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 108.0, 103.0, 107.0, 107.0, 112.0, 110.0, 100.0, 114.0, 109.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 116.0, 145.0, 185.0, 122.0, 145.0, 145.0, 121.0, 178.0, 121.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 163.0, 163.0, 162.0, 189.0, 162.0, 163.0, 172.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 165.0, 76.0, 79.0, 75.0, 80.0, 158.0, 76.0], "value": 93.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 78.0, 124.0, 80.0, 78.0, 80.0, 125.0, 78.0, 79.0, 139.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 122.0, 113.0, 113.0, 120.0, 118.0, 114.0], "value": 115.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 150.0, 152.0, 150.0, 150.0, 151.0, 150.0, 150.0, 152.0, 150.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 58.0, 54.0, 53.0, 61.0, 54.0, 62.0, 53.0, 53.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 55.0, 54.0, 54.0, 60.0, 54.0, 55.0, 54.0], "value": 54.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 81.0, 78.0, 79.0, 77.0, 78.0, 78.0, 78.0, 79.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 129.0, 122.0, 122.0, 125.0, 129.0, 128.0, 129.0, 163.0], "value": 131.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 183.0, 190.0, 178.0, 191.0, 176.0, 192.0, 180.0, 180.0, 199.0], "value": 184.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 69.0, 77.0, 69.0, 76.0, 68.0, 72.0, 72.0, 70.0, 68.0], "value": 71.6, "unit": "score"}]}]} 04:10:51 INFO - Return code: 0 04:10:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:10:51 INFO - # TBPL SUCCESS # 04:10:51 INFO - Running post-action listener: _package_coverage_data 04:10:51 INFO - Running post-action listener: _resource_record_post_action 04:10:51 INFO - [mozharness: 2017-08-14 11:10:51.263685Z] Finished run-tests step (success) 04:10:51 INFO - Running post-run listener: _resource_record_post_run 04:10:51 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 405504; Write bytes: 440791040; Read time: 96; Write time: 356160 04:10:51 INFO - TinderboxPrint: CPU usage
13.1% 04:10:51 INFO - TinderboxPrint: I/O read bytes / time
405,504 / 96 04:10:51 INFO - TinderboxPrint: I/O write bytes / time
440,791,040 / 356,160 04:10:51 INFO - TinderboxPrint: CPU idle
8,259.4 (86.8%) 04:10:51 INFO - TinderboxPrint: CPU user
1,201.2 (12.6%) 04:10:51 INFO - TinderboxPrint: Swap in / out
0 / 0 04:10:51 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 118710272; Read time: 0; Write time: 106516 04:10:51 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:10:51 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 405504; Write bytes: 322080768; Read time: 96; Write time: 249644 04:10:51 INFO - Running post-run listener: _upload_blobber_files 04:10:51 INFO - Blob upload gear active. 04:10:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:10:51 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 04:10:51 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'] 04:10:51 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 04:10:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:10:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:10:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:10:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:53 INFO - (blobuploader) - INFO - Done attempting. 04:10:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:10:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:10:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:54 INFO - (blobuploader) - INFO - Done attempting. 04:10:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:10:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:10:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:54 INFO - (blobuploader) - INFO - Done attempting. 04:10:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:10:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:11:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:11:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:11:01 INFO - (blobuploader) - INFO - Done attempting. 04:11:01 INFO - (blobuploader) - INFO - Iteration through files over. 04:11:01 INFO - Return code: 0 04:11:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:11:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:11:01 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e09046aa9ca8ca9290e0e1c88cf1fc630c2107c0017935c34b55406aa1c23ceb1554a9cf2451df1e5d58825ac6d70b85e7239ede611da99586fb8ca885fb985", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90fcc15babc7bea7f2989a7251b3424f1c52e0822f2b6078e253276344afdef7867b4cda934195f021003f837b5fd5397d93b93c4063bcc62bcd9b91a5534751", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce2bed4f398767d17a98b8b57760105e65090184bcee6da11b960db290aefded24d3e271b80e1f14c67617c959e621eb9c301512cf1a0524090f0e35eb8890b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5e979fac2e5dec3282e10844879775ddc18c3c79a455c3361cd44770435ecdc8c2efa55d9c1b52d08dd727e05d1ae3c98951f4f53024941de3b84b802509d85"} 04:11:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:11:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:11:01 INFO - Contents: 04:11:01 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e09046aa9ca8ca9290e0e1c88cf1fc630c2107c0017935c34b55406aa1c23ceb1554a9cf2451df1e5d58825ac6d70b85e7239ede611da99586fb8ca885fb985", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90fcc15babc7bea7f2989a7251b3424f1c52e0822f2b6078e253276344afdef7867b4cda934195f021003f837b5fd5397d93b93c4063bcc62bcd9b91a5534751", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce2bed4f398767d17a98b8b57760105e65090184bcee6da11b960db290aefded24d3e271b80e1f14c67617c959e621eb9c301512cf1a0524090f0e35eb8890b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5e979fac2e5dec3282e10844879775ddc18c3c79a455c3361cd44770435ecdc8c2efa55d9c1b52d08dd727e05d1ae3c98951f4f53024941de3b84b802509d85"} 04:11:01 INFO - Running post-run listener: copy_logs_to_upload_dir 04:11:01 INFO - Copying logs to upload dir... 04:11:01 INFO - mkdir: /builds/slave/test/build/upload/logs 04:11:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.819304 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-08-14 04:11:01.323897) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 04:11:01.331659) ========= 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=7de08804244eb36560b44971000001c3-1502705859.724837-544757484 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/5e09046aa9ca8ca9290e0e1c88cf1fc630c2107c0017935c34b55406aa1c23ceb1554a9cf2451df1e5d58825ac6d70b85e7239ede611da99586fb8ca885fb985", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90fcc15babc7bea7f2989a7251b3424f1c52e0822f2b6078e253276344afdef7867b4cda934195f021003f837b5fd5397d93b93c4063bcc62bcd9b91a5534751", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce2bed4f398767d17a98b8b57760105e65090184bcee6da11b960db290aefded24d3e271b80e1f14c67617c959e621eb9c301512cf1a0524090f0e35eb8890b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5e979fac2e5dec3282e10844879775ddc18c3c79a455c3361cd44770435ecdc8c2efa55d9c1b52d08dd727e05d1ae3c98951f4f53024941de3b84b802509d85"} build_url:https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011104 build_url: 'https://queue.taskcluster.net/v1/task/a-GT4NhbSgyPIRge8EWYUw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e09046aa9ca8ca9290e0e1c88cf1fc630c2107c0017935c34b55406aa1c23ceb1554a9cf2451df1e5d58825ac6d70b85e7239ede611da99586fb8ca885fb985", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90fcc15babc7bea7f2989a7251b3424f1c52e0822f2b6078e253276344afdef7867b4cda934195f021003f837b5fd5397d93b93c4063bcc62bcd9b91a5534751", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce2bed4f398767d17a98b8b57760105e65090184bcee6da11b960db290aefded24d3e271b80e1f14c67617c959e621eb9c301512cf1a0524090f0e35eb8890b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b5e979fac2e5dec3282e10844879775ddc18c3c79a455c3361cd44770435ecdc8c2efa55d9c1b52d08dd727e05d1ae3c98951f4f53024941de3b84b802509d85"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 04:11:01.359189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 04:11:01.359567) ========= 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=7de08804244eb36560b44971000001c3-1502705859.724837-544757484 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004437 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 04:11:01.440164) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 04:11:01.443488) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 04:11:01.444039) ========= ========= Total master_lag: 0.06 =========