builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1502865718.3 results: success (0) revision: 9ab2470a3210324bc11320531b15d195aaf05051 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:58.295780) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:58.296225) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:58.296496) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:58.325957) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:58.326259) ========= 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=41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 23:41:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-08-15 23:41:59 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.239026 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:58.580532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:58.583925) ========= 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=41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019103 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:58.636666) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:58.637005) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9ab2470a3210324bc11320531b15d195aaf05051 --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 9ab2470a3210324bc11320531b15d195aaf05051 --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=41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 23:41:59,129 truncating revision to first 12 chars 2017-08-15 23:41:59,129 Setting DEBUG logging. 2017-08-15 23:41:59,129 attempt 1/10 2017-08-15 23:41:59,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9ab2470a3210?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 23:41:59,496 unpacking tar archive at: mozilla-central-9ab2470a3210/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679518 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:59.334674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:59.335078) ========= script_repo_revision: 9ab2470a3210324bc11320531b15d195aaf05051 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:59.335512) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:59.335832) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 23:41:59.348115) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-08-15 23:41:59.348646) ========= /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=41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:42:00 INFO - MultiFileLogger online at 20170815 23:42:00 in /builds/slave/test 23:42:00 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 23:42:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:42:00 INFO - {'append_to_log': False, 23:42:00 INFO - 'base_work_dir': '/builds/slave/test', 23:42:00 INFO - 'blob_upload_branch': 'Firefox', 23:42:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:42:00 INFO - 'branch': 'Firefox', 23:42:00 INFO - 'buildbot_json_path': 'buildprops.json', 23:42:00 INFO - 'code_coverage': False, 23:42:00 INFO - 'config_files': ('talos/linux_config.py',), 23:42:00 INFO - 'default_actions': ('clobber', 23:42:00 INFO - 'read-buildbot-config', 23:42:00 INFO - 'download-and-extract', 23:42:00 INFO - 'populate-webroot', 23:42:00 INFO - 'create-virtualenv', 23:42:00 INFO - 'install', 23:42:00 INFO - 'setup-mitmproxy', 23:42:00 INFO - 'run-tests'), 23:42:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:42:00 INFO - 'disable_ccov_upload': False, 23:42:00 INFO - 'download_minidump_stackwalk': True, 23:42:00 INFO - 'download_symbols': 'ondemand', 23:42:00 INFO - 'enable_stylo': False, 23:42:00 INFO - 'enable_webrender': False, 23:42:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:42:00 INFO - 'tooltool.py': '/tools/tooltool.py', 23:42:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:42:00 INFO - '/tools/misc-python/virtualenv.py')}, 23:42:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:42:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:42:00 INFO - 'gecko_profile': False, 23:42:00 INFO - 'gecko_profile_interval': 0, 23:42:00 INFO - 'installer_path': 'installer.exe', 23:42:00 INFO - 'log_level': 'info', 23:42:00 INFO - 'log_name': 'talos', 23:42:00 INFO - 'log_to_console': True, 23:42:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:42:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:42:00 INFO - 'opt_config_files': (), 23:42:00 INFO - 'pip_index': False, 23:42:00 INFO - 'suite': 'dromaeojs-e10s', 23:42:00 INFO - 'system_bits': '32', 23:42:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:42:00 INFO - 'title': 'talos-linux64-ix-024', 23:42:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:42:00 INFO - 'use_talos_json': True, 23:42:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:42:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:42:00 INFO - 'work_dir': 'build'} 23:42:00 INFO - [mozharness: 2017-08-16 06:42:00.050470Z] Running clobber step. 23:42:00 INFO - Running pre-action listener: _resource_record_pre_action 23:42:00 INFO - Running main action method: clobber 23:42:00 INFO - rmtree: /builds/slave/test/build 23:42:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:42:01 INFO - Running post-action listener: _resource_record_post_action 23:42:01 INFO - [mozharness: 2017-08-16 06:42:01.033327Z] Finished clobber step (success) 23:42:01 INFO - [mozharness: 2017-08-16 06:42:01.033439Z] Running read-buildbot-config step. 23:42:01 INFO - Running pre-action listener: _resource_record_pre_action 23:42:01 INFO - Running main action method: read_buildbot_config 23:42:01 INFO - Using buildbot properties: 23:42:01 INFO - { 23:42:01 INFO - "project": "", 23:42:01 INFO - "product": "firefox", 23:42:01 INFO - "who": "asasaki@mozilla.com", 23:42:01 INFO - "installer_path": "public/build/target.tar.bz2", 23:42:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 23:42:01 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 23:42:01 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 23:42:01 INFO - "stage_platform": "linux64-stylosequential", 23:42:01 INFO - "basedir": "/builds/slave/test", 23:42:01 INFO - "buildnumber": 37, 23:42:01 INFO - "platform": "ubuntu64_hw_styloseq", 23:42:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:42:01 INFO - "slavebuilddir": "test", 23:42:01 INFO - "taskId": "dALXWjPpSZCoDYDObz_5fA", 23:42:01 INFO - "branch": "mozilla-central", 23:42:01 INFO - "script_repo_revision": "production", 23:42:01 INFO - "revision": "9ab2470a3210324bc11320531b15d195aaf05051", 23:42:01 INFO - "slavename": "talos-linux64-ix-024", 23:42:01 INFO - "repo_path": "mozilla-central" 23:42:01 INFO - } 23:42:01 INFO - Finding installer, test and symbols from parent task. 23:42:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dALXWjPpSZCoDYDObz_5fA'}, attempt #1 23:42:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dALXWjPpSZCoDYDObz_5fA'}, attempt #1 23:42:01 INFO - Task dependencies: d3FxelQfSZeBQxstE0lcrA 23:42:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA'}, attempt #1 23:42:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 23:42:02 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.test_packages.json 23:42:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.crashreporter-symbols.zip 23:42:02 INFO - Running post-action listener: _resource_record_post_action 23:42:02 INFO - [mozharness: 2017-08-16 06:42:02.362691Z] Finished read-buildbot-config step (success) 23:42:02 INFO - [mozharness: 2017-08-16 06:42:02.362913Z] Running download-and-extract step. 23:42:02 INFO - Running pre-action listener: _resource_record_pre_action 23:42:02 INFO - Running main action method: download_and_extract 23:42:02 INFO - mkdir: /builds/slave/test/build/tests 23:42:02 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')]} 23:42:02 INFO - trying https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.test_packages.json 23:42:02 INFO - Downloading https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 23:42:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 23:42:03 INFO - Downloaded 989 bytes. 23:42:03 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 23:42:03 INFO - Using the following test package requirements: 23:42:03 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 23:42:03 INFO - u'common': [u'target.common.tests.zip'], 23:42:03 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 23:42:03 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 23:42:03 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 23:42:03 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 23:42:03 INFO - u'mozbase': [u'target.common.tests.zip'], 23:42:03 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 23:42:03 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 23:42:03 INFO - u'web-platform': [u'target.common.tests.zip', 23:42:03 INFO - u'target.web-platform.tests.tar.gz'], 23:42:03 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 23:42:03 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 23:42:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip 23:42:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:42:03 INFO - Fetch https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip into memory 23:42:05 INFO - Content-Length response header: 54003984 23:42:05 INFO - Bytes received: 54003984 23:42:16 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 23:42:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip 23:42:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip'}, attempt #1 23:42:16 INFO - Fetch https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.common.tests.zip into memory 23:42:18 INFO - Content-Length response header: 54003984 23:42:18 INFO - Bytes received: 54003984 23:42:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.talos.tests.zip 23:42:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 23:42:30 INFO - Fetch https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.talos.tests.zip into memory 23:42:32 INFO - Content-Length response header: 14496050 23:42:32 INFO - Bytes received: 14496050 23:42:32 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')]} 23:42:32 INFO - trying https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 23:42:32 INFO - Downloading https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 23:42:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 23:42:33 INFO - Downloaded 61840933 bytes. 23:42:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 23:42:33 INFO - mkdir: /builds/slave/test/properties 23:42:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:42:33 INFO - Writing to file /builds/slave/test/properties/build_url 23:42:33 INFO - Contents: 23:42:33 INFO - build_url:https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 23:42:33 INFO - Running post-action listener: _resource_record_post_action 23:42:33 INFO - Running post-action listener: set_extra_try_arguments 23:42:33 INFO - [mozharness: 2017-08-16 06:42:33.762587Z] Finished download-and-extract step (success) 23:42:33 INFO - [mozharness: 2017-08-16 06:42:33.762686Z] Running populate-webroot step. 23:42:33 INFO - Running pre-action listener: _resource_record_pre_action 23:42:33 INFO - Running main action method: populate_webroot 23:42:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:42:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:42:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:42:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:42:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:42:33 INFO - 'tests': ['damp', 'tps']}, 23:42:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:42:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 23:42:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 23:42:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 23:42:33 INFO - 'other-e10s': {'tests': ['a11yr', 23:42:33 INFO - 'ts_paint', 23:42:33 INFO - 'tpaint', 23:42:33 INFO - 'sessionrestore', 23:42:33 INFO - 'sessionrestore_many_windows', 23:42:33 INFO - 'sessionrestore_no_auto_restore', 23:42:33 INFO - 'tabpaint']}, 23:42:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 23:42:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 23:42:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:42:33 INFO - 'tsvgr_opacity', 23:42:33 INFO - 'tart', 23:42:33 INFO - 'tscrollx', 23:42:33 INFO - 'tsvg_static']}, 23:42:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:42:33 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:42:33 INFO - 'talos_options': ['--mitmproxy', 23:42:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:42:33 INFO - '--firstNonBlankPaint'], 23:42:33 INFO - 'tests': ['tp6_google', 23:42:33 INFO - 'tp6_youtube', 23:42:33 INFO - 'tp6_amazon', 23:42:33 INFO - 'tp6_facebook']}, 23:42:33 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:42:33 INFO - 'talos_options': ['--stylo', 23:42:33 INFO - '--mitmproxy', 23:42:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:42:33 INFO - '--firstNonBlankPaint'], 23:42:33 INFO - 'tests': ['tp6_google', 23:42:33 INFO - 'tp6_youtube', 23:42:33 INFO - 'tp6_amazon', 23:42:33 INFO - 'tp6_facebook']}, 23:42:33 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 23:42:33 INFO - 'talos_options': ['--stylo', 23:42:33 INFO - '--stylo-threads=1', 23:42:33 INFO - '--mitmproxy', 23:42:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 23:42:33 INFO - '--firstNonBlankPaint'], 23:42:33 INFO - 'tests': ['tp6_google', 23:42:33 INFO - 'tp6_youtube', 23:42:33 INFO - 'tp6_amazon', 23:42:33 INFO - 'tp6_facebook']}, 23:42:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:42:33 INFO - 'talos_options': ['--xperf_path', 23:42:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:42:33 INFO - 'tests': ['tp5n']}}} 23:42:33 INFO - Running post-action listener: _resource_record_post_action 23:42:33 INFO - [mozharness: 2017-08-16 06:42:33.771697Z] Finished populate-webroot step (success) 23:42:33 INFO - [mozharness: 2017-08-16 06:42:33.771787Z] Running create-virtualenv step. 23:42:33 INFO - Running pre-action listener: _resource_record_pre_action 23:42:33 INFO - Running main action method: create_virtualenv 23:42:33 INFO - Creating virtualenv /builds/slave/test/build/venv 23:42:33 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 23:42:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:42:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 23:42:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:42:34 INFO - Using real prefix '/usr' 23:42:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:42:34 INFO - Installing distribute.............................................................................................................................................................................................done. 23:42:36 INFO - Installing pip.................done. 23:42:36 INFO - Return code: 0 23:42:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:42:37 INFO - Reading from file tmpfile_stdout 23:42:37 INFO - Output received: 23:42:37 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) 23:42:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:42:37 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')]} 23:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:37 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')]} 23:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:37 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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccec30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccbcc0>, '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 0x1ccccd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd160>, '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': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', '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 23:42:37 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 23:42:37 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 23:42:37 INFO - Using env: {'DISPLAY': ':0', 23:42:37 INFO - 'HOME': '/home/cltbld', 23:42:37 INFO - 'LANG': 'en_US.UTF-8', 23:42:37 INFO - 'LANGUAGE': 'en_US:en', 23:42:37 INFO - 'LOGNAME': 'cltbld', 23:42:37 INFO - 'MAIL': '/var/mail/cltbld', 23:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:37 INFO - 'MOZ_NO_REMOTE': '1', 23:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:37 INFO - 'NO_EM_RESTART': '1', 23:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:37 INFO - 'PWD': '/builds/slave/test', 23:42:37 INFO - 'SHELL': '/bin/bash', 23:42:37 INFO - 'SHLVL': '1', 23:42:37 INFO - 'TERM': 'linux', 23:42:37 INFO - 'TMOUT': '86400', 23:42:37 INFO - 'USER': 'cltbld', 23:42:37 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', 23:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:37 INFO - '_': '/tools/buildbot/bin/python'} 23:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:37 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 23:42:37 INFO - Cleaning up... 23:42:37 INFO - Return code: 0 23:42:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:42:37 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')]} 23:42:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:37 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')]} 23:42:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:37 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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccec30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccbcc0>, '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 0x1ccccd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd160>, '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': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', '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 23:42:37 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 23:42:37 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 23:42:37 INFO - Using env: {'DISPLAY': ':0', 23:42:37 INFO - 'HOME': '/home/cltbld', 23:42:37 INFO - 'LANG': 'en_US.UTF-8', 23:42:37 INFO - 'LANGUAGE': 'en_US:en', 23:42:37 INFO - 'LOGNAME': 'cltbld', 23:42:37 INFO - 'MAIL': '/var/mail/cltbld', 23:42:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:37 INFO - 'MOZ_NO_REMOTE': '1', 23:42:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:37 INFO - 'NO_EM_RESTART': '1', 23:42:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:37 INFO - 'PWD': '/builds/slave/test', 23:42:37 INFO - 'SHELL': '/bin/bash', 23:42:37 INFO - 'SHLVL': '1', 23:42:37 INFO - 'TERM': 'linux', 23:42:37 INFO - 'TMOUT': '86400', 23:42:37 INFO - 'USER': 'cltbld', 23:42:37 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', 23:42:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:37 INFO - '_': '/tools/buildbot/bin/python'} 23:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:37 INFO - Downloading/unpacking psutil>=3.1.1 23:42:37 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 23:42:37 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 23:42:37 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 23:42:37 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 23:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:42:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:42:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:42:38 INFO - Installing collected packages: psutil 23:42:38 INFO - Running setup.py install for psutil 23:42:39 INFO - building 'psutil._psutil_linux' extension 23:42:39 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 23:42:39 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 23:42:40 INFO - building 'psutil._psutil_posix' extension 23:42:40 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 23:42:40 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 23:42:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:42:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:42:40 INFO - Successfully installed psutil 23:42:40 INFO - Cleaning up... 23:42:40 INFO - Return code: 0 23:42:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:42: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')]} 23:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42: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')]} 23:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccec30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccbcc0>, '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 0x1ccccd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd160>, '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': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', '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 23:42: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:42: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 mozsystemmonitor==0.3 23:42:40 INFO - Using env: {'DISPLAY': ':0', 23:42:40 INFO - 'HOME': '/home/cltbld', 23:42:40 INFO - 'LANG': 'en_US.UTF-8', 23:42:40 INFO - 'LANGUAGE': 'en_US:en', 23:42:40 INFO - 'LOGNAME': 'cltbld', 23:42:40 INFO - 'MAIL': '/var/mail/cltbld', 23:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:40 INFO - 'MOZ_NO_REMOTE': '1', 23:42:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:40 INFO - 'NO_EM_RESTART': '1', 23:42:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:40 INFO - 'PWD': '/builds/slave/test', 23:42:40 INFO - 'SHELL': '/bin/bash', 23:42:40 INFO - 'SHLVL': '1', 23:42:40 INFO - 'TERM': 'linux', 23:42:40 INFO - 'TMOUT': '86400', 23:42:40 INFO - 'USER': 'cltbld', 23:42:40 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', 23:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:40 INFO - '_': '/tools/buildbot/bin/python'} 23:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:42: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 23:42: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 23:42: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 23:42: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 23:42:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:42:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:42:41 INFO - Installing collected packages: mozsystemmonitor 23:42:41 INFO - Running setup.py install for mozsystemmonitor 23:42:41 INFO - Successfully installed mozsystemmonitor 23:42:41 INFO - Cleaning up... 23:42:41 INFO - Return code: 0 23:42:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccec30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccbcc0>, '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 0x1ccccd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd160>, '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': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', '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 23:42:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:42:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:42:41 INFO - Using env: {'DISPLAY': ':0', 23:42:41 INFO - 'HOME': '/home/cltbld', 23:42:41 INFO - 'LANG': 'en_US.UTF-8', 23:42:41 INFO - 'LANGUAGE': 'en_US:en', 23:42:41 INFO - 'LOGNAME': 'cltbld', 23:42:41 INFO - 'MAIL': '/var/mail/cltbld', 23:42:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:41 INFO - 'MOZ_NO_REMOTE': '1', 23:42:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:41 INFO - 'NO_EM_RESTART': '1', 23:42:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:41 INFO - 'PWD': '/builds/slave/test', 23:42:41 INFO - 'SHELL': '/bin/bash', 23:42:41 INFO - 'SHLVL': '1', 23:42:41 INFO - 'TERM': 'linux', 23:42:41 INFO - 'TMOUT': '86400', 23:42:41 INFO - 'USER': 'cltbld', 23:42:41 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', 23:42:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:41 INFO - '_': '/tools/buildbot/bin/python'} 23:42:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:42 INFO - Downloading/unpacking jsonschema==2.5.1 23:42: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 23:42: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 23:42: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 23:42: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 23:42:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:42:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:43 INFO - Downloading functools32-3.2.3-2.tar.gz 23:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:42:43 INFO - warning: no files found matching '*.txt' 23:42:43 INFO - no previously-included directories found matching 'build' 23:42:43 INFO - no previously-included directories found matching 'dist' 23:42:43 INFO - no previously-included directories found matching '.git*' 23:42:43 INFO - Installing collected packages: jsonschema, functools32 23:42:43 INFO - Running setup.py install for functools32 23:42:43 INFO - warning: no files found matching '*.txt' 23:42:43 INFO - no previously-included directories found matching 'build' 23:42:43 INFO - no previously-included directories found matching 'dist' 23:42:43 INFO - no previously-included directories found matching '.git*' 23:42:43 INFO - Successfully installed jsonschema functools32 23:42:43 INFO - Cleaning up... 23:42:43 INFO - Return code: 0 23:42:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:42: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')]} 23:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42: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')]} 23:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42: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', '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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccec30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccbcc0>, '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 0x1ccccd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd160>, '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': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', '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 23:42: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:42: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 functools32==3.2.3-2 23:42:43 INFO - Using env: {'DISPLAY': ':0', 23:42:43 INFO - 'HOME': '/home/cltbld', 23:42:43 INFO - 'LANG': 'en_US.UTF-8', 23:42:43 INFO - 'LANGUAGE': 'en_US:en', 23:42:43 INFO - 'LOGNAME': 'cltbld', 23:42:43 INFO - 'MAIL': '/var/mail/cltbld', 23:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:43 INFO - 'MOZ_NO_REMOTE': '1', 23:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:43 INFO - 'NO_EM_RESTART': '1', 23:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:43 INFO - 'PWD': '/builds/slave/test', 23:42:43 INFO - 'SHELL': '/bin/bash', 23:42:43 INFO - 'SHLVL': '1', 23:42:43 INFO - 'TERM': 'linux', 23:42:43 INFO - 'TMOUT': '86400', 23:42:43 INFO - 'USER': 'cltbld', 23:42:43 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', 23:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:43 INFO - '_': '/tools/buildbot/bin/python'} 23:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:42:43 INFO - Cleaning up... 23:42:43 INFO - Return code: 0 23:42:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:42: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')]} 23:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42: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')]} 23:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42: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', '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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccec30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccbcc0>, '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 0x1ccccd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd160>, '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': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', '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 23:42: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:42: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 blobuploader==1.2.4 23:42:43 INFO - Using env: {'DISPLAY': ':0', 23:42:43 INFO - 'HOME': '/home/cltbld', 23:42:43 INFO - 'LANG': 'en_US.UTF-8', 23:42:43 INFO - 'LANGUAGE': 'en_US:en', 23:42:43 INFO - 'LOGNAME': 'cltbld', 23:42:43 INFO - 'MAIL': '/var/mail/cltbld', 23:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:43 INFO - 'MOZ_NO_REMOTE': '1', 23:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:43 INFO - 'NO_EM_RESTART': '1', 23:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:43 INFO - 'PWD': '/builds/slave/test', 23:42:43 INFO - 'SHELL': '/bin/bash', 23:42:43 INFO - 'SHLVL': '1', 23:42:43 INFO - 'TERM': 'linux', 23:42:43 INFO - 'TMOUT': '86400', 23:42:43 INFO - 'USER': 'cltbld', 23:42:43 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', 23:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:43 INFO - '_': '/tools/buildbot/bin/python'} 23:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:43 INFO - Downloading/unpacking blobuploader==1.2.4 23:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:42:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:42:45 INFO - Downloading blobuploader-1.2.4.tar.gz 23:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:42:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:42: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 23:42: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 23:42: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 23:42: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 23:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:42:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:42: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 23:42: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 23:42: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 23:42: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 23:42:45 INFO - Downloading docopt-0.6.1.tar.gz 23:42:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:42:45 INFO - Installing collected packages: blobuploader, requests, docopt 23:42:45 INFO - Running setup.py install for blobuploader 23:42:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:42:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:42:45 INFO - Running setup.py install for requests 23:42:46 INFO - Running setup.py install for docopt 23:42:46 INFO - Successfully installed blobuploader requests docopt 23:42:46 INFO - Cleaning up... 23:42:46 INFO - Return code: 0 23:42:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:46 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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccec30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccbcc0>, '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 0x1ccccd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd160>, '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': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', '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 23:42:46 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 23:42:46 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 23:42:46 INFO - Using env: {'DISPLAY': ':0', 23:42:46 INFO - 'HOME': '/home/cltbld', 23:42:46 INFO - 'LANG': 'en_US.UTF-8', 23:42:46 INFO - 'LANGUAGE': 'en_US:en', 23:42:46 INFO - 'LOGNAME': 'cltbld', 23:42:46 INFO - 'MAIL': '/var/mail/cltbld', 23:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:46 INFO - 'MOZ_NO_REMOTE': '1', 23:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:46 INFO - 'NO_EM_RESTART': '1', 23:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:46 INFO - 'PWD': '/builds/slave/test', 23:42:46 INFO - 'SHELL': '/bin/bash', 23:42:46 INFO - 'SHLVL': '1', 23:42:46 INFO - 'TERM': 'linux', 23:42:46 INFO - 'TMOUT': '86400', 23:42:46 INFO - 'USER': 'cltbld', 23:42:46 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', 23:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:46 INFO - '_': '/tools/buildbot/bin/python'} 23:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:42:46 INFO - Running setup.py (path:/tmp/pip-0NctPg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:42:46 INFO - Running setup.py (path:/tmp/pip-NKlH6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:42:46 INFO - Running setup.py (path:/tmp/pip-QPqjh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:42:46 INFO - Running setup.py (path:/tmp/pip-HOnVn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:42:46 INFO - Running setup.py (path:/tmp/pip-tzQiNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:42:46 INFO - Running setup.py (path:/tmp/pip-D2Znu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:42:46 INFO - Running setup.py (path:/tmp/pip-5t_Uj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:42:46 INFO - Running setup.py (path:/tmp/pip-lZ1Ifn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:42:47 INFO - Running setup.py (path:/tmp/pip-iF1vqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:42:47 INFO - Running setup.py (path:/tmp/pip-iHD90e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:42:47 INFO - Running setup.py (path:/tmp/pip-pHAtfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:42:47 INFO - Running setup.py (path:/tmp/pip-FlecWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:42:47 INFO - Running setup.py (path:/tmp/pip-pKh5cB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:42:47 INFO - Running setup.py (path:/tmp/pip-Z5wKFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:47 INFO - Running setup.py (path:/tmp/pip-zeS8AI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:42:47 INFO - Running setup.py (path:/tmp/pip-fvqRCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:42:47 INFO - Running setup.py (path:/tmp/pip-F_zbvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:42:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:42:47 INFO - Running setup.py install for manifestparser 23:42:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:42:47 INFO - Running setup.py install for mozcrash 23:42:47 INFO - Running setup.py install for mozdebug 23:42:47 INFO - Running setup.py install for mozdevice 23:42:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:42:48 INFO - Running setup.py install for mozfile 23:42:48 INFO - Running setup.py install for mozhttpd 23:42:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:42:48 INFO - Running setup.py install for mozinfo 23:42:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:42:48 INFO - Running setup.py install for mozInstall 23:42:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:42:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:42:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:42:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:42:48 INFO - Running setup.py install for mozleak 23:42:48 INFO - Running setup.py install for mozlog 23:42:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:42:48 INFO - Running setup.py install for moznetwork 23:42:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:42:48 INFO - Running setup.py install for mozprocess 23:42:48 INFO - Running setup.py install for mozprofile 23:42:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:42:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:42:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:42:48 INFO - Running setup.py install for mozrunner 23:42:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:42:49 INFO - Running setup.py install for mozscreenshot 23:42:49 INFO - Running setup.py install for moztest 23:42:49 INFO - Running setup.py install for mozversion 23:42:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:42:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:42:49 INFO - Cleaning up... 23:42:49 INFO - Return code: 0 23:42:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:49 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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccec30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccbcc0>, '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 0x1ccccd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd160>, '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': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', '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 23:42:49 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 23:42:49 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 23:42:49 INFO - Using env: {'DISPLAY': ':0', 23:42:49 INFO - 'HOME': '/home/cltbld', 23:42:49 INFO - 'LANG': 'en_US.UTF-8', 23:42:49 INFO - 'LANGUAGE': 'en_US:en', 23:42:49 INFO - 'LOGNAME': 'cltbld', 23:42:49 INFO - 'MAIL': '/var/mail/cltbld', 23:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:49 INFO - 'MOZ_NO_REMOTE': '1', 23:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:49 INFO - 'NO_EM_RESTART': '1', 23:42:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:49 INFO - 'PWD': '/builds/slave/test', 23:42:49 INFO - 'SHELL': '/bin/bash', 23:42:49 INFO - 'SHLVL': '1', 23:42:49 INFO - 'TERM': 'linux', 23:42:49 INFO - 'TMOUT': '86400', 23:42:49 INFO - 'USER': 'cltbld', 23:42:49 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', 23:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:49 INFO - '_': '/tools/buildbot/bin/python'} 23:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:42:49 INFO - Running setup.py (path:/tmp/pip-0EdbK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:42:49 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)) 23:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:42:49 INFO - Running setup.py (path:/tmp/pip-aqliS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:42:49 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)) 23:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:42:49 INFO - Running setup.py (path:/tmp/pip-_3OcIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:42:49 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)) 23:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:42:49 INFO - Running setup.py (path:/tmp/pip-YsnlqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:42:49 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)) 23:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:42:49 INFO - Running setup.py (path:/tmp/pip-Gh6yYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:42:50 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)) 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:42:50 INFO - Running setup.py (path:/tmp/pip-q7Ujr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:42:50 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)) 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:42:50 INFO - Running setup.py (path:/tmp/pip-kyECa8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:42:50 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)) 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:42:50 INFO - Running setup.py (path:/tmp/pip-7wMV2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:42:50 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)) 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:42:50 INFO - Running setup.py (path:/tmp/pip-N9Bqju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:42:50 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)) 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:42:50 INFO - Running setup.py (path:/tmp/pip-tt9grE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:42:50 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)) 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:42:50 INFO - Running setup.py (path:/tmp/pip-q6bSA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:42:50 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)) 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:42:50 INFO - Running setup.py (path:/tmp/pip-xvXciq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:42:50 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)) 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:42:50 INFO - Running setup.py (path:/tmp/pip-UaCptG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:42:50 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)) 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:42:50 INFO - Running setup.py (path:/tmp/pip-vBo8QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:42:50 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)) 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:50 INFO - Running setup.py (path:/tmp/pip-OTlkFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:42:50 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)) 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:42:50 INFO - Running setup.py (path:/tmp/pip-HDfIA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:42:50 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)) 23:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:42:50 INFO - Running setup.py (path:/tmp/pip-wjTCum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:42:50 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)) 23:42:50 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)) 23:42:50 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)) 23:42:50 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)) 23:42:50 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)) 23:42:50 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)) 23:42:50 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)) 23:42:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:42:50 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 23:42:50 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 23:42:50 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 23:42:50 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 23:42:52 INFO - Downloading blessings-1.6.tar.gz 23:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:42:52 INFO - Installing collected packages: blessings 23:42:52 INFO - Running setup.py install for blessings 23:42:52 INFO - Successfully installed blessings 23:42:52 INFO - Cleaning up... 23:42:52 INFO - Return code: 0 23:42:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:42:52 INFO - Reading from file tmpfile_stdout 23:42:52 INFO - Current package versions: 23:42:52 INFO - argparse == 1.2.1 23:42:52 INFO - blessings == 1.6 23:42:52 INFO - blobuploader == 1.2.4 23:42:52 INFO - docopt == 0.6.1 23:42:52 INFO - functools32 == 3.2.3-2 23:42:52 INFO - jsonschema == 2.5.1 23:42:52 INFO - manifestparser == 1.1 23:42:52 INFO - mozInstall == 1.13 23:42:52 INFO - mozcrash == 1.0 23:42:52 INFO - mozdebug == 0.1 23:42:52 INFO - mozdevice == 0.51 23:42:52 INFO - mozfile == 1.2 23:42:52 INFO - mozhttpd == 0.7 23:42:52 INFO - mozinfo == 0.10 23:42:52 INFO - mozleak == 0.1 23:42:52 INFO - mozlog == 3.5 23:42:52 INFO - moznetwork == 0.27 23:42:52 INFO - mozprocess == 0.25 23:42:52 INFO - mozprofile == 0.28 23:42:52 INFO - mozrunner == 6.13 23:42:52 INFO - mozscreenshot == 0.1 23:42:52 INFO - mozsystemmonitor == 0.3 23:42:52 INFO - moztest == 0.8 23:42:52 INFO - mozversion == 1.4 23:42:52 INFO - psutil == 3.1.1 23:42:52 INFO - requests == 1.2.3 23:42:52 INFO - wsgiref == 0.1.2 23:42:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:42:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:52 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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccec30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccbcc0>, '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 0x1ccccd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd160>, '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': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', '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 23:42:52 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 23:42:52 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 23:42:52 INFO - Using env: {'DISPLAY': ':0', 23:42:52 INFO - 'HOME': '/home/cltbld', 23:42:52 INFO - 'LANG': 'en_US.UTF-8', 23:42:52 INFO - 'LANGUAGE': 'en_US:en', 23:42:52 INFO - 'LOGNAME': 'cltbld', 23:42:52 INFO - 'MAIL': '/var/mail/cltbld', 23:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:52 INFO - 'MOZ_NO_REMOTE': '1', 23:42:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:52 INFO - 'NO_EM_RESTART': '1', 23:42:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:52 INFO - 'PWD': '/builds/slave/test', 23:42:52 INFO - 'SHELL': '/bin/bash', 23:42:52 INFO - 'SHLVL': '1', 23:42:52 INFO - 'TERM': 'linux', 23:42:52 INFO - 'TMOUT': '86400', 23:42:52 INFO - 'USER': 'cltbld', 23:42:52 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', 23:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:52 INFO - '_': '/tools/buildbot/bin/python'} 23:42:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:52 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)) 23:42:52 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)) 23:42:52 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)) 23:42:52 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)) 23:42:52 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)) 23:42:52 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)) 23:42:52 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)) 23:42:52 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)) 23:42:52 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)) 23:42:52 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 23:42:52 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 23:42:52 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 23:42:52 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 23:42:52 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 23:42:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 23:42:53 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)) 23:42:53 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)) 23:42:53 INFO - Installing collected packages: simplejson 23:42:53 INFO - Running setup.py install for simplejson 23:42:53 INFO - building 'simplejson._speedups' extension 23:42:53 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 23:42:54 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 23:42:54 INFO - Successfully installed simplejson 23:42:54 INFO - Cleaning up... 23:42:54 INFO - Return code: 0 23:42:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:42: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')]} 23:42:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:42: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')]} 23:42:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:42:54 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 0x1a271f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b2ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccec30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ccbcc0>, '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 0x1ccccd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd160>, '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': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', '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 23:42:54 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 23:42:54 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 23:42:54 INFO - Using env: {'DISPLAY': ':0', 23:42:54 INFO - 'HOME': '/home/cltbld', 23:42:54 INFO - 'LANG': 'en_US.UTF-8', 23:42:54 INFO - 'LANGUAGE': 'en_US:en', 23:42:54 INFO - 'LOGNAME': 'cltbld', 23:42:54 INFO - 'MAIL': '/var/mail/cltbld', 23:42:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:42:54 INFO - 'MOZ_NO_REMOTE': '1', 23:42:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:42:54 INFO - 'NO_EM_RESTART': '1', 23:42:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:42:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:42:54 INFO - 'PWD': '/builds/slave/test', 23:42:54 INFO - 'SHELL': '/bin/bash', 23:42:54 INFO - 'SHLVL': '1', 23:42:54 INFO - 'TERM': 'linux', 23:42:54 INFO - 'TMOUT': '86400', 23:42:54 INFO - 'USER': 'cltbld', 23:42:54 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', 23:42:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:42:54 INFO - '_': '/tools/buildbot/bin/python'} 23:42:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:42:55 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:42:55 INFO - Cleaning up... 23:42:55 INFO - Return code: 0 23:42:55 INFO - Running post-action listener: _resource_record_post_action 23:42:55 INFO - Running post-action listener: _start_resource_monitoring 23:42:55 INFO - Starting resource monitoring. 23:42:55 INFO - [mozharness: 2017-08-16 06:42:55.223363Z] Finished create-virtualenv step (success) 23:42:55 INFO - [mozharness: 2017-08-16 06:42:55.224304Z] Running install step. 23:42:55 INFO - Running pre-action listener: _resource_record_pre_action 23:42:55 INFO - Running main action method: install 23:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:42:55 INFO - Reading from file tmpfile_stdout 23:42:55 INFO - Detecting whether we're running mozinstall >=1.0... 23:42:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:42:55 INFO - Reading from file tmpfile_stdout 23:42:55 INFO - Output received: 23:42:55 INFO - Usage: mozinstall [options] installer 23:42:55 INFO - Options: 23:42:55 INFO - -h, --help show this help message and exit 23:42:55 INFO - -d DEST, --destination=DEST 23:42:55 INFO - Directory to install application into. [default: 23:42:55 INFO - "/builds/slave/test"] 23:42:55 INFO - --app=APP Application being installed. [default: firefox] 23:42:55 INFO - mkdir: /builds/slave/test/build/application 23:42:55 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'] 23:42:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 23:43:13 INFO - Reading from file tmpfile_stdout 23:43:13 INFO - Output received: 23:43:13 INFO - /builds/slave/test/build/application/firefox/firefox 23:43:13 INFO - Running post-action listener: _resource_record_post_action 23:43:13 INFO - [mozharness: 2017-08-16 06:43:13.528521Z] Finished install step (success) 23:43:13 INFO - [mozharness: 2017-08-16 06:43:13.528630Z] Running setup-mitmproxy step. 23:43:13 INFO - Running pre-action listener: _resource_record_pre_action 23:43:13 INFO - Running main action method: setup_mitmproxy 23:43:13 INFO - Skipping: mitmproxy is not required 23:43:13 INFO - Running post-action listener: _resource_record_post_action 23:43:13 INFO - [mozharness: 2017-08-16 06:43:13.529117Z] Finished setup-mitmproxy step (success) 23:43:13 INFO - [mozharness: 2017-08-16 06:43:13.529210Z] Running run-tests step. 23:43:13 INFO - Running pre-action listener: _resource_record_pre_action 23:43:13 INFO - Running pre-action listener: _set_gcov_prefix 23:43:13 INFO - Running main action method: run_tests 23:43:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:43:13 INFO - Python 2.7.3 23:43:13 INFO - Return code: 0 23:43:13 INFO - grabbing minidump binary from tooltool 23:43:13 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')]} 23:43:13 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 0x1ccbcc0>, '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 0x1ccccd0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ccd160>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:43:13 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 23:43:13 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 23:43:13 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 23:43:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:43:13 INFO - Return code: 0 23:43:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:43:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:43:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:43:13 INFO - ENV: RUST_BACKTRACE is now full 23:43:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:43:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:43:13 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/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 23:43:13 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/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 23:43:13 INFO - Using env: {'DISPLAY': ':0', 23:43:13 INFO - 'HOME': '/home/cltbld', 23:43:13 INFO - 'LANG': 'en_US.UTF-8', 23:43:13 INFO - 'LANGUAGE': 'en_US:en', 23:43:13 INFO - 'LOGNAME': 'cltbld', 23:43:13 INFO - 'MAIL': '/var/mail/cltbld', 23:43:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:43:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:43:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:43:13 INFO - 'MOZ_NO_REMOTE': '1', 23:43:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:43:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:43:13 INFO - 'NO_EM_RESTART': '1', 23:43:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:43:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:43:13 INFO - 'PWD': '/builds/slave/test', 23:43:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:43:13 INFO - 'RUST_BACKTRACE': 'full', 23:43:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 23:43:13 INFO - 'SHELL': '/bin/bash', 23:43:13 INFO - 'SHLVL': '1', 23:43:13 INFO - 'STYLO_FORCE_ENABLED': '1', 23:43:13 INFO - 'TERM': 'linux', 23:43:13 INFO - 'TMOUT': '86400', 23:43:13 INFO - 'USER': 'cltbld', 23:43:13 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724', 23:43:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:43:13 INFO - '_': '/tools/buildbot/bin/python'} 23:43:13 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/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 23:43:13 INFO - mozversion application_buildid: 20170816055606 23:43:13 INFO - mozversion application_changeset: 9ab2470a3210324bc11320531b15d195aaf05051 23:43:13 INFO - mozversion application_display_name: Nightly 23:43:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:43:13 INFO - mozversion application_name: Firefox 23:43:13 INFO - mozversion application_remotingname: firefox 23:43:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:43:13 INFO - mozversion application_vendor: Mozilla 23:43:13 INFO - mozversion application_version: 57.0a1 23:43:13 INFO - mozversion platform_buildid: 20170816055606 23:43:13 INFO - mozversion platform_changeset: 9ab2470a3210324bc11320531b15d195aaf05051 23:43:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:43:13 INFO - mozversion platform_version: 57.0a1 23:43:13 INFO - using testdate: 1502865793 23:43:13 INFO - actual date: 1502865793 23:43:13 INFO - starting webserver on 'localhost:59956' 23:43:13 INFO - SUITE-START | Running 2 tests 23:43:13 INFO - TEST-START | dromaeo_css 23:43:13 INFO - Initialising browser for dromaeo_css test... 23:43:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59956/getInfo.html -profile /tmp/tmpfbd1XZ/profile 23:43:13 INFO - TEST-INFO | started process 3301 (/builds/slave/test/build/application/firefox/firefox http://localhost:59956/getInfo.html) 23:43:23 INFO - TEST-INFO | 3301: exit 0 23:43:23 INFO - Browser initialized. 23:43:23 INFO - Running cycle 1/1 for dromaeo_css test... 23:43:23 INFO - TEST-INFO | started process 3494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfbd1XZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 23:43:25 INFO - PID 3494 | 23:43:25 INFO - PID 3494 | (/builds/slave/test/build/application/firefox/firefox:3547): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 23:43:25 INFO - PID 3494 | 23:43:35 INFO - PID 3494 | RSS: Main: 170881024 23:43:35 INFO - PID 3494 | 23:46:34 INFO - PID 3494 | Cycle 1(1): loaded http://localhost:59956/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59956/tests/dromaeo/cssquery-ext.html) 23:46:36 INFO - PID 3494 | RSS: Main: 175042560 23:46:36 INFO - PID 3494 | 23:49:37 INFO - PID 3494 | Cycle 1(1): loaded http://localhost:59956/tests/dromaeo/cssquery-ext.html (next: http://localhost:59956/tests/dromaeo/cssquery-jquery.html) 23:49:38 INFO - PID 3494 | RSS: Main: 171466752 23:49:38 INFO - PID 3494 | 23:52:40 INFO - PID 3494 | Cycle 1(1): loaded http://localhost:59956/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59956/tests/dromaeo/cssquery-mootools.html) 23:52:40 INFO - PID 3494 | RSS: Main: 174706688 23:52:40 INFO - PID 3494 | 23:55:42 INFO - PID 3494 | Cycle 1(1): loaded http://localhost:59956/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59956/tests/dromaeo/cssquery-prototype.html) 23:55:43 INFO - PID 3494 | RSS: Main: 174153728 23:55:43 INFO - PID 3494 | 23:58:46 INFO - PID 3494 | Cycle 1(1): loaded http://localhost:59956/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59956/tests/dromaeo/cssquery-yui.html) 23:58:47 INFO - PID 3494 | RSS: Main: 176902144 23:58:47 INFO - PID 3494 | 00:01:49 INFO - PID 3494 | Cycle 1(1): loaded http://localhost:59956/tests/dromaeo/cssquery-yui.html (next: http://localhost:59956/tests/dromaeo/cssquery-dojo.html) 00:01:49 INFO - PID 3494 | RSS: Main: 178118656 00:01:49 INFO - PID 3494 | 00:01:49 INFO - PID 3494 | __start_tp_report 00:01:49 INFO - PID 3494 | _x_x_mozilla_page_load 00:01:49 INFO - PID 3494 | _x_x_mozilla_page_load_details 00:01:49 INFO - PID 3494 | |i|pagename|runs| 00:01:49 INFO - PID 3494 | |0;dojo.html;3127.0462508934775;3129.76526760493;3163;3172.8413579321027;3185.124090875009;6152.907706384408;6199.938000619993;6237.750489980401;6238.906416403752;6267.122602835601;6101.450869421751;6174.660393678346;6186.195794546703;6188.81433556994;6195.504359651229;5636.0982242841155;5645.774169033234;5666.150077488369;5683.914741278884;5692.57305702072;5758.856028599298;5763.0779075347955;5781.942180578203;5800.651960882339;5872.119182122673;5646.604737668365;5723.370429252779;5732.5127364174095;5772.913406298909;5807.477327040566;5484.204790305424;5560.582956278296;5638.689872057035;5722.2561067061015;5766.481016708474;5655.3779084300695;5660.971695141498;5740.54075673945;5744.167095771131;5753.741081651336;5928.49607783339;6092.451679348836;6133.080037994292;6179.16581261533;6232.563720539564;6581.605103693746;6602;6602.9669851650915;6617.636030018347;6620.470362370998;6641.93358066418;6645.302243264436;6653.60078395293;6657;6681.665916704194;6170.352113028157;6171.382861713838;6179;6183.598066125733;6196.752129914753;6832.111825462757;6834.521583489108;6936.79189624312;6957.582545047313;6959.0257363969085;6533.411992920564;6534.313897040743;6608.306127856602;6622.834429139214;6623.834404139935;6576.76981305652;6666.300038495985;6672.96663516689;6721.7311307548125;6759.662016899136;6572.704228309737;6630.569013014138;6674.399304062561;6690.531662783558;6690.96654516734;6729.461643068543;6736.764213252611;6778.898316525256;6779.084823548857;6798.728050878009;5407.675539467645;5422.915416916632;5505.394406615269;5510.173473978855;5514.172874068841;4509.458864936163;4631.1895418301665;4643.767811609406;4646.721196728207;4647.95352046482;5754.165645981309;5819.476247137778;5827.038538641162;5839.678817664984;5841.1238314253205;6717.429018533382;6770.864582708318;6788.185417749902;6805.081314022643;6810.727570897108;5698.943010569841;5780.104083867007;5866.5893387462465;5867.823965281048;5875.676837773878;5821.18503409523;5883.823485295448;5901.380355062656;5908.468237858613;6008.158857759917;6496.447801936888;6509.2839787623325;6509.674516274167;6525.575837570543;6569.146011018537;6693.163354580677;6698.296678848651;6764.627945463047;6768.526203165731;6772.830679233059;6325.7153428094925;6381.904271435839;6441.549091563733;6471.870562588816;6476.935230647821;6436.13112229843;6459.709313080829;6507;6509.576877502947;6539.836504087436;6642;6663.100481434944;6664.566803157779;6665;6670.099536562696;6366.586171898812;6373.235211774617;6451.032345148265;6464.0627109069865;6469.28837827848;6472.805815825533;6475.967620162058;6499.7400103995315;6501.44737697301;6507.7722279721875;6352.983522636356;6357.237131544244;6447.258565265054;6447.677616119082;6450.129232553733;6367.649779262185;6420.390062944013;6549.541532092708;6586.769463068769;6600.80197594073;6300.873982520416;6336.20797400325;6368.458681011981;6371.93628063732;6408.231012278557 00:01:49 INFO - PID 3494 | |1;ext.html;814.9674013039479;840;861.7457849934269;879.9824003519927;885.282920834124;39457.40813887794;40145.19709605806;40190.19619607606;40205.798971005104;40207.59792402075;37541.81229093858;37586.624133758654;37760.43359349612;37793;37891.62108378922;6895.138107736533;7004.264552221995;7014.158301003887;7015.158181018285;7023.894641580355;7617.80955476112;7755.534667919915;7771.300582947533;7804.843903121934;7830.491018083835;7675.462717609769;7794.337481314067;7818.80452988677;7823.295903368696;7827.1390147083775;7220.711171553132;7825.256600622932;7860.68557257709;7861.68553257869;7864.016997875266;7673.194314596999;7756.379489640872;7756.6509507072315;7757.883631745472;7760.029996250469;38019.23961520754;38494;38523.42214866779;38548.42177367342;38581.61418385808;3536.045267777711;3571.6428357164336;3575.6245594212755;3576.749627526074;3582.8566857325677;31735.365292694016;31895.202619934687;31914.680853191403;32013.839930800197;32028.679713202804;4834.9516504834855;4949.90100197994;4958.553730164303;4974.9751251243515;4985.277134815467;185114;185628;185997.0700146504;187280;188124.99999999863;49265.26102108471;49285.75357123263;49369.753151234014;49595.26416575402;49723.75138124286;50431.747841260556;50437.74781126144;50453;50493.74753126211;50588;15531;15649;15785.131817750134;15789.36842526309;15806.288717007763;12766.80849787254;12767.553135640208;12780.360981950866;12787.424565894557;12806;14379;14386.208758518382;14726.852731472762;14804.259787010606;14868.99268598747;6050.848728781815;6108.17539632144;6187.504999600022;6232.3144454110015;6255.186825712628;990.6334656177261;1007.5717819926648;1017.8167929772563;1019.37308555238;1020.3571749797728;22790.08839646429;23039.424014399774;23068;23083.88458057699;23149.42126446852;1081.929674571166;1097.5993762276712;1101.658485869383;1103.8013157631704;1117.2737720481753;12046.698832529257;12106;12232.938835305766;12403.317817520123;12405.13164078524;225640;227401;227448;227764;229026;48775;51454.74272628688;51494.485055148965;52981.7350913243;53634.12280570161;1423.6369725719876;1434.4692463788465;1453.5276035288573;1454.2365258239508;1455.1341951538818;26418;26648.333791655365;26839.73160268372;26941.461170776867;27116.32209194707;36694;36699.816500917324;36865;36939.26121477609;36939.8153009244;188390;188448;188618;188682;188819;31915.521267180546;31936.5209521862;31937;32160;32327.51508727324;41970.53103141375;42479;43246.567534324255;43734.125317492835;43771.343429849214;31244.531332029583;31263.68736312608;31553.053408397784;31782.52326215155;31885.521717173797;31767.682323177396;32088.518672219467;32233.194170145933;32345.191370215933;32681.18297042593;34307.82846085853;34332.82833585816;34479.13802154866;34575;34624.307513850086;30737.538936915516;30741.38517229598;30883;30980.535291970187;31102.533461997635;22476.77523224747;22526.66210006884;22670;22852.542949141258;22957.933785959343 00:01:49 INFO - PID 3494 | |2;jquery.html;587.9000569903116;591.2225423568005;597.2772944736868;599.7600959616153;602.2111034544747;21949.78050219497;22538.774612253874;22585.54828903421;22806.31581052567;22825.77174228259;25697.614535781977;26041.60937585933;26297;26315.473690526225;26413.735862641366;6437.517186211041;6604.24051234107;6615.106960560311;6622.2715501294815;6627.801165965029;6334.303226645088;6488.221413430395;6621.437177839889;6938.653067346612;7014.368706816385;6988.965055174743;6992.720291188346;6997.930020699804;7001.789946301594;7001.789946301619;6937;6959.234484206733;6977.302269773033;6989.021536984801;6991.440684745208;6822.965885170592;6827.351401616838;6827.590344579341;6849.904015357569;6861.794146175623;30629.540556891665;31364.37271254562;31885;31955.520667190012;31983.360332793214;1949.1618604000273;1985.930492432758;1986.136030826595;1989.1347263940231;1994.7107669388004;20665.690014649794;21336.146554137817;21341.25305614296;21395.893020534797;21415.785842141537;2406.193925035115;2442.364985103868;2494.239257026606;2511.7488251174736;2513.5726926422553;134425;136972;137786.311068445;138170;138243;20429.591408171753;22849.31452056441;23030.65454018191;23505.412364690677;23719.288421347388;23527.764722352556;23848.165314214268;24233.75766242315;24397.26808195757;44443.77778111089;9946.900530994597;10015.949920250352;10021.79956400868;10024.097831195228;10224.488775561193;9134.588943497558;9157.175854173156;9172.03693612161;9181.265498760084;9214.078592140731;9233.815323693489;9428.198603118812;9444.150026497648;9611.615535378647;9666.565004574812;2638.7361263873845;2643.5109504741686;2724.632174656396;2753.4493101379403;2789.288731373487;948.4451595816387;968.7086208098052;971.703630392737;974.7465658928729;979.0747743382435;19895.005249737456;25144.24567262985;25257.873710631327;25508.23475295744;25523.617145742828;999.6850991937662;1044.1907521670767;1049.480507148951;1053.8103141434462;1066.6906597086759;10646.30422723839;11331.773364532663;13357.398917048757;14125.728684418451;14718.779218311734;467965;471784;473798;481819;484298;126698;127967.3601631986;129213.35393323161;129890.35054824855;131921;1248.5130798988403;1262.9242245465302;1271.707507273314;1280.8142819291152;1289.7936330187124;22107.33677989663;22143.44641383978;22191.889040554695;22366;22619.321420357417;61627.91860407052;61925.690371547855;62133;63406.68296658487;63637;79809.60095199487;83654;83981.58009209915;84384.57807710922;86035.56982215049;20726.689099663818;21510.569788604455;21549.46126346791;21849.672254916506;21882.45293867666;24451.51096978015;24593.385165371008;24615.876920615283;24668.753312466644;24717.382065448506;18367.265309387476;19016.904915475334;19341;19349.12928918174;19500.732452390548;17411.303547857944;17469.30122795074;17746.5563360917;18074.457766267034;18293.17680704398;18690.34583789561;19381;19488.902555487133;19593.8040619592;19755.209791608173;20522.486937826674;20946.371608851758;21046;21066;21090.57818843645;18555;18670.43988680342;18778.718319225496;18899.716504252174;19026.1438235277 00:01:49 INFO - PID 3494 | |3;mootools.html;1320.4982106799418;1353.7495563320783;1371.6707990082377;1373.5810577773786;1379.4826939897532;13380;13488.123271987313;13979.510717124902;13983;13989.0907091039;13953.162810231393;14263.286835658228;14277.357518911647;14288.357023933922;14296.428142874298;2702.0812923606018;2744.053301610941;2757.489864375087;2762.613234147221;2763.6821765496925;2522.5333313337;2647.6293318935363;2688.368233465144;2693.2189664997127;2695.878685459159;2643.2466746977116;2647.179374393944;2685.8388496690163;2694.797890158236;2732.6584176977876;2575.1888155231136;2595.935101622465;2609.3346196719717;2609.386794103384;2611.216635009499;2482.6276058591175;2500.3249122736943;2508.297676650541;2516.245126462054;2535.657686212356;13306.201627902357;13570.864291357058;13583.592492225249;13585.728285434236;13590.38843252056;7364.1163060432555;7567.356774674159;7569.053868266466;7634.274743899321;7643.923560764432;4997;5103.617228707862;5165.302684137631;5241.711705856176;5246.816361427332;1781.6525777473398;1790.8746387752863;1819.2813838533705;1846.3722334406232;1846.6952952762913;21231;21695.891520542296;21820.345389638336;21897.343079707633;21912.12351505938;6599;6695.363940425652;6858.3827455529245;6957.756478523227;6990.790276291719;17546.473605791845;17576.648467030842;17587;17597.648047038987;17688;7627.199144089902;7770.92229077702;7797.649105790253;7799.415043871732;7806.3364614007305;5951.702414879239;6207.937920620826;6894.551854129566;7086.255943125898;7134.393576545948;5441.537469315073;5530.806421775219;5533.723313834292;5616.382197958222;5637.069883469182;1660.4603503861294;1666.3501234518546;1684.5872761173346;1692.4414943068757;1714.579927917668;855.0978717453022;868.6438560190292;882.2853488674194;890.247740659142;895.5790778334173;7036.366726994493;7039.260877607778;7082.929170708227;7108.822279443055;7115.501914866013;704.5385272646424;706.4454403293493;710.9786706398817;714.410611245714;716.691822516323;4723.881902952385;5542.695151766611;5619.269494965628;5654.575906807006;5862.648241105548;18601.627967440574;18725.812741872407;18995.1452184652;19297.903510482356;19340.4197874064;18884.62230755377;18980.715289270673;18995.715064274045;19130.330438434587;19149.521261968563;10298.948505257425;10638.574457021787;10872.293300935415;10937;10991.450427478754;7856.607169641381;7886.802829929297;8067.435279530377;8190.467619604707;8419.284360829153;16197.190140493163;16382.098984555963;16632.83367166361;16817.579560511083;16870;16454.424095156613;16879.32482700678;17069.74395384095;17123.65752684964;17199.22603482821;11237.494312755782;11647.068234541386;11701.765964680488;11705;11751.47118379692;12827.294498802656;12840.678983025498;12922.806157907828;12956.481740730265;12974.80537791915;10402.8556858747;10412.323198992344;10581.947090264499;10589.841152382567;10600.363978161335;10321.587136514756;10327.333796502133;10430.58277668915;10495;10569.788604228026;8752.387332886892;8791.296696264411;8817.118288171132;8826.823463530822;8827.867581986147;6332.968335158294;6386.9361306386345;6399.904001439889;6407.423331899965;6443.291237963726;6566.80299591013;6612.669366531751;6676.9316909294275;6688.565243259172;6739.730410783513 00:01:49 INFO - PID 3494 | |4;prototype.html;487.2204472843453;509.6559822120069;519.9090159222135;523.7747768459562;528.0943182442111;6141.539384546166;6233.407826256504;6272.9372706272925;6284.685765711713;6313.589616674924;6068.936561569066;6099.146119543257;6107;6200.240892802704;6230.5638605297645;5067.8226262080925;5083.18669012958;5084.898302033957;5136.407713608774;5156.8710782230555;4824.348712923763;4910.435299940499;5045.192769156935;5066.620003499734;5119.257707632391;4821.553533939821;4895.632827537931;4903.215485522317;4920.065187614359;4938.617187187575;4841.298011788289;4885.413750349981;4892.8532144035735;4894.241392584155;4958.752062396866;4398.406215160944;4411.713238639478;4436.356728274414;4448.777561121931;4496.955030449686;5991.760329586811;6015.218021657201;6023.247094113236;6031.788887388964;6081.361457046991;5622.578306626979;5663.915041274384;5689.146628005791;5767.480926716574;5777.7977770777825;6460.386263305026;6484.157059582224;6517.576357536793;6564.474842012628;6564.5404821662505;4790.6886052406835;4824.6863953842885;4876.975615121937;4886.218205087204;4893.290472881448;6529.5719747133135;6701.93298067018;6718.294579069225;6775.695093720745;6907.481938854606;4949.232868905326;4952.232403977389;4970.329005584272;4987.251912213124;5000.62495312853;5020.472850350734;5034.244863270465;5053.8736531587;5106.948930510647;5109.233614957786;5643.548516118701;5655.1517272409465;5674.205611214434;5686.147077938343;5709.571782116358;6621.271660117383;6637.203535575762;6641.302663220389;6690.557946349548;6691.5650482718465;1731.3680506614994;1741.747446620233;1757.77148970633;1762.1101343821288;1782.7236778299384;1150.6375491720082;1182.3378907811652;1213.4418167642982;1227.8894899458912;1239.132607174981;5747.5114615257335;5777.826665200051;5786.276715410574;5794.362620111784;5874.355180549453;6560.3111673273615;6599.73601055962;6614.503912206604;6652.83367915806;6759.2226893906845;5700.857478563069;5720.628159169641;5729.942700573024;5809.767609295665;5815.185873977646;3535.52270443492;3537.964620353815;3545.890195333824;3571.3750093733493;3575.5888072871953;6410.8717825643225;6412.487001039905;6483.7082331295205;6513.348665133449;6522.217333919865;6801.4898882584;6871.759488417882;6885.724571017103;6923.273056329113;6968.118607975818;6430.80707578764;6460.903086453707;6481.157449531531;6516.511261655395;6582.473402127818;6678.031685405492;6707.66461676924;6725.596464212163;6731.292669893043;6734.588844306987;6047.78832740852;6577.80266592003;6605.471562275103;6606.735730570724;6624.205095388585;6345.428911397997;6409.2949775525585;6429.4959247209445;6433.613983161025;6549.6070235786;4921.941782516633;4942.678725882806;4967.478414766542;4990.50094990498;5330.466953304794;6369.980803071487;6528.67356632176;6634.402903738686;6661.666916654245;6737.191537015394;6444.13004244421;6470.38531339522;6472.35276472349;6509.837254068686;6534.542582019213;6394.360563943568;6464.612123272619;6504.837379065561;6539.411452969255;6594.802155935329;6440.967795160994;6453.580517266362;6474.838129046811;6492.285848556749;6512.3162067982175;6563.835904102436;6573.934260657524;6587.068754404436;6594.571352862049;6618.305077966744;6340.71466784005;6347.191050550571;6381.489480841615;6381.744730210739;6418 00:01:49 INFO - PID 3494 | |5;yui.html;869.2046777198867;887.1926546842374;901.7745563609097;904.3398319226964;917.1287277086767;16934.15329233538;17569.56076098098;17645.823541764577;17688.557786055357;19920.402387928385;19856.702149467732;19864.404067877986;19955.401337959884;20066.097025633844;20085.497862553442;1009.8889122196571;1047.5495536919123;1059.3802625464114;1061.2836335473562;1065.0255016659746;1009.2590281763972;1042.3849928542159;1052.5894900988621;1060.8886066962973;1062.8990245926664;1116.7933932222525;1117.279354816143;1118.0552433193939;1119.2556949628488;1119.2948442481224;1106.551846502168;1113.4822307626912;1114.3759494682963;1115.5928086248502;1115.7154925494028;801.8997625296838;818.2349503214514;818.7216346442239;818.7420962396826;819.397742659145;19365.419037428757;20000.799992000186;20335.89832050845;20401.4899627509;20443.38669839907;21356.5728685427;21699.91500424988;21858.23496177642;21960.89019554908;22157;16953.66092678152;17145.314187432487;17357.47927562175;17421.564460888454;17442.912785436118;3557.6442355764475;3591.676749092594;3592.0660628236847;3592.7305452091196;3594.6405359464106;122108;123105;123631.3818430911;126499.36750316282;126910;16738.665226695397;16760.1619919006;17066.743998840026;17083.316667333416;17152.914235428994;30249.848750756104;31520.684793152235;31573.368532629218;31588;31633;7677.347425468898;7903.170167132484;8654.653813847375;8966;9165.266778657691;4222.155568886174;4327.415798867176;4335.544767799399;4339.82640694375;4350.456192975878;5336.252924590561;5428.945710542844;5429.348478182644;5469.288992430958;5476.7535460904355;1009.2934945538153;1017.6946915925192;1040.70339953113;1048.6120135549895;1048.9685309440729;686.3651122711472;686.9072675188786;697.2086681616402;704.2042491984025;716.7240612364277;11325.263857849213;11702.88297117035;11931.1051671125;12527.123101382816;12726.300053497147;659.1990731261444;662.3409707341226;669.2069897171867;678.4335080207983;696.6586372677351;5760.6255593386295;6351.777687780906;6372.522060845455;6389.872202555923;6449.709763060673;111078;111184.44407777909;111570;111909;115127.42436287765;96179.51910240404;101144.49427752814;102674;102801;104834;88315;90329.54835225914;90513.54743226373;91074.08925910789;92328.53835730912;13383.866161338263;13499.32503374847;13551.661208469866;13664.726705465637;13670.248136352597;38633.42049869198;39440.60559394369;39627.20745585015;39845.60154398419;40440.59559404486;49359.25961110658;50228.748856255486;50833.49166508435;51170.232446512586;52079.479205208976;17117.914410427868;18853.24587016559;18916.905415472833;19139.904300478407;19210.903945480182;18806.435806925812;18874;19068.23727050958;19106.23575056982;19172.71240931415;17613.559661008578;17665.558361041076;17817.376391826223;17861.73207401916;17936.641267174324;16461.58846028811;16483.175841208133;16608.335666573686;16642.750358744386;16677.249523771217;17336.65326693484;17501.737473937646;17517.82482175213;17520.211590478713;17669.293228270726;13835.377408016864;13905.930470347583;14058.648533786738;14249.64375890611;14345.64135896611;14964.850351496345;15058.247087645355;15154.848451515343;15157.556045185815;15317.540473785804 00:01:49 INFO - PID 3494 | __end_tp_report 00:01:49 INFO - PID 3494 | __start_cc_report 00:01:49 INFO - PID 3494 | _x_x_mozilla_cycle_collect,378 00:01:49 INFO - PID 3494 | __end_cc_report 00:01:49 INFO - PID 3494 | __startTimestamp1502866909542__endTimestamp 00:01:49 INFO - PID 3494 | 00:01:49 INFO - PID 3494 | ------- Summary: start ------- 00:01:49 INFO - PID 3494 | Number of tests: 6 00:01:49 INFO - PID 3494 | 00:01:49 INFO - PID 3494 | [#0] dojo.html Cycles:165 Average:6140.98 Median:6368.46 stddev:720.51 (11.3%) stddev-sans-first:682.83 00:01:49 INFO - PID 3494 | Values: 3127.0 3129.8 3163.0 3172.8 3185.1 6152.9 6199.9 6237.8 6238.9 6267.1 6101.5 6174.7 6186.2 6188.8 6195.5 5636.1 5645.8 5666.2 5683.9 5692.6 5758.9 5763.1 5781.9 5800.7 5872.1 5646.6 5723.4 5732.5 5772.9 5807.5 5484.2 5560.6 5638.7 5722.3 5766.5 5655.4 5661.0 5740.5 5744.2 5753.7 5928.5 6092.5 6133.1 6179.2 6232.6 6581.6 6602.0 6603.0 6617.6 6620.5 6641.9 6645.3 6653.6 6657.0 6681.7 6170.4 6171.4 6179.0 6183.6 6196.8 6832.1 6834.5 6936.8 6957.6 6959.0 6533.4 6534.3 6608.3 6622.8 6623.8 6576.8 6666.3 6673.0 6721.7 6759.7 6572.7 6630.6 6674.4 6690.5 6691.0 6729.5 6736.8 6778.9 6779.1 6798.7 5407.7 5422.9 5505.4 5510.2 5514.2 4509.5 4631.2 4643.8 4646.7 4648.0 5754.2 5819.5 5827.0 5839.7 5841.1 6717.4 6770.9 6788.2 6805.1 6810.7 5698.9 5780.1 5866.6 5867.8 5875.7 5821.2 5883.8 5901.4 5908.5 6008.2 6496.4 6509.3 6509.7 6525.6 6569.1 6693.2 6698.3 6764.6 6768.5 6772.8 6325.7 6381.9 6441.5 6471.9 6476.9 6436.1 6459.7 6507.0 6509.6 6539.8 6642.0 6663.1 6664.6 6665.0 6670.1 6366.6 6373.2 6451.0 6464.1 6469.3 6472.8 6476.0 6499.7 6501.4 6507.8 6353.0 6357.2 6447.3 6447.7 6450.1 6367.6 6420.4 6549.5 6586.8 6600.8 6300.9 6336.2 6368.5 6371.9 6408.2 00:01:49 INFO - PID 3494 | 00:01:49 INFO - PID 3494 | [#1] ext.html Cycles:180 Average:36894.33 Median:34405.98 stddev:52204.25 (151.7%) stddev-sans-first:52280.40 00:01:49 INFO - PID 3494 | Values: 815.0 840.0 861.7 880.0 885.3 39457.4 40145.2 40190.2 40205.8 40207.6 37541.8 37586.6 37760.4 37793.0 37891.6 6895.1 7004.3 7014.2 7015.2 7023.9 7617.8 7755.5 7771.3 7804.8 7830.5 7675.5 7794.3 7818.8 7823.3 7827.1 7220.7 7825.3 7860.7 7861.7 7864.0 7673.2 7756.4 7756.7 7757.9 7760.0 38019.2 38494.0 38523.4 38548.4 38581.6 3536.0 3571.6 3575.6 3576.7 3582.9 31735.4 31895.2 31914.7 32013.8 32028.7 4835.0 4949.9 4958.6 4975.0 4985.3 185114.0 185628.0 185997.1 187280.0 188125.0 49265.3 49285.8 49369.8 49595.3 49723.8 50431.7 50437.7 50453.0 50493.7 50588.0 15531.0 15649.0 15785.1 15789.4 15806.3 12766.8 12767.6 12780.4 12787.4 12806.0 14379.0 14386.2 14726.9 14804.3 14869.0 6050.8 6108.2 6187.5 6232.3 6255.2 990.6 1007.6 1017.8 1019.4 1020.4 22790.1 23039.4 23068.0 23083.9 23149.4 1081.9 1097.6 1101.7 1103.8 1117.3 12046.7 12106.0 12232.9 12403.3 12405.1 225640.0 227401.0 227448.0 227764.0 229026.0 48775.0 51454.7 51494.5 52981.7 53634.1 1423.6 1434.5 1453.5 1454.2 1455.1 26418.0 26648.3 26839.7 26941.5 27116.3 36694.0 36699.8 36865.0 36939.3 36939.8 188390.0 188448.0 188618.0 188682.0 188819.0 31915.5 31936.5 31937.0 32160.0 32327.5 41970.5 42479.0 43246.6 43734.1 43771.3 31244.5 31263.7 31553.1 31782.5 31885.5 31767.7 32088.5 32233.2 32345.2 32681.2 34307.8 34332.8 34479.1 34575.0 34624.3 30737.5 30741.4 30883.0 30980.5 31102.5 22476.8 22526.7 22670.0 22852.5 22957.9 00:01:49 INFO - PID 3494 | 00:01:49 INFO - PID 3494 | [#2] jquery.html Cycles:180 Average:36553.21 Median:24522.45 stddev:80769.76 (329.4%) stddev-sans-first:80951.20 00:01:49 INFO - PID 3494 | Values: 587.9 591.2 597.3 599.8 602.2 21949.8 22538.8 22585.5 22806.3 22825.8 25697.6 26041.6 26297.0 26315.5 26413.7 6437.5 6604.2 6615.1 6622.3 6627.8 6334.3 6488.2 6621.4 6938.7 7014.4 6989.0 6992.7 6997.9 7001.8 7001.8 6937.0 6959.2 6977.3 6989.0 6991.4 6823.0 6827.4 6827.6 6849.9 6861.8 30629.5 31364.4 31885.0 31955.5 31983.4 1949.2 1985.9 1986.1 1989.1 1994.7 20665.7 21336.1 21341.3 21395.9 21415.8 2406.2 2442.4 2494.2 2511.7 2513.6 134425.0 136972.0 137786.3 138170.0 138243.0 20429.6 22849.3 23030.7 23505.4 23719.3 23527.8 23848.2 24233.8 24397.3 44443.8 9946.9 10015.9 10021.8 10024.1 10224.5 9134.6 9157.2 9172.0 9181.3 9214.1 9233.8 9428.2 9444.2 9611.6 9666.6 2638.7 2643.5 2724.6 2753.4 2789.3 948.4 968.7 971.7 974.7 979.1 19895.0 25144.2 25257.9 25508.2 25523.6 999.7 1044.2 1049.5 1053.8 1066.7 10646.3 11331.8 13357.4 14125.7 14718.8 467965.0 471784.0 473798.0 481819.0 484298.0 126698.0 127967.4 129213.4 129890.4 131921.0 1248.5 1262.9 1271.7 1280.8 1289.8 22107.3 22143.4 22191.9 22366.0 22619.3 61627.9 61925.7 62133.0 63406.7 63637.0 79809.6 83654.0 83981.6 84384.6 86035.6 20726.7 21510.6 21549.5 21849.7 21882.5 24451.5 24593.4 24615.9 24668.8 24717.4 18367.3 19016.9 19341.0 19349.1 19500.7 17411.3 17469.3 17746.6 18074.5 18293.2 18690.3 19381.0 19488.9 19593.8 19755.2 20522.5 20946.4 21046.0 21066.0 21090.6 18555.0 18670.4 18778.7 18899.7 19026.1 00:01:49 INFO - PID 3494 | 00:01:49 INFO - PID 3494 | [#3] mootools.html Cycles:180 Average:8616.50 Median:2555.42 stddev:5843.75 (228.7%) stddev-sans-first:5834.43 00:01:49 INFO - PID 3494 | Values: 1320.5 1353.7 1371.7 1373.6 1379.5 13380.0 13488.1 13979.5 13983.0 13989.1 13953.2 14263.3 14277.4 14288.4 14296.4 2702.1 2744.1 2757.5 2762.6 2763.7 2522.5 2647.6 2688.4 2693.2 2695.9 2643.2 2647.2 2685.8 2694.8 2732.7 2575.2 2595.9 2609.3 2609.4 2611.2 2482.6 2500.3 2508.3 2516.2 2535.7 13306.2 13570.9 13583.6 13585.7 13590.4 7364.1 7567.4 7569.1 7634.3 7643.9 4997.0 5103.6 5165.3 5241.7 5246.8 1781.7 1790.9 1819.3 1846.4 1846.7 21231.0 21695.9 21820.3 21897.3 21912.1 6599.0 6695.4 6858.4 6957.8 6990.8 17546.5 17576.6 17587.0 17597.6 17688.0 7627.2 7770.9 7797.6 7799.4 7806.3 5951.7 6207.9 6894.6 7086.3 7134.4 5441.5 5530.8 5533.7 5616.4 5637.1 1660.5 1666.4 1684.6 1692.4 1714.6 855.1 868.6 882.3 890.2 895.6 7036.4 7039.3 7082.9 7108.8 7115.5 704.5 706.4 711.0 714.4 716.7 4723.9 5542.7 5619.3 5654.6 5862.6 18601.6 18725.8 18995.1 19297.9 19340.4 18884.6 18980.7 18995.7 19130.3 19149.5 10298.9 10638.6 10872.3 10937.0 10991.5 7856.6 7886.8 8067.4 8190.5 8419.3 16197.2 16382.1 16632.8 16817.6 16870.0 16454.4 16879.3 17069.7 17123.7 17199.2 11237.5 11647.1 11701.8 11705.0 11751.5 12827.3 12840.7 12922.8 12956.5 12974.8 10402.9 10412.3 10581.9 10589.8 10600.4 10321.6 10327.3 10430.6 10495.0 10569.8 8752.4 8791.3 8817.1 8826.8 8827.9 6333.0 6386.9 6399.9 6407.4 6443.3 6566.8 6612.7 6676.9 6688.6 6739.7 00:01:49 INFO - PID 3494 | 00:01:49 INFO - PID 3494 | [#4] prototype.html Cycles:180 Average:5490.67 Median:6075.15 stddev:1537.04 (25.3%) stddev-sans-first:1494.76 00:01:49 INFO - PID 3494 | Values: 487.2 509.7 519.9 523.8 528.1 6141.5 6233.4 6272.9 6284.7 6313.6 6068.9 6099.1 6107.0 6200.2 6230.6 5067.8 5083.2 5084.9 5136.4 5156.9 4824.3 4910.4 5045.2 5066.6 5119.3 4821.6 4895.6 4903.2 4920.1 4938.6 4841.3 4885.4 4892.9 4894.2 4958.8 4398.4 4411.7 4436.4 4448.8 4497.0 5991.8 6015.2 6023.2 6031.8 6081.4 5622.6 5663.9 5689.1 5767.5 5777.8 6460.4 6484.2 6517.6 6564.5 6564.5 4790.7 4824.7 4877.0 4886.2 4893.3 6529.6 6701.9 6718.3 6775.7 6907.5 4949.2 4952.2 4970.3 4987.3 5000.6 5020.5 5034.2 5053.9 5106.9 5109.2 5643.5 5655.2 5674.2 5686.1 5709.6 6621.3 6637.2 6641.3 6690.6 6691.6 1731.4 1741.7 1757.8 1762.1 1782.7 1150.6 1182.3 1213.4 1227.9 1239.1 5747.5 5777.8 5786.3 5794.4 5874.4 6560.3 6599.7 6614.5 6652.8 6759.2 5700.9 5720.6 5729.9 5809.8 5815.2 3535.5 3538.0 3545.9 3571.4 3575.6 6410.9 6412.5 6483.7 6513.3 6522.2 6801.5 6871.8 6885.7 6923.3 6968.1 6430.8 6460.9 6481.2 6516.5 6582.5 6678.0 6707.7 6725.6 6731.3 6734.6 6047.8 6577.8 6605.5 6606.7 6624.2 6345.4 6409.3 6429.5 6433.6 6549.6 4921.9 4942.7 4967.5 4990.5 5330.5 6370.0 6528.7 6634.4 6661.7 6737.2 6444.1 6470.4 6472.4 6509.8 6534.5 6394.4 6464.6 6504.8 6539.4 6594.8 6441.0 6453.6 6474.8 6492.3 6512.3 6563.8 6573.9 6587.1 6594.6 6618.3 6340.7 6347.2 6381.5 6381.7 6418.0 00:01:49 INFO - PID 3494 | 00:01:49 INFO - PID 3494 | [#5] yui.html Cycles:180 Average:23477.68 Median:18863.62 stddev:31973.91 (169.5%) stddev-sans-first:32018.53 00:01:49 INFO - PID 3494 | Values: 869.2 887.2 901.8 904.3 917.1 16934.2 17569.6 17645.8 17688.6 19920.4 19856.7 19864.4 19955.4 20066.1 20085.5 1009.9 1047.5 1059.4 1061.3 1065.0 1009.3 1042.4 1052.6 1060.9 1062.9 1116.8 1117.3 1118.1 1119.3 1119.3 1106.6 1113.5 1114.4 1115.6 1115.7 801.9 818.2 818.7 818.7 819.4 19365.4 20000.8 20335.9 20401.5 20443.4 21356.6 21699.9 21858.2 21960.9 22157.0 16953.7 17145.3 17357.5 17421.6 17442.9 3557.6 3591.7 3592.1 3592.7 3594.6 122108.0 123105.0 123631.4 126499.4 126910.0 16738.7 16760.2 17066.7 17083.3 17152.9 30249.8 31520.7 31573.4 31588.0 31633.0 7677.3 7903.2 8654.7 8966.0 9165.3 4222.2 4327.4 4335.5 4339.8 4350.5 5336.3 5428.9 5429.3 5469.3 5476.8 1009.3 1017.7 1040.7 1048.6 1049.0 686.4 686.9 697.2 704.2 716.7 11325.3 11702.9 11931.1 12527.1 12726.3 659.2 662.3 669.2 678.4 696.7 5760.6 6351.8 6372.5 6389.9 6449.7 111078.0 111184.4 111570.0 111909.0 115127.4 96179.5 101144.5 102674.0 102801.0 104834.0 88315.0 90329.5 90513.5 91074.1 92328.5 13383.9 13499.3 13551.7 13664.7 13670.2 38633.4 39440.6 39627.2 39845.6 40440.6 49359.3 50228.7 50833.5 51170.2 52079.5 17117.9 18853.2 18916.9 19139.9 19210.9 18806.4 18874.0 19068.2 19106.2 19172.7 17613.6 17665.6 17817.4 17861.7 17936.6 16461.6 16483.2 16608.3 16642.8 16677.2 17336.7 17501.7 17517.8 17520.2 17669.3 13835.4 13905.9 14058.6 14249.6 14345.6 14964.9 15058.2 15154.8 15157.6 15317.5 00:01:49 INFO - PID 3494 | -------- Summary: end -------- 00:01:49 INFO - PID 3494 | 00:01:50 INFO - TEST-INFO | 3494: exit 0 00:01:50 INFO - TEST-OK | dromaeo_css | took 1116329ms 00:01:50 INFO - TEST-START | kraken 00:01:50 INFO - Initialising browser for kraken test... 00:01:50 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59956/getInfo.html -profile /tmp/tmpKoXfUa/profile 00:01:50 INFO - TEST-INFO | started process 3873 (/builds/slave/test/build/application/firefox/firefox http://localhost:59956/getInfo.html) 00:01:56 INFO - TEST-INFO | 3873: exit 0 00:01:56 INFO - Browser initialized. 00:01:56 INFO - Running cycle 1/1 for kraken test... 00:01:56 INFO - TEST-INFO | started process 4065 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKoXfUa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 00:01:57 INFO - PID 4065 | 00:01:57 INFO - PID 4065 | (/builds/slave/test/build/application/firefox/firefox:4119): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 00:01:57 INFO - PID 4065 | 00:02:07 INFO - PID 4065 | RSS: Main: 167563264 00:02:07 INFO - PID 4065 | 00:02:10 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59956/tests/kraken/driver.html?testName=audio-beat-detection) 00:02:11 INFO - PID 4065 | RSS: Main: 173948928 00:02:11 INFO - PID 4065 | 00:02:14 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59956/tests/kraken/driver.html?testName=audio-dft) 00:02:14 INFO - PID 4065 | RSS: Main: 174247936 00:02:14 INFO - PID 4065 | 00:02:17 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59956/tests/kraken/driver.html?testName=audio-fft) 00:02:18 INFO - PID 4065 | RSS: Main: 169287680 00:02:18 INFO - PID 4065 | 00:02:20 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59956/tests/kraken/driver.html?testName=audio-oscillator) 00:02:21 INFO - PID 4065 | RSS: Main: 169738240 00:02:21 INFO - PID 4065 | 00:02:23 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59956/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:02:24 INFO - PID 4065 | RSS: Main: 169758720 00:02:24 INFO - PID 4065 | 00:02:27 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59956/tests/kraken/driver.html?testName=imaging-darkroom) 00:02:28 INFO - PID 4065 | RSS: Main: 172707840 00:02:28 INFO - PID 4065 | 00:02:31 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59956/tests/kraken/driver.html?testName=imaging-desaturate) 00:02:32 INFO - PID 4065 | RSS: Main: 172670976 00:02:32 INFO - PID 4065 | 00:02:35 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59956/tests/kraken/driver.html?testName=json-parse-financial) 00:02:35 INFO - PID 4065 | RSS: Main: 173174784 00:02:35 INFO - PID 4065 | 00:02:37 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59956/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:02:37 INFO - PID 4065 | RSS: Main: 173199360 00:02:37 INFO - PID 4065 | 00:02:39 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59956/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:02:40 INFO - PID 4065 | RSS: Main: 173449216 00:02:40 INFO - PID 4065 | 00:02:42 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59956/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:02:43 INFO - PID 4065 | RSS: Main: 173334528 00:02:43 INFO - PID 4065 | 00:02:45 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:02:46 INFO - PID 4065 | RSS: Main: 174129152 00:02:46 INFO - PID 4065 | 00:02:49 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:02:50 INFO - PID 4065 | RSS: Main: 174776320 00:02:50 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | Cycle 1(1): loaded http://localhost:59956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59956/tests/kraken/driver.html?testName=ai-astar) 00:02:52 INFO - PID 4065 | RSS: Main: 175280128 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | __start_tp_report 00:02:52 INFO - PID 4065 | _x_x_mozilla_page_load 00:02:52 INFO - PID 4065 | _x_x_mozilla_page_load_details 00:02:52 INFO - PID 4065 | |i|pagename|runs| 00:02:52 INFO - PID 4065 | |0;ai-astar;99;107;109;110;113;108;115;100;107;114 00:02:52 INFO - PID 4065 | |1;audio-beat-detection;150;118;162;172;119;145;144;117;174;129 00:02:52 INFO - PID 4065 | |2;audio-dft;162;164;170;165;163;166;165;177;164;162 00:02:52 INFO - PID 4065 | |3;audio-fft;74;78;80;170;76;77;85;91;97;81 00:02:52 INFO - PID 4065 | |4;audio-oscillator;92;88;128;88;79;80;130;80;85;133 00:02:52 INFO - PID 4065 | |5;imaging-gaussian-blur;115;117;117;116;117;122;114;114;120;116 00:02:52 INFO - PID 4065 | |6;imaging-darkroom;150;150;151;151;149;149;150;153;151;151 00:02:52 INFO - PID 4065 | |7;imaging-desaturate;94;94;94;93;94;94;94;94;96;93 00:02:52 INFO - PID 4065 | |8;json-parse-financial;53;61;58;56;54;64;53;54;52;53 00:02:52 INFO - PID 4065 | |9;json-stringify-tinderbox;55;54;54;53;54;55;60;61;54;60 00:02:52 INFO - PID 4065 | |10;stanford-crypto-aes;78;84;77;80;78;79;77;77;76;77 00:02:52 INFO - PID 4065 | |11;stanford-crypto-ccm;132;125;141;139;130;125;140;121;124;176 00:02:52 INFO - PID 4065 | |12;stanford-crypto-pbkdf2;196;183;190;187;180;176;177;190;175;178 00:02:52 INFO - PID 4065 | |13;stanford-crypto-sha256-iterative;75;68;73;68;70;72;72;69;68;69 00:02:52 INFO - PID 4065 | __end_tp_report 00:02:52 INFO - PID 4065 | __start_cc_report 00:02:52 INFO - PID 4065 | _x_x_mozilla_cycle_collect,940 00:02:52 INFO - PID 4065 | __end_cc_report 00:02:52 INFO - PID 4065 | __startTimestamp1502866972603__endTimestamp 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | ------- Summary: start ------- 00:02:52 INFO - PID 4065 | Number of tests: 14 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#0] ai-astar Cycles:10 Average:108.20 Median:111.50 stddev:5.39 (4.8%) stddev-sans-first:4.58 00:02:52 INFO - PID 4065 | Values: 99.0 107.0 109.0 110.0 113.0 108.0 115.0 100.0 107.0 114.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#1] audio-beat-detection Cycles:10 Average:143.00 Median:147.50 stddev:21.83 (14.8%) stddev-sans-first:23.01 00:02:52 INFO - PID 4065 | Values: 150.0 118.0 162.0 172.0 119.0 145.0 144.0 117.0 174.0 129.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.00 stddev:4.57 (2.8%) stddev-sans-first:4.63 00:02:52 INFO - PID 4065 | Values: 162.0 164.0 170.0 165.0 163.0 166.0 165.0 177.0 164.0 162.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#3] audio-fft Cycles:10 Average:90.90 Median:80.50 stddev:28.70 (35.7%) stddev-sans-first:29.78 00:02:52 INFO - PID 4065 | Values: 74.0 78.0 80.0 170.0 76.0 77.0 85.0 91.0 97.0 81.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:82.50 stddev:22.51 (27.3%) stddev-sans-first:23.76 00:02:52 INFO - PID 4065 | Values: 92.0 88.0 128.0 88.0 79.0 80.0 130.0 80.0 85.0 133.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:2.53 (2.2%) stddev-sans-first:2.60 00:02:52 INFO - PID 4065 | Values: 115.0 117.0 117.0 116.0 117.0 122.0 114.0 114.0 120.0 116.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:1.18 (0.8%) stddev-sans-first:1.24 00:02:52 INFO - PID 4065 | Values: 150.0 150.0 151.0 151.0 149.0 149.0 150.0 153.0 151.0 151.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 00:02:52 INFO - PID 4065 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 96.0 93.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.00 stddev:3.99 (7.3%) stddev-sans-first:4.11 00:02:52 INFO - PID 4065 | Values: 53.0 61.0 58.0 56.0 54.0 64.0 53.0 54.0 52.0 53.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:55.00 stddev:3.06 (5.6%) stddev-sans-first:3.22 00:02:52 INFO - PID 4065 | Values: 55.0 54.0 54.0 53.0 54.0 55.0 60.0 61.0 54.0 60.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.00 stddev:2.31 (3.0%) stddev-sans-first:2.45 00:02:52 INFO - PID 4065 | Values: 78.0 84.0 77.0 80.0 78.0 79.0 77.0 77.0 76.0 77.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#11] stanford-crypto-ccm Cycles:10 Average:135.30 Median:135.50 stddev:16.01 (11.8%) stddev-sans-first:16.94 00:02:52 INFO - PID 4065 | Values: 132.0 125.0 141.0 139.0 130.0 125.0 140.0 121.0 124.0 176.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:185.00 stddev:7.19 (3.9%) stddev-sans-first:5.95 00:02:52 INFO - PID 4065 | Values: 196.0 183.0 190.0 187.0 180.0 176.0 177.0 190.0 175.0 178.0 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:2.46 (3.5%) stddev-sans-first:1.96 00:02:52 INFO - PID 4065 | Values: 75.0 68.0 73.0 68.0 70.0 72.0 72.0 69.0 68.0 69.0 00:02:52 INFO - PID 4065 | -------- Summary: end -------- 00:02:52 INFO - PID 4065 | 00:02:52 INFO - PID 4065 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 00:02:53 INFO - TEST-INFO | 4065: exit 0 00:02:53 INFO - TEST-OK | kraken | took 62925ms 00:02:53 INFO - SUITE-END | took 1179s 00:02:53 INFO - Completed test suite (00:19:39) 00:02:53 INFO - javascript benchmark 00:02:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8559.096518741797, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3127.0462508934775, 3129.76526760493, 3163.0, 3172.8413579321027, 3185.124090875009, 6152.907706384408, 6199.938000619993, 6237.750489980401, 6238.906416403752, 6267.122602835601, 6101.450869421751, 6174.660393678346, 6186.195794546703, 6188.81433556994, 6195.504359651229, 5636.0982242841155, 5645.774169033234, 5666.150077488369, 5683.914741278884, 5692.57305702072, 5758.856028599298, 5763.0779075347955, 5781.942180578203, 5800.651960882339, 5872.119182122673, 5646.604737668365, 5723.370429252779, 5732.5127364174095, 5772.913406298909, 5807.477327040566, 5484.204790305424, 5560.582956278296, 5638.689872057035, 5722.2561067061015, 5766.481016708474, 5655.3779084300695, 5660.971695141498, 5740.54075673945, 5744.167095771131, 5753.741081651336, 5928.49607783339, 6092.451679348836, 6133.080037994292, 6179.16581261533, 6232.563720539564, 6581.605103693746, 6602.0, 6602.9669851650915, 6617.636030018347, 6620.470362370998, 6641.93358066418, 6645.302243264436, 6653.60078395293, 6657.0, 6681.665916704194, 6170.352113028157, 6171.382861713838, 6179.0, 6183.598066125733, 6196.752129914753, 6832.111825462757, 6834.521583489108, 6936.79189624312, 6957.582545047313, 6959.0257363969085, 6533.411992920564, 6534.313897040743, 6608.306127856602, 6622.834429139214, 6623.834404139935, 6576.76981305652, 6666.300038495985, 6672.96663516689, 6721.7311307548125, 6759.662016899136, 6572.704228309737, 6630.569013014138, 6674.399304062561, 6690.531662783558, 6690.96654516734, 6729.461643068543, 6736.764213252611, 6778.898316525256, 6779.084823548857, 6798.728050878009, 5407.675539467645, 5422.915416916632, 5505.394406615269, 5510.173473978855, 5514.172874068841, 4509.458864936163, 4631.1895418301665, 4643.767811609406, 4646.721196728207, 4647.95352046482, 5754.165645981309, 5819.476247137778, 5827.038538641162, 5839.678817664984, 5841.1238314253205, 6717.429018533382, 6770.864582708318, 6788.185417749902, 6805.081314022643, 6810.727570897108, 5698.943010569841, 5780.104083867007, 5866.5893387462465, 5867.823965281048, 5875.676837773878, 5821.18503409523, 5883.823485295448, 5901.380355062656, 5908.468237858613, 6008.158857759917, 6496.447801936888, 6509.2839787623325, 6509.674516274167, 6525.575837570543, 6569.146011018537, 6693.163354580677, 6698.296678848651, 6764.627945463047, 6768.526203165731, 6772.830679233059, 6325.7153428094925, 6381.904271435839, 6441.549091563733, 6471.870562588816, 6476.935230647821, 6436.13112229843, 6459.709313080829, 6507.0, 6509.576877502947, 6539.836504087436, 6642.0, 6663.100481434944, 6664.566803157779, 6665.0, 6670.099536562696, 6366.586171898812, 6373.235211774617, 6451.032345148265, 6464.0627109069865, 6469.28837827848, 6472.805815825533, 6475.967620162058, 6499.7400103995315, 6501.44737697301, 6507.7722279721875, 6352.983522636356, 6357.237131544244, 6447.258565265054, 6447.677616119082, 6450.129232553733, 6367.649779262185, 6420.390062944013, 6549.541532092708, 6586.769463068769, 6600.80197594073, 6300.873982520416, 6336.20797400325, 6368.458681011981, 6371.93628063732, 6408.231012278557], "value": 6087.112416641248, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.9674013039479, 840.0, 861.7457849934269, 879.9824003519927, 885.282920834124, 39457.40813887794, 40145.19709605806, 40190.19619607606, 40205.798971005104, 40207.59792402075, 37541.81229093858, 37586.624133758654, 37760.43359349612, 37793.0, 37891.62108378922, 6895.138107736533, 7004.264552221995, 7014.158301003887, 7015.158181018285, 7023.894641580355, 7617.80955476112, 7755.534667919915, 7771.300582947533, 7804.843903121934, 7830.491018083835, 7675.462717609769, 7794.337481314067, 7818.80452988677, 7823.295903368696, 7827.1390147083775, 7220.711171553132, 7825.256600622932, 7860.68557257709, 7861.68553257869, 7864.016997875266, 7673.194314596999, 7756.379489640872, 7756.6509507072315, 7757.883631745472, 7760.029996250469, 38019.23961520754, 38494.0, 38523.42214866779, 38548.42177367342, 38581.61418385808, 3536.045267777711, 3571.6428357164336, 3575.6245594212755, 3576.749627526074, 3582.8566857325677, 31735.365292694016, 31895.202619934687, 31914.680853191403, 32013.839930800197, 32028.679713202804, 4834.9516504834855, 4949.90100197994, 4958.553730164303, 4974.9751251243515, 4985.277134815467, 185114.0, 185628.0, 185997.0700146504, 187280.0, 188124.99999999863, 49265.26102108471, 49285.75357123263, 49369.753151234014, 49595.26416575402, 49723.75138124286, 50431.747841260556, 50437.74781126144, 50453.0, 50493.74753126211, 50588.0, 15531.0, 15649.0, 15785.131817750134, 15789.36842526309, 15806.288717007763, 12766.80849787254, 12767.553135640208, 12780.360981950866, 12787.424565894557, 12806.0, 14379.0, 14386.208758518382, 14726.852731472762, 14804.259787010606, 14868.99268598747, 6050.848728781815, 6108.17539632144, 6187.504999600022, 6232.3144454110015, 6255.186825712628, 990.6334656177261, 1007.5717819926648, 1017.8167929772563, 1019.37308555238, 1020.3571749797728, 22790.08839646429, 23039.424014399774, 23068.0, 23083.88458057699, 23149.42126446852, 1081.929674571166, 1097.5993762276712, 1101.658485869383, 1103.8013157631704, 1117.2737720481753, 12046.698832529257, 12106.0, 12232.938835305766, 12403.317817520123, 12405.13164078524, 225640.0, 227401.0, 227448.0, 227764.0, 229026.0, 48775.0, 51454.74272628688, 51494.485055148965, 52981.7350913243, 53634.12280570161, 1423.6369725719876, 1434.4692463788465, 1453.5276035288573, 1454.2365258239508, 1455.1341951538818, 26418.0, 26648.333791655365, 26839.73160268372, 26941.461170776867, 27116.32209194707, 36694.0, 36699.816500917324, 36865.0, 36939.26121477609, 36939.8153009244, 188390.0, 188448.0, 188618.0, 188682.0, 188819.0, 31915.521267180546, 31936.5209521862, 31937.0, 32160.0, 32327.51508727324, 41970.53103141375, 42479.0, 43246.567534324255, 43734.125317492835, 43771.343429849214, 31244.531332029583, 31263.68736312608, 31553.053408397784, 31782.52326215155, 31885.521717173797, 31767.682323177396, 32088.518672219467, 32233.194170145933, 32345.191370215933, 32681.18297042593, 34307.82846085853, 34332.82833585816, 34479.13802154866, 34575.0, 34624.307513850086, 30737.538936915516, 30741.38517229598, 30883.0, 30980.535291970187, 31102.533461997635, 22476.77523224747, 22526.66210006884, 22670.0, 22852.542949141258, 22957.933785959343], "value": 17006.901272857245, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.9000569903116, 591.2225423568005, 597.2772944736868, 599.7600959616153, 602.2111034544747, 21949.78050219497, 22538.774612253874, 22585.54828903421, 22806.31581052567, 22825.77174228259, 25697.614535781977, 26041.60937585933, 26297.0, 26315.473690526225, 26413.735862641366, 6437.517186211041, 6604.24051234107, 6615.106960560311, 6622.2715501294815, 6627.801165965029, 6334.303226645088, 6488.221413430395, 6621.437177839889, 6938.653067346612, 7014.368706816385, 6988.965055174743, 6992.720291188346, 6997.930020699804, 7001.789946301594, 7001.789946301619, 6937.0, 6959.234484206733, 6977.302269773033, 6989.021536984801, 6991.440684745208, 6822.965885170592, 6827.351401616838, 6827.590344579341, 6849.904015357569, 6861.794146175623, 30629.540556891665, 31364.37271254562, 31885.0, 31955.520667190012, 31983.360332793214, 1949.1618604000273, 1985.930492432758, 1986.136030826595, 1989.1347263940231, 1994.7107669388004, 20665.690014649794, 21336.146554137817, 21341.25305614296, 21395.893020534797, 21415.785842141537, 2406.193925035115, 2442.364985103868, 2494.239257026606, 2511.7488251174736, 2513.5726926422553, 134425.0, 136972.0, 137786.311068445, 138170.0, 138243.0, 20429.591408171753, 22849.31452056441, 23030.65454018191, 23505.412364690677, 23719.288421347388, 23527.764722352556, 23848.165314214268, 24233.75766242315, 24397.26808195757, 44443.77778111089, 9946.900530994597, 10015.949920250352, 10021.79956400868, 10024.097831195228, 10224.488775561193, 9134.588943497558, 9157.175854173156, 9172.03693612161, 9181.265498760084, 9214.078592140731, 9233.815323693489, 9428.198603118812, 9444.150026497648, 9611.615535378647, 9666.565004574812, 2638.7361263873845, 2643.5109504741686, 2724.632174656396, 2753.4493101379403, 2789.288731373487, 948.4451595816387, 968.7086208098052, 971.703630392737, 974.7465658928729, 979.0747743382435, 19895.005249737456, 25144.24567262985, 25257.873710631327, 25508.23475295744, 25523.617145742828, 999.6850991937662, 1044.1907521670767, 1049.480507148951, 1053.8103141434462, 1066.6906597086759, 10646.30422723839, 11331.773364532663, 13357.398917048757, 14125.728684418451, 14718.779218311734, 467965.0, 471784.0, 473798.0, 481819.0, 484298.0, 126698.0, 127967.3601631986, 129213.35393323161, 129890.35054824855, 131921.0, 1248.5130798988403, 1262.9242245465302, 1271.707507273314, 1280.8142819291152, 1289.7936330187124, 22107.33677989663, 22143.44641383978, 22191.889040554695, 22366.0, 22619.321420357417, 61627.91860407052, 61925.690371547855, 62133.0, 63406.68296658487, 63637.0, 79809.60095199487, 83654.0, 83981.58009209915, 84384.57807710922, 86035.56982215049, 20726.689099663818, 21510.569788604455, 21549.46126346791, 21849.672254916506, 21882.45293867666, 24451.51096978015, 24593.385165371008, 24615.876920615283, 24668.753312466644, 24717.382065448506, 18367.265309387476, 19016.904915475334, 19341.0, 19349.12928918174, 19500.732452390548, 17411.303547857944, 17469.30122795074, 17746.5563360917, 18074.457766267034, 18293.17680704398, 18690.34583789561, 19381.0, 19488.902555487133, 19593.8040619592, 19755.209791608173, 20522.486937826674, 20946.371608851758, 21046.0, 21066.0, 21090.57818843645, 18555.0, 18670.43988680342, 18778.718319225496, 18899.716504252174, 19026.1438235277], "value": 13031.82550358577, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1320.4982106799418, 1353.7495563320783, 1371.6707990082377, 1373.5810577773786, 1379.4826939897532, 13380.0, 13488.123271987313, 13979.510717124902, 13983.0, 13989.0907091039, 13953.162810231393, 14263.286835658228, 14277.357518911647, 14288.357023933922, 14296.428142874298, 2702.0812923606018, 2744.053301610941, 2757.489864375087, 2762.613234147221, 2763.6821765496925, 2522.5333313337, 2647.6293318935363, 2688.368233465144, 2693.2189664997127, 2695.878685459159, 2643.2466746977116, 2647.179374393944, 2685.8388496690163, 2694.797890158236, 2732.6584176977876, 2575.1888155231136, 2595.935101622465, 2609.3346196719717, 2609.386794103384, 2611.216635009499, 2482.6276058591175, 2500.3249122736943, 2508.297676650541, 2516.245126462054, 2535.657686212356, 13306.201627902357, 13570.864291357058, 13583.592492225249, 13585.728285434236, 13590.38843252056, 7364.1163060432555, 7567.356774674159, 7569.053868266466, 7634.274743899321, 7643.923560764432, 4997.0, 5103.617228707862, 5165.302684137631, 5241.711705856176, 5246.816361427332, 1781.6525777473398, 1790.8746387752863, 1819.2813838533705, 1846.3722334406232, 1846.6952952762913, 21231.0, 21695.891520542296, 21820.345389638336, 21897.343079707633, 21912.12351505938, 6599.0, 6695.363940425652, 6858.3827455529245, 6957.756478523227, 6990.790276291719, 17546.473605791845, 17576.648467030842, 17587.0, 17597.648047038987, 17688.0, 7627.199144089902, 7770.92229077702, 7797.649105790253, 7799.415043871732, 7806.3364614007305, 5951.702414879239, 6207.937920620826, 6894.551854129566, 7086.255943125898, 7134.393576545948, 5441.537469315073, 5530.806421775219, 5533.723313834292, 5616.382197958222, 5637.069883469182, 1660.4603503861294, 1666.3501234518546, 1684.5872761173346, 1692.4414943068757, 1714.579927917668, 855.0978717453022, 868.6438560190292, 882.2853488674194, 890.247740659142, 895.5790778334173, 7036.366726994493, 7039.260877607778, 7082.929170708227, 7108.822279443055, 7115.501914866013, 704.5385272646424, 706.4454403293493, 710.9786706398817, 714.410611245714, 716.691822516323, 4723.881902952385, 5542.695151766611, 5619.269494965628, 5654.575906807006, 5862.648241105548, 18601.627967440574, 18725.812741872407, 18995.1452184652, 19297.903510482356, 19340.4197874064, 18884.62230755377, 18980.715289270673, 18995.715064274045, 19130.330438434587, 19149.521261968563, 10298.948505257425, 10638.574457021787, 10872.293300935415, 10937.0, 10991.450427478754, 7856.607169641381, 7886.802829929297, 8067.435279530377, 8190.467619604707, 8419.284360829153, 16197.190140493163, 16382.098984555963, 16632.83367166361, 16817.579560511083, 16870.0, 16454.424095156613, 16879.32482700678, 17069.74395384095, 17123.65752684964, 17199.22603482821, 11237.494312755782, 11647.068234541386, 11701.765964680488, 11705.0, 11751.47118379692, 12827.294498802656, 12840.678983025498, 12922.806157907828, 12956.481740730265, 12974.80537791915, 10402.8556858747, 10412.323198992344, 10581.947090264499, 10589.841152382567, 10600.363978161335, 10321.587136514756, 10327.333796502133, 10430.58277668915, 10495.0, 10569.788604228026, 8752.387332886892, 8791.296696264411, 8817.118288171132, 8826.823463530822, 8827.867581986147, 6332.968335158294, 6386.9361306386345, 6399.904001439889, 6407.423331899965, 6443.291237963726, 6566.80299591013, 6612.669366531751, 6676.9316909294275, 6688.565243259172, 6739.730410783513], "value": 6281.514571132432, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.2204472843453, 509.6559822120069, 519.9090159222135, 523.7747768459562, 528.0943182442111, 6141.539384546166, 6233.407826256504, 6272.9372706272925, 6284.685765711713, 6313.589616674924, 6068.936561569066, 6099.146119543257, 6107.0, 6200.240892802704, 6230.5638605297645, 5067.8226262080925, 5083.18669012958, 5084.898302033957, 5136.407713608774, 5156.8710782230555, 4824.348712923763, 4910.435299940499, 5045.192769156935, 5066.620003499734, 5119.257707632391, 4821.553533939821, 4895.632827537931, 4903.215485522317, 4920.065187614359, 4938.617187187575, 4841.298011788289, 4885.413750349981, 4892.8532144035735, 4894.241392584155, 4958.752062396866, 4398.406215160944, 4411.713238639478, 4436.356728274414, 4448.777561121931, 4496.955030449686, 5991.760329586811, 6015.218021657201, 6023.247094113236, 6031.788887388964, 6081.361457046991, 5622.578306626979, 5663.915041274384, 5689.146628005791, 5767.480926716574, 5777.7977770777825, 6460.386263305026, 6484.157059582224, 6517.576357536793, 6564.474842012628, 6564.5404821662505, 4790.6886052406835, 4824.6863953842885, 4876.975615121937, 4886.218205087204, 4893.290472881448, 6529.5719747133135, 6701.93298067018, 6718.294579069225, 6775.695093720745, 6907.481938854606, 4949.232868905326, 4952.232403977389, 4970.329005584272, 4987.251912213124, 5000.62495312853, 5020.472850350734, 5034.244863270465, 5053.8736531587, 5106.948930510647, 5109.233614957786, 5643.548516118701, 5655.1517272409465, 5674.205611214434, 5686.147077938343, 5709.571782116358, 6621.271660117383, 6637.203535575762, 6641.302663220389, 6690.557946349548, 6691.5650482718465, 1731.3680506614994, 1741.747446620233, 1757.77148970633, 1762.1101343821288, 1782.7236778299384, 1150.6375491720082, 1182.3378907811652, 1213.4418167642982, 1227.8894899458912, 1239.132607174981, 5747.5114615257335, 5777.826665200051, 5786.276715410574, 5794.362620111784, 5874.355180549453, 6560.3111673273615, 6599.73601055962, 6614.503912206604, 6652.83367915806, 6759.2226893906845, 5700.857478563069, 5720.628159169641, 5729.942700573024, 5809.767609295665, 5815.185873977646, 3535.52270443492, 3537.964620353815, 3545.890195333824, 3571.3750093733493, 3575.5888072871953, 6410.8717825643225, 6412.487001039905, 6483.7082331295205, 6513.348665133449, 6522.217333919865, 6801.4898882584, 6871.759488417882, 6885.724571017103, 6923.273056329113, 6968.118607975818, 6430.80707578764, 6460.903086453707, 6481.157449531531, 6516.511261655395, 6582.473402127818, 6678.031685405492, 6707.66461676924, 6725.596464212163, 6731.292669893043, 6734.588844306987, 6047.78832740852, 6577.80266592003, 6605.471562275103, 6606.735730570724, 6624.205095388585, 6345.428911397997, 6409.2949775525585, 6429.4959247209445, 6433.613983161025, 6549.6070235786, 4921.941782516633, 4942.678725882806, 4967.478414766542, 4990.50094990498, 5330.466953304794, 6369.980803071487, 6528.67356632176, 6634.402903738686, 6661.666916654245, 6737.191537015394, 6444.13004244421, 6470.38531339522, 6472.35276472349, 6509.837254068686, 6534.542582019213, 6394.360563943568, 6464.612123272619, 6504.837379065561, 6539.411452969255, 6594.802155935329, 6440.967795160994, 6453.580517266362, 6474.838129046811, 6492.285848556749, 6512.3162067982175, 6563.835904102436, 6573.934260657524, 6587.068754404436, 6594.571352862049, 6618.305077966744, 6340.71466784005, 6347.191050550571, 6381.489480841615, 6381.744730210739, 6418.0], "value": 5037.847952183863, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [869.2046777198867, 887.1926546842374, 901.7745563609097, 904.3398319226964, 917.1287277086767, 16934.15329233538, 17569.56076098098, 17645.823541764577, 17688.557786055357, 19920.402387928385, 19856.702149467732, 19864.404067877986, 19955.401337959884, 20066.097025633844, 20085.497862553442, 1009.8889122196571, 1047.5495536919123, 1059.3802625464114, 1061.2836335473562, 1065.0255016659746, 1009.2590281763972, 1042.3849928542159, 1052.5894900988621, 1060.8886066962973, 1062.8990245926664, 1116.7933932222525, 1117.279354816143, 1118.0552433193939, 1119.2556949628488, 1119.2948442481224, 1106.551846502168, 1113.4822307626912, 1114.3759494682963, 1115.5928086248502, 1115.7154925494028, 801.8997625296838, 818.2349503214514, 818.7216346442239, 818.7420962396826, 819.397742659145, 19365.419037428757, 20000.799992000186, 20335.89832050845, 20401.4899627509, 20443.38669839907, 21356.5728685427, 21699.91500424988, 21858.23496177642, 21960.89019554908, 22157.0, 16953.66092678152, 17145.314187432487, 17357.47927562175, 17421.564460888454, 17442.912785436118, 3557.6442355764475, 3591.676749092594, 3592.0660628236847, 3592.7305452091196, 3594.6405359464106, 122108.0, 123105.0, 123631.3818430911, 126499.36750316282, 126910.0, 16738.665226695397, 16760.1619919006, 17066.743998840026, 17083.316667333416, 17152.914235428994, 30249.848750756104, 31520.684793152235, 31573.368532629218, 31588.0, 31633.0, 7677.347425468898, 7903.170167132484, 8654.653813847375, 8966.0, 9165.266778657691, 4222.155568886174, 4327.415798867176, 4335.544767799399, 4339.82640694375, 4350.456192975878, 5336.252924590561, 5428.945710542844, 5429.348478182644, 5469.288992430958, 5476.7535460904355, 1009.2934945538153, 1017.6946915925192, 1040.70339953113, 1048.6120135549895, 1048.9685309440729, 686.3651122711472, 686.9072675188786, 697.2086681616402, 704.2042491984025, 716.7240612364277, 11325.263857849213, 11702.88297117035, 11931.1051671125, 12527.123101382816, 12726.300053497147, 659.1990731261444, 662.3409707341226, 669.2069897171867, 678.4335080207983, 696.6586372677351, 5760.6255593386295, 6351.777687780906, 6372.522060845455, 6389.872202555923, 6449.709763060673, 111078.0, 111184.44407777909, 111570.0, 111909.0, 115127.42436287765, 96179.51910240404, 101144.49427752814, 102674.0, 102801.0, 104834.0, 88315.0, 90329.54835225914, 90513.54743226373, 91074.08925910789, 92328.53835730912, 13383.866161338263, 13499.32503374847, 13551.661208469866, 13664.726705465637, 13670.248136352597, 38633.42049869198, 39440.60559394369, 39627.20745585015, 39845.60154398419, 40440.59559404486, 49359.25961110658, 50228.748856255486, 50833.49166508435, 51170.232446512586, 52079.479205208976, 17117.914410427868, 18853.24587016559, 18916.905415472833, 19139.904300478407, 19210.903945480182, 18806.435806925812, 18874.0, 19068.23727050958, 19106.23575056982, 19172.71240931415, 17613.559661008578, 17665.558361041076, 17817.376391826223, 17861.73207401916, 17936.641267174324, 16461.58846028811, 16483.175841208133, 16608.335666573686, 16642.750358744386, 16677.249523771217, 17336.65326693484, 17501.737473937646, 17517.82482175213, 17520.211590478713, 17669.293228270726, 13835.377408016864, 13905.930470347583, 14058.648533786738, 14249.64375890611, 14345.64135896611, 14964.850351496345, 15058.247087645355, 15154.848451515343, 15157.556045185815, 15317.540473785804], "value": 9208.48280535325, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 107.0, 109.0, 110.0, 113.0, 108.0, 115.0, 100.0, 107.0, 114.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 118.0, 162.0, 172.0, 119.0, 145.0, 144.0, 117.0, 174.0, 129.0], "value": 143.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 170.0, 165.0, 163.0, 166.0, 165.0, 177.0, 164.0, 162.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 80.0, 170.0, 76.0, 77.0, 85.0, 91.0, 97.0, 81.0], "value": 90.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 128.0, 88.0, 79.0, 80.0, 130.0, 80.0, 85.0, 133.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 117.0, 116.0, 117.0, 122.0, 114.0, 114.0, 120.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 151.0, 149.0, 149.0, 150.0, 153.0, 151.0, 151.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 96.0, 93.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 61.0, 58.0, 56.0, 54.0, 64.0, 53.0, 54.0, 52.0, 53.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 53.0, 54.0, 55.0, 60.0, 61.0, 54.0, 60.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 84.0, 77.0, 80.0, 78.0, 79.0, 77.0, 77.0, 76.0, 77.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 125.0, 141.0, 139.0, 130.0, 125.0, 140.0, 121.0, 124.0, 176.0], "value": 135.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 183.0, 190.0, 187.0, 180.0, 176.0, 177.0, 190.0, 175.0, 178.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 68.0, 73.0, 68.0, 70.0, 72.0, 72.0, 69.0, 68.0, 69.0], "value": 70.4, "unit": "score"}]}]} 00:02:53 INFO - Return code: 0 00:02:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:02:53 INFO - # TBPL SUCCESS # 00:02:53 INFO - Running post-action listener: _package_coverage_data 00:02:53 INFO - Running post-action listener: _resource_record_post_action 00:02:53 INFO - [mozharness: 2017-08-16 07:02:53.417949Z] Finished run-tests step (success) 00:02:53 INFO - Running post-run listener: _resource_record_post_run 00:02:53 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8232960; Write bytes: 442667008; Read time: 3024; Write time: 480456 00:02:53 INFO - TinderboxPrint: CPU usage
13.2% 00:02:53 INFO - TinderboxPrint: I/O read bytes / time
8,232,960 / 3,024 00:02:53 INFO - TinderboxPrint: I/O write bytes / time
442,667,008 / 480,456 00:02:53 INFO - TinderboxPrint: CPU idle
8,290.8 (86.8%) 00:02:53 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 00:02:53 INFO - TinderboxPrint: Swap in / out
0 / 0 00:02:53 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107311104; Read time: 76; Write time: 128276 00:02:53 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 00:02:53 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 5722112; Write bytes: 321978368; Read time: 2452; Write time: 346860 00:02:54 INFO - Running post-run listener: _upload_blobber_files 00:02:54 INFO - Blob upload gear active. 00:02:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:02:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:02:54 INFO - (blobuploader) - INFO - Open directory for files ... 00:02:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:02:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:02:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:02:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:02:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:02:55 INFO - (blobuploader) - INFO - Done attempting. 00:02:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:02:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:02:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:03:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:02 INFO - (blobuploader) - INFO - Done attempting. 00:03:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:03:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:03:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:02 INFO - (blobuploader) - INFO - Done attempting. 00:03:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:03:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:03:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:03:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:03:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:03:03 INFO - (blobuploader) - INFO - Done attempting. 00:03:03 INFO - (blobuploader) - INFO - Iteration through files over. 00:03:03 INFO - Return code: 0 00:03:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:03:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:03:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57312657958155a19278b60f9ade8422b7913d829b332a92427876797bb16aeab0ebbbf4e13b47d0947d3f3caae7277c9f9ff36afb8bf9ff83a9edca8a848394", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4043308ec5217656104566b7283e777630c6202b8e9a4fe7b23daf8b3760db1a39f6edb54f94db388bbf239a3ce84eefb6123521fd0c9ae4c0337d1dfa309f16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd47233071405445481631d30cf0113ec9aa12b7e568ff4c0344f69b5f655b488851740249e17095a61e60a98017e9c5846377ff55a5f8f964a671472dc54208", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab618be9f262cfc329a04e696f2a29a7ceb77b8e3f71c8cba5276da6bc36b6b7a46afe6ecdd2418106ff72e18cb3cbea46162b756a0408233f053e8c993acc5b"} 00:03:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:03:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:03:03 INFO - Contents: 00:03:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57312657958155a19278b60f9ade8422b7913d829b332a92427876797bb16aeab0ebbbf4e13b47d0947d3f3caae7277c9f9ff36afb8bf9ff83a9edca8a848394", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4043308ec5217656104566b7283e777630c6202b8e9a4fe7b23daf8b3760db1a39f6edb54f94db388bbf239a3ce84eefb6123521fd0c9ae4c0337d1dfa309f16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd47233071405445481631d30cf0113ec9aa12b7e568ff4c0344f69b5f655b488851740249e17095a61e60a98017e9c5846377ff55a5f8f964a671472dc54208", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab618be9f262cfc329a04e696f2a29a7ceb77b8e3f71c8cba5276da6bc36b6b7a46afe6ecdd2418106ff72e18cb3cbea46162b756a0408233f053e8c993acc5b"} 00:03:03 INFO - Running post-run listener: copy_logs_to_upload_dir 00:03:03 INFO - Copying logs to upload dir... 00:03:03 INFO - mkdir: /builds/slave/test/build/upload/logs 00:03:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.034649 ========= master_lag: 0.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-08-16 00:03:03.834124) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 00:03:03.839030) ========= 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=41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57312657958155a19278b60f9ade8422b7913d829b332a92427876797bb16aeab0ebbbf4e13b47d0947d3f3caae7277c9f9ff36afb8bf9ff83a9edca8a848394", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4043308ec5217656104566b7283e777630c6202b8e9a4fe7b23daf8b3760db1a39f6edb54f94db388bbf239a3ce84eefb6123521fd0c9ae4c0337d1dfa309f16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd47233071405445481631d30cf0113ec9aa12b7e568ff4c0344f69b5f655b488851740249e17095a61e60a98017e9c5846377ff55a5f8f964a671472dc54208", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab618be9f262cfc329a04e696f2a29a7ceb77b8e3f71c8cba5276da6bc36b6b7a46afe6ecdd2418106ff72e18cb3cbea46162b756a0408233f053e8c993acc5b"} build_url:https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011194 build_url: 'https://queue.taskcluster.net/v1/task/d3FxelQfSZeBQxstE0lcrA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/57312657958155a19278b60f9ade8422b7913d829b332a92427876797bb16aeab0ebbbf4e13b47d0947d3f3caae7277c9f9ff36afb8bf9ff83a9edca8a848394", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4043308ec5217656104566b7283e777630c6202b8e9a4fe7b23daf8b3760db1a39f6edb54f94db388bbf239a3ce84eefb6123521fd0c9ae4c0337d1dfa309f16", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bd47233071405445481631d30cf0113ec9aa12b7e568ff4c0344f69b5f655b488851740249e17095a61e60a98017e9c5846377ff55a5f8f964a671472dc54208", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab618be9f262cfc329a04e696f2a29a7ceb77b8e3f71c8cba5276da6bc36b6b7a46afe6ecdd2418106ff72e18cb3cbea46162b756a0408233f053e8c993acc5b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 00:03:03.868743) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 00:03:03.869067) ========= 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=41a7e32711b8e08598a63237000001d6-1502865717.369357-348270724 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 00:03:03.951721) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 00:03:03.952043) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 00:03:03.952325) ========= ========= Total master_lag: 0.61 =========