builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-020 starttime: 1502321490.94 results: success (0) revision: a4a448ba7f187069fce916ee234a06cbb0d06f80 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:30.939699) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:30.940409) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:30.940697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:30.957134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:30.957464) ========= 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=af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-09 16:31:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.7M=0.001s 2017-08-09 16:31:32 (19.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120525 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:31.091133) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:31.091426) ========= 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=af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022794 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:31.145640) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-09 16:31:31.149012) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a4a448ba7f187069fce916ee234a06cbb0d06f80 --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 a4a448ba7f187069fce916ee234a06cbb0d06f80 --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=af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-09 16:31:32,395 truncating revision to first 12 chars 2017-08-09 16:31:32,395 Setting DEBUG logging. 2017-08-09 16:31:32,395 attempt 1/10 2017-08-09 16:31:32,395 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a4a448ba7f18?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-09 16:31:33,835 unpacking tar archive at: mozilla-central-a4a448ba7f18/testing/mozharness/ program finished with exit code 0 elapsedTime=1.739463 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-09 16:31:32.902465) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:32.905815) ========= script_repo_revision: a4a448ba7f187069fce916ee234a06cbb0d06f80 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:32.906216) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:32.906490) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-09 16:31:32.915754) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-09 16:31:32.916099) ========= /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=af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:31:34 INFO - MultiFileLogger online at 20170809 16:31:34 in /builds/slave/test 16:31:34 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 16:31:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:31:34 INFO - {'append_to_log': False, 16:31:34 INFO - 'base_work_dir': '/builds/slave/test', 16:31:34 INFO - 'blob_upload_branch': 'Firefox', 16:31:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:31:34 INFO - 'branch': 'Firefox', 16:31:34 INFO - 'buildbot_json_path': 'buildprops.json', 16:31:34 INFO - 'code_coverage': False, 16:31:34 INFO - 'config_files': ('talos/linux_config.py',), 16:31:34 INFO - 'default_actions': ('clobber', 16:31:34 INFO - 'read-buildbot-config', 16:31:34 INFO - 'download-and-extract', 16:31:34 INFO - 'populate-webroot', 16:31:34 INFO - 'create-virtualenv', 16:31:34 INFO - 'install', 16:31:34 INFO - 'setup-mitmproxy', 16:31:34 INFO - 'run-tests'), 16:31:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:31:34 INFO - 'disable_ccov_upload': False, 16:31:34 INFO - 'download_minidump_stackwalk': True, 16:31:34 INFO - 'download_symbols': 'ondemand', 16:31:34 INFO - 'enable_stylo': False, 16:31:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:31:34 INFO - 'tooltool.py': '/tools/tooltool.py', 16:31:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:31:34 INFO - '/tools/misc-python/virtualenv.py')}, 16:31:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:31:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:31:34 INFO - 'gecko_profile': False, 16:31:34 INFO - 'gecko_profile_interval': 0, 16:31:34 INFO - 'installer_path': 'installer.exe', 16:31:34 INFO - 'log_level': 'info', 16:31:34 INFO - 'log_name': 'talos', 16:31:34 INFO - 'log_to_console': True, 16:31:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:31:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:31:34 INFO - 'opt_config_files': (), 16:31:34 INFO - 'pip_index': False, 16:31:34 INFO - 'suite': 'dromaeojs-e10s', 16:31:34 INFO - 'system_bits': '32', 16:31:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:34 INFO - 'title': 'talos-linux64-ix-020', 16:31:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:31:34 INFO - 'use_talos_json': True, 16:31:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:31:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:31:34 INFO - 'work_dir': 'build'} 16:31:34 INFO - [mozharness: 2017-08-09 23:31:34.262584Z] Running clobber step. 16:31:34 INFO - Running pre-action listener: _resource_record_pre_action 16:31:34 INFO - Running main action method: clobber 16:31:34 INFO - rmtree: /builds/slave/test/build 16:31:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:35 INFO - Running post-action listener: _resource_record_post_action 16:31:35 INFO - [mozharness: 2017-08-09 23:31:35.807573Z] Finished clobber step (success) 16:31:35 INFO - [mozharness: 2017-08-09 23:31:35.807674Z] Running read-buildbot-config step. 16:31:35 INFO - Running pre-action listener: _resource_record_pre_action 16:31:35 INFO - Running main action method: read_buildbot_config 16:31:35 INFO - Using buildbot properties: 16:31:35 INFO - { 16:31:35 INFO - "project": "", 16:31:35 INFO - "product": "firefox", 16:31:35 INFO - "who": "ryanvm@gmail.com", 16:31:35 INFO - "installer_path": "public/build/target.tar.bz2", 16:31:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:31:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 16:31:35 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:31:35 INFO - "stage_platform": "linux64-stylo", 16:31:35 INFO - "basedir": "/builds/slave/test", 16:31:35 INFO - "buildnumber": 72, 16:31:35 INFO - "platform": "ubuntu64_hw_stylo", 16:31:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:31:35 INFO - "slavebuilddir": "test", 16:31:35 INFO - "taskId": "Ke-qk0PmQGWoVF-g2WPZrg", 16:31:35 INFO - "branch": "mozilla-central", 16:31:35 INFO - "script_repo_revision": "production", 16:31:35 INFO - "revision": "a4a448ba7f187069fce916ee234a06cbb0d06f80", 16:31:35 INFO - "slavename": "talos-linux64-ix-020", 16:31:35 INFO - "repo_path": "mozilla-central" 16:31:35 INFO - } 16:31:35 INFO - Finding installer, test and symbols from parent task. 16:31:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ke-qk0PmQGWoVF-g2WPZrg'}, attempt #1 16:31:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ke-qk0PmQGWoVF-g2WPZrg'}, attempt #1 16:31:36 INFO - Task dependencies: W3D-FPkqR6iRZ6ceKXKElw 16:31:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw'}, attempt #1 16:31:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2 16:31:37 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.test_packages.json 16:31:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.crashreporter-symbols.zip 16:31:37 INFO - Running post-action listener: _resource_record_post_action 16:31:37 INFO - [mozharness: 2017-08-09 23:31:37.188921Z] Finished read-buildbot-config step (success) 16:31:37 INFO - [mozharness: 2017-08-09 23:31:37.189194Z] Running download-and-extract step. 16:31:37 INFO - Running pre-action listener: _resource_record_pre_action 16:31:37 INFO - Running main action method: download_and_extract 16:31:37 INFO - mkdir: /builds/slave/test/build/tests 16:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:37 INFO - trying https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.test_packages.json 16:31:37 INFO - Downloading https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:31:37 INFO - Downloaded 989 bytes. 16:31:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:31:37 INFO - Using the following test package requirements: 16:31:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:31:37 INFO - u'common': [u'target.common.tests.zip'], 16:31:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:31:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:31:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:31:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:31:37 INFO - u'mozbase': [u'target.common.tests.zip'], 16:31:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:31:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:31:37 INFO - u'web-platform': [u'target.common.tests.zip', 16:31:37 INFO - u'target.web-platform.tests.tar.gz'], 16:31:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:31:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:31:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.common.tests.zip 16:31:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:31:37 INFO - Fetch https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.common.tests.zip into memory 16:31:39 INFO - Content-Length response header: 54284101 16:31:39 INFO - Bytes received: 54284101 16:31:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:31:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.common.tests.zip 16:31:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:31:50 INFO - Fetch https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.common.tests.zip into memory 16:31:51 INFO - Content-Length response header: 54284101 16:31:51 INFO - Bytes received: 54284101 16:32:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.talos.tests.zip 16:32:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:32:03 INFO - Fetch https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.talos.tests.zip into memory 16:32:03 INFO - Content-Length response header: 14496008 16:32:03 INFO - Bytes received: 14496008 16:32: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')]} 16:32:04 INFO - trying https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2 16:32:04 INFO - Downloading https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:32:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:32:05 INFO - Downloaded 61801086 bytes. 16:32:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2 16:32:05 INFO - mkdir: /builds/slave/test/properties 16:32:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:32:05 INFO - Writing to file /builds/slave/test/properties/build_url 16:32:05 INFO - Contents: 16:32:05 INFO - build_url:https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2 16:32:05 INFO - Running post-action listener: _resource_record_post_action 16:32:05 INFO - Running post-action listener: set_extra_try_arguments 16:32:05 INFO - [mozharness: 2017-08-09 23:32:05.221579Z] Finished download-and-extract step (success) 16:32:05 INFO - [mozharness: 2017-08-09 23:32:05.221677Z] Running populate-webroot step. 16:32:05 INFO - Running pre-action listener: _resource_record_pre_action 16:32:05 INFO - Running main action method: populate_webroot 16:32:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:32:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:32:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:32:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:32:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:32:05 INFO - 'tests': ['damp', 'tps']}, 16:32:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:32:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:32:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:32:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:32:05 INFO - 'other-e10s': {'tests': ['a11yr', 16:32:05 INFO - 'ts_paint', 16:32:05 INFO - 'tpaint', 16:32:05 INFO - 'sessionrestore', 16:32:05 INFO - 'sessionrestore_many_windows', 16:32:05 INFO - 'sessionrestore_no_auto_restore', 16:32:05 INFO - 'tabpaint']}, 16:32:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 16:32:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 16:32:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:32:05 INFO - 'tsvgr_opacity', 16:32:05 INFO - 'tart', 16:32:05 INFO - 'tscrollx', 16:32:05 INFO - 'tsvg_static']}, 16:32:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:32:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:32:05 INFO - 'talos_options': ['--mitmproxy', 16:32:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:32:05 INFO - '--firstNonBlankPaint'], 16:32:05 INFO - 'tests': ['tp6_google', 16:32:05 INFO - 'tp6_youtube', 16:32:05 INFO - 'tp6_amazon', 16:32:05 INFO - 'tp6_facebook']}, 16:32:05 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:32:05 INFO - 'talos_options': ['--stylo', 16:32:05 INFO - '--mitmproxy', 16:32:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:32:05 INFO - '--firstNonBlankPaint'], 16:32:05 INFO - 'tests': ['tp6_google', 16:32:05 INFO - 'tp6_youtube', 16:32:05 INFO - 'tp6_amazon', 16:32:05 INFO - 'tp6_facebook']}, 16:32:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:32:05 INFO - 'talos_options': ['--stylo', 16:32:05 INFO - '--stylo-threads=1', 16:32:05 INFO - '--mitmproxy', 16:32:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:32:05 INFO - '--firstNonBlankPaint'], 16:32:05 INFO - 'tests': ['tp6_google', 16:32:05 INFO - 'tp6_youtube', 16:32:05 INFO - 'tp6_amazon', 16:32:05 INFO - 'tp6_facebook']}, 16:32:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:32:05 INFO - 'talos_options': ['--xperf_path', 16:32:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:32:05 INFO - 'tests': ['tp5n']}}} 16:32:05 INFO - Running post-action listener: _resource_record_post_action 16:32:05 INFO - [mozharness: 2017-08-09 23:32:05.230095Z] Finished populate-webroot step (success) 16:32:05 INFO - [mozharness: 2017-08-09 23:32:05.230186Z] Running create-virtualenv step. 16:32:05 INFO - Running pre-action listener: _resource_record_pre_action 16:32:05 INFO - Running main action method: create_virtualenv 16:32:05 INFO - Creating virtualenv /builds/slave/test/build/venv 16:32: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 16:32:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:32:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:32:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:32:05 INFO - Using real prefix '/usr' 16:32:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:32:05 INFO - Installing distribute.............................................................................................................................................................................................done. 16:32:07 INFO - Installing pip.................done. 16:32:07 INFO - Return code: 0 16:32:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:32:08 INFO - Reading from file tmpfile_stdout 16:32:08 INFO - Output received: 16:32: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) 16:32:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32: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')]} 16:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32: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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d9f00>, '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 0x20d4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d5050>, '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': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', '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 16:32: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 16:32: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 16:32:08 INFO - Using env: {'DISPLAY': ':0', 16:32:08 INFO - 'HOME': '/home/cltbld', 16:32:08 INFO - 'LANG': 'en_US.UTF-8', 16:32:08 INFO - 'LANGUAGE': 'en_US:en', 16:32:08 INFO - 'LOGNAME': 'cltbld', 16:32:08 INFO - 'MAIL': '/var/mail/cltbld', 16:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:08 INFO - 'MOZ_NO_REMOTE': '1', 16:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:08 INFO - 'NO_EM_RESTART': '1', 16:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:08 INFO - 'PWD': '/builds/slave/test', 16:32:08 INFO - 'SHELL': '/bin/bash', 16:32:08 INFO - 'SHLVL': '1', 16:32:08 INFO - 'TERM': 'linux', 16:32:08 INFO - 'TMOUT': '86400', 16:32:08 INFO - 'USER': 'cltbld', 16:32:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', 16:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:08 INFO - '_': '/tools/buildbot/bin/python'} 16:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32: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 16:32:08 INFO - Cleaning up... 16:32:08 INFO - Return code: 0 16:32:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32: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')]} 16:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32: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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d9f00>, '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 0x20d4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d5050>, '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': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', '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 16:32: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 16:32: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 16:32:08 INFO - Using env: {'DISPLAY': ':0', 16:32:08 INFO - 'HOME': '/home/cltbld', 16:32:08 INFO - 'LANG': 'en_US.UTF-8', 16:32:08 INFO - 'LANGUAGE': 'en_US:en', 16:32:08 INFO - 'LOGNAME': 'cltbld', 16:32:08 INFO - 'MAIL': '/var/mail/cltbld', 16:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:08 INFO - 'MOZ_NO_REMOTE': '1', 16:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:08 INFO - 'NO_EM_RESTART': '1', 16:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:08 INFO - 'PWD': '/builds/slave/test', 16:32:08 INFO - 'SHELL': '/bin/bash', 16:32:08 INFO - 'SHLVL': '1', 16:32:08 INFO - 'TERM': 'linux', 16:32:08 INFO - 'TMOUT': '86400', 16:32:08 INFO - 'USER': 'cltbld', 16:32:08 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', 16:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:08 INFO - '_': '/tools/buildbot/bin/python'} 16:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:08 INFO - Downloading/unpacking psutil>=3.1.1 16:32: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 16:32: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 16:32: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 16:32: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 16:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:32:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:09 INFO - Installing collected packages: psutil 16:32:09 INFO - Running setup.py install for psutil 16:32:09 INFO - building 'psutil._psutil_linux' extension 16:32:09 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 16:32: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 16:32:10 INFO - building 'psutil._psutil_posix' extension 16:32: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 16:32: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 16:32:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:32:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:32:10 INFO - Successfully installed psutil 16:32:10 INFO - Cleaning up... 16:32:10 INFO - Return code: 0 16:32:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32: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')]} 16:32:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32: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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d9f00>, '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 0x20d4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d5050>, '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': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', '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 16:32: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 16:32: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 16:32:10 INFO - Using env: {'DISPLAY': ':0', 16:32:10 INFO - 'HOME': '/home/cltbld', 16:32:10 INFO - 'LANG': 'en_US.UTF-8', 16:32:10 INFO - 'LANGUAGE': 'en_US:en', 16:32:10 INFO - 'LOGNAME': 'cltbld', 16:32:10 INFO - 'MAIL': '/var/mail/cltbld', 16:32:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:10 INFO - 'MOZ_NO_REMOTE': '1', 16:32:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:10 INFO - 'NO_EM_RESTART': '1', 16:32:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:10 INFO - 'PWD': '/builds/slave/test', 16:32:10 INFO - 'SHELL': '/bin/bash', 16:32:10 INFO - 'SHLVL': '1', 16:32:10 INFO - 'TERM': 'linux', 16:32:10 INFO - 'TMOUT': '86400', 16:32:10 INFO - 'USER': 'cltbld', 16:32:10 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', 16:32:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:10 INFO - '_': '/tools/buildbot/bin/python'} 16:32:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:32: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 16:32: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 16:32: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 16:32: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 16:32:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:32:11 INFO - Installing collected packages: mozsystemmonitor 16:32:11 INFO - Running setup.py install for mozsystemmonitor 16:32:11 INFO - Successfully installed mozsystemmonitor 16:32:11 INFO - Cleaning up... 16:32:11 INFO - Return code: 0 16:32:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:32:11 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')]} 16:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:11 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')]} 16:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:11 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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d9f00>, '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 0x20d4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d5050>, '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': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', '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 16:32:11 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 16:32:11 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 16:32:11 INFO - Using env: {'DISPLAY': ':0', 16:32:11 INFO - 'HOME': '/home/cltbld', 16:32:11 INFO - 'LANG': 'en_US.UTF-8', 16:32:11 INFO - 'LANGUAGE': 'en_US:en', 16:32:11 INFO - 'LOGNAME': 'cltbld', 16:32:11 INFO - 'MAIL': '/var/mail/cltbld', 16:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:11 INFO - 'MOZ_NO_REMOTE': '1', 16:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:11 INFO - 'NO_EM_RESTART': '1', 16:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:11 INFO - 'PWD': '/builds/slave/test', 16:32:11 INFO - 'SHELL': '/bin/bash', 16:32:11 INFO - 'SHLVL': '1', 16:32:11 INFO - 'TERM': 'linux', 16:32:11 INFO - 'TMOUT': '86400', 16:32:11 INFO - 'USER': 'cltbld', 16:32:11 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', 16:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:11 INFO - '_': '/tools/buildbot/bin/python'} 16:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:12 INFO - Downloading/unpacking jsonschema==2.5.1 16:32: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 16:32: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 16:32: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 16:32: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 16:32:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:32:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:32: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 16:32: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 16:32: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 16:32: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 16:32:13 INFO - Downloading functools32-3.2.3-2.tar.gz 16:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:32:13 INFO - warning: no files found matching '*.txt' 16:32:13 INFO - no previously-included directories found matching 'build' 16:32:13 INFO - no previously-included directories found matching 'dist' 16:32:13 INFO - no previously-included directories found matching '.git*' 16:32:13 INFO - Installing collected packages: jsonschema, functools32 16:32:13 INFO - Running setup.py install for functools32 16:32:13 INFO - warning: no files found matching '*.txt' 16:32:13 INFO - no previously-included directories found matching 'build' 16:32:13 INFO - no previously-included directories found matching 'dist' 16:32:13 INFO - no previously-included directories found matching '.git*' 16:32:13 INFO - Successfully installed jsonschema functools32 16:32:13 INFO - Cleaning up... 16:32:13 INFO - Return code: 0 16:32:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32: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')]} 16:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32: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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d9f00>, '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 0x20d4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d5050>, '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': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', '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 16:32: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 16:32: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 16:32:13 INFO - Using env: {'DISPLAY': ':0', 16:32:13 INFO - 'HOME': '/home/cltbld', 16:32:13 INFO - 'LANG': 'en_US.UTF-8', 16:32:13 INFO - 'LANGUAGE': 'en_US:en', 16:32:13 INFO - 'LOGNAME': 'cltbld', 16:32:13 INFO - 'MAIL': '/var/mail/cltbld', 16:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:13 INFO - 'MOZ_NO_REMOTE': '1', 16:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:13 INFO - 'NO_EM_RESTART': '1', 16:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:13 INFO - 'PWD': '/builds/slave/test', 16:32:13 INFO - 'SHELL': '/bin/bash', 16:32:13 INFO - 'SHLVL': '1', 16:32:13 INFO - 'TERM': 'linux', 16:32:13 INFO - 'TMOUT': '86400', 16:32:13 INFO - 'USER': 'cltbld', 16:32:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', 16:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:13 INFO - '_': '/tools/buildbot/bin/python'} 16:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:32:13 INFO - Cleaning up... 16:32:13 INFO - Return code: 0 16:32:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32: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')]} 16:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32: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', '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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d9f00>, '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 0x20d4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d5050>, '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': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', '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 16:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:32: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 blobuploader==1.2.4 16:32:13 INFO - Using env: {'DISPLAY': ':0', 16:32:13 INFO - 'HOME': '/home/cltbld', 16:32:13 INFO - 'LANG': 'en_US.UTF-8', 16:32:13 INFO - 'LANGUAGE': 'en_US:en', 16:32:13 INFO - 'LOGNAME': 'cltbld', 16:32:13 INFO - 'MAIL': '/var/mail/cltbld', 16:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:13 INFO - 'MOZ_NO_REMOTE': '1', 16:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:13 INFO - 'NO_EM_RESTART': '1', 16:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:13 INFO - 'PWD': '/builds/slave/test', 16:32:13 INFO - 'SHELL': '/bin/bash', 16:32:13 INFO - 'SHLVL': '1', 16:32:13 INFO - 'TERM': 'linux', 16:32:13 INFO - 'TMOUT': '86400', 16:32:13 INFO - 'USER': 'cltbld', 16:32:13 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', 16:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:13 INFO - '_': '/tools/buildbot/bin/python'} 16:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:13 INFO - Downloading/unpacking blobuploader==1.2.4 16:32: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 16:32: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 16:32: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 16:32: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 16:32:14 INFO - Downloading blobuploader-1.2.4.tar.gz 16:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:32:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:32: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 16:32: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 16:32: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 16:32: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 16:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:32:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:32: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 16:32: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 16:32: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 16:32: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 16:32:15 INFO - Downloading docopt-0.6.1.tar.gz 16:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:32:15 INFO - Installing collected packages: blobuploader, requests, docopt 16:32:15 INFO - Running setup.py install for blobuploader 16:32:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:32:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:32:15 INFO - Running setup.py install for requests 16:32:16 INFO - Running setup.py install for docopt 16:32:16 INFO - Successfully installed blobuploader requests docopt 16:32:16 INFO - Cleaning up... 16:32:16 INFO - Return code: 0 16:32:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32: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')]} 16:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32: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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d9f00>, '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 0x20d4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d5050>, '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': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', '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 16:32: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 16:32: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 16:32:16 INFO - Using env: {'DISPLAY': ':0', 16:32:16 INFO - 'HOME': '/home/cltbld', 16:32:16 INFO - 'LANG': 'en_US.UTF-8', 16:32:16 INFO - 'LANGUAGE': 'en_US:en', 16:32:16 INFO - 'LOGNAME': 'cltbld', 16:32:16 INFO - 'MAIL': '/var/mail/cltbld', 16:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:16 INFO - 'MOZ_NO_REMOTE': '1', 16:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:16 INFO - 'NO_EM_RESTART': '1', 16:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:16 INFO - 'PWD': '/builds/slave/test', 16:32:16 INFO - 'SHELL': '/bin/bash', 16:32:16 INFO - 'SHLVL': '1', 16:32:16 INFO - 'TERM': 'linux', 16:32:16 INFO - 'TMOUT': '86400', 16:32:16 INFO - 'USER': 'cltbld', 16:32:16 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', 16:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:16 INFO - '_': '/tools/buildbot/bin/python'} 16:32:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:16 INFO - Running setup.py (path:/tmp/pip-_phgW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:16 INFO - Running setup.py (path:/tmp/pip-9EgGQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:16 INFO - Running setup.py (path:/tmp/pip-YSc6Q0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:16 INFO - Running setup.py (path:/tmp/pip-GZTzRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:16 INFO - Running setup.py (path:/tmp/pip-dOqkH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:16 INFO - Running setup.py (path:/tmp/pip-qd3lDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:16 INFO - Running setup.py (path:/tmp/pip-ueygQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:16 INFO - Running setup.py (path:/tmp/pip-9CDRZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:16 INFO - Running setup.py (path:/tmp/pip-CqjKUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:17 INFO - Running setup.py (path:/tmp/pip-lOMPu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:17 INFO - Running setup.py (path:/tmp/pip-twhrmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:17 INFO - Running setup.py (path:/tmp/pip-2nLyAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:17 INFO - Running setup.py (path:/tmp/pip-3PnlGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:17 INFO - Running setup.py (path:/tmp/pip-a2qWQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:17 INFO - Running setup.py (path:/tmp/pip-dhW3Q_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:17 INFO - Running setup.py (path:/tmp/pip-ikEmeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:17 INFO - Running setup.py (path:/tmp/pip-oHQW8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:32:17 INFO - Running setup.py install for manifestparser 16:32:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:32:17 INFO - Running setup.py install for mozcrash 16:32:17 INFO - Running setup.py install for mozdebug 16:32:17 INFO - Running setup.py install for mozdevice 16:32:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Running setup.py install for mozfile 16:32:18 INFO - Running setup.py install for mozhttpd 16:32:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Running setup.py install for mozinfo 16:32:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Running setup.py install for mozInstall 16:32:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Running setup.py install for mozleak 16:32:18 INFO - Running setup.py install for mozlog 16:32:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Running setup.py install for moznetwork 16:32:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Running setup.py install for mozprocess 16:32:18 INFO - Running setup.py install for mozprofile 16:32:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:32:18 INFO - Running setup.py install for mozrunner 16:32:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:32:19 INFO - Running setup.py install for mozscreenshot 16:32:19 INFO - Running setup.py install for moztest 16:32:19 INFO - Running setup.py install for mozversion 16:32:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:32:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:32:19 INFO - Cleaning up... 16:32:19 INFO - Return code: 0 16:32:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32: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')]} 16:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32: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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d9f00>, '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 0x20d4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d5050>, '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': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', '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 16:32: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 16:32: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 16:32:19 INFO - Using env: {'DISPLAY': ':0', 16:32:19 INFO - 'HOME': '/home/cltbld', 16:32:19 INFO - 'LANG': 'en_US.UTF-8', 16:32:19 INFO - 'LANGUAGE': 'en_US:en', 16:32:19 INFO - 'LOGNAME': 'cltbld', 16:32:19 INFO - 'MAIL': '/var/mail/cltbld', 16:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:19 INFO - 'MOZ_NO_REMOTE': '1', 16:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:19 INFO - 'NO_EM_RESTART': '1', 16:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:19 INFO - 'PWD': '/builds/slave/test', 16:32:19 INFO - 'SHELL': '/bin/bash', 16:32:19 INFO - 'SHLVL': '1', 16:32:19 INFO - 'TERM': 'linux', 16:32:19 INFO - 'TMOUT': '86400', 16:32:19 INFO - 'USER': 'cltbld', 16:32:19 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', 16:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:19 INFO - '_': '/tools/buildbot/bin/python'} 16:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:32:19 INFO - Running setup.py (path:/tmp/pip-yapKEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:32:19 INFO - Running setup.py (path:/tmp/pip-evNNC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:32:19 INFO - Running setup.py (path:/tmp/pip-f4N0gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:32:19 INFO - Running setup.py (path:/tmp/pip-IdZC4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:32:19 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)) 16:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:32:19 INFO - Running setup.py (path:/tmp/pip-k1HdOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:32: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)) 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:32:20 INFO - Running setup.py (path:/tmp/pip-Q3z2PK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:32: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)) 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:32:20 INFO - Running setup.py (path:/tmp/pip-sTY_Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:32: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)) 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:32:20 INFO - Running setup.py (path:/tmp/pip-Hv2LX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:32: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)) 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:32:20 INFO - Running setup.py (path:/tmp/pip-oMzi2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:32: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)) 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:32:20 INFO - Running setup.py (path:/tmp/pip-Tsxl_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:32: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)) 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:32:20 INFO - Running setup.py (path:/tmp/pip-kP1B69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:32: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)) 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:32:20 INFO - Running setup.py (path:/tmp/pip-Oq3GXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:32: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)) 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:32:20 INFO - Running setup.py (path:/tmp/pip-HcBMdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:32: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)) 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:32:20 INFO - Running setup.py (path:/tmp/pip-QIN2l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:32:20 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)) 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:20 INFO - Running setup.py (path:/tmp/pip-y4OnYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:32:20 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)) 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:32:20 INFO - Running setup.py (path:/tmp/pip-AHwQlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:32:20 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)) 16:32:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:32:20 INFO - Running setup.py (path:/tmp/pip-6QsKUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:32:20 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)) 16:32:20 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)) 16:32:20 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)) 16:32:20 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)) 16:32:20 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)) 16:32:20 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)) 16:32:20 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)) 16:32:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:32:20 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 16:32:20 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 16:32:20 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 16:32:20 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 16:32:22 INFO - Downloading blessings-1.6.tar.gz 16:32:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:32:22 INFO - Installing collected packages: blessings 16:32:22 INFO - Running setup.py install for blessings 16:32:22 INFO - Successfully installed blessings 16:32:22 INFO - Cleaning up... 16:32:22 INFO - Return code: 0 16:32:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:22 INFO - Reading from file tmpfile_stdout 16:32:22 INFO - Current package versions: 16:32:22 INFO - argparse == 1.2.1 16:32:22 INFO - blessings == 1.6 16:32:22 INFO - blobuploader == 1.2.4 16:32:22 INFO - docopt == 0.6.1 16:32:22 INFO - functools32 == 3.2.3-2 16:32:22 INFO - jsonschema == 2.5.1 16:32:22 INFO - manifestparser == 1.1 16:32:22 INFO - mozInstall == 1.13 16:32:22 INFO - mozcrash == 1.0 16:32:22 INFO - mozdebug == 0.1 16:32:22 INFO - mozdevice == 0.51 16:32:22 INFO - mozfile == 1.2 16:32:22 INFO - mozhttpd == 0.7 16:32:22 INFO - mozinfo == 0.10 16:32:22 INFO - mozleak == 0.1 16:32:22 INFO - mozlog == 3.5 16:32:22 INFO - moznetwork == 0.27 16:32:22 INFO - mozprocess == 0.25 16:32:22 INFO - mozprofile == 0.28 16:32:22 INFO - mozrunner == 6.13 16:32:22 INFO - mozscreenshot == 0.1 16:32:22 INFO - mozsystemmonitor == 0.3 16:32:22 INFO - moztest == 0.8 16:32:22 INFO - mozversion == 1.4 16:32:22 INFO - psutil == 3.1.1 16:32:22 INFO - requests == 1.2.3 16:32:22 INFO - wsgiref == 0.1.2 16:32:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:32: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')]} 16:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32: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')]} 16:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32: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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d9f00>, '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 0x20d4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d5050>, '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': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', '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 16:32: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 16:32: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 16:32:22 INFO - Using env: {'DISPLAY': ':0', 16:32:22 INFO - 'HOME': '/home/cltbld', 16:32:22 INFO - 'LANG': 'en_US.UTF-8', 16:32:22 INFO - 'LANGUAGE': 'en_US:en', 16:32:22 INFO - 'LOGNAME': 'cltbld', 16:32:22 INFO - 'MAIL': '/var/mail/cltbld', 16:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:22 INFO - 'MOZ_NO_REMOTE': '1', 16:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:22 INFO - 'NO_EM_RESTART': '1', 16:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:22 INFO - 'PWD': '/builds/slave/test', 16:32:22 INFO - 'SHELL': '/bin/bash', 16:32:22 INFO - 'SHLVL': '1', 16:32:22 INFO - 'TERM': 'linux', 16:32:22 INFO - 'TMOUT': '86400', 16:32:22 INFO - 'USER': 'cltbld', 16:32:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', 16:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:22 INFO - '_': '/tools/buildbot/bin/python'} 16:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32: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)) 16:32: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)) 16:32: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)) 16:32: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)) 16:32: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)) 16:32: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)) 16:32: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)) 16:32: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)) 16:32: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)) 16:32:22 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:32: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 16:32: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 16:32: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 16:32: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 16:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 16:32:23 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)) 16:32:23 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)) 16:32:23 INFO - Installing collected packages: simplejson 16:32:23 INFO - Running setup.py install for simplejson 16:32:23 INFO - building 'simplejson._speedups' extension 16:32:23 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 16:32:24 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 16:32:24 INFO - Successfully installed simplejson 16:32:24 INFO - Cleaning up... 16:32:24 INFO - Return code: 0 16:32:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:32:24 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')]} 16:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:32:24 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')]} 16:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:32:24 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 0x1d691f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20d6b20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20d9f00>, '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 0x20d4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d5050>, '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': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', '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 16:32:24 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 16:32:24 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 16:32:24 INFO - Using env: {'DISPLAY': ':0', 16:32:24 INFO - 'HOME': '/home/cltbld', 16:32:24 INFO - 'LANG': 'en_US.UTF-8', 16:32:24 INFO - 'LANGUAGE': 'en_US:en', 16:32:24 INFO - 'LOGNAME': 'cltbld', 16:32:24 INFO - 'MAIL': '/var/mail/cltbld', 16:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:24 INFO - 'MOZ_NO_REMOTE': '1', 16:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:24 INFO - 'NO_EM_RESTART': '1', 16:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:24 INFO - 'PWD': '/builds/slave/test', 16:32:24 INFO - 'SHELL': '/bin/bash', 16:32:24 INFO - 'SHLVL': '1', 16:32:24 INFO - 'TERM': 'linux', 16:32:24 INFO - 'TMOUT': '86400', 16:32:24 INFO - 'USER': 'cltbld', 16:32:24 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', 16:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:24 INFO - '_': '/tools/buildbot/bin/python'} 16:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:32:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:32:25 INFO - Cleaning up... 16:32:25 INFO - Return code: 0 16:32:25 INFO - Running post-action listener: _resource_record_post_action 16:32:25 INFO - Running post-action listener: _start_resource_monitoring 16:32:25 INFO - Starting resource monitoring. 16:32:25 INFO - [mozharness: 2017-08-09 23:32:25.184581Z] Finished create-virtualenv step (success) 16:32:25 INFO - [mozharness: 2017-08-09 23:32:25.185102Z] Running install step. 16:32:25 INFO - Running pre-action listener: _resource_record_pre_action 16:32:25 INFO - Running main action method: install 16:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:32:25 INFO - Reading from file tmpfile_stdout 16:32:25 INFO - Detecting whether we're running mozinstall >=1.0... 16:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:32:25 INFO - Reading from file tmpfile_stdout 16:32:25 INFO - Output received: 16:32:25 INFO - Usage: mozinstall [options] installer 16:32:25 INFO - Options: 16:32:25 INFO - -h, --help show this help message and exit 16:32:25 INFO - -d DEST, --destination=DEST 16:32:25 INFO - Directory to install application into. [default: 16:32:25 INFO - "/builds/slave/test"] 16:32:25 INFO - --app=APP Application being installed. [default: firefox] 16:32:25 INFO - mkdir: /builds/slave/test/build/application 16:32: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'] 16:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:32:43 INFO - Reading from file tmpfile_stdout 16:32:43 INFO - Output received: 16:32:43 INFO - /builds/slave/test/build/application/firefox/firefox 16:32:43 INFO - Running post-action listener: _resource_record_post_action 16:32:43 INFO - [mozharness: 2017-08-09 23:32:43.500566Z] Finished install step (success) 16:32:43 INFO - [mozharness: 2017-08-09 23:32:43.500852Z] Running setup-mitmproxy step. 16:32:43 INFO - Running pre-action listener: _resource_record_pre_action 16:32:43 INFO - Running main action method: setup_mitmproxy 16:32:43 INFO - Skipping: mitmproxy is not required 16:32:43 INFO - Running post-action listener: _resource_record_post_action 16:32:43 INFO - [mozharness: 2017-08-09 23:32:43.502075Z] Finished setup-mitmproxy step (success) 16:32:43 INFO - [mozharness: 2017-08-09 23:32:43.502297Z] Running run-tests step. 16:32:43 INFO - Running pre-action listener: _resource_record_pre_action 16:32:43 INFO - Running pre-action listener: _set_gcov_prefix 16:32:43 INFO - Running main action method: run_tests 16:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:43 INFO - Python 2.7.3 16:32:43 INFO - Return code: 0 16:32:43 INFO - grabbing minidump binary from tooltool 16:32: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')]} 16:32: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 0x20d9f00>, '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 0x20d4ba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20d5050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32: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 16:32: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 16:32: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 16:32:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:43 INFO - Return code: 0 16:32:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:32:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:43 INFO - ENV: RUST_BACKTRACE is now full 16:32:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:32:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32: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/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 16:32: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/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 16:32:43 INFO - Using env: {'DISPLAY': ':0', 16:32:43 INFO - 'HOME': '/home/cltbld', 16:32:43 INFO - 'LANG': 'en_US.UTF-8', 16:32:43 INFO - 'LANGUAGE': 'en_US:en', 16:32:43 INFO - 'LOGNAME': 'cltbld', 16:32:43 INFO - 'MAIL': '/var/mail/cltbld', 16:32:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:43 INFO - 'MOZ_NO_REMOTE': '1', 16:32:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:43 INFO - 'NO_EM_RESTART': '1', 16:32:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:43 INFO - 'PWD': '/builds/slave/test', 16:32:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:43 INFO - 'RUST_BACKTRACE': 'full', 16:32:43 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:32:43 INFO - 'SHELL': '/bin/bash', 16:32:43 INFO - 'SHLVL': '1', 16:32:43 INFO - 'STYLO_FORCE_ENABLED': '1', 16:32:43 INFO - 'TERM': 'linux', 16:32:43 INFO - 'TMOUT': '86400', 16:32:43 INFO - 'USER': 'cltbld', 16:32:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115', 16:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:43 INFO - '_': '/tools/buildbot/bin/python'} 16:32: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/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 16:32:43 INFO - mozversion application_buildid: 20170809224807 16:32:43 INFO - mozversion application_changeset: a4a448ba7f187069fce916ee234a06cbb0d06f80 16:32:43 INFO - mozversion application_display_name: Nightly 16:32:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:43 INFO - mozversion application_name: Firefox 16:32:43 INFO - mozversion application_remotingname: firefox 16:32:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:32:43 INFO - mozversion application_vendor: Mozilla 16:32:43 INFO - mozversion application_version: 57.0a1 16:32:43 INFO - mozversion platform_buildid: 20170809224807 16:32:43 INFO - mozversion platform_changeset: a4a448ba7f187069fce916ee234a06cbb0d06f80 16:32:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:32:43 INFO - mozversion platform_version: 57.0a1 16:32:43 INFO - using testdate: 1502321563 16:32:43 INFO - actual date: 1502321563 16:32:43 INFO - starting webserver on 'localhost:44163' 16:32:43 INFO - SUITE-START | Running 2 tests 16:32:43 INFO - TEST-START | dromaeo_css 16:32:43 INFO - Initialising browser for dromaeo_css test... 16:32:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44163/getInfo.html -profile /tmp/tmpXOsu3b/profile 16:32:43 INFO - TEST-INFO | started process 7111 (/builds/slave/test/build/application/firefox/firefox http://localhost:44163/getInfo.html) 16:32:51 INFO - TEST-INFO | 7111: exit 0 16:32:51 INFO - Browser initialized. 16:32:51 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:51 INFO - TEST-INFO | started process 7343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXOsu3b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:52 INFO - PID 7343 | 16:32:52 INFO - PID 7343 | (/builds/slave/test/build/application/firefox/firefox:7397): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:32:52 INFO - PID 7343 | 16:33:02 INFO - PID 7343 | RSS: Main: 174358528 16:33:02 INFO - PID 7343 | 16:36:01 INFO - PID 7343 | Cycle 1(1): loaded http://localhost:44163/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44163/tests/dromaeo/cssquery-ext.html) 16:36:03 INFO - PID 7343 | RSS: Main: 175996928 16:36:03 INFO - PID 7343 | 16:39:05 INFO - PID 7343 | Cycle 1(1): loaded http://localhost:44163/tests/dromaeo/cssquery-ext.html (next: http://localhost:44163/tests/dromaeo/cssquery-jquery.html) 16:39:05 INFO - PID 7343 | RSS: Main: 173318144 16:39:05 INFO - PID 7343 | 16:42:07 INFO - PID 7343 | Cycle 1(1): loaded http://localhost:44163/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44163/tests/dromaeo/cssquery-mootools.html) 16:42:08 INFO - PID 7343 | RSS: Main: 175796224 16:42:08 INFO - PID 7343 | 16:45:09 INFO - PID 7343 | Cycle 1(1): loaded http://localhost:44163/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44163/tests/dromaeo/cssquery-prototype.html) 16:45:10 INFO - PID 7343 | RSS: Main: 173957120 16:45:10 INFO - PID 7343 | 16:48:14 INFO - PID 7343 | Cycle 1(1): loaded http://localhost:44163/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44163/tests/dromaeo/cssquery-yui.html) 16:48:14 INFO - PID 7343 | RSS: Main: 177291264 16:48:14 INFO - PID 7343 | 16:51:16 INFO - PID 7343 | Cycle 1(1): loaded http://localhost:44163/tests/dromaeo/cssquery-yui.html (next: http://localhost:44163/tests/dromaeo/cssquery-dojo.html) 16:51:16 INFO - PID 7343 | RSS: Main: 175816704 16:51:16 INFO - PID 7343 | 16:51:16 INFO - PID 7343 | __start_tp_report 16:51:16 INFO - PID 7343 | _x_x_mozilla_page_load 16:51:16 INFO - PID 7343 | _x_x_mozilla_page_load_details 16:51:16 INFO - PID 7343 | |i|pagename|runs| 16:51:16 INFO - PID 7343 | |0;dojo.html;3111.7666175036866;3133.2636830344873;3137.748980081594;3153.3535625196837;3187.6971687689675;6206.751729930803;6228.096925945741;6311.337309582496;6316.242050953881;6332.556721029529;6161.722722477488;6265.3734626537325;6278.215223097113;6284.780032698845;6357.872842543158;5739.167820666001;5766.423357664242;5781.075027995522;5788.507976821975;5915.615484993462;5816.738246778884;5829;5841.357450680422;5867.677277749722;5873.030949893263;57.42118346343301;5678.034734095172;5733.168690539869;5859.121131830217;5868;5709.371969083398;5711.143328500717;5740.54075673945;5823.912641310384;5832.708364581797;5704.543636509069;5712.828615141552;5784.595078344518;5792.333881603585;5805.970970145122;6081.209442772411;6182.629042257479;6201.0388389799655;6217.067439884054;6264.6241225526155;6641.302663220341;6698.330166983312;6723.865522689519;6795.558288711218;6811.829704257384;6717.764878229238;6774.69513871872;6781.423578995791;6809.625470599115;6838.897416538756;6332.461740752087;6338.429541341301;6340.1440805490665;6346.968265158691;6362.1093046973465;6952.721891124298;7062.329078737512;7065.540739851893;7069.257727938595;7082.150141982995;6630.9336906630315;6636.469082473391;6713.227978782503;6727.831804204934;6742.292059333699;6704.564203326768;6738.528303018839;6782.93217067823;6833.760818371433;6839.521233513607;6624.9337506624315;6719.395254427027;6737.629430381278;6745.325467453314;6798.116244888133;6723.22682891464;6735.259121496631;6754.932450675528;6807.285235050347;6812.897806532906;5426.864328391743;5444;5464.098423760114;5464.644798088111;5503.816679413945;4556.635469162459;4619.86140415788;4623.190941585209;4636.397268355092;4665.2768820832825;5800.8259752207505;5816;5872.17789509469;5901.76392944286;5938.376470470625;6607.2071351438135;6646.501512386591;6647.5679080860555;6663.600183988976;6783.219929708048;5728.369879313273;5769.769209231667;5828;5832.3292821326095;5840.474357307863;5912.674802885883;5930.614510056919;5947.286325640951;6001.789937352171;6006.459418652343;6513.902291465632;6590.044443555754;6601.3728695773825;6603.405693487609;6603.537752357385;6751.864962700718;6761.526693131434;6822.385985261251;6853.691583878837;6858.794236172923;6422.454091402096;6540.280569137486;6547.952327627557;6574.638394888327;6676.732930682719;6608.7026083825385;6679;6681.599104053772;6682.3317668232785;6686.1642294713165;6833.93166068333;6850.828729281808;6872.896906546506;6881.13985751781;6886.070380498769;6565.179352580927;6591.901121483277;6642.83392915181;6658.267590565131;6671.766488172891;6435.324290949383;6566.507511936719;6583.045458408408;6583.473322134122;6651.467882569286;6379.649119298298;6455.741770329322;6465.64438955862;6477.708503117466;6480.967595161994;6412.294647588855;6691.431228345645;6700.6984685688285;6711.664416779239;6738.59568425896;6405.135306733531;6425.646589437439;6503.414692677682;6508.121403610452;6509.446697030616 16:51:16 INFO - PID 7343 | |1;ext.html;802.3982013489882;865.5326123893097;892.5581836990691;892.6964831957138;1183.3905538647593;30408.391832163343;31125.844370778144;40321.798391008044;41670;41917.161656766846;43114.568854311445;43479.3478097828;43489.7825510872;43506.12987740251;43598.782006090005;7766.184550622188;7849.921500785004;8047.597620119;8062.314703250231;8074.798130046766;7841.411894107936;7954.840903181933;7981.561014144219;7982.800429989239;7986.720464783733;7950.801229969239;7974.760757177294;8027.839443211162;8029.919700802976;8041.839163216732;7964.721234756785;7994.840103197962;7998.560079195642;7999.200079992012;7999.40004499662;7852.3325517331095;7913.129555748863;7922.128565857751;7935.166807485189;7941.880871786928;37779.81110094432;37947.81026094852;38067.809660951796;38116.42825357622;38209.61790382089;3556.519869817593;3580.8925732228076;3600.7839529628304;3612.873549425784;3614.2771445710964;31309;31452.685473145204;31474;31568.368632627447;31591.36817263665;5050.974745126287;5057.8229761958155;5058.924116138261;5073.1122053640465;5154.123798954187;196253;196535;196654;196661;197573.01213493984;49825.25262121071;49900.50099498958;49950.75024624926;49958.75020624946;50001.74999124981;52460;52596.73701631468;54119.45880541144;56812.43187568154;56874.7156264216;12955.222686638832;15005.099694018394;15042.774358384633;15048.32282547288;15109.168995705122;10663.200259980378;10693.411862347646;11851.407429628483;12087.307776911239;12099.153059285765;14541.563753087425;14668.339924703414;14692.191929443983;14701.191434471206;14842.925785371004;5681;5749.13762935563;5795.913061304083;5970.194023806817;5982.760689572456;989.2679417231197;1021.4637315409469;1022.4632068164274;1025.8102251083424;1036.6423583863555;23110.07559697627;23967.52064958691;28820.711792882223;29837.552436713468;30150.69849301523;1085.5983286184162;1101.6529793115144;1104.6133853151332;1110.3116068037868;1121.2095472691733;12671.732826717254;12672.936635316764;12707;12831.743365132832;12877.806832897513;225050;235270;235877;236259;236364.81817590803;53005;53229.2015619766;53479;53483.19775203375;53600;1446.2118145610668;1485.094092603511;1499.3627708223962;1501.7221813964452;1505.0593379138038;22753.658695119255;22758.317250482512;22783;22929.54140917139;22937.70622937693;38671.22657546777;38812.80593597127;39027;39043;39114.82655520339;203143;203939;204286;204746;204790;34339.65660343364;36804.81597592102;38849.80575097106;38852.41721374238;39031.804840975616;46001.53998459972;47631.28553071638;47713;47829.76085119552;48313.516864830905;34762.82618586891;34795.130121747155;34845.47731784076;34953.65046349504;35133.472997904544;34203.14492137716;34316;34375.31249375048;34649.82675086609;34946.126346841535;37342.8132859334;37726.811365942995;37798.81100594479;37893.81053094717;38013.23973520459;33519.83240083784;34524.13689657779;34554.13614659654;34755.652443476254;34845.12887177841;23690.28929132129;24589.50820983606;24665;25566.233013009638;25772.09797657073 16:51:16 INFO - PID 7343 | |2;jquery.html;578.1328007988018;588.579165896384;591.7278052096036;604.2537067873844;616.1035693066588;22008.239340852735;22106.447338816517;22915.31254062379;22928;23108.768912310872;24694;26376.736232637668;26556.33609159772;26596.867015664942;26610.73389266107;6419.743210271584;6556.93443065568;6573.638449885254;6582.078509008743;6586;5920.851978700523;6404.3595640435815;6462.644554549498;6471.611703297817;6513.478921686254;6471.4175724184815;6478.514111441637;6479.708413121397;6485.092087107809;6487.286398496161;6421;6459.61242325462;6482.092507049017;6485.319041500646;6493.577917435376;6033.577649564532;6044.063170208625;6054;6066.120412540157;6066.878662426727;29470.263243419085;30355.544666830014;30825.383492330253;30865.845670771727;31285.37429251425;1957.275807951053;1993.5913137806715;1996.3511858645998;1996.9301074462323;1997.2909617086016;19331.61336773271;20027.399178024683;20045.699314510293;20050.699239511418;20070.197192112297;2302.34383200787;2349.3304408243566;2383.165891937825;2387.6299173628117;2403.3390817525146;131083;134223;134391.32804336015;134462.3276883619;134669.3266533661;14568.271586420637;14575.271236438348;14952.32714527827;15259.542213733384;15333.923330383277;24330.513389732107;24334.878325608614;24385;24570.508589828103;24588.385290367885;9435;9596.76008099803;9751.90248097524;9861.901380986243;9900.851487227697;8806.515641639644;8821.60302786376;8897;9005.594748236344;9039.502827344559;7856.882146767803;11485.621725392839;11558.768824623461;11572.76854462906;11891.345975971404;3555.799780197791;3806.7715937043868;3861.2663593917628;4058.6753059755147;4106.870610582114;927.2072378116748;931.8788557487619;958.769895225141;960.3757557587624;963.5182408795603;19152.23391064342;19215;19531.121099550553;19644.821310721403;19650.508737281398;1003.603576587244;1032.7573020340214;1035.3529044347283;1039.6101461951769;1047.8271085270844;10963.40537733221;11110.777784444428;11123.27698699582;11168;11206.38364889939;464538;471603;472781;477345;501020;109177.45411273051;109287;111397;113334.86665133243;113934.43032784783;1196.7546652936128;1219.6889793102703;1225.081189108169;1225.7732319520917;1230.1081715755827;16744.162791860115;17387.304507819546;17460.73808892842;17569.50659193983;17610;55053;55747.442525574224;55979.72010139923;57717;57837;68781;69166.27084322931;69426.65286673534;69710;70632;20424.897875510527;20590.382288531368;20593.691094633894;20751.481212969797;20792.48018799542;22969.540609188058;23022.539549209258;23385.88307058454;23430.17994370189;23457.41356466102;18129.728054078936;18473.630527389647;18504.537386564905;18642.906785465984;18715.344962926778;16123.274452649424;16834.326626934784;17190.828091718922;17403.7389439156;17613.735793962845;18820.435386938414;19165.61668766589;19221.711674324615;20311.695324569846;20387;14807.333669985092;15073.849261507245;15105.32026058852;15150.924245378703;15231.466898658493;17302.480925572254;17957.551061223574;18160;18858.71711924295;18946.43160705181 16:51:16 INFO - PID 7343 | |3;mootools.html;1331.2145833957964;1371.8765311121997;1386.0851837787063;1397.7553928062594;1398.615380770288;13659.726805463884;13946.930265348685;14340.856591434083;14341.498047568337;14359.569212923616;13713.657158571015;14704.779428308584;14739.852601473982;14777.187254700988;14782.482613108543;2713.579395193743;2776.8889244430197;2777.5555911054234;2778.763805076571;2779.332960089574;2604.5181641396402;2684.543627583306;2724.4551089782026;2738.835669859815;2770.1827960751625;2724.931876703088;2754.0223220756643;2754.449110177972;2755.3800394911186;2755.917322480319;2658.1493921944984;2680.8793604287853;2690.5829596412586;2690.9058182963504;2695.541757901152;2633.1968749531384;2644.867756612181;2648.7218842021502;2653.283613424384;2654.6548948636746;13702.588922332247;14000;14093.295335233197;14095.71808563823;14122.152670839783;7514.39884809214;7747.767566972943;7791.337736292422;7796.298333149987;7798.259165379337;5206.0368831766245;5322.547583455373;5385.7576409061685;5401.378841433247;5465.043617366945;1893.6496748101645;1921.778995415517;1924.0572119661265;1928.4503916383903;1964.6856502959602;22671.433214169778;22946.541069178522;23143.652845207336;23169.304920852403;23236.41908952273;6720.7647732330115;7134.429245660334;7185.964070179615;7358.431160886966;7472;15808.52574422769;15941.282642281125;16129.677406451805;16131.435399760952;16146.67706645884;7501.887471687929;7709.614519274014;7749.496282741717;7753.069631644239;7753.224677532202;7040.718371265092;7094.92905070953;7133.108361454818;7191.460640451987;7249.673764680602;5027.944131732377;5184.637075404761;5208.0365132450615;5215.400228973716;5230.790768369298;1314.2246074815905;1356.8371795384617;1444.162385816224;1499.3552772307794;1507.4271776724775;891.4918496457087;919.4850883505259;923.6028507741736;924.893637231727;938.0525669074284;7864.606769661494;8262.256396924306;8301.086880443147;8688;9071.863922041042;992.5979978108877;1004.6433516101824;1016.2885979814159;1017.0998666180336;1029.1972261635935;5256.789728410898;5305.549028332558;5328.120860058125;5383.596230282745;5412.621116521885;18442.815571844378;19187.656864019384;19506;19833.801661983485;19861.503462413268;19432.902835486017;19449.611007780048;19613.803861961198;19692.212311507665;19808;10316.638917637847;10501.369917804956;10635.52140153695;10974.99999999984;11053.115750739922;7729.111152217567;8022.759317220492;8197.139300373614;8214.301784348398;8299.792505187419;16696.66606667884;16907.492775216764;16953.91523042377;17396.565085872953;17419.39032133869;17405.21676524585;17696.380626678005;17720.556986074935;17788.288468461633;18121.36575219861;10516.211284153873;10829.350238985371;10833.945830270799;10838.67483975482;10855.565777368816;12847.164934279243;13224.20654760679;13313.400896959467;13326.267055312052;13347.19916804956;10923.672289831318;10993.560257589606;11003.284786488852;11049.116070714163;11266.098712103176;10188.91127318883;10465.110465610509;10494.21293403013;10531.736706582396;10808.729781755519;9126.17864392208;9175.44947303164;9190.080991900757;9206.17144457002;9251.722448326562;6697.665116744046;6725.29384414649;6810.148731408574;6832.795016149524;6870.7595234166565;6832.453403727591;6866.725330986905;6877.58734475933;6909.585424874524;7063.364297213276 16:51:16 INFO - PID 7343 | |4;prototype.html;513.5993924738705;516.460298987558;521.1687358662932;535.8312131678518;543.2801537962201;6118.632882027082;6171.691415429233;6174.691265436727;6214.875702485948;6255.218097737783;6133.068083553678;6148.938510614893;6151.907721384172;6163.322034576193;6193.535484838632;5070.771815268304;5072.3405957225505;5086.5676417504465;5090.796368145269;5143.4599367066485;4808.158572249842;4869.196582563873;5056.494350564951;5057.140286151344;5103.183490641498;4860.513948605147;4864.46490886004;4871.220604703248;4914.058946716063;4952.628552858532;4904.337914381548;4910.533499317559;4939.394696723579;4940.604751619898;4941.158833670635;4263.850765223202;4406.911861762779;4452.732836029816;4456.910861782779;4463.330500424962;5847.619904706223;5872.765089396419;5947.6431414115295;5949.553783466214;6006.459418652343;5600.411956744565;5607.43925607436;5612.887742245132;5700.2589663343915;5728.971355143198;6509.6419696916655;6527.706253218616;6541.771038013647;6549.1209049258605;6556.393683547513;4770.7376094314795;4833.4441539222735;4850.199717046683;4877.097736918646;4898.142825005645;6447.484201263887;6639.468842492589;6669.566478178903;6744.763933262312;6842.828929276759;4845.2732090186755;4973;4992.950070499322;5003.849884503471;5022.949770502321;5043.420006699203;5047.97476012625;5065.7720402581235;5094.566961808214;5117.518003768169;5661.631993920382;5685.204071430003;5687.630304030225;5695.658260504383;5697.401772813795;6551.181102362205;6562.376574225441;6563.573367731082;6583.967080164569;6599.8020059398295;1762.97355539667;1771.4862689819809;1773.7782777152856;1781.4388467632655;1789.5257756694486;1184.579474286633;1204.4519743516678;1214.7145420826098;1224.0758227538151;1243.359669770069;5708.942910570924;5738.110592858114;5749.310082790092;5765.88468230633;5815.709214539256;6584.604923704593;6686.398224159849;6704.530682852153;6706.664666766642;6759.681862036856;5722.7424765885635;5747.505648531412;5772;5785.768569257267;5798.33319168301;3487.7035451986358;3526.4357702767434;3556.893293201208;3574.7488379067117;3591.2278860044694;6418.807435776934;6450.387213214737;6477.255115661665;6496.285408605049;6504.479641628658;6778.559393639398;6795.490338224653;6806.013128096398;6827.590344579242;6842.315768423118;6387.774174042172;6407.9562207951785;6411.6473593953715;6412.487001039813;6501.349865013555;6527.602949109804;6589.769358072444;6592.274849766618;6614.173228346457;6616.801495955129;5988.28140623128;6599.868002640016;6611.371919667624;6629.7348106075215;6651.235107962646;6349.396807303298;6367.586106903036;6395.456386207225;6452.290248072614;6469.45009674183;4963.131451995959;4971.950280497149;4980.203167493184;4989.900201995867;5012.573931215888;6308.33762454954;6398.200224971879;6563.3764792344655;6701.597904125768;6784.626845523544;6409.519286053472;6411.5832470889245;6438.29178790342;6450.258220304538;6451.1290975717675;6354.809355719336;6393.744250230125;6430.807075787734;6449.258335291502;6494.253160886558;6326.683665816783;6353.205849268841;6360.968195158995;6373.808785736435;6417.71120299597;6473.8705225896165;6551.672416379257;6554.868902621825;6566.484153311241;6577.6053436793945;6228.0969259456215;6257.4994000480765;6276.309605943434;6331.588446750947;6369.471326881608 16:51:16 INFO - PID 7343 | |5;yui.html;877.2762470961454;892.2460520859873;914.9817003659931;919.1819280840049;926.7636752628081;18904.24383024679;19819.801801981994;19928.50178745532;19946;19989.100490477944;17470.126493675296;17506.824931750678;17834.019128947904;22146;22191.889040554815;1031.1647565471953;1059.6609085092773;1061.8354155105972;1062.3678911047953;1062.9255952083358;1062.0282441565957;1068.9037986581206;1069.5400977579638;1069.8341757027674;1072.6835583502846;1003.8092762375162;1059.1897198643044;1090.6782499162766;1091.2143256855052;1120.56298043763;1088.5754555723195;1089.9346039237632;1090.5910283643634;1091.3997301484153;1093.3549205968477;784.1766145547209;785.8664027115404;787.9133295337508;789.1477204618998;790.746960972489;20179.798202017937;20261.088251028737;20401.183952641877;20595;20799.792002079936;21324.89337553318;21963.23128690488;22574.548509029726;22971.540569188688;22990.310290691305;17070.743938840926;17124.828751712448;17251;17317.7402338965;17506.824931750645;3644.325799727059;3702.4631428442995;3703.962960370389;3704.2961837251105;3704.555453345589;121449;122297;123092;123793;126805.36597317047;16834.831651683326;17247;17305;17438.651226975642;17484.737728934077;30963.380732385227;31309.843450783057;31332.843335783175;31867.840660796548;32319.35361292761;8162.3878209134555;8282.296004839656;8298.879651247125;8302.70940517079;8309.584520773937;3826.6364695353896;3860.536735591747;3884.533855937306;3974.940375894364;3988.3818008208773;5408.215808707715;5486.725663716798;5494.615376923657;5521.861953451115;5544.362398324244;941.1247539787926;958.769895225141;969.6121551379505;976.4336684722844;976.9951150244345;669.5313280703527;671.5769065488711;675.5242037930929;695.6313154028373;697.435077587156;11588.826167607493;11590.884091159149;11713.648590542298;12432.254064756144;12601.747965040648;698.6995591895433;702;703.1351437731619;717.8671945690064;723.5043994863536;5531.585131115183;5601.047821870292;5603.7478313475995;5618.297712785902;5770.2498675171955;113808.43095784468;114930.42534787272;115831.42084289524;116093;116403;94467.52766236124;95976;97537;97830.5108474453;98921;86475.56762216148;86759;87677.56161219154;88030;89059;11123.666290011313;11263.49314280843;11366.318020918772;11443.25618834773;11458.484368203617;38783;38797;39043.2191356177;39051.80474097611;40623;50265.24602131044;51284;71533.64233179009;72183.63908180426;72411.27588724045;19274;19303.613927721086;19602.215911363386;19700.802991969897;19814.90092549528;18702.625947481247;18838.717419238998;21331.57336853223;21348.252811151535;21405;16188;18882.905585471985;19443.611127777083;19596.60806783828;19633.509162271057;19426.875693174912;20042.298519551747;20187.192512299345;20259.69610455815;20356.28752993638;17840.732389013916;18094.5476363092;18197.45407637773;18777;18814.811851881852;14081.647958801112;14452.927735361256;14505.709885802014;14587.197704126374;14820.481283155037;14002.649933751738;14040.368183431567;14147.151170929777;14752.704945901236;15688.215589220721 16:51:16 INFO - PID 7343 | __end_tp_report 16:51:16 INFO - PID 7343 | __start_cc_report 16:51:16 INFO - PID 7343 | _x_x_mozilla_cycle_collect,386 16:51:16 INFO - PID 7343 | __end_cc_report 16:51:16 INFO - PID 7343 | __startTimestamp1502322676786__endTimestamp 16:51:16 INFO - PID 7343 | 16:51:16 INFO - PID 7343 | ------- Summary: start ------- 16:51:16 INFO - PID 7343 | Number of tests: 6 16:51:16 INFO - PID 7343 | 16:51:16 INFO - PID 7343 | [#0] dojo.html Cycles:165 Average:6187.16 Median:6465.64 stddev:888.13 (13.7%) stddev-sans-first:857.46 16:51:16 INFO - PID 7343 | Values: 3111.8 3133.3 3137.7 3153.4 3187.7 6206.8 6228.1 6311.3 6316.2 6332.6 6161.7 6265.4 6278.2 6284.8 6357.9 5739.2 5766.4 5781.1 5788.5 5915.6 5816.7 5829.0 5841.4 5867.7 5873.0 57.4 5678.0 5733.2 5859.1 5868.0 5709.4 5711.1 5740.5 5823.9 5832.7 5704.5 5712.8 5784.6 5792.3 5806.0 6081.2 6182.6 6201.0 6217.1 6264.6 6641.3 6698.3 6723.9 6795.6 6811.8 6717.8 6774.7 6781.4 6809.6 6838.9 6332.5 6338.4 6340.1 6347.0 6362.1 6952.7 7062.3 7065.5 7069.3 7082.2 6630.9 6636.5 6713.2 6727.8 6742.3 6704.6 6738.5 6782.9 6833.8 6839.5 6624.9 6719.4 6737.6 6745.3 6798.1 6723.2 6735.3 6754.9 6807.3 6812.9 5426.9 5444.0 5464.1 5464.6 5503.8 4556.6 4619.9 4623.2 4636.4 4665.3 5800.8 5816.0 5872.2 5901.8 5938.4 6607.2 6646.5 6647.6 6663.6 6783.2 5728.4 5769.8 5828.0 5832.3 5840.5 5912.7 5930.6 5947.3 6001.8 6006.5 6513.9 6590.0 6601.4 6603.4 6603.5 6751.9 6761.5 6822.4 6853.7 6858.8 6422.5 6540.3 6548.0 6574.6 6676.7 6608.7 6679.0 6681.6 6682.3 6686.2 6833.9 6850.8 6872.9 6881.1 6886.1 6565.2 6591.9 6642.8 6658.3 6671.8 6435.3 6566.5 6583.0 6583.5 6651.5 6379.6 6455.7 6465.6 6477.7 6481.0 6412.3 6691.4 6700.7 6711.7 6738.6 6405.1 6425.6 6503.4 6508.1 6509.4 16:51:16 INFO - PID 7343 | 16:51:16 INFO - PID 7343 | [#1] ext.html Cycles:180 Average:38762.55 Median:3606.83 stddev:54984.15 (1524.4%) stddev-sans-first:55064.52 16:51:16 INFO - PID 7343 | Values: 802.4 865.5 892.6 892.7 1183.4 30408.4 31125.8 40321.8 41670.0 41917.2 43114.6 43479.3 43489.8 43506.1 43598.8 7766.2 7849.9 8047.6 8062.3 8074.8 7841.4 7954.8 7981.6 7982.8 7986.7 7950.8 7974.8 8027.8 8029.9 8041.8 7964.7 7994.8 7998.6 7999.2 7999.4 7852.3 7913.1 7922.1 7935.2 7941.9 37779.8 37947.8 38067.8 38116.4 38209.6 3556.5 3580.9 3600.8 3612.9 3614.3 31309.0 31452.7 31474.0 31568.4 31591.4 5051.0 5057.8 5058.9 5073.1 5154.1 196253.0 196535.0 196654.0 196661.0 197573.0 49825.3 49900.5 49950.8 49958.8 50001.7 52460.0 52596.7 54119.5 56812.4 56874.7 12955.2 15005.1 15042.8 15048.3 15109.2 10663.2 10693.4 11851.4 12087.3 12099.2 14541.6 14668.3 14692.2 14701.2 14842.9 5681.0 5749.1 5795.9 5970.2 5982.8 989.3 1021.5 1022.5 1025.8 1036.6 23110.1 23967.5 28820.7 29837.6 30150.7 1085.6 1101.7 1104.6 1110.3 1121.2 12671.7 12672.9 12707.0 12831.7 12877.8 225050.0 235270.0 235877.0 236259.0 236364.8 53005.0 53229.2 53479.0 53483.2 53600.0 1446.2 1485.1 1499.4 1501.7 1505.1 22753.7 22758.3 22783.0 22929.5 22937.7 38671.2 38812.8 39027.0 39043.0 39114.8 203143.0 203939.0 204286.0 204746.0 204790.0 34339.7 36804.8 38849.8 38852.4 39031.8 46001.5 47631.3 47713.0 47829.8 48313.5 34762.8 34795.1 34845.5 34953.7 35133.5 34203.1 34316.0 34375.3 34649.8 34946.1 37342.8 37726.8 37798.8 37893.8 38013.2 33519.8 34524.1 34554.1 34755.7 34845.1 23690.3 24589.5 24665.0 25566.2 25772.1 16:51:16 INFO - PID 7343 | 16:51:16 INFO - PID 7343 | [#2] jquery.html Cycles:180 Average:34470.16 Median:23065.65 stddev:80311.54 (348.2%) stddev-sans-first:80496.52 16:51:16 INFO - PID 7343 | Values: 578.1 588.6 591.7 604.3 616.1 22008.2 22106.4 22915.3 22928.0 23108.8 24694.0 26376.7 26556.3 26596.9 26610.7 6419.7 6556.9 6573.6 6582.1 6586.0 5920.9 6404.4 6462.6 6471.6 6513.5 6471.4 6478.5 6479.7 6485.1 6487.3 6421.0 6459.6 6482.1 6485.3 6493.6 6033.6 6044.1 6054.0 6066.1 6066.9 29470.3 30355.5 30825.4 30865.8 31285.4 1957.3 1993.6 1996.4 1996.9 1997.3 19331.6 20027.4 20045.7 20050.7 20070.2 2302.3 2349.3 2383.2 2387.6 2403.3 131083.0 134223.0 134391.3 134462.3 134669.3 14568.3 14575.3 14952.3 15259.5 15333.9 24330.5 24334.9 24385.0 24570.5 24588.4 9435.0 9596.8 9751.9 9861.9 9900.9 8806.5 8821.6 8897.0 9005.6 9039.5 7856.9 11485.6 11558.8 11572.8 11891.3 3555.8 3806.8 3861.3 4058.7 4106.9 927.2 931.9 958.8 960.4 963.5 19152.2 19215.0 19531.1 19644.8 19650.5 1003.6 1032.8 1035.4 1039.6 1047.8 10963.4 11110.8 11123.3 11168.0 11206.4 464538.0 471603.0 472781.0 477345.0 501020.0 109177.5 109287.0 111397.0 113334.9 113934.4 1196.8 1219.7 1225.1 1225.8 1230.1 16744.2 17387.3 17460.7 17569.5 17610.0 55053.0 55747.4 55979.7 57717.0 57837.0 68781.0 69166.3 69426.7 69710.0 70632.0 20424.9 20590.4 20593.7 20751.5 20792.5 22969.5 23022.5 23385.9 23430.2 23457.4 18129.7 18473.6 18504.5 18642.9 18715.3 16123.3 16834.3 17190.8 17403.7 17613.7 18820.4 19165.6 19221.7 20311.7 20387.0 14807.3 15073.8 15105.3 15150.9 15231.5 17302.5 17957.6 18160.0 18858.7 18946.4 16:51:16 INFO - PID 7343 | 16:51:16 INFO - PID 7343 | [#3] mootools.html Cycles:180 Average:8805.21 Median:2639.03 stddev:5966.50 (226.1%) stddev-sans-first:5956.80 16:51:16 INFO - PID 7343 | Values: 1331.2 1371.9 1386.1 1397.8 1398.6 13659.7 13946.9 14340.9 14341.5 14359.6 13713.7 14704.8 14739.9 14777.2 14782.5 2713.6 2776.9 2777.6 2778.8 2779.3 2604.5 2684.5 2724.5 2738.8 2770.2 2724.9 2754.0 2754.4 2755.4 2755.9 2658.1 2680.9 2690.6 2690.9 2695.5 2633.2 2644.9 2648.7 2653.3 2654.7 13702.6 14000.0 14093.3 14095.7 14122.2 7514.4 7747.8 7791.3 7796.3 7798.3 5206.0 5322.5 5385.8 5401.4 5465.0 1893.6 1921.8 1924.1 1928.5 1964.7 22671.4 22946.5 23143.7 23169.3 23236.4 6720.8 7134.4 7186.0 7358.4 7472.0 15808.5 15941.3 16129.7 16131.4 16146.7 7501.9 7709.6 7749.5 7753.1 7753.2 7040.7 7094.9 7133.1 7191.5 7249.7 5027.9 5184.6 5208.0 5215.4 5230.8 1314.2 1356.8 1444.2 1499.4 1507.4 891.5 919.5 923.6 924.9 938.1 7864.6 8262.3 8301.1 8688.0 9071.9 992.6 1004.6 1016.3 1017.1 1029.2 5256.8 5305.5 5328.1 5383.6 5412.6 18442.8 19187.7 19506.0 19833.8 19861.5 19432.9 19449.6 19613.8 19692.2 19808.0 10316.6 10501.4 10635.5 10975.0 11053.1 7729.1 8022.8 8197.1 8214.3 8299.8 16696.7 16907.5 16953.9 17396.6 17419.4 17405.2 17696.4 17720.6 17788.3 18121.4 10516.2 10829.4 10833.9 10838.7 10855.6 12847.2 13224.2 13313.4 13326.3 13347.2 10923.7 10993.6 11003.3 11049.1 11266.1 10188.9 10465.1 10494.2 10531.7 10808.7 9126.2 9175.4 9190.1 9206.2 9251.7 6697.7 6725.3 6810.1 6832.8 6870.8 6832.5 6866.7 6877.6 6909.6 7063.4 16:51:16 INFO - PID 7343 | 16:51:16 INFO - PID 7343 | [#4] prototype.html Cycles:180 Average:5462.05 Median:6062.55 stddev:1517.91 (25.0%) stddev-sans-first:1476.03 16:51:16 INFO - PID 7343 | Values: 513.6 516.5 521.2 535.8 543.3 6118.6 6171.7 6174.7 6214.9 6255.2 6133.1 6148.9 6151.9 6163.3 6193.5 5070.8 5072.3 5086.6 5090.8 5143.5 4808.2 4869.2 5056.5 5057.1 5103.2 4860.5 4864.5 4871.2 4914.1 4952.6 4904.3 4910.5 4939.4 4940.6 4941.2 4263.9 4406.9 4452.7 4456.9 4463.3 5847.6 5872.8 5947.6 5949.6 6006.5 5600.4 5607.4 5612.9 5700.3 5729.0 6509.6 6527.7 6541.8 6549.1 6556.4 4770.7 4833.4 4850.2 4877.1 4898.1 6447.5 6639.5 6669.6 6744.8 6842.8 4845.3 4973.0 4993.0 5003.8 5022.9 5043.4 5048.0 5065.8 5094.6 5117.5 5661.6 5685.2 5687.6 5695.7 5697.4 6551.2 6562.4 6563.6 6584.0 6599.8 1763.0 1771.5 1773.8 1781.4 1789.5 1184.6 1204.5 1214.7 1224.1 1243.4 5708.9 5738.1 5749.3 5765.9 5815.7 6584.6 6686.4 6704.5 6706.7 6759.7 5722.7 5747.5 5772.0 5785.8 5798.3 3487.7 3526.4 3556.9 3574.7 3591.2 6418.8 6450.4 6477.3 6496.3 6504.5 6778.6 6795.5 6806.0 6827.6 6842.3 6387.8 6408.0 6411.6 6412.5 6501.3 6527.6 6589.8 6592.3 6614.2 6616.8 5988.3 6599.9 6611.4 6629.7 6651.2 6349.4 6367.6 6395.5 6452.3 6469.5 4963.1 4972.0 4980.2 4989.9 5012.6 6308.3 6398.2 6563.4 6701.6 6784.6 6409.5 6411.6 6438.3 6450.3 6451.1 6354.8 6393.7 6430.8 6449.3 6494.3 6326.7 6353.2 6361.0 6373.8 6417.7 6473.9 6551.7 6554.9 6566.5 6577.6 6228.1 6257.5 6276.3 6331.6 6369.5 16:51:16 INFO - PID 7343 | 16:51:16 INFO - PID 7343 | [#5] yui.html Cycles:180 Average:23859.59 Median:20308.69 stddev:32093.68 (158.0%) stddev-sans-first:32137.31 16:51:16 INFO - PID 7343 | Values: 877.3 892.2 915.0 919.2 926.8 18904.2 19819.8 19928.5 19946.0 19989.1 17470.1 17506.8 17834.0 22146.0 22191.9 1031.2 1059.7 1061.8 1062.4 1062.9 1062.0 1068.9 1069.5 1069.8 1072.7 1003.8 1059.2 1090.7 1091.2 1120.6 1088.6 1089.9 1090.6 1091.4 1093.4 784.2 785.9 787.9 789.1 790.7 20179.8 20261.1 20401.2 20595.0 20799.8 21324.9 21963.2 22574.5 22971.5 22990.3 17070.7 17124.8 17251.0 17317.7 17506.8 3644.3 3702.5 3704.0 3704.3 3704.6 121449.0 122297.0 123092.0 123793.0 126805.4 16834.8 17247.0 17305.0 17438.7 17484.7 30963.4 31309.8 31332.8 31867.8 32319.4 8162.4 8282.3 8298.9 8302.7 8309.6 3826.6 3860.5 3884.5 3974.9 3988.4 5408.2 5486.7 5494.6 5521.9 5544.4 941.1 958.8 969.6 976.4 977.0 669.5 671.6 675.5 695.6 697.4 11588.8 11590.9 11713.6 12432.3 12601.7 698.7 702.0 703.1 717.9 723.5 5531.6 5601.0 5603.7 5618.3 5770.2 113808.4 114930.4 115831.4 116093.0 116403.0 94467.5 95976.0 97537.0 97830.5 98921.0 86475.6 86759.0 87677.6 88030.0 89059.0 11123.7 11263.5 11366.3 11443.3 11458.5 38783.0 38797.0 39043.2 39051.8 40623.0 50265.2 51284.0 71533.6 72183.6 72411.3 19274.0 19303.6 19602.2 19700.8 19814.9 18702.6 18838.7 21331.6 21348.3 21405.0 16188.0 18882.9 19443.6 19596.6 19633.5 19426.9 20042.3 20187.2 20259.7 20356.3 17840.7 18094.5 18197.5 18777.0 18814.8 14081.6 14452.9 14505.7 14587.2 14820.5 14002.6 14040.4 14147.2 14752.7 15688.2 16:51:16 INFO - PID 7343 | -------- Summary: end -------- 16:51:16 INFO - PID 7343 | 16:51:17 INFO - TEST-INFO | 7343: exit 0 16:51:17 INFO - TEST-OK | dromaeo_css | took 1113720ms 16:51:17 INFO - TEST-START | kraken 16:51:17 INFO - Initialising browser for kraken test... 16:51:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44163/getInfo.html -profile /tmp/tmpPNQpSf/profile 16:51:17 INFO - TEST-INFO | started process 7720 (/builds/slave/test/build/application/firefox/firefox http://localhost:44163/getInfo.html) 16:51:24 INFO - TEST-INFO | 7720: exit 0 16:51:24 INFO - Browser initialized. 16:51:24 INFO - Running cycle 1/1 for kraken test... 16:51:24 INFO - TEST-INFO | started process 7951 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNQpSf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:25 INFO - PID 7951 | 16:51:25 INFO - PID 7951 | (/builds/slave/test/build/application/firefox/firefox:8005): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 16:51:25 INFO - PID 7951 | 16:51:35 INFO - PID 7951 | RSS: Main: 170991616 16:51:35 INFO - PID 7951 | 16:51:38 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44163/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:39 INFO - PID 7951 | RSS: Main: 175788032 16:51:39 INFO - PID 7951 | 16:51:42 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44163/tests/kraken/driver.html?testName=audio-dft) 16:51:42 INFO - PID 7951 | RSS: Main: 175816704 16:51:42 INFO - PID 7951 | 16:51:45 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44163/tests/kraken/driver.html?testName=audio-fft) 16:51:46 INFO - PID 7951 | RSS: Main: 171081728 16:51:46 INFO - PID 7951 | 16:51:48 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44163/tests/kraken/driver.html?testName=audio-oscillator) 16:51:49 INFO - PID 7951 | RSS: Main: 171589632 16:51:49 INFO - PID 7951 | 16:51:51 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44163/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:52 INFO - PID 7951 | RSS: Main: 171679744 16:51:52 INFO - PID 7951 | 16:51:55 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44163/tests/kraken/driver.html?testName=imaging-darkroom) 16:51:55 INFO - PID 7951 | RSS: Main: 174333952 16:51:55 INFO - PID 7951 | 16:51:59 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44163/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:59 INFO - PID 7951 | RSS: Main: 174112768 16:51:59 INFO - PID 7951 | 16:52:02 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44163/tests/kraken/driver.html?testName=json-parse-financial) 16:52:03 INFO - PID 7951 | RSS: Main: 174161920 16:52:03 INFO - PID 7951 | 16:52:05 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44163/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:52:05 INFO - PID 7951 | RSS: Main: 174477312 16:52:05 INFO - PID 7951 | 16:52:07 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44163/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:52:08 INFO - PID 7951 | RSS: Main: 174317568 16:52:08 INFO - PID 7951 | 16:52:10 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44163/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:52:11 INFO - PID 7951 | RSS: Main: 174501888 16:52:11 INFO - PID 7951 | 16:52:13 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:52:14 INFO - PID 7951 | RSS: Main: 174944256 16:52:14 INFO - PID 7951 | 16:52:17 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:52:18 INFO - PID 7951 | RSS: Main: 174915584 16:52:18 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | Cycle 1(1): loaded http://localhost:44163/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44163/tests/kraken/driver.html?testName=ai-astar) 16:52:20 INFO - PID 7951 | RSS: Main: 176451584 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | __start_tp_report 16:52:20 INFO - PID 7951 | _x_x_mozilla_page_load 16:52:20 INFO - PID 7951 | _x_x_mozilla_page_load_details 16:52:20 INFO - PID 7951 | |i|pagename|runs| 16:52:20 INFO - PID 7951 | |0;ai-astar;104;113;101;108;114;112;107;99;109;110 16:52:20 INFO - PID 7951 | |1;audio-beat-detection;150;123;152;167;125;150;150;129;175;125 16:52:20 INFO - PID 7951 | |2;audio-dft;163;165;166;163;170;164;174;163;162;163 16:52:20 INFO - PID 7951 | |3;audio-fft;74;75;76;172;79;78;78;74;156;76 16:52:20 INFO - PID 7951 | |4;audio-oscillator;83;79;136;79;86;78;127;78;80;137 16:52:20 INFO - PID 7951 | |5;imaging-gaussian-blur;122;114;114;115;119;114;113;118;115;115 16:52:20 INFO - PID 7951 | |6;imaging-darkroom;152;151;150;152;152;152;150;152;151;151 16:52:20 INFO - PID 7951 | |7;imaging-desaturate;94;95;94;94;95;96;95;95;99;97 16:52:20 INFO - PID 7951 | |8;json-parse-financial;57;58;60;55;56;54;55;61;61;59 16:52:20 INFO - PID 7951 | |9;json-stringify-tinderbox;54;54;54;55;59;60;58;54;54;55 16:52:20 INFO - PID 7951 | |10;stanford-crypto-aes;79;86;79;82;78;88;86;78;76;78 16:52:20 INFO - PID 7951 | |11;stanford-crypto-ccm;146;129;131;125;126;130;142;141;121;177 16:52:20 INFO - PID 7951 | |12;stanford-crypto-pbkdf2;192;179;181;182;181;184;177;188;180;183 16:52:20 INFO - PID 7951 | |13;stanford-crypto-sha256-iterative;67;69;64;72;69;68;66;65;72;71 16:52:20 INFO - PID 7951 | __end_tp_report 16:52:20 INFO - PID 7951 | __start_cc_report 16:52:20 INFO - PID 7951 | _x_x_mozilla_cycle_collect,946 16:52:20 INFO - PID 7951 | __end_cc_report 16:52:20 INFO - PID 7951 | __startTimestamp1502322740628__endTimestamp 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | ------- Summary: start ------- 16:52:20 INFO - PID 7951 | Number of tests: 14 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#0] ai-astar Cycles:10 Average:107.70 Median:111.00 stddev:5.03 (4.5%) stddev-sans-first:5.16 16:52:20 INFO - PID 7951 | Values: 104.0 113.0 101.0 108.0 114.0 112.0 107.0 99.0 109.0 110.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:150.00 stddev:18.40 (12.3%) stddev-sans-first:19.41 16:52:20 INFO - PID 7951 | Values: 150.0 123.0 152.0 167.0 125.0 150.0 150.0 129.0 175.0 125.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:3.83 (2.3%) stddev-sans-first:3.97 16:52:20 INFO - PID 7951 | Values: 163.0 165.0 166.0 163.0 170.0 164.0 174.0 163.0 162.0 163.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:37.23 (49.0%) stddev-sans-first:38.79 16:52:20 INFO - PID 7951 | Values: 74.0 75.0 76.0 172.0 79.0 78.0 78.0 74.0 156.0 76.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:79.00 stddev:25.80 (32.7%) stddev-sans-first:26.92 16:52:20 INFO - PID 7951 | Values: 83.0 79.0 136.0 79.0 86.0 78.0 127.0 78.0 80.0 137.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:115.00 stddev:2.85 (2.5%) stddev-sans-first:1.99 16:52:20 INFO - PID 7951 | Values: 122.0 114.0 114.0 115.0 119.0 114.0 113.0 118.0 115.0 115.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:152.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 16:52:20 INFO - PID 7951 | Values: 152.0 151.0 150.0 152.0 152.0 152.0 150.0 152.0 151.0 151.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.58 (1.7%) stddev-sans-first:1.59 16:52:20 INFO - PID 7951 | Values: 94.0 95.0 94.0 94.0 95.0 96.0 95.0 95.0 99.0 97.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.50 stddev:2.59 (4.4%) stddev-sans-first:2.74 16:52:20 INFO - PID 7951 | Values: 57.0 58.0 60.0 55.0 56.0 54.0 55.0 61.0 61.0 59.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.00 stddev:2.36 (4.3%) stddev-sans-first:2.42 16:52:20 INFO - PID 7951 | Values: 54.0 54.0 54.0 55.0 59.0 60.0 58.0 54.0 54.0 55.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:80.50 stddev:4.22 (5.2%) stddev-sans-first:4.41 16:52:20 INFO - PID 7951 | Values: 79.0 86.0 79.0 82.0 78.0 88.0 86.0 78.0 76.0 78.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:136.00 stddev:16.30 (12.0%) stddev-sans-first:16.95 16:52:20 INFO - PID 7951 | Values: 146.0 129.0 131.0 125.0 126.0 130.0 142.0 141.0 121.0 177.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:182.50 stddev:4.42 (2.4%) stddev-sans-first:3.16 16:52:20 INFO - PID 7951 | Values: 192.0 179.0 181.0 182.0 181.0 184.0 177.0 188.0 180.0 183.0 16:52:20 INFO - PID 7951 | 16:52:20 INFO - PID 7951 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:2.83 (4.1%) stddev-sans-first:2.96 16:52:20 INFO - PID 7951 | Values: 67.0 69.0 64.0 72.0 69.0 68.0 66.0 65.0 72.0 71.0 16:52:20 INFO - PID 7951 | -------- Summary: end -------- 16:52:20 INFO - PID 7951 | 16:52:21 INFO - PID 7951 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 16:52:21 INFO - TEST-INFO | 7951: exit 0 16:52:21 INFO - TEST-OK | kraken | took 63852ms 16:52:21 INFO - SUITE-END | took 1177s 16:52:21 INFO - Completed test suite (00:19:37) 16:52:21 INFO - javascript benchmark 16:52:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8573.202423776449, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.7666175036866, 3133.2636830344873, 3137.748980081594, 3153.3535625196837, 3187.6971687689675, 6206.751729930803, 6228.096925945741, 6311.337309582496, 6316.242050953881, 6332.556721029529, 6161.722722477488, 6265.3734626537325, 6278.215223097113, 6284.780032698845, 6357.872842543158, 5739.167820666001, 5766.423357664242, 5781.075027995522, 5788.507976821975, 5915.615484993462, 5816.738246778884, 5829.0, 5841.357450680422, 5867.677277749722, 5873.030949893263, 57.42118346343301, 5678.034734095172, 5733.168690539869, 5859.121131830217, 5868.0, 5709.371969083398, 5711.143328500717, 5740.54075673945, 5823.912641310384, 5832.708364581797, 5704.543636509069, 5712.828615141552, 5784.595078344518, 5792.333881603585, 5805.970970145122, 6081.209442772411, 6182.629042257479, 6201.0388389799655, 6217.067439884054, 6264.6241225526155, 6641.302663220341, 6698.330166983312, 6723.865522689519, 6795.558288711218, 6811.829704257384, 6717.764878229238, 6774.69513871872, 6781.423578995791, 6809.625470599115, 6838.897416538756, 6332.461740752087, 6338.429541341301, 6340.1440805490665, 6346.968265158691, 6362.1093046973465, 6952.721891124298, 7062.329078737512, 7065.540739851893, 7069.257727938595, 7082.150141982995, 6630.9336906630315, 6636.469082473391, 6713.227978782503, 6727.831804204934, 6742.292059333699, 6704.564203326768, 6738.528303018839, 6782.93217067823, 6833.760818371433, 6839.521233513607, 6624.9337506624315, 6719.395254427027, 6737.629430381278, 6745.325467453314, 6798.116244888133, 6723.22682891464, 6735.259121496631, 6754.932450675528, 6807.285235050347, 6812.897806532906, 5426.864328391743, 5444.0, 5464.098423760114, 5464.644798088111, 5503.816679413945, 4556.635469162459, 4619.86140415788, 4623.190941585209, 4636.397268355092, 4665.2768820832825, 5800.8259752207505, 5816.0, 5872.17789509469, 5901.76392944286, 5938.376470470625, 6607.2071351438135, 6646.501512386591, 6647.5679080860555, 6663.600183988976, 6783.219929708048, 5728.369879313273, 5769.769209231667, 5828.0, 5832.3292821326095, 5840.474357307863, 5912.674802885883, 5930.614510056919, 5947.286325640951, 6001.789937352171, 6006.459418652343, 6513.902291465632, 6590.044443555754, 6601.3728695773825, 6603.405693487609, 6603.537752357385, 6751.864962700718, 6761.526693131434, 6822.385985261251, 6853.691583878837, 6858.794236172923, 6422.454091402096, 6540.280569137486, 6547.952327627557, 6574.638394888327, 6676.732930682719, 6608.7026083825385, 6679.0, 6681.599104053772, 6682.3317668232785, 6686.1642294713165, 6833.93166068333, 6850.828729281808, 6872.896906546506, 6881.13985751781, 6886.070380498769, 6565.179352580927, 6591.901121483277, 6642.83392915181, 6658.267590565131, 6671.766488172891, 6435.324290949383, 6566.507511936719, 6583.045458408408, 6583.473322134122, 6651.467882569286, 6379.649119298298, 6455.741770329322, 6465.64438955862, 6477.708503117466, 6480.967595161994, 6412.294647588855, 6691.431228345645, 6700.6984685688285, 6711.664416779239, 6738.59568425896, 6405.135306733531, 6425.646589437439, 6503.414692677682, 6508.121403610452, 6509.446697030616], "value": 6123.227382673209, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.3982013489882, 865.5326123893097, 892.5581836990691, 892.6964831957138, 1183.3905538647593, 30408.391832163343, 31125.844370778144, 40321.798391008044, 41670.0, 41917.161656766846, 43114.568854311445, 43479.3478097828, 43489.7825510872, 43506.12987740251, 43598.782006090005, 7766.184550622188, 7849.921500785004, 8047.597620119, 8062.314703250231, 8074.798130046766, 7841.411894107936, 7954.840903181933, 7981.561014144219, 7982.800429989239, 7986.720464783733, 7950.801229969239, 7974.760757177294, 8027.839443211162, 8029.919700802976, 8041.839163216732, 7964.721234756785, 7994.840103197962, 7998.560079195642, 7999.200079992012, 7999.40004499662, 7852.3325517331095, 7913.129555748863, 7922.128565857751, 7935.166807485189, 7941.880871786928, 37779.81110094432, 37947.81026094852, 38067.809660951796, 38116.42825357622, 38209.61790382089, 3556.519869817593, 3580.8925732228076, 3600.7839529628304, 3612.873549425784, 3614.2771445710964, 31309.0, 31452.685473145204, 31474.0, 31568.368632627447, 31591.36817263665, 5050.974745126287, 5057.8229761958155, 5058.924116138261, 5073.1122053640465, 5154.123798954187, 196253.0, 196535.0, 196654.0, 196661.0, 197573.01213493984, 49825.25262121071, 49900.50099498958, 49950.75024624926, 49958.75020624946, 50001.74999124981, 52460.0, 52596.73701631468, 54119.45880541144, 56812.43187568154, 56874.7156264216, 12955.222686638832, 15005.099694018394, 15042.774358384633, 15048.32282547288, 15109.168995705122, 10663.200259980378, 10693.411862347646, 11851.407429628483, 12087.307776911239, 12099.153059285765, 14541.563753087425, 14668.339924703414, 14692.191929443983, 14701.191434471206, 14842.925785371004, 5681.0, 5749.13762935563, 5795.913061304083, 5970.194023806817, 5982.760689572456, 989.2679417231197, 1021.4637315409469, 1022.4632068164274, 1025.8102251083424, 1036.6423583863555, 23110.07559697627, 23967.52064958691, 28820.711792882223, 29837.552436713468, 30150.69849301523, 1085.5983286184162, 1101.6529793115144, 1104.6133853151332, 1110.3116068037868, 1121.2095472691733, 12671.732826717254, 12672.936635316764, 12707.0, 12831.743365132832, 12877.806832897513, 225050.0, 235270.0, 235877.0, 236259.0, 236364.81817590803, 53005.0, 53229.2015619766, 53479.0, 53483.19775203375, 53600.0, 1446.2118145610668, 1485.094092603511, 1499.3627708223962, 1501.7221813964452, 1505.0593379138038, 22753.658695119255, 22758.317250482512, 22783.0, 22929.54140917139, 22937.70622937693, 38671.22657546777, 38812.80593597127, 39027.0, 39043.0, 39114.82655520339, 203143.0, 203939.0, 204286.0, 204746.0, 204790.0, 34339.65660343364, 36804.81597592102, 38849.80575097106, 38852.41721374238, 39031.804840975616, 46001.53998459972, 47631.28553071638, 47713.0, 47829.76085119552, 48313.516864830905, 34762.82618586891, 34795.130121747155, 34845.47731784076, 34953.65046349504, 35133.472997904544, 34203.14492137716, 34316.0, 34375.31249375048, 34649.82675086609, 34946.126346841535, 37342.8132859334, 37726.811365942995, 37798.81100594479, 37893.81053094717, 38013.23973520459, 33519.83240083784, 34524.13689657779, 34554.13614659654, 34755.652443476254, 34845.12887177841, 23690.28929132129, 24589.50820983606, 24665.0, 25566.233013009638, 25772.09797657073], "value": 17633.946586882317, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.1328007988018, 588.579165896384, 591.7278052096036, 604.2537067873844, 616.1035693066588, 22008.239340852735, 22106.447338816517, 22915.31254062379, 22928.0, 23108.768912310872, 24694.0, 26376.736232637668, 26556.33609159772, 26596.867015664942, 26610.73389266107, 6419.743210271584, 6556.93443065568, 6573.638449885254, 6582.078509008743, 6586.0, 5920.851978700523, 6404.3595640435815, 6462.644554549498, 6471.611703297817, 6513.478921686254, 6471.4175724184815, 6478.514111441637, 6479.708413121397, 6485.092087107809, 6487.286398496161, 6421.0, 6459.61242325462, 6482.092507049017, 6485.319041500646, 6493.577917435376, 6033.577649564532, 6044.063170208625, 6054.0, 6066.120412540157, 6066.878662426727, 29470.263243419085, 30355.544666830014, 30825.383492330253, 30865.845670771727, 31285.37429251425, 1957.275807951053, 1993.5913137806715, 1996.3511858645998, 1996.9301074462323, 1997.2909617086016, 19331.61336773271, 20027.399178024683, 20045.699314510293, 20050.699239511418, 20070.197192112297, 2302.34383200787, 2349.3304408243566, 2383.165891937825, 2387.6299173628117, 2403.3390817525146, 131083.0, 134223.0, 134391.32804336015, 134462.3276883619, 134669.3266533661, 14568.271586420637, 14575.271236438348, 14952.32714527827, 15259.542213733384, 15333.923330383277, 24330.513389732107, 24334.878325608614, 24385.0, 24570.508589828103, 24588.385290367885, 9435.0, 9596.76008099803, 9751.90248097524, 9861.901380986243, 9900.851487227697, 8806.515641639644, 8821.60302786376, 8897.0, 9005.594748236344, 9039.502827344559, 7856.882146767803, 11485.621725392839, 11558.768824623461, 11572.76854462906, 11891.345975971404, 3555.799780197791, 3806.7715937043868, 3861.2663593917628, 4058.6753059755147, 4106.870610582114, 927.2072378116748, 931.8788557487619, 958.769895225141, 960.3757557587624, 963.5182408795603, 19152.23391064342, 19215.0, 19531.121099550553, 19644.821310721403, 19650.508737281398, 1003.603576587244, 1032.7573020340214, 1035.3529044347283, 1039.6101461951769, 1047.8271085270844, 10963.40537733221, 11110.777784444428, 11123.27698699582, 11168.0, 11206.38364889939, 464538.0, 471603.0, 472781.0, 477345.0, 501020.0, 109177.45411273051, 109287.0, 111397.0, 113334.86665133243, 113934.43032784783, 1196.7546652936128, 1219.6889793102703, 1225.081189108169, 1225.7732319520917, 1230.1081715755827, 16744.162791860115, 17387.304507819546, 17460.73808892842, 17569.50659193983, 17610.0, 55053.0, 55747.442525574224, 55979.72010139923, 57717.0, 57837.0, 68781.0, 69166.27084322931, 69426.65286673534, 69710.0, 70632.0, 20424.897875510527, 20590.382288531368, 20593.691094633894, 20751.481212969797, 20792.48018799542, 22969.540609188058, 23022.539549209258, 23385.88307058454, 23430.17994370189, 23457.41356466102, 18129.728054078936, 18473.630527389647, 18504.537386564905, 18642.906785465984, 18715.344962926778, 16123.274452649424, 16834.326626934784, 17190.828091718922, 17403.7389439156, 17613.735793962845, 18820.435386938414, 19165.61668766589, 19221.711674324615, 20311.695324569846, 20387.0, 14807.333669985092, 15073.849261507245, 15105.32026058852, 15150.924245378703, 15231.466898658493, 17302.480925572254, 17957.551061223574, 18160.0, 18858.71711924295, 18946.43160705181], "value": 12240.801599707678, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1331.2145833957964, 1371.8765311121997, 1386.0851837787063, 1397.7553928062594, 1398.615380770288, 13659.726805463884, 13946.930265348685, 14340.856591434083, 14341.498047568337, 14359.569212923616, 13713.657158571015, 14704.779428308584, 14739.852601473982, 14777.187254700988, 14782.482613108543, 2713.579395193743, 2776.8889244430197, 2777.5555911054234, 2778.763805076571, 2779.332960089574, 2604.5181641396402, 2684.543627583306, 2724.4551089782026, 2738.835669859815, 2770.1827960751625, 2724.931876703088, 2754.0223220756643, 2754.449110177972, 2755.3800394911186, 2755.917322480319, 2658.1493921944984, 2680.8793604287853, 2690.5829596412586, 2690.9058182963504, 2695.541757901152, 2633.1968749531384, 2644.867756612181, 2648.7218842021502, 2653.283613424384, 2654.6548948636746, 13702.588922332247, 14000.0, 14093.295335233197, 14095.71808563823, 14122.152670839783, 7514.39884809214, 7747.767566972943, 7791.337736292422, 7796.298333149987, 7798.259165379337, 5206.0368831766245, 5322.547583455373, 5385.7576409061685, 5401.378841433247, 5465.043617366945, 1893.6496748101645, 1921.778995415517, 1924.0572119661265, 1928.4503916383903, 1964.6856502959602, 22671.433214169778, 22946.541069178522, 23143.652845207336, 23169.304920852403, 23236.41908952273, 6720.7647732330115, 7134.429245660334, 7185.964070179615, 7358.431160886966, 7472.0, 15808.52574422769, 15941.282642281125, 16129.677406451805, 16131.435399760952, 16146.67706645884, 7501.887471687929, 7709.614519274014, 7749.496282741717, 7753.069631644239, 7753.224677532202, 7040.718371265092, 7094.92905070953, 7133.108361454818, 7191.460640451987, 7249.673764680602, 5027.944131732377, 5184.637075404761, 5208.0365132450615, 5215.400228973716, 5230.790768369298, 1314.2246074815905, 1356.8371795384617, 1444.162385816224, 1499.3552772307794, 1507.4271776724775, 891.4918496457087, 919.4850883505259, 923.6028507741736, 924.893637231727, 938.0525669074284, 7864.606769661494, 8262.256396924306, 8301.086880443147, 8688.0, 9071.863922041042, 992.5979978108877, 1004.6433516101824, 1016.2885979814159, 1017.0998666180336, 1029.1972261635935, 5256.789728410898, 5305.549028332558, 5328.120860058125, 5383.596230282745, 5412.621116521885, 18442.815571844378, 19187.656864019384, 19506.0, 19833.801661983485, 19861.503462413268, 19432.902835486017, 19449.611007780048, 19613.803861961198, 19692.212311507665, 19808.0, 10316.638917637847, 10501.369917804956, 10635.52140153695, 10974.99999999984, 11053.115750739922, 7729.111152217567, 8022.759317220492, 8197.139300373614, 8214.301784348398, 8299.792505187419, 16696.66606667884, 16907.492775216764, 16953.91523042377, 17396.565085872953, 17419.39032133869, 17405.21676524585, 17696.380626678005, 17720.556986074935, 17788.288468461633, 18121.36575219861, 10516.211284153873, 10829.350238985371, 10833.945830270799, 10838.67483975482, 10855.565777368816, 12847.164934279243, 13224.20654760679, 13313.400896959467, 13326.267055312052, 13347.19916804956, 10923.672289831318, 10993.560257589606, 11003.284786488852, 11049.116070714163, 11266.098712103176, 10188.91127318883, 10465.110465610509, 10494.21293403013, 10531.736706582396, 10808.729781755519, 9126.17864392208, 9175.44947303164, 9190.080991900757, 9206.17144457002, 9251.722448326562, 6697.665116744046, 6725.29384414649, 6810.148731408574, 6832.795016149524, 6870.7595234166565, 6832.453403727591, 6866.725330986905, 6877.58734475933, 6909.585424874524, 7063.364297213276], "value": 6460.038614217477, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.5993924738705, 516.460298987558, 521.1687358662932, 535.8312131678518, 543.2801537962201, 6118.632882027082, 6171.691415429233, 6174.691265436727, 6214.875702485948, 6255.218097737783, 6133.068083553678, 6148.938510614893, 6151.907721384172, 6163.322034576193, 6193.535484838632, 5070.771815268304, 5072.3405957225505, 5086.5676417504465, 5090.796368145269, 5143.4599367066485, 4808.158572249842, 4869.196582563873, 5056.494350564951, 5057.140286151344, 5103.183490641498, 4860.513948605147, 4864.46490886004, 4871.220604703248, 4914.058946716063, 4952.628552858532, 4904.337914381548, 4910.533499317559, 4939.394696723579, 4940.604751619898, 4941.158833670635, 4263.850765223202, 4406.911861762779, 4452.732836029816, 4456.910861782779, 4463.330500424962, 5847.619904706223, 5872.765089396419, 5947.6431414115295, 5949.553783466214, 6006.459418652343, 5600.411956744565, 5607.43925607436, 5612.887742245132, 5700.2589663343915, 5728.971355143198, 6509.6419696916655, 6527.706253218616, 6541.771038013647, 6549.1209049258605, 6556.393683547513, 4770.7376094314795, 4833.4441539222735, 4850.199717046683, 4877.097736918646, 4898.142825005645, 6447.484201263887, 6639.468842492589, 6669.566478178903, 6744.763933262312, 6842.828929276759, 4845.2732090186755, 4973.0, 4992.950070499322, 5003.849884503471, 5022.949770502321, 5043.420006699203, 5047.97476012625, 5065.7720402581235, 5094.566961808214, 5117.518003768169, 5661.631993920382, 5685.204071430003, 5687.630304030225, 5695.658260504383, 5697.401772813795, 6551.181102362205, 6562.376574225441, 6563.573367731082, 6583.967080164569, 6599.8020059398295, 1762.97355539667, 1771.4862689819809, 1773.7782777152856, 1781.4388467632655, 1789.5257756694486, 1184.579474286633, 1204.4519743516678, 1214.7145420826098, 1224.0758227538151, 1243.359669770069, 5708.942910570924, 5738.110592858114, 5749.310082790092, 5765.88468230633, 5815.709214539256, 6584.604923704593, 6686.398224159849, 6704.530682852153, 6706.664666766642, 6759.681862036856, 5722.7424765885635, 5747.505648531412, 5772.0, 5785.768569257267, 5798.33319168301, 3487.7035451986358, 3526.4357702767434, 3556.893293201208, 3574.7488379067117, 3591.2278860044694, 6418.807435776934, 6450.387213214737, 6477.255115661665, 6496.285408605049, 6504.479641628658, 6778.559393639398, 6795.490338224653, 6806.013128096398, 6827.590344579242, 6842.315768423118, 6387.774174042172, 6407.9562207951785, 6411.6473593953715, 6412.487001039813, 6501.349865013555, 6527.602949109804, 6589.769358072444, 6592.274849766618, 6614.173228346457, 6616.801495955129, 5988.28140623128, 6599.868002640016, 6611.371919667624, 6629.7348106075215, 6651.235107962646, 6349.396807303298, 6367.586106903036, 6395.456386207225, 6452.290248072614, 6469.45009674183, 4963.131451995959, 4971.950280497149, 4980.203167493184, 4989.900201995867, 5012.573931215888, 6308.33762454954, 6398.200224971879, 6563.3764792344655, 6701.597904125768, 6784.626845523544, 6409.519286053472, 6411.5832470889245, 6438.29178790342, 6450.258220304538, 6451.1290975717675, 6354.809355719336, 6393.744250230125, 6430.807075787734, 6449.258335291502, 6494.253160886558, 6326.683665816783, 6353.205849268841, 6360.968195158995, 6373.808785736435, 6417.71120299597, 6473.8705225896165, 6551.672416379257, 6554.868902621825, 6566.484153311241, 6577.6053436793945, 6228.0969259456215, 6257.4994000480765, 6276.309605943434, 6331.588446750947, 6369.471326881608], "value": 5019.972712775156, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [877.2762470961454, 892.2460520859873, 914.9817003659931, 919.1819280840049, 926.7636752628081, 18904.24383024679, 19819.801801981994, 19928.50178745532, 19946.0, 19989.100490477944, 17470.126493675296, 17506.824931750678, 17834.019128947904, 22146.0, 22191.889040554815, 1031.1647565471953, 1059.6609085092773, 1061.8354155105972, 1062.3678911047953, 1062.9255952083358, 1062.0282441565957, 1068.9037986581206, 1069.5400977579638, 1069.8341757027674, 1072.6835583502846, 1003.8092762375162, 1059.1897198643044, 1090.6782499162766, 1091.2143256855052, 1120.56298043763, 1088.5754555723195, 1089.9346039237632, 1090.5910283643634, 1091.3997301484153, 1093.3549205968477, 784.1766145547209, 785.8664027115404, 787.9133295337508, 789.1477204618998, 790.746960972489, 20179.798202017937, 20261.088251028737, 20401.183952641877, 20595.0, 20799.792002079936, 21324.89337553318, 21963.23128690488, 22574.548509029726, 22971.540569188688, 22990.310290691305, 17070.743938840926, 17124.828751712448, 17251.0, 17317.7402338965, 17506.824931750645, 3644.325799727059, 3702.4631428442995, 3703.962960370389, 3704.2961837251105, 3704.555453345589, 121449.0, 122297.0, 123092.0, 123793.0, 126805.36597317047, 16834.831651683326, 17247.0, 17305.0, 17438.651226975642, 17484.737728934077, 30963.380732385227, 31309.843450783057, 31332.843335783175, 31867.840660796548, 32319.35361292761, 8162.3878209134555, 8282.296004839656, 8298.879651247125, 8302.70940517079, 8309.584520773937, 3826.6364695353896, 3860.536735591747, 3884.533855937306, 3974.940375894364, 3988.3818008208773, 5408.215808707715, 5486.725663716798, 5494.615376923657, 5521.861953451115, 5544.362398324244, 941.1247539787926, 958.769895225141, 969.6121551379505, 976.4336684722844, 976.9951150244345, 669.5313280703527, 671.5769065488711, 675.5242037930929, 695.6313154028373, 697.435077587156, 11588.826167607493, 11590.884091159149, 11713.648590542298, 12432.254064756144, 12601.747965040648, 698.6995591895433, 702.0, 703.1351437731619, 717.8671945690064, 723.5043994863536, 5531.585131115183, 5601.047821870292, 5603.7478313475995, 5618.297712785902, 5770.2498675171955, 113808.43095784468, 114930.42534787272, 115831.42084289524, 116093.0, 116403.0, 94467.52766236124, 95976.0, 97537.0, 97830.5108474453, 98921.0, 86475.56762216148, 86759.0, 87677.56161219154, 88030.0, 89059.0, 11123.666290011313, 11263.49314280843, 11366.318020918772, 11443.25618834773, 11458.484368203617, 38783.0, 38797.0, 39043.2191356177, 39051.80474097611, 40623.0, 50265.24602131044, 51284.0, 71533.64233179009, 72183.63908180426, 72411.27588724045, 19274.0, 19303.613927721086, 19602.215911363386, 19700.802991969897, 19814.90092549528, 18702.625947481247, 18838.717419238998, 21331.57336853223, 21348.252811151535, 21405.0, 16188.0, 18882.905585471985, 19443.611127777083, 19596.60806783828, 19633.509162271057, 19426.875693174912, 20042.298519551747, 20187.192512299345, 20259.69610455815, 20356.28752993638, 17840.732389013916, 18094.5476363092, 18197.45407637773, 18777.0, 18814.811851881852, 14081.647958801112, 14452.927735361256, 14505.709885802014, 14587.197704126374, 14820.481283155037, 14002.649933751738, 14040.368183431567, 14147.151170929777, 14752.704945901236, 15688.215589220721], "value": 9263.060954570416, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 101.0, 108.0, 114.0, 112.0, 107.0, 99.0, 109.0, 110.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 123.0, 152.0, 167.0, 125.0, 150.0, 150.0, 129.0, 175.0, 125.0], "value": 144.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 163.0, 170.0, 164.0, 174.0, 163.0, 162.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 172.0, 79.0, 78.0, 78.0, 74.0, 156.0, 76.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 79.0, 136.0, 79.0, 86.0, 78.0, 127.0, 78.0, 80.0, 137.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 114.0, 114.0, 115.0, 119.0, 114.0, 113.0, 118.0, 115.0, 115.0], "value": 115.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 150.0, 152.0, 152.0, 152.0, 150.0, 152.0, 151.0, 151.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 95.0, 96.0, 95.0, 95.0, 99.0, 97.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 60.0, 55.0, 56.0, 54.0, 55.0, 61.0, 61.0, 59.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 59.0, 60.0, 58.0, 54.0, 54.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 79.0, 82.0, 78.0, 88.0, 86.0, 78.0, 76.0, 78.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 129.0, 131.0, 125.0, 126.0, 130.0, 142.0, 141.0, 121.0, 177.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 179.0, 181.0, 182.0, 181.0, 184.0, 177.0, 188.0, 180.0, 183.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 64.0, 72.0, 69.0, 68.0, 66.0, 65.0, 72.0, 71.0], "value": 68.3, "unit": "score"}]}]} 16:52:21 INFO - Return code: 0 16:52:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:52:21 INFO - # TBPL SUCCESS # 16:52:21 INFO - Running post-action listener: _package_coverage_data 16:52:21 INFO - Running post-action listener: _resource_record_post_action 16:52:21 INFO - [mozharness: 2017-08-09 23:52:21.890270Z] Finished run-tests step (success) 16:52:21 INFO - Running post-run listener: _resource_record_post_run 16:52:21 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431382528; Read time: 8; Write time: 638976 16:52:21 INFO - TinderboxPrint: CPU usage
13.2% 16:52:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:52:21 INFO - TinderboxPrint: I/O write bytes / time
431,382,528 / 638,976 16:52:21 INFO - TinderboxPrint: CPU idle
8,275.7 (86.8%) 16:52:21 INFO - TinderboxPrint: CPU user
1,204.8 (12.6%) 16:52:21 INFO - TinderboxPrint: Swap in / out
0 / 0 16:52:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107282432; Read time: 0; Write time: 216864 16:52:21 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:52:21 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 324100096; Read time: 0; Write time: 422112 16:52:22 INFO - Running post-run listener: _upload_blobber_files 16:52:22 INFO - Blob upload gear active. 16:52:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:52:22 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 16:52:22 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'] 16:52:22 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 16:52:22 INFO - (blobuploader) - INFO - Open directory for files ... 16:52:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:52:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:52:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:29 INFO - (blobuploader) - INFO - Done attempting. 16:52:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:52:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:52:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:30 INFO - (blobuploader) - INFO - Done attempting. 16:52:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:52:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:52:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:31 INFO - (blobuploader) - INFO - Done attempting. 16:52:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:52:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:52:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:32 INFO - (blobuploader) - INFO - Done attempting. 16:52:32 INFO - (blobuploader) - INFO - Iteration through files over. 16:52:32 INFO - Return code: 0 16:52:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:52:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:52:32 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec95c6c05d14192723b90b9095d3fe79fdf398cf5a4df8c2016f11dc710fe13ee43fdabdc4accc124a5855e521f7b09985cdb0a796fa4b2510c2019ae68a85e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17217fd7adb201e7c77ced8e7749690629df3ad401d5c3d50033b90ca450795b92b0749257f1a8b6c7106aa17dbbdc644acadb9dcd0c1f1ee0f0ce3c90c8ee89", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/641ef3f91da1062ad92dcc86aea732b4eadf1af940697e35b94078c8505f026fb32b789bd5926a374cb26d96e630ea27abfac97b2ddab07f57657089b99cf8e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e2a28462e6044176e1e24d68fb38a2e549fd7a048c928e96ecca173b8ba41be642f8f738bcf8e9aab7511aad86fc76091e6119378d00d06a470844ca073254"} 16:52:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:52:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:52:32 INFO - Contents: 16:52:32 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec95c6c05d14192723b90b9095d3fe79fdf398cf5a4df8c2016f11dc710fe13ee43fdabdc4accc124a5855e521f7b09985cdb0a796fa4b2510c2019ae68a85e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17217fd7adb201e7c77ced8e7749690629df3ad401d5c3d50033b90ca450795b92b0749257f1a8b6c7106aa17dbbdc644acadb9dcd0c1f1ee0f0ce3c90c8ee89", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/641ef3f91da1062ad92dcc86aea732b4eadf1af940697e35b94078c8505f026fb32b789bd5926a374cb26d96e630ea27abfac97b2ddab07f57657089b99cf8e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e2a28462e6044176e1e24d68fb38a2e549fd7a048c928e96ecca173b8ba41be642f8f738bcf8e9aab7511aad86fc76091e6119378d00d06a470844ca073254"} 16:52:32 INFO - Running post-run listener: copy_logs_to_upload_dir 16:52:32 INFO - Copying logs to upload dir... 16:52:32 INFO - mkdir: /builds/slave/test/build/upload/logs 16:52:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.939189 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-08-09 16:52:30.914779) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 16:52:30.923508) ========= 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=af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec95c6c05d14192723b90b9095d3fe79fdf398cf5a4df8c2016f11dc710fe13ee43fdabdc4accc124a5855e521f7b09985cdb0a796fa4b2510c2019ae68a85e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17217fd7adb201e7c77ced8e7749690629df3ad401d5c3d50033b90ca450795b92b0749257f1a8b6c7106aa17dbbdc644acadb9dcd0c1f1ee0f0ce3c90c8ee89", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/641ef3f91da1062ad92dcc86aea732b4eadf1af940697e35b94078c8505f026fb32b789bd5926a374cb26d96e630ea27abfac97b2ddab07f57657089b99cf8e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e2a28462e6044176e1e24d68fb38a2e549fd7a048c928e96ecca173b8ba41be642f8f738bcf8e9aab7511aad86fc76091e6119378d00d06a470844ca073254"} build_url:https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011109 build_url: 'https://queue.taskcluster.net/v1/task/W3D-FPkqR6iRZ6ceKXKElw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ec95c6c05d14192723b90b9095d3fe79fdf398cf5a4df8c2016f11dc710fe13ee43fdabdc4accc124a5855e521f7b09985cdb0a796fa4b2510c2019ae68a85e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17217fd7adb201e7c77ced8e7749690629df3ad401d5c3d50033b90ca450795b92b0749257f1a8b6c7106aa17dbbdc644acadb9dcd0c1f1ee0f0ce3c90c8ee89", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/641ef3f91da1062ad92dcc86aea732b4eadf1af940697e35b94078c8505f026fb32b789bd5926a374cb26d96e630ea27abfac97b2ddab07f57657089b99cf8e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/63e2a28462e6044176e1e24d68fb38a2e549fd7a048c928e96ecca173b8ba41be642f8f738bcf8e9aab7511aad86fc76091e6119378d00d06a470844ca073254"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-09 16:52:30.947575) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:52:30.947879) ========= 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=af724c981e2a0f424dbabf99000001e7-1502318575.929471-1783205115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-09 16:52:31.030361) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 16:52:31.030673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-09 16:52:31.030959) ========= ========= Total master_lag: 0.21 =========