builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-073 starttime: 1502760630.67 results: success (0) revision: b95b1638db48fc3d450b95b98da6bcd2f9326d2f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 18:30:30.672930) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-14 18:30:30.673401) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 18:30:30.673671) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-14 18:30:30.697402) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 18:30:30.697766) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-14 18:30:31-- 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% 212M=0s 2017-08-14 18:30:31 (212 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132956 ========= master_lag: 0.28 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 18:30:31.114699) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 18:30:31.115012) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021870 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 18:30:31.180852) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-14 18:30:31.181209) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b95b1638db48fc3d450b95b98da6bcd2f9326d2f --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 b95b1638db48fc3d450b95b98da6bcd2f9326d2f --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=9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-14 18:30:32,250 truncating revision to first 12 chars 2017-08-14 18:30:32,250 Setting DEBUG logging. 2017-08-14 18:30:32,250 attempt 1/10 2017-08-14 18:30:32,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b95b1638db48?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-14 18:30:33,225 unpacking tar archive at: mozilla-central-b95b1638db48/testing/mozharness/ program finished with exit code 0 elapsedTime=1.283655 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-14 18:30:32.491358) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 18:30:32.491632) ========= script_repo_revision: b95b1638db48fc3d450b95b98da6bcd2f9326d2f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-14 18:30:32.492004) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 18:30:32.492260) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-14 18:30:32.507375) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-14 18:30:32.507707) ========= /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=9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:30:33 INFO - MultiFileLogger online at 20170814 18:30:33 in /builds/slave/test 18:30:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:30:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:30:33 INFO - {'append_to_log': False, 18:30:33 INFO - 'base_work_dir': '/builds/slave/test', 18:30:33 INFO - 'blob_upload_branch': 'Firefox', 18:30:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:30:33 INFO - 'branch': 'Firefox', 18:30:33 INFO - 'buildbot_json_path': 'buildprops.json', 18:30:33 INFO - 'code_coverage': False, 18:30:33 INFO - 'config_files': ('talos/linux_config.py',), 18:30:33 INFO - 'default_actions': ('clobber', 18:30:33 INFO - 'read-buildbot-config', 18:30:33 INFO - 'download-and-extract', 18:30:33 INFO - 'populate-webroot', 18:30:33 INFO - 'create-virtualenv', 18:30:33 INFO - 'install', 18:30:33 INFO - 'setup-mitmproxy', 18:30:33 INFO - 'run-tests'), 18:30:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:30:33 INFO - 'disable_ccov_upload': False, 18:30:33 INFO - 'download_minidump_stackwalk': True, 18:30:33 INFO - 'download_symbols': 'ondemand', 18:30:33 INFO - 'enable_stylo': False, 18:30:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:30:33 INFO - 'tooltool.py': '/tools/tooltool.py', 18:30:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:30:33 INFO - '/tools/misc-python/virtualenv.py')}, 18:30:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:30:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:30:33 INFO - 'gecko_profile': False, 18:30:33 INFO - 'gecko_profile_interval': 0, 18:30:33 INFO - 'installer_path': 'installer.exe', 18:30:33 INFO - 'log_level': 'info', 18:30:33 INFO - 'log_name': 'talos', 18:30:33 INFO - 'log_to_console': True, 18:30:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:30:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:30:33 INFO - 'opt_config_files': (), 18:30:33 INFO - 'pip_index': False, 18:30:33 INFO - 'suite': 'dromaeojs-e10s', 18:30:33 INFO - 'system_bits': '32', 18:30:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:30:33 INFO - 'title': 'talos-linux64-ix-073', 18:30:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:30:33 INFO - 'use_talos_json': True, 18:30:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:30:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:30:33 INFO - 'work_dir': 'build'} 18:30:33 INFO - [mozharness: 2017-08-15 01:30:33.670454Z] Running clobber step. 18:30:33 INFO - Running pre-action listener: _resource_record_pre_action 18:30:33 INFO - Running main action method: clobber 18:30:33 INFO - rmtree: /builds/slave/test/build 18:30:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:30:34 INFO - Running post-action listener: _resource_record_post_action 18:30:34 INFO - [mozharness: 2017-08-15 01:30:34.712786Z] Finished clobber step (success) 18:30:34 INFO - [mozharness: 2017-08-15 01:30:34.712888Z] Running read-buildbot-config step. 18:30:34 INFO - Running pre-action listener: _resource_record_pre_action 18:30:34 INFO - Running main action method: read_buildbot_config 18:30:34 INFO - Using buildbot properties: 18:30:34 INFO - { 18:30:34 INFO - "project": "", 18:30:34 INFO - "product": "firefox", 18:30:34 INFO - "who": "kwierso@gmail.com", 18:30:34 INFO - "installer_path": "public/build/target.tar.bz2", 18:30:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 18:30:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 18:30:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 18:30:34 INFO - "stage_platform": "linux64-stylosequential", 18:30:34 INFO - "basedir": "/builds/slave/test", 18:30:34 INFO - "buildnumber": 32, 18:30:34 INFO - "platform": "ubuntu64_hw_styloseq", 18:30:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:30:34 INFO - "slavebuilddir": "test", 18:30:34 INFO - "taskId": "ZXb8ic-LRdCvPETRF6cxNg", 18:30:34 INFO - "branch": "mozilla-central", 18:30:34 INFO - "script_repo_revision": "production", 18:30:34 INFO - "revision": "b95b1638db48fc3d450b95b98da6bcd2f9326d2f", 18:30:34 INFO - "slavename": "talos-linux64-ix-073", 18:30:34 INFO - "repo_path": "mozilla-central" 18:30:34 INFO - } 18:30:34 INFO - Finding installer, test and symbols from parent task. 18:30:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZXb8ic-LRdCvPETRF6cxNg'}, attempt #1 18:30:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZXb8ic-LRdCvPETRF6cxNg'}, attempt #1 18:30:35 INFO - Task dependencies: WNyohAO-Q2uqbLtYqVVqMQ 18:30:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ'}, attempt #1 18:30:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.tar.bz2 18:30:36 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.test_packages.json 18:30:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.crashreporter-symbols.zip 18:30:36 INFO - Running post-action listener: _resource_record_post_action 18:30:36 INFO - [mozharness: 2017-08-15 01:30:36.105890Z] Finished read-buildbot-config step (success) 18:30:36 INFO - [mozharness: 2017-08-15 01:30:36.106112Z] Running download-and-extract step. 18:30:36 INFO - Running pre-action listener: _resource_record_pre_action 18:30:36 INFO - Running main action method: download_and_extract 18:30:36 INFO - mkdir: /builds/slave/test/build/tests 18:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:30:36 INFO - trying https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.test_packages.json 18:30:36 INFO - Downloading https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:30:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:30:36 INFO - Downloaded 989 bytes. 18:30:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:30:36 INFO - Using the following test package requirements: 18:30:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:30:36 INFO - u'common': [u'target.common.tests.zip'], 18:30:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:30:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:30:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:30:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:30:36 INFO - u'mozbase': [u'target.common.tests.zip'], 18:30:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:30:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:30:36 INFO - u'web-platform': [u'target.common.tests.zip', 18:30:36 INFO - u'target.web-platform.tests.tar.gz'], 18:30:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:30:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:30:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.common.tests.zip 18:30:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:30:36 INFO - Fetch https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.common.tests.zip into memory 18:30:38 INFO - Content-Length response header: 54034621 18:30:38 INFO - Bytes received: 54034621 18:30:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:30:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.common.tests.zip 18:30:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:30:49 INFO - Fetch https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.common.tests.zip into memory 18:30:50 INFO - Content-Length response header: 54034621 18:30:50 INFO - Bytes received: 54034621 18:31:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.talos.tests.zip 18:31:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:31:02 INFO - Fetch https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.talos.tests.zip into memory 18:31:03 INFO - Content-Length response header: 14496050 18:31:03 INFO - Bytes received: 14496050 18:31:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:04 INFO - trying https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.tar.bz2 18:31:04 INFO - Downloading https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:31:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:31:05 INFO - Downloaded 61935990 bytes. 18:31:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.tar.bz2 18:31:05 INFO - mkdir: /builds/slave/test/properties 18:31:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:31:05 INFO - Writing to file /builds/slave/test/properties/build_url 18:31:05 INFO - Contents: 18:31:05 INFO - build_url:https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.tar.bz2 18:31:05 INFO - Running post-action listener: _resource_record_post_action 18:31:05 INFO - Running post-action listener: set_extra_try_arguments 18:31:05 INFO - [mozharness: 2017-08-15 01:31:05.458161Z] Finished download-and-extract step (success) 18:31:05 INFO - [mozharness: 2017-08-15 01:31:05.458259Z] Running populate-webroot step. 18:31:05 INFO - Running pre-action listener: _resource_record_pre_action 18:31:05 INFO - Running main action method: populate_webroot 18:31:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:31:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:31:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:31:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:31:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:31:05 INFO - 'tests': ['damp', 'tps']}, 18:31:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:31:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:31:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:31:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:31:05 INFO - 'other-e10s': {'tests': ['a11yr', 18:31:05 INFO - 'ts_paint', 18:31:05 INFO - 'tpaint', 18:31:05 INFO - 'sessionrestore', 18:31:05 INFO - 'sessionrestore_many_windows', 18:31:05 INFO - 'sessionrestore_no_auto_restore', 18:31:05 INFO - 'tabpaint']}, 18:31:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 18:31:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 18:31:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:31:05 INFO - 'tsvgr_opacity', 18:31:05 INFO - 'tart', 18:31:05 INFO - 'tscrollx', 18:31:05 INFO - 'tsvg_static']}, 18:31:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:31:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:31:05 INFO - 'talos_options': ['--mitmproxy', 18:31:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:31:05 INFO - '--firstNonBlankPaint'], 18:31:05 INFO - 'tests': ['tp6_google', 18:31:05 INFO - 'tp6_youtube', 18:31:05 INFO - 'tp6_amazon', 18:31:05 INFO - 'tp6_facebook']}, 18:31:05 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:31:05 INFO - 'talos_options': ['--stylo', 18:31:05 INFO - '--mitmproxy', 18:31:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:31:05 INFO - '--firstNonBlankPaint'], 18:31:05 INFO - 'tests': ['tp6_google', 18:31:05 INFO - 'tp6_youtube', 18:31:05 INFO - 'tp6_amazon', 18:31:05 INFO - 'tp6_facebook']}, 18:31:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 18:31:05 INFO - 'talos_options': ['--stylo', 18:31:05 INFO - '--stylo-threads=1', 18:31:05 INFO - '--mitmproxy', 18:31:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 18:31:05 INFO - '--firstNonBlankPaint'], 18:31:05 INFO - 'tests': ['tp6_google', 18:31:05 INFO - 'tp6_youtube', 18:31:05 INFO - 'tp6_amazon', 18:31:05 INFO - 'tp6_facebook']}, 18:31:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:31:05 INFO - 'talos_options': ['--xperf_path', 18:31:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:31:05 INFO - 'tests': ['tp5n']}}} 18:31:05 INFO - Running post-action listener: _resource_record_post_action 18:31:05 INFO - [mozharness: 2017-08-15 01:31:05.466674Z] Finished populate-webroot step (success) 18:31:05 INFO - [mozharness: 2017-08-15 01:31:05.466764Z] Running create-virtualenv step. 18:31:05 INFO - Running pre-action listener: _resource_record_pre_action 18:31:05 INFO - Running main action method: create_virtualenv 18:31:05 INFO - Creating virtualenv /builds/slave/test/build/venv 18:31:05 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:31:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:31:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 18:31:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:31:05 INFO - Using real prefix '/usr' 18:31:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:31:06 INFO - Installing distribute.............................................................................................................................................................................................done. 18:31:08 INFO - Installing pip.................done. 18:31:08 INFO - Return code: 0 18:31:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:31:08 INFO - Reading from file tmpfile_stdout 18:31:08 INFO - Output received: 18:31:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:31:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:08 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 0x26261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2993b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2996f00>, '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 0x2991ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2992050>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:31:08 INFO - Using env: {'DISPLAY': ':0', 18:31:08 INFO - 'HOME': '/home/cltbld', 18:31:08 INFO - 'LANG': 'en_US.UTF-8', 18:31:08 INFO - 'LANGUAGE': 'en_US:en', 18:31:08 INFO - 'LOGNAME': 'cltbld', 18:31:08 INFO - 'MAIL': '/var/mail/cltbld', 18:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:08 INFO - 'MOZ_NO_REMOTE': '1', 18:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:08 INFO - 'NO_EM_RESTART': '1', 18:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:08 INFO - 'PWD': '/builds/slave/test', 18:31:08 INFO - 'SHELL': '/bin/bash', 18:31:08 INFO - 'SHLVL': '1', 18:31:08 INFO - 'TERM': 'linux', 18:31:08 INFO - 'TMOUT': '86400', 18:31:08 INFO - 'USER': 'cltbld', 18:31:08 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 18:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:08 INFO - '_': '/tools/buildbot/bin/python'} 18:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:31:08 INFO - Cleaning up... 18:31:08 INFO - Return code: 0 18:31:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:08 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 0x26261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2993b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2996f00>, '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 0x2991ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2992050>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:31:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:31:08 INFO - Using env: {'DISPLAY': ':0', 18:31:08 INFO - 'HOME': '/home/cltbld', 18:31:08 INFO - 'LANG': 'en_US.UTF-8', 18:31:08 INFO - 'LANGUAGE': 'en_US:en', 18:31:08 INFO - 'LOGNAME': 'cltbld', 18:31:08 INFO - 'MAIL': '/var/mail/cltbld', 18:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:08 INFO - 'MOZ_NO_REMOTE': '1', 18:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:08 INFO - 'NO_EM_RESTART': '1', 18:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:08 INFO - 'PWD': '/builds/slave/test', 18:31:08 INFO - 'SHELL': '/bin/bash', 18:31:08 INFO - 'SHLVL': '1', 18:31:08 INFO - 'TERM': 'linux', 18:31:08 INFO - 'TMOUT': '86400', 18:31:08 INFO - 'USER': 'cltbld', 18:31:08 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 18:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:08 INFO - '_': '/tools/buildbot/bin/python'} 18:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:08 INFO - Downloading/unpacking psutil>=3.1.1 18:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:31:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:09 INFO - Installing collected packages: psutil 18:31:09 INFO - Running setup.py install for psutil 18:31:10 INFO - building 'psutil._psutil_linux' extension 18:31:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:31:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:31:10 INFO - building 'psutil._psutil_posix' extension 18:31:10 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:31:10 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:31:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:31:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:31:10 INFO - Successfully installed psutil 18:31:10 INFO - Cleaning up... 18:31:10 INFO - Return code: 0 18:31:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:10 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 0x26261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2993b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2996f00>, '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 0x2991ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2992050>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:31:10 INFO - Using env: {'DISPLAY': ':0', 18:31:10 INFO - 'HOME': '/home/cltbld', 18:31:10 INFO - 'LANG': 'en_US.UTF-8', 18:31:10 INFO - 'LANGUAGE': 'en_US:en', 18:31:10 INFO - 'LOGNAME': 'cltbld', 18:31:10 INFO - 'MAIL': '/var/mail/cltbld', 18:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:10 INFO - 'MOZ_NO_REMOTE': '1', 18:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:10 INFO - 'NO_EM_RESTART': '1', 18:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:10 INFO - 'PWD': '/builds/slave/test', 18:31:10 INFO - 'SHELL': '/bin/bash', 18:31:10 INFO - 'SHLVL': '1', 18:31:10 INFO - 'TERM': 'linux', 18:31:10 INFO - 'TMOUT': '86400', 18:31:10 INFO - 'USER': 'cltbld', 18:31:10 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 18:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:10 INFO - '_': '/tools/buildbot/bin/python'} 18:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:31:11 INFO - Installing collected packages: mozsystemmonitor 18:31:11 INFO - Running setup.py install for mozsystemmonitor 18:31:12 INFO - Successfully installed mozsystemmonitor 18:31:12 INFO - Cleaning up... 18:31:12 INFO - Return code: 0 18:31:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2993b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2996f00>, '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 0x2991ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2992050>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:31:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:31:12 INFO - Using env: {'DISPLAY': ':0', 18:31:12 INFO - 'HOME': '/home/cltbld', 18:31:12 INFO - 'LANG': 'en_US.UTF-8', 18:31:12 INFO - 'LANGUAGE': 'en_US:en', 18:31:12 INFO - 'LOGNAME': 'cltbld', 18:31:12 INFO - 'MAIL': '/var/mail/cltbld', 18:31:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:12 INFO - 'MOZ_NO_REMOTE': '1', 18:31:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:12 INFO - 'NO_EM_RESTART': '1', 18:31:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:12 INFO - 'PWD': '/builds/slave/test', 18:31:12 INFO - 'SHELL': '/bin/bash', 18:31:12 INFO - 'SHLVL': '1', 18:31:12 INFO - 'TERM': 'linux', 18:31:12 INFO - 'TMOUT': '86400', 18:31:12 INFO - 'USER': 'cltbld', 18:31:12 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 18:31:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:12 INFO - '_': '/tools/buildbot/bin/python'} 18:31:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:12 INFO - Downloading/unpacking jsonschema==2.5.1 18:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:31:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:13 INFO - Downloading functools32-3.2.3-2.tar.gz 18:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:31:13 INFO - warning: no files found matching '*.txt' 18:31:13 INFO - no previously-included directories found matching 'build' 18:31:13 INFO - no previously-included directories found matching 'dist' 18:31:13 INFO - no previously-included directories found matching '.git*' 18:31:13 INFO - Installing collected packages: jsonschema, functools32 18:31:13 INFO - Running setup.py install for functools32 18:31:13 INFO - warning: no files found matching '*.txt' 18:31:13 INFO - no previously-included directories found matching 'build' 18:31:13 INFO - no previously-included directories found matching 'dist' 18:31:13 INFO - no previously-included directories found matching '.git*' 18:31:13 INFO - Successfully installed jsonschema functools32 18:31:13 INFO - Cleaning up... 18:31:13 INFO - Return code: 0 18:31:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:31: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')]} 18:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31: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')]} 18:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:13 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 0x26261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2993b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2996f00>, '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 0x2991ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2992050>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:31:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:31:13 INFO - Using env: {'DISPLAY': ':0', 18:31:13 INFO - 'HOME': '/home/cltbld', 18:31:13 INFO - 'LANG': 'en_US.UTF-8', 18:31:13 INFO - 'LANGUAGE': 'en_US:en', 18:31:13 INFO - 'LOGNAME': 'cltbld', 18:31:13 INFO - 'MAIL': '/var/mail/cltbld', 18:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:13 INFO - 'MOZ_NO_REMOTE': '1', 18:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:13 INFO - 'NO_EM_RESTART': '1', 18:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:13 INFO - 'PWD': '/builds/slave/test', 18:31:13 INFO - 'SHELL': '/bin/bash', 18:31:13 INFO - 'SHLVL': '1', 18:31:13 INFO - 'TERM': 'linux', 18:31:13 INFO - 'TMOUT': '86400', 18:31:13 INFO - 'USER': 'cltbld', 18:31:13 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 18:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:13 INFO - '_': '/tools/buildbot/bin/python'} 18:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:31:13 INFO - Cleaning up... 18:31:14 INFO - Return code: 0 18:31:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2993b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2996f00>, '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 0x2991ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2992050>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:31:14 INFO - Using env: {'DISPLAY': ':0', 18:31:14 INFO - 'HOME': '/home/cltbld', 18:31:14 INFO - 'LANG': 'en_US.UTF-8', 18:31:14 INFO - 'LANGUAGE': 'en_US:en', 18:31:14 INFO - 'LOGNAME': 'cltbld', 18:31:14 INFO - 'MAIL': '/var/mail/cltbld', 18:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:14 INFO - 'MOZ_NO_REMOTE': '1', 18:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:14 INFO - 'NO_EM_RESTART': '1', 18:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:14 INFO - 'PWD': '/builds/slave/test', 18:31:14 INFO - 'SHELL': '/bin/bash', 18:31:14 INFO - 'SHLVL': '1', 18:31:14 INFO - 'TERM': 'linux', 18:31:14 INFO - 'TMOUT': '86400', 18:31:14 INFO - 'USER': 'cltbld', 18:31:14 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 18:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:14 INFO - '_': '/tools/buildbot/bin/python'} 18:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:14 INFO - Downloading/unpacking blobuploader==1.2.4 18:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:15 INFO - Downloading blobuploader-1.2.4.tar.gz 18:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:31:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:31:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:15 INFO - Downloading docopt-0.6.1.tar.gz 18:31:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:31:15 INFO - Installing collected packages: blobuploader, requests, docopt 18:31:15 INFO - Running setup.py install for blobuploader 18:31:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:31:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:31:16 INFO - Running setup.py install for requests 18:31:16 INFO - Running setup.py install for docopt 18:31:16 INFO - Successfully installed blobuploader requests docopt 18:31:16 INFO - Cleaning up... 18:31:16 INFO - Return code: 0 18:31:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:16 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 0x26261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2993b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2996f00>, '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 0x2991ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2992050>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:31:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:31:16 INFO - Using env: {'DISPLAY': ':0', 18:31:16 INFO - 'HOME': '/home/cltbld', 18:31:16 INFO - 'LANG': 'en_US.UTF-8', 18:31:16 INFO - 'LANGUAGE': 'en_US:en', 18:31:16 INFO - 'LOGNAME': 'cltbld', 18:31:16 INFO - 'MAIL': '/var/mail/cltbld', 18:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:16 INFO - 'MOZ_NO_REMOTE': '1', 18:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:16 INFO - 'NO_EM_RESTART': '1', 18:31:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:16 INFO - 'PWD': '/builds/slave/test', 18:31:16 INFO - 'SHELL': '/bin/bash', 18:31:16 INFO - 'SHLVL': '1', 18:31:16 INFO - 'TERM': 'linux', 18:31:16 INFO - 'TMOUT': '86400', 18:31:16 INFO - 'USER': 'cltbld', 18:31:16 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 18:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:16 INFO - '_': '/tools/buildbot/bin/python'} 18:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:16 INFO - Running setup.py (path:/tmp/pip-0OHgWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:16 INFO - Running setup.py (path:/tmp/pip-4oUOGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:16 INFO - Running setup.py (path:/tmp/pip-vV8cMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:16 INFO - Running setup.py (path:/tmp/pip-cnBvLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:17 INFO - Running setup.py (path:/tmp/pip-zOBoWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:17 INFO - Running setup.py (path:/tmp/pip-dK_WXP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:17 INFO - Running setup.py (path:/tmp/pip-QBRWuW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:17 INFO - Running setup.py (path:/tmp/pip-uxwqIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:17 INFO - Running setup.py (path:/tmp/pip-69nZFo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:17 INFO - Running setup.py (path:/tmp/pip-iRYRqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:17 INFO - Running setup.py (path:/tmp/pip-bwkAXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:17 INFO - Running setup.py (path:/tmp/pip-MNDey8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:17 INFO - Running setup.py (path:/tmp/pip-2VnMsy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:17 INFO - Running setup.py (path:/tmp/pip-oq2sPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:17 INFO - Running setup.py (path:/tmp/pip-KkcnhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:17 INFO - Running setup.py (path:/tmp/pip-1ojSlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:17 INFO - Running setup.py (path:/tmp/pip-imRCjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:31:17 INFO - Running setup.py install for manifestparser 18:31:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:31:18 INFO - Running setup.py install for mozcrash 18:31:18 INFO - Running setup.py install for mozdebug 18:31:18 INFO - Running setup.py install for mozdevice 18:31:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:31:18 INFO - Running setup.py install for mozfile 18:31:18 INFO - Running setup.py install for mozhttpd 18:31:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:31:18 INFO - Running setup.py install for mozinfo 18:31:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:31:18 INFO - Running setup.py install for mozInstall 18:31:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:31:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:31:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:31:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:31:18 INFO - Running setup.py install for mozleak 18:31:18 INFO - Running setup.py install for mozlog 18:31:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:31:19 INFO - Running setup.py install for moznetwork 18:31:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:31:19 INFO - Running setup.py install for mozprocess 18:31:19 INFO - Running setup.py install for mozprofile 18:31:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:31:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:31:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:31:19 INFO - Running setup.py install for mozrunner 18:31:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:31:19 INFO - Running setup.py install for mozscreenshot 18:31:19 INFO - Running setup.py install for moztest 18:31:19 INFO - Running setup.py install for mozversion 18:31:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:31:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:31:19 INFO - Cleaning up... 18:31:19 INFO - Return code: 0 18:31:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:19 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 0x26261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2993b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2996f00>, '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 0x2991ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2992050>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:31:19 INFO - Using env: {'DISPLAY': ':0', 18:31:19 INFO - 'HOME': '/home/cltbld', 18:31:19 INFO - 'LANG': 'en_US.UTF-8', 18:31:19 INFO - 'LANGUAGE': 'en_US:en', 18:31:19 INFO - 'LOGNAME': 'cltbld', 18:31:19 INFO - 'MAIL': '/var/mail/cltbld', 18:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:19 INFO - 'MOZ_NO_REMOTE': '1', 18:31:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:19 INFO - 'NO_EM_RESTART': '1', 18:31:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:19 INFO - 'PWD': '/builds/slave/test', 18:31:19 INFO - 'SHELL': '/bin/bash', 18:31:19 INFO - 'SHLVL': '1', 18:31:19 INFO - 'TERM': 'linux', 18:31:19 INFO - 'TMOUT': '86400', 18:31:19 INFO - 'USER': 'cltbld', 18:31:19 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 18:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:19 INFO - '_': '/tools/buildbot/bin/python'} 18:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:31:20 INFO - Running setup.py (path:/tmp/pip-I15UL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:31:20 INFO - Running setup.py (path:/tmp/pip-_9uXZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:31:20 INFO - Running setup.py (path:/tmp/pip-zOYPNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:31:20 INFO - Running setup.py (path:/tmp/pip-HvOn6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:31:20 INFO - Running setup.py (path:/tmp/pip-Xg_7Ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:31:20 INFO - Running setup.py (path:/tmp/pip-Xj5gUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:31:20 INFO - Running setup.py (path:/tmp/pip-AKjLxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:31:20 INFO - Running setup.py (path:/tmp/pip-rqovvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:31:20 INFO - Running setup.py (path:/tmp/pip-2h2uz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:31:20 INFO - Running setup.py (path:/tmp/pip-xMG0tP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:31:20 INFO - Running setup.py (path:/tmp/pip-_PtAxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:31:20 INFO - Running setup.py (path:/tmp/pip-aQJEeb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:31:20 INFO - Running setup.py (path:/tmp/pip-7GQWIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:31:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:31:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:31:20 INFO - Running setup.py (path:/tmp/pip-aOOz2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:21 INFO - Running setup.py (path:/tmp/pip-e5JFBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:31:21 INFO - Running setup.py (path:/tmp/pip-ZcwHH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:31:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:31:21 INFO - Running setup.py (path:/tmp/pip-SbPtvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:31:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:22 INFO - Downloading blessings-1.6.tar.gz 18:31:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:31:22 INFO - Installing collected packages: blessings 18:31:22 INFO - Running setup.py install for blessings 18:31:22 INFO - Successfully installed blessings 18:31:22 INFO - Cleaning up... 18:31:22 INFO - Return code: 0 18:31:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:31:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:22 INFO - Reading from file tmpfile_stdout 18:31:22 INFO - Current package versions: 18:31:22 INFO - argparse == 1.2.1 18:31:22 INFO - blessings == 1.6 18:31:22 INFO - blobuploader == 1.2.4 18:31:22 INFO - docopt == 0.6.1 18:31:22 INFO - functools32 == 3.2.3-2 18:31:22 INFO - jsonschema == 2.5.1 18:31:22 INFO - manifestparser == 1.1 18:31:22 INFO - mozInstall == 1.13 18:31:22 INFO - mozcrash == 1.0 18:31:22 INFO - mozdebug == 0.1 18:31:22 INFO - mozdevice == 0.51 18:31:22 INFO - mozfile == 1.2 18:31:22 INFO - mozhttpd == 0.7 18:31:22 INFO - mozinfo == 0.10 18:31:22 INFO - mozleak == 0.1 18:31:22 INFO - mozlog == 3.5 18:31:22 INFO - moznetwork == 0.27 18:31:22 INFO - mozprocess == 0.25 18:31:22 INFO - mozprofile == 0.28 18:31:22 INFO - mozrunner == 6.13 18:31:22 INFO - mozscreenshot == 0.1 18:31:22 INFO - mozsystemmonitor == 0.3 18:31:22 INFO - moztest == 0.8 18:31:22 INFO - mozversion == 1.4 18:31:22 INFO - psutil == 3.1.1 18:31:22 INFO - requests == 1.2.3 18:31:22 INFO - wsgiref == 0.1.2 18:31:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:22 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 0x26261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2993b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2996f00>, '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 0x2991ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2992050>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:31:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:31:22 INFO - Using env: {'DISPLAY': ':0', 18:31:22 INFO - 'HOME': '/home/cltbld', 18:31:22 INFO - 'LANG': 'en_US.UTF-8', 18:31:22 INFO - 'LANGUAGE': 'en_US:en', 18:31:22 INFO - 'LOGNAME': 'cltbld', 18:31:22 INFO - 'MAIL': '/var/mail/cltbld', 18:31:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:22 INFO - 'MOZ_NO_REMOTE': '1', 18:31:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:22 INFO - 'NO_EM_RESTART': '1', 18:31:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:22 INFO - 'PWD': '/builds/slave/test', 18:31:22 INFO - 'SHELL': '/bin/bash', 18:31:22 INFO - 'SHLVL': '1', 18:31:22 INFO - 'TERM': 'linux', 18:31:22 INFO - 'TMOUT': '86400', 18:31:22 INFO - 'USER': 'cltbld', 18:31:22 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 18:31:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:22 INFO - '_': '/tools/buildbot/bin/python'} 18:31:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:31:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:31:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:31:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 18:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:31:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:31:24 INFO - Installing collected packages: simplejson 18:31:24 INFO - Running setup.py install for simplejson 18:31:24 INFO - building 'simplejson._speedups' extension 18:31:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 18:31:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 18:31:25 INFO - Successfully installed simplejson 18:31:25 INFO - Cleaning up... 18:31:25 INFO - Return code: 0 18:31:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:31:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:31:25 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 0x26261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27f2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2993b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2996f00>, '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 0x2991ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2992050>, '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': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:31:25 INFO - Using env: {'DISPLAY': ':0', 18:31:25 INFO - 'HOME': '/home/cltbld', 18:31:25 INFO - 'LANG': 'en_US.UTF-8', 18:31:25 INFO - 'LANGUAGE': 'en_US:en', 18:31:25 INFO - 'LOGNAME': 'cltbld', 18:31:25 INFO - 'MAIL': '/var/mail/cltbld', 18:31:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:25 INFO - 'MOZ_NO_REMOTE': '1', 18:31:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:25 INFO - 'NO_EM_RESTART': '1', 18:31:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:25 INFO - 'PWD': '/builds/slave/test', 18:31:25 INFO - 'SHELL': '/bin/bash', 18:31:25 INFO - 'SHLVL': '1', 18:31:25 INFO - 'TERM': 'linux', 18:31:25 INFO - 'TMOUT': '86400', 18:31:25 INFO - 'USER': 'cltbld', 18:31:25 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 18:31:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:25 INFO - '_': '/tools/buildbot/bin/python'} 18:31:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:31:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:31:25 INFO - Cleaning up... 18:31:25 INFO - Return code: 0 18:31:25 INFO - Running post-action listener: _resource_record_post_action 18:31:25 INFO - Running post-action listener: _start_resource_monitoring 18:31:25 INFO - Starting resource monitoring. 18:31:25 INFO - [mozharness: 2017-08-15 01:31:25.472085Z] Finished create-virtualenv step (success) 18:31:25 INFO - [mozharness: 2017-08-15 01:31:25.472591Z] Running install step. 18:31:25 INFO - Running pre-action listener: _resource_record_pre_action 18:31:25 INFO - Running main action method: install 18:31:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:31:25 INFO - Reading from file tmpfile_stdout 18:31:25 INFO - Detecting whether we're running mozinstall >=1.0... 18:31:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:31:25 INFO - Reading from file tmpfile_stdout 18:31:25 INFO - Output received: 18:31:25 INFO - Usage: mozinstall [options] installer 18:31:25 INFO - Options: 18:31:25 INFO - -h, --help show this help message and exit 18:31:25 INFO - -d DEST, --destination=DEST 18:31:25 INFO - Directory to install application into. [default: 18:31:25 INFO - "/builds/slave/test"] 18:31:25 INFO - --app=APP Application being installed. [default: firefox] 18:31:25 INFO - mkdir: /builds/slave/test/build/application 18:31:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:31:43 INFO - Reading from file tmpfile_stdout 18:31:43 INFO - Output received: 18:31:43 INFO - /builds/slave/test/build/application/firefox/firefox 18:31:43 INFO - Running post-action listener: _resource_record_post_action 18:31:43 INFO - [mozharness: 2017-08-15 01:31:43.810754Z] Finished install step (success) 18:31:43 INFO - [mozharness: 2017-08-15 01:31:43.811006Z] Running setup-mitmproxy step. 18:31:43 INFO - Running pre-action listener: _resource_record_pre_action 18:31:43 INFO - Running main action method: setup_mitmproxy 18:31:43 INFO - Skipping: mitmproxy is not required 18:31:43 INFO - Running post-action listener: _resource_record_post_action 18:31:43 INFO - [mozharness: 2017-08-15 01:31:43.812142Z] Finished setup-mitmproxy step (success) 18:31:43 INFO - [mozharness: 2017-08-15 01:31:43.812362Z] Running run-tests step. 18:31:43 INFO - Running pre-action listener: _resource_record_pre_action 18:31:43 INFO - Running pre-action listener: _set_gcov_prefix 18:31:43 INFO - Running main action method: run_tests 18:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:31:43 INFO - Python 2.7.3 18:31:43 INFO - Return code: 0 18:31:43 INFO - grabbing minidump binary from tooltool 18:31: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')]} 18:31:43 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 0x2996f00>, '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 0x2991ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2992050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:31:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:31:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:31:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:31:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:31:43 INFO - Return code: 0 18:31:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:31:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:31:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:31:43 INFO - ENV: RUST_BACKTRACE is now full 18:31:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:31:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:31:43 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/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:31:43 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/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-073 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:31:43 INFO - Using env: {'DISPLAY': ':0', 18:31:43 INFO - 'HOME': '/home/cltbld', 18:31:43 INFO - 'LANG': 'en_US.UTF-8', 18:31:43 INFO - 'LANGUAGE': 'en_US:en', 18:31:43 INFO - 'LOGNAME': 'cltbld', 18:31:43 INFO - 'MAIL': '/var/mail/cltbld', 18:31:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:31:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:31:43 INFO - 'MOZ_NO_REMOTE': '1', 18:31:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:31:43 INFO - 'NO_EM_RESTART': '1', 18:31:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:31:43 INFO - 'PWD': '/builds/slave/test', 18:31:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:31:43 INFO - 'RUST_BACKTRACE': 'full', 18:31:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 18:31:43 INFO - 'SHELL': '/bin/bash', 18:31:43 INFO - 'SHLVL': '1', 18:31:43 INFO - 'STYLO_FORCE_ENABLED': '1', 18:31:43 INFO - 'TERM': 'linux', 18:31:43 INFO - 'TMOUT': '86400', 18:31:43 INFO - 'USER': 'cltbld', 18:31:43 INFO - 'XDG_SESSION_COOKIE': '9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126', 18:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:31:43 INFO - '_': '/tools/buildbot/bin/python'} 18:31:43 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/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-073', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:31:44 INFO - mozversion application_buildid: 20170815004719 18:31:44 INFO - mozversion application_changeset: b95b1638db48fc3d450b95b98da6bcd2f9326d2f 18:31:44 INFO - mozversion application_display_name: Nightly 18:31:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:31:44 INFO - mozversion application_name: Firefox 18:31:44 INFO - mozversion application_remotingname: firefox 18:31:44 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:31:44 INFO - mozversion application_vendor: Mozilla 18:31:44 INFO - mozversion application_version: 57.0a1 18:31:44 INFO - mozversion platform_buildid: 20170815004719 18:31:44 INFO - mozversion platform_changeset: b95b1638db48fc3d450b95b98da6bcd2f9326d2f 18:31:44 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:31:44 INFO - mozversion platform_version: 57.0a1 18:31:44 INFO - using testdate: 1502760704 18:31:44 INFO - actual date: 1502760704 18:31:44 INFO - starting webserver on 'localhost:49132' 18:31:44 INFO - SUITE-START | Running 2 tests 18:31:44 INFO - TEST-START | dromaeo_css 18:31:44 INFO - Initialising browser for dromaeo_css test... 18:31:44 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49132/getInfo.html -profile /tmp/tmpMwjuJU/profile 18:31:44 INFO - TEST-INFO | started process 29230 (/builds/slave/test/build/application/firefox/firefox http://localhost:49132/getInfo.html) 18:31:49 INFO - TEST-INFO | 29230: exit 0 18:31:50 INFO - Browser initialized. 18:31:50 INFO - Running cycle 1/1 for dromaeo_css test... 18:31:50 INFO - TEST-INFO | started process 29464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMwjuJU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:31:51 INFO - PID 29464 | 18:31:51 INFO - PID 29464 | (/builds/slave/test/build/application/firefox/firefox:29518): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:31:51 INFO - PID 29464 | 18:32:01 INFO - PID 29464 | RSS: Main: 168017920 18:32:01 INFO - PID 29464 | 18:35:01 INFO - PID 29464 | Cycle 1(1): loaded http://localhost:49132/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49132/tests/dromaeo/cssquery-ext.html) 18:35:02 INFO - PID 29464 | RSS: Main: 175407104 18:35:02 INFO - PID 29464 | 18:38:04 INFO - PID 29464 | Cycle 1(1): loaded http://localhost:49132/tests/dromaeo/cssquery-ext.html (next: http://localhost:49132/tests/dromaeo/cssquery-jquery.html) 18:38:04 INFO - PID 29464 | RSS: Main: 172572672 18:38:04 INFO - PID 29464 | 18:41:06 INFO - PID 29464 | Cycle 1(1): loaded http://localhost:49132/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49132/tests/dromaeo/cssquery-mootools.html) 18:41:07 INFO - PID 29464 | RSS: Main: 174743552 18:41:07 INFO - PID 29464 | 18:44:08 INFO - PID 29464 | Cycle 1(1): loaded http://localhost:49132/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49132/tests/dromaeo/cssquery-prototype.html) 18:44:09 INFO - PID 29464 | RSS: Main: 172732416 18:44:09 INFO - PID 29464 | 18:47:13 INFO - PID 29464 | Cycle 1(1): loaded http://localhost:49132/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49132/tests/dromaeo/cssquery-yui.html) 18:47:14 INFO - PID 29464 | RSS: Main: 176529408 18:47:14 INFO - PID 29464 | 18:50:15 INFO - PID 29464 | Cycle 1(1): loaded http://localhost:49132/tests/dromaeo/cssquery-yui.html (next: http://localhost:49132/tests/dromaeo/cssquery-dojo.html) 18:50:16 INFO - PID 29464 | RSS: Main: 177102848 18:50:16 INFO - PID 29464 | 18:50:16 INFO - PID 29464 | __start_tp_report 18:50:16 INFO - PID 29464 | _x_x_mozilla_page_load 18:50:16 INFO - PID 29464 | _x_x_mozilla_page_load_details 18:50:16 INFO - PID 29464 | |i|pagename|runs| 18:50:16 INFO - PID 29464 | |0;dojo.html;3165.794223375479;3183.363327334532;3188.5057816038516;3212.7269182119517;3219.4526930421825;6181.474574661159;6228.1591985082005;6242.875142497153;6280.089387038883;6283.685815709207;6082.939170608292;6166;6177.289611694657;6179.165812615295;6180;5614.157876318564;5651.971740141304;5656.406077361879;5658.8019419320335;5735;5744.597878148531;5759.827205183851;5776.480116789488;5800.506956908646;5879.412058794108;5576.247206627094;5646.604737668365;5695.914561281584;5764.971175144118;5803.100519419497;5658.179563963244;5691.3170419549915;5732.742026608813;5745.540356771448;5752.338481074688;5623.465770751772;5636.633618814805;5698.401667824902;5704.401037891003;5720.656760594377;6058.909116363258;6077.361877002895;6182.165407669952;6190.380961903818;6205;6666.9333306666795;6680.498962577826;6686.83282917931;6712.160979877515;6729;6732.158480189976;6781.050652908597;6784.28764979675;6786.491013174032;6798.898016529756;6201.255849298068;6210.254769427607;6217.222847144062;6259.342769009279;6302.842428939267;6681.76613818514;6773.254941956381;6871.690773915186;6938.826529336706;6962.965185174143;6485.513586481033;6634.933650663432;6652.667366631649;6655.6339401332425;6661.733530658817;6614.933850661432;6623;6696.531242813054;6755.932440675629;6793.592384456949;6534.901976470357;6627.271000189975;6652.600843949282;6657.167854018247;6721.1598550181225;6625;6665.533412661067;6672.899906501407;6690.933090669128;6698.564593301518;4910.8526744197015;4953.405591329064;4964.453910069889;4965.255211718199;4972.881101752077;4345.565443455693;4380.014496738208;4381.255186618282;4396.780160991938;4434.911301774011;5810.738516766755;5811.331696854916;5880.088586269135;5883.588148829541;5896.675682837399;6553.213614366211;6695.866082678319;6725.327467253333;6732.461403087741;6832.385085342244;5724.255846739898;5786.594938354359;5789.8263052108505;5800.042992906123;5828.184054232411;5889.528837692974;5896.911546326808;5921.851953701192;5978.432048955342;5990.071538911476;6432.067350234096;6491.253505846794;6498.740050398026;6596.307387724316;6628.403443690091;6651.866962660816;6716.731330746716;6745.392914637706;6751.966240168964;6803.727850885909;6526.24948130971;6542.247641521286;6557.147570815763;6558.901616475661;6561.376669216417;6552.312007239362;6580.243272023587;6648.9002664961035;6650.667466626553;6672.633005184762;6747.325267473409;6767.1879374475375;6832.077669514552;6838.350356716104;6858.725650973905;6351.460125889351;6482.254540727688;6486.4486518646445;6505.479561635152;6540.803775886731;6358.713857876499;6413.486921046212;6443.484521238383;6460.030995350735;6473.449756770728;6451.935480645321;6455.548111632141;6535.117759102461;6537.477001839747;6538.509611779231;6510.762955038527;6525.575837570543;6634.734610615521;6698.330166983263;6701.8324541884895;6042.697865106815;6134.294556125924;6219.378062193744;6228.22147231596;6341.714622841891 18:50:16 INFO - PID 29464 | |1;ext.html;808.8099296665287;844.9070602233754;868.1015149320452;868.5526953618887;1160.4487868262581;31471;31960.840195799017;42933.78533107338;43421.7828910855;43538.346924796155;44733.10533789322;45098.549014509845;45304;45304.546954530444;45330.773346133305;7303.780886573411;7496.8125796854965;7751.147373788879;7918.762437126867;7920.445568810185;7756.767296981071;7849.254320839511;7853.332466740334;7857.449978501507;7858.371330293591;7844.529328240295;7904.446688731762;7913.802154946144;7914.841703165933;7918.0498340198965;7861.68553257869;7883.999999999971;7890.48711833729;7897.763067107996;7906.367490600767;7745.806354841117;7792.181820908836;7808.258215469521;7811.257930496594;7814.72648457307;39437.60562394368;39661.60338396608;39899.20201595952;40061.79969100165;40121.79939100286;3563.893083207508;3592.892213233607;3605.891823245307;3607.2785442911522;3607.5851277103206;32117.678823211703;32297;32323;32323.676763232535;32358.676413236037;5073.416557095944;5093.872653183663;5096.184610462308;5108.872278193037;5109.846704598868;189817;190542;191607;192531;192969;48453;48540;48834.26748598774;51116;51462;52691;52767;52853.20720189124;52951.20573191405;53154.202686959725;16941.491755247363;16972.83027169737;17023.40418085361;17054.403095891583;17143.828561714472;12352.62942111738;12529.43617537213;13858.792118118236;14066.2966851657;14139.64650883736;15025.774613380809;15080.170590617401;15158.696826063637;15175.089494630358;15300.311485983157;6077;6207.317195108534;6238.812835614848;6253;6266.937330626635;1000.474750755859;1007.5063219022626;1008.3395376028712;1008.9041541053588;1016.0398423489879;22792.88603557005;29992.700072998992;30025.549616755765;30586.541201881988;30659.2335191622;1108.6009036746764;1109.8557187565725;1122.9326240425437;1130.2596799096605;1136.2557524821254;12415.93792031034;12429.689257768629;12631.873681263254;12671.303078330597;12718.618441446772;238221;238711;239483;240028;240719;54808;54908;55022.17466738002;55065.1740223897;55190.72404637951;1474.7714104313848;1520.7034628247607;1534.6930613877046;1550.3488534815406;1557.2058250292432;23282.185123521274;23373.532529349657;23410.882945585163;23461.41346466352;23589.646155307342;39384.80307598443;39546.2090758189;39598.80200598978;39602.60397396104;39621.80189099036;209815;209957;210180;210294;210729;36427.27145457129;36591.81704091569;38352.356526129974;38605;38751.224975500896;46666.30000550063;47269.29096063493;47411.52588474071;47470.28794568015;47909;34567.827160864035;34954.825225873705;35045;35139.82430087936;35256.823715881255;33765.83117084399;33844.492332614536;34177.487337689454;34254.82872585721;34403.82798085993;37717;37743.24513509769;37920;37957.81021094987;37965.43051854169;33181.336373271915;33341.49987750234;33780.15549611279;35035.29929401448;35121.47317790184;24743.50512989766;25212.74787252104;25249.74750252474;25407.110751123622;25534.36164095838 18:50:16 INFO - PID 29464 | |2;jquery.html;578.0404528482719;581.1660267516112;582.6911736779506;591.4351794036694;597.3876776304288;22187.77812221879;22492.325230243077;22947.770522294773;22962.311130666065;23085.422864428398;26574;27092.45815083697;27106.728932710666;27132.5930111048;27157.592636110476;6558.508111891603;6704.899426508607;6706.0276259942275;6707.698153583076;6711.362420570063;6248.375162483738;6526.151600291955;6536.7712130075215;6538.05198246254;6541.378569035934;6512.283648798629;6517.0224466329955;6517.902231466532;6520.282768895418;6520.576162549442;6505.121808555832;6508.219013718337;6509.349065093476;6515.804525864231;6517.446017088553;6042.425969532887;6050.364711705296;6057.7879774207695;6067.150598916155;6069.57512974092;29173.708262917313;29511.55732664012;30005.099847004625;30482.08553743391;30501;1963.9705404418803;2000.469875482998;2003.4991252186953;2007.4178488238392;2013.1947221111527;19149.80850191494;19386.80613193864;20061.1975520979;20176.19295228189;20244.291449799333;2474.1216868011957;2475.752424757528;2508.8871000805007;2519.722830488645;2519.8110141739444;133869;135874.999999999;136489;136767;136929;14627.634309142144;15437;15498.84501154974;15553.222338883237;15619.84380156184;23471.53056938886;23519.7648023521;23535.646965295535;23559.882200588887;23695.05219791189;10686.198535109897;10717.196210284259;10721.839172412265;10799.298045627009;10933.18001149917;8768;8914.777130571658;9241.676541321021;10090.445025523666;10291.53688084038;9368.859467107999;9588.472634005057;9625.229981601595;9648.179904708179;9715.07706767856;2792.148394739624;2805.90179343722;2845.715428457138;2866.082853486864;2904.651441826952;961.4087336288272;968.4818622037176;981.4454833019321;1002.4035698759227;1005.1104772276587;19838.90080549588;20086.59826803485;20427.8978605109;20523.384298471068;21124.894375528333;1007.5919252702668;1011.0647650922867;1023.5342918971999;1028.6554004408606;1028.7788125553043;10875.129989600971;10959;11019.889801101886;11020.614278500214;11067.446627668583;486427;487352;491298;500366;500383;116738.41630791791;120694;120789.39605301917;122808.38595806964;122895;1273.5988163728396;1281.116029939339;1291.5350473829415;1292.7718667266136;1297.8767017133357;17938.282468701105;18160.636787264444;18290;21068.789312107296;22326.441838954157;60682.69658651855;61345.69327153335;61516;62106.68946655238;63986.36013639804;69668;70341;70397;70686;70866.29133708803;15095.773563396777;15158.393664253306;15237.542873713806;15310.923445382701;15354.539363819104;23868.64197037011;24211.152609658577;24273;24526.754732452446;24744.876275618506;19445.416637500897;19557.902210488857;19749.802501974795;19758.20967161355;20045.398638040882;17898;17982.460526184237;18003.369882054067;18418.263269469073;18770.436886893414;19773.110210040293;20219.898900505403;20263.29078482246;20488.69266960967;20493.38519844407;14712.485063022743;14879.181645009628;15043.398264069314;15062.096274223582;15063.623409414853;18358.449246522625;18398;18687.532811679273;18763.437096887115;18813.717794232824 18:50:16 INFO - PID 29464 | |3;mootools.html;1371.9451221951122;1431.0769553637897;1439.3091316168243;1441.192931958103;1441.6323837421455;13524.526641567547;13992.230427326493;14619.26903654817;14627.122372657648;14640.926795366022;14520.27398630067;14898.478553250638;14920.626984325398;14940.252987350643;14958.476453324136;2711.5119278529855;2782.8886844526196;2784.8886044558194;2785.039161489283;2786.3312804926773;2651.8408895466237;2698.3254186453387;2747.8763455644544;2749.463854548364;2752.174347695683;2681.0616284300536;2722.8366298022083;2725.236933658569;2727.8499682517454;2728.031548800167;2600.2329312852657;2607.960880586793;2612.3207965928805;2616.188981415767;2616.306678730138;2576.884040218176;2594.5718956372175;2595.9610605840926;2598.1296265751;2602.596597527386;13793.931030344884;13916.652083697887;13930.93034534831;13937;14139.646508837259;7696.692132314701;7944.0467143942515;7950.0857401399;7957.244061814176;7957.442978991473;5122.410922743895;5229.764660590283;5271.789128434858;5331.5201631853315;5349.331333583302;1731.6796392667397;1737.643783024477;1748.6939785537606;1774.5297496163528;1784.8036715961234;23254.65118023231;23552.882235588713;23791.524169516513;23825.7617423827;24700.38249043788;7085.8703017653215;7137.072180616487;7157.89263161053;7287.234840341688;7389.224131466226;19184.232630694896;19204.231830726894;19228.903855480912;19229.519262018563;19254.133563989653;7910.485818421784;8027.2775450209765;8028.799280018046;8033.638486268132;8043.075046369625;7103.183133939559;7152.17749958751;7257.165425975974;7273.490855640161;7419.406447484188;5482.753276102585;5621.297337832771;5637.098064309691;5644.8306550803545;5707.857303567361;1665.383807991051;1694.4323651576613;1722.0958996526924;1723;1731.385358197847;862.094800459515;886.1492966751862;893.1648908270788;898.7887846356101;899.9280057595507;6877.1747390313485;6949.722011119599;7875.448718589644;8019.35845132388;8223.342132629376;731.1956847467849;741.7774667599698;991.3358050106445;1031.8555402243692;1038.948052597367;5121.948780512147;5264.52619264268;5293.920591191135;5316.946830531722;5328.706921119298;19132.808671913102;19247.807521924882;19476.610467790848;20121.094550745252;20204.797952020584;19309.22763089489;19664.115114819582;20076.39770806878;20135;20144.294949676692;10737.35575865435;10825.78348433027;11278.097752179807;11359.318440893572;11368;8224.177582241728;8445.577721114043;8550.016748074051;8616.224539791448;8833.425827321204;16822.831771682126;16846.326146953983;16903.577410564834;17154.142292885554;17176.14119294055;17121.74317385265;17149.91425042867;17569.297228110732;18037.909810450863;18348.99080550529;11138.777224455303;11736.530538778694;11767.23512971654;11772.882271177179;11779.52881884715;13243.337833108499;13291.268980205794;13363.799543007057;13370.197788132744;13383.263920484467;10827.566897324334;10839.891601083888;10884.51019704131;10992.560297588007;11061.11511079128;10289.344929355279;10492.842607361048;10568.577256909637;10706.089982351587;10882.129429645767;9603.663871764455;9616.807663846825;9709.46597937092;9715.46564938935;9722.173615242784;6894;6992.370686638227;7041.859162816818;7126.322999315057;7199.640017998974;7127.322904324081;7138.750143744944;7155.677994490365;7160.140783106061;7250.274972502708 18:50:16 INFO - PID 29464 | |4;prototype.html;494.7180107338817;499.36081815276435;530.3476723629938;536.4045909040965;543.891221755649;6126.693665316728;6198;6273.184486016818;6274.592151510149;6283.465905398047;5909.615874968124;6072.362401947798;6102.237220347457;6182.598131121474;6209.223847019122;4857.902841943159;4874.195757699984;4920.97539512302;4969;4973.01079568172;4810.921010553248;4978.775955082012;4982.476839931809;5000.849974500771;5024.84925452237;4919.680220785655;4921.8523444296725;4937.358143441347;4960.23116416956;4969.428515720684;4926.334944782462;4940.752962351868;4942.406911170647;4950.579200767939;4995.175795993693;4474.955250447487;4477.194105061088;4487.640988720895;4507.526709695468;4530.501644819067;6131.816045518642;6135.110408990716;6137.9386206137815;6139.38606139387;6144.262688477412;5654.208410822488;5716.571257155689;5740.9712951435395;5751.482366586985;5772.365039845614;6526.379993900572;6527.804165875032;6537.93462065378;6544;6569.408753212234;4842.443119041285;4888.388951381077;4897.4123105227245;4902.607791376681;4907.730074845882;6852.383285504278;6890.655467226618;6913.9283411071365;6921.196915249332;6934.445244380488;5010.774515146827;5022.447530771612;5025.698458092453;5034.320366750442;5039.722815245197;5096.949030509648;5105.285260063594;5121.615878809104;5121.795128194905;5124.897502049938;5695.5443564514735;5741.799037033684;5749.418909799755;5754.108113242454;5762.30852297727;6509.2839787623325;6512.502124511294;6561.245456772437;6590.934090659128;6595.373439523238;1667.6247844235193;1715.1167148918316;1719.8280171982951;1722.3971609936673;1724.956876078108;1219.2745316536646;1222.9143959922899;1236.8003037054043;1243.1484433163312;1245.1159676629695;5758.309002919593;5784.971075144597;5803.82588522345;5809.576653719866;5813.767449302065;6568.211814582185;6640.410240006401;6740.898886516707;6742.831429214309;6746.494012949049;5735.741891614887;5756.25168728071;5778.27771528559;5817.447342502455;5827.825165245049;3541.8406171722336;3561.415170249214;3593.347060352215;3594.759807866282;3615.692666123409;6564.737410503526;6634.535582509178;6643.5017373697165;6651.235107962646;6677.432418244503;6817.931820681829;6927.238003819576;6927.58434493932;6990;7022.12223472066;6437.227532696106;6456.289808121103;6460.224773027173;6526.184226971629;6565.212174539086;6633.441141331879;6643.966780166068;6661;6717.328267173439;6755.1423358576785;6532.738690452328;6705;6759.3240675933985;6760.628165450948;6803.863922721617;6528.738850445929;6536.281009089092;6543.574667646588;6546.476281897341;6571.211454625475;5011.473795251592;5040.6219533534395;5044.545990860694;5048.974755126201;5061.39263288393;6793.490488213502;6837.2820853809635;6844.638599683101;6871.793846184622;6872.244053154249;6574.901376479261;6598.868022639424;6604.867902642017;6627.569208001464;6631.1048008520165;6272.6236425814595;6421.967890160519;6575;6583;6607.669616519059;6124.693765311806;6389.201349831271;6408.814369341687;6461.773837915651;6470.935290647033;6355.311995763858;6414.03789431589;6433.906235939808;6444.7744328948265;6543.5419520633095;6163.445289923749;6179.969100154471;6217.440430361289;6270.996640537492;6297.96851015742 18:50:16 INFO - PID 29464 | |5;yui.html;914.638717706506;925.0934084597098;925.639000789692;939.727479031081;942.8727121838554;17927.193276302565;18688.719669204973;18749;18850.434486965412;19430.51423714404;20246.367972163636;20464;20575.38273851783;20589;20646.174153033862;1027.1679939249232;1047.5600247895864;1053.0785562632695;1055.2771351624124;1057.6298295596557;1013.758146270816;1016.3546148195875;1024.728446961552;1034.9534270957788;1052.4369462337613;1105.9557617695323;1108.4568561404894;1111.7998760223156;1113.014981741161;1114.9554017839278;1099.9450027498592;1102.7408558988632;1103.3931337764238;1105.4362275239605;1109.8945600167972;806.2340776262574;806.7942674617993;806.9838603227961;813.4590497319275;813.4712436915993;20125.597488050156;20359.4910127248;20426.489337766525;20456.386308410772;20663.79336206634;20903.68644470334;21377.03803328854;21396.893015534824;21957.341279761633;22703.318900433012;16879.83120168795;16899.0388205018;17008.234629441704;17078.658426831393;17353.7396939046;3690.5940346561856;3711.981440092782;3714.7213958953184;3717.5538935327663;3717.8141092945243;125408;128612;128766.78083047998;129829;129848.35075824561;16481.423150189927;17054.829451705325;17122.40071597488;17527.29890804379;18400.723989139908;32534.674653253638;32727;33233.66766332354;33397.3320533588;33568.328633427685;7576.166621671612;7763;8145.470544414594;8853.557322133867;9019.729408117766;3751.6248375162268;4171.124063946544;4230.682698797603;4234.9364759528635;4240.554741752133;5266.210068489757;5386.461353864661;5415.0523658359625;5423.376311724123;5432.429594892558;1036.9170466362673;1071.566015763617;1086.2884810449011;1087.6247694545368;1089.629525961177;703.3283214530112;712.3232928717739;715.8818794898888;721.1850608812009;726.9963650181716;12467.753224677459;12870.22778633285;12961.675958100934;13090.14914030585;13272.469101236036;688.3460712323313;700.4221517248291;704.7779949315949;715.2954339975121;719.1837264704598;5868.618539794899;5900.763969441175;5953.107033944856;5960.850978725566;6082.817515474543;111014;111589;114255.42872285585;114531;115511.42244288725;103316.48341758244;107485.46257268664;107822;109541;111373.88626113797;85571;87820.5608971951;89674.10325896788;91969.54015229881;92034;10702.732431688959;10797.488351630622;10956.945215273872;10984.340939543654;11032;40492.39261411022;40847.79576102101;41193.58806412017;42012.57987420209;42243;51475.48524514707;52607.73696131495;70712;72360.63819680868;74552.62723686347;20015.499612509804;20019;20197.59604807925;20355.9822008896;20805.895970520654;21924.89037554802;22141;22763.08947642142;22968.885155574117;23090.191843285404;18956.24175032983;19016.619667606847;19091.236350545823;19374.8062519373;20790.792092078886;19999.60000800005;20252.898735506817;20253.49366265855;20505.077271522518;20771.376858694264;18557.44327670172;19527.511812204808;19682.409527714193;20080.196792128736;20266;14361.712765744836;14412.495562655256;14594.343254553358;14723.92638036803;14731.705365892407;14785.260736963324;14810.703785924006;14940.103593784408;15015.474458393905;15284.465043723416 18:50:16 INFO - PID 29464 | __end_tp_report 18:50:16 INFO - PID 29464 | __start_cc_report 18:50:16 INFO - PID 29464 | _x_x_mozilla_cycle_collect,348 18:50:16 INFO - PID 29464 | __end_cc_report 18:50:16 INFO - PID 29464 | __startTimestamp1502761816134__endTimestamp 18:50:16 INFO - PID 29464 | 18:50:16 INFO - PID 29464 | ------- Summary: start ------- 18:50:16 INFO - PID 29464 | Number of tests: 6 18:50:16 INFO - PID 29464 | 18:50:16 INFO - PID 29464 | [#0] dojo.html Cycles:165 Average:6137.74 Median:6413.49 stddev:760.49 (11.9%) stddev-sans-first:726.21 18:50:16 INFO - PID 29464 | Values: 3165.8 3183.4 3188.5 3212.7 3219.5 6181.5 6228.2 6242.9 6280.1 6283.7 6082.9 6166.0 6177.3 6179.2 6180.0 5614.2 5652.0 5656.4 5658.8 5735.0 5744.6 5759.8 5776.5 5800.5 5879.4 5576.2 5646.6 5695.9 5765.0 5803.1 5658.2 5691.3 5732.7 5745.5 5752.3 5623.5 5636.6 5698.4 5704.4 5720.7 6058.9 6077.4 6182.2 6190.4 6205.0 6666.9 6680.5 6686.8 6712.2 6729.0 6732.2 6781.1 6784.3 6786.5 6798.9 6201.3 6210.3 6217.2 6259.3 6302.8 6681.8 6773.3 6871.7 6938.8 6963.0 6485.5 6634.9 6652.7 6655.6 6661.7 6614.9 6623.0 6696.5 6755.9 6793.6 6534.9 6627.3 6652.6 6657.2 6721.2 6625.0 6665.5 6672.9 6690.9 6698.6 4910.9 4953.4 4964.5 4965.3 4972.9 4345.6 4380.0 4381.3 4396.8 4434.9 5810.7 5811.3 5880.1 5883.6 5896.7 6553.2 6695.9 6725.3 6732.5 6832.4 5724.3 5786.6 5789.8 5800.0 5828.2 5889.5 5896.9 5921.9 5978.4 5990.1 6432.1 6491.3 6498.7 6596.3 6628.4 6651.9 6716.7 6745.4 6752.0 6803.7 6526.2 6542.2 6557.1 6558.9 6561.4 6552.3 6580.2 6648.9 6650.7 6672.6 6747.3 6767.2 6832.1 6838.4 6858.7 6351.5 6482.3 6486.4 6505.5 6540.8 6358.7 6413.5 6443.5 6460.0 6473.4 6451.9 6455.5 6535.1 6537.5 6538.5 6510.8 6525.6 6634.7 6698.3 6701.8 6042.7 6134.3 6219.4 6228.2 6341.7 18:50:16 INFO - PID 29464 | 18:50:16 INFO - PID 29464 | [#1] ext.html Cycles:180 Average:39290.71 Median:3606.59 stddev:55576.92 (1541.0%) stddev-sans-first:55657.72 18:50:16 INFO - PID 29464 | Values: 808.8 844.9 868.1 868.6 1160.4 31471.0 31960.8 42933.8 43421.8 43538.3 44733.1 45098.5 45304.0 45304.5 45330.8 7303.8 7496.8 7751.1 7918.8 7920.4 7756.8 7849.3 7853.3 7857.4 7858.4 7844.5 7904.4 7913.8 7914.8 7918.0 7861.7 7884.0 7890.5 7897.8 7906.4 7745.8 7792.2 7808.3 7811.3 7814.7 39437.6 39661.6 39899.2 40061.8 40121.8 3563.9 3592.9 3605.9 3607.3 3607.6 32117.7 32297.0 32323.0 32323.7 32358.7 5073.4 5093.9 5096.2 5108.9 5109.8 189817.0 190542.0 191607.0 192531.0 192969.0 48453.0 48540.0 48834.3 51116.0 51462.0 52691.0 52767.0 52853.2 52951.2 53154.2 16941.5 16972.8 17023.4 17054.4 17143.8 12352.6 12529.4 13858.8 14066.3 14139.6 15025.8 15080.2 15158.7 15175.1 15300.3 6077.0 6207.3 6238.8 6253.0 6266.9 1000.5 1007.5 1008.3 1008.9 1016.0 22792.9 29992.7 30025.5 30586.5 30659.2 1108.6 1109.9 1122.9 1130.3 1136.3 12415.9 12429.7 12631.9 12671.3 12718.6 238221.0 238711.0 239483.0 240028.0 240719.0 54808.0 54908.0 55022.2 55065.2 55190.7 1474.8 1520.7 1534.7 1550.3 1557.2 23282.2 23373.5 23410.9 23461.4 23589.6 39384.8 39546.2 39598.8 39602.6 39621.8 209815.0 209957.0 210180.0 210294.0 210729.0 36427.3 36591.8 38352.4 38605.0 38751.2 46666.3 47269.3 47411.5 47470.3 47909.0 34567.8 34954.8 35045.0 35139.8 35256.8 33765.8 33844.5 34177.5 34254.8 34403.8 37717.0 37743.2 37920.0 37957.8 37965.4 33181.3 33341.5 33780.2 35035.3 35121.5 24743.5 25212.7 25249.7 25407.1 25534.4 18:50:16 INFO - PID 29464 | 18:50:16 INFO - PID 29464 | [#2] jquery.html Cycles:180 Average:35448.84 Median:22720.05 stddev:83094.99 (365.7%) stddev-sans-first:83286.84 18:50:16 INFO - PID 29464 | Values: 578.0 581.2 582.7 591.4 597.4 22187.8 22492.3 22947.8 22962.3 23085.4 26574.0 27092.5 27106.7 27132.6 27157.6 6558.5 6704.9 6706.0 6707.7 6711.4 6248.4 6526.2 6536.8 6538.1 6541.4 6512.3 6517.0 6517.9 6520.3 6520.6 6505.1 6508.2 6509.3 6515.8 6517.4 6042.4 6050.4 6057.8 6067.2 6069.6 29173.7 29511.6 30005.1 30482.1 30501.0 1964.0 2000.5 2003.5 2007.4 2013.2 19149.8 19386.8 20061.2 20176.2 20244.3 2474.1 2475.8 2508.9 2519.7 2519.8 133869.0 135875.0 136489.0 136767.0 136929.0 14627.6 15437.0 15498.8 15553.2 15619.8 23471.5 23519.8 23535.6 23559.9 23695.1 10686.2 10717.2 10721.8 10799.3 10933.2 8768.0 8914.8 9241.7 10090.4 10291.5 9368.9 9588.5 9625.2 9648.2 9715.1 2792.1 2805.9 2845.7 2866.1 2904.7 961.4 968.5 981.4 1002.4 1005.1 19838.9 20086.6 20427.9 20523.4 21124.9 1007.6 1011.1 1023.5 1028.7 1028.8 10875.1 10959.0 11019.9 11020.6 11067.4 486427.0 487352.0 491298.0 500366.0 500383.0 116738.4 120694.0 120789.4 122808.4 122895.0 1273.6 1281.1 1291.5 1292.8 1297.9 17938.3 18160.6 18290.0 21068.8 22326.4 60682.7 61345.7 61516.0 62106.7 63986.4 69668.0 70341.0 70397.0 70686.0 70866.3 15095.8 15158.4 15237.5 15310.9 15354.5 23868.6 24211.2 24273.0 24526.8 24744.9 19445.4 19557.9 19749.8 19758.2 20045.4 17898.0 17982.5 18003.4 18418.3 18770.4 19773.1 20219.9 20263.3 20488.7 20493.4 14712.5 14879.2 15043.4 15062.1 15063.6 18358.4 18398.0 18687.5 18763.4 18813.7 18:50:16 INFO - PID 29464 | 18:50:16 INFO - PID 29464 | [#3] mootools.html Cycles:180 Average:9012.58 Median:2599.18 stddev:6186.30 (238.0%) stddev-sans-first:6177.01 18:50:16 INFO - PID 29464 | Values: 1371.9 1431.1 1439.3 1441.2 1441.6 13524.5 13992.2 14619.3 14627.1 14640.9 14520.3 14898.5 14920.6 14940.3 14958.5 2711.5 2782.9 2784.9 2785.0 2786.3 2651.8 2698.3 2747.9 2749.5 2752.2 2681.1 2722.8 2725.2 2727.8 2728.0 2600.2 2608.0 2612.3 2616.2 2616.3 2576.9 2594.6 2596.0 2598.1 2602.6 13793.9 13916.7 13930.9 13937.0 14139.6 7696.7 7944.0 7950.1 7957.2 7957.4 5122.4 5229.8 5271.8 5331.5 5349.3 1731.7 1737.6 1748.7 1774.5 1784.8 23254.7 23552.9 23791.5 23825.8 24700.4 7085.9 7137.1 7157.9 7287.2 7389.2 19184.2 19204.2 19228.9 19229.5 19254.1 7910.5 8027.3 8028.8 8033.6 8043.1 7103.2 7152.2 7257.2 7273.5 7419.4 5482.8 5621.3 5637.1 5644.8 5707.9 1665.4 1694.4 1722.1 1723.0 1731.4 862.1 886.1 893.2 898.8 899.9 6877.2 6949.7 7875.4 8019.4 8223.3 731.2 741.8 991.3 1031.9 1038.9 5121.9 5264.5 5293.9 5316.9 5328.7 19132.8 19247.8 19476.6 20121.1 20204.8 19309.2 19664.1 20076.4 20135.0 20144.3 10737.4 10825.8 11278.1 11359.3 11368.0 8224.2 8445.6 8550.0 8616.2 8833.4 16822.8 16846.3 16903.6 17154.1 17176.1 17121.7 17149.9 17569.3 18037.9 18349.0 11138.8 11736.5 11767.2 11772.9 11779.5 13243.3 13291.3 13363.8 13370.2 13383.3 10827.6 10839.9 10884.5 10992.6 11061.1 10289.3 10492.8 10568.6 10706.1 10882.1 9603.7 9616.8 9709.5 9715.5 9722.2 6894.0 6992.4 7041.9 7126.3 7199.6 7127.3 7138.8 7155.7 7160.1 7250.3 18:50:16 INFO - PID 29464 | 18:50:16 INFO - PID 29464 | [#4] prototype.html Cycles:180 Average:5515.43 Median:6133.46 stddev:1549.52 (25.3%) stddev-sans-first:1507.34 18:50:16 INFO - PID 29464 | Values: 494.7 499.4 530.3 536.4 543.9 6126.7 6198.0 6273.2 6274.6 6283.5 5909.6 6072.4 6102.2 6182.6 6209.2 4857.9 4874.2 4921.0 4969.0 4973.0 4810.9 4978.8 4982.5 5000.8 5024.8 4919.7 4921.9 4937.4 4960.2 4969.4 4926.3 4940.8 4942.4 4950.6 4995.2 4475.0 4477.2 4487.6 4507.5 4530.5 6131.8 6135.1 6137.9 6139.4 6144.3 5654.2 5716.6 5741.0 5751.5 5772.4 6526.4 6527.8 6537.9 6544.0 6569.4 4842.4 4888.4 4897.4 4902.6 4907.7 6852.4 6890.7 6913.9 6921.2 6934.4 5010.8 5022.4 5025.7 5034.3 5039.7 5096.9 5105.3 5121.6 5121.8 5124.9 5695.5 5741.8 5749.4 5754.1 5762.3 6509.3 6512.5 6561.2 6590.9 6595.4 1667.6 1715.1 1719.8 1722.4 1725.0 1219.3 1222.9 1236.8 1243.1 1245.1 5758.3 5785.0 5803.8 5809.6 5813.8 6568.2 6640.4 6740.9 6742.8 6746.5 5735.7 5756.3 5778.3 5817.4 5827.8 3541.8 3561.4 3593.3 3594.8 3615.7 6564.7 6634.5 6643.5 6651.2 6677.4 6817.9 6927.2 6927.6 6990.0 7022.1 6437.2 6456.3 6460.2 6526.2 6565.2 6633.4 6644.0 6661.0 6717.3 6755.1 6532.7 6705.0 6759.3 6760.6 6803.9 6528.7 6536.3 6543.6 6546.5 6571.2 5011.5 5040.6 5044.5 5049.0 5061.4 6793.5 6837.3 6844.6 6871.8 6872.2 6574.9 6598.9 6604.9 6627.6 6631.1 6272.6 6422.0 6575.0 6583.0 6607.7 6124.7 6389.2 6408.8 6461.8 6470.9 6355.3 6414.0 6433.9 6444.8 6543.5 6163.4 6180.0 6217.4 6271.0 6298.0 18:50:16 INFO - PID 29464 | 18:50:16 INFO - PID 29464 | [#5] yui.html Cycles:180 Average:24590.78 Median:20259.75 stddev:33235.84 (164.0%) stddev-sans-first:33281.52 18:50:16 INFO - PID 29464 | Values: 914.6 925.1 925.6 939.7 942.9 17927.2 18688.7 18749.0 18850.4 19430.5 20246.4 20464.0 20575.4 20589.0 20646.2 1027.2 1047.6 1053.1 1055.3 1057.6 1013.8 1016.4 1024.7 1035.0 1052.4 1106.0 1108.5 1111.8 1113.0 1115.0 1099.9 1102.7 1103.4 1105.4 1109.9 806.2 806.8 807.0 813.5 813.5 20125.6 20359.5 20426.5 20456.4 20663.8 20903.7 21377.0 21396.9 21957.3 22703.3 16879.8 16899.0 17008.2 17078.7 17353.7 3690.6 3712.0 3714.7 3717.6 3717.8 125408.0 128612.0 128766.8 129829.0 129848.4 16481.4 17054.8 17122.4 17527.3 18400.7 32534.7 32727.0 33233.7 33397.3 33568.3 7576.2 7763.0 8145.5 8853.6 9019.7 3751.6 4171.1 4230.7 4234.9 4240.6 5266.2 5386.5 5415.1 5423.4 5432.4 1036.9 1071.6 1086.3 1087.6 1089.6 703.3 712.3 715.9 721.2 727.0 12467.8 12870.2 12961.7 13090.1 13272.5 688.3 700.4 704.8 715.3 719.2 5868.6 5900.8 5953.1 5960.9 6082.8 111014.0 111589.0 114255.4 114531.0 115511.4 103316.5 107485.5 107822.0 109541.0 111373.9 85571.0 87820.6 89674.1 91969.5 92034.0 10702.7 10797.5 10956.9 10984.3 11032.0 40492.4 40847.8 41193.6 42012.6 42243.0 51475.5 52607.7 70712.0 72360.6 74552.6 20015.5 20019.0 20197.6 20356.0 20805.9 21924.9 22141.0 22763.1 22968.9 23090.2 18956.2 19016.6 19091.2 19374.8 20790.8 19999.6 20252.9 20253.5 20505.1 20771.4 18557.4 19527.5 19682.4 20080.2 20266.0 14361.7 14412.5 14594.3 14723.9 14731.7 14785.3 14810.7 14940.1 15015.5 15284.5 18:50:16 INFO - PID 29464 | -------- Summary: end -------- 18:50:16 INFO - PID 29464 | 18:50:16 INFO - TEST-INFO | 29464: exit 0 18:50:16 INFO - TEST-OK | dromaeo_css | took 1112726ms 18:50:16 INFO - TEST-START | kraken 18:50:16 INFO - Initialising browser for kraken test... 18:50:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:49132/getInfo.html -profile /tmp/tmpLrYd02/profile 18:50:16 INFO - TEST-INFO | started process 29838 (/builds/slave/test/build/application/firefox/firefox http://localhost:49132/getInfo.html) 18:50:22 INFO - TEST-INFO | 29838: exit 0 18:50:22 INFO - Browser initialized. 18:50:22 INFO - Running cycle 1/1 for kraken test... 18:50:22 INFO - TEST-INFO | started process 30067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLrYd02/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:50:23 INFO - PID 30067 | 18:50:23 INFO - PID 30067 | (/builds/slave/test/build/application/firefox/firefox:30123): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 18:50:23 INFO - PID 30067 | 18:50:34 INFO - PID 30067 | RSS: Main: 168071168 18:50:34 INFO - PID 30067 | 18:50:36 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49132/tests/kraken/driver.html?testName=audio-beat-detection) 18:50:37 INFO - PID 30067 | RSS: Main: 173809664 18:50:37 INFO - PID 30067 | 18:50:40 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49132/tests/kraken/driver.html?testName=audio-dft) 18:50:41 INFO - PID 30067 | RSS: Main: 174034944 18:50:41 INFO - PID 30067 | 18:50:44 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49132/tests/kraken/driver.html?testName=audio-fft) 18:50:44 INFO - PID 30067 | RSS: Main: 169472000 18:50:44 INFO - PID 30067 | 18:50:46 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49132/tests/kraken/driver.html?testName=audio-oscillator) 18:50:47 INFO - PID 30067 | RSS: Main: 170160128 18:50:47 INFO - PID 30067 | 18:50:49 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49132/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:50:50 INFO - PID 30067 | RSS: Main: 170115072 18:50:50 INFO - PID 30067 | 18:50:53 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49132/tests/kraken/driver.html?testName=imaging-darkroom) 18:50:54 INFO - PID 30067 | RSS: Main: 172285952 18:50:54 INFO - PID 30067 | 18:50:57 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49132/tests/kraken/driver.html?testName=imaging-desaturate) 18:50:58 INFO - PID 30067 | RSS: Main: 172433408 18:50:58 INFO - PID 30067 | 18:51:01 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49132/tests/kraken/driver.html?testName=json-parse-financial) 18:51:01 INFO - PID 30067 | RSS: Main: 173412352 18:51:01 INFO - PID 30067 | 18:51:03 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49132/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:51:04 INFO - PID 30067 | RSS: Main: 172953600 18:51:04 INFO - PID 30067 | 18:51:06 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49132/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:51:06 INFO - PID 30067 | RSS: Main: 173129728 18:51:06 INFO - PID 30067 | 18:51:08 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49132/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:51:09 INFO - PID 30067 | RSS: Main: 174092288 18:51:09 INFO - PID 30067 | 18:51:12 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49132/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:51:13 INFO - PID 30067 | RSS: Main: 173039616 18:51:13 INFO - PID 30067 | 18:51:16 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49132/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:51:16 INFO - PID 30067 | RSS: Main: 173113344 18:51:16 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | Cycle 1(1): loaded http://localhost:49132/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49132/tests/kraken/driver.html?testName=ai-astar) 18:51:18 INFO - PID 30067 | RSS: Main: 175251456 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | __start_tp_report 18:51:18 INFO - PID 30067 | _x_x_mozilla_page_load 18:51:18 INFO - PID 30067 | _x_x_mozilla_page_load_details 18:51:18 INFO - PID 30067 | |i|pagename|runs| 18:51:18 INFO - PID 30067 | |0;ai-astar;99;109;103;109;108;109;110;101;111;114 18:51:18 INFO - PID 30067 | |1;audio-beat-detection;144;117;146;180;123;151;145;118;179;121 18:51:18 INFO - PID 30067 | |2;audio-dft;163;163;163;162;161;172;166;174;165;165 18:51:18 INFO - PID 30067 | |3;audio-fft;73;74;77;183;77;83;81;92;98;76 18:51:18 INFO - PID 30067 | |4;audio-oscillator;89;81;126;79;79;79;136;78;80;129 18:51:18 INFO - PID 30067 | |5;imaging-gaussian-blur;124;115;119;114;115;115;123;123;115;115 18:51:18 INFO - PID 30067 | |6;imaging-darkroom;149;150;154;150;150;150;151;150;151;151 18:51:18 INFO - PID 30067 | |7;imaging-desaturate;93;94;94;99;94;95;94;94;94;94 18:51:18 INFO - PID 30067 | |8;json-parse-financial;54;54;54;65;55;64;53;53;53;52 18:51:18 INFO - PID 30067 | |9;json-stringify-tinderbox;57;54;54;54;59;56;54;56;60;54 18:51:18 INFO - PID 30067 | |10;stanford-crypto-aes;76;76;76;83;78;77;77;85;78;82 18:51:18 INFO - PID 30067 | |11;stanford-crypto-ccm;128;125;127;124;134;130;145;124;124;179 18:51:18 INFO - PID 30067 | |12;stanford-crypto-pbkdf2;174;173;189;186;181;181;173;176;173;174 18:51:18 INFO - PID 30067 | |13;stanford-crypto-sha256-iterative;70;66;67;68;66;67;68;70;67;70 18:51:18 INFO - PID 30067 | __end_tp_report 18:51:18 INFO - PID 30067 | __start_cc_report 18:51:18 INFO - PID 30067 | _x_x_mozilla_cycle_collect,981 18:51:18 INFO - PID 30067 | __end_cc_report 18:51:18 INFO - PID 30067 | __startTimestamp1502761878783__endTimestamp 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | ------- Summary: start ------- 18:51:18 INFO - PID 30067 | Number of tests: 14 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#0] ai-astar Cycles:10 Average:107.30 Median:109.50 stddev:4.74 (4.3%) stddev-sans-first:3.96 18:51:18 INFO - PID 30067 | Values: 99.0 109.0 103.0 109.0 108.0 109.0 110.0 101.0 111.0 114.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:145.50 stddev:23.39 (16.1%) stddev-sans-first:24.80 18:51:18 INFO - PID 30067 | Values: 144.0 117.0 146.0 180.0 123.0 151.0 145.0 118.0 179.0 121.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:4.30 (2.6%) stddev-sans-first:4.47 18:51:18 INFO - PID 30067 | Values: 163.0 163.0 163.0 162.0 161.0 172.0 166.0 174.0 165.0 165.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#3] audio-fft Cycles:10 Average:91.40 Median:79.00 stddev:33.18 (42.0%) stddev-sans-first:34.51 18:51:18 INFO - PID 30067 | Values: 73.0 74.0 77.0 183.0 77.0 83.0 81.0 92.0 98.0 76.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:79.00 stddev:24.29 (30.7%) stddev-sans-first:25.64 18:51:18 INFO - PID 30067 | Values: 89.0 81.0 126.0 79.0 79.0 79.0 136.0 78.0 80.0 129.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:117.00 stddev:4.05 (3.5%) stddev-sans-first:3.62 18:51:18 INFO - PID 30067 | Values: 124.0 115.0 119.0 114.0 115.0 115.0 123.0 123.0 115.0 115.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:150.50 stddev:1.35 (0.9%) stddev-sans-first:1.30 18:51:18 INFO - PID 30067 | Values: 149.0 150.0 154.0 150.0 150.0 150.0 151.0 150.0 151.0 151.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.00 stddev:1.65 (1.8%) stddev-sans-first:1.66 18:51:18 INFO - PID 30067 | Values: 93.0 94.0 94.0 99.0 94.0 95.0 94.0 94.0 94.0 94.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#8] json-parse-financial Cycles:10 Average:55.70 Median:54.00 stddev:4.72 (8.7%) stddev-sans-first:4.96 18:51:18 INFO - PID 30067 | Values: 54.0 54.0 54.0 65.0 55.0 64.0 53.0 53.0 53.0 52.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:2.25 (4.0%) stddev-sans-first:2.35 18:51:18 INFO - PID 30067 | Values: 57.0 54.0 54.0 54.0 59.0 56.0 54.0 56.0 60.0 54.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.00 stddev:3.29 (4.2%) stddev-sans-first:3.33 18:51:18 INFO - PID 30067 | Values: 76.0 76.0 76.0 83.0 78.0 77.0 77.0 85.0 78.0 82.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:129.00 stddev:17.09 (13.2%) stddev-sans-first:17.99 18:51:18 INFO - PID 30067 | Values: 128.0 125.0 127.0 124.0 134.0 130.0 145.0 124.0 124.0 179.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:178.50 stddev:5.91 (3.3%) stddev-sans-first:6.09 18:51:18 INFO - PID 30067 | Values: 174.0 173.0 189.0 186.0 181.0 181.0 173.0 176.0 173.0 174.0 18:51:18 INFO - PID 30067 | 18:51:18 INFO - PID 30067 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.60 (2.3%) stddev-sans-first:1.50 18:51:18 INFO - PID 30067 | Values: 70.0 66.0 67.0 68.0 66.0 67.0 68.0 70.0 67.0 70.0 18:51:18 INFO - PID 30067 | -------- Summary: end -------- 18:51:18 INFO - PID 30067 | 18:51:19 INFO - PID 30067 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:51:19 INFO - TEST-INFO | 30067: exit 0 18:51:19 INFO - TEST-OK | kraken | took 62591ms 18:51:19 INFO - SUITE-END | took 1175s 18:51:19 INFO - Completed test suite (00:19:35) 18:51:19 INFO - javascript benchmark 18:51:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8660.340495926734, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3165.794223375479, 3183.363327334532, 3188.5057816038516, 3212.7269182119517, 3219.4526930421825, 6181.474574661159, 6228.1591985082005, 6242.875142497153, 6280.089387038883, 6283.685815709207, 6082.939170608292, 6166.0, 6177.289611694657, 6179.165812615295, 6180.0, 5614.157876318564, 5651.971740141304, 5656.406077361879, 5658.8019419320335, 5735.0, 5744.597878148531, 5759.827205183851, 5776.480116789488, 5800.506956908646, 5879.412058794108, 5576.247206627094, 5646.604737668365, 5695.914561281584, 5764.971175144118, 5803.100519419497, 5658.179563963244, 5691.3170419549915, 5732.742026608813, 5745.540356771448, 5752.338481074688, 5623.465770751772, 5636.633618814805, 5698.401667824902, 5704.401037891003, 5720.656760594377, 6058.909116363258, 6077.361877002895, 6182.165407669952, 6190.380961903818, 6205.0, 6666.9333306666795, 6680.498962577826, 6686.83282917931, 6712.160979877515, 6729.0, 6732.158480189976, 6781.050652908597, 6784.28764979675, 6786.491013174032, 6798.898016529756, 6201.255849298068, 6210.254769427607, 6217.222847144062, 6259.342769009279, 6302.842428939267, 6681.76613818514, 6773.254941956381, 6871.690773915186, 6938.826529336706, 6962.965185174143, 6485.513586481033, 6634.933650663432, 6652.667366631649, 6655.6339401332425, 6661.733530658817, 6614.933850661432, 6623.0, 6696.531242813054, 6755.932440675629, 6793.592384456949, 6534.901976470357, 6627.271000189975, 6652.600843949282, 6657.167854018247, 6721.1598550181225, 6625.0, 6665.533412661067, 6672.899906501407, 6690.933090669128, 6698.564593301518, 4910.8526744197015, 4953.405591329064, 4964.453910069889, 4965.255211718199, 4972.881101752077, 4345.565443455693, 4380.014496738208, 4381.255186618282, 4396.780160991938, 4434.911301774011, 5810.738516766755, 5811.331696854916, 5880.088586269135, 5883.588148829541, 5896.675682837399, 6553.213614366211, 6695.866082678319, 6725.327467253333, 6732.461403087741, 6832.385085342244, 5724.255846739898, 5786.594938354359, 5789.8263052108505, 5800.042992906123, 5828.184054232411, 5889.528837692974, 5896.911546326808, 5921.851953701192, 5978.432048955342, 5990.071538911476, 6432.067350234096, 6491.253505846794, 6498.740050398026, 6596.307387724316, 6628.403443690091, 6651.866962660816, 6716.731330746716, 6745.392914637706, 6751.966240168964, 6803.727850885909, 6526.24948130971, 6542.247641521286, 6557.147570815763, 6558.901616475661, 6561.376669216417, 6552.312007239362, 6580.243272023587, 6648.9002664961035, 6650.667466626553, 6672.633005184762, 6747.325267473409, 6767.1879374475375, 6832.077669514552, 6838.350356716104, 6858.725650973905, 6351.460125889351, 6482.254540727688, 6486.4486518646445, 6505.479561635152, 6540.803775886731, 6358.713857876499, 6413.486921046212, 6443.484521238383, 6460.030995350735, 6473.449756770728, 6451.935480645321, 6455.548111632141, 6535.117759102461, 6537.477001839747, 6538.509611779231, 6510.762955038527, 6525.575837570543, 6634.734610615521, 6698.330166983263, 6701.8324541884895, 6042.697865106815, 6134.294556125924, 6219.378062193744, 6228.22147231596, 6341.714622841891], "value": 6078.692303902869, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [808.8099296665287, 844.9070602233754, 868.1015149320452, 868.5526953618887, 1160.4487868262581, 31471.0, 31960.840195799017, 42933.78533107338, 43421.7828910855, 43538.346924796155, 44733.10533789322, 45098.549014509845, 45304.0, 45304.546954530444, 45330.773346133305, 7303.780886573411, 7496.8125796854965, 7751.147373788879, 7918.762437126867, 7920.445568810185, 7756.767296981071, 7849.254320839511, 7853.332466740334, 7857.449978501507, 7858.371330293591, 7844.529328240295, 7904.446688731762, 7913.802154946144, 7914.841703165933, 7918.0498340198965, 7861.68553257869, 7883.999999999971, 7890.48711833729, 7897.763067107996, 7906.367490600767, 7745.806354841117, 7792.181820908836, 7808.258215469521, 7811.257930496594, 7814.72648457307, 39437.60562394368, 39661.60338396608, 39899.20201595952, 40061.79969100165, 40121.79939100286, 3563.893083207508, 3592.892213233607, 3605.891823245307, 3607.2785442911522, 3607.5851277103206, 32117.678823211703, 32297.0, 32323.0, 32323.676763232535, 32358.676413236037, 5073.416557095944, 5093.872653183663, 5096.184610462308, 5108.872278193037, 5109.846704598868, 189817.0, 190542.0, 191607.0, 192531.0, 192969.0, 48453.0, 48540.0, 48834.26748598774, 51116.0, 51462.0, 52691.0, 52767.0, 52853.20720189124, 52951.20573191405, 53154.202686959725, 16941.491755247363, 16972.83027169737, 17023.40418085361, 17054.403095891583, 17143.828561714472, 12352.62942111738, 12529.43617537213, 13858.792118118236, 14066.2966851657, 14139.64650883736, 15025.774613380809, 15080.170590617401, 15158.696826063637, 15175.089494630358, 15300.311485983157, 6077.0, 6207.317195108534, 6238.812835614848, 6253.0, 6266.937330626635, 1000.474750755859, 1007.5063219022626, 1008.3395376028712, 1008.9041541053588, 1016.0398423489879, 22792.88603557005, 29992.700072998992, 30025.549616755765, 30586.541201881988, 30659.2335191622, 1108.6009036746764, 1109.8557187565725, 1122.9326240425437, 1130.2596799096605, 1136.2557524821254, 12415.93792031034, 12429.689257768629, 12631.873681263254, 12671.303078330597, 12718.618441446772, 238221.0, 238711.0, 239483.0, 240028.0, 240719.0, 54808.0, 54908.0, 55022.17466738002, 55065.1740223897, 55190.72404637951, 1474.7714104313848, 1520.7034628247607, 1534.6930613877046, 1550.3488534815406, 1557.2058250292432, 23282.185123521274, 23373.532529349657, 23410.882945585163, 23461.41346466352, 23589.646155307342, 39384.80307598443, 39546.2090758189, 39598.80200598978, 39602.60397396104, 39621.80189099036, 209815.0, 209957.0, 210180.0, 210294.0, 210729.0, 36427.27145457129, 36591.81704091569, 38352.356526129974, 38605.0, 38751.224975500896, 46666.30000550063, 47269.29096063493, 47411.52588474071, 47470.28794568015, 47909.0, 34567.827160864035, 34954.825225873705, 35045.0, 35139.82430087936, 35256.823715881255, 33765.83117084399, 33844.492332614536, 34177.487337689454, 34254.82872585721, 34403.82798085993, 37717.0, 37743.24513509769, 37920.0, 37957.81021094987, 37965.43051854169, 33181.336373271915, 33341.49987750234, 33780.15549611279, 35035.29929401448, 35121.47317790184, 24743.50512989766, 25212.74787252104, 25249.74750252474, 25407.110751123622, 25534.36164095838], "value": 17920.31279367532, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.0404528482719, 581.1660267516112, 582.6911736779506, 591.4351794036694, 597.3876776304288, 22187.77812221879, 22492.325230243077, 22947.770522294773, 22962.311130666065, 23085.422864428398, 26574.0, 27092.45815083697, 27106.728932710666, 27132.5930111048, 27157.592636110476, 6558.508111891603, 6704.899426508607, 6706.0276259942275, 6707.698153583076, 6711.362420570063, 6248.375162483738, 6526.151600291955, 6536.7712130075215, 6538.05198246254, 6541.378569035934, 6512.283648798629, 6517.0224466329955, 6517.902231466532, 6520.282768895418, 6520.576162549442, 6505.121808555832, 6508.219013718337, 6509.349065093476, 6515.804525864231, 6517.446017088553, 6042.425969532887, 6050.364711705296, 6057.7879774207695, 6067.150598916155, 6069.57512974092, 29173.708262917313, 29511.55732664012, 30005.099847004625, 30482.08553743391, 30501.0, 1963.9705404418803, 2000.469875482998, 2003.4991252186953, 2007.4178488238392, 2013.1947221111527, 19149.80850191494, 19386.80613193864, 20061.1975520979, 20176.19295228189, 20244.291449799333, 2474.1216868011957, 2475.752424757528, 2508.8871000805007, 2519.722830488645, 2519.8110141739444, 133869.0, 135874.999999999, 136489.0, 136767.0, 136929.0, 14627.634309142144, 15437.0, 15498.84501154974, 15553.222338883237, 15619.84380156184, 23471.53056938886, 23519.7648023521, 23535.646965295535, 23559.882200588887, 23695.05219791189, 10686.198535109897, 10717.196210284259, 10721.839172412265, 10799.298045627009, 10933.18001149917, 8768.0, 8914.777130571658, 9241.676541321021, 10090.445025523666, 10291.53688084038, 9368.859467107999, 9588.472634005057, 9625.229981601595, 9648.179904708179, 9715.07706767856, 2792.148394739624, 2805.90179343722, 2845.715428457138, 2866.082853486864, 2904.651441826952, 961.4087336288272, 968.4818622037176, 981.4454833019321, 1002.4035698759227, 1005.1104772276587, 19838.90080549588, 20086.59826803485, 20427.8978605109, 20523.384298471068, 21124.894375528333, 1007.5919252702668, 1011.0647650922867, 1023.5342918971999, 1028.6554004408606, 1028.7788125553043, 10875.129989600971, 10959.0, 11019.889801101886, 11020.614278500214, 11067.446627668583, 486427.0, 487352.0, 491298.0, 500366.0, 500383.0, 116738.41630791791, 120694.0, 120789.39605301917, 122808.38595806964, 122895.0, 1273.5988163728396, 1281.116029939339, 1291.5350473829415, 1292.7718667266136, 1297.8767017133357, 17938.282468701105, 18160.636787264444, 18290.0, 21068.789312107296, 22326.441838954157, 60682.69658651855, 61345.69327153335, 61516.0, 62106.68946655238, 63986.36013639804, 69668.0, 70341.0, 70397.0, 70686.0, 70866.29133708803, 15095.773563396777, 15158.393664253306, 15237.542873713806, 15310.923445382701, 15354.539363819104, 23868.64197037011, 24211.152609658577, 24273.0, 24526.754732452446, 24744.876275618506, 19445.416637500897, 19557.902210488857, 19749.802501974795, 19758.20967161355, 20045.398638040882, 17898.0, 17982.460526184237, 18003.369882054067, 18418.263269469073, 18770.436886893414, 19773.110210040293, 20219.898900505403, 20263.29078482246, 20488.69266960967, 20493.38519844407, 14712.485063022743, 14879.181645009628, 15043.398264069314, 15062.096274223582, 15063.623409414853, 18358.449246522625, 18398.0, 18687.532811679273, 18763.437096887115, 18813.717794232824], "value": 12313.130495578422, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.9451221951122, 1431.0769553637897, 1439.3091316168243, 1441.192931958103, 1441.6323837421455, 13524.526641567547, 13992.230427326493, 14619.26903654817, 14627.122372657648, 14640.926795366022, 14520.27398630067, 14898.478553250638, 14920.626984325398, 14940.252987350643, 14958.476453324136, 2711.5119278529855, 2782.8886844526196, 2784.8886044558194, 2785.039161489283, 2786.3312804926773, 2651.8408895466237, 2698.3254186453387, 2747.8763455644544, 2749.463854548364, 2752.174347695683, 2681.0616284300536, 2722.8366298022083, 2725.236933658569, 2727.8499682517454, 2728.031548800167, 2600.2329312852657, 2607.960880586793, 2612.3207965928805, 2616.188981415767, 2616.306678730138, 2576.884040218176, 2594.5718956372175, 2595.9610605840926, 2598.1296265751, 2602.596597527386, 13793.931030344884, 13916.652083697887, 13930.93034534831, 13937.0, 14139.646508837259, 7696.692132314701, 7944.0467143942515, 7950.0857401399, 7957.244061814176, 7957.442978991473, 5122.410922743895, 5229.764660590283, 5271.789128434858, 5331.5201631853315, 5349.331333583302, 1731.6796392667397, 1737.643783024477, 1748.6939785537606, 1774.5297496163528, 1784.8036715961234, 23254.65118023231, 23552.882235588713, 23791.524169516513, 23825.7617423827, 24700.38249043788, 7085.8703017653215, 7137.072180616487, 7157.89263161053, 7287.234840341688, 7389.224131466226, 19184.232630694896, 19204.231830726894, 19228.903855480912, 19229.519262018563, 19254.133563989653, 7910.485818421784, 8027.2775450209765, 8028.799280018046, 8033.638486268132, 8043.075046369625, 7103.183133939559, 7152.17749958751, 7257.165425975974, 7273.490855640161, 7419.406447484188, 5482.753276102585, 5621.297337832771, 5637.098064309691, 5644.8306550803545, 5707.857303567361, 1665.383807991051, 1694.4323651576613, 1722.0958996526924, 1723.0, 1731.385358197847, 862.094800459515, 886.1492966751862, 893.1648908270788, 898.7887846356101, 899.9280057595507, 6877.1747390313485, 6949.722011119599, 7875.448718589644, 8019.35845132388, 8223.342132629376, 731.1956847467849, 741.7774667599698, 991.3358050106445, 1031.8555402243692, 1038.948052597367, 5121.948780512147, 5264.52619264268, 5293.920591191135, 5316.946830531722, 5328.706921119298, 19132.808671913102, 19247.807521924882, 19476.610467790848, 20121.094550745252, 20204.797952020584, 19309.22763089489, 19664.115114819582, 20076.39770806878, 20135.0, 20144.294949676692, 10737.35575865435, 10825.78348433027, 11278.097752179807, 11359.318440893572, 11368.0, 8224.177582241728, 8445.577721114043, 8550.016748074051, 8616.224539791448, 8833.425827321204, 16822.831771682126, 16846.326146953983, 16903.577410564834, 17154.142292885554, 17176.14119294055, 17121.74317385265, 17149.91425042867, 17569.297228110732, 18037.909810450863, 18348.99080550529, 11138.777224455303, 11736.530538778694, 11767.23512971654, 11772.882271177179, 11779.52881884715, 13243.337833108499, 13291.268980205794, 13363.799543007057, 13370.197788132744, 13383.263920484467, 10827.566897324334, 10839.891601083888, 10884.51019704131, 10992.560297588007, 11061.11511079128, 10289.344929355279, 10492.842607361048, 10568.577256909637, 10706.089982351587, 10882.129429645767, 9603.663871764455, 9616.807663846825, 9709.46597937092, 9715.46564938935, 9722.173615242784, 6894.0, 6992.370686638227, 7041.859162816818, 7126.322999315057, 7199.640017998974, 7127.322904324081, 7138.750143744944, 7155.677994490365, 7160.140783106061, 7250.274972502708], "value": 6552.395553356433, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.7180107338817, 499.36081815276435, 530.3476723629938, 536.4045909040965, 543.891221755649, 6126.693665316728, 6198.0, 6273.184486016818, 6274.592151510149, 6283.465905398047, 5909.615874968124, 6072.362401947798, 6102.237220347457, 6182.598131121474, 6209.223847019122, 4857.902841943159, 4874.195757699984, 4920.97539512302, 4969.0, 4973.01079568172, 4810.921010553248, 4978.775955082012, 4982.476839931809, 5000.849974500771, 5024.84925452237, 4919.680220785655, 4921.8523444296725, 4937.358143441347, 4960.23116416956, 4969.428515720684, 4926.334944782462, 4940.752962351868, 4942.406911170647, 4950.579200767939, 4995.175795993693, 4474.955250447487, 4477.194105061088, 4487.640988720895, 4507.526709695468, 4530.501644819067, 6131.816045518642, 6135.110408990716, 6137.9386206137815, 6139.38606139387, 6144.262688477412, 5654.208410822488, 5716.571257155689, 5740.9712951435395, 5751.482366586985, 5772.365039845614, 6526.379993900572, 6527.804165875032, 6537.93462065378, 6544.0, 6569.408753212234, 4842.443119041285, 4888.388951381077, 4897.4123105227245, 4902.607791376681, 4907.730074845882, 6852.383285504278, 6890.655467226618, 6913.9283411071365, 6921.196915249332, 6934.445244380488, 5010.774515146827, 5022.447530771612, 5025.698458092453, 5034.320366750442, 5039.722815245197, 5096.949030509648, 5105.285260063594, 5121.615878809104, 5121.795128194905, 5124.897502049938, 5695.5443564514735, 5741.799037033684, 5749.418909799755, 5754.108113242454, 5762.30852297727, 6509.2839787623325, 6512.502124511294, 6561.245456772437, 6590.934090659128, 6595.373439523238, 1667.6247844235193, 1715.1167148918316, 1719.8280171982951, 1722.3971609936673, 1724.956876078108, 1219.2745316536646, 1222.9143959922899, 1236.8003037054043, 1243.1484433163312, 1245.1159676629695, 5758.309002919593, 5784.971075144597, 5803.82588522345, 5809.576653719866, 5813.767449302065, 6568.211814582185, 6640.410240006401, 6740.898886516707, 6742.831429214309, 6746.494012949049, 5735.741891614887, 5756.25168728071, 5778.27771528559, 5817.447342502455, 5827.825165245049, 3541.8406171722336, 3561.415170249214, 3593.347060352215, 3594.759807866282, 3615.692666123409, 6564.737410503526, 6634.535582509178, 6643.5017373697165, 6651.235107962646, 6677.432418244503, 6817.931820681829, 6927.238003819576, 6927.58434493932, 6990.0, 7022.12223472066, 6437.227532696106, 6456.289808121103, 6460.224773027173, 6526.184226971629, 6565.212174539086, 6633.441141331879, 6643.966780166068, 6661.0, 6717.328267173439, 6755.1423358576785, 6532.738690452328, 6705.0, 6759.3240675933985, 6760.628165450948, 6803.863922721617, 6528.738850445929, 6536.281009089092, 6543.574667646588, 6546.476281897341, 6571.211454625475, 5011.473795251592, 5040.6219533534395, 5044.545990860694, 5048.974755126201, 5061.39263288393, 6793.490488213502, 6837.2820853809635, 6844.638599683101, 6871.793846184622, 6872.244053154249, 6574.901376479261, 6598.868022639424, 6604.867902642017, 6627.569208001464, 6631.1048008520165, 6272.6236425814595, 6421.967890160519, 6575.0, 6583.0, 6607.669616519059, 6124.693765311806, 6389.201349831271, 6408.814369341687, 6461.773837915651, 6470.935290647033, 6355.311995763858, 6414.03789431589, 6433.906235939808, 6444.7744328948265, 6543.5419520633095, 6163.445289923749, 6179.969100154471, 6217.440430361289, 6270.996640537492, 6297.96851015742], "value": 5060.185421635246, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [914.638717706506, 925.0934084597098, 925.639000789692, 939.727479031081, 942.8727121838554, 17927.193276302565, 18688.719669204973, 18749.0, 18850.434486965412, 19430.51423714404, 20246.367972163636, 20464.0, 20575.38273851783, 20589.0, 20646.174153033862, 1027.1679939249232, 1047.5600247895864, 1053.0785562632695, 1055.2771351624124, 1057.6298295596557, 1013.758146270816, 1016.3546148195875, 1024.728446961552, 1034.9534270957788, 1052.4369462337613, 1105.9557617695323, 1108.4568561404894, 1111.7998760223156, 1113.014981741161, 1114.9554017839278, 1099.9450027498592, 1102.7408558988632, 1103.3931337764238, 1105.4362275239605, 1109.8945600167972, 806.2340776262574, 806.7942674617993, 806.9838603227961, 813.4590497319275, 813.4712436915993, 20125.597488050156, 20359.4910127248, 20426.489337766525, 20456.386308410772, 20663.79336206634, 20903.68644470334, 21377.03803328854, 21396.893015534824, 21957.341279761633, 22703.318900433012, 16879.83120168795, 16899.0388205018, 17008.234629441704, 17078.658426831393, 17353.7396939046, 3690.5940346561856, 3711.981440092782, 3714.7213958953184, 3717.5538935327663, 3717.8141092945243, 125408.0, 128612.0, 128766.78083047998, 129829.0, 129848.35075824561, 16481.423150189927, 17054.829451705325, 17122.40071597488, 17527.29890804379, 18400.723989139908, 32534.674653253638, 32727.0, 33233.66766332354, 33397.3320533588, 33568.328633427685, 7576.166621671612, 7763.0, 8145.470544414594, 8853.557322133867, 9019.729408117766, 3751.6248375162268, 4171.124063946544, 4230.682698797603, 4234.9364759528635, 4240.554741752133, 5266.210068489757, 5386.461353864661, 5415.0523658359625, 5423.376311724123, 5432.429594892558, 1036.9170466362673, 1071.566015763617, 1086.2884810449011, 1087.6247694545368, 1089.629525961177, 703.3283214530112, 712.3232928717739, 715.8818794898888, 721.1850608812009, 726.9963650181716, 12467.753224677459, 12870.22778633285, 12961.675958100934, 13090.14914030585, 13272.469101236036, 688.3460712323313, 700.4221517248291, 704.7779949315949, 715.2954339975121, 719.1837264704598, 5868.618539794899, 5900.763969441175, 5953.107033944856, 5960.850978725566, 6082.817515474543, 111014.0, 111589.0, 114255.42872285585, 114531.0, 115511.42244288725, 103316.48341758244, 107485.46257268664, 107822.0, 109541.0, 111373.88626113797, 85571.0, 87820.5608971951, 89674.10325896788, 91969.54015229881, 92034.0, 10702.732431688959, 10797.488351630622, 10956.945215273872, 10984.340939543654, 11032.0, 40492.39261411022, 40847.79576102101, 41193.58806412017, 42012.57987420209, 42243.0, 51475.48524514707, 52607.73696131495, 70712.0, 72360.63819680868, 74552.62723686347, 20015.499612509804, 20019.0, 20197.59604807925, 20355.9822008896, 20805.895970520654, 21924.89037554802, 22141.0, 22763.08947642142, 22968.885155574117, 23090.191843285404, 18956.24175032983, 19016.619667606847, 19091.236350545823, 19374.8062519373, 20790.792092078886, 19999.60000800005, 20252.898735506817, 20253.49366265855, 20505.077271522518, 20771.376858694264, 18557.44327670172, 19527.511812204808, 19682.409527714193, 20080.196792128736, 20266.0, 14361.712765744836, 14412.495562655256, 14594.343254553358, 14723.92638036803, 14731.705365892407, 14785.260736963324, 14810.703785924006, 14940.103593784408, 15015.474458393905, 15284.465043723416], "value": 9486.174087158193, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 109.0, 103.0, 109.0, 108.0, 109.0, 110.0, 101.0, 111.0, 114.0], "value": 107.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 117.0, 146.0, 180.0, 123.0, 151.0, 145.0, 118.0, 179.0, 121.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 161.0, 172.0, 166.0, 174.0, 165.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 77.0, 183.0, 77.0, 83.0, 81.0, 92.0, 98.0, 76.0], "value": 91.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 126.0, 79.0, 79.0, 79.0, 136.0, 78.0, 80.0, 129.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 115.0, 119.0, 114.0, 115.0, 115.0, 123.0, 123.0, 115.0, 115.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 154.0, 150.0, 150.0, 150.0, 151.0, 150.0, 151.0, 151.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 99.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 65.0, 55.0, 64.0, 53.0, 53.0, 53.0, 52.0], "value": 55.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 54.0, 54.0, 59.0, 56.0, 54.0, 56.0, 60.0, 54.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 83.0, 78.0, 77.0, 77.0, 85.0, 78.0, 82.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 125.0, 127.0, 124.0, 134.0, 130.0, 145.0, 124.0, 124.0, 179.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 189.0, 186.0, 181.0, 181.0, 173.0, 176.0, 173.0, 174.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 67.0, 68.0, 66.0, 67.0, 68.0, 70.0, 67.0, 70.0], "value": 67.9, "unit": "score"}]}]} 18:51:19 INFO - Return code: 0 18:51:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:51:20 INFO - # TBPL SUCCESS # 18:51:20 INFO - Running post-action listener: _package_coverage_data 18:51:20 INFO - Running post-action listener: _resource_record_post_action 18:51:20 INFO - [mozharness: 2017-08-15 01:51:20.051167Z] Finished run-tests step (success) 18:51:20 INFO - Running post-run listener: _resource_record_post_run 18:51:20 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 432304128; Read time: 172; Write time: 309328 18:51:20 INFO - TinderboxPrint: CPU usage
13.1% 18:51:20 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 172 18:51:20 INFO - TinderboxPrint: I/O write bytes / time
432,304,128 / 309,328 18:51:20 INFO - TinderboxPrint: CPU idle
8,269.4 (86.9%) 18:51:20 INFO - TinderboxPrint: CPU user
1,202.2 (12.6%) 18:51:20 INFO - TinderboxPrint: Swap in / out
0 / 0 18:51:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107483136; Read time: 0; Write time: 88056 18:51:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:51:20 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8192; Write bytes: 324820992; Read time: 172; Write time: 221272 18:51:20 INFO - Running post-run listener: _upload_blobber_files 18:51:20 INFO - Blob upload gear active. 18:51:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:51:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:51:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:51:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:51:21 INFO - (blobuploader) - INFO - Open directory for files ... 18:51:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:51:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:51:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:28 INFO - (blobuploader) - INFO - Done attempting. 18:51:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:51:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:51:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:29 INFO - (blobuploader) - INFO - Done attempting. 18:51:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:51:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:51:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:30 INFO - (blobuploader) - INFO - Done attempting. 18:51:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:51:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:51:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:51:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:51:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:51:31 INFO - (blobuploader) - INFO - Done attempting. 18:51:31 INFO - (blobuploader) - INFO - Iteration through files over. 18:51:31 INFO - Return code: 0 18:51:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:51:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:51:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1cd6b07a770f44f0bf0a65cf1acbdf86c1605b8bce8c816d167cfd5366a26d4450c5359881751bf0b984e9861bfa021d1920fa504c40dd280071251c5028bd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da6f8ca8227ab7e9b8a55579375633a582946e74b963bc8656165110cbd9785c3cafea14cfe0321ee27cb602749d9bcbda89b21514a4f03e439e692c526fcb84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebad4a4c592f39d3d5d0fdac481dd059024bbc27a76cc3282fe94858a180aba81ed920593ce19ed46a5d26f4810c26e15a5a2ca1bef55fd8eda1bf7207e1c7e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b02a09f452804410021d4acff51d296bb15edf88609977428412345a90bf66c2c27a4a4edd77ea762c79a532dec4f11a3079912a95940b7bf7b7c1433cbc0221"} 18:51:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:51:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:51:31 INFO - Contents: 18:51:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1cd6b07a770f44f0bf0a65cf1acbdf86c1605b8bce8c816d167cfd5366a26d4450c5359881751bf0b984e9861bfa021d1920fa504c40dd280071251c5028bd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da6f8ca8227ab7e9b8a55579375633a582946e74b963bc8656165110cbd9785c3cafea14cfe0321ee27cb602749d9bcbda89b21514a4f03e439e692c526fcb84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebad4a4c592f39d3d5d0fdac481dd059024bbc27a76cc3282fe94858a180aba81ed920593ce19ed46a5d26f4810c26e15a5a2ca1bef55fd8eda1bf7207e1c7e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b02a09f452804410021d4acff51d296bb15edf88609977428412345a90bf66c2c27a4a4edd77ea762c79a532dec4f11a3079912a95940b7bf7b7c1433cbc0221"} 18:51:31 INFO - Running post-run listener: copy_logs_to_upload_dir 18:51:31 INFO - Copying logs to upload dir... 18:51:31 INFO - mkdir: /builds/slave/test/build/upload/logs 18:51:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.530776 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-14 18:51:30.055404) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 18:51:30.063684) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126 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/e1cd6b07a770f44f0bf0a65cf1acbdf86c1605b8bce8c816d167cfd5366a26d4450c5359881751bf0b984e9861bfa021d1920fa504c40dd280071251c5028bd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da6f8ca8227ab7e9b8a55579375633a582946e74b963bc8656165110cbd9785c3cafea14cfe0321ee27cb602749d9bcbda89b21514a4f03e439e692c526fcb84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebad4a4c592f39d3d5d0fdac481dd059024bbc27a76cc3282fe94858a180aba81ed920593ce19ed46a5d26f4810c26e15a5a2ca1bef55fd8eda1bf7207e1c7e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b02a09f452804410021d4acff51d296bb15edf88609977428412345a90bf66c2c27a4a4edd77ea762c79a532dec4f11a3079912a95940b7bf7b7c1433cbc0221"} build_url:https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011388 build_url: 'https://queue.taskcluster.net/v1/task/WNyohAO-Q2uqbLtYqVVqMQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1cd6b07a770f44f0bf0a65cf1acbdf86c1605b8bce8c816d167cfd5366a26d4450c5359881751bf0b984e9861bfa021d1920fa504c40dd280071251c5028bd5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/da6f8ca8227ab7e9b8a55579375633a582946e74b963bc8656165110cbd9785c3cafea14cfe0321ee27cb602749d9bcbda89b21514a4f03e439e692c526fcb84", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebad4a4c592f39d3d5d0fdac481dd059024bbc27a76cc3282fe94858a180aba81ed920593ce19ed46a5d26f4810c26e15a5a2ca1bef55fd8eda1bf7207e1c7e0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b02a09f452804410021d4acff51d296bb15edf88609977428412345a90bf66c2c27a4a4edd77ea762c79a532dec4f11a3079912a95940b7bf7b7c1433cbc0221"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-14 18:51:30.090001) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 18:51:30.090319) ========= 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=9531f05ccb2eabcb9acf5f1b000001c0-1502760262.840909-110866126 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-14 18:51:30.176768) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 18:51:30.177108) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-14 18:51:30.177423) ========= ========= Total master_lag: 0.47 =========