builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-082 starttime: 1502792071.65 results: success (0) revision: b4b58cf12108a0b49db77781bdcab8cc481fb64b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:31.653889) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:31.654363) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:31.656653) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:31.711274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:31.711588) ========= 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=51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-15 03:14: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% 230M=0s 2017-08-15 03:14:32 (230 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147422 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:31.893670) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:31.893984) ========= 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=51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017195 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:31.953335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:31.953656) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4b58cf12108a0b49db77781bdcab8cc481fb64b --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 b4b58cf12108a0b49db77781bdcab8cc481fb64b --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=51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-15 03:14:32,415 truncating revision to first 12 chars 2017-08-15 03:14:32,415 Setting DEBUG logging. 2017-08-15 03:14:32,415 attempt 1/10 2017-08-15 03:14:32,415 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4b58cf12108?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-15 03:14:32,950 unpacking tar archive at: mozilla-central-b4b58cf12108/testing/mozharness/ program finished with exit code 0 elapsedTime=0.925555 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:32.900402) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:32.900719) ========= script_repo_revision: b4b58cf12108a0b49db77781bdcab8cc481fb64b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:32.901101) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:32.901367) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-15 03:14:32.920420) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-15 03:14:32.920714) ========= /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=51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:14:33 INFO - MultiFileLogger online at 20170815 03:14:33 in /builds/slave/test 03:14:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:14:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:14:33 INFO - {'append_to_log': False, 03:14:33 INFO - 'base_work_dir': '/builds/slave/test', 03:14:33 INFO - 'blob_upload_branch': 'Firefox', 03:14:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:14:33 INFO - 'branch': 'Firefox', 03:14:33 INFO - 'buildbot_json_path': 'buildprops.json', 03:14:33 INFO - 'code_coverage': False, 03:14:33 INFO - 'config_files': ('talos/linux_config.py',), 03:14:33 INFO - 'default_actions': ('clobber', 03:14:33 INFO - 'read-buildbot-config', 03:14:33 INFO - 'download-and-extract', 03:14:33 INFO - 'populate-webroot', 03:14:33 INFO - 'create-virtualenv', 03:14:33 INFO - 'install', 03:14:33 INFO - 'setup-mitmproxy', 03:14:33 INFO - 'run-tests'), 03:14:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:14:33 INFO - 'disable_ccov_upload': False, 03:14:33 INFO - 'download_minidump_stackwalk': True, 03:14:33 INFO - 'download_symbols': 'ondemand', 03:14:33 INFO - 'enable_stylo': False, 03:14:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:14:33 INFO - 'tooltool.py': '/tools/tooltool.py', 03:14:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:14:33 INFO - '/tools/misc-python/virtualenv.py')}, 03:14:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:14:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:14:33 INFO - 'gecko_profile': False, 03:14:33 INFO - 'gecko_profile_interval': 0, 03:14:33 INFO - 'installer_path': 'installer.exe', 03:14:33 INFO - 'log_level': 'info', 03:14:33 INFO - 'log_name': 'talos', 03:14:33 INFO - 'log_to_console': True, 03:14:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:14:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:14:33 INFO - 'opt_config_files': (), 03:14:33 INFO - 'pip_index': False, 03:14:33 INFO - 'suite': 'dromaeojs-e10s', 03:14:33 INFO - 'system_bits': '32', 03:14:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:14:33 INFO - 'title': 'talos-linux64-ix-082', 03:14:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:14:33 INFO - 'use_talos_json': True, 03:14:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:14:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:14:33 INFO - 'work_dir': 'build'} 03:14:33 INFO - [mozharness: 2017-08-15 10:14:33.595396Z] Running clobber step. 03:14:33 INFO - Running pre-action listener: _resource_record_pre_action 03:14:33 INFO - Running main action method: clobber 03:14:33 INFO - rmtree: /builds/slave/test/build 03:14:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:14:34 INFO - Running post-action listener: _resource_record_post_action 03:14:34 INFO - [mozharness: 2017-08-15 10:14:34.586949Z] Finished clobber step (success) 03:14:34 INFO - [mozharness: 2017-08-15 10:14:34.587053Z] Running read-buildbot-config step. 03:14:34 INFO - Running pre-action listener: _resource_record_pre_action 03:14:34 INFO - Running main action method: read_buildbot_config 03:14:34 INFO - Using buildbot properties: 03:14:34 INFO - { 03:14:34 INFO - "project": "", 03:14:34 INFO - "product": "firefox", 03:14:34 INFO - "who": "cbook@mozilla.com", 03:14:34 INFO - "installer_path": "public/build/target.tar.bz2", 03:14:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:14:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:14:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:14:34 INFO - "stage_platform": "linux64-stylosequential", 03:14:34 INFO - "basedir": "/builds/slave/test", 03:14:34 INFO - "buildnumber": 148, 03:14:34 INFO - "platform": "ubuntu64_hw_styloseq", 03:14:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:14:34 INFO - "slavebuilddir": "test", 03:14:34 INFO - "taskId": "G8dg6okhSGSXI2ghI6u7Rg", 03:14:34 INFO - "branch": "mozilla-central", 03:14:34 INFO - "script_repo_revision": "production", 03:14:34 INFO - "revision": "b4b58cf12108a0b49db77781bdcab8cc481fb64b", 03:14:34 INFO - "slavename": "talos-linux64-ix-082", 03:14:34 INFO - "repo_path": "mozilla-central" 03:14:34 INFO - } 03:14:34 INFO - Finding installer, test and symbols from parent task. 03:14:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G8dg6okhSGSXI2ghI6u7Rg'}, attempt #1 03:14:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G8dg6okhSGSXI2ghI6u7Rg'}, attempt #1 03:14:35 INFO - Task dependencies: LqQYgX9sTWiYQ1iQnjcEBw 03:14:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw'}, attempt #1 03:14:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.tar.bz2 03:14:35 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.test_packages.json 03:14:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.crashreporter-symbols.zip 03:14:35 INFO - Running post-action listener: _resource_record_post_action 03:14:35 INFO - [mozharness: 2017-08-15 10:14:35.925408Z] Finished read-buildbot-config step (success) 03:14:35 INFO - [mozharness: 2017-08-15 10:14:35.925630Z] Running download-and-extract step. 03:14:35 INFO - Running pre-action listener: _resource_record_pre_action 03:14:35 INFO - Running main action method: download_and_extract 03:14:35 INFO - mkdir: /builds/slave/test/build/tests 03:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:14:35 INFO - trying https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.test_packages.json 03:14:35 INFO - Downloading https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:14:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:14:36 INFO - Downloaded 989 bytes. 03:14:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:14:36 INFO - Using the following test package requirements: 03:14:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:14:36 INFO - u'common': [u'target.common.tests.zip'], 03:14:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:14:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:14:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:14:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:14:36 INFO - u'mozbase': [u'target.common.tests.zip'], 03:14:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:14:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:14:36 INFO - u'web-platform': [u'target.common.tests.zip', 03:14:36 INFO - u'target.web-platform.tests.tar.gz'], 03:14:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:14:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:14:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.common.tests.zip 03:14:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:14:36 INFO - Fetch https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.common.tests.zip into memory 03:14:37 INFO - Content-Length response header: 54002031 03:14:37 INFO - Bytes received: 54002031 03:14:49 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:14:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.common.tests.zip 03:14:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:14:49 INFO - Fetch https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.common.tests.zip into memory 03:14:50 INFO - Content-Length response header: 54002031 03:14:50 INFO - Bytes received: 54002031 03:15:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.talos.tests.zip 03:15:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:15:02 INFO - Fetch https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.talos.tests.zip into memory 03:15:03 INFO - Content-Length response header: 14496050 03:15:03 INFO - Bytes received: 14496050 03:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:03 INFO - trying https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.tar.bz2 03:15:03 INFO - Downloading https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:15:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:15:05 INFO - Downloaded 61869465 bytes. 03:15:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.tar.bz2 03:15:05 INFO - mkdir: /builds/slave/test/properties 03:15:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:15:05 INFO - Writing to file /builds/slave/test/properties/build_url 03:15:05 INFO - Contents: 03:15:05 INFO - build_url:https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.tar.bz2 03:15:05 INFO - Running post-action listener: _resource_record_post_action 03:15:05 INFO - Running post-action listener: set_extra_try_arguments 03:15:05 INFO - [mozharness: 2017-08-15 10:15:05.163199Z] Finished download-and-extract step (success) 03:15:05 INFO - [mozharness: 2017-08-15 10:15:05.163445Z] Running populate-webroot step. 03:15:05 INFO - Running pre-action listener: _resource_record_pre_action 03:15:05 INFO - Running main action method: populate_webroot 03:15:05 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:15:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:15:05 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:15:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:15:05 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:15:05 INFO - 'tests': ['damp', 'tps']}, 03:15:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:15:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:15:05 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:15:05 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:15:05 INFO - 'other-e10s': {'tests': ['a11yr', 03:15:05 INFO - 'ts_paint', 03:15:05 INFO - 'tpaint', 03:15:05 INFO - 'sessionrestore', 03:15:05 INFO - 'sessionrestore_many_windows', 03:15:05 INFO - 'sessionrestore_no_auto_restore', 03:15:05 INFO - 'tabpaint']}, 03:15:05 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:15:05 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:15:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:15:05 INFO - 'tsvgr_opacity', 03:15:05 INFO - 'tart', 03:15:05 INFO - 'tscrollx', 03:15:05 INFO - 'tsvg_static']}, 03:15:05 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:15:05 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:15:05 INFO - 'talos_options': ['--mitmproxy', 03:15:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:15:05 INFO - '--firstNonBlankPaint'], 03:15:05 INFO - 'tests': ['tp6_google', 03:15:05 INFO - 'tp6_youtube', 03:15:05 INFO - 'tp6_amazon', 03:15:05 INFO - 'tp6_facebook']}, 03:15:05 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:15:05 INFO - 'talos_options': ['--stylo', 03:15:05 INFO - '--mitmproxy', 03:15:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:15:05 INFO - '--firstNonBlankPaint'], 03:15:05 INFO - 'tests': ['tp6_google', 03:15:05 INFO - 'tp6_youtube', 03:15:05 INFO - 'tp6_amazon', 03:15:05 INFO - 'tp6_facebook']}, 03:15:05 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:15:05 INFO - 'talos_options': ['--stylo', 03:15:05 INFO - '--stylo-threads=1', 03:15:05 INFO - '--mitmproxy', 03:15:05 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:15:05 INFO - '--firstNonBlankPaint'], 03:15:05 INFO - 'tests': ['tp6_google', 03:15:05 INFO - 'tp6_youtube', 03:15:05 INFO - 'tp6_amazon', 03:15:05 INFO - 'tp6_facebook']}, 03:15:05 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:15:05 INFO - 'talos_options': ['--xperf_path', 03:15:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:15:05 INFO - 'tests': ['tp5n']}}} 03:15:05 INFO - Running post-action listener: _resource_record_post_action 03:15:05 INFO - [mozharness: 2017-08-15 10:15:05.178719Z] Finished populate-webroot step (success) 03:15:05 INFO - [mozharness: 2017-08-15 10:15:05.178810Z] Running create-virtualenv step. 03:15:05 INFO - Running pre-action listener: _resource_record_pre_action 03:15:05 INFO - Running main action method: create_virtualenv 03:15:05 INFO - Creating virtualenv /builds/slave/test/build/venv 03:15: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 03:15:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:15:05 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:15:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:15:05 INFO - Using real prefix '/usr' 03:15:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:15:05 INFO - Installing distribute.............................................................................................................................................................................................done. 03:15:07 INFO - Installing pip.................done. 03:15:07 INFO - Return code: 0 03:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:15:08 INFO - Reading from file tmpfile_stdout 03:15:08 INFO - Output received: 03:15: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) 03:15:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:15: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')]} 03:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15: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')]} 03:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15: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 0x11521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bfb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c2f00>, '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 0x14bdba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14be050>, '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': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:15: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 03:15: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 03:15:08 INFO - Using env: {'DISPLAY': ':0', 03:15:08 INFO - 'HOME': '/home/cltbld', 03:15:08 INFO - 'LANG': 'en_US.UTF-8', 03:15:08 INFO - 'LANGUAGE': 'en_US:en', 03:15:08 INFO - 'LOGNAME': 'cltbld', 03:15:08 INFO - 'MAIL': '/var/mail/cltbld', 03:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:08 INFO - 'MOZ_NO_REMOTE': '1', 03:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:08 INFO - 'NO_EM_RESTART': '1', 03:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:08 INFO - 'PWD': '/builds/slave/test', 03:15:08 INFO - 'SHELL': '/bin/bash', 03:15:08 INFO - 'SHLVL': '1', 03:15:08 INFO - 'TERM': 'linux', 03:15:08 INFO - 'TMOUT': '86400', 03:15:08 INFO - 'USER': 'cltbld', 03:15:08 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 03:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:08 INFO - '_': '/tools/buildbot/bin/python'} 03:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15: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 03:15:08 INFO - Cleaning up... 03:15:08 INFO - Return code: 0 03:15:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:15: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')]} 03:15:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15: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')]} 03:15:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15: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 0x11521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bfb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c2f00>, '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 0x14bdba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14be050>, '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': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:15: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 03:15: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 03:15:08 INFO - Using env: {'DISPLAY': ':0', 03:15:08 INFO - 'HOME': '/home/cltbld', 03:15:08 INFO - 'LANG': 'en_US.UTF-8', 03:15:08 INFO - 'LANGUAGE': 'en_US:en', 03:15:08 INFO - 'LOGNAME': 'cltbld', 03:15:08 INFO - 'MAIL': '/var/mail/cltbld', 03:15:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:08 INFO - 'MOZ_NO_REMOTE': '1', 03:15:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:08 INFO - 'NO_EM_RESTART': '1', 03:15:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:08 INFO - 'PWD': '/builds/slave/test', 03:15:08 INFO - 'SHELL': '/bin/bash', 03:15:08 INFO - 'SHLVL': '1', 03:15:08 INFO - 'TERM': 'linux', 03:15:08 INFO - 'TMOUT': '86400', 03:15:08 INFO - 'USER': 'cltbld', 03:15:08 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 03:15:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:08 INFO - '_': '/tools/buildbot/bin/python'} 03:15:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:08 INFO - Downloading/unpacking psutil>=3.1.1 03:15: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 03:15: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 03:15: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 03:15: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 03:15:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:15:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:09 INFO - Installing collected packages: psutil 03:15:09 INFO - Running setup.py install for psutil 03:15:09 INFO - building 'psutil._psutil_linux' extension 03:15: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 03:15:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:15:11 INFO - building 'psutil._psutil_posix' extension 03:15:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:15:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:15:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:15:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:15:11 INFO - Successfully installed psutil 03:15:11 INFO - Cleaning up... 03:15:11 INFO - Return code: 0 03:15:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:15: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')]} 03:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15: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')]} 03:15:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bfb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c2f00>, '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 0x14bdba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14be050>, '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': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:15: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:15: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 mozsystemmonitor==0.3 03:15:11 INFO - Using env: {'DISPLAY': ':0', 03:15:11 INFO - 'HOME': '/home/cltbld', 03:15:11 INFO - 'LANG': 'en_US.UTF-8', 03:15:11 INFO - 'LANGUAGE': 'en_US:en', 03:15:11 INFO - 'LOGNAME': 'cltbld', 03:15:11 INFO - 'MAIL': '/var/mail/cltbld', 03:15:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:11 INFO - 'MOZ_NO_REMOTE': '1', 03:15:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:11 INFO - 'NO_EM_RESTART': '1', 03:15:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:11 INFO - 'PWD': '/builds/slave/test', 03:15:11 INFO - 'SHELL': '/bin/bash', 03:15:11 INFO - 'SHLVL': '1', 03:15:11 INFO - 'TERM': 'linux', 03:15:11 INFO - 'TMOUT': '86400', 03:15:11 INFO - 'USER': 'cltbld', 03:15:11 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 03:15:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:11 INFO - '_': '/tools/buildbot/bin/python'} 03:15:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:15:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:15:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:15:12 INFO - Installing collected packages: mozsystemmonitor 03:15:12 INFO - Running setup.py install for mozsystemmonitor 03:15:12 INFO - Successfully installed mozsystemmonitor 03:15:12 INFO - Cleaning up... 03:15:12 INFO - Return code: 0 03:15:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bfb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c2f00>, '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 0x14bdba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14be050>, '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': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:15:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:15:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:15:12 INFO - Using env: {'DISPLAY': ':0', 03:15:12 INFO - 'HOME': '/home/cltbld', 03:15:12 INFO - 'LANG': 'en_US.UTF-8', 03:15:12 INFO - 'LANGUAGE': 'en_US:en', 03:15:12 INFO - 'LOGNAME': 'cltbld', 03:15:12 INFO - 'MAIL': '/var/mail/cltbld', 03:15:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:12 INFO - 'MOZ_NO_REMOTE': '1', 03:15:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:12 INFO - 'NO_EM_RESTART': '1', 03:15:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:12 INFO - 'PWD': '/builds/slave/test', 03:15:12 INFO - 'SHELL': '/bin/bash', 03:15:12 INFO - 'SHLVL': '1', 03:15:12 INFO - 'TERM': 'linux', 03:15:12 INFO - 'TMOUT': '86400', 03:15:12 INFO - 'USER': 'cltbld', 03:15:12 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 03:15:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:12 INFO - '_': '/tools/buildbot/bin/python'} 03:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:13 INFO - Downloading/unpacking jsonschema==2.5.1 03:15: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 03:15: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 03:15: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 03:15: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 03:15:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:15:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:14 INFO - Downloading functools32-3.2.3-2.tar.gz 03:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:15:14 INFO - warning: no files found matching '*.txt' 03:15:14 INFO - no previously-included directories found matching 'build' 03:15:14 INFO - no previously-included directories found matching 'dist' 03:15:14 INFO - no previously-included directories found matching '.git*' 03:15:14 INFO - Installing collected packages: jsonschema, functools32 03:15:14 INFO - Running setup.py install for functools32 03:15:14 INFO - warning: no files found matching '*.txt' 03:15:14 INFO - no previously-included directories found matching 'build' 03:15:14 INFO - no previously-included directories found matching 'dist' 03:15:14 INFO - no previously-included directories found matching '.git*' 03:15:14 INFO - Successfully installed jsonschema functools32 03:15:14 INFO - Cleaning up... 03:15:14 INFO - Return code: 0 03:15:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x11521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bfb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c2f00>, '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 0x14bdba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14be050>, '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': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:15:14 INFO - Using env: {'DISPLAY': ':0', 03:15:14 INFO - 'HOME': '/home/cltbld', 03:15:14 INFO - 'LANG': 'en_US.UTF-8', 03:15:14 INFO - 'LANGUAGE': 'en_US:en', 03:15:14 INFO - 'LOGNAME': 'cltbld', 03:15:14 INFO - 'MAIL': '/var/mail/cltbld', 03:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:14 INFO - 'MOZ_NO_REMOTE': '1', 03:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:14 INFO - 'NO_EM_RESTART': '1', 03:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:14 INFO - 'PWD': '/builds/slave/test', 03:15:14 INFO - 'SHELL': '/bin/bash', 03:15:14 INFO - 'SHLVL': '1', 03:15:14 INFO - 'TERM': 'linux', 03:15:14 INFO - 'TMOUT': '86400', 03:15:14 INFO - 'USER': 'cltbld', 03:15:14 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 03:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:14 INFO - '_': '/tools/buildbot/bin/python'} 03:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:15:14 INFO - Cleaning up... 03:15:14 INFO - Return code: 0 03:15:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bfb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c2f00>, '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 0x14bdba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14be050>, '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': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:15:14 INFO - Using env: {'DISPLAY': ':0', 03:15:14 INFO - 'HOME': '/home/cltbld', 03:15:14 INFO - 'LANG': 'en_US.UTF-8', 03:15:14 INFO - 'LANGUAGE': 'en_US:en', 03:15:14 INFO - 'LOGNAME': 'cltbld', 03:15:14 INFO - 'MAIL': '/var/mail/cltbld', 03:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:14 INFO - 'MOZ_NO_REMOTE': '1', 03:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:14 INFO - 'NO_EM_RESTART': '1', 03:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:14 INFO - 'PWD': '/builds/slave/test', 03:15:14 INFO - 'SHELL': '/bin/bash', 03:15:14 INFO - 'SHLVL': '1', 03:15:14 INFO - 'TERM': 'linux', 03:15:14 INFO - 'TMOUT': '86400', 03:15:14 INFO - 'USER': 'cltbld', 03:15:14 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 03:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:14 INFO - '_': '/tools/buildbot/bin/python'} 03:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:15 INFO - Downloading/unpacking blobuploader==1.2.4 03:15: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 03:15: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 03:15: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 03:15: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 03:15:16 INFO - Downloading blobuploader-1.2.4.tar.gz 03:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:15:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:15:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:16 INFO - Downloading docopt-0.6.1.tar.gz 03:15:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:15:16 INFO - Installing collected packages: blobuploader, requests, docopt 03:15:16 INFO - Running setup.py install for blobuploader 03:15:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:15:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:15:16 INFO - Running setup.py install for requests 03:15:17 INFO - Running setup.py install for docopt 03:15:17 INFO - Successfully installed blobuploader requests docopt 03:15:17 INFO - Cleaning up... 03:15:17 INFO - Return code: 0 03:15:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:17 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 0x11521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bfb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c2f00>, '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 0x14bdba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14be050>, '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': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:15:17 INFO - Using env: {'DISPLAY': ':0', 03:15:17 INFO - 'HOME': '/home/cltbld', 03:15:17 INFO - 'LANG': 'en_US.UTF-8', 03:15:17 INFO - 'LANGUAGE': 'en_US:en', 03:15:17 INFO - 'LOGNAME': 'cltbld', 03:15:17 INFO - 'MAIL': '/var/mail/cltbld', 03:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:17 INFO - 'MOZ_NO_REMOTE': '1', 03:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:17 INFO - 'NO_EM_RESTART': '1', 03:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:17 INFO - 'PWD': '/builds/slave/test', 03:15:17 INFO - 'SHELL': '/bin/bash', 03:15:17 INFO - 'SHLVL': '1', 03:15:17 INFO - 'TERM': 'linux', 03:15:17 INFO - 'TMOUT': '86400', 03:15:17 INFO - 'USER': 'cltbld', 03:15:17 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 03:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:17 INFO - '_': '/tools/buildbot/bin/python'} 03:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:15:17 INFO - Running setup.py (path:/tmp/pip-ebvEOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:15:17 INFO - Running setup.py (path:/tmp/pip-fgEQ0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:15:17 INFO - Running setup.py (path:/tmp/pip-07_uBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:15:17 INFO - Running setup.py (path:/tmp/pip-IQAnHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:15:17 INFO - Running setup.py (path:/tmp/pip-J3VGM8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:15:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:15:17 INFO - Running setup.py (path:/tmp/pip-U6XFvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:15:18 INFO - Running setup.py (path:/tmp/pip-Qbojsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:15:18 INFO - Running setup.py (path:/tmp/pip-47BsY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:15:18 INFO - Running setup.py (path:/tmp/pip-qx7pLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:15:18 INFO - Running setup.py (path:/tmp/pip-397oUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:15:18 INFO - Running setup.py (path:/tmp/pip-sNoCAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:15:18 INFO - Running setup.py (path:/tmp/pip-7bF_Vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:15:18 INFO - Running setup.py (path:/tmp/pip-scczfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:15:18 INFO - Running setup.py (path:/tmp/pip-OUnwbd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:18 INFO - Running setup.py (path:/tmp/pip-QBpw6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:15:18 INFO - Running setup.py (path:/tmp/pip-vcJH2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:15:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:15:18 INFO - Running setup.py (path:/tmp/pip-6yMiCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:15:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:15:18 INFO - Running setup.py install for manifestparser 03:15:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:15:18 INFO - Running setup.py install for mozcrash 03:15:19 INFO - Running setup.py install for mozdebug 03:15:19 INFO - Running setup.py install for mozdevice 03:15:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:15:19 INFO - Running setup.py install for mozfile 03:15:19 INFO - Running setup.py install for mozhttpd 03:15:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:15:19 INFO - Running setup.py install for mozinfo 03:15:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:15:19 INFO - Running setup.py install for mozInstall 03:15:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:15:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:15:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:15:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:15:19 INFO - Running setup.py install for mozleak 03:15:19 INFO - Running setup.py install for mozlog 03:15:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:15:19 INFO - Running setup.py install for moznetwork 03:15:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:15:19 INFO - Running setup.py install for mozprocess 03:15:20 INFO - Running setup.py install for mozprofile 03:15:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:15:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:15:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:15:20 INFO - Running setup.py install for mozrunner 03:15:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:15:20 INFO - Running setup.py install for mozscreenshot 03:15:20 INFO - Running setup.py install for moztest 03:15:20 INFO - Running setup.py install for mozversion 03:15:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:15:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:15:20 INFO - Cleaning up... 03:15:20 INFO - Return code: 0 03:15:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:20 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 0x11521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bfb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c2f00>, '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 0x14bdba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14be050>, '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': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:15:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:15:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:15:20 INFO - Using env: {'DISPLAY': ':0', 03:15:20 INFO - 'HOME': '/home/cltbld', 03:15:20 INFO - 'LANG': 'en_US.UTF-8', 03:15:20 INFO - 'LANGUAGE': 'en_US:en', 03:15:20 INFO - 'LOGNAME': 'cltbld', 03:15:20 INFO - 'MAIL': '/var/mail/cltbld', 03:15:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:20 INFO - 'MOZ_NO_REMOTE': '1', 03:15:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:20 INFO - 'NO_EM_RESTART': '1', 03:15:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:20 INFO - 'PWD': '/builds/slave/test', 03:15:20 INFO - 'SHELL': '/bin/bash', 03:15:20 INFO - 'SHLVL': '1', 03:15:20 INFO - 'TERM': 'linux', 03:15:20 INFO - 'TMOUT': '86400', 03:15:20 INFO - 'USER': 'cltbld', 03:15:20 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 03:15:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:20 INFO - '_': '/tools/buildbot/bin/python'} 03:15:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:15:20 INFO - Running setup.py (path:/tmp/pip-tPF8Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:15:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:15:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:15:20 INFO - Running setup.py (path:/tmp/pip-dr_vtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:15:21 INFO - Running setup.py (path:/tmp/pip-SyJjiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:15:21 INFO - Running setup.py (path:/tmp/pip-xiKTG6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:15:21 INFO - Running setup.py (path:/tmp/pip-A51bDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:15:21 INFO - Running setup.py (path:/tmp/pip-H53U28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:15:21 INFO - Running setup.py (path:/tmp/pip-XYnJKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:15:21 INFO - Running setup.py (path:/tmp/pip-ngnytw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:15:21 INFO - Running setup.py (path:/tmp/pip-3eb7ZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:15:21 INFO - Running setup.py (path:/tmp/pip-E5GGTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:15:21 INFO - Running setup.py (path:/tmp/pip-lA1vHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:15:21 INFO - Running setup.py (path:/tmp/pip-CcFyEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:15:21 INFO - Running setup.py (path:/tmp/pip-yTqq5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:15:21 INFO - Running setup.py (path:/tmp/pip-x6MhuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:21 INFO - Running setup.py (path:/tmp/pip-BBp_xD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:15:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:15:21 INFO - Running setup.py (path:/tmp/pip-OmAotd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:15:22 INFO - Running setup.py (path:/tmp/pip-epu_Ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:15:22 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:15:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:15: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 03:15: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 03:15: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 03:15: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 03:15:23 INFO - Downloading blessings-1.6.tar.gz 03:15:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:15:23 INFO - Installing collected packages: blessings 03:15:23 INFO - Running setup.py install for blessings 03:15:23 INFO - Successfully installed blessings 03:15:23 INFO - Cleaning up... 03:15:23 INFO - Return code: 0 03:15:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:15:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:15:23 INFO - Reading from file tmpfile_stdout 03:15:23 INFO - Current package versions: 03:15:23 INFO - argparse == 1.2.1 03:15:23 INFO - blessings == 1.6 03:15:23 INFO - blobuploader == 1.2.4 03:15:23 INFO - docopt == 0.6.1 03:15:23 INFO - functools32 == 3.2.3-2 03:15:23 INFO - jsonschema == 2.5.1 03:15:23 INFO - manifestparser == 1.1 03:15:23 INFO - mozInstall == 1.13 03:15:23 INFO - mozcrash == 1.0 03:15:23 INFO - mozdebug == 0.1 03:15:23 INFO - mozdevice == 0.51 03:15:23 INFO - mozfile == 1.2 03:15:23 INFO - mozhttpd == 0.7 03:15:23 INFO - mozinfo == 0.10 03:15:23 INFO - mozleak == 0.1 03:15:23 INFO - mozlog == 3.5 03:15:23 INFO - moznetwork == 0.27 03:15:23 INFO - mozprocess == 0.25 03:15:23 INFO - mozprofile == 0.28 03:15:23 INFO - mozrunner == 6.13 03:15:23 INFO - mozscreenshot == 0.1 03:15:23 INFO - mozsystemmonitor == 0.3 03:15:23 INFO - moztest == 0.8 03:15:23 INFO - mozversion == 1.4 03:15:23 INFO - psutil == 3.1.1 03:15:23 INFO - requests == 1.2.3 03:15:23 INFO - wsgiref == 0.1.2 03:15:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:23 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 0x11521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bfb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c2f00>, '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 0x14bdba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14be050>, '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': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:15:23 INFO - Using env: {'DISPLAY': ':0', 03:15:23 INFO - 'HOME': '/home/cltbld', 03:15:23 INFO - 'LANG': 'en_US.UTF-8', 03:15:23 INFO - 'LANGUAGE': 'en_US:en', 03:15:23 INFO - 'LOGNAME': 'cltbld', 03:15:23 INFO - 'MAIL': '/var/mail/cltbld', 03:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:23 INFO - 'MOZ_NO_REMOTE': '1', 03:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:23 INFO - 'NO_EM_RESTART': '1', 03:15:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:23 INFO - 'PWD': '/builds/slave/test', 03:15:23 INFO - 'SHELL': '/bin/bash', 03:15:23 INFO - 'SHLVL': '1', 03:15:23 INFO - 'TERM': 'linux', 03:15:23 INFO - 'TMOUT': '86400', 03:15:23 INFO - 'USER': 'cltbld', 03:15:23 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 03:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:23 INFO - '_': '/tools/buildbot/bin/python'} 03:15:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:15:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:15:23 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:15:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:15:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:15:25 INFO - Installing collected packages: simplejson 03:15:25 INFO - Running setup.py install for simplejson 03:15:25 INFO - building 'simplejson._speedups' extension 03:15:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:15:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:15:26 INFO - Successfully installed simplejson 03:15:26 INFO - Cleaning up... 03:15:26 INFO - Return code: 0 03:15:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:15:26 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 0x11521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x131ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14bfb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14c2f00>, '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 0x14bdba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14be050>, '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': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:15:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:15:26 INFO - Using env: {'DISPLAY': ':0', 03:15:26 INFO - 'HOME': '/home/cltbld', 03:15:26 INFO - 'LANG': 'en_US.UTF-8', 03:15:26 INFO - 'LANGUAGE': 'en_US:en', 03:15:26 INFO - 'LOGNAME': 'cltbld', 03:15:26 INFO - 'MAIL': '/var/mail/cltbld', 03:15:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:26 INFO - 'MOZ_NO_REMOTE': '1', 03:15:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:26 INFO - 'NO_EM_RESTART': '1', 03:15:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:26 INFO - 'PWD': '/builds/slave/test', 03:15:26 INFO - 'SHELL': '/bin/bash', 03:15:26 INFO - 'SHLVL': '1', 03:15:26 INFO - 'TERM': 'linux', 03:15:26 INFO - 'TMOUT': '86400', 03:15:26 INFO - 'USER': 'cltbld', 03:15:26 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 03:15:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:26 INFO - '_': '/tools/buildbot/bin/python'} 03:15:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:15:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:15:26 INFO - Cleaning up... 03:15:26 INFO - Return code: 0 03:15:26 INFO - Running post-action listener: _resource_record_post_action 03:15:26 INFO - Running post-action listener: _start_resource_monitoring 03:15:26 INFO - Starting resource monitoring. 03:15:26 INFO - [mozharness: 2017-08-15 10:15:26.442355Z] Finished create-virtualenv step (success) 03:15:26 INFO - [mozharness: 2017-08-15 10:15:26.443331Z] Running install step. 03:15:26 INFO - Running pre-action listener: _resource_record_pre_action 03:15:26 INFO - Running main action method: install 03:15:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:15:26 INFO - Reading from file tmpfile_stdout 03:15:26 INFO - Detecting whether we're running mozinstall >=1.0... 03:15:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:15:26 INFO - Reading from file tmpfile_stdout 03:15:26 INFO - Output received: 03:15:26 INFO - Usage: mozinstall [options] installer 03:15:26 INFO - Options: 03:15:26 INFO - -h, --help show this help message and exit 03:15:26 INFO - -d DEST, --destination=DEST 03:15:26 INFO - Directory to install application into. [default: 03:15:26 INFO - "/builds/slave/test"] 03:15:26 INFO - --app=APP Application being installed. [default: firefox] 03:15:26 INFO - mkdir: /builds/slave/test/build/application 03:15:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:15:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:15:44 INFO - Reading from file tmpfile_stdout 03:15:44 INFO - Output received: 03:15:44 INFO - /builds/slave/test/build/application/firefox/firefox 03:15:44 INFO - Running post-action listener: _resource_record_post_action 03:15:44 INFO - [mozharness: 2017-08-15 10:15:44.743082Z] Finished install step (success) 03:15:44 INFO - [mozharness: 2017-08-15 10:15:44.743194Z] Running setup-mitmproxy step. 03:15:44 INFO - Running pre-action listener: _resource_record_pre_action 03:15:44 INFO - Running main action method: setup_mitmproxy 03:15:44 INFO - Skipping: mitmproxy is not required 03:15:44 INFO - Running post-action listener: _resource_record_post_action 03:15:44 INFO - [mozharness: 2017-08-15 10:15:44.743723Z] Finished setup-mitmproxy step (success) 03:15:44 INFO - [mozharness: 2017-08-15 10:15:44.743817Z] Running run-tests step. 03:15:44 INFO - Running pre-action listener: _resource_record_pre_action 03:15:44 INFO - Running pre-action listener: _set_gcov_prefix 03:15:44 INFO - Running main action method: run_tests 03:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:15:44 INFO - Python 2.7.3 03:15:44 INFO - Return code: 0 03:15:44 INFO - grabbing minidump binary from tooltool 03:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:15:44 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 0x14c2f00>, '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 0x14bdba0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14be050>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:15:44 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:15:44 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:15:44 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:15:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:15:44 INFO - Return code: 0 03:15:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:15:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:15:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:15:44 INFO - ENV: RUST_BACKTRACE is now full 03:15:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:15:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:15:44 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/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:15:44 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/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:15:44 INFO - Using env: {'DISPLAY': ':0', 03:15:44 INFO - 'HOME': '/home/cltbld', 03:15:44 INFO - 'LANG': 'en_US.UTF-8', 03:15:44 INFO - 'LANGUAGE': 'en_US:en', 03:15:44 INFO - 'LOGNAME': 'cltbld', 03:15:44 INFO - 'MAIL': '/var/mail/cltbld', 03:15:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:15:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:15:44 INFO - 'MOZ_NO_REMOTE': '1', 03:15:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:15:44 INFO - 'NO_EM_RESTART': '1', 03:15:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:15:44 INFO - 'PWD': '/builds/slave/test', 03:15:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:15:44 INFO - 'RUST_BACKTRACE': 'full', 03:15:44 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:15:44 INFO - 'SHELL': '/bin/bash', 03:15:44 INFO - 'SHLVL': '1', 03:15:44 INFO - 'STYLO_FORCE_ENABLED': '1', 03:15:44 INFO - 'TERM': 'linux', 03:15:44 INFO - 'TMOUT': '86400', 03:15:44 INFO - 'USER': 'cltbld', 03:15:44 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195', 03:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:15:44 INFO - '_': '/tools/buildbot/bin/python'} 03:15:44 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/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:15:45 INFO - mozversion application_buildid: 20170815092123 03:15:45 INFO - mozversion application_changeset: b4b58cf12108a0b49db77781bdcab8cc481fb64b 03:15:45 INFO - mozversion application_display_name: Nightly 03:15:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:15:45 INFO - mozversion application_name: Firefox 03:15:45 INFO - mozversion application_remotingname: firefox 03:15:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:15:45 INFO - mozversion application_vendor: Mozilla 03:15:45 INFO - mozversion application_version: 57.0a1 03:15:45 INFO - mozversion platform_buildid: 20170815092123 03:15:45 INFO - mozversion platform_changeset: b4b58cf12108a0b49db77781bdcab8cc481fb64b 03:15:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:15:45 INFO - mozversion platform_version: 57.0a1 03:15:45 INFO - using testdate: 1502792145 03:15:45 INFO - actual date: 1502792145 03:15:45 INFO - starting webserver on 'localhost:58339' 03:15:45 INFO - SUITE-START | Running 2 tests 03:15:45 INFO - TEST-START | dromaeo_css 03:15:45 INFO - Initialising browser for dromaeo_css test... 03:15:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58339/getInfo.html -profile /tmp/tmpz0BETU/profile 03:15:45 INFO - TEST-INFO | started process 3336 (/builds/slave/test/build/application/firefox/firefox http://localhost:58339/getInfo.html) 03:15:52 INFO - TEST-INFO | 3336: exit 0 03:15:52 INFO - Browser initialized. 03:15:52 INFO - Running cycle 1/1 for dromaeo_css test... 03:15:52 INFO - TEST-INFO | started process 3572 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz0BETU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:53 INFO - PID 3572 | 03:15:53 INFO - PID 3572 | (/builds/slave/test/build/application/firefox/firefox:3626): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:15:53 INFO - PID 3572 | 03:16:03 INFO - PID 3572 | RSS: Main: 171393024 03:16:03 INFO - PID 3572 | 03:19:03 INFO - PID 3572 | Cycle 1(1): loaded http://localhost:58339/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58339/tests/dromaeo/cssquery-ext.html) 03:19:04 INFO - PID 3572 | RSS: Main: 176250880 03:19:04 INFO - PID 3572 | 03:22:06 INFO - PID 3572 | Cycle 1(1): loaded http://localhost:58339/tests/dromaeo/cssquery-ext.html (next: http://localhost:58339/tests/dromaeo/cssquery-jquery.html) 03:22:07 INFO - PID 3572 | RSS: Main: 173899776 03:22:07 INFO - PID 3572 | 03:25:08 INFO - PID 3572 | Cycle 1(1): loaded http://localhost:58339/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58339/tests/dromaeo/cssquery-mootools.html) 03:25:09 INFO - PID 3572 | RSS: Main: 175394816 03:25:09 INFO - PID 3572 | 03:28:11 INFO - PID 3572 | Cycle 1(1): loaded http://localhost:58339/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58339/tests/dromaeo/cssquery-prototype.html) 03:28:12 INFO - PID 3572 | RSS: Main: 173875200 03:28:12 INFO - PID 3572 | 03:31:15 INFO - PID 3572 | Cycle 1(1): loaded http://localhost:58339/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58339/tests/dromaeo/cssquery-yui.html) 03:31:16 INFO - PID 3572 | RSS: Main: 176881664 03:31:16 INFO - PID 3572 | 03:34:18 INFO - PID 3572 | Cycle 1(1): loaded http://localhost:58339/tests/dromaeo/cssquery-yui.html (next: http://localhost:58339/tests/dromaeo/cssquery-dojo.html) 03:34:18 INFO - PID 3572 | RSS: Main: 177844224 03:34:18 INFO - PID 3572 | 03:34:18 INFO - PID 3572 | __start_tp_report 03:34:18 INFO - PID 3572 | _x_x_mozilla_page_load 03:34:18 INFO - PID 3572 | _x_x_mozilla_page_load_details 03:34:18 INFO - PID 3572 | |i|pagename|runs| 03:34:18 INFO - PID 3572 | |0;dojo.html;3122.4067427188834;3153.1328884556747;3157.6842315768426;3159.857806398712;3193.0580478758766;6076.605020673659;6143.32423433422;6151.354107818682;6153.2923713772925;6164.938350616492;6121.357257487955;6141.232345956755;6224.502039836813;6254.093156492306;6297.527685423589;5676.460736230051;5703.116017017359;5712.857178570548;5744.4829965303115;5792.6524408535415;5499.615026948115;5633.60564760467;5725.055365864628;5738.196652468658;5807.564432667546;5582.665040097587;5623.297087864017;5681.573881958849;5685.800996965087;5710.942890571083;5640.746166422521;5700;5704.201411802351;5729.713514324267;5735.340435849889;5565.805196818092;5593.74828132735;5671.829845104653;5676.4323567642905;5678.5741069419955;5922.052471604523;5938.613990090674;5993.910091348634;6001.099835024781;6159.969200153971;6572.8356791080605;6589;6666.6333351665635;6681.265060843303;6694.43097336727;6695.631740254284;6701.1623547056615;6738.730450781963;6759.5606285591275;6800.557963732342;6169.537284703665;6188.721507532172;6200.565960382775;6280.685965701697;6283.654399008053;6699.732010719614;6815.977603359535;6831.28271531492;6911.5853048817235;6917.9308206918295;6442.48460123189;6460.160179176677;6466.159399278158;6466.321036291121;6483.643399613066;6625.204975402982;6629.9337006630285;6687.565308254948;6690.799276021728;6694.698738556776;6618.073469714244;6690.330966903271;6707.832304192434;6713.597184168965;6717.764878229336;6677.065210870482;6678.833029174212;6763.72945082201;6766.357196066366;6783.321667833276;5279.41926388097;5365.1683988980985;5387.865303367369;5442.401335853053;5471.781128754885;4535.9546404536195;4543.409356783597;4556.863294101182;4623.491415944243;4653.092646933816;5808.448197421239;5813.069908814654;5849.88300233993;5868.149118377812;5869.559783016291;6681.432078273401;6690.130283063268;6704.83237919056;6796.25241223465;6803.7618683345845;5612.382637909826;5759.222504961776;5786.797462088806;5846.824595262149;5870.324912635102;5803.506701930383;5845.064789633639;5849.1226316052935;5869.501092407193;5869.706514674249;6395.168628078413;6396.904046439307;6416.807495775134;6418.326075762071;6485;6635.435987940886;6740.561863478858;6747.696353664195;6751.45988320943;6753.223379311442;6504.284528701934;6539.051837483634;6583.242927063449;6585.769498067544;6586.47308215332;6405.679716014274;6587.901181482186;6603.108580341593;6675.499337549801;6700.5309628327495;6639.966800165968;6652.534322597566;6657;6686.632235227109;6688.765893193715;6386.648734319657;6432.807015789534;6441.1304473895425;6450.193725784277;6453.515986300952;6452.741890324334;6473.093766872547;6475.287718350884;6480.157579514822;6483.189601299838;6381.744730210739;6415.615063096229;6422.293547709842;6428.935710643021;6528.412442880163;6455.3221911700475;6511.3163117871945;6546.345365463416;6636.933630663631;6655.134832471747;6242.687865606611;6278.434940855345;6341.49268058545;6371.745130194926;6415.486761059197 03:34:18 INFO - PID 3572 | |1;ext.html;816.8447994880976;820.3642177312578;853.3343991686485;876.145757886061;879.3404946290283;41116.17767644645;42408.78795606018;42508.78745606272;42552.361714574305;42621.14757704844;38459.423108653325;38623.806880965625;38638;38799.41800872989;38816;6726.428253598438;6789.76235831746;6865.725370985179;6878.1058462399815;6882.965585172067;6770.119884415019;6857.3828355448;6908;6915.792526224196;6917.412019978308;6836;6852;6853.554518956252;6853.828654283633;6877.724891004354;6797.388235058844;6834.6582670866255;6838.247792742794;6870.935005074197;6871.175458944908;6192.9380706192815;6215.28524219716;6218.253809542884;6225.844353891143;6253.062040693932;34180.82909585436;34421.13947151316;34500.482492762625;34521.309573808634;34580;3253.869845206189;3271.0350446618304;3295.242094318296;3295.6869097435706;3298.422776014188;27831;27838.582421263698;27925.581116283272;27947;27961.86019069912;4322.740635561876;4331.04716962271;4335.5014173370155;4365.934510982338;4415.690901636886;181629.0918545412;186164;193262;193935;195806;50386.24420633693;50544.24183637249;50584;50591.24113138306;50604.493955060716;52560.47439525556;52606;52627.210591841154;52657.47342526602;52730.472695273325;16166.110863902599;16199.514014579581;16398.426055088014;16461.6707665846;16636.50090497287;13769;13772.931135344259;13864.792028119586;13920.303984800921;13935.09421887574;13071.477140914258;13109.344532773322;13116.344182790823;13171.407286672124;13338.799918001238;5160.225966105114;5170.689758614495;5186.170212765939;5234.528892399702;5295.179247216687;974.2108891797525;987.629638885418;1007.4710776842217;1011.9139873110868;1013.1034034879185;22212.77787222107;22354.77645223527;22670.886645566665;22699.205527806447;22778.544429111324;1108.1854836695022;1113.4655365424642;1117.2905205194759;1124.1961997171898;1134.1663877050362;11983.700407489883;12080.456379462945;12087.274763514217;12185.878141218474;12296.938515307365;202202;204019;204032;204620;204838;52351.73824130855;52475.737621312415;52935.470645293055;52960.470395296325;53088.469115309126;1421.7440860645183;1460.7005563859384;1469.189876286546;1490.5528341497507;1493.4996776079918;22336.77663223347;22524.66213006839;22631.660525092466;22696.319110426713;22859.428514287276;36386.63613363938;36422.27155456929;36465.27069458543;36516;36622.450663240605;193646;193911;194158;194208;194470;33975.830120849234;35952.46071308985;36323;36634.45048324224;36646.45030324494;48042.5195748052;48387;48431.5156848427;48486;48945.75527122484;34973.125671857386;34976.775812847445;35058.474122888685;35341.46987795237;35344.646553534134;34460.31079378348;34840.30319393547;35108.29783404266;35131.47302790409;35381.64618353886;38128.428073579475;38217.80891095638;38364.232715346094;38474;38827.41758873676;33418.49872251967;33676.49485257772;34006.48990265099;34035.48946765751;34111.65888341184;24219.75780242175;24330.27009189727;24569.754302456746;24997.87501062483;25209.495810084063 03:34:18 INFO - PID 3572 | |2;jquery.html;578.9102689083193;579.5542809344568;587.9441453061958;591.2313991810645;603.2278683285394;22316.888415557918;22699.319020429415;23228.303150905456;23246.418839529;23294.88352558239;26691.466170676624;26850.388976661416;26986.865065674694;27068.729312706866;27107.45785084297;6541.542092053558;6709.161354830646;6714.429273511757;6721.529492935497;6723.529352945296;5891.64650120992;6159.291681456622;6375.840603984914;6440.194975628046;6448.54860159789;6336.239651241857;6343.904841427382;6344.3655634436645;6345;6352.396522330394;6390.520710946697;6391.584547004453;6392.55252132351;6395.232572091332;6400.071989561534;5958.433948774859;5961.314448838396;5978.163057171956;5981.970090149565;5993.310769261547;29790.40419191604;30095.398092038256;30568;31243.531347029813;31414.371712565848;1968.6259610673926;2017.4452025692906;2019.2730616978024;2020.0808632072371;2020.101055030512;19781.208751649916;20128.094235759425;20227.39317820453;20452.38642840717;20459.18163273467;2378.8215883808784;2407.2176542623542;2418.661387405765;2428.659987601737;2439.0609615298063;142542;146413;146910;147089;147294;14725.705485890223;15383.769243461356;15504.767428488582;15566.9221653891;15608.219589020504;23672;23689.881550592138;23706;23712.170074047324;23773.286801395985;10662.200334974908;10699.197560182862;10709.357438553712;10862.185336099825;11004.834927476095;10174.248509912411;10201;10236.385816851012;10285.125764310118;10305.330153539995;7904.920950790533;9127.817443651089;9434.575444105032;9498.715038548855;9683.709488715349;2614;2622.659054322926;2699.986500067487;2701.5272327342636;2778.152663437671;950.2777888804559;964.7361955837735;976.9169620582188;992.806402751471;1002.5438425516372;19593.89801132548;20347.491312717004;20428.79571204269;23854.284371468882;23954.281371558533;1000.9549570269355;1045.1116550931647;1046.4140081554353;1050.5430137890041;1062.9202809789297;11271.267367621078;11417;11612.593559225386;11623.07015438763;11701.2979221247;543539;549866;561111;563187;570803;109918;116855.41572292084;117640;118612;122828.38585807013;1249.8937590304745;1263.7346157307068;1303.426492343366;1307.091571357916;1307.2613973105165;20631.484212894797;21052.9999650033;21110.894445527672;21115.155393784076;21610.89194554017;58730;60384.396156037874;61210.38789612047;61221.69389153026;62363;73406;74983;75114;75273.24726752662;75908.62045689736;12498.937505312415;12906;12941.158824676742;14513.854861451673;14950.476733314283;22719.545609088058;23907.760922390553;24031.879840601385;24135;24198.63702044506;18409.90795046016;18709.532261693566;18960.525986849887;19022.429327120208;19026.429207123256;16933;17040.57398565046;17206.741898871278;17469.65060698804;17499.56251093733;18255.634887302444;19274.32539861098;19460.708089378386;19542.511437214183;19576.412707618794;14572;14612.269386530843;14679;14683.55949321522;14694.338754755849;18384.632307354044;18439.81560184381;18606.44180674582;18627.06864656789;18674.71987920155 03:34:18 INFO - PID 3572 | |3;mootools.html;1363.2502123831891;1425.7686720282763;1426.5720283914823;1427.136582367668;1431.770916653335;13940.372683229254;14524.564263072098;14527.927360363197;14552.563423097325;14605.05067170633;15102.924485377585;15275.923620381911;15291.694166116698;15313;15365.462208822693;2660.0689758584485;2694.609281654159;2699.35215548269;2701.0681314946314;2705.2290097322266;2578.974210257892;2596.532624127656;2625.3042943619957;2628.2640860559072;2636.5913283441096;2587.1979686297213;2604.2057172562363;2605.0361366294496;2635.314818147276;2637.4856902903944;2547.783438407738;2571.5114128315654;2573.086554273234;2573.4209802794408;2575;2507.18516482144;2519.7732204101717;2522.3567990162574;2538.860362680052;2546.7580579844885;14210.786838197435;14530.782038269434;14540;14544.054636448596;14550.563483095524;7692.192319806451;7987.520748755093;7996.520208787491;8014.078380986203;8021.67913283468;4966.50334966504;5083.237514372837;5136.229565565195;5245.737713114368;5285.445028272053;1894;1900.515368581017;1945.6497830390524;1964.0768838645813;1969.8916559589218;23902;24014.87992560026;24048.15831445891;24184.274471765875;24600.138995135083;7053.435725141976;7082.20611757277;7174.426045916314;7230.783076507713;7322.3775979042375;19163.520911977033;19165.616687666447;19232.903835481015;19319.22723091089;19342.4197274082;7723.7682869514;8230;8270.37972152091;8271.751847444586;8280.668773249003;5986.640801551921;6251.624902505773;6369.331220221903;6390.712417941204;7405.518641288299;5515.641483303572;5691.0609749391715;5706.857328566736;5786.797462088806;5796.739146738407;1745.659596378694;1745.895246285227;1749.685056689808;1793.2916497983224;1805.0794095011638;885.8936927568733;904.9230815380766;914.7667344827026;916.4043371808244;925.0379605210505;7220.422366210691;7329.413646908234;7375;7441.441891858132;7459.776206713807;721.5634541102662;730.5689643110591;731.4566265180465;736.2747693521984;738.6048464071696;4427.180971520279;4457.554244575516;5663.631863928831;5764.250647415809;5797.4782269595935;19036.809631903503;19040.333588324618;19121.80878191228;19124.2350305989;19210.80789192118;19529.414117576496;19791.60416791656;20523.384298471068;20532.58934821295;20603.58792824135;10931.234813563133;10934.56261749521;11030.338179709242;11058.447077646246;11105.83341249882;8052.355811534946;8275.668973241243;8330.625121869409;8525.701600443954;8574.871376929226;16919.154042298083;17289.740653890454;17405.82594174042;17477.650446991243;17781.1998460067;17584;18094.819051809314;18146.45560633183;18265.269389224282;18481.630367392307;11599;11604.709882253012;11664.475098620413;11933.880661193278;11951.22317049389;12494.250344979331;12714.364281786058;12716.936415318234;12730.554430594884;12733.108682392143;10961.530779371153;11179.776404471702;11180.888191117985;11324.094072474347;11477.08183345347;10620.415877126832;10803.945980270048;10808.729781755519;10882.891171088188;11153.49809258569;9735.756606084904;9895.554700038372;9902.405855648396;9906.752331191778;9908.900910991086;7329.853402932018;7355.668994895135;7371.226021267904;7372.48392612512;7395.149557800922;7356.816079597838;7476.925230747841;7526.623668816428;7591.544507329578;7680.039995000625 03:34:18 INFO - PID 3572 | |4;prototype.html;491.1576646052021;511.30717877276265;514.8455463360992;535.2987586261995;538.4265756968828;6264.185655864731;6294.43350098491;6357.904631430526;6385.936140638592;6402.0396940458895;6194.907076393846;6196.907046394308;6211.409916057979;6242.375762423755;6252.937470625292;4915.729634870081;5051.848444546669;5082.780132768127;5135.691858488484;5186.974065129669;4974.179260422026;5035.949640503603;5037.949620503803;5078.695278283315;5085.135526960407;4883.536064073907;4936.481669424713;4989.800407983676;5009.373828271466;5026.396832380101;4969.428515720684;5006.1990081586955;5031.195008798574;5045.435914866403;5048.823291184827;4507.909841803145;4517.254652982254;4526.275795872678;4528.27547592387;4557.384753058328;5968.224130863004;6016.059481039926;6046.667433291167;6068.939310606882;6122.540809439265;5688.829335119953;5727.284089488814;5741.971290143564;5753.338366087912;5764.279465066867;6557.868842623121;6571.507136964699;6607.240167380764;6614.173228346457;6634.436072933807;4867.3915760529935;4913.378585066919;4933.358663373739;4945.455999840015;4951.207806750903;6744.865102697968;6813.454923606099;6848.828779280558;6955.339242771928;7055;5008.824691135793;5019.548240658285;5064.011948230989;5082.313887625123;5086.720230387365;5068.391792984866;5108.948910510847;5129.589632829365;5160.277561141444;5172.767225474862;5681.460261275172;5764.74058667361;5768.653880767168;5776.624519406225;5788.5369170466265;6610.570312929644;6655.567388119756;6690.498212634072;6701.731930722814;6715.496337774686;1786.214065811039;1786.7141257398753;1802.8197180281868;1805.1606003208572;1807.168702396912;1184.585395111704;1208.667616405478;1235.5799028330412;1238.4210132081669;1243.384524660299;5806.854828629233;5836.474717275466;5893.5874488785375;5899.348182508905;5911.379305172981;6893.75871844483;6911.9308806912295;6914.688839002257;6931.792046238621;6946.680130775137;5840.415958404125;5856.8535786604825;5859.011903929027;5865;5879.001139612466;3631.364511210528;3649.9270014600093;3655.707543396522;3656.305301992666;3669.2661467706566;6622.701978410983;6631.877799104241;6664.900026499607;6711;6746.359095885883;7007.614581197981;7013.614251216232;7045.577265363992;7068.505204635626;7070.505064645426;6604.174478190226;6639.43564796988;6647.335266473314;6664.466842652576;6676.86646267072;6330.335314791881;6838.589684618939;6847.554908930903;6858.794236172923;6877.277885822116;6683.131192944886;6723.697433615401;6789.422899053438;6794.592324460548;6808.489363297674;6594.208694956636;6596.472282217315;6636.800895973129;6652.101966234496;6657.201135863727;5053.823116190915;5055.646104772631;5073.822416215415;5089.422279093493;5098;6533.934660653333;6674.866502670016;6769.120014398097;6839.1451068616425;6864.553804002724;6547.738090476518;6548.770793022221;6576.76981305652;6640.667966601747;6670.7665231716655;6562.77030303937;6583.670816459254;6587.299207324973;6596.8350791230605;6599.7360105595235;6483.610983341015;6507.577007494498;6554.672266386567;6567.507436942344;6591.110200122922;6659.134312539339;6666.133402657623;6691.197056353074;6706.161729783777;6750.898736518858;6483.2544257411;6502.837429064311;6507.121538592419;6526.641034743135;6573.8027859162385 03:34:18 INFO - PID 3572 | |5;yui.html;896.941698789579;916.4592890194783;919.4896832258094;920.1902325953163;936.3773090894556;18659.533511662215;19581.118849651764;19661.705074423877;19672.508187295305;20627.793722062775;21135.365939021816;22423.103075876945;22443.438914027156;22585.887070564626;22638.886805565948;1025.5538840604324;1052.726291164299;1053.289029904815;1054.6308791922843;1055.2771351624124;1019.525920446992;1048.5019615682565;1056.0706578211202;1056.10758908722;1061.2995423020807;1116.8324751287291;1120.0871289898748;1120.1374941295198;1120.9607663731772;1121.2767764791704;1115.3029356652091;1116.0903863351343;1116.4473585575192;1116.7208197950554;1117.251441534174;816.3510009542427;816.4774544291658;817.3787921179886;818.8239528501341;820.9014918209793;20151.395458136278;20658.690119648218;20877.89561052185;20925;21171.78828211729;21618.783812161833;21792;22015.11939522417;22141.114355425765;22232.666510002364;16206.513804585882;16253.024818510927;16485;16689.49931502057;16894.662106757918;3351.5475410819713;3356.2951780126205;3358.529805827186;3359.177001634615;3377.831108444568;131669.3416532911;133743;135018;135330;138075.99999999898;16705.749413758804;16850.91574542144;17354.739678904825;17503;17511.824881751276;31132.533012004384;31192;31193.532097018564;31230.37539249248;31403;7769.805754856174;8056.113827478973;8636.309095272363;8779.385443018928;9019.684311049083;4251.80866860992;4345.174416860787;4353.673474489426;4364.08354245612;4364.62900653448;5109.923351149736;5212.817551385683;5219.712915789668;5227.973860130751;5236.450172731885;1095.4686976816238;1123.5225029362489;1125.060574420368;1140.372794962767;1144.296257801446;670.299536983853;700.6356694518923;707.0243064570963;712.0920825946959;716.2157437605813;11561.537538498535;12400.875991240153;12469;12626;13223.603291901258;635.8187916443884;636.4939872801134;643.9935600643934;647.9838004049842;678.3047376439189;6408.61548307103;6412.935870641234;6607.6365799880505;6619.238787539398;6621.3047629998155;106530.46734766276;111856.4407177959;112392.43803780929;114168.42915785534;117256;97855.99999999857;98697.50651246698;98950.5052474733;99034;100293.99706002993;85307.57346213229;87497.56251218703;89621;92180;93527;12346.814797778221;12727.23636581808;13059.477620895437;13180.604581862559;13419.194848309133;37286.813565931996;39373.60626393814;39762.2463619603;40713.185736285704;41495.1700965985;68629.31370686428;74504.88242676256;75580;75593;78345.60827195828;18270.634587308446;19801.801981979996;19856.40430787021;20384.490387740425;20385.898070509553;21765.891170544044;21919.78080219241;22043.448913777283;22234.555308893407;22262.554748905255;19492.122854471298;19831.30590429328;19969.20123195114;20213.6967945478;20492.38522844317;20093.59812803765;20861;21113.366599002056;21248.15007399687;21317;19577.119029643414;19711.211551538352;19760.802391975896;19886.204551818344;20163.899180504002;13875.375608097862;14822.25888705582;14885.553433397015;15098.773518397453;15130.848691512943;13782.724345512834;13881.444742210198;13968.30158492051;13969.231692256617;14068.296585170905 03:34:18 INFO - PID 3572 | __end_tp_report 03:34:18 INFO - PID 3572 | __start_cc_report 03:34:18 INFO - PID 3572 | _x_x_mozilla_cycle_collect,360 03:34:18 INFO - PID 3572 | __end_cc_report 03:34:18 INFO - PID 3572 | __startTimestamp1502793258423__endTimestamp 03:34:18 INFO - PID 3572 | 03:34:18 INFO - PID 3572 | ------- Summary: start ------- 03:34:18 INFO - PID 3572 | Number of tests: 6 03:34:18 INFO - PID 3572 | 03:34:18 INFO - PID 3572 | [#0] dojo.html Cycles:165 Average:6129.47 Median:6396.90 stddev:729.15 (11.4%) stddev-sans-first:692.18 03:34:18 INFO - PID 3572 | Values: 3122.4 3153.1 3157.7 3159.9 3193.1 6076.6 6143.3 6151.4 6153.3 6164.9 6121.4 6141.2 6224.5 6254.1 6297.5 5676.5 5703.1 5712.9 5744.5 5792.7 5499.6 5633.6 5725.1 5738.2 5807.6 5582.7 5623.3 5681.6 5685.8 5710.9 5640.7 5700.0 5704.2 5729.7 5735.3 5565.8 5593.7 5671.8 5676.4 5678.6 5922.1 5938.6 5993.9 6001.1 6160.0 6572.8 6589.0 6666.6 6681.3 6694.4 6695.6 6701.2 6738.7 6759.6 6800.6 6169.5 6188.7 6200.6 6280.7 6283.7 6699.7 6816.0 6831.3 6911.6 6917.9 6442.5 6460.2 6466.2 6466.3 6483.6 6625.2 6629.9 6687.6 6690.8 6694.7 6618.1 6690.3 6707.8 6713.6 6717.8 6677.1 6678.8 6763.7 6766.4 6783.3 5279.4 5365.2 5387.9 5442.4 5471.8 4536.0 4543.4 4556.9 4623.5 4653.1 5808.4 5813.1 5849.9 5868.1 5869.6 6681.4 6690.1 6704.8 6796.3 6803.8 5612.4 5759.2 5786.8 5846.8 5870.3 5803.5 5845.1 5849.1 5869.5 5869.7 6395.2 6396.9 6416.8 6418.3 6485.0 6635.4 6740.6 6747.7 6751.5 6753.2 6504.3 6539.1 6583.2 6585.8 6586.5 6405.7 6587.9 6603.1 6675.5 6700.5 6640.0 6652.5 6657.0 6686.6 6688.8 6386.6 6432.8 6441.1 6450.2 6453.5 6452.7 6473.1 6475.3 6480.2 6483.2 6381.7 6415.6 6422.3 6428.9 6528.4 6455.3 6511.3 6546.3 6636.9 6655.1 6242.7 6278.4 6341.5 6371.7 6415.5 03:34:18 INFO - PID 3572 | 03:34:18 INFO - PID 3572 | [#1] ext.html Cycles:180 Average:36856.31 Median:35236.47 stddev:50871.34 (144.4%) stddev-sans-first:50942.07 03:34:18 INFO - PID 3572 | Values: 816.8 820.4 853.3 876.1 879.3 41116.2 42408.8 42508.8 42552.4 42621.1 38459.4 38623.8 38638.0 38799.4 38816.0 6726.4 6789.8 6865.7 6878.1 6883.0 6770.1 6857.4 6908.0 6915.8 6917.4 6836.0 6852.0 6853.6 6853.8 6877.7 6797.4 6834.7 6838.2 6870.9 6871.2 6192.9 6215.3 6218.3 6225.8 6253.1 34180.8 34421.1 34500.5 34521.3 34580.0 3253.9 3271.0 3295.2 3295.7 3298.4 27831.0 27838.6 27925.6 27947.0 27961.9 4322.7 4331.0 4335.5 4365.9 4415.7 181629.1 186164.0 193262.0 193935.0 195806.0 50386.2 50544.2 50584.0 50591.2 50604.5 52560.5 52606.0 52627.2 52657.5 52730.5 16166.1 16199.5 16398.4 16461.7 16636.5 13769.0 13772.9 13864.8 13920.3 13935.1 13071.5 13109.3 13116.3 13171.4 13338.8 5160.2 5170.7 5186.2 5234.5 5295.2 974.2 987.6 1007.5 1011.9 1013.1 22212.8 22354.8 22670.9 22699.2 22778.5 1108.2 1113.5 1117.3 1124.2 1134.2 11983.7 12080.5 12087.3 12185.9 12296.9 202202.0 204019.0 204032.0 204620.0 204838.0 52351.7 52475.7 52935.5 52960.5 53088.5 1421.7 1460.7 1469.2 1490.6 1493.5 22336.8 22524.7 22631.7 22696.3 22859.4 36386.6 36422.3 36465.3 36516.0 36622.5 193646.0 193911.0 194158.0 194208.0 194470.0 33975.8 35952.5 36323.0 36634.5 36646.5 48042.5 48387.0 48431.5 48486.0 48945.8 34973.1 34976.8 35058.5 35341.5 35344.6 34460.3 34840.3 35108.3 35131.5 35381.6 38128.4 38217.8 38364.2 38474.0 38827.4 33418.5 33676.5 34006.5 34035.5 34111.7 24219.8 24330.3 24569.8 24997.9 25209.5 03:34:18 INFO - PID 3572 | 03:34:18 INFO - PID 3572 | [#2] jquery.html Cycles:180 Average:37482.03 Median:22709.43 stddev:93391.59 (411.2%) stddev-sans-first:93612.48 03:34:18 INFO - PID 3572 | Values: 578.9 579.6 587.9 591.2 603.2 22316.9 22699.3 23228.3 23246.4 23294.9 26691.5 26850.4 26986.9 27068.7 27107.5 6541.5 6709.2 6714.4 6721.5 6723.5 5891.6 6159.3 6375.8 6440.2 6448.5 6336.2 6343.9 6344.4 6345.0 6352.4 6390.5 6391.6 6392.6 6395.2 6400.1 5958.4 5961.3 5978.2 5982.0 5993.3 29790.4 30095.4 30568.0 31243.5 31414.4 1968.6 2017.4 2019.3 2020.1 2020.1 19781.2 20128.1 20227.4 20452.4 20459.2 2378.8 2407.2 2418.7 2428.7 2439.1 142542.0 146413.0 146910.0 147089.0 147294.0 14725.7 15383.8 15504.8 15566.9 15608.2 23672.0 23689.9 23706.0 23712.2 23773.3 10662.2 10699.2 10709.4 10862.2 11004.8 10174.2 10201.0 10236.4 10285.1 10305.3 7904.9 9127.8 9434.6 9498.7 9683.7 2614.0 2622.7 2700.0 2701.5 2778.2 950.3 964.7 976.9 992.8 1002.5 19593.9 20347.5 20428.8 23854.3 23954.3 1001.0 1045.1 1046.4 1050.5 1062.9 11271.3 11417.0 11612.6 11623.1 11701.3 543539.0 549866.0 561111.0 563187.0 570803.0 109918.0 116855.4 117640.0 118612.0 122828.4 1249.9 1263.7 1303.4 1307.1 1307.3 20631.5 21053.0 21110.9 21115.2 21610.9 58730.0 60384.4 61210.4 61221.7 62363.0 73406.0 74983.0 75114.0 75273.2 75908.6 12498.9 12906.0 12941.2 14513.9 14950.5 22719.5 23907.8 24031.9 24135.0 24198.6 18409.9 18709.5 18960.5 19022.4 19026.4 16933.0 17040.6 17206.7 17469.7 17499.6 18255.6 19274.3 19460.7 19542.5 19576.4 14572.0 14612.3 14679.0 14683.6 14694.3 18384.6 18439.8 18606.4 18627.1 18674.7 03:34:18 INFO - PID 3572 | 03:34:18 INFO - PID 3572 | [#3] mootools.html Cycles:180 Average:9054.11 Median:2559.65 stddev:6269.68 (244.9%) stddev-sans-first:6260.64 03:34:18 INFO - PID 3572 | Values: 1363.3 1425.8 1426.6 1427.1 1431.8 13940.4 14524.6 14527.9 14552.6 14605.1 15102.9 15275.9 15291.7 15313.0 15365.5 2660.1 2694.6 2699.4 2701.1 2705.2 2579.0 2596.5 2625.3 2628.3 2636.6 2587.2 2604.2 2605.0 2635.3 2637.5 2547.8 2571.5 2573.1 2573.4 2575.0 2507.2 2519.8 2522.4 2538.9 2546.8 14210.8 14530.8 14540.0 14544.1 14550.6 7692.2 7987.5 7996.5 8014.1 8021.7 4966.5 5083.2 5136.2 5245.7 5285.4 1894.0 1900.5 1945.6 1964.1 1969.9 23902.0 24014.9 24048.2 24184.3 24600.1 7053.4 7082.2 7174.4 7230.8 7322.4 19163.5 19165.6 19232.9 19319.2 19342.4 7723.8 8230.0 8270.4 8271.8 8280.7 5986.6 6251.6 6369.3 6390.7 7405.5 5515.6 5691.1 5706.9 5786.8 5796.7 1745.7 1745.9 1749.7 1793.3 1805.1 885.9 904.9 914.8 916.4 925.0 7220.4 7329.4 7375.0 7441.4 7459.8 721.6 730.6 731.5 736.3 738.6 4427.2 4457.6 5663.6 5764.3 5797.5 19036.8 19040.3 19121.8 19124.2 19210.8 19529.4 19791.6 20523.4 20532.6 20603.6 10931.2 10934.6 11030.3 11058.4 11105.8 8052.4 8275.7 8330.6 8525.7 8574.9 16919.2 17289.7 17405.8 17477.7 17781.2 17584.0 18094.8 18146.5 18265.3 18481.6 11599.0 11604.7 11664.5 11933.9 11951.2 12494.3 12714.4 12716.9 12730.6 12733.1 10961.5 11179.8 11180.9 11324.1 11477.1 10620.4 10803.9 10808.7 10882.9 11153.5 9735.8 9895.6 9902.4 9906.8 9908.9 7329.9 7355.7 7371.2 7372.5 7395.1 7356.8 7476.9 7526.6 7591.5 7680.0 03:34:18 INFO - PID 3572 | 03:34:18 INFO - PID 3572 | [#4] prototype.html Cycles:180 Average:5585.45 Median:6195.91 stddev:1569.33 (25.3%) stddev-sans-first:1526.45 03:34:18 INFO - PID 3572 | Values: 491.2 511.3 514.8 535.3 538.4 6264.2 6294.4 6357.9 6385.9 6402.0 6194.9 6196.9 6211.4 6242.4 6252.9 4915.7 5051.8 5082.8 5135.7 5187.0 4974.2 5035.9 5037.9 5078.7 5085.1 4883.5 4936.5 4989.8 5009.4 5026.4 4969.4 5006.2 5031.2 5045.4 5048.8 4507.9 4517.3 4526.3 4528.3 4557.4 5968.2 6016.1 6046.7 6068.9 6122.5 5688.8 5727.3 5742.0 5753.3 5764.3 6557.9 6571.5 6607.2 6614.2 6634.4 4867.4 4913.4 4933.4 4945.5 4951.2 6744.9 6813.5 6848.8 6955.3 7055.0 5008.8 5019.5 5064.0 5082.3 5086.7 5068.4 5108.9 5129.6 5160.3 5172.8 5681.5 5764.7 5768.7 5776.6 5788.5 6610.6 6655.6 6690.5 6701.7 6715.5 1786.2 1786.7 1802.8 1805.2 1807.2 1184.6 1208.7 1235.6 1238.4 1243.4 5806.9 5836.5 5893.6 5899.3 5911.4 6893.8 6911.9 6914.7 6931.8 6946.7 5840.4 5856.9 5859.0 5865.0 5879.0 3631.4 3649.9 3655.7 3656.3 3669.3 6622.7 6631.9 6664.9 6711.0 6746.4 7007.6 7013.6 7045.6 7068.5 7070.5 6604.2 6639.4 6647.3 6664.5 6676.9 6330.3 6838.6 6847.6 6858.8 6877.3 6683.1 6723.7 6789.4 6794.6 6808.5 6594.2 6596.5 6636.8 6652.1 6657.2 5053.8 5055.6 5073.8 5089.4 5098.0 6533.9 6674.9 6769.1 6839.1 6864.6 6547.7 6548.8 6576.8 6640.7 6670.8 6562.8 6583.7 6587.3 6596.8 6599.7 6483.6 6507.6 6554.7 6567.5 6591.1 6659.1 6666.1 6691.2 6706.2 6750.9 6483.3 6502.8 6507.1 6526.6 6573.8 03:34:18 INFO - PID 3572 | 03:34:18 INFO - PID 3572 | [#5] yui.html Cycles:180 Average:24795.58 Median:20901.45 stddev:33439.32 (160.0%) stddev-sans-first:33484.98 03:34:18 INFO - PID 3572 | Values: 896.9 916.5 919.5 920.2 936.4 18659.5 19581.1 19661.7 19672.5 20627.8 21135.4 22423.1 22443.4 22585.9 22638.9 1025.6 1052.7 1053.3 1054.6 1055.3 1019.5 1048.5 1056.1 1056.1 1061.3 1116.8 1120.1 1120.1 1121.0 1121.3 1115.3 1116.1 1116.4 1116.7 1117.3 816.4 816.5 817.4 818.8 820.9 20151.4 20658.7 20877.9 20925.0 21171.8 21618.8 21792.0 22015.1 22141.1 22232.7 16206.5 16253.0 16485.0 16689.5 16894.7 3351.5 3356.3 3358.5 3359.2 3377.8 131669.3 133743.0 135018.0 135330.0 138076.0 16705.7 16850.9 17354.7 17503.0 17511.8 31132.5 31192.0 31193.5 31230.4 31403.0 7769.8 8056.1 8636.3 8779.4 9019.7 4251.8 4345.2 4353.7 4364.1 4364.6 5109.9 5212.8 5219.7 5228.0 5236.5 1095.5 1123.5 1125.1 1140.4 1144.3 670.3 700.6 707.0 712.1 716.2 11561.5 12400.9 12469.0 12626.0 13223.6 635.8 636.5 644.0 648.0 678.3 6408.6 6412.9 6607.6 6619.2 6621.3 106530.5 111856.4 112392.4 114168.4 117256.0 97856.0 98697.5 98950.5 99034.0 100294.0 85307.6 87497.6 89621.0 92180.0 93527.0 12346.8 12727.2 13059.5 13180.6 13419.2 37286.8 39373.6 39762.2 40713.2 41495.2 68629.3 74504.9 75580.0 75593.0 78345.6 18270.6 19801.8 19856.4 20384.5 20385.9 21765.9 21919.8 22043.4 22234.6 22262.6 19492.1 19831.3 19969.2 20213.7 20492.4 20093.6 20861.0 21113.4 21248.2 21317.0 19577.1 19711.2 19760.8 19886.2 20163.9 13875.4 14822.3 14885.6 15098.8 15130.8 13782.7 13881.4 13968.3 13969.2 14068.3 03:34:18 INFO - PID 3572 | -------- Summary: end -------- 03:34:18 INFO - PID 3572 | 03:34:19 INFO - TEST-INFO | 3572: exit 0 03:34:19 INFO - TEST-OK | dromaeo_css | took 1113737ms 03:34:19 INFO - TEST-START | kraken 03:34:19 INFO - Initialising browser for kraken test... 03:34:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:58339/getInfo.html -profile /tmp/tmpVEKAEN/profile 03:34:19 INFO - TEST-INFO | started process 3942 (/builds/slave/test/build/application/firefox/firefox http://localhost:58339/getInfo.html) 03:34:24 INFO - TEST-INFO | 3942: exit 0 03:34:25 INFO - Browser initialized. 03:34:25 INFO - Running cycle 1/1 for kraken test... 03:34:25 INFO - TEST-INFO | started process 4178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVEKAEN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:34:26 INFO - PID 4178 | 03:34:26 INFO - PID 4178 | (/builds/slave/test/build/application/firefox/firefox:4232): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:34:26 INFO - PID 4178 | 03:34:36 INFO - PID 4178 | RSS: Main: 168013824 03:34:36 INFO - PID 4178 | 03:34:39 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58339/tests/kraken/driver.html?testName=audio-beat-detection) 03:34:40 INFO - PID 4178 | RSS: Main: 173731840 03:34:40 INFO - PID 4178 | 03:34:42 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58339/tests/kraken/driver.html?testName=audio-dft) 03:34:43 INFO - PID 4178 | RSS: Main: 177430528 03:34:43 INFO - PID 4178 | 03:34:46 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58339/tests/kraken/driver.html?testName=audio-fft) 03:34:47 INFO - PID 4178 | RSS: Main: 172236800 03:34:47 INFO - PID 4178 | 03:34:49 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58339/tests/kraken/driver.html?testName=audio-oscillator) 03:34:49 INFO - PID 4178 | RSS: Main: 172482560 03:34:49 INFO - PID 4178 | 03:34:52 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58339/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:34:52 INFO - PID 4178 | RSS: Main: 172937216 03:34:52 INFO - PID 4178 | 03:34:55 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58339/tests/kraken/driver.html?testName=imaging-darkroom) 03:34:56 INFO - PID 4178 | RSS: Main: 173920256 03:34:56 INFO - PID 4178 | 03:35:00 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58339/tests/kraken/driver.html?testName=imaging-desaturate) 03:35:00 INFO - PID 4178 | RSS: Main: 173531136 03:35:00 INFO - PID 4178 | 03:35:03 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58339/tests/kraken/driver.html?testName=json-parse-financial) 03:35:04 INFO - PID 4178 | RSS: Main: 174624768 03:35:04 INFO - PID 4178 | 03:35:05 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58339/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:35:06 INFO - PID 4178 | RSS: Main: 173830144 03:35:06 INFO - PID 4178 | 03:35:08 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58339/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:35:09 INFO - PID 4178 | RSS: Main: 173715456 03:35:09 INFO - PID 4178 | 03:35:11 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58339/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:35:11 INFO - PID 4178 | RSS: Main: 173932544 03:35:11 INFO - PID 4178 | 03:35:14 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:35:15 INFO - PID 4178 | RSS: Main: 174645248 03:35:15 INFO - PID 4178 | 03:35:18 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:35:19 INFO - PID 4178 | RSS: Main: 174264320 03:35:19 INFO - PID 4178 | 03:35:20 INFO - PID 4178 | Cycle 1(1): loaded http://localhost:58339/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58339/tests/kraken/driver.html?testName=ai-astar) 03:35:21 INFO - PID 4178 | RSS: Main: 175931392 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | __start_tp_report 03:35:21 INFO - PID 4178 | _x_x_mozilla_page_load 03:35:21 INFO - PID 4178 | _x_x_mozilla_page_load_details 03:35:21 INFO - PID 4178 | |i|pagename|runs| 03:35:21 INFO - PID 4178 | |0;ai-astar;98;108;103;108;109;111;111;99;107;111 03:35:21 INFO - PID 4178 | |1;audio-beat-detection;149;121;144;182;131;145;156;124;170;125 03:35:21 INFO - PID 4178 | |2;audio-dft;166;162;162;164;165;175;170;163;166;166 03:35:21 INFO - PID 4178 | |3;audio-fft;76;82;76;170;79;79;76;74;177;79 03:35:21 INFO - PID 4178 | |4;audio-oscillator;78;78;136;80;80;81;136;88;80;136 03:35:21 INFO - PID 4178 | |5;imaging-gaussian-blur;122;113;113;114;115;113;114;115;120;115 03:35:21 INFO - PID 4178 | |6;imaging-darkroom;151;151;151;151;151;152;161;151;152;152 03:35:21 INFO - PID 4178 | |7;imaging-desaturate;94;94;94;94;94;96;94;94;93;95 03:35:21 INFO - PID 4178 | |8;json-parse-financial;52;52;53;55;53;61;53;54;53;53 03:35:21 INFO - PID 4178 | |9;json-stringify-tinderbox;54;54;54;54;54;55;55;54;55;59 03:35:21 INFO - PID 4178 | |10;stanford-crypto-aes;79;77;77;79;78;80;76;89;77;77 03:35:21 INFO - PID 4178 | |11;stanford-crypto-ccm;136;140;132;129;127;143;130;139;123;169 03:35:21 INFO - PID 4178 | |12;stanford-crypto-pbkdf2;174;173;176;185;186;174;176;177;174;174 03:35:21 INFO - PID 4178 | |13;stanford-crypto-sha256-iterative;76;70;71;67;67;70;73;67;66;65 03:35:21 INFO - PID 4178 | __end_tp_report 03:35:21 INFO - PID 4178 | __start_cc_report 03:35:21 INFO - PID 4178 | _x_x_mozilla_cycle_collect,969 03:35:21 INFO - PID 4178 | __end_cc_report 03:35:21 INFO - PID 4178 | __startTimestamp1502793321230__endTimestamp 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | ------- Summary: start ------- 03:35:21 INFO - PID 4178 | Number of tests: 14 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#0] ai-astar Cycles:10 Average:106.50 Median:111.00 stddev:4.86 (4.4%) stddev-sans-first:4.07 03:35:21 INFO - PID 4178 | Values: 98.0 108.0 103.0 108.0 109.0 111.0 111.0 99.0 107.0 111.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:147.00 stddev:20.40 (13.9%) stddev-sans-first:21.57 03:35:21 INFO - PID 4178 | Values: 149.0 121.0 144.0 182.0 131.0 145.0 156.0 124.0 170.0 125.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#2] audio-dft Cycles:10 Average:165.90 Median:166.00 stddev:3.98 (2.4%) stddev-sans-first:4.23 03:35:21 INFO - PID 4178 | Values: 166.0 162.0 162.0 164.0 165.0 175.0 170.0 163.0 166.0 166.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#3] audio-fft Cycles:10 Average:96.80 Median:77.50 stddev:40.52 (52.3%) stddev-sans-first:42.27 03:35:21 INFO - PID 4178 | Values: 76.0 82.0 76.0 170.0 79.0 79.0 76.0 74.0 177.0 79.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:80.00 stddev:26.85 (33.6%) stddev-sans-first:27.55 03:35:21 INFO - PID 4178 | Values: 78.0 78.0 136.0 80.0 80.0 81.0 136.0 88.0 80.0 136.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:115.00 stddev:3.10 (2.7%) stddev-sans-first:2.18 03:35:21 INFO - PID 4178 | Values: 122.0 113.0 113.0 114.0 115.0 113.0 114.0 115.0 120.0 115.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#6] imaging-darkroom Cycles:10 Average:152.30 Median:151.50 stddev:3.09 (2.0%) stddev-sans-first:3.24 03:35:21 INFO - PID 4178 | Values: 151.0 151.0 151.0 151.0 151.0 152.0 161.0 151.0 152.0 152.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 03:35:21 INFO - PID 4178 | Values: 94.0 94.0 94.0 94.0 94.0 96.0 94.0 94.0 93.0 95.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:53.00 stddev:2.64 (5.0%) stddev-sans-first:2.71 03:35:21 INFO - PID 4178 | Values: 52.0 52.0 53.0 55.0 53.0 61.0 53.0 54.0 53.0 53.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#9] json-stringify-tinderbox Cycles:10 Average:54.80 Median:54.50 stddev:1.55 (2.8%) stddev-sans-first:1.62 03:35:21 INFO - PID 4178 | Values: 54.0 54.0 54.0 54.0 54.0 55.0 55.0 54.0 55.0 59.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:78.50 stddev:3.75 (4.8%) stddev-sans-first:3.98 03:35:21 INFO - PID 4178 | Values: 79.0 77.0 77.0 79.0 78.0 80.0 76.0 89.0 77.0 77.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#11] stanford-crypto-ccm Cycles:10 Average:136.80 Median:137.50 stddev:12.94 (9.4%) stddev-sans-first:13.72 03:35:21 INFO - PID 4178 | Values: 136.0 140.0 132.0 129.0 127.0 143.0 130.0 139.0 123.0 169.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.90 Median:176.00 stddev:4.70 (2.7%) stddev-sans-first:4.87 03:35:21 INFO - PID 4178 | Values: 174.0 173.0 176.0 185.0 186.0 174.0 176.0 177.0 174.0 174.0 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:70.00 stddev:3.46 (4.9%) stddev-sans-first:2.65 03:35:21 INFO - PID 4178 | Values: 76.0 70.0 71.0 67.0 67.0 70.0 73.0 67.0 66.0 65.0 03:35:21 INFO - PID 4178 | -------- Summary: end -------- 03:35:21 INFO - PID 4178 | 03:35:21 INFO - PID 4178 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:35:21 INFO - TEST-INFO | 4178: exit 0 03:35:21 INFO - TEST-OK | kraken | took 62887ms 03:35:21 INFO - SUITE-END | took 1176s 03:35:22 INFO - Completed test suite (00:19:37) 03:35:22 INFO - javascript benchmark 03:35:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8581.391491586128, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3122.4067427188834, 3153.1328884556747, 3157.6842315768426, 3159.857806398712, 3193.0580478758766, 6076.605020673659, 6143.32423433422, 6151.354107818682, 6153.2923713772925, 6164.938350616492, 6121.357257487955, 6141.232345956755, 6224.502039836813, 6254.093156492306, 6297.527685423589, 5676.460736230051, 5703.116017017359, 5712.857178570548, 5744.4829965303115, 5792.6524408535415, 5499.615026948115, 5633.60564760467, 5725.055365864628, 5738.196652468658, 5807.564432667546, 5582.665040097587, 5623.297087864017, 5681.573881958849, 5685.800996965087, 5710.942890571083, 5640.746166422521, 5700.0, 5704.201411802351, 5729.713514324267, 5735.340435849889, 5565.805196818092, 5593.74828132735, 5671.829845104653, 5676.4323567642905, 5678.5741069419955, 5922.052471604523, 5938.613990090674, 5993.910091348634, 6001.099835024781, 6159.969200153971, 6572.8356791080605, 6589.0, 6666.6333351665635, 6681.265060843303, 6694.43097336727, 6695.631740254284, 6701.1623547056615, 6738.730450781963, 6759.5606285591275, 6800.557963732342, 6169.537284703665, 6188.721507532172, 6200.565960382775, 6280.685965701697, 6283.654399008053, 6699.732010719614, 6815.977603359535, 6831.28271531492, 6911.5853048817235, 6917.9308206918295, 6442.48460123189, 6460.160179176677, 6466.159399278158, 6466.321036291121, 6483.643399613066, 6625.204975402982, 6629.9337006630285, 6687.565308254948, 6690.799276021728, 6694.698738556776, 6618.073469714244, 6690.330966903271, 6707.832304192434, 6713.597184168965, 6717.764878229336, 6677.065210870482, 6678.833029174212, 6763.72945082201, 6766.357196066366, 6783.321667833276, 5279.41926388097, 5365.1683988980985, 5387.865303367369, 5442.401335853053, 5471.781128754885, 4535.9546404536195, 4543.409356783597, 4556.863294101182, 4623.491415944243, 4653.092646933816, 5808.448197421239, 5813.069908814654, 5849.88300233993, 5868.149118377812, 5869.559783016291, 6681.432078273401, 6690.130283063268, 6704.83237919056, 6796.25241223465, 6803.7618683345845, 5612.382637909826, 5759.222504961776, 5786.797462088806, 5846.824595262149, 5870.324912635102, 5803.506701930383, 5845.064789633639, 5849.1226316052935, 5869.501092407193, 5869.706514674249, 6395.168628078413, 6396.904046439307, 6416.807495775134, 6418.326075762071, 6485.0, 6635.435987940886, 6740.561863478858, 6747.696353664195, 6751.45988320943, 6753.223379311442, 6504.284528701934, 6539.051837483634, 6583.242927063449, 6585.769498067544, 6586.47308215332, 6405.679716014274, 6587.901181482186, 6603.108580341593, 6675.499337549801, 6700.5309628327495, 6639.966800165968, 6652.534322597566, 6657.0, 6686.632235227109, 6688.765893193715, 6386.648734319657, 6432.807015789534, 6441.1304473895425, 6450.193725784277, 6453.515986300952, 6452.741890324334, 6473.093766872547, 6475.287718350884, 6480.157579514822, 6483.189601299838, 6381.744730210739, 6415.615063096229, 6422.293547709842, 6428.935710643021, 6528.412442880163, 6455.3221911700475, 6511.3163117871945, 6546.345365463416, 6636.933630663631, 6655.134832471747, 6242.687865606611, 6278.434940855345, 6341.49268058545, 6371.745130194926, 6415.486761059197], "value": 6074.608215677682, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.8447994880976, 820.3642177312578, 853.3343991686485, 876.145757886061, 879.3404946290283, 41116.17767644645, 42408.78795606018, 42508.78745606272, 42552.361714574305, 42621.14757704844, 38459.423108653325, 38623.806880965625, 38638.0, 38799.41800872989, 38816.0, 6726.428253598438, 6789.76235831746, 6865.725370985179, 6878.1058462399815, 6882.965585172067, 6770.119884415019, 6857.3828355448, 6908.0, 6915.792526224196, 6917.412019978308, 6836.0, 6852.0, 6853.554518956252, 6853.828654283633, 6877.724891004354, 6797.388235058844, 6834.6582670866255, 6838.247792742794, 6870.935005074197, 6871.175458944908, 6192.9380706192815, 6215.28524219716, 6218.253809542884, 6225.844353891143, 6253.062040693932, 34180.82909585436, 34421.13947151316, 34500.482492762625, 34521.309573808634, 34580.0, 3253.869845206189, 3271.0350446618304, 3295.242094318296, 3295.6869097435706, 3298.422776014188, 27831.0, 27838.582421263698, 27925.581116283272, 27947.0, 27961.86019069912, 4322.740635561876, 4331.04716962271, 4335.5014173370155, 4365.934510982338, 4415.690901636886, 181629.0918545412, 186164.0, 193262.0, 193935.0, 195806.0, 50386.24420633693, 50544.24183637249, 50584.0, 50591.24113138306, 50604.493955060716, 52560.47439525556, 52606.0, 52627.210591841154, 52657.47342526602, 52730.472695273325, 16166.110863902599, 16199.514014579581, 16398.426055088014, 16461.6707665846, 16636.50090497287, 13769.0, 13772.931135344259, 13864.792028119586, 13920.303984800921, 13935.09421887574, 13071.477140914258, 13109.344532773322, 13116.344182790823, 13171.407286672124, 13338.799918001238, 5160.225966105114, 5170.689758614495, 5186.170212765939, 5234.528892399702, 5295.179247216687, 974.2108891797525, 987.629638885418, 1007.4710776842217, 1011.9139873110868, 1013.1034034879185, 22212.77787222107, 22354.77645223527, 22670.886645566665, 22699.205527806447, 22778.544429111324, 1108.1854836695022, 1113.4655365424642, 1117.2905205194759, 1124.1961997171898, 1134.1663877050362, 11983.700407489883, 12080.456379462945, 12087.274763514217, 12185.878141218474, 12296.938515307365, 202202.0, 204019.0, 204032.0, 204620.0, 204838.0, 52351.73824130855, 52475.737621312415, 52935.470645293055, 52960.470395296325, 53088.469115309126, 1421.7440860645183, 1460.7005563859384, 1469.189876286546, 1490.5528341497507, 1493.4996776079918, 22336.77663223347, 22524.66213006839, 22631.660525092466, 22696.319110426713, 22859.428514287276, 36386.63613363938, 36422.27155456929, 36465.27069458543, 36516.0, 36622.450663240605, 193646.0, 193911.0, 194158.0, 194208.0, 194470.0, 33975.830120849234, 35952.46071308985, 36323.0, 36634.45048324224, 36646.45030324494, 48042.5195748052, 48387.0, 48431.5156848427, 48486.0, 48945.75527122484, 34973.125671857386, 34976.775812847445, 35058.474122888685, 35341.46987795237, 35344.646553534134, 34460.31079378348, 34840.30319393547, 35108.29783404266, 35131.47302790409, 35381.64618353886, 38128.428073579475, 38217.80891095638, 38364.232715346094, 38474.0, 38827.41758873676, 33418.49872251967, 33676.49485257772, 34006.48990265099, 34035.48946765751, 34111.65888341184, 24219.75780242175, 24330.27009189727, 24569.754302456746, 24997.87501062483, 25209.495810084063], "value": 16721.750326044938, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9102689083193, 579.5542809344568, 587.9441453061958, 591.2313991810645, 603.2278683285394, 22316.888415557918, 22699.319020429415, 23228.303150905456, 23246.418839529, 23294.88352558239, 26691.466170676624, 26850.388976661416, 26986.865065674694, 27068.729312706866, 27107.45785084297, 6541.542092053558, 6709.161354830646, 6714.429273511757, 6721.529492935497, 6723.529352945296, 5891.64650120992, 6159.291681456622, 6375.840603984914, 6440.194975628046, 6448.54860159789, 6336.239651241857, 6343.904841427382, 6344.3655634436645, 6345.0, 6352.396522330394, 6390.520710946697, 6391.584547004453, 6392.55252132351, 6395.232572091332, 6400.071989561534, 5958.433948774859, 5961.314448838396, 5978.163057171956, 5981.970090149565, 5993.310769261547, 29790.40419191604, 30095.398092038256, 30568.0, 31243.531347029813, 31414.371712565848, 1968.6259610673926, 2017.4452025692906, 2019.2730616978024, 2020.0808632072371, 2020.101055030512, 19781.208751649916, 20128.094235759425, 20227.39317820453, 20452.38642840717, 20459.18163273467, 2378.8215883808784, 2407.2176542623542, 2418.661387405765, 2428.659987601737, 2439.0609615298063, 142542.0, 146413.0, 146910.0, 147089.0, 147294.0, 14725.705485890223, 15383.769243461356, 15504.767428488582, 15566.9221653891, 15608.219589020504, 23672.0, 23689.881550592138, 23706.0, 23712.170074047324, 23773.286801395985, 10662.200334974908, 10699.197560182862, 10709.357438553712, 10862.185336099825, 11004.834927476095, 10174.248509912411, 10201.0, 10236.385816851012, 10285.125764310118, 10305.330153539995, 7904.920950790533, 9127.817443651089, 9434.575444105032, 9498.715038548855, 9683.709488715349, 2614.0, 2622.659054322926, 2699.986500067487, 2701.5272327342636, 2778.152663437671, 950.2777888804559, 964.7361955837735, 976.9169620582188, 992.806402751471, 1002.5438425516372, 19593.89801132548, 20347.491312717004, 20428.79571204269, 23854.284371468882, 23954.281371558533, 1000.9549570269355, 1045.1116550931647, 1046.4140081554353, 1050.5430137890041, 1062.9202809789297, 11271.267367621078, 11417.0, 11612.593559225386, 11623.07015438763, 11701.2979221247, 543539.0, 549866.0, 561111.0, 563187.0, 570803.0, 109918.0, 116855.41572292084, 117640.0, 118612.0, 122828.38585807013, 1249.8937590304745, 1263.7346157307068, 1303.426492343366, 1307.091571357916, 1307.2613973105165, 20631.484212894797, 21052.9999650033, 21110.894445527672, 21115.155393784076, 21610.89194554017, 58730.0, 60384.396156037874, 61210.38789612047, 61221.69389153026, 62363.0, 73406.0, 74983.0, 75114.0, 75273.24726752662, 75908.62045689736, 12498.937505312415, 12906.0, 12941.158824676742, 14513.854861451673, 14950.476733314283, 22719.545609088058, 23907.760922390553, 24031.879840601385, 24135.0, 24198.63702044506, 18409.90795046016, 18709.532261693566, 18960.525986849887, 19022.429327120208, 19026.429207123256, 16933.0, 17040.57398565046, 17206.741898871278, 17469.65060698804, 17499.56251093733, 18255.634887302444, 19274.32539861098, 19460.708089378386, 19542.511437214183, 19576.412707618794, 14572.0, 14612.269386530843, 14679.0, 14683.55949321522, 14694.338754755849, 18384.632307354044, 18439.81560184381, 18606.44180674582, 18627.06864656789, 18674.71987920155], "value": 12313.91870700419, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1363.2502123831891, 1425.7686720282763, 1426.5720283914823, 1427.136582367668, 1431.770916653335, 13940.372683229254, 14524.564263072098, 14527.927360363197, 14552.563423097325, 14605.05067170633, 15102.924485377585, 15275.923620381911, 15291.694166116698, 15313.0, 15365.462208822693, 2660.0689758584485, 2694.609281654159, 2699.35215548269, 2701.0681314946314, 2705.2290097322266, 2578.974210257892, 2596.532624127656, 2625.3042943619957, 2628.2640860559072, 2636.5913283441096, 2587.1979686297213, 2604.2057172562363, 2605.0361366294496, 2635.314818147276, 2637.4856902903944, 2547.783438407738, 2571.5114128315654, 2573.086554273234, 2573.4209802794408, 2575.0, 2507.18516482144, 2519.7732204101717, 2522.3567990162574, 2538.860362680052, 2546.7580579844885, 14210.786838197435, 14530.782038269434, 14540.0, 14544.054636448596, 14550.563483095524, 7692.192319806451, 7987.520748755093, 7996.520208787491, 8014.078380986203, 8021.67913283468, 4966.50334966504, 5083.237514372837, 5136.229565565195, 5245.737713114368, 5285.445028272053, 1894.0, 1900.515368581017, 1945.6497830390524, 1964.0768838645813, 1969.8916559589218, 23902.0, 24014.87992560026, 24048.15831445891, 24184.274471765875, 24600.138995135083, 7053.435725141976, 7082.20611757277, 7174.426045916314, 7230.783076507713, 7322.3775979042375, 19163.520911977033, 19165.616687666447, 19232.903835481015, 19319.22723091089, 19342.4197274082, 7723.7682869514, 8230.0, 8270.37972152091, 8271.751847444586, 8280.668773249003, 5986.640801551921, 6251.624902505773, 6369.331220221903, 6390.712417941204, 7405.518641288299, 5515.641483303572, 5691.0609749391715, 5706.857328566736, 5786.797462088806, 5796.739146738407, 1745.659596378694, 1745.895246285227, 1749.685056689808, 1793.2916497983224, 1805.0794095011638, 885.8936927568733, 904.9230815380766, 914.7667344827026, 916.4043371808244, 925.0379605210505, 7220.422366210691, 7329.413646908234, 7375.0, 7441.441891858132, 7459.776206713807, 721.5634541102662, 730.5689643110591, 731.4566265180465, 736.2747693521984, 738.6048464071696, 4427.180971520279, 4457.554244575516, 5663.631863928831, 5764.250647415809, 5797.4782269595935, 19036.809631903503, 19040.333588324618, 19121.80878191228, 19124.2350305989, 19210.80789192118, 19529.414117576496, 19791.60416791656, 20523.384298471068, 20532.58934821295, 20603.58792824135, 10931.234813563133, 10934.56261749521, 11030.338179709242, 11058.447077646246, 11105.83341249882, 8052.355811534946, 8275.668973241243, 8330.625121869409, 8525.701600443954, 8574.871376929226, 16919.154042298083, 17289.740653890454, 17405.82594174042, 17477.650446991243, 17781.1998460067, 17584.0, 18094.819051809314, 18146.45560633183, 18265.269389224282, 18481.630367392307, 11599.0, 11604.709882253012, 11664.475098620413, 11933.880661193278, 11951.22317049389, 12494.250344979331, 12714.364281786058, 12716.936415318234, 12730.554430594884, 12733.108682392143, 10961.530779371153, 11179.776404471702, 11180.888191117985, 11324.094072474347, 11477.08183345347, 10620.415877126832, 10803.945980270048, 10808.729781755519, 10882.891171088188, 11153.49809258569, 9735.756606084904, 9895.554700038372, 9902.405855648396, 9906.752331191778, 9908.900910991086, 7329.853402932018, 7355.668994895135, 7371.226021267904, 7372.48392612512, 7395.149557800922, 7356.816079597838, 7476.925230747841, 7526.623668816428, 7591.544507329578, 7680.039995000625], "value": 6528.3240395727435, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [491.1576646052021, 511.30717877276265, 514.8455463360992, 535.2987586261995, 538.4265756968828, 6264.185655864731, 6294.43350098491, 6357.904631430526, 6385.936140638592, 6402.0396940458895, 6194.907076393846, 6196.907046394308, 6211.409916057979, 6242.375762423755, 6252.937470625292, 4915.729634870081, 5051.848444546669, 5082.780132768127, 5135.691858488484, 5186.974065129669, 4974.179260422026, 5035.949640503603, 5037.949620503803, 5078.695278283315, 5085.135526960407, 4883.536064073907, 4936.481669424713, 4989.800407983676, 5009.373828271466, 5026.396832380101, 4969.428515720684, 5006.1990081586955, 5031.195008798574, 5045.435914866403, 5048.823291184827, 4507.909841803145, 4517.254652982254, 4526.275795872678, 4528.27547592387, 4557.384753058328, 5968.224130863004, 6016.059481039926, 6046.667433291167, 6068.939310606882, 6122.540809439265, 5688.829335119953, 5727.284089488814, 5741.971290143564, 5753.338366087912, 5764.279465066867, 6557.868842623121, 6571.507136964699, 6607.240167380764, 6614.173228346457, 6634.436072933807, 4867.3915760529935, 4913.378585066919, 4933.358663373739, 4945.455999840015, 4951.207806750903, 6744.865102697968, 6813.454923606099, 6848.828779280558, 6955.339242771928, 7055.0, 5008.824691135793, 5019.548240658285, 5064.011948230989, 5082.313887625123, 5086.720230387365, 5068.391792984866, 5108.948910510847, 5129.589632829365, 5160.277561141444, 5172.767225474862, 5681.460261275172, 5764.74058667361, 5768.653880767168, 5776.624519406225, 5788.5369170466265, 6610.570312929644, 6655.567388119756, 6690.498212634072, 6701.731930722814, 6715.496337774686, 1786.214065811039, 1786.7141257398753, 1802.8197180281868, 1805.1606003208572, 1807.168702396912, 1184.585395111704, 1208.667616405478, 1235.5799028330412, 1238.4210132081669, 1243.384524660299, 5806.854828629233, 5836.474717275466, 5893.5874488785375, 5899.348182508905, 5911.379305172981, 6893.75871844483, 6911.9308806912295, 6914.688839002257, 6931.792046238621, 6946.680130775137, 5840.415958404125, 5856.8535786604825, 5859.011903929027, 5865.0, 5879.001139612466, 3631.364511210528, 3649.9270014600093, 3655.707543396522, 3656.305301992666, 3669.2661467706566, 6622.701978410983, 6631.877799104241, 6664.900026499607, 6711.0, 6746.359095885883, 7007.614581197981, 7013.614251216232, 7045.577265363992, 7068.505204635626, 7070.505064645426, 6604.174478190226, 6639.43564796988, 6647.335266473314, 6664.466842652576, 6676.86646267072, 6330.335314791881, 6838.589684618939, 6847.554908930903, 6858.794236172923, 6877.277885822116, 6683.131192944886, 6723.697433615401, 6789.422899053438, 6794.592324460548, 6808.489363297674, 6594.208694956636, 6596.472282217315, 6636.800895973129, 6652.101966234496, 6657.201135863727, 5053.823116190915, 5055.646104772631, 5073.822416215415, 5089.422279093493, 5098.0, 6533.934660653333, 6674.866502670016, 6769.120014398097, 6839.1451068616425, 6864.553804002724, 6547.738090476518, 6548.770793022221, 6576.76981305652, 6640.667966601747, 6670.7665231716655, 6562.77030303937, 6583.670816459254, 6587.299207324973, 6596.8350791230605, 6599.7360105595235, 6483.610983341015, 6507.577007494498, 6554.672266386567, 6567.507436942344, 6591.110200122922, 6659.134312539339, 6666.133402657623, 6691.197056353074, 6706.161729783777, 6750.898736518858, 6483.2544257411, 6502.837429064311, 6507.121538592419, 6526.641034743135, 6573.8027859162385], "value": 5123.0311028401975, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [896.941698789579, 916.4592890194783, 919.4896832258094, 920.1902325953163, 936.3773090894556, 18659.533511662215, 19581.118849651764, 19661.705074423877, 19672.508187295305, 20627.793722062775, 21135.365939021816, 22423.103075876945, 22443.438914027156, 22585.887070564626, 22638.886805565948, 1025.5538840604324, 1052.726291164299, 1053.289029904815, 1054.6308791922843, 1055.2771351624124, 1019.525920446992, 1048.5019615682565, 1056.0706578211202, 1056.10758908722, 1061.2995423020807, 1116.8324751287291, 1120.0871289898748, 1120.1374941295198, 1120.9607663731772, 1121.2767764791704, 1115.3029356652091, 1116.0903863351343, 1116.4473585575192, 1116.7208197950554, 1117.251441534174, 816.3510009542427, 816.4774544291658, 817.3787921179886, 818.8239528501341, 820.9014918209793, 20151.395458136278, 20658.690119648218, 20877.89561052185, 20925.0, 21171.78828211729, 21618.783812161833, 21792.0, 22015.11939522417, 22141.114355425765, 22232.666510002364, 16206.513804585882, 16253.024818510927, 16485.0, 16689.49931502057, 16894.662106757918, 3351.5475410819713, 3356.2951780126205, 3358.529805827186, 3359.177001634615, 3377.831108444568, 131669.3416532911, 133743.0, 135018.0, 135330.0, 138075.99999999898, 16705.749413758804, 16850.91574542144, 17354.739678904825, 17503.0, 17511.824881751276, 31132.533012004384, 31192.0, 31193.532097018564, 31230.37539249248, 31403.0, 7769.805754856174, 8056.113827478973, 8636.309095272363, 8779.385443018928, 9019.684311049083, 4251.80866860992, 4345.174416860787, 4353.673474489426, 4364.08354245612, 4364.62900653448, 5109.923351149736, 5212.817551385683, 5219.712915789668, 5227.973860130751, 5236.450172731885, 1095.4686976816238, 1123.5225029362489, 1125.060574420368, 1140.372794962767, 1144.296257801446, 670.299536983853, 700.6356694518923, 707.0243064570963, 712.0920825946959, 716.2157437605813, 11561.537538498535, 12400.875991240153, 12469.0, 12626.0, 13223.603291901258, 635.8187916443884, 636.4939872801134, 643.9935600643934, 647.9838004049842, 678.3047376439189, 6408.61548307103, 6412.935870641234, 6607.6365799880505, 6619.238787539398, 6621.3047629998155, 106530.46734766276, 111856.4407177959, 112392.43803780929, 114168.42915785534, 117256.0, 97855.99999999857, 98697.50651246698, 98950.5052474733, 99034.0, 100293.99706002993, 85307.57346213229, 87497.56251218703, 89621.0, 92180.0, 93527.0, 12346.814797778221, 12727.23636581808, 13059.477620895437, 13180.604581862559, 13419.194848309133, 37286.813565931996, 39373.60626393814, 39762.2463619603, 40713.185736285704, 41495.1700965985, 68629.31370686428, 74504.88242676256, 75580.0, 75593.0, 78345.60827195828, 18270.634587308446, 19801.801981979996, 19856.40430787021, 20384.490387740425, 20385.898070509553, 21765.891170544044, 21919.78080219241, 22043.448913777283, 22234.555308893407, 22262.554748905255, 19492.122854471298, 19831.30590429328, 19969.20123195114, 20213.6967945478, 20492.38522844317, 20093.59812803765, 20861.0, 21113.366599002056, 21248.15007399687, 21317.0, 19577.119029643414, 19711.211551538352, 19760.802391975896, 19886.204551818344, 20163.899180504002, 13875.375608097862, 14822.25888705582, 14885.553433397015, 15098.773518397453, 15130.848691512943, 13782.724345512834, 13881.444742210198, 13968.30158492051, 13969.231692256617, 14068.296585170905], "value": 9545.428677967462, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1543.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 108.0, 103.0, 108.0, 109.0, 111.0, 111.0, 99.0, 107.0, 111.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 144.0, 182.0, 131.0, 145.0, 156.0, 124.0, 170.0, 125.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 162.0, 164.0, 165.0, 175.0, 170.0, 163.0, 166.0, 166.0], "value": 165.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 82.0, 76.0, 170.0, 79.0, 79.0, 76.0, 74.0, 177.0, 79.0], "value": 96.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 136.0, 80.0, 80.0, 81.0, 136.0, 88.0, 80.0, 136.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 113.0, 113.0, 114.0, 115.0, 113.0, 114.0, 115.0, 120.0, 115.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 151.0, 151.0, 152.0, 161.0, 151.0, 152.0, 152.0], "value": 152.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0, 93.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 55.0, 53.0, 61.0, 53.0, 54.0, 53.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 55.0, 54.0, 55.0, 59.0], "value": 54.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 77.0, 79.0, 78.0, 80.0, 76.0, 89.0, 77.0, 77.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 140.0, 132.0, 129.0, 127.0, 143.0, 130.0, 139.0, 123.0, 169.0], "value": 136.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 176.0, 185.0, 186.0, 174.0, 176.0, 177.0, 174.0, 174.0], "value": 176.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 70.0, 71.0, 67.0, 67.0, 70.0, 73.0, 67.0, 66.0, 65.0], "value": 69.2, "unit": "score"}]}]} 03:35:22 INFO - Return code: 0 03:35:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:35:22 INFO - # TBPL SUCCESS # 03:35:22 INFO - Running post-action listener: _package_coverage_data 03:35:22 INFO - Running post-action listener: _resource_record_post_action 03:35:22 INFO - [mozharness: 2017-08-15 10:35:22.535906Z] Finished run-tests step (success) 03:35:22 INFO - Running post-run listener: _resource_record_post_run 03:35:22 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 5689344; Write bytes: 442691584; Read time: 4304; Write time: 406104 03:35:22 INFO - TinderboxPrint: CPU usage
13.1% 03:35:22 INFO - TinderboxPrint: I/O read bytes / time
5,689,344 / 4,304 03:35:22 INFO - TinderboxPrint: I/O write bytes / time
442,691,584 / 406,104 03:35:22 INFO - TinderboxPrint: CPU idle
8,280.6 (86.8%) 03:35:22 INFO - TinderboxPrint: CPU user
1,201.5 (12.6%) 03:35:22 INFO - TinderboxPrint: Swap in / out
0 / 0 03:35:22 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 8192; Write bytes: 200880128; Read time: 392; Write time: 201944 03:35:22 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:35:22 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3493888; Write bytes: 168935424; Read time: 3544; Write time: 84208 03:35:23 INFO - Running post-run listener: _upload_blobber_files 03:35:23 INFO - Blob upload gear active. 03:35:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:35:23 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 03:35:23 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'] 03:35:23 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 03:35:23 INFO - (blobuploader) - INFO - Open directory for files ... 03:35:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:35:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:35:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:30 INFO - (blobuploader) - INFO - Done attempting. 03:35:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:35:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:35:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:31 INFO - (blobuploader) - INFO - Done attempting. 03:35:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:35:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:35:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:31 INFO - (blobuploader) - INFO - Done attempting. 03:35:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:35:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:35:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:35:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:35:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:35:32 INFO - (blobuploader) - INFO - Done attempting. 03:35:32 INFO - (blobuploader) - INFO - Iteration through files over. 03:35:32 INFO - Return code: 0 03:35:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:35:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:35:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbd3020f084f18750d3a9998a9f7b02cbd23947a53f87dff305a97957028b78ad0873949d957f1887eeb960949820ee460dc78621e5b54c0e9c309e0f292d458", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bc368f55c7904ba36edb9a35869414ebb24c111e585840a2352439ad5c5c1c17ab1ad13a6e55a779772f0550645b93733ce5e01ea65be894126e1f0b66ec183", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15bbb5eb3365cff7e0ea81baa4c0c59611951905e6571627d1d937fc9f2dceb488e0fe20b06205d534245102966ae48d7621c019f5d0fd6802ac17e0e608a609", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/346086e3920b601f55c1a922ce3e49e0a60db3e6783c2238747dc3e8e491dfdd274c9f9ba5252cddc82c9c73a2a5a7e621cfd0020593ea4ea679574fd4c70228"} 03:35:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:35:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:35:32 INFO - Contents: 03:35:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbd3020f084f18750d3a9998a9f7b02cbd23947a53f87dff305a97957028b78ad0873949d957f1887eeb960949820ee460dc78621e5b54c0e9c309e0f292d458", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bc368f55c7904ba36edb9a35869414ebb24c111e585840a2352439ad5c5c1c17ab1ad13a6e55a779772f0550645b93733ce5e01ea65be894126e1f0b66ec183", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15bbb5eb3365cff7e0ea81baa4c0c59611951905e6571627d1d937fc9f2dceb488e0fe20b06205d534245102966ae48d7621c019f5d0fd6802ac17e0e608a609", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/346086e3920b601f55c1a922ce3e49e0a60db3e6783c2238747dc3e8e491dfdd274c9f9ba5252cddc82c9c73a2a5a7e621cfd0020593ea4ea679574fd4c70228"} 03:35:32 INFO - Running post-run listener: copy_logs_to_upload_dir 03:35:32 INFO - Copying logs to upload dir... 03:35:32 INFO - mkdir: /builds/slave/test/build/upload/logs 03:35:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.459085 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-08-15 03:35:32.452648) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 03:35:32.459834) ========= 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=51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbd3020f084f18750d3a9998a9f7b02cbd23947a53f87dff305a97957028b78ad0873949d957f1887eeb960949820ee460dc78621e5b54c0e9c309e0f292d458", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bc368f55c7904ba36edb9a35869414ebb24c111e585840a2352439ad5c5c1c17ab1ad13a6e55a779772f0550645b93733ce5e01ea65be894126e1f0b66ec183", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15bbb5eb3365cff7e0ea81baa4c0c59611951905e6571627d1d937fc9f2dceb488e0fe20b06205d534245102966ae48d7621c019f5d0fd6802ac17e0e608a609", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/346086e3920b601f55c1a922ce3e49e0a60db3e6783c2238747dc3e8e491dfdd274c9f9ba5252cddc82c9c73a2a5a7e621cfd0020593ea4ea679574fd4c70228"} build_url:https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/LqQYgX9sTWiYQ1iQnjcEBw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbd3020f084f18750d3a9998a9f7b02cbd23947a53f87dff305a97957028b78ad0873949d957f1887eeb960949820ee460dc78621e5b54c0e9c309e0f292d458", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1bc368f55c7904ba36edb9a35869414ebb24c111e585840a2352439ad5c5c1c17ab1ad13a6e55a779772f0550645b93733ce5e01ea65be894126e1f0b66ec183", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/15bbb5eb3365cff7e0ea81baa4c0c59611951905e6571627d1d937fc9f2dceb488e0fe20b06205d534245102966ae48d7621c019f5d0fd6802ac17e0e608a609", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/346086e3920b601f55c1a922ce3e49e0a60db3e6783c2238747dc3e8e491dfdd274c9f9ba5252cddc82c9c73a2a5a7e621cfd0020593ea4ea679574fd4c70228"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-15 03:35:32.486040) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:35:32.486362) ========= 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=51fc86400edbde9650d2781a000001d0-1502772156.747206-1491600195 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004390 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-15 03:35:32.570355) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 03:35:32.573718) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-15 03:35:32.574045) ========= ========= Total master_lag: 0.27 =========