builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1502879509.25 results: success (0) revision: 0aa944d3ac94757842143a13fe66f6534817383f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:31:49.249322) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:31:49.249801) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:31:49.250082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:31:49.280992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:31:49.281415) ========= 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=bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 03:31:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2017-08-16 03:31:49 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152102 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:31:49.450786) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:31:49.451165) ========= 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=bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017512 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:31:49.500694) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 03:31:49.501059) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0aa944d3ac94757842143a13fe66f6534817383f --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 0aa944d3ac94757842143a13fe66f6534817383f --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=bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 03:31:49,634 truncating revision to first 12 chars 2017-08-16 03:31:49,634 Setting DEBUG logging. 2017-08-16 03:31:49,634 attempt 1/10 2017-08-16 03:31:49,634 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0aa944d3ac94?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 03:31:50,517 unpacking tar archive at: mozilla-central-0aa944d3ac94/testing/mozharness/ program finished with exit code 0 elapsedTime=1.168499 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-08-16 03:31:50.684431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:31:50.684813) ========= script_repo_revision: 0aa944d3ac94757842143a13fe66f6534817383f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:31:50.685202) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:31:50.685466) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:31:50.696186) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-16 03:31:50.696455) ========= /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=bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:31:51 INFO - MultiFileLogger online at 20170816 03:31:51 in /builds/slave/test 03:31:51 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:31:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:31:51 INFO - {'append_to_log': False, 03:31:51 INFO - 'base_work_dir': '/builds/slave/test', 03:31:51 INFO - 'blob_upload_branch': 'Firefox', 03:31:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:31:51 INFO - 'branch': 'Firefox', 03:31:51 INFO - 'buildbot_json_path': 'buildprops.json', 03:31:51 INFO - 'code_coverage': False, 03:31:51 INFO - 'config_files': ('talos/linux_config.py',), 03:31:51 INFO - 'default_actions': ('clobber', 03:31:51 INFO - 'read-buildbot-config', 03:31:51 INFO - 'download-and-extract', 03:31:51 INFO - 'populate-webroot', 03:31:51 INFO - 'create-virtualenv', 03:31:51 INFO - 'install', 03:31:51 INFO - 'setup-mitmproxy', 03:31:51 INFO - 'run-tests'), 03:31:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:31:51 INFO - 'disable_ccov_upload': False, 03:31:51 INFO - 'download_minidump_stackwalk': True, 03:31:51 INFO - 'download_symbols': 'ondemand', 03:31:51 INFO - 'enable_stylo': False, 03:31:51 INFO - 'enable_webrender': False, 03:31:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:31:51 INFO - 'tooltool.py': '/tools/tooltool.py', 03:31:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:31:51 INFO - '/tools/misc-python/virtualenv.py')}, 03:31:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:31:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:31:51 INFO - 'gecko_profile': False, 03:31:51 INFO - 'gecko_profile_interval': 0, 03:31:51 INFO - 'installer_path': 'installer.exe', 03:31:51 INFO - 'log_level': 'info', 03:31:51 INFO - 'log_name': 'talos', 03:31:51 INFO - 'log_to_console': True, 03:31:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:31:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:31:51 INFO - 'opt_config_files': (), 03:31:51 INFO - 'pip_index': False, 03:31:51 INFO - 'suite': 'dromaeojs-e10s', 03:31:51 INFO - 'system_bits': '32', 03:31:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:31:51 INFO - 'title': 'talos-linux64-ix-055', 03:31:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:31:51 INFO - 'use_talos_json': True, 03:31:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:31:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:31:51 INFO - 'work_dir': 'build'} 03:31:51 INFO - [mozharness: 2017-08-16 10:31:51.030524Z] Running clobber step. 03:31:51 INFO - Running pre-action listener: _resource_record_pre_action 03:31:51 INFO - Running main action method: clobber 03:31:51 INFO - rmtree: /builds/slave/test/build 03:31:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:31:52 INFO - Running post-action listener: _resource_record_post_action 03:31:52 INFO - [mozharness: 2017-08-16 10:31:52.020911Z] Finished clobber step (success) 03:31:52 INFO - [mozharness: 2017-08-16 10:31:52.021013Z] Running read-buildbot-config step. 03:31:52 INFO - Running pre-action listener: _resource_record_pre_action 03:31:52 INFO - Running main action method: read_buildbot_config 03:31:52 INFO - Using buildbot properties: 03:31:52 INFO - { 03:31:52 INFO - "project": "", 03:31:52 INFO - "product": "firefox", 03:31:52 INFO - "who": "cbook@mozilla.com", 03:31:52 INFO - "installer_path": "public/build/target.tar.bz2", 03:31:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:31:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:31:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:31:52 INFO - "stage_platform": "linux64-pgo", 03:31:52 INFO - "basedir": "/builds/slave/test", 03:31:52 INFO - "buildnumber": 122, 03:31:52 INFO - "platform": "ubuntu64_hw", 03:31:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:31:52 INFO - "slavebuilddir": "test", 03:31:52 INFO - "taskId": "ZTJlw8qwQy-fuk_ScjDDJg", 03:31:52 INFO - "branch": "mozilla-central", 03:31:52 INFO - "script_repo_revision": "production", 03:31:52 INFO - "revision": "0aa944d3ac94757842143a13fe66f6534817383f", 03:31:52 INFO - "slavename": "talos-linux64-ix-055", 03:31:52 INFO - "repo_path": "mozilla-central" 03:31:52 INFO - } 03:31:52 INFO - Finding installer, test and symbols from parent task. 03:31:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZTJlw8qwQy-fuk_ScjDDJg'}, attempt #1 03:31:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZTJlw8qwQy-fuk_ScjDDJg'}, attempt #1 03:31:52 INFO - Task dependencies: AtIu2ZuORpy14LOMDAK86Q 03:31:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q'}, attempt #1 03:31:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.tar.bz2 03:31:53 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.test_packages.json 03:31:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.crashreporter-symbols.zip 03:31:53 INFO - Running post-action listener: _resource_record_post_action 03:31:53 INFO - [mozharness: 2017-08-16 10:31:53.375680Z] Finished read-buildbot-config step (success) 03:31:53 INFO - [mozharness: 2017-08-16 10:31:53.375906Z] Running download-and-extract step. 03:31:53 INFO - Running pre-action listener: _resource_record_pre_action 03:31:53 INFO - Running main action method: download_and_extract 03:31:53 INFO - mkdir: /builds/slave/test/build/tests 03:31:53 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:31:53 INFO - trying https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.test_packages.json 03:31:53 INFO - Downloading https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:31:53 INFO - Downloaded 989 bytes. 03:31:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:31:53 INFO - Using the following test package requirements: 03:31:53 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:31:53 INFO - u'common': [u'target.common.tests.zip'], 03:31:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:31:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:31:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:31:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:31:53 INFO - u'mozbase': [u'target.common.tests.zip'], 03:31:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:31:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:31:53 INFO - u'web-platform': [u'target.common.tests.zip', 03:31:53 INFO - u'target.web-platform.tests.tar.gz'], 03:31:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:31:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:31:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.common.tests.zip 03:31:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:31:53 INFO - Fetch https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.common.tests.zip into memory 03:31:54 INFO - Content-Length response header: 54616426 03:31:54 INFO - Bytes received: 54616426 03:32:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:32:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.common.tests.zip 03:32:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:32:05 INFO - Fetch https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.common.tests.zip into memory 03:32:06 INFO - Content-Length response header: 54616426 03:32:06 INFO - Bytes received: 54616426 03:32:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.talos.tests.zip 03:32:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:32:19 INFO - Fetch https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.talos.tests.zip into memory 03:32:19 INFO - Content-Length response header: 14496050 03:32:19 INFO - Bytes received: 14496050 03:32: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:32:20 INFO - trying https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.tar.bz2 03:32:20 INFO - Downloading https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:32:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:32:21 INFO - Downloaded 62809944 bytes. 03:32:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.tar.bz2 03:32:21 INFO - mkdir: /builds/slave/test/properties 03:32:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:32:21 INFO - Writing to file /builds/slave/test/properties/build_url 03:32:21 INFO - Contents: 03:32:21 INFO - build_url:https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.tar.bz2 03:32:21 INFO - Running post-action listener: _resource_record_post_action 03:32:21 INFO - Running post-action listener: set_extra_try_arguments 03:32:21 INFO - [mozharness: 2017-08-16 10:32:21.123583Z] Finished download-and-extract step (success) 03:32:21 INFO - [mozharness: 2017-08-16 10:32:21.123693Z] Running populate-webroot step. 03:32:21 INFO - Running pre-action listener: _resource_record_pre_action 03:32:21 INFO - Running main action method: populate_webroot 03:32:21 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:32:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:32:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:32:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:32:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:32:21 INFO - 'tests': ['damp', 'tps']}, 03:32:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:32:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:32:21 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:32:21 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:32:21 INFO - 'other-e10s': {'tests': ['a11yr', 03:32:21 INFO - 'ts_paint', 03:32:21 INFO - 'tpaint', 03:32:21 INFO - 'sessionrestore', 03:32:21 INFO - 'sessionrestore_many_windows', 03:32:21 INFO - 'sessionrestore_no_auto_restore', 03:32:21 INFO - 'tabpaint']}, 03:32:21 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:32:21 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:32:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:32:21 INFO - 'tsvgr_opacity', 03:32:21 INFO - 'tart', 03:32:21 INFO - 'tscrollx', 03:32:21 INFO - 'tsvg_static']}, 03:32:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:32:21 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:32:21 INFO - 'talos_options': ['--mitmproxy', 03:32:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:32:21 INFO - '--firstNonBlankPaint'], 03:32:21 INFO - 'tests': ['tp6_google', 03:32:21 INFO - 'tp6_youtube', 03:32:21 INFO - 'tp6_amazon', 03:32:21 INFO - 'tp6_facebook']}, 03:32:21 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:32:21 INFO - 'talos_options': ['--stylo', 03:32:21 INFO - '--mitmproxy', 03:32:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:32:21 INFO - '--firstNonBlankPaint'], 03:32:21 INFO - 'tests': ['tp6_google', 03:32:21 INFO - 'tp6_youtube', 03:32:21 INFO - 'tp6_amazon', 03:32:21 INFO - 'tp6_facebook']}, 03:32:21 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:32:21 INFO - 'talos_options': ['--stylo', 03:32:21 INFO - '--stylo-threads=1', 03:32:21 INFO - '--mitmproxy', 03:32:21 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:32:21 INFO - '--firstNonBlankPaint'], 03:32:21 INFO - 'tests': ['tp6_google', 03:32:21 INFO - 'tp6_youtube', 03:32:21 INFO - 'tp6_amazon', 03:32:21 INFO - 'tp6_facebook']}, 03:32:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:32:21 INFO - 'talos_options': ['--xperf_path', 03:32:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:32:21 INFO - 'tests': ['tp5n']}}} 03:32:21 INFO - Running post-action listener: _resource_record_post_action 03:32:21 INFO - [mozharness: 2017-08-16 10:32:21.132531Z] Finished populate-webroot step (success) 03:32:21 INFO - [mozharness: 2017-08-16 10:32:21.132623Z] Running create-virtualenv step. 03:32:21 INFO - Running pre-action listener: _resource_record_pre_action 03:32:21 INFO - Running main action method: create_virtualenv 03:32:21 INFO - Creating virtualenv /builds/slave/test/build/venv 03:32:21 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:32:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:32:21 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:32:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:32:22 INFO - Using real prefix '/usr' 03:32:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:32:23 INFO - Installing distribute.............................................................................................................................................................................................done. 03:32:25 INFO - Installing pip.................done. 03:32:25 INFO - Return code: 0 03:32:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:32:25 INFO - Reading from file tmpfile_stdout 03:32:25 INFO - Output received: 03:32:25 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:32:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee0b0>, '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 0xfeefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', '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:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:32:25 INFO - Using env: {'DISPLAY': ':0', 03:32:25 INFO - 'HOME': '/home/cltbld', 03:32:25 INFO - 'LANG': 'en_US.UTF-8', 03:32:25 INFO - 'LANGUAGE': 'en_US:en', 03:32:25 INFO - 'LOGNAME': 'cltbld', 03:32:25 INFO - 'MAIL': '/var/mail/cltbld', 03:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:25 INFO - 'MOZ_NO_REMOTE': '1', 03:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:25 INFO - 'NO_EM_RESTART': '1', 03:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:25 INFO - 'PWD': '/builds/slave/test', 03:32:25 INFO - 'SHELL': '/bin/bash', 03:32:25 INFO - 'SHLVL': '1', 03:32:25 INFO - 'TERM': 'linux', 03:32:25 INFO - 'TMOUT': '86400', 03:32:25 INFO - 'USER': 'cltbld', 03:32:25 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', 03:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:25 INFO - '_': '/tools/buildbot/bin/python'} 03:32:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:25 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:32:25 INFO - Cleaning up... 03:32:25 INFO - Return code: 0 03:32:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee0b0>, '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 0xfeefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', '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:32:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:32:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:32:25 INFO - Using env: {'DISPLAY': ':0', 03:32:25 INFO - 'HOME': '/home/cltbld', 03:32:25 INFO - 'LANG': 'en_US.UTF-8', 03:32:25 INFO - 'LANGUAGE': 'en_US:en', 03:32:25 INFO - 'LOGNAME': 'cltbld', 03:32:25 INFO - 'MAIL': '/var/mail/cltbld', 03:32:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:25 INFO - 'MOZ_NO_REMOTE': '1', 03:32:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:25 INFO - 'NO_EM_RESTART': '1', 03:32:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:25 INFO - 'PWD': '/builds/slave/test', 03:32:25 INFO - 'SHELL': '/bin/bash', 03:32:25 INFO - 'SHLVL': '1', 03:32:25 INFO - 'TERM': 'linux', 03:32:25 INFO - 'TMOUT': '86400', 03:32:25 INFO - 'USER': 'cltbld', 03:32:25 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', 03:32:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:25 INFO - '_': '/tools/buildbot/bin/python'} 03:32:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:26 INFO - Downloading/unpacking psutil>=3.1.1 03:32:26 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:32:26 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:32:26 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:32:26 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:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:32:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:27 INFO - Installing collected packages: psutil 03:32:27 INFO - Running setup.py install for psutil 03:32:27 INFO - building 'psutil._psutil_linux' extension 03:32:27 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:32:28 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:32:28 INFO - building 'psutil._psutil_posix' extension 03:32:28 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:32:28 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:32:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:32:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:32:28 INFO - Successfully installed psutil 03:32:28 INFO - Cleaning up... 03:32:28 INFO - Return code: 0 03:32:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:32:28 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:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:28 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:32:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:28 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 0xd491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee0b0>, '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 0xfeefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', '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:32:28 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:32:28 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:32:28 INFO - Using env: {'DISPLAY': ':0', 03:32:28 INFO - 'HOME': '/home/cltbld', 03:32:28 INFO - 'LANG': 'en_US.UTF-8', 03:32:28 INFO - 'LANGUAGE': 'en_US:en', 03:32:28 INFO - 'LOGNAME': 'cltbld', 03:32:28 INFO - 'MAIL': '/var/mail/cltbld', 03:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:28 INFO - 'MOZ_NO_REMOTE': '1', 03:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:28 INFO - 'NO_EM_RESTART': '1', 03:32:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:28 INFO - 'PWD': '/builds/slave/test', 03:32:28 INFO - 'SHELL': '/bin/bash', 03:32:28 INFO - 'SHLVL': '1', 03:32:28 INFO - 'TERM': 'linux', 03:32:28 INFO - 'TMOUT': '86400', 03:32:28 INFO - 'USER': 'cltbld', 03:32:28 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', 03:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:28 INFO - '_': '/tools/buildbot/bin/python'} 03:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:32:29 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:32:29 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:32:29 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:32:29 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:32:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:32:30 INFO - Installing collected packages: mozsystemmonitor 03:32:30 INFO - Running setup.py install for mozsystemmonitor 03:32:30 INFO - Successfully installed mozsystemmonitor 03:32:30 INFO - Cleaning up... 03:32:30 INFO - Return code: 0 03:32:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:32:30 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:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:30 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:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:30 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 0xd491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee0b0>, '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 0xfeefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', '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:32:30 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:32:30 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:32:30 INFO - Using env: {'DISPLAY': ':0', 03:32:30 INFO - 'HOME': '/home/cltbld', 03:32:30 INFO - 'LANG': 'en_US.UTF-8', 03:32:30 INFO - 'LANGUAGE': 'en_US:en', 03:32:30 INFO - 'LOGNAME': 'cltbld', 03:32:30 INFO - 'MAIL': '/var/mail/cltbld', 03:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:30 INFO - 'MOZ_NO_REMOTE': '1', 03:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:30 INFO - 'NO_EM_RESTART': '1', 03:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:30 INFO - 'PWD': '/builds/slave/test', 03:32:30 INFO - 'SHELL': '/bin/bash', 03:32:30 INFO - 'SHLVL': '1', 03:32:30 INFO - 'TERM': 'linux', 03:32:30 INFO - 'TMOUT': '86400', 03:32:30 INFO - 'USER': 'cltbld', 03:32:30 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', 03:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:30 INFO - '_': '/tools/buildbot/bin/python'} 03:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:30 INFO - Downloading/unpacking jsonschema==2.5.1 03:32:30 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:32:30 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:32:30 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:32:30 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:32:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:32:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:32:31 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:32:31 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:32:31 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:32:31 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:32:31 INFO - Downloading functools32-3.2.3-2.tar.gz 03:32:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:32:31 INFO - warning: no files found matching '*.txt' 03:32:31 INFO - no previously-included directories found matching 'build' 03:32:31 INFO - no previously-included directories found matching 'dist' 03:32:31 INFO - no previously-included directories found matching '.git*' 03:32:31 INFO - Installing collected packages: jsonschema, functools32 03:32:32 INFO - Running setup.py install for functools32 03:32:32 INFO - warning: no files found matching '*.txt' 03:32:32 INFO - no previously-included directories found matching 'build' 03:32:32 INFO - no previously-included directories found matching 'dist' 03:32:32 INFO - no previously-included directories found matching '.git*' 03:32:32 INFO - Successfully installed jsonschema functools32 03:32:32 INFO - Cleaning up... 03:32:32 INFO - Return code: 0 03:32:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:32 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 0xd491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee0b0>, '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 0xfeefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', '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:32:32 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:32:32 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:32:32 INFO - Using env: {'DISPLAY': ':0', 03:32:32 INFO - 'HOME': '/home/cltbld', 03:32:32 INFO - 'LANG': 'en_US.UTF-8', 03:32:32 INFO - 'LANGUAGE': 'en_US:en', 03:32:32 INFO - 'LOGNAME': 'cltbld', 03:32:32 INFO - 'MAIL': '/var/mail/cltbld', 03:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:32 INFO - 'MOZ_NO_REMOTE': '1', 03:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:32 INFO - 'NO_EM_RESTART': '1', 03:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:32 INFO - 'PWD': '/builds/slave/test', 03:32:32 INFO - 'SHELL': '/bin/bash', 03:32:32 INFO - 'SHLVL': '1', 03:32:32 INFO - 'TERM': 'linux', 03:32:32 INFO - 'TMOUT': '86400', 03:32:32 INFO - 'USER': 'cltbld', 03:32:32 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', 03:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:32 INFO - '_': '/tools/buildbot/bin/python'} 03:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:32:32 INFO - Cleaning up... 03:32:32 INFO - Return code: 0 03:32:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:32 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 0xd491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee0b0>, '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 0xfeefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', '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:32:32 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:32:32 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:32:32 INFO - Using env: {'DISPLAY': ':0', 03:32:32 INFO - 'HOME': '/home/cltbld', 03:32:32 INFO - 'LANG': 'en_US.UTF-8', 03:32:32 INFO - 'LANGUAGE': 'en_US:en', 03:32:32 INFO - 'LOGNAME': 'cltbld', 03:32:32 INFO - 'MAIL': '/var/mail/cltbld', 03:32:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:32 INFO - 'MOZ_NO_REMOTE': '1', 03:32:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:32 INFO - 'NO_EM_RESTART': '1', 03:32:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:32 INFO - 'PWD': '/builds/slave/test', 03:32:32 INFO - 'SHELL': '/bin/bash', 03:32:32 INFO - 'SHLVL': '1', 03:32:32 INFO - 'TERM': 'linux', 03:32:32 INFO - 'TMOUT': '86400', 03:32:32 INFO - 'USER': 'cltbld', 03:32:32 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', 03:32:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:32 INFO - '_': '/tools/buildbot/bin/python'} 03:32:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:32 INFO - Downloading/unpacking blobuploader==1.2.4 03:32:32 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:32:32 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:32:32 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:32:32 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:32:33 INFO - Downloading blobuploader-1.2.4.tar.gz 03:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:32:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:32:33 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:32:33 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:32:33 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:32:33 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:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:32:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:32:34 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:32:34 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:32:34 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:32:34 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:32:34 INFO - Downloading docopt-0.6.1.tar.gz 03:32:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:32:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:32:34 INFO - Running setup.py install for blobuploader 03:32:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:32:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:32:34 INFO - Running setup.py install for requests 03:32:34 INFO - Running setup.py install for docopt 03:32:34 INFO - Successfully installed blobuploader requests docopt 03:32:34 INFO - Cleaning up... 03:32:34 INFO - Return code: 0 03:32:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:34 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:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:34 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:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:34 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 0xd491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee0b0>, '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 0xfeefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', '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:32:34 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:32:34 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:32:34 INFO - Using env: {'DISPLAY': ':0', 03:32:34 INFO - 'HOME': '/home/cltbld', 03:32:34 INFO - 'LANG': 'en_US.UTF-8', 03:32:34 INFO - 'LANGUAGE': 'en_US:en', 03:32:34 INFO - 'LOGNAME': 'cltbld', 03:32:34 INFO - 'MAIL': '/var/mail/cltbld', 03:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:34 INFO - 'MOZ_NO_REMOTE': '1', 03:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:34 INFO - 'NO_EM_RESTART': '1', 03:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:34 INFO - 'PWD': '/builds/slave/test', 03:32:34 INFO - 'SHELL': '/bin/bash', 03:32:34 INFO - 'SHLVL': '1', 03:32:34 INFO - 'TERM': 'linux', 03:32:34 INFO - 'TMOUT': '86400', 03:32:34 INFO - 'USER': 'cltbld', 03:32:34 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', 03:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:34 INFO - '_': '/tools/buildbot/bin/python'} 03:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:35 INFO - Running setup.py (path:/tmp/pip-3cR1vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:35 INFO - Running setup.py (path:/tmp/pip-iPl5_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:35 INFO - Running setup.py (path:/tmp/pip-0y4H7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:35 INFO - Running setup.py (path:/tmp/pip-iSrQaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:35 INFO - Running setup.py (path:/tmp/pip-5iWf33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:35 INFO - Running setup.py (path:/tmp/pip-ffEvNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:35 INFO - Running setup.py (path:/tmp/pip-5GAZo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:35 INFO - Running setup.py (path:/tmp/pip-UsmKir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:35 INFO - Running setup.py (path:/tmp/pip-e_j7OK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:35 INFO - Running setup.py (path:/tmp/pip-S0pXQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:35 INFO - Running setup.py (path:/tmp/pip-huXsl9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:35 INFO - Running setup.py (path:/tmp/pip-vrbds4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:36 INFO - Running setup.py (path:/tmp/pip-2kfN3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:36 INFO - Running setup.py (path:/tmp/pip-02bC35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:36 INFO - Running setup.py (path:/tmp/pip-vU8pDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:36 INFO - Running setup.py (path:/tmp/pip-lUbhfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:36 INFO - Running setup.py (path:/tmp/pip-crqQPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:32:36 INFO - Running setup.py install for manifestparser 03:32:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:32:36 INFO - Running setup.py install for mozcrash 03:32:36 INFO - Running setup.py install for mozdebug 03:32:36 INFO - Running setup.py install for mozdevice 03:32:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:32:36 INFO - Running setup.py install for mozfile 03:32:36 INFO - Running setup.py install for mozhttpd 03:32:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:32:36 INFO - Running setup.py install for mozinfo 03:32:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:32:37 INFO - Running setup.py install for mozInstall 03:32:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:32:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:32:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:32:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:32:37 INFO - Running setup.py install for mozleak 03:32:37 INFO - Running setup.py install for mozlog 03:32:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:32:37 INFO - Running setup.py install for moznetwork 03:32:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:32:37 INFO - Running setup.py install for mozprocess 03:32:37 INFO - Running setup.py install for mozprofile 03:32:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:32:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:32:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:32:37 INFO - Running setup.py install for mozrunner 03:32:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:32:37 INFO - Running setup.py install for mozscreenshot 03:32:37 INFO - Running setup.py install for moztest 03:32:38 INFO - Running setup.py install for mozversion 03:32:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:32:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:32:38 INFO - Cleaning up... 03:32:38 INFO - Return code: 0 03:32:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:38 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:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:38 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:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:38 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 0xd491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee0b0>, '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 0xfeefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', '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:32:38 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:32:38 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:32:38 INFO - Using env: {'DISPLAY': ':0', 03:32:38 INFO - 'HOME': '/home/cltbld', 03:32:38 INFO - 'LANG': 'en_US.UTF-8', 03:32:38 INFO - 'LANGUAGE': 'en_US:en', 03:32:38 INFO - 'LOGNAME': 'cltbld', 03:32:38 INFO - 'MAIL': '/var/mail/cltbld', 03:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:38 INFO - 'MOZ_NO_REMOTE': '1', 03:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:38 INFO - 'NO_EM_RESTART': '1', 03:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:38 INFO - 'PWD': '/builds/slave/test', 03:32:38 INFO - 'SHELL': '/bin/bash', 03:32:38 INFO - 'SHLVL': '1', 03:32:38 INFO - 'TERM': 'linux', 03:32:38 INFO - 'TMOUT': '86400', 03:32:38 INFO - 'USER': 'cltbld', 03:32:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', 03:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:38 INFO - '_': '/tools/buildbot/bin/python'} 03:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:32:38 INFO - Running setup.py (path:/tmp/pip-sU3XRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:32:38 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:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:32:38 INFO - Running setup.py (path:/tmp/pip-OGyGjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:32:38 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:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:32:38 INFO - Running setup.py (path:/tmp/pip-665q_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:32:38 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:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:32:38 INFO - Running setup.py (path:/tmp/pip-dPbTfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:32:38 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:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:32:38 INFO - Running setup.py (path:/tmp/pip-iBUNqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:32:38 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:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:32:38 INFO - Running setup.py (path:/tmp/pip-FGVaEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:32:38 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:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:32:38 INFO - Running setup.py (path:/tmp/pip-_yA_H0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:32:38 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:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:32:38 INFO - Running setup.py (path:/tmp/pip-Fm8BHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:32:38 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:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:32:38 INFO - Running setup.py (path:/tmp/pip-bOcbYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:32:39 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:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:32:39 INFO - Running setup.py (path:/tmp/pip-YbjHyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:32:39 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:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:32:39 INFO - Running setup.py (path:/tmp/pip-xr_X0N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:32:39 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:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:32:39 INFO - Running setup.py (path:/tmp/pip-H7M_E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:32:39 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:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:32:39 INFO - Running setup.py (path:/tmp/pip-vtwhEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:32:39 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:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:32:39 INFO - Running setup.py (path:/tmp/pip-z8lML5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:32:39 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:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:39 INFO - Running setup.py (path:/tmp/pip-Xyatb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:32:39 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:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:32:39 INFO - Running setup.py (path:/tmp/pip-qBg2yC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:32:39 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:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:32:39 INFO - Running setup.py (path:/tmp/pip-L3DT5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:32:39 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:32:39 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:32:39 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:32:39 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:32:39 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:32:39 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:32:39 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:32:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:32:39 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:32:39 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:32:39 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:32:39 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:32:40 INFO - Downloading blessings-1.6.tar.gz 03:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:32:40 INFO - Installing collected packages: blessings 03:32:40 INFO - Running setup.py install for blessings 03:32:40 INFO - Successfully installed blessings 03:32:40 INFO - Cleaning up... 03:32:40 INFO - Return code: 0 03:32:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:41 INFO - Reading from file tmpfile_stdout 03:32:41 INFO - Current package versions: 03:32:41 INFO - argparse == 1.2.1 03:32:41 INFO - blessings == 1.6 03:32:41 INFO - blobuploader == 1.2.4 03:32:41 INFO - docopt == 0.6.1 03:32:41 INFO - functools32 == 3.2.3-2 03:32:41 INFO - jsonschema == 2.5.1 03:32:41 INFO - manifestparser == 1.1 03:32:41 INFO - mozInstall == 1.13 03:32:41 INFO - mozcrash == 1.0 03:32:41 INFO - mozdebug == 0.1 03:32:41 INFO - mozdevice == 0.51 03:32:41 INFO - mozfile == 1.2 03:32:41 INFO - mozhttpd == 0.7 03:32:41 INFO - mozinfo == 0.10 03:32:41 INFO - mozleak == 0.1 03:32:41 INFO - mozlog == 3.5 03:32:41 INFO - moznetwork == 0.27 03:32:41 INFO - mozprocess == 0.25 03:32:41 INFO - mozprofile == 0.28 03:32:41 INFO - mozrunner == 6.13 03:32:41 INFO - mozscreenshot == 0.1 03:32:41 INFO - mozsystemmonitor == 0.3 03:32:41 INFO - moztest == 0.8 03:32:41 INFO - mozversion == 1.4 03:32:41 INFO - psutil == 3.1.1 03:32:41 INFO - requests == 1.2.3 03:32:41 INFO - wsgiref == 0.1.2 03:32:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:41 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 0xd491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee0b0>, '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 0xfeefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', '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:32:41 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:32:41 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:32:41 INFO - Using env: {'DISPLAY': ':0', 03:32:41 INFO - 'HOME': '/home/cltbld', 03:32:41 INFO - 'LANG': 'en_US.UTF-8', 03:32:41 INFO - 'LANGUAGE': 'en_US:en', 03:32:41 INFO - 'LOGNAME': 'cltbld', 03:32:41 INFO - 'MAIL': '/var/mail/cltbld', 03:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:41 INFO - 'MOZ_NO_REMOTE': '1', 03:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:41 INFO - 'NO_EM_RESTART': '1', 03:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:41 INFO - 'PWD': '/builds/slave/test', 03:32:41 INFO - 'SHELL': '/bin/bash', 03:32:41 INFO - 'SHLVL': '1', 03:32:41 INFO - 'TERM': 'linux', 03:32:41 INFO - 'TMOUT': '86400', 03:32:41 INFO - 'USER': 'cltbld', 03:32:41 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', 03:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:41 INFO - '_': '/tools/buildbot/bin/python'} 03:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:41 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:32:41 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:32:41 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:32:41 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:32:41 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:32:41 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:32:41 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:32:41 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:32:41 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:32:41 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:32:41 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:32:41 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:32:41 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:32:41 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:32:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:32:42 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:32:42 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:32:42 INFO - Installing collected packages: simplejson 03:32:42 INFO - Running setup.py install for simplejson 03:32:42 INFO - building 'simplejson._speedups' extension 03:32:42 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:32:43 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:32:43 INFO - Successfully installed simplejson 03:32:43 INFO - Cleaning up... 03:32:43 INFO - Return code: 0 03:32:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:32:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd491f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xff0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfee0b0>, '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 0xfeefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef440>, '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': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', '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:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:32:43 INFO - Using env: {'DISPLAY': ':0', 03:32:43 INFO - 'HOME': '/home/cltbld', 03:32:43 INFO - 'LANG': 'en_US.UTF-8', 03:32:43 INFO - 'LANGUAGE': 'en_US:en', 03:32:43 INFO - 'LOGNAME': 'cltbld', 03:32:43 INFO - 'MAIL': '/var/mail/cltbld', 03:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:32:43 INFO - 'MOZ_NO_REMOTE': '1', 03:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:32:43 INFO - 'NO_EM_RESTART': '1', 03:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:32:43 INFO - 'PWD': '/builds/slave/test', 03:32:43 INFO - 'SHELL': '/bin/bash', 03:32:43 INFO - 'SHLVL': '1', 03:32:43 INFO - 'TERM': 'linux', 03:32:43 INFO - 'TMOUT': '86400', 03:32:43 INFO - 'USER': 'cltbld', 03:32:43 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', 03:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:32:43 INFO - '_': '/tools/buildbot/bin/python'} 03:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:32:43 INFO - Cleaning up... 03:32:43 INFO - Return code: 0 03:32:43 INFO - Running post-action listener: _resource_record_post_action 03:32:43 INFO - Running post-action listener: _start_resource_monitoring 03:32:43 INFO - Starting resource monitoring. 03:32:43 INFO - [mozharness: 2017-08-16 10:32:43.915163Z] Finished create-virtualenv step (success) 03:32:43 INFO - [mozharness: 2017-08-16 10:32:43.916144Z] Running install step. 03:32:43 INFO - Running pre-action listener: _resource_record_pre_action 03:32:43 INFO - Running main action method: install 03:32:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:32:44 INFO - Reading from file tmpfile_stdout 03:32:44 INFO - Detecting whether we're running mozinstall >=1.0... 03:32:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:32:44 INFO - Reading from file tmpfile_stdout 03:32:44 INFO - Output received: 03:32:44 INFO - Usage: mozinstall [options] installer 03:32:44 INFO - Options: 03:32:44 INFO - -h, --help show this help message and exit 03:32:44 INFO - -d DEST, --destination=DEST 03:32:44 INFO - Directory to install application into. [default: 03:32:44 INFO - "/builds/slave/test"] 03:32:44 INFO - --app=APP Application being installed. [default: firefox] 03:32:44 INFO - mkdir: /builds/slave/test/build/application 03:32:44 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:32:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:33:02 INFO - Reading from file tmpfile_stdout 03:33:02 INFO - Output received: 03:33:02 INFO - /builds/slave/test/build/application/firefox/firefox 03:33:02 INFO - Running post-action listener: _resource_record_post_action 03:33:02 INFO - [mozharness: 2017-08-16 10:33:02.047384Z] Finished install step (success) 03:33:02 INFO - [mozharness: 2017-08-16 10:33:02.047665Z] Running setup-mitmproxy step. 03:33:02 INFO - Running pre-action listener: _resource_record_pre_action 03:33:02 INFO - Running main action method: setup_mitmproxy 03:33:02 INFO - Skipping: mitmproxy is not required 03:33:02 INFO - Running post-action listener: _resource_record_post_action 03:33:02 INFO - [mozharness: 2017-08-16 10:33:02.048795Z] Finished setup-mitmproxy step (success) 03:33:02 INFO - [mozharness: 2017-08-16 10:33:02.049029Z] Running run-tests step. 03:33:02 INFO - Running pre-action listener: _resource_record_pre_action 03:33:02 INFO - Running pre-action listener: _set_gcov_prefix 03:33:02 INFO - Running main action method: run_tests 03:33:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:33:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:33:02 INFO - Python 2.7.3 03:33:02 INFO - Return code: 0 03:33:02 INFO - grabbing minidump binary from tooltool 03:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:33:02 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 0xfee0b0>, '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 0xfeefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfef440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:33:02 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:33:02 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:33:02 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:33:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:33:02 INFO - Return code: 0 03:33:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:33:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:33:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:33:02 INFO - ENV: RUST_BACKTRACE is now full 03:33:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:33:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:33:02 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/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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:33:02 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/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-055 --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:33:02 INFO - Using env: {'DISPLAY': ':0', 03:33:02 INFO - 'HOME': '/home/cltbld', 03:33:02 INFO - 'LANG': 'en_US.UTF-8', 03:33:02 INFO - 'LANGUAGE': 'en_US:en', 03:33:02 INFO - 'LOGNAME': 'cltbld', 03:33:02 INFO - 'MAIL': '/var/mail/cltbld', 03:33:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:33:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:33:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:33:02 INFO - 'MOZ_NO_REMOTE': '1', 03:33:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:33:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:33:02 INFO - 'NO_EM_RESTART': '1', 03:33:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:33:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:33:02 INFO - 'PWD': '/builds/slave/test', 03:33:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:33:02 INFO - 'RUST_BACKTRACE': 'full', 03:33:02 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:33:02 INFO - 'SHELL': '/bin/bash', 03:33:02 INFO - 'SHLVL': '1', 03:33:02 INFO - 'TERM': 'linux', 03:33:02 INFO - 'TMOUT': '86400', 03:33:02 INFO - 'USER': 'cltbld', 03:33:02 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820', 03:33:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:33:02 INFO - '_': '/tools/buildbot/bin/python'} 03:33:02 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/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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:33:02 INFO - mozversion application_buildid: 20170816092056 03:33:02 INFO - mozversion application_changeset: 0aa944d3ac94757842143a13fe66f6534817383f 03:33:02 INFO - mozversion application_display_name: Nightly 03:33:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:33:02 INFO - mozversion application_name: Firefox 03:33:02 INFO - mozversion application_remotingname: firefox 03:33:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:33:02 INFO - mozversion application_vendor: Mozilla 03:33:02 INFO - mozversion application_version: 57.0a1 03:33:02 INFO - mozversion platform_buildid: 20170816092056 03:33:02 INFO - mozversion platform_changeset: 0aa944d3ac94757842143a13fe66f6534817383f 03:33:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:33:02 INFO - mozversion platform_version: 57.0a1 03:33:02 INFO - using testdate: 1502879582 03:33:02 INFO - actual date: 1502879582 03:33:02 INFO - starting webserver on 'localhost:33902' 03:33:02 INFO - SUITE-START | Running 2 tests 03:33:02 INFO - TEST-START | dromaeo_css 03:33:02 INFO - Initialising browser for dromaeo_css test... 03:33:02 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33902/getInfo.html -profile /tmp/tmp8lFJ8E/profile 03:33:02 INFO - TEST-INFO | started process 3290 (/builds/slave/test/build/application/firefox/firefox http://localhost:33902/getInfo.html) 03:33:10 INFO - TEST-INFO | 3290: exit 0 03:33:10 INFO - Browser initialized. 03:33:10 INFO - Running cycle 1/1 for dromaeo_css test... 03:33:10 INFO - TEST-INFO | started process 3507 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8lFJ8E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:33:11 INFO - PID 3507 | 03:33:11 INFO - PID 3507 | (/builds/slave/test/build/application/firefox/firefox:3555): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:33:11 INFO - PID 3507 | 03:33:21 INFO - PID 3507 | RSS: Main: 161464320 03:33:21 INFO - PID 3507 | 03:36:19 INFO - PID 3507 | Cycle 1(1): loaded http://localhost:33902/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33902/tests/dromaeo/cssquery-ext.html) 03:36:21 INFO - PID 3507 | RSS: Main: 166256640 03:36:21 INFO - PID 3507 | 03:39:22 INFO - PID 3507 | Cycle 1(1): loaded http://localhost:33902/tests/dromaeo/cssquery-ext.html (next: http://localhost:33902/tests/dromaeo/cssquery-jquery.html) 03:39:23 INFO - PID 3507 | RSS: Main: 163475456 03:39:23 INFO - PID 3507 | 03:42:24 INFO - PID 3507 | Cycle 1(1): loaded http://localhost:33902/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33902/tests/dromaeo/cssquery-mootools.html) 03:42:25 INFO - PID 3507 | RSS: Main: 165351424 03:42:25 INFO - PID 3507 | 03:45:27 INFO - PID 3507 | Cycle 1(1): loaded http://localhost:33902/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33902/tests/dromaeo/cssquery-prototype.html) 03:45:27 INFO - PID 3507 | RSS: Main: 163913728 03:45:27 INFO - PID 3507 | 03:48:30 INFO - PID 3507 | Cycle 1(1): loaded http://localhost:33902/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33902/tests/dromaeo/cssquery-yui.html) 03:48:31 INFO - PID 3507 | RSS: Main: 167505920 03:48:31 INFO - PID 3507 | 03:51:32 INFO - PID 3507 | Cycle 1(1): loaded http://localhost:33902/tests/dromaeo/cssquery-yui.html (next: http://localhost:33902/tests/dromaeo/cssquery-dojo.html) 03:51:33 INFO - PID 3507 | RSS: Main: 168558592 03:51:33 INFO - PID 3507 | 03:51:33 INFO - PID 3507 | __start_tp_report 03:51:33 INFO - PID 3507 | _x_x_mozilla_page_load 03:51:33 INFO - PID 3507 | _x_x_mozilla_page_load_details 03:51:33 INFO - PID 3507 | |i|pagename|runs| 03:51:33 INFO - PID 3507 | |0;dojo.html;3513.244652399735;3546.414841551144;3555.786652800832;3567.6789088981996;3570.125319296773;6287.434130928215;6340.239171299445;6372;6381.7766378176775;6413.74345026199;6218.906716399258;6293.056041593763;6297.307296197415;6301.117843501902;6396.456301214391;5485.259489968853;5514.6139770216105;5532.917006244909;5540.50135487806;5550.2784637997;5171.663841850286;5388.137897936331;5475.123980163175;5567.192757050226;5604.607677462579;5463.125899856024;5488.4785945335125;5532.529734972532;5553.389127196006;5554.1113421852515;5382.946170538284;5499.367572729107;5540.168974653794;5557.194206839986;5564.10974244119;5443.1835224716215;5447.618666693333;5507.807226747084;5526.309211348582;5528.226048353194;6140;6209.813705588795;6212.782552610637;6223.097650840603;6256.2492500899725;6793.320667933217;6803.591784492946;6885.449164066863;6895;6896.103506544167;6794.932050679479;6853.451723862079;6891.310868913069;6905.240423553405;6954.478414118961;6357.904631430532;6406;6434;6434.292227854932;6443.259025212114;7005.50961432705;7024.1571011478945;7029.156501219784;7089.7873063808165;7120.0387947626405;6495.610263384212;6620.569662971891;6626.469882409396;6749.42629876466;6835.487338449537;6770.289119642465;6774.593524388552;6782.423494002966;6789.864202716017;6791.72833086671;6727.562708423937;6736.326367363225;6745.5952642841585;6792.558483698544;6858.108445902001;6681.866362672719;6757.831054223586;6901.62041087735;6907.861842763116;6910.2744211858035;4889.926651100236;4907.1657818171;4907.411110666742;4907.828226012072;4908.484609115992;4375.212461756914;4386.035072284092;4389.100234451929;4396.318570621559;4399.076193999232;6402.48780097591;6406.0390941359165;6477.287498375175;6484.513661475408;6488;6610.471162307004;6749.190097188369;6760.492963027694;6838.555493892881;6885.690143943434;6391.680415979183;6398.776042838478;6399.392057754506;6402.071699603532;6451.387118223855;5540.861478463071;5545.9722701387045;5549.750261238173;5551.25058117149;5563.276774019351;7216;7228.241034691387;7309;7312.561246325131;7324.853502930018;6874.518783685094;6885.2770459101075;6934.549254298556;6959.234484206632;6969.337912898267;7050.5769653820935;7100.573965562083;7175.856482870209;7203.063601731741;7230.168530619047;6659.53383263167;6735.057092007025;6737.831554210988;6745.291744366771;6751.054852320777;6834.2482326943;6867.793966181022;6876.209235937931;6878.484113691593;6890.44876409876;6574.901376479261;6590.604563726;6602.10871532337;6670.966645166744;6671.499637527108;6599.274079851309;6663.300353462817;6675.365840245169;6699.698513566804;6714.563553369016;6657.900131497934;6674.666266686743;6703.631300278532;6733.461323094239;6753.290904455158;6715.865682686416;6733.52865299444;6735.865282694221;6795.898061528982;6798.52410331272;6349.555531112777;6456.806295811133;6486.9351306488215;6497.805065848032;6584.242812076481 03:51:33 INFO - PID 3507 | |1;ext.html;872.088812056652;910.2263076385074;925.8657494663274;960.1166926427686;960.2318145483616;42561.57438425615;43131.56868431315;43215.78392108035;43345.56654433455;43366.34950475742;40679;40838;40914.18171636573;40916;40998.59001409985;6903.620300883437;7025.332593403644;7067.752628657998;7071.929280707204;7081.256468070856;6961.756338528153;7033.015377847106;7045.718171273143;7047.119110111211;7047.6476176191245;7651.464397492177;7744.380449564022;7772.6113694315345;7773;7777.455578109534;7651.617419129021;7720.652570634335;7721.72973945912;7724.150343462243;7724.382049436032;7552.093748750185;7659.195784442665;7671.386289096915;7714.614269286513;7716.996790417266;40420.19159616791;40578.594214057775;40633.39049914254;40670.18659626791;40673.79663101695;3442.6557344265625;3508.2106526031694;3508.561429821272;3509.5613048368955;3509.666581674737;30699.69300307013;30982.845085774654;30999.84500077485;31215.687843121505;31364.37271254562;5042.747862606891;5053.0399224147295;5056.570191533724;5068.898622027576;5094.668846525001;200890;203495;204692;210587;266633.9999999981;54960.45039549634;55141.44858551443;55169;55268;55330.72334638301;56932.43067569354;57101.428985710445;57252.713736431884;57656.423435765944;57695.13457298144;16000.359985600446;16000.919995399949;16065.598360040858;16146.919265403832;16471.752923706154;13144.60566183016;13187.53843615469;13246.602601921957;13251;13261.801072983913;15491.225438728019;15546.611334716723;15570.610734731723;15580.298886550132;15612.219389030502;6167.383261673796;6215.720292586844;6269.153664255358;6278.6860656966965;6316.210473690789;1099.1701265544464;1099.2964502718266;1112.232559533919;1114.2924243105524;1127.836463712757;25047.749522504542;25353.112641057844;25508.872455637604;25536.616950745753;25549.616755748677;1215.8540975083047;1217.4825699077855;1222.6943264183953;1227.5274019502556;1236.0605939485877;13409.932950335186;13441.102080396575;13483.865161348262;13597.32013399326;13729.862701372858;258615;261440;262146;262334;262620;54455.455445445834;54473.18290225571;55061.72469137629;55190.72404637951;55314.446855531736;1499.6250937265684;1516.4768154986511;1536.2011753887916;1549.5506303172178;1562.6015366081576;24741.75382942541;24742.25773226806;30117;30485.390292194475;30767.53848692316;54359;54721.17918231309;54877.72561137169;54906.17640735312;55077.44922550723;229357;229441;229648;232342;232687;37744;37943.43084853785;39646.20707585775;39953.40069899012;40087.59912400955;48183.75908120437;49357;49508.50491495183;49780.75109624429;50071.74964125156;35806.46290305595;36312.4553131698;36478.63521364859;36692.266154677294;36807;36089;36111.45832812457;36132;36209.45685814662;36468.81765591155;41318.76043718693;41850;42144.36783448312;42359.36460953027;42477.78761106298;34454;34684.13289667779;34688;34812.303753925284;34930.301393972484;25761.227163185133;26353;26695.7330426701;27338.5899211508;27605.861970690017 03:51:33 INFO - PID 3507 | |2;jquery.html;570.1390899741392;571.2373980735717;575.1028395702707;581.5754499215573;588.2822955993686;23525.29424117277;23607.645885311693;24311.392215194606;24311.392215194628;24316.27051188467;26215.86892065542;26788.732112678867;26878.059267925626;26893.596596051026;26981.595276070875;6349.809505714825;6454.386833250834;6457.096006559085;6476.708548115323;6482.578632388903;5969.104634304846;6197.566170368076;6210.689465526728;6218.067289906528;6365.713542890581;6152.292486364081;6161.661108639023;6162.691865406712;6170;6185.938140618604;6149.661768602725;6150.415710507495;6194.8451288717915;6198.380161983766;6205.968970155143;5750.482456578886;5754.482096611283;5762.308522977228;5763.337216220147;5776.768929242825;28739.856300718573;31054.68945310563;31726.524102138486;31816.363672726646;31999.84000080008;2177.074743234135;2207.39296693409;2208.7018252535863;2209.1163534586135;2209.4365936686204;20448.693269600968;20717.482062948395;20729.170833166805;20736.792632073637;20740.792592074038;2452.6811514503;2467.099508679337;2508.6487891694997;2518.987405062963;2570.7814835738986;160552;164060.9999999988;165120.17439912845;165327;165381;15219.771703424458;15684.372625095097;15915.204239787965;15917.602059948362;16027.278772455267;23826.689532075554;23890.52218955611;23909.880450597637;23926.401839954142;23929.16247931314;10788;10823.242373033812;10948.34309941406;10985;11113.444327783578;8995.505247211335;9345.859812102824;10047.24645651579;10198.898011019943;10211.132053775364;9331;9890.357126786736;9950.35322704022;9985.30102892805;10019.79960400788;2755.9724402755714;2765.6855305722734;2773.6898555785747;2777.666679998413;2893.8119022263486;1053.5733028123623;1070.6145787516489;1075.1291453922347;1078.962236321725;1079.0989523747758;21565.78434215669;21926;21978.45053873634;22035.338939831832;22068.117275308807;1125.482278152043;1127.1884243344778;1127.9041281491166;1135.3188087147646;1139.7606502634374;11804.58683946075;11986.820197697041;12190.634280971584;12290.20113692607;12352.567660131852;483438;504208;510432;526835;528233;129964;135228;135951.32024339816;137471.31264343613;138411;1222.3521533587214;1240.5968060380412;1259.8236246925437;1271.802870555084;1277.303869391184;18754.6249075015;18874;18913.621727565645;18992.715109273096;19577;67527.32472675211;68509.3149068503;68760;69410.3058969424;69707.65146174439;83175.584122079;84123;84161.57919210364;84930;85273.57363213145;14827.33277002559;15270.160141191896;15271.694566108838;15305.540833775005;15316.540503784905;24531.632025519273;24801.379965501008;24923.75076249214;25070.99716011339;25266.36834079163;20138.19447222095;20158.092885820468;20386.59226815485;20392.59214815725;20474.283400080927;17950.19224134891;18006.279748809902;18087.457376278733;18434.170462329497;18512.72230916564;19586.216551337788;19684.311049113214;20456.693149603067;20718.378448646567;20819.791802081785;15125.924370378078;15164.848351516344;15173.089614623157;15192.544223673307;15205.467808626645;19927.402177934684;20150.89924550368;20316.89841550783;20440.897795510926;20447 03:51:33 INFO - PID 3507 | |3;mootools.html;1418.8652078052585;1471.8528147185277;1481.3778213150476;1493.7012597480507;1499.7450433426313;15633.218339083043;16273.918630406846;16281.348746050144;16291.266892989828;16311.429099981504;15754.76367854483;16601.83398166018;16603.584910377216;16613.584660383465;16627.251773670185;2592.494463579603;2653.7478939500716;2655.4423571050006;2655.81409301349;2657.7342265773364;2707.91876243713;2715.456908618274;2724.4006318609872;2816.873240704163;2817.67596726376;2741.561350183971;2748.0656576763895;2764.7788176945796;2769.0308392062716;2774.4728501584636;2648.6689163854517;2693.2997420670667;2729.959050614242;2748.093129267347;2748.738869807365;2540.047482194177;2577.768000879911;2580.019592554836;2592.157548796649;2677.5582028965196;16030.278637461342;16130.274137663833;16149.354025838953;16152.83847161525;16167.353305867751;8481.745547633582;8759.562021898879;8760.561971901443;8763.079876612928;8767;5407.918881216785;5701.401352857932;5802.245708057968;5814;5821.068629019379;1771;1796.119901248392;1797.3888877781617;1844.1424737496993;1847.1503108569939;28308.858455707796;28680.139595812157;28735.85632071847;29252.268693282836;30098;6907.792766217021;7001.92998070023;7063.92936070643;7192.244814294424;7192.4246060315045;18689.25242990265;18690.06549672511;18819;22334.441638959157;22620.077293429913;8860.158284962918;9094.727158185266;9100.726978190665;9102.998670146279;9104.635814567344;7517.887231691529;8044.477108987897;8081.919180808117;8096.433249672466;8105.230003149692;5795.420457954171;6000.489958353589;6012.849678757979;6021.367756385516;6046.3349031606485;1728.5246557196872;1749.160403006564;1755.1048965027928;1770.4246120011048;1778.2531336838558;975.5805003848271;1004.7437903334749;1006.7080546641538;1007.6120693533043;1027.753339198587;8525.104863989316;8525.31797456202;8540.40217184791;8566.914330856736;8635;757.1255200243727;760.2245709376405;768.2893323675578;1063.8509613470837;1116.2576886370473;5637.210790489335;5638.577106717013;5835.941640583625;5976.641401515923;6497.837554061186;22523.436914076952;22773;23541.411464713517;23640.29079127629;23649;22869.771302287096;23013.53972920532;23183.188588399324;23229.53540929172;23281.301560953198;11960.940195299141;12162.695932601755;12164.513419463123;12207.328596927255;12297.385130743605;9053.68312109073;9736.805263894825;9797.755056123653;9879.703608891745;10189.847152292574;20132.174886771467;20330.288439904532;20424.591508169455;20589.176432942513;20922;19981.60036799285;20489.79510204879;20791.68812467784;20900.68648970297;21305.14779408806;12992.870071299167;13238.53665121716;13286.402111904794;13291.069625126149;13341.933290333487;14725.484608038667;14814.481493147689;14939.626509337353;15015.174165421007;15028.398864045315;11998;12011.099167562643;12236.510539578318;12424.503019879103;12474.5010199591;11419.686736025464;11753.706157346134;11757.88242117602;11832.822507662564;12030.939845300718;10726.410047447465;10897.727556810825;10997.505112269808;11006.889931100586;11020.834687479533;8267.503949762793;8306.252437280433;8350.290225330915;8459.746207613782;8474.533900635524;8495.108013658477;8524.403291769517;8613.913860861312;8638.17937295956;8664.523451210243 03:51:33 INFO - PID 3507 | |4;prototype.html;510.2754089193345;517.1647788821056;528.1918664443401;540.0710777462763;541.9322584676916;6305.873882522347;6319;6323.620582765037;6343.714532846021;6347.3969972852565;6182.505399568035;6195.721192546335;6208.472279856206;6230.5638605297645;6241.438270555649;4964.106460837048;4971.179755340365;4988.426330971948;4990;4991.351124353829;4711.175544279755;4822.373091498101;4926.507349265081;4935.605151587883;4972.801087956477;4712.528747125277;4759.405074365704;4773.212419950704;4795.472498025214;4813.085513752376;4758.143534163849;4794.880127996793;4797.2324428091515;4803.303520989454;4835.6131509479155;4212.810423530948;4237.385579091046;4283.1433713257475;4308.67684923632;4324.437823083011;6020.307664618581;6034.547408944347;6042.184305118797;6065.423784740443;6073.119397687311;5741.110127930177;5774.393688662672;5782.363939966643;5790.797322093748;5794.246747922743;6720.764773232913;6724.798256052326;6729.091572637681;6729.461643068543;6743.426808721265;4922.145155809621;4937.851864444073;4953.2570114483115;4966.90066198674;4969.428515720666;6664.400203981665;6761.492888033417;6805.761798337035;6812.352826481477;6978.371946524786;5054.267131265946;5054.508919868647;5055.823046193365;5069.656541016633;5071.4928507149725;5140.280360749498;5150.0472412603785;5151.356080489939;5158.716270605153;5162.741862906914;5734.426557344233;5736.971315143398;5751.971240143856;5754;5767.279090113736;6657.1345725055435;6657.23441804189;6668.9982513115165;6674.399304062657;6708.15525730428;1770.5927636643387;1774.9527778610423;1781.7060185069317;1801.7117261238138;1811.8278763517444;1178.552150182925;1232.9938350308191;1233.2785320587557;1246.5263199984129;1254.5859866244118;6374.661321122523;6383.904241436382;6402.8719425611225;6418.486521078303;6426.967865160645;6823.69293381799;6853.862922741617;6854.280300568468;6859.211190713032;6863.176418829772;6206.317305096436;6265.373462653698;6312.684365781693;6373.426391624776;6381.425671689477;3533.152043509539;3595.6044835068124;3596.9820150899077;3610.5667319921777;3645.8177091145335;7172.6055066970775;7189.604571748499;7199.2440793715905;7274.381677557361;7291.562506249642;6903.344182302673;6954;6980.197277313174;6994.370506654425;7013.228544860061;6728.495362847806;7017.228284766408;7017.508774385744;7080.36276735086;7149.0348802911985;6566.9343306568235;6617.8014659560295;6661.900071498834;6688.565243259172;6831.574790949141;6623.370779775913;6623.701933413105;6644;6751.156105486814;6792.320767923168;7206.7117315306805;7242.818929526593;7243.275672432715;7256.129264488295;7282.308180722823;5091.567216786615;5101.7704203310195;5106.514881086291;5110.565601923878;5127.948720512747;6664.400203981665;6749.763758268634;6779.593224406552;6841.418479429304;6941.652917354213;6555.656090501531;6599.53803233769;6648.401643852077;6676.866462670817;6687.230968438692;6478.643674597943;6566.507511936719;6580.5064620152725;6628.933710662832;6651.605422048156;6583.539152259296;6621.867562648817;6648.434883034996;6666.633335166613;6668.966655166887;6689.26418094019;6704.363085506869;6732.764353247613;6752.223494298219;6795.93204067953;6448.162273751958;6482;6526.804195874131;6548.705308261235;6564.6389448580785 03:51:33 INFO - PID 3507 | |5;yui.html;921.2537844346081;935.854942483915;951.5860600638723;953.2231231546285;962.7256231973889;17625.82374176258;19235.23059077637;19955.0022498875;19967.201311947523;20023.299184528507;21994.89002554989;22367.99999999996;22418.551628967412;22558.097676092977;22573.77426225737;1002.4135880509892;1038.8961103889626;1040.3185913226848;1040.3757745352766;1040.677390009096;1000.7948370584049;1020.1277907389186;1055.6041484443333;1055.9894401056006;1059.86751656043;1011.4993078426189;1077.8975997280286;1078.7357097511122;1078.9784204315908;1079.0288740133865;1006.7734759679087;1066.845307430426;1067.4289255248443;1067.8184708599556;1071.0735214039878;736.5323019882413;760.1600231743898;771.93052625264;772.7025095338336;772.9188435214278;17540.29838806446;17847.107644617718;17867.821321786745;18107.094645267684;20165.798342016686;21775;21986.670199947013;22042.228522001813;22284.442888927744;22288.55422891533;17158.227879745442;17412.91293543524;17497.47507574775;17524.91237543817;18028.729569056475;3803.4675145479655;3832.559255685604;3833.9424908626393;3839.1937693084487;3845.8846234613006;148300;149521;149719.2514037423;149774;151317;16437.753433698505;16463.506094817174;16951.49145525636;17002.829971700372;17023.744643830352;24408.877955610107;24458.26625201247;24564.754352456603;24573.38566535851;24580.139695110942;7853.960730196312;8425.4944703318;8796.736097917073;9158.587863546156;9206.861897071549;4335.674824388184;4404.889877753018;4418.226810308183;4440.555944405533;4442.68901176921;5708.372079071299;5838.38696936824;5852.209951656472;5871.383504732027;5875.853103672357;1075.4676435164642;1099.9725006874733;1106.5518465021519;1106.878243393226;1110.156281226274;720.9567425954459;741.3994664321916;747.5103807006419;753.0925235091702;763.5914785589683;13091.738165236642;13123.950083993257;13488.190708557519;13498.392572334073;13620.387082581308;712.4656507619286;725.811289064847;731.4185222747928;739.6190961654752;745.8433728916988;5931.228940237827;5982.1325907744;5982.700864956735;5988.550858685616;6093.695315234309;122799;126584;132994.33502832425;133726;137478;113757;117765.41117294358;118721;119448;125373.37313313375;104018.47990760149;105503;105765;107142.92857071485;109226;13576.117552359065;13659.248741318925;13701.588952331445;13847;14145.43418263258;46765;48098.519014809404;49192;49457.50542494529;50882.49117508777;61459.38540614537;61583;61686.383136168064;61693;63221.36778632155;19730.40808775739;20258.59482810365;20266.290679826136;20360.389188324374;20429.59140817205;21751.129954801632;21859.781402185774;21895.343139705834;22022.449438763517;22186.1125554976;21095.894520527298;21105.89447052755;21165.89417052905;21262.25582104619;21313.6802947959;20258;20471.795282046987;20524.58950821005;20533.076011579215;20744.688829667266;20305.695414569087;20659.690104648744;20698.48253793667;20757.377278681663;20992.685109723672;14034.649133771738;14444;14455.349509272319;14592.635184120481;14866.702665946405;15460.768088478457;15838.049717017017;15875;15951.8404815955;16097.678046438772 03:51:33 INFO - PID 3507 | __end_tp_report 03:51:33 INFO - PID 3507 | __start_cc_report 03:51:33 INFO - PID 3507 | _x_x_mozilla_cycle_collect,326 03:51:33 INFO - PID 3507 | __end_cc_report 03:51:33 INFO - PID 3507 | __startTimestamp1502880693145__endTimestamp 03:51:33 INFO - PID 3507 | 03:51:33 INFO - PID 3507 | ------- Summary: start ------- 03:51:33 INFO - PID 3507 | Number of tests: 6 03:51:33 INFO - PID 3507 | 03:51:33 INFO - PID 3507 | [#0] dojo.html Cycles:165 Average:6266.93 Median:6590.60 stddev:830.14 (12.6%) stddev-sans-first:804.08 03:51:33 INFO - PID 3507 | Values: 3513.2 3546.4 3555.8 3567.7 3570.1 6287.4 6340.2 6372.0 6381.8 6413.7 6218.9 6293.1 6297.3 6301.1 6396.5 5485.3 5514.6 5532.9 5540.5 5550.3 5171.7 5388.1 5475.1 5567.2 5604.6 5463.1 5488.5 5532.5 5553.4 5554.1 5382.9 5499.4 5540.2 5557.2 5564.1 5443.2 5447.6 5507.8 5526.3 5528.2 6140.0 6209.8 6212.8 6223.1 6256.2 6793.3 6803.6 6885.4 6895.0 6896.1 6794.9 6853.5 6891.3 6905.2 6954.5 6357.9 6406.0 6434.0 6434.3 6443.3 7005.5 7024.2 7029.2 7089.8 7120.0 6495.6 6620.6 6626.5 6749.4 6835.5 6770.3 6774.6 6782.4 6789.9 6791.7 6727.6 6736.3 6745.6 6792.6 6858.1 6681.9 6757.8 6901.6 6907.9 6910.3 4889.9 4907.2 4907.4 4907.8 4908.5 4375.2 4386.0 4389.1 4396.3 4399.1 6402.5 6406.0 6477.3 6484.5 6488.0 6610.5 6749.2 6760.5 6838.6 6885.7 6391.7 6398.8 6399.4 6402.1 6451.4 5540.9 5546.0 5549.8 5551.3 5563.3 7216.0 7228.2 7309.0 7312.6 7324.9 6874.5 6885.3 6934.5 6959.2 6969.3 7050.6 7100.6 7175.9 7203.1 7230.2 6659.5 6735.1 6737.8 6745.3 6751.1 6834.2 6867.8 6876.2 6878.5 6890.4 6574.9 6590.6 6602.1 6671.0 6671.5 6599.3 6663.3 6675.4 6699.7 6714.6 6657.9 6674.7 6703.6 6733.5 6753.3 6715.9 6733.5 6735.9 6795.9 6798.5 6349.6 6456.8 6486.9 6497.8 6584.2 03:51:33 INFO - PID 3507 | 03:51:33 INFO - PID 3507 | [#1] ext.html Cycles:180 Average:42238.30 Median:37843.72 stddev:61773.77 (163.2%) stddev-sans-first:61868.98 03:51:33 INFO - PID 3507 | Values: 872.1 910.2 925.9 960.1 960.2 42561.6 43131.6 43215.8 43345.6 43366.3 40679.0 40838.0 40914.2 40916.0 40998.6 6903.6 7025.3 7067.8 7071.9 7081.3 6961.8 7033.0 7045.7 7047.1 7047.6 7651.5 7744.4 7772.6 7773.0 7777.5 7651.6 7720.7 7721.7 7724.2 7724.4 7552.1 7659.2 7671.4 7714.6 7717.0 40420.2 40578.6 40633.4 40670.2 40673.8 3442.7 3508.2 3508.6 3509.6 3509.7 30699.7 30982.8 30999.8 31215.7 31364.4 5042.7 5053.0 5056.6 5068.9 5094.7 200890.0 203495.0 204692.0 210587.0 266634.0 54960.5 55141.4 55169.0 55268.0 55330.7 56932.4 57101.4 57252.7 57656.4 57695.1 16000.4 16000.9 16065.6 16146.9 16471.8 13144.6 13187.5 13246.6 13251.0 13261.8 15491.2 15546.6 15570.6 15580.3 15612.2 6167.4 6215.7 6269.2 6278.7 6316.2 1099.2 1099.3 1112.2 1114.3 1127.8 25047.7 25353.1 25508.9 25536.6 25549.6 1215.9 1217.5 1222.7 1227.5 1236.1 13409.9 13441.1 13483.9 13597.3 13729.9 258615.0 261440.0 262146.0 262334.0 262620.0 54455.5 54473.2 55061.7 55190.7 55314.4 1499.6 1516.5 1536.2 1549.6 1562.6 24741.8 24742.3 30117.0 30485.4 30767.5 54359.0 54721.2 54877.7 54906.2 55077.4 229357.0 229441.0 229648.0 232342.0 232687.0 37744.0 37943.4 39646.2 39953.4 40087.6 48183.8 49357.0 49508.5 49780.8 50071.7 35806.5 36312.5 36478.6 36692.3 36807.0 36089.0 36111.5 36132.0 36209.5 36468.8 41318.8 41850.0 42144.4 42359.4 42477.8 34454.0 34684.1 34688.0 34812.3 34930.3 25761.2 26353.0 26695.7 27338.6 27605.9 03:51:33 INFO - PID 3507 | 03:51:33 INFO - PID 3507 | [#2] jquery.html Cycles:180 Average:37932.49 Median:2208.05 stddev:87484.31 (3962.1%) stddev-sans-first:87684.75 03:51:33 INFO - PID 3507 | Values: 570.1 571.2 575.1 581.6 588.3 23525.3 23607.6 24311.4 24311.4 24316.3 26215.9 26788.7 26878.1 26893.6 26981.6 6349.8 6454.4 6457.1 6476.7 6482.6 5969.1 6197.6 6210.7 6218.1 6365.7 6152.3 6161.7 6162.7 6170.0 6185.9 6149.7 6150.4 6194.8 6198.4 6206.0 5750.5 5754.5 5762.3 5763.3 5776.8 28739.9 31054.7 31726.5 31816.4 31999.8 2177.1 2207.4 2208.7 2209.1 2209.4 20448.7 20717.5 20729.2 20736.8 20740.8 2452.7 2467.1 2508.6 2519.0 2570.8 160552.0 164061.0 165120.2 165327.0 165381.0 15219.8 15684.4 15915.2 15917.6 16027.3 23826.7 23890.5 23909.9 23926.4 23929.2 10788.0 10823.2 10948.3 10985.0 11113.4 8995.5 9345.9 10047.2 10198.9 10211.1 9331.0 9890.4 9950.4 9985.3 10019.8 2756.0 2765.7 2773.7 2777.7 2893.8 1053.6 1070.6 1075.1 1079.0 1079.1 21565.8 21926.0 21978.5 22035.3 22068.1 1125.5 1127.2 1127.9 1135.3 1139.8 11804.6 11986.8 12190.6 12290.2 12352.6 483438.0 504208.0 510432.0 526835.0 528233.0 129964.0 135228.0 135951.3 137471.3 138411.0 1222.4 1240.6 1259.8 1271.8 1277.3 18754.6 18874.0 18913.6 18992.7 19577.0 67527.3 68509.3 68760.0 69410.3 69707.7 83175.6 84123.0 84161.6 84930.0 85273.6 14827.3 15270.2 15271.7 15305.5 15316.5 24531.6 24801.4 24923.8 25071.0 25266.4 20138.2 20158.1 20386.6 20392.6 20474.3 17950.2 18006.3 18087.5 18434.2 18512.7 19586.2 19684.3 20456.7 20718.4 20819.8 15125.9 15164.8 15173.1 15192.5 15205.5 19927.4 20150.9 20316.9 20440.9 20447.0 03:51:33 INFO - PID 3507 | 03:51:33 INFO - PID 3507 | [#3] mootools.html Cycles:180 Average:10187.52 Median:23644.65 stddev:7319.47 (31.0%) stddev-sans-first:7310.35 03:51:33 INFO - PID 3507 | Values: 1418.9 1471.9 1481.4 1493.7 1499.7 15633.2 16273.9 16281.3 16291.3 16311.4 15754.8 16601.8 16603.6 16613.6 16627.3 2592.5 2653.7 2655.4 2655.8 2657.7 2707.9 2715.5 2724.4 2816.9 2817.7 2741.6 2748.1 2764.8 2769.0 2774.5 2648.7 2693.3 2730.0 2748.1 2748.7 2540.0 2577.8 2580.0 2592.2 2677.6 16030.3 16130.3 16149.4 16152.8 16167.4 8481.7 8759.6 8760.6 8763.1 8767.0 5407.9 5701.4 5802.2 5814.0 5821.1 1771.0 1796.1 1797.4 1844.1 1847.2 28308.9 28680.1 28735.9 29252.3 30098.0 6907.8 7001.9 7063.9 7192.2 7192.4 18689.3 18690.1 18819.0 22334.4 22620.1 8860.2 9094.7 9100.7 9103.0 9104.6 7517.9 8044.5 8081.9 8096.4 8105.2 5795.4 6000.5 6012.8 6021.4 6046.3 1728.5 1749.2 1755.1 1770.4 1778.3 975.6 1004.7 1006.7 1007.6 1027.8 8525.1 8525.3 8540.4 8566.9 8635.0 757.1 760.2 768.3 1063.9 1116.3 5637.2 5638.6 5835.9 5976.6 6497.8 22523.4 22773.0 23541.4 23640.3 23649.0 22869.8 23013.5 23183.2 23229.5 23281.3 11960.9 12162.7 12164.5 12207.3 12297.4 9053.7 9736.8 9797.8 9879.7 10189.8 20132.2 20330.3 20424.6 20589.2 20922.0 19981.6 20489.8 20791.7 20900.7 21305.1 12992.9 13238.5 13286.4 13291.1 13341.9 14725.5 14814.5 14939.6 15015.2 15028.4 11998.0 12011.1 12236.5 12424.5 12474.5 11419.7 11753.7 11757.9 11832.8 12030.9 10726.4 10897.7 10997.5 11006.9 11020.8 8267.5 8306.3 8350.3 8459.7 8474.5 8495.1 8524.4 8613.9 8638.2 8664.5 03:51:33 INFO - PID 3507 | 03:51:33 INFO - PID 3507 | [#4] prototype.html Cycles:180 Average:5630.15 Median:6333.67 stddev:1624.82 (25.7%) stddev-sans-first:1583.28 03:51:33 INFO - PID 3507 | Values: 510.3 517.2 528.2 540.1 541.9 6305.9 6319.0 6323.6 6343.7 6347.4 6182.5 6195.7 6208.5 6230.6 6241.4 4964.1 4971.2 4988.4 4990.0 4991.4 4711.2 4822.4 4926.5 4935.6 4972.8 4712.5 4759.4 4773.2 4795.5 4813.1 4758.1 4794.9 4797.2 4803.3 4835.6 4212.8 4237.4 4283.1 4308.7 4324.4 6020.3 6034.5 6042.2 6065.4 6073.1 5741.1 5774.4 5782.4 5790.8 5794.2 6720.8 6724.8 6729.1 6729.5 6743.4 4922.1 4937.9 4953.3 4966.9 4969.4 6664.4 6761.5 6805.8 6812.4 6978.4 5054.3 5054.5 5055.8 5069.7 5071.5 5140.3 5150.0 5151.4 5158.7 5162.7 5734.4 5737.0 5752.0 5754.0 5767.3 6657.1 6657.2 6669.0 6674.4 6708.2 1770.6 1775.0 1781.7 1801.7 1811.8 1178.6 1233.0 1233.3 1246.5 1254.6 6374.7 6383.9 6402.9 6418.5 6427.0 6823.7 6853.9 6854.3 6859.2 6863.2 6206.3 6265.4 6312.7 6373.4 6381.4 3533.2 3595.6 3597.0 3610.6 3645.8 7172.6 7189.6 7199.2 7274.4 7291.6 6903.3 6954.0 6980.2 6994.4 7013.2 6728.5 7017.2 7017.5 7080.4 7149.0 6566.9 6617.8 6661.9 6688.6 6831.6 6623.4 6623.7 6644.0 6751.2 6792.3 7206.7 7242.8 7243.3 7256.1 7282.3 5091.6 5101.8 5106.5 5110.6 5127.9 6664.4 6749.8 6779.6 6841.4 6941.7 6555.7 6599.5 6648.4 6676.9 6687.2 6478.6 6566.5 6580.5 6628.9 6651.6 6583.5 6621.9 6648.4 6666.6 6669.0 6689.3 6704.4 6732.8 6752.2 6795.9 6448.2 6482.0 6526.8 6548.7 6564.6 03:51:33 INFO - PID 3507 | 03:51:33 INFO - PID 3507 | [#5] yui.html Cycles:180 Average:26576.92 Median:20394.99 stddev:38080.46 (186.7%) stddev-sans-first:38138.56 03:51:33 INFO - PID 3507 | Values: 921.3 935.9 951.6 953.2 962.7 17625.8 19235.2 19955.0 19967.2 20023.3 21994.9 22368.0 22418.6 22558.1 22573.8 1002.4 1038.9 1040.3 1040.4 1040.7 1000.8 1020.1 1055.6 1056.0 1059.9 1011.5 1077.9 1078.7 1079.0 1079.0 1006.8 1066.8 1067.4 1067.8 1071.1 736.5 760.2 771.9 772.7 772.9 17540.3 17847.1 17867.8 18107.1 20165.8 21775.0 21986.7 22042.2 22284.4 22288.6 17158.2 17412.9 17497.5 17524.9 18028.7 3803.5 3832.6 3833.9 3839.2 3845.9 148300.0 149521.0 149719.3 149774.0 151317.0 16437.8 16463.5 16951.5 17002.8 17023.7 24408.9 24458.3 24564.8 24573.4 24580.1 7854.0 8425.5 8796.7 9158.6 9206.9 4335.7 4404.9 4418.2 4440.6 4442.7 5708.4 5838.4 5852.2 5871.4 5875.9 1075.5 1100.0 1106.6 1106.9 1110.2 721.0 741.4 747.5 753.1 763.6 13091.7 13124.0 13488.2 13498.4 13620.4 712.5 725.8 731.4 739.6 745.8 5931.2 5982.1 5982.7 5988.6 6093.7 122799.0 126584.0 132994.3 133726.0 137478.0 113757.0 117765.4 118721.0 119448.0 125373.4 104018.5 105503.0 105765.0 107142.9 109226.0 13576.1 13659.2 13701.6 13847.0 14145.4 46765.0 48098.5 49192.0 49457.5 50882.5 61459.4 61583.0 61686.4 61693.0 63221.4 19730.4 20258.6 20266.3 20360.4 20429.6 21751.1 21859.8 21895.3 22022.4 22186.1 21095.9 21105.9 21165.9 21262.3 21313.7 20258.0 20471.8 20524.6 20533.1 20744.7 20305.7 20659.7 20698.5 20757.4 20992.7 14034.6 14444.0 14455.3 14592.6 14866.7 15460.8 15838.0 15875.0 15951.8 16097.7 03:51:33 INFO - PID 3507 | -------- Summary: end -------- 03:51:33 INFO - PID 3507 | 03:51:33 INFO - TEST-INFO | 3507: exit 0 03:51:33 INFO - TEST-OK | dromaeo_css | took 1110963ms 03:51:33 INFO - TEST-START | kraken 03:51:33 INFO - Initialising browser for kraken test... 03:51:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:33902/getInfo.html -profile /tmp/tmpExMWZ1/profile 03:51:33 INFO - TEST-INFO | started process 3907 (/builds/slave/test/build/application/firefox/firefox http://localhost:33902/getInfo.html) 03:51:39 INFO - TEST-INFO | 3907: exit 0 03:51:39 INFO - Browser initialized. 03:51:39 INFO - Running cycle 1/1 for kraken test... 03:51:39 INFO - TEST-INFO | started process 4120 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpExMWZ1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:40 INFO - PID 4120 | 03:51:40 INFO - PID 4120 | (/builds/slave/test/build/application/firefox/firefox:4168): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:51:40 INFO - PID 4120 | 03:51:50 INFO - PID 4120 | RSS: Main: 157884416 03:51:50 INFO - PID 4120 | 03:51:53 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33902/tests/kraken/driver.html?testName=audio-beat-detection) 03:51:53 INFO - PID 4120 | RSS: Main: 164020224 03:51:53 INFO - PID 4120 | 03:51:56 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33902/tests/kraken/driver.html?testName=audio-dft) 03:51:57 INFO - PID 4120 | RSS: Main: 167997440 03:51:57 INFO - PID 4120 | 03:52:00 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33902/tests/kraken/driver.html?testName=audio-fft) 03:52:00 INFO - PID 4120 | RSS: Main: 162299904 03:52:00 INFO - PID 4120 | 03:52:02 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33902/tests/kraken/driver.html?testName=audio-oscillator) 03:52:03 INFO - PID 4120 | RSS: Main: 162488320 03:52:03 INFO - PID 4120 | 03:52:05 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33902/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:52:06 INFO - PID 4120 | RSS: Main: 162902016 03:52:06 INFO - PID 4120 | 03:52:09 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33902/tests/kraken/driver.html?testName=imaging-darkroom) 03:52:09 INFO - PID 4120 | RSS: Main: 162721792 03:52:09 INFO - PID 4120 | 03:52:13 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33902/tests/kraken/driver.html?testName=imaging-desaturate) 03:52:13 INFO - PID 4120 | RSS: Main: 164761600 03:52:13 INFO - PID 4120 | 03:52:16 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33902/tests/kraken/driver.html?testName=json-parse-financial) 03:52:17 INFO - PID 4120 | RSS: Main: 164847616 03:52:17 INFO - PID 4120 | 03:52:18 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33902/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:52:19 INFO - PID 4120 | RSS: Main: 164818944 03:52:19 INFO - PID 4120 | 03:52:21 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:52:21 INFO - PID 4120 | RSS: Main: 165302272 03:52:21 INFO - PID 4120 | 03:52:23 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:52:24 INFO - PID 4120 | RSS: Main: 165105664 03:52:24 INFO - PID 4120 | 03:52:26 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:52:27 INFO - PID 4120 | RSS: Main: 164958208 03:52:27 INFO - PID 4120 | 03:52:30 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:52:31 INFO - PID 4120 | RSS: Main: 164904960 03:52:31 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | Cycle 1(1): loaded http://localhost:33902/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33902/tests/kraken/driver.html?testName=ai-astar) 03:52:32 INFO - PID 4120 | RSS: Main: 166916096 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | __start_tp_report 03:52:32 INFO - PID 4120 | _x_x_mozilla_page_load 03:52:32 INFO - PID 4120 | _x_x_mozilla_page_load_details 03:52:32 INFO - PID 4120 | |i|pagename|runs| 03:52:32 INFO - PID 4120 | |0;ai-astar;97;106;98;106;106;106;109;99;106;109 03:52:32 INFO - PID 4120 | |1;audio-beat-detection;140;114;142;160;114;144;141;114;172;114 03:52:32 INFO - PID 4120 | |2;audio-dft;161;162;161;162;162;162;162;167;163;172 03:52:32 INFO - PID 4120 | |3;audio-fft;73;73;79;128;74;75;73;86;100;72 03:52:32 INFO - PID 4120 | |4;audio-oscillator;78;78;127;79;77;78;134;79;77;122 03:52:32 INFO - PID 4120 | |5;imaging-gaussian-blur;113;113;113;114;115;114;114;114;115;114 03:52:32 INFO - PID 4120 | |6;imaging-darkroom;147;148;148;148;148;148;147;149;148;148 03:52:32 INFO - PID 4120 | |7;imaging-desaturate;98;99;94;99;94;94;94;94;93;94 03:52:32 INFO - PID 4120 | |8;json-parse-financial;48;46;54;47;47;57;48;48;49;47 03:52:32 INFO - PID 4120 | |9;json-stringify-tinderbox;53;53;53;54;54;54;54;54;54;54 03:52:32 INFO - PID 4120 | |10;stanford-crypto-aes;73;73;73;72;74;73;74;72;74;74 03:52:32 INFO - PID 4120 | |11;stanford-crypto-ccm;116;112;119;114;115;117;111;118;115;147 03:52:32 INFO - PID 4120 | |12;stanford-crypto-pbkdf2;163;175;167;177;163;171;160;176;168;168 03:52:32 INFO - PID 4120 | |13;stanford-crypto-sha256-iterative;61;61;66;60;60;60;65;61;61;66 03:52:32 INFO - PID 4120 | __end_tp_report 03:52:32 INFO - PID 4120 | __start_cc_report 03:52:32 INFO - PID 4120 | _x_x_mozilla_cycle_collect,821 03:52:32 INFO - PID 4120 | __end_cc_report 03:52:32 INFO - PID 4120 | __startTimestamp1502880752924__endTimestamp 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | ------- Summary: start ------- 03:52:32 INFO - PID 4120 | Number of tests: 14 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#0] ai-astar Cycles:10 Average:104.20 Median:109.00 stddev:4.47 (4.1%) stddev-sans-first:3.91 03:52:32 INFO - PID 4120 | Values: 97.0 106.0 98.0 106.0 106.0 106.0 109.0 99.0 106.0 109.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#1] audio-beat-detection Cycles:10 Average:135.50 Median:141.50 stddev:20.94 (14.8%) stddev-sans-first:22.15 03:52:32 INFO - PID 4120 | Values: 140.0 114.0 142.0 160.0 114.0 144.0 141.0 114.0 172.0 114.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#2] audio-dft Cycles:10 Average:163.40 Median:162.00 stddev:3.47 (2.1%) stddev-sans-first:3.57 03:52:32 INFO - PID 4120 | Values: 161.0 162.0 161.0 162.0 162.0 162.0 162.0 167.0 163.0 172.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#3] audio-fft Cycles:10 Average:83.30 Median:73.50 stddev:17.96 (24.4%) stddev-sans-first:18.66 03:52:32 INFO - PID 4120 | Values: 73.0 73.0 79.0 128.0 74.0 75.0 73.0 86.0 100.0 72.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:78.00 stddev:24.17 (31.0%) stddev-sans-first:25.03 03:52:32 INFO - PID 4120 | Values: 78.0 78.0 127.0 79.0 77.0 78.0 134.0 79.0 77.0 122.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 03:52:32 INFO - PID 4120 | Values: 113.0 113.0 113.0 114.0 115.0 114.0 114.0 114.0 115.0 114.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 03:52:32 INFO - PID 4120 | Values: 147.0 148.0 148.0 148.0 148.0 148.0 147.0 149.0 148.0 148.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.00 stddev:2.36 (2.5%) stddev-sans-first:2.29 03:52:32 INFO - PID 4120 | Values: 98.0 99.0 94.0 99.0 94.0 94.0 94.0 94.0 93.0 94.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#8] json-parse-financial Cycles:10 Average:49.10 Median:48.00 stddev:3.54 (7.4%) stddev-sans-first:3.73 03:52:32 INFO - PID 4120 | Values: 48.0 46.0 54.0 47.0 47.0 57.0 48.0 48.0 49.0 47.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#9] json-stringify-tinderbox Cycles:10 Average:53.70 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.44 03:52:32 INFO - PID 4120 | Values: 53.0 53.0 53.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#10] stanford-crypto-aes Cycles:10 Average:73.20 Median:73.50 stddev:0.79 (1.1%) stddev-sans-first:0.83 03:52:32 INFO - PID 4120 | Values: 73.0 73.0 73.0 72.0 74.0 73.0 74.0 72.0 74.0 74.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:116.50 stddev:10.35 (8.9%) stddev-sans-first:10.94 03:52:32 INFO - PID 4120 | Values: 116.0 112.0 119.0 114.0 115.0 117.0 111.0 118.0 115.0 147.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.80 Median:169.50 stddev:5.88 (3.5%) stddev-sans-first:5.85 03:52:32 INFO - PID 4120 | Values: 163.0 175.0 167.0 177.0 163.0 171.0 160.0 176.0 168.0 168.0 03:52:32 INFO - PID 4120 | 03:52:32 INFO - PID 4120 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:61.00 stddev:2.51 (4.1%) stddev-sans-first:2.64 03:52:32 INFO - PID 4120 | Values: 61.0 61.0 66.0 60.0 60.0 60.0 65.0 61.0 61.0 66.0 03:52:32 INFO - PID 4120 | -------- Summary: end -------- 03:52:32 INFO - PID 4120 | 03:52:33 INFO - PID 4120 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:52:33 INFO - TEST-INFO | 4120: exit 0 03:52:33 INFO - TEST-OK | kraken | took 59786ms 03:52:33 INFO - SUITE-END | took 1170s 03:52:33 INFO - Completed test suite (00:19:30) 03:52:33 INFO - javascript benchmark 03:52:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8990.668343803784, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3513.244652399735, 3546.414841551144, 3555.786652800832, 3567.6789088981996, 3570.125319296773, 6287.434130928215, 6340.239171299445, 6372.0, 6381.7766378176775, 6413.74345026199, 6218.906716399258, 6293.056041593763, 6297.307296197415, 6301.117843501902, 6396.456301214391, 5485.259489968853, 5514.6139770216105, 5532.917006244909, 5540.50135487806, 5550.2784637997, 5171.663841850286, 5388.137897936331, 5475.123980163175, 5567.192757050226, 5604.607677462579, 5463.125899856024, 5488.4785945335125, 5532.529734972532, 5553.389127196006, 5554.1113421852515, 5382.946170538284, 5499.367572729107, 5540.168974653794, 5557.194206839986, 5564.10974244119, 5443.1835224716215, 5447.618666693333, 5507.807226747084, 5526.309211348582, 5528.226048353194, 6140.0, 6209.813705588795, 6212.782552610637, 6223.097650840603, 6256.2492500899725, 6793.320667933217, 6803.591784492946, 6885.449164066863, 6895.0, 6896.103506544167, 6794.932050679479, 6853.451723862079, 6891.310868913069, 6905.240423553405, 6954.478414118961, 6357.904631430532, 6406.0, 6434.0, 6434.292227854932, 6443.259025212114, 7005.50961432705, 7024.1571011478945, 7029.156501219784, 7089.7873063808165, 7120.0387947626405, 6495.610263384212, 6620.569662971891, 6626.469882409396, 6749.42629876466, 6835.487338449537, 6770.289119642465, 6774.593524388552, 6782.423494002966, 6789.864202716017, 6791.72833086671, 6727.562708423937, 6736.326367363225, 6745.5952642841585, 6792.558483698544, 6858.108445902001, 6681.866362672719, 6757.831054223586, 6901.62041087735, 6907.861842763116, 6910.2744211858035, 4889.926651100236, 4907.1657818171, 4907.411110666742, 4907.828226012072, 4908.484609115992, 4375.212461756914, 4386.035072284092, 4389.100234451929, 4396.318570621559, 4399.076193999232, 6402.48780097591, 6406.0390941359165, 6477.287498375175, 6484.513661475408, 6488.0, 6610.471162307004, 6749.190097188369, 6760.492963027694, 6838.555493892881, 6885.690143943434, 6391.680415979183, 6398.776042838478, 6399.392057754506, 6402.071699603532, 6451.387118223855, 5540.861478463071, 5545.9722701387045, 5549.750261238173, 5551.25058117149, 5563.276774019351, 7216.0, 7228.241034691387, 7309.0, 7312.561246325131, 7324.853502930018, 6874.518783685094, 6885.2770459101075, 6934.549254298556, 6959.234484206632, 6969.337912898267, 7050.5769653820935, 7100.573965562083, 7175.856482870209, 7203.063601731741, 7230.168530619047, 6659.53383263167, 6735.057092007025, 6737.831554210988, 6745.291744366771, 6751.054852320777, 6834.2482326943, 6867.793966181022, 6876.209235937931, 6878.484113691593, 6890.44876409876, 6574.901376479261, 6590.604563726, 6602.10871532337, 6670.966645166744, 6671.499637527108, 6599.274079851309, 6663.300353462817, 6675.365840245169, 6699.698513566804, 6714.563553369016, 6657.900131497934, 6674.666266686743, 6703.631300278532, 6733.461323094239, 6753.290904455158, 6715.865682686416, 6733.52865299444, 6735.865282694221, 6795.898061528982, 6798.52410331272, 6349.555531112777, 6456.806295811133, 6486.9351306488215, 6497.805065848032, 6584.242812076481], "value": 6202.383315912698, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [872.088812056652, 910.2263076385074, 925.8657494663274, 960.1166926427686, 960.2318145483616, 42561.57438425615, 43131.56868431315, 43215.78392108035, 43345.56654433455, 43366.34950475742, 40679.0, 40838.0, 40914.18171636573, 40916.0, 40998.59001409985, 6903.620300883437, 7025.332593403644, 7067.752628657998, 7071.929280707204, 7081.256468070856, 6961.756338528153, 7033.015377847106, 7045.718171273143, 7047.119110111211, 7047.6476176191245, 7651.464397492177, 7744.380449564022, 7772.6113694315345, 7773.0, 7777.455578109534, 7651.617419129021, 7720.652570634335, 7721.72973945912, 7724.150343462243, 7724.382049436032, 7552.093748750185, 7659.195784442665, 7671.386289096915, 7714.614269286513, 7716.996790417266, 40420.19159616791, 40578.594214057775, 40633.39049914254, 40670.18659626791, 40673.79663101695, 3442.6557344265625, 3508.2106526031694, 3508.561429821272, 3509.5613048368955, 3509.666581674737, 30699.69300307013, 30982.845085774654, 30999.84500077485, 31215.687843121505, 31364.37271254562, 5042.747862606891, 5053.0399224147295, 5056.570191533724, 5068.898622027576, 5094.668846525001, 200890.0, 203495.0, 204692.0, 210587.0, 266633.9999999981, 54960.45039549634, 55141.44858551443, 55169.0, 55268.0, 55330.72334638301, 56932.43067569354, 57101.428985710445, 57252.713736431884, 57656.423435765944, 57695.13457298144, 16000.359985600446, 16000.919995399949, 16065.598360040858, 16146.919265403832, 16471.752923706154, 13144.60566183016, 13187.53843615469, 13246.602601921957, 13251.0, 13261.801072983913, 15491.225438728019, 15546.611334716723, 15570.610734731723, 15580.298886550132, 15612.219389030502, 6167.383261673796, 6215.720292586844, 6269.153664255358, 6278.6860656966965, 6316.210473690789, 1099.1701265544464, 1099.2964502718266, 1112.232559533919, 1114.2924243105524, 1127.836463712757, 25047.749522504542, 25353.112641057844, 25508.872455637604, 25536.616950745753, 25549.616755748677, 1215.8540975083047, 1217.4825699077855, 1222.6943264183953, 1227.5274019502556, 1236.0605939485877, 13409.932950335186, 13441.102080396575, 13483.865161348262, 13597.32013399326, 13729.862701372858, 258615.0, 261440.0, 262146.0, 262334.0, 262620.0, 54455.455445445834, 54473.18290225571, 55061.72469137629, 55190.72404637951, 55314.446855531736, 1499.6250937265684, 1516.4768154986511, 1536.2011753887916, 1549.5506303172178, 1562.6015366081576, 24741.75382942541, 24742.25773226806, 30117.0, 30485.390292194475, 30767.53848692316, 54359.0, 54721.17918231309, 54877.72561137169, 54906.17640735312, 55077.44922550723, 229357.0, 229441.0, 229648.0, 232342.0, 232687.0, 37744.0, 37943.43084853785, 39646.20707585775, 39953.40069899012, 40087.59912400955, 48183.75908120437, 49357.0, 49508.50491495183, 49780.75109624429, 50071.74964125156, 35806.46290305595, 36312.4553131698, 36478.63521364859, 36692.266154677294, 36807.0, 36089.0, 36111.45832812457, 36132.0, 36209.45685814662, 36468.81765591155, 41318.76043718693, 41850.0, 42144.36783448312, 42359.36460953027, 42477.78761106298, 34454.0, 34684.13289667779, 34688.0, 34812.303753925284, 34930.301393972484, 25761.227163185133, 26353.0, 26695.7330426701, 27338.5899211508, 27605.861970690017], "value": 18515.18722348025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.1390899741392, 571.2373980735717, 575.1028395702707, 581.5754499215573, 588.2822955993686, 23525.29424117277, 23607.645885311693, 24311.392215194606, 24311.392215194628, 24316.27051188467, 26215.86892065542, 26788.732112678867, 26878.059267925626, 26893.596596051026, 26981.595276070875, 6349.809505714825, 6454.386833250834, 6457.096006559085, 6476.708548115323, 6482.578632388903, 5969.104634304846, 6197.566170368076, 6210.689465526728, 6218.067289906528, 6365.713542890581, 6152.292486364081, 6161.661108639023, 6162.691865406712, 6170.0, 6185.938140618604, 6149.661768602725, 6150.415710507495, 6194.8451288717915, 6198.380161983766, 6205.968970155143, 5750.482456578886, 5754.482096611283, 5762.308522977228, 5763.337216220147, 5776.768929242825, 28739.856300718573, 31054.68945310563, 31726.524102138486, 31816.363672726646, 31999.84000080008, 2177.074743234135, 2207.39296693409, 2208.7018252535863, 2209.1163534586135, 2209.4365936686204, 20448.693269600968, 20717.482062948395, 20729.170833166805, 20736.792632073637, 20740.792592074038, 2452.6811514503, 2467.099508679337, 2508.6487891694997, 2518.987405062963, 2570.7814835738986, 160552.0, 164060.9999999988, 165120.17439912845, 165327.0, 165381.0, 15219.771703424458, 15684.372625095097, 15915.204239787965, 15917.602059948362, 16027.278772455267, 23826.689532075554, 23890.52218955611, 23909.880450597637, 23926.401839954142, 23929.16247931314, 10788.0, 10823.242373033812, 10948.34309941406, 10985.0, 11113.444327783578, 8995.505247211335, 9345.859812102824, 10047.24645651579, 10198.898011019943, 10211.132053775364, 9331.0, 9890.357126786736, 9950.35322704022, 9985.30102892805, 10019.79960400788, 2755.9724402755714, 2765.6855305722734, 2773.6898555785747, 2777.666679998413, 2893.8119022263486, 1053.5733028123623, 1070.6145787516489, 1075.1291453922347, 1078.962236321725, 1079.0989523747758, 21565.78434215669, 21926.0, 21978.45053873634, 22035.338939831832, 22068.117275308807, 1125.482278152043, 1127.1884243344778, 1127.9041281491166, 1135.3188087147646, 1139.7606502634374, 11804.58683946075, 11986.820197697041, 12190.634280971584, 12290.20113692607, 12352.567660131852, 483438.0, 504208.0, 510432.0, 526835.0, 528233.0, 129964.0, 135228.0, 135951.32024339816, 137471.31264343613, 138411.0, 1222.3521533587214, 1240.5968060380412, 1259.8236246925437, 1271.802870555084, 1277.303869391184, 18754.6249075015, 18874.0, 18913.621727565645, 18992.715109273096, 19577.0, 67527.32472675211, 68509.3149068503, 68760.0, 69410.3058969424, 69707.65146174439, 83175.584122079, 84123.0, 84161.57919210364, 84930.0, 85273.57363213145, 14827.33277002559, 15270.160141191896, 15271.694566108838, 15305.540833775005, 15316.540503784905, 24531.632025519273, 24801.379965501008, 24923.75076249214, 25070.99716011339, 25266.36834079163, 20138.19447222095, 20158.092885820468, 20386.59226815485, 20392.59214815725, 20474.283400080927, 17950.19224134891, 18006.279748809902, 18087.457376278733, 18434.170462329497, 18512.72230916564, 19586.216551337788, 19684.311049113214, 20456.693149603067, 20718.378448646567, 20819.791802081785, 15125.924370378078, 15164.848351516344, 15173.089614623157, 15192.544223673307, 15205.467808626645, 19927.402177934684, 20150.89924550368, 20316.89841550783, 20440.897795510926, 20447.0], "value": 12710.456689416798, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.8652078052585, 1471.8528147185277, 1481.3778213150476, 1493.7012597480507, 1499.7450433426313, 15633.218339083043, 16273.918630406846, 16281.348746050144, 16291.266892989828, 16311.429099981504, 15754.76367854483, 16601.83398166018, 16603.584910377216, 16613.584660383465, 16627.251773670185, 2592.494463579603, 2653.7478939500716, 2655.4423571050006, 2655.81409301349, 2657.7342265773364, 2707.91876243713, 2715.456908618274, 2724.4006318609872, 2816.873240704163, 2817.67596726376, 2741.561350183971, 2748.0656576763895, 2764.7788176945796, 2769.0308392062716, 2774.4728501584636, 2648.6689163854517, 2693.2997420670667, 2729.959050614242, 2748.093129267347, 2748.738869807365, 2540.047482194177, 2577.768000879911, 2580.019592554836, 2592.157548796649, 2677.5582028965196, 16030.278637461342, 16130.274137663833, 16149.354025838953, 16152.83847161525, 16167.353305867751, 8481.745547633582, 8759.562021898879, 8760.561971901443, 8763.079876612928, 8767.0, 5407.918881216785, 5701.401352857932, 5802.245708057968, 5814.0, 5821.068629019379, 1771.0, 1796.119901248392, 1797.3888877781617, 1844.1424737496993, 1847.1503108569939, 28308.858455707796, 28680.139595812157, 28735.85632071847, 29252.268693282836, 30098.0, 6907.792766217021, 7001.92998070023, 7063.92936070643, 7192.244814294424, 7192.4246060315045, 18689.25242990265, 18690.06549672511, 18819.0, 22334.441638959157, 22620.077293429913, 8860.158284962918, 9094.727158185266, 9100.726978190665, 9102.998670146279, 9104.635814567344, 7517.887231691529, 8044.477108987897, 8081.919180808117, 8096.433249672466, 8105.230003149692, 5795.420457954171, 6000.489958353589, 6012.849678757979, 6021.367756385516, 6046.3349031606485, 1728.5246557196872, 1749.160403006564, 1755.1048965027928, 1770.4246120011048, 1778.2531336838558, 975.5805003848271, 1004.7437903334749, 1006.7080546641538, 1007.6120693533043, 1027.753339198587, 8525.104863989316, 8525.31797456202, 8540.40217184791, 8566.914330856736, 8635.0, 757.1255200243727, 760.2245709376405, 768.2893323675578, 1063.8509613470837, 1116.2576886370473, 5637.210790489335, 5638.577106717013, 5835.941640583625, 5976.641401515923, 6497.837554061186, 22523.436914076952, 22773.0, 23541.411464713517, 23640.29079127629, 23649.0, 22869.771302287096, 23013.53972920532, 23183.188588399324, 23229.53540929172, 23281.301560953198, 11960.940195299141, 12162.695932601755, 12164.513419463123, 12207.328596927255, 12297.385130743605, 9053.68312109073, 9736.805263894825, 9797.755056123653, 9879.703608891745, 10189.847152292574, 20132.174886771467, 20330.288439904532, 20424.591508169455, 20589.176432942513, 20922.0, 19981.60036799285, 20489.79510204879, 20791.68812467784, 20900.68648970297, 21305.14779408806, 12992.870071299167, 13238.53665121716, 13286.402111904794, 13291.069625126149, 13341.933290333487, 14725.484608038667, 14814.481493147689, 14939.626509337353, 15015.174165421007, 15028.398864045315, 11998.0, 12011.099167562643, 12236.510539578318, 12424.503019879103, 12474.5010199591, 11419.686736025464, 11753.706157346134, 11757.88242117602, 11832.822507662564, 12030.939845300718, 10726.410047447465, 10897.727556810825, 10997.505112269808, 11006.889931100586, 11020.834687479533, 8267.503949762793, 8306.252437280433, 8350.290225330915, 8459.746207613782, 8474.533900635524, 8495.108013658477, 8524.403291769517, 8613.913860861312, 8638.17937295956, 8664.523451210243], "value": 7188.636842639602, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.2754089193345, 517.1647788821056, 528.1918664443401, 540.0710777462763, 541.9322584676916, 6305.873882522347, 6319.0, 6323.620582765037, 6343.714532846021, 6347.3969972852565, 6182.505399568035, 6195.721192546335, 6208.472279856206, 6230.5638605297645, 6241.438270555649, 4964.106460837048, 4971.179755340365, 4988.426330971948, 4990.0, 4991.351124353829, 4711.175544279755, 4822.373091498101, 4926.507349265081, 4935.605151587883, 4972.801087956477, 4712.528747125277, 4759.405074365704, 4773.212419950704, 4795.472498025214, 4813.085513752376, 4758.143534163849, 4794.880127996793, 4797.2324428091515, 4803.303520989454, 4835.6131509479155, 4212.810423530948, 4237.385579091046, 4283.1433713257475, 4308.67684923632, 4324.437823083011, 6020.307664618581, 6034.547408944347, 6042.184305118797, 6065.423784740443, 6073.119397687311, 5741.110127930177, 5774.393688662672, 5782.363939966643, 5790.797322093748, 5794.246747922743, 6720.764773232913, 6724.798256052326, 6729.091572637681, 6729.461643068543, 6743.426808721265, 4922.145155809621, 4937.851864444073, 4953.2570114483115, 4966.90066198674, 4969.428515720666, 6664.400203981665, 6761.492888033417, 6805.761798337035, 6812.352826481477, 6978.371946524786, 5054.267131265946, 5054.508919868647, 5055.823046193365, 5069.656541016633, 5071.4928507149725, 5140.280360749498, 5150.0472412603785, 5151.356080489939, 5158.716270605153, 5162.741862906914, 5734.426557344233, 5736.971315143398, 5751.971240143856, 5754.0, 5767.279090113736, 6657.1345725055435, 6657.23441804189, 6668.9982513115165, 6674.399304062657, 6708.15525730428, 1770.5927636643387, 1774.9527778610423, 1781.7060185069317, 1801.7117261238138, 1811.8278763517444, 1178.552150182925, 1232.9938350308191, 1233.2785320587557, 1246.5263199984129, 1254.5859866244118, 6374.661321122523, 6383.904241436382, 6402.8719425611225, 6418.486521078303, 6426.967865160645, 6823.69293381799, 6853.862922741617, 6854.280300568468, 6859.211190713032, 6863.176418829772, 6206.317305096436, 6265.373462653698, 6312.684365781693, 6373.426391624776, 6381.425671689477, 3533.152043509539, 3595.6044835068124, 3596.9820150899077, 3610.5667319921777, 3645.8177091145335, 7172.6055066970775, 7189.604571748499, 7199.2440793715905, 7274.381677557361, 7291.562506249642, 6903.344182302673, 6954.0, 6980.197277313174, 6994.370506654425, 7013.228544860061, 6728.495362847806, 7017.228284766408, 7017.508774385744, 7080.36276735086, 7149.0348802911985, 6566.9343306568235, 6617.8014659560295, 6661.900071498834, 6688.565243259172, 6831.574790949141, 6623.370779775913, 6623.701933413105, 6644.0, 6751.156105486814, 6792.320767923168, 7206.7117315306805, 7242.818929526593, 7243.275672432715, 7256.129264488295, 7282.308180722823, 5091.567216786615, 5101.7704203310195, 5106.514881086291, 5110.565601923878, 5127.948720512747, 6664.400203981665, 6749.763758268634, 6779.593224406552, 6841.418479429304, 6941.652917354213, 6555.656090501531, 6599.53803233769, 6648.401643852077, 6676.866462670817, 6687.230968438692, 6478.643674597943, 6566.507511936719, 6580.5064620152725, 6628.933710662832, 6651.605422048156, 6583.539152259296, 6621.867562648817, 6648.434883034996, 6666.633335166613, 6668.966655166887, 6689.26418094019, 6704.363085506869, 6732.764353247613, 6752.223494298219, 6795.93204067953, 6448.162273751958, 6482.0, 6526.804195874131, 6548.705308261235, 6564.6389448580785], "value": 5152.660402696008, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [921.2537844346081, 935.854942483915, 951.5860600638723, 953.2231231546285, 962.7256231973889, 17625.82374176258, 19235.23059077637, 19955.0022498875, 19967.201311947523, 20023.299184528507, 21994.89002554989, 22367.99999999996, 22418.551628967412, 22558.097676092977, 22573.77426225737, 1002.4135880509892, 1038.8961103889626, 1040.3185913226848, 1040.3757745352766, 1040.677390009096, 1000.7948370584049, 1020.1277907389186, 1055.6041484443333, 1055.9894401056006, 1059.86751656043, 1011.4993078426189, 1077.8975997280286, 1078.7357097511122, 1078.9784204315908, 1079.0288740133865, 1006.7734759679087, 1066.845307430426, 1067.4289255248443, 1067.8184708599556, 1071.0735214039878, 736.5323019882413, 760.1600231743898, 771.93052625264, 772.7025095338336, 772.9188435214278, 17540.29838806446, 17847.107644617718, 17867.821321786745, 18107.094645267684, 20165.798342016686, 21775.0, 21986.670199947013, 22042.228522001813, 22284.442888927744, 22288.55422891533, 17158.227879745442, 17412.91293543524, 17497.47507574775, 17524.91237543817, 18028.729569056475, 3803.4675145479655, 3832.559255685604, 3833.9424908626393, 3839.1937693084487, 3845.8846234613006, 148300.0, 149521.0, 149719.2514037423, 149774.0, 151317.0, 16437.753433698505, 16463.506094817174, 16951.49145525636, 17002.829971700372, 17023.744643830352, 24408.877955610107, 24458.26625201247, 24564.754352456603, 24573.38566535851, 24580.139695110942, 7853.960730196312, 8425.4944703318, 8796.736097917073, 9158.587863546156, 9206.861897071549, 4335.674824388184, 4404.889877753018, 4418.226810308183, 4440.555944405533, 4442.68901176921, 5708.372079071299, 5838.38696936824, 5852.209951656472, 5871.383504732027, 5875.853103672357, 1075.4676435164642, 1099.9725006874733, 1106.5518465021519, 1106.878243393226, 1110.156281226274, 720.9567425954459, 741.3994664321916, 747.5103807006419, 753.0925235091702, 763.5914785589683, 13091.738165236642, 13123.950083993257, 13488.190708557519, 13498.392572334073, 13620.387082581308, 712.4656507619286, 725.811289064847, 731.4185222747928, 739.6190961654752, 745.8433728916988, 5931.228940237827, 5982.1325907744, 5982.700864956735, 5988.550858685616, 6093.695315234309, 122799.0, 126584.0, 132994.33502832425, 133726.0, 137478.0, 113757.0, 117765.41117294358, 118721.0, 119448.0, 125373.37313313375, 104018.47990760149, 105503.0, 105765.0, 107142.92857071485, 109226.0, 13576.117552359065, 13659.248741318925, 13701.588952331445, 13847.0, 14145.43418263258, 46765.0, 48098.519014809404, 49192.0, 49457.50542494529, 50882.49117508777, 61459.38540614537, 61583.0, 61686.383136168064, 61693.0, 63221.36778632155, 19730.40808775739, 20258.59482810365, 20266.290679826136, 20360.389188324374, 20429.59140817205, 21751.129954801632, 21859.781402185774, 21895.343139705834, 22022.449438763517, 22186.1125554976, 21095.894520527298, 21105.89447052755, 21165.89417052905, 21262.25582104619, 21313.6802947959, 20258.0, 20471.795282046987, 20524.58950821005, 20533.076011579215, 20744.688829667266, 20305.695414569087, 20659.690104648744, 20698.48253793667, 20757.377278681663, 20992.685109723672, 14034.649133771738, 14444.0, 14455.349509272319, 14592.635184120481, 14866.702665946405, 15460.768088478457, 15838.049717017017, 15875.0, 15951.8404815955, 16097.678046438772], "value": 9767.849590636835, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 106.0, 98.0, 106.0, 106.0, 106.0, 109.0, 99.0, 106.0, 109.0], "value": 104.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 114.0, 142.0, 160.0, 114.0, 144.0, 141.0, 114.0, 172.0, 114.0], "value": 135.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 162.0, 167.0, 163.0, 172.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 79.0, 128.0, 74.0, 75.0, 73.0, 86.0, 100.0, 72.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 127.0, 79.0, 77.0, 78.0, 134.0, 79.0, 77.0, 122.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 149.0, 148.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 94.0, 99.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 46.0, 54.0, 47.0, 47.0, 57.0, 48.0, 48.0, 49.0, 47.0], "value": 49.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 53.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 72.0, 74.0, 73.0, 74.0, 72.0, 74.0, 74.0], "value": 73.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 112.0, 119.0, 114.0, 115.0, 117.0, 111.0, 118.0, 115.0, 147.0], "value": 118.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 175.0, 167.0, 177.0, 163.0, 171.0, 160.0, 176.0, 168.0, 168.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 66.0, 60.0, 60.0, 60.0, 65.0, 61.0, 61.0, 66.0], "value": 62.1, "unit": "score"}]}]} 03:52:33 INFO - Return code: 0 03:52:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:52:33 INFO - # TBPL SUCCESS # 03:52:33 INFO - Running post-action listener: _package_coverage_data 03:52:33 INFO - Running post-action listener: _resource_record_post_action 03:52:33 INFO - [mozharness: 2017-08-16 10:52:33.728720Z] Finished run-tests step (success) 03:52:33 INFO - Running post-run listener: _resource_record_post_run 03:52:33 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 10629120; Write bytes: 431063040; Read time: 5952; Write time: 356240 03:52:33 INFO - TinderboxPrint: CPU usage
13.1% 03:52:33 INFO - TinderboxPrint: I/O read bytes / time
10,629,120 / 5,952 03:52:33 INFO - TinderboxPrint: I/O write bytes / time
431,063,040 / 356,240 03:52:33 INFO - TinderboxPrint: CPU idle
8,240.3 (86.9%) 03:52:33 INFO - TinderboxPrint: CPU user
1,187.8 (12.5%) 03:52:33 INFO - TinderboxPrint: Swap in / out
0 / 0 03:52:33 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 36864; Write bytes: 120483840; Read time: 208; Write time: 71048 03:52:33 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:52:33 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 8400896; Write bytes: 233037824; Read time: 5240; Write time: 228024 03:52:34 INFO - Running post-run listener: _upload_blobber_files 03:52:34 INFO - Blob upload gear active. 03:52:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:52:34 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:52:34 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:52:34 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:52:34 INFO - (blobuploader) - INFO - Open directory for files ... 03:52:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:52:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:52:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:35 INFO - (blobuploader) - INFO - Done attempting. 03:52:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:52:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:52:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:42 INFO - (blobuploader) - INFO - Done attempting. 03:52:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:52:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:43 INFO - (blobuploader) - INFO - Done attempting. 03:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:52:43 INFO - (blobuploader) - INFO - Done attempting. 03:52:43 INFO - (blobuploader) - INFO - Iteration through files over. 03:52:43 INFO - Return code: 0 03:52:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:52:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:52:43 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d88149c756734786c49885b689acc7ec37575b29daa416d84608e9f881efa36e0b8566bc1fac697a84bef19a4922c51ec34255d60a4e9ecf3139586c6cb55266", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6be7b2ec557718cf950ff26a0da7defb063c247e1faddf6aed1a1dc9e0bf281eed757ec653ed6f56f9b02d987babdbb3f0460ee879940bafc5a6ec1fdbcab9e0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/345f7cefab71d3ba0e3a8766f5939b767a243aec0ff1355aaa2c400b8beefac07246a8315b8627d1a7b24638b3cedd3898578fb4b682817c9dc86d46c5ae28bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9726e93043402eafd3f744fe46aa6dc3e49d2fff364c44faaa8b927f3bd5713aa90ed5d7599a2c2fc7c506443c78063d6ddffd230d878722687458b6ae996730"} 03:52:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:52:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:52:43 INFO - Contents: 03:52:43 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d88149c756734786c49885b689acc7ec37575b29daa416d84608e9f881efa36e0b8566bc1fac697a84bef19a4922c51ec34255d60a4e9ecf3139586c6cb55266", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6be7b2ec557718cf950ff26a0da7defb063c247e1faddf6aed1a1dc9e0bf281eed757ec653ed6f56f9b02d987babdbb3f0460ee879940bafc5a6ec1fdbcab9e0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/345f7cefab71d3ba0e3a8766f5939b767a243aec0ff1355aaa2c400b8beefac07246a8315b8627d1a7b24638b3cedd3898578fb4b682817c9dc86d46c5ae28bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9726e93043402eafd3f744fe46aa6dc3e49d2fff364c44faaa8b927f3bd5713aa90ed5d7599a2c2fc7c506443c78063d6ddffd230d878722687458b6ae996730"} 03:52:43 INFO - Running post-run listener: copy_logs_to_upload_dir 03:52:43 INFO - Copying logs to upload dir... 03:52:43 INFO - mkdir: /builds/slave/test/build/upload/logs 03:52:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.955707 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-08-16 03:52:43.664544) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:52:43.669346) ========= 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=bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d88149c756734786c49885b689acc7ec37575b29daa416d84608e9f881efa36e0b8566bc1fac697a84bef19a4922c51ec34255d60a4e9ecf3139586c6cb55266", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6be7b2ec557718cf950ff26a0da7defb063c247e1faddf6aed1a1dc9e0bf281eed757ec653ed6f56f9b02d987babdbb3f0460ee879940bafc5a6ec1fdbcab9e0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/345f7cefab71d3ba0e3a8766f5939b767a243aec0ff1355aaa2c400b8beefac07246a8315b8627d1a7b24638b3cedd3898578fb4b682817c9dc86d46c5ae28bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9726e93043402eafd3f744fe46aa6dc3e49d2fff364c44faaa8b927f3bd5713aa90ed5d7599a2c2fc7c506443c78063d6ddffd230d878722687458b6ae996730"} build_url:https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011087 build_url: 'https://queue.taskcluster.net/v1/task/AtIu2ZuORpy14LOMDAK86Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d88149c756734786c49885b689acc7ec37575b29daa416d84608e9f881efa36e0b8566bc1fac697a84bef19a4922c51ec34255d60a4e9ecf3139586c6cb55266", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6be7b2ec557718cf950ff26a0da7defb063c247e1faddf6aed1a1dc9e0bf281eed757ec653ed6f56f9b02d987babdbb3f0460ee879940bafc5a6ec1fdbcab9e0", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/345f7cefab71d3ba0e3a8766f5939b767a243aec0ff1355aaa2c400b8beefac07246a8315b8627d1a7b24638b3cedd3898578fb4b682817c9dc86d46c5ae28bc", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9726e93043402eafd3f744fe46aa6dc3e49d2fff364c44faaa8b927f3bd5713aa90ed5d7599a2c2fc7c506443c78063d6ddffd230d878722687458b6ae996730"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:52:43.703390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:52:43.703877) ========= 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=bb9b54edd4a927dc735d112f000001d9-1502879507.627911-1855562820 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004401 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:52:43.785651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:52:43.787752) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:52:43.788096) ========= ========= Total master_lag: 0.18 =========