builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-013 starttime: 1500724336.91 results: success (0) revision: 7ce557b85b611536b69539a7c18d4834ffc92eea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:16.911012) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:16.911379) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:16.911644) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:17.050596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:17.051142) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-22 04:52:17-- 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% 42.6M=0s 2017-07-22 04:52:17 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152418 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:17.267710) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:17.268006) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017966 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:17.377505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-07-22 04:52:17.380456) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7ce557b85b611536b69539a7c18d4834ffc92eea --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 7ce557b85b611536b69539a7c18d4834ffc92eea --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=9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-22 04:52:17,391 truncating revision to first 12 chars 2017-07-22 04:52:17,391 Setting DEBUG logging. 2017-07-22 04:52:17,391 attempt 1/10 2017-07-22 04:52:17,391 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7ce557b85b61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-22 04:52:19,387 unpacking tar archive at: mozilla-central-7ce557b85b61/testing/mozharness/ program finished with exit code 0 elapsedTime=2.338999 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-07-22 04:52:19.775151) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:19.775505) ========= script_repo_revision: 7ce557b85b611536b69539a7c18d4834ffc92eea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:19.775887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:19.776169) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-22 04:52:19.786590) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-07-22 04:52:19.786995) ========= /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=9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:52:19 INFO - MultiFileLogger online at 20170722 04:52:19 in /builds/slave/test 04:52:19 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 04:52:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:52:19 INFO - {'append_to_log': False, 04:52:19 INFO - 'base_work_dir': '/builds/slave/test', 04:52:19 INFO - 'blob_upload_branch': 'Firefox', 04:52:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:52:19 INFO - 'branch': 'Firefox', 04:52:19 INFO - 'buildbot_json_path': 'buildprops.json', 04:52:19 INFO - 'code_coverage': False, 04:52:19 INFO - 'config_files': ('talos/linux_config.py',), 04:52:19 INFO - 'default_actions': ('clobber', 04:52:19 INFO - 'read-buildbot-config', 04:52:19 INFO - 'download-and-extract', 04:52:19 INFO - 'populate-webroot', 04:52:19 INFO - 'create-virtualenv', 04:52:19 INFO - 'install', 04:52:19 INFO - 'setup-mitmproxy', 04:52:19 INFO - 'run-tests'), 04:52:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:52:19 INFO - 'disable_ccov_upload': False, 04:52:19 INFO - 'download_minidump_stackwalk': True, 04:52:19 INFO - 'download_symbols': 'ondemand', 04:52:19 INFO - 'enable_stylo': False, 04:52:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:52:19 INFO - 'tooltool.py': '/tools/tooltool.py', 04:52:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:52:19 INFO - '/tools/misc-python/virtualenv.py')}, 04:52:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:52:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:52:19 INFO - 'gecko_profile': False, 04:52:19 INFO - 'gecko_profile_interval': 0, 04:52:19 INFO - 'installer_path': 'installer.exe', 04:52:19 INFO - 'log_level': 'info', 04:52:19 INFO - 'log_name': 'talos', 04:52:19 INFO - 'log_to_console': True, 04:52:19 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:52:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:52:19 INFO - 'opt_config_files': (), 04:52:19 INFO - 'pip_index': False, 04:52:19 INFO - 'suite': 'dromaeojs-e10s', 04:52:19 INFO - 'system_bits': '32', 04:52:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:52:19 INFO - 'title': 'talos-linux64-ix-013', 04:52:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:52:19 INFO - 'use_talos_json': True, 04:52:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:52:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:52:19 INFO - 'work_dir': 'build'} 04:52:19 INFO - [mozharness: 2017-07-22 11:52:19.881000Z] Running clobber step. 04:52:19 INFO - Running pre-action listener: _resource_record_pre_action 04:52:19 INFO - Running main action method: clobber 04:52:19 INFO - rmtree: /builds/slave/test/build 04:52:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:52:20 INFO - Running post-action listener: _resource_record_post_action 04:52:20 INFO - [mozharness: 2017-07-22 11:52:20.895734Z] Finished clobber step (success) 04:52:20 INFO - [mozharness: 2017-07-22 11:52:20.895839Z] Running read-buildbot-config step. 04:52:20 INFO - Running pre-action listener: _resource_record_pre_action 04:52:20 INFO - Running main action method: read_buildbot_config 04:52:20 INFO - Using buildbot properties: 04:52:20 INFO - { 04:52:20 INFO - "project": "", 04:52:20 INFO - "product": "firefox", 04:52:20 INFO - "who": "archaeopteryx@coole-files.de", 04:52:20 INFO - "installer_path": "public/build/target.tar.bz2", 04:52:20 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 04:52:20 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:52:20 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 04:52:20 INFO - "stage_platform": "linux64-stylo", 04:52:20 INFO - "basedir": "/builds/slave/test", 04:52:20 INFO - "buildnumber": 42, 04:52:20 INFO - "platform": "ubuntu64_hw_stylo", 04:52:20 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:52:20 INFO - "slavebuilddir": "test", 04:52:20 INFO - "taskId": "Efh4bBz-RiCfiIgIHycXcw", 04:52:20 INFO - "branch": "mozilla-central", 04:52:20 INFO - "script_repo_revision": "production", 04:52:20 INFO - "revision": "7ce557b85b611536b69539a7c18d4834ffc92eea", 04:52:20 INFO - "slavename": "talos-linux64-ix-013", 04:52:20 INFO - "repo_path": "mozilla-central" 04:52:20 INFO - } 04:52:20 INFO - Finding installer, test and symbols from parent task. 04:52:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Efh4bBz-RiCfiIgIHycXcw'}, attempt #1 04:52:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Efh4bBz-RiCfiIgIHycXcw'}, attempt #1 04:52:21 INFO - Task dependencies: XkiOXKQhR4m2VKusltKq-Q 04:52:21 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q'}, attempt #1 04:52:22 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2 04:52:22 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/test_packages.json 04:52:22 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.crashreporter-symbols.zip 04:52:22 INFO - Running post-action listener: _resource_record_post_action 04:52:22 INFO - [mozharness: 2017-07-22 11:52:22.202554Z] Finished read-buildbot-config step (success) 04:52:22 INFO - [mozharness: 2017-07-22 11:52:22.202869Z] Running download-and-extract step. 04:52:22 INFO - Running pre-action listener: _resource_record_pre_action 04:52:22 INFO - Running main action method: download_and_extract 04:52:22 INFO - mkdir: /builds/slave/test/build/tests 04:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:22 INFO - trying https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.test_packages.json 04:52:22 INFO - Downloading https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:52:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:52:22 INFO - Downloaded 989 bytes. 04:52:22 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:52:22 INFO - Using the following test package requirements: 04:52:22 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:52:22 INFO - u'common': [u'target.common.tests.zip'], 04:52:22 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:52:22 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:52:22 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:52:22 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:52:22 INFO - u'mozbase': [u'target.common.tests.zip'], 04:52:22 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:52:22 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:52:22 INFO - u'web-platform': [u'target.common.tests.zip', 04:52:22 INFO - u'target.web-platform.tests.tar.gz'], 04:52:22 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:52:22 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:52:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.common.tests.zip 04:52:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:52:22 INFO - Fetch https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.common.tests.zip into memory 04:52:24 INFO - Content-Length response header: 72760941 04:52:24 INFO - Bytes received: 72760941 04:52:35 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:52:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.common.tests.zip 04:52:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:52:35 INFO - Fetch https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.common.tests.zip into memory 04:52:37 INFO - Content-Length response header: 72760941 04:52:37 INFO - Bytes received: 72760941 04:52:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.talos.tests.zip 04:52:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:52:51 INFO - Fetch https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.talos.tests.zip into memory 04:52:52 INFO - Content-Length response header: 14498826 04:52:52 INFO - Bytes received: 14498826 04:52:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:52:52 INFO - trying https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2 04:52:52 INFO - Downloading https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:52:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:52:53 INFO - Downloaded 62028878 bytes. 04:52:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2 04:52:53 INFO - mkdir: /builds/slave/test/properties 04:52:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:52:53 INFO - Writing to file /builds/slave/test/properties/build_url 04:52:53 INFO - Contents: 04:52:53 INFO - build_url:https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2 04:52:53 INFO - Running post-action listener: _resource_record_post_action 04:52:53 INFO - Running post-action listener: set_extra_try_arguments 04:52:53 INFO - [mozharness: 2017-07-22 11:52:53.976906Z] Finished download-and-extract step (success) 04:52:53 INFO - [mozharness: 2017-07-22 11:52:53.977005Z] Running populate-webroot step. 04:52:53 INFO - Running pre-action listener: _resource_record_pre_action 04:52:53 INFO - Running main action method: populate_webroot 04:52:53 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:52:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:52:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:52:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:52:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:52:53 INFO - 'tests': ['damp', 'tps']}, 04:52:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:52:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:52:53 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 04:52:53 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 04:52:53 INFO - 'other-e10s': {'tests': ['a11yr', 04:52:53 INFO - 'ts_paint', 04:52:53 INFO - 'tpaint', 04:52:53 INFO - 'sessionrestore', 04:52:53 INFO - 'sessionrestore_many_windows', 04:52:53 INFO - 'sessionrestore_no_auto_restore', 04:52:53 INFO - 'tabpaint']}, 04:52:53 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 04:52:53 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 04:52:53 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:52:53 INFO - 'talos_options': ['--mitmproxy', 04:52:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:52:53 INFO - '--firstNonBlankPaint'], 04:52:53 INFO - 'tests': ['quantum_pageload_google', 04:52:53 INFO - 'quantum_pageload_youtube', 04:52:53 INFO - 'quantum_pageload_amazon', 04:52:53 INFO - 'quantum_pageload_facebook']}, 04:52:53 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 04:52:53 INFO - 'talos_options': ['--stylo', 04:52:53 INFO - '--mitmproxy', 04:52:53 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 04:52:53 INFO - '--firstNonBlankPaint'], 04:52:53 INFO - 'tests': ['quantum_pageload_google', 04:52:53 INFO - 'quantum_pageload_youtube', 04:52:53 INFO - 'quantum_pageload_amazon', 04:52:53 INFO - 'quantum_pageload_facebook']}, 04:52:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:52:53 INFO - 'tsvgr_opacity', 04:52:53 INFO - 'tart', 04:52:53 INFO - 'tscrollx', 04:52:53 INFO - 'cart', 04:52:53 INFO - 'tsvg_static']}, 04:52:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:52:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:52:53 INFO - 'talos_options': ['--xperf_path', 04:52:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:52:53 INFO - 'tests': ['tp5n']}}} 04:52:53 INFO - Running post-action listener: _resource_record_post_action 04:52:53 INFO - [mozharness: 2017-07-22 11:52:53.984303Z] Finished populate-webroot step (success) 04:52:53 INFO - [mozharness: 2017-07-22 11:52:53.984394Z] Running create-virtualenv step. 04:52:53 INFO - Running pre-action listener: _resource_record_pre_action 04:52:53 INFO - Running main action method: create_virtualenv 04:52:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:52:53 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 04:52:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:52:53 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 04:52:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:52:54 INFO - Using real prefix '/usr' 04:52:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:52:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:52:56 INFO - Installing pip.................done. 04:52:56 INFO - Return code: 0 04:52:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:52:56 INFO - Reading from file tmpfile_stdout 04:52:56 INFO - Output received: 04:52:56 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) 04:52:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:52:56 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')]} 04:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:56 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')]} 04:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:56 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 0x21011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246deb0>, '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 0x246edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', '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 04:52:56 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 04:52:56 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 04:52:56 INFO - Using env: {'DISPLAY': ':0', 04:52:56 INFO - 'HOME': '/home/cltbld', 04:52:56 INFO - 'LANG': 'en_US.UTF-8', 04:52:56 INFO - 'LANGUAGE': 'en_US:en', 04:52:56 INFO - 'LOGNAME': 'cltbld', 04:52:56 INFO - 'MAIL': '/var/mail/cltbld', 04:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:56 INFO - 'MOZ_NO_REMOTE': '1', 04:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:56 INFO - 'NO_EM_RESTART': '1', 04:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:56 INFO - 'PWD': '/builds/slave/test', 04:52:56 INFO - 'SHELL': '/bin/bash', 04:52:56 INFO - 'SHLVL': '1', 04:52:56 INFO - 'TERM': 'linux', 04:52:56 INFO - 'TMOUT': '86400', 04:52:56 INFO - 'USER': 'cltbld', 04:52:56 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', 04:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:56 INFO - '_': '/tools/buildbot/bin/python'} 04:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:56 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 04:52:56 INFO - Cleaning up... 04:52:56 INFO - Return code: 0 04:52:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:52:56 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')]} 04:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:56 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')]} 04:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:56 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 0x21011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246deb0>, '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 0x246edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', '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 04:52:56 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 04:52:56 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 04:52:56 INFO - Using env: {'DISPLAY': ':0', 04:52:56 INFO - 'HOME': '/home/cltbld', 04:52:56 INFO - 'LANG': 'en_US.UTF-8', 04:52:56 INFO - 'LANGUAGE': 'en_US:en', 04:52:56 INFO - 'LOGNAME': 'cltbld', 04:52:56 INFO - 'MAIL': '/var/mail/cltbld', 04:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:56 INFO - 'MOZ_NO_REMOTE': '1', 04:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:56 INFO - 'NO_EM_RESTART': '1', 04:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:56 INFO - 'PWD': '/builds/slave/test', 04:52:56 INFO - 'SHELL': '/bin/bash', 04:52:56 INFO - 'SHLVL': '1', 04:52:56 INFO - 'TERM': 'linux', 04:52:56 INFO - 'TMOUT': '86400', 04:52:56 INFO - 'USER': 'cltbld', 04:52:56 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', 04:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:56 INFO - '_': '/tools/buildbot/bin/python'} 04:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:57 INFO - Downloading/unpacking psutil>=3.1.1 04:52:57 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 04:52:57 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 04:52:57 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 04:52:57 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 04:52:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:52:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:58 INFO - Installing collected packages: psutil 04:52:58 INFO - Running setup.py install for psutil 04:52:58 INFO - building 'psutil._psutil_linux' extension 04:52:58 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 04:52:58 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 04:52:58 INFO - building 'psutil._psutil_posix' extension 04:52:58 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 04:52:58 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 04:52:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:52:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:52:58 INFO - Successfully installed psutil 04:52:58 INFO - Cleaning up... 04:52:58 INFO - Return code: 0 04:52:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:52:58 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')]} 04:52:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:52:58 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')]} 04:52:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:52:58 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 0x21011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246deb0>, '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 0x246edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', '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 04:52:58 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 04:52:58 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 04:52:58 INFO - Using env: {'DISPLAY': ':0', 04:52:58 INFO - 'HOME': '/home/cltbld', 04:52:58 INFO - 'LANG': 'en_US.UTF-8', 04:52:58 INFO - 'LANGUAGE': 'en_US:en', 04:52:58 INFO - 'LOGNAME': 'cltbld', 04:52:58 INFO - 'MAIL': '/var/mail/cltbld', 04:52:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:52:58 INFO - 'MOZ_NO_REMOTE': '1', 04:52:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:52:58 INFO - 'NO_EM_RESTART': '1', 04:52:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:52:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:52:58 INFO - 'PWD': '/builds/slave/test', 04:52:58 INFO - 'SHELL': '/bin/bash', 04:52:58 INFO - 'SHLVL': '1', 04:52:58 INFO - 'TERM': 'linux', 04:52:58 INFO - 'TMOUT': '86400', 04:52:58 INFO - 'USER': 'cltbld', 04:52:58 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', 04:52:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:52:58 INFO - '_': '/tools/buildbot/bin/python'} 04:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:52:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:52:59 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 04:52:59 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 04:52:59 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 04:52:59 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 04:53:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:53:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:53:00 INFO - Installing collected packages: mozsystemmonitor 04:53:00 INFO - Running setup.py install for mozsystemmonitor 04:53:00 INFO - Successfully installed mozsystemmonitor 04:53:00 INFO - Cleaning up... 04:53:00 INFO - Return code: 0 04:53:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:53:00 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')]} 04:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:00 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')]} 04:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:00 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 0x21011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246deb0>, '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 0x246edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', '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 04:53:00 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 04:53:00 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 04:53:00 INFO - Using env: {'DISPLAY': ':0', 04:53:00 INFO - 'HOME': '/home/cltbld', 04:53:00 INFO - 'LANG': 'en_US.UTF-8', 04:53:00 INFO - 'LANGUAGE': 'en_US:en', 04:53:00 INFO - 'LOGNAME': 'cltbld', 04:53:00 INFO - 'MAIL': '/var/mail/cltbld', 04:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:00 INFO - 'MOZ_NO_REMOTE': '1', 04:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:00 INFO - 'NO_EM_RESTART': '1', 04:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:00 INFO - 'PWD': '/builds/slave/test', 04:53:00 INFO - 'SHELL': '/bin/bash', 04:53:00 INFO - 'SHLVL': '1', 04:53:00 INFO - 'TERM': 'linux', 04:53:00 INFO - 'TMOUT': '86400', 04:53:00 INFO - 'USER': 'cltbld', 04:53:00 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', 04:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:00 INFO - '_': '/tools/buildbot/bin/python'} 04:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:00 INFO - Downloading/unpacking jsonschema==2.5.1 04:53:00 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 04:53:00 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 04:53:00 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 04:53:00 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 04:53:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:53:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:53:01 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 04:53:01 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 04:53:01 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 04:53:01 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 04:53:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:53:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:53:01 INFO - warning: no files found matching '*.txt' 04:53:01 INFO - no previously-included directories found matching 'build' 04:53:01 INFO - no previously-included directories found matching 'dist' 04:53:01 INFO - no previously-included directories found matching '.git*' 04:53:01 INFO - Installing collected packages: jsonschema, functools32 04:53:01 INFO - Running setup.py install for functools32 04:53:01 INFO - warning: no files found matching '*.txt' 04:53:01 INFO - no previously-included directories found matching 'build' 04:53:01 INFO - no previously-included directories found matching 'dist' 04:53:01 INFO - no previously-included directories found matching '.git*' 04:53:01 INFO - Successfully installed jsonschema functools32 04:53:01 INFO - Cleaning up... 04:53:02 INFO - Return code: 0 04:53:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53: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')]} 04:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:02 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 0x21011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246deb0>, '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 0x246edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', '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 04:53:02 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 04:53:02 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 04:53:02 INFO - Using env: {'DISPLAY': ':0', 04:53:02 INFO - 'HOME': '/home/cltbld', 04:53:02 INFO - 'LANG': 'en_US.UTF-8', 04:53:02 INFO - 'LANGUAGE': 'en_US:en', 04:53:02 INFO - 'LOGNAME': 'cltbld', 04:53:02 INFO - 'MAIL': '/var/mail/cltbld', 04:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:02 INFO - 'MOZ_NO_REMOTE': '1', 04:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:02 INFO - 'NO_EM_RESTART': '1', 04:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:02 INFO - 'PWD': '/builds/slave/test', 04:53:02 INFO - 'SHELL': '/bin/bash', 04:53:02 INFO - 'SHLVL': '1', 04:53:02 INFO - 'TERM': 'linux', 04:53:02 INFO - 'TMOUT': '86400', 04:53:02 INFO - 'USER': 'cltbld', 04:53:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', 04:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:02 INFO - '_': '/tools/buildbot/bin/python'} 04:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:53:02 INFO - Cleaning up... 04:53:02 INFO - Return code: 0 04:53:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:53: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')]} 04:53:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53: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')]} 04:53:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:02 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 0x21011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246deb0>, '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 0x246edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', '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 04:53:02 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 04:53:02 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 04:53:02 INFO - Using env: {'DISPLAY': ':0', 04:53:02 INFO - 'HOME': '/home/cltbld', 04:53:02 INFO - 'LANG': 'en_US.UTF-8', 04:53:02 INFO - 'LANGUAGE': 'en_US:en', 04:53:02 INFO - 'LOGNAME': 'cltbld', 04:53:02 INFO - 'MAIL': '/var/mail/cltbld', 04:53:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:02 INFO - 'MOZ_NO_REMOTE': '1', 04:53:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:02 INFO - 'NO_EM_RESTART': '1', 04:53:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:02 INFO - 'PWD': '/builds/slave/test', 04:53:02 INFO - 'SHELL': '/bin/bash', 04:53:02 INFO - 'SHLVL': '1', 04:53:02 INFO - 'TERM': 'linux', 04:53:02 INFO - 'TMOUT': '86400', 04:53:02 INFO - 'USER': 'cltbld', 04:53:02 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', 04:53:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:02 INFO - '_': '/tools/buildbot/bin/python'} 04:53:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:53:02 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 04:53:02 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 04:53:02 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 04:53:02 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 04:53:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:53:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:53:03 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 04:53:03 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 04:53:03 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 04:53:03 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 04:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:53:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:53:03 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 04:53:03 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 04:53:03 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 04:53:03 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 04:53:04 INFO - Downloading docopt-0.6.1.tar.gz 04:53:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:53:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:53:04 INFO - Running setup.py install for blobuploader 04:53:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:53:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:53:04 INFO - Running setup.py install for requests 04:53:04 INFO - Running setup.py install for docopt 04:53:04 INFO - Successfully installed blobuploader requests docopt 04:53:04 INFO - Cleaning up... 04:53:04 INFO - Return code: 0 04:53:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:04 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 0x21011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246deb0>, '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 0x246edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', '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 04:53:04 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 04:53:04 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 04:53:04 INFO - Using env: {'DISPLAY': ':0', 04:53:04 INFO - 'HOME': '/home/cltbld', 04:53:04 INFO - 'LANG': 'en_US.UTF-8', 04:53:04 INFO - 'LANGUAGE': 'en_US:en', 04:53:04 INFO - 'LOGNAME': 'cltbld', 04:53:04 INFO - 'MAIL': '/var/mail/cltbld', 04:53:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:04 INFO - 'MOZ_NO_REMOTE': '1', 04:53:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:04 INFO - 'NO_EM_RESTART': '1', 04:53:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:04 INFO - 'PWD': '/builds/slave/test', 04:53:04 INFO - 'SHELL': '/bin/bash', 04:53:04 INFO - 'SHLVL': '1', 04:53:04 INFO - 'TERM': 'linux', 04:53:04 INFO - 'TMOUT': '86400', 04:53:04 INFO - 'USER': 'cltbld', 04:53:04 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', 04:53:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:04 INFO - '_': '/tools/buildbot/bin/python'} 04:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:04 INFO - Running setup.py (path:/tmp/pip-MPEkMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:05 INFO - Running setup.py (path:/tmp/pip-Wm7vzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:05 INFO - Running setup.py (path:/tmp/pip-aNjCp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:05 INFO - Running setup.py (path:/tmp/pip-hLqR9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:05 INFO - Running setup.py (path:/tmp/pip-z8FFuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:05 INFO - Running setup.py (path:/tmp/pip-HAKOTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:05 INFO - Running setup.py (path:/tmp/pip-YaEw4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:05 INFO - Running setup.py (path:/tmp/pip-TGCCE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:05 INFO - Running setup.py (path:/tmp/pip-rrzGNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:05 INFO - Running setup.py (path:/tmp/pip-2I7pQR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:05 INFO - Running setup.py (path:/tmp/pip-ap2Ij6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:05 INFO - Running setup.py (path:/tmp/pip-vxgRBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:05 INFO - Running setup.py (path:/tmp/pip-ilfnIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:05 INFO - Running setup.py (path:/tmp/pip-LQz8Ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:05 INFO - Running setup.py (path:/tmp/pip-e1OxgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:06 INFO - Running setup.py (path:/tmp/pip-rB0xpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:06 INFO - Running setup.py (path:/tmp/pip-HUznyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:53:06 INFO - Running setup.py install for manifestparser 04:53:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:53:06 INFO - Running setup.py install for mozcrash 04:53:06 INFO - Running setup.py install for mozdebug 04:53:06 INFO - Running setup.py install for mozdevice 04:53:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:53:06 INFO - Running setup.py install for mozfile 04:53:06 INFO - Running setup.py install for mozhttpd 04:53:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:53:06 INFO - Running setup.py install for mozinfo 04:53:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:53:06 INFO - Running setup.py install for mozInstall 04:53:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:53:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:53:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:53:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:53:06 INFO - Running setup.py install for mozleak 04:53:07 INFO - Running setup.py install for mozlog 04:53:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:53:07 INFO - Running setup.py install for moznetwork 04:53:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:53:07 INFO - Running setup.py install for mozprocess 04:53:07 INFO - Running setup.py install for mozprofile 04:53:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:53:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:53:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:53:07 INFO - Running setup.py install for mozrunner 04:53:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:53:07 INFO - Running setup.py install for mozscreenshot 04:53:07 INFO - Running setup.py install for moztest 04:53:07 INFO - Running setup.py install for mozversion 04:53:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:53:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:53:07 INFO - Cleaning up... 04:53:07 INFO - Return code: 0 04:53:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:07 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')]} 04:53:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:07 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')]} 04:53:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:08 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 0x21011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246deb0>, '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 0x246edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', '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 04:53:08 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 04:53:08 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 04:53:08 INFO - Using env: {'DISPLAY': ':0', 04:53:08 INFO - 'HOME': '/home/cltbld', 04:53:08 INFO - 'LANG': 'en_US.UTF-8', 04:53:08 INFO - 'LANGUAGE': 'en_US:en', 04:53:08 INFO - 'LOGNAME': 'cltbld', 04:53:08 INFO - 'MAIL': '/var/mail/cltbld', 04:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:08 INFO - 'MOZ_NO_REMOTE': '1', 04:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:08 INFO - 'NO_EM_RESTART': '1', 04:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:08 INFO - 'PWD': '/builds/slave/test', 04:53:08 INFO - 'SHELL': '/bin/bash', 04:53:08 INFO - 'SHLVL': '1', 04:53:08 INFO - 'TERM': 'linux', 04:53:08 INFO - 'TMOUT': '86400', 04:53:08 INFO - 'USER': 'cltbld', 04:53:08 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', 04:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:08 INFO - '_': '/tools/buildbot/bin/python'} 04:53:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:53:08 INFO - Running setup.py (path:/tmp/pip-LK_Pck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:53:08 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)) 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:53:08 INFO - Running setup.py (path:/tmp/pip-ISgZ_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:53:08 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)) 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:53:08 INFO - Running setup.py (path:/tmp/pip-EPtZ0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:53:08 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)) 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:53:08 INFO - Running setup.py (path:/tmp/pip-UeUcgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:53:08 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)) 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:53:08 INFO - Running setup.py (path:/tmp/pip-y72f_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:53:08 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)) 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:53:08 INFO - Running setup.py (path:/tmp/pip-d9lhyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:53:08 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)) 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:53:08 INFO - Running setup.py (path:/tmp/pip-xvjsRh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:53:08 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)) 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:53:08 INFO - Running setup.py (path:/tmp/pip-cSe1Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:53:08 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)) 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:53:08 INFO - Running setup.py (path:/tmp/pip-RnssTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:53:08 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)) 04:53:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:53:08 INFO - Running setup.py (path:/tmp/pip-aK5lFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:53:08 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)) 04:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:53:09 INFO - Running setup.py (path:/tmp/pip-w53mQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:53:09 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)) 04:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:53:09 INFO - Running setup.py (path:/tmp/pip-U99AUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:53:09 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)) 04:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:53:09 INFO - Running setup.py (path:/tmp/pip-jNo0pN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:53:09 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)) 04:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:53:09 INFO - Running setup.py (path:/tmp/pip-KhA3iM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:53:09 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)) 04:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:09 INFO - Running setup.py (path:/tmp/pip-p0GT0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:53:09 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)) 04:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:53:09 INFO - Running setup.py (path:/tmp/pip-brU9u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:53:09 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)) 04:53:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:53:09 INFO - Running setup.py (path:/tmp/pip-HOE5Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:53:09 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)) 04:53:09 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)) 04:53:09 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)) 04:53:09 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)) 04:53:09 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)) 04:53:09 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)) 04:53:09 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)) 04:53:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:53:09 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 04:53:09 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 04:53:09 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 04:53:09 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 04:53:10 INFO - Downloading blessings-1.6.tar.gz 04:53:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:53:10 INFO - Installing collected packages: blessings 04:53:10 INFO - Running setup.py install for blessings 04:53:11 INFO - Successfully installed blessings 04:53:11 INFO - Cleaning up... 04:53:11 INFO - Return code: 0 04:53:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:53:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:11 INFO - Reading from file tmpfile_stdout 04:53:11 INFO - Current package versions: 04:53:11 INFO - argparse == 1.2.1 04:53:11 INFO - blessings == 1.6 04:53:11 INFO - blobuploader == 1.2.4 04:53:11 INFO - docopt == 0.6.1 04:53:11 INFO - functools32 == 3.2.3-2 04:53:11 INFO - jsonschema == 2.5.1 04:53:11 INFO - manifestparser == 1.1 04:53:11 INFO - mozInstall == 1.13 04:53:11 INFO - mozcrash == 1.0 04:53:11 INFO - mozdebug == 0.1 04:53:11 INFO - mozdevice == 0.51 04:53:11 INFO - mozfile == 1.2 04:53:11 INFO - mozhttpd == 0.7 04:53:11 INFO - mozinfo == 0.10 04:53:11 INFO - mozleak == 0.1 04:53:11 INFO - mozlog == 3.5 04:53:11 INFO - moznetwork == 0.27 04:53:11 INFO - mozprocess == 0.25 04:53:11 INFO - mozprofile == 0.28 04:53:11 INFO - mozrunner == 6.13 04:53:11 INFO - mozscreenshot == 0.1 04:53:11 INFO - mozsystemmonitor == 0.3 04:53:11 INFO - moztest == 0.8 04:53:11 INFO - mozversion == 1.4 04:53:11 INFO - psutil == 3.1.1 04:53:11 INFO - requests == 1.2.3 04:53:11 INFO - wsgiref == 0.1.2 04:53:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:11 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 0x21011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246deb0>, '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 0x246edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', '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 04:53:11 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 04:53:11 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 04:53:11 INFO - Using env: {'DISPLAY': ':0', 04:53:11 INFO - 'HOME': '/home/cltbld', 04:53:11 INFO - 'LANG': 'en_US.UTF-8', 04:53:11 INFO - 'LANGUAGE': 'en_US:en', 04:53:11 INFO - 'LOGNAME': 'cltbld', 04:53:11 INFO - 'MAIL': '/var/mail/cltbld', 04:53:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:11 INFO - 'MOZ_NO_REMOTE': '1', 04:53:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:11 INFO - 'NO_EM_RESTART': '1', 04:53:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:11 INFO - 'PWD': '/builds/slave/test', 04:53:11 INFO - 'SHELL': '/bin/bash', 04:53:11 INFO - 'SHLVL': '1', 04:53:11 INFO - 'TERM': 'linux', 04:53:11 INFO - 'TMOUT': '86400', 04:53:11 INFO - 'USER': 'cltbld', 04:53:11 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', 04:53:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:11 INFO - '_': '/tools/buildbot/bin/python'} 04:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:11 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)) 04:53:11 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)) 04:53:11 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)) 04:53:11 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)) 04:53:11 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)) 04:53:11 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)) 04:53:11 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)) 04:53:11 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)) 04:53:11 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)) 04:53:11 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:13 INFO - Downloading marionette_driver-1.4.0.tar.gz 04:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 04:53:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 04:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:53:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 04:53:13 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)) 04:53:13 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)) 04:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 04:53:13 INFO - Installing collected packages: marionette-driver, simplejson 04:53:13 INFO - Running setup.py install for marionette-driver 04:53:13 INFO - Running setup.py install for simplejson 04:53:13 INFO - building 'simplejson._speedups' extension 04:53:13 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 04:53:14 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 04:53:14 INFO - Successfully installed marionette-driver simplejson 04:53:14 INFO - Cleaning up... 04:53:14 INFO - Return code: 0 04:53:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:53:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:53:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246deb0>, '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 0x246edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f240>, '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': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', '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 04:53:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:53:14 INFO - Using env: {'DISPLAY': ':0', 04:53:14 INFO - 'HOME': '/home/cltbld', 04:53:14 INFO - 'LANG': 'en_US.UTF-8', 04:53:14 INFO - 'LANGUAGE': 'en_US:en', 04:53:14 INFO - 'LOGNAME': 'cltbld', 04:53:14 INFO - 'MAIL': '/var/mail/cltbld', 04:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:14 INFO - 'MOZ_NO_REMOTE': '1', 04:53:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:14 INFO - 'NO_EM_RESTART': '1', 04:53:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:14 INFO - 'PWD': '/builds/slave/test', 04:53:14 INFO - 'SHELL': '/bin/bash', 04:53:14 INFO - 'SHLVL': '1', 04:53:14 INFO - 'TERM': 'linux', 04:53:14 INFO - 'TMOUT': '86400', 04:53:14 INFO - 'USER': 'cltbld', 04:53:14 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', 04:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:14 INFO - '_': '/tools/buildbot/bin/python'} 04:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:53:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:53:14 INFO - Cleaning up... 04:53:14 INFO - Return code: 0 04:53:14 INFO - Running post-action listener: _resource_record_post_action 04:53:14 INFO - Running post-action listener: _start_resource_monitoring 04:53:14 INFO - Starting resource monitoring. 04:53:14 INFO - [mozharness: 2017-07-22 11:53:14.827059Z] Finished create-virtualenv step (success) 04:53:14 INFO - [mozharness: 2017-07-22 11:53:14.827561Z] Running install step. 04:53:14 INFO - Running pre-action listener: _resource_record_pre_action 04:53:14 INFO - Running main action method: install 04:53:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:53:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:53:15 INFO - Reading from file tmpfile_stdout 04:53:15 INFO - Detecting whether we're running mozinstall >=1.0... 04:53:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:53:15 INFO - Reading from file tmpfile_stdout 04:53:15 INFO - Output received: 04:53:15 INFO - Usage: mozinstall [options] installer 04:53:15 INFO - Options: 04:53:15 INFO - -h, --help show this help message and exit 04:53:15 INFO - -d DEST, --destination=DEST 04:53:15 INFO - Directory to install application into. [default: 04:53:15 INFO - "/builds/slave/test"] 04:53:15 INFO - --app=APP Application being installed. [default: firefox] 04:53:15 INFO - mkdir: /builds/slave/test/build/application 04:53:15 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'] 04:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:53:33 INFO - Reading from file tmpfile_stdout 04:53:33 INFO - Output received: 04:53:33 INFO - /builds/slave/test/build/application/firefox/firefox 04:53:33 INFO - Running post-action listener: _resource_record_post_action 04:53:33 INFO - [mozharness: 2017-07-22 11:53:33.117582Z] Finished install step (success) 04:53:33 INFO - [mozharness: 2017-07-22 11:53:33.117834Z] Running setup-mitmproxy step. 04:53:33 INFO - Running pre-action listener: _resource_record_pre_action 04:53:33 INFO - Running main action method: setup_mitmproxy 04:53:33 INFO - Skipping: mitmproxy is not required 04:53:33 INFO - Running post-action listener: _resource_record_post_action 04:53:33 INFO - [mozharness: 2017-07-22 11:53:33.118960Z] Finished setup-mitmproxy step (success) 04:53:33 INFO - [mozharness: 2017-07-22 11:53:33.119180Z] Running run-tests step. 04:53:33 INFO - Running pre-action listener: _resource_record_pre_action 04:53:33 INFO - Running pre-action listener: _set_gcov_prefix 04:53:33 INFO - Running main action method: run_tests 04:53:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:53:33 INFO - Python 2.7.3 04:53:33 INFO - Return code: 0 04:53:33 INFO - grabbing minidump binary from tooltool 04:53:33 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')]} 04:53:33 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 0x246deb0>, '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 0x246edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:53:33 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 04:53:33 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 04:53:33 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 04:53:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:53:33 INFO - Return code: 0 04:53:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:53:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:53:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:53:33 INFO - ENV: RUST_BACKTRACE is now 1 04:53:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:53:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:53:33 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/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 04:53:33 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/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-013 --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 04:53:33 INFO - Using env: {'DISPLAY': ':0', 04:53:33 INFO - 'HOME': '/home/cltbld', 04:53:33 INFO - 'LANG': 'en_US.UTF-8', 04:53:33 INFO - 'LANGUAGE': 'en_US:en', 04:53:33 INFO - 'LOGNAME': 'cltbld', 04:53:33 INFO - 'MAIL': '/var/mail/cltbld', 04:53:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:53:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:53:33 INFO - 'MOZ_NO_REMOTE': '1', 04:53:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:53:33 INFO - 'NO_EM_RESTART': '1', 04:53:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:53:33 INFO - 'PWD': '/builds/slave/test', 04:53:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:53:33 INFO - 'RUST_BACKTRACE': '1', 04:53:33 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 04:53:33 INFO - 'SHELL': '/bin/bash', 04:53:33 INFO - 'SHLVL': '1', 04:53:33 INFO - 'STYLO_FORCE_ENABLED': '1', 04:53:33 INFO - 'TERM': 'linux', 04:53:33 INFO - 'TMOUT': '86400', 04:53:33 INFO - 'USER': 'cltbld', 04:53:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047', 04:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:53:33 INFO - '_': '/tools/buildbot/bin/python'} 04:53:33 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/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--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 04:53:33 INFO - mozversion application_buildid: 20170722111228 04:53:33 INFO - mozversion application_changeset: 7ce557b85b611536b69539a7c18d4834ffc92eea 04:53:33 INFO - mozversion application_display_name: Nightly 04:53:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:53:33 INFO - mozversion application_name: Firefox 04:53:33 INFO - mozversion application_remotingname: firefox 04:53:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:53:33 INFO - mozversion application_vendor: Mozilla 04:53:33 INFO - mozversion application_version: 56.0a1 04:53:33 INFO - mozversion platform_buildid: 20170722111228 04:53:33 INFO - mozversion platform_changeset: 7ce557b85b611536b69539a7c18d4834ffc92eea 04:53:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:53:33 INFO - mozversion platform_version: 56.0a1 04:53:33 INFO - using testdate: 1500724413 04:53:33 INFO - actual date: 1500724413 04:53:33 INFO - starting webserver on 'localhost:35880' 04:53:33 INFO - SUITE-START | Running 2 tests 04:53:33 INFO - TEST-START | dromaeo_css 04:53:33 INFO - Initialising browser for dromaeo_css test... 04:53:33 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35880/getInfo.html -profile /tmp/tmpe_wnhK/profile 04:53:33 INFO - TEST-INFO | started process 11025 (/builds/slave/test/build/application/firefox/firefox http://localhost:35880/getInfo.html) 04:53:39 INFO - TEST-INFO | 11025: exit 0 04:53:39 INFO - Browser initialized. 04:53:39 INFO - Running cycle 1/1 for dromaeo_css test... 04:53:39 INFO - TEST-INFO | started process 11253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe_wnhK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:51 INFO - PID 11253 | RSS: Main: 177504256 04:53:51 INFO - PID 11253 | 04:56:50 INFO - PID 11253 | Cycle 1(1): loaded http://localhost:35880/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35880/tests/dromaeo/cssquery-ext.html) 04:56:51 INFO - PID 11253 | RSS: Main: 182521856 04:56:51 INFO - PID 11253 | 04:59:53 INFO - PID 11253 | Cycle 1(1): loaded http://localhost:35880/tests/dromaeo/cssquery-ext.html (next: http://localhost:35880/tests/dromaeo/cssquery-jquery.html) 04:59:54 INFO - PID 11253 | RSS: Main: 180953088 04:59:54 INFO - PID 11253 | 05:02:56 INFO - PID 11253 | Cycle 1(1): loaded http://localhost:35880/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35880/tests/dromaeo/cssquery-mootools.html) 05:02:56 INFO - PID 11253 | RSS: Main: 182198272 05:02:56 INFO - PID 11253 | 05:05:58 INFO - PID 11253 | Cycle 1(1): loaded http://localhost:35880/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35880/tests/dromaeo/cssquery-prototype.html) 05:05:59 INFO - PID 11253 | RSS: Main: 181194752 05:05:59 INFO - PID 11253 | 05:09:03 INFO - PID 11253 | Cycle 1(1): loaded http://localhost:35880/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35880/tests/dromaeo/cssquery-yui.html) 05:09:03 INFO - PID 11253 | RSS: Main: 180977664 05:09:03 INFO - PID 11253 | 05:12:05 INFO - PID 11253 | Cycle 1(1): loaded http://localhost:35880/tests/dromaeo/cssquery-yui.html (next: http://localhost:35880/tests/dromaeo/cssquery-dojo.html) 05:12:05 INFO - PID 11253 | RSS: Main: 182628352 05:12:05 INFO - PID 11253 | 05:12:05 INFO - PID 11253 | __start_tp_report 05:12:05 INFO - PID 11253 | _x_x_mozilla_page_load 05:12:05 INFO - PID 11253 | _x_x_mozilla_page_load_details 05:12:05 INFO - PID 11253 | |i|pagename|runs| 05:12:05 INFO - PID 11253 | |0;dojo.html;3143.7956532825365;3163.288260141467;3166.2717574957774;3186.458302088644;3196.9360612787746;6032.276126864783;6138.324784273726;6151.907721384177;6168.4448399644025;6206.348333424988;5961.61249518781;6127.632342059468;6128.908066379008;6135.171751813504;6157.353477884813;5604.915926261109;5613.550915926737;5631.549476041907;5653.971730141344;5721.656700597957;5710.2862142232225;5730.455606717355;5742.626729262605;5761.020626493485;5779.913301300484;5394.595405344576;5568.331800183963;5594.160875868612;5641.576881733866;5682.17608446775;5488.890222195574;5492.093804522249;5558.194061861048;5584.664920104807;5628.043232650419;5486.423925487846;5509.173623956399;5613.80351687693;5615.354234263031;5617.8033768817895;5922;5966.67183304918;6009.57932944694;6047.123167140784;6065.939340606582;6578.80263592093;6588.538802283794;6605.174353205849;6611.636360000198;6617.437517810992;6564.474842012628;6614.206295244553;6614.536982411233;6689.632070236135;6719.428848547879;6066.211392518989;6080.787172448943;6146.78486252979;6201.658908760016;6223.813285601439;6791.932080679228;6868.004139399859;6881.518293719391;6884.173899132136;6893.138357705287;6443.6455994920725;6471.546991710629;6495.772647957298;6548.27968923418;6557.836054098686;6426.196725409324;6474.773382931575;6526.151600291932;6570.77002304917;6655.86688266232;6578.375054369827;6605.669716514155;6622.072909792633;6636.900446493307;6661.833454163588;6503.414692677682;6567.802965911031;6656.068150458939;6656.500762442836;6670.099536562599;5183.092958732283;5277.63056586043;5326.147816349366;5344;5351;4511.458624965026;4525.909481810411;4546.4544254689645;4572.0627271409285;4618.168729628632;5636.887262254732;5714.9714251429305;5715.799947001835;5716.114002329646;5717.913596416667;6445.51658625605;6507.381798729113;6521.184851893513;6598.043283723833;6621.139251897319;5651.463111004448;5707.771689132472;5784.305883294031;5806.158107074535;5842.737076831553;5757.050086735641;5779.133130030529;5787.797427090116;5797.449242321973;5808.796692115756;6218.875622487615;6321.810345689637;6386.2975072741965;6423.03654451836;6437.163168788027;6494.967525162344;6591.14315139048;6673.9666301668185;6683.699233534599;6703.29615390377;6365.108884756045;6438.517111216771;6438.967805160944;6454.419102280817;6457.967710161419;6447.387498187664;6462.159919210472;6525.119108920235;6529.7388104475285;6545.607263564201;6487.837804054936;6545.050967609765;6564.9671751640935;6597.670116494252;6694.330566943267;6400.39196276353;6437.738328736942;6488.416042556192;6499.2200935887995;6504.902426463512;6407.295197528175;6422.518311126591;6489.415952564292;6508.60948343101;6523.510736694672;6259.092431597302;6271.905921411091;6333.904991425225;6335.366463353628;6421.614703117828;6428.260750013808;6446.871797435524;6548.116004339353;6570.605763654196;6584.308647592125;6268.623882567061;6284.622922624657;6362.936370636419;6370.617762934239;6387.329330420239 05:12:05 INFO - PID 11253 | |1;ext.html;792.6750032486682;849.6473963305227;881.4050515901766;882.8234353129371;1161.767646470706;28701.425971480585;30325.696743032564;40713.1857362853;41437.58562414375;41581.79209103958;41133.58866411335;41525.58474415255;41640.58359416405;41747.58252417475;41823.11795969181;7129.465290103237;7423;7524.548527088392;7541.472096953215;7733.304002639761;7561.357284630813;7678.846423071535;7679.654415551286;7680.500767450126;7681.9615901920415;7635.885461718079;7642.694292228304;7657.885131723028;7690.961545192266;7698.576578288192;7605.581693006882;7691.961540192319;7693.9615301923695;7695.769126926201;7697.268759467842;7570.280823321776;7626.694932202705;7643.197464266227;7647.044119485065;7649.885251721229;37726.811365942995;37768;37802.43296350529;37901.43147852785;37924.43113353302;3625.0574850538787;3630.1832087780303;3648.890533284006;3650.251698401821;3663.6519530644546;30564;30812.845935770176;30876.69123308783;30897.227569310722;30906;4904.681195722266;4909.533594308535;4922.187839006559;4940.851774446773;4968.105740966625;195784;198900;199115;199406;200350;48303.27545086826;48558.27162592564;48636.7568162164;48723.26915096276;48738.512614874104;50614.493855061715;50708.46457677102;51030.48969510257;51036;51362;15258.084514928918;15492.457763978207;15587.532374028571;15618.76571851423;15641.13973731433;11768.470418831173;11936.10479214045;12656.620301390973;13438.798418023738;13633.113847599874;14139.575812725634;14344.426222950966;14385.64035899111;14400.063995840237;14449.422023118957;5586.1062230043;5668;5679.8864022720145;5737.512311453574;5747.6838773867;957.8706874571843;962.138885697297;985.9161971232382;1016.9237307201842;1021.1830535571513;21591.460213494473;21832.45418864541;21900.780992190194;22240.777592224193;22301.438899276895;1073.511552243743;1074.8441475985937;1104.8011357955484;1107.2470719910539;1116.3692513729716;11596.710082248012;11667.183297169286;11760.94119529414;11787.587434439753;11838;230516;232205;232434;232446;232532;50452.24321635178;50669.239961400606;50688.74655626698;50720.74639626852;50907.23639145416;1412.8516505766952;1465;1467.882569394446;1469.4563011685532;1476.468471350313;22003.11987520545;22055.448613784785;22309.219177328716;22534.314383933423;22590.66114008324;35703.64296357003;35819.64180358267;35837;35894.8205258972;35896.46155307725;197891;198342;198620;198686;198818;32165.839170803996;32701.509477357384;34524.48213276853;34561.48157777585;34642.307153857284;42609.573904260564;44972.325415119456;45075.32387014263;45126;45183.09633807371;31709.36581268408;32415.51376729398;33148.50277245795;33270.16824579308;33425;31338.843305783324;32749.181270468427;32762;33001.17497062593;33180.50229246612;34514;36376.63623363733;36452.81773591115;36567.63432365642;36644.81677591595;29562.88324427406;30955.226119346295;31747.20631984219;32204.355912882078;32369;23113;23439.179628712915;23698.881505592362;23743;23887.52224955526 05:12:05 INFO - PID 11253 | |2;jquery.html;554.6616563896025;560.683213984099;567.4297331182163;574.2706762411734;595.3629616310546;21669;22708.091676332926;22728.090876364946;22790.202342918;24088;26032;26575.468490630177;26606.467870642577;26638.73361266387;26649.86675066622;6547.181602299713;6718.596884186964;6722.226943901441;6729.7308107675635;6731.831704207385;5738.971305143468;6065.4844338231305;6334.873302533946;6337.493000559944;6346.524010699193;6294.213223347082;6305.495560355183;6305.810825675214;6324.083007963865;6325.33583973683;6312.968435157841;6321.620702757827;6329.272133704637;6329.525285603599;6329.968350158243;5905.645661260338;5908.320543137508;5917.704114794243;5918.852028699317;5923.200367950358;28633.57049644257;29092;29404.558931616044;29772.70227297721;29940.401191976038;1930.8648394612383;1984.2261518007988;1985.4738494299022;1988.125224901039;1988.830949369291;18911.527211819677;19697.40907772769;19704.802951970585;19726.11232494541;19760.80239197604;2245.124401483423;2310.607196776552;2367.7513861044686;2367.8816059197143;2377.5126099149634;135925;138944.442222311;139788.30105849507;140844.29577852148;144798;14714.705705885823;14740.262986850614;14850;15131.167785771888;15221.162836043903;23403.648945265835;23618.64572031421;24207.273781786575;24239.151629692875;24256.393590160387;10128.088472037405;10132.290739648153;10252.38485690861;10302.536385862504;10412.073766353249;9364.578593963288;9381.484018379055;9489.90510094904;9513.286503512265;9608.519574021271;9130.908690913138;9354.859677104849;9372.156505914363;9489.634768006794;9544.331896767299;2661.334666333417;2718.143784707811;2719.619253304539;2729.1169093325543;2747.5466548019754;934.9065093490733;942.1097063275139;971.300663522277;974.7611835100446;982.6413359123868;19678.311259105863;19915.203391864165;22779.772202277763;24279.878600606884;24643.383915402257;1001.9398836069713;1010.1918465227789;1019.6686077024997;1020.3061917895902;1023.1661196125134;10677.519511621995;10842.837357439645;10985.670429887115;11180.440977951233;11405.600803971822;472833;480355;495875;497770;503562;118981;119422.40288798501;122118.38940805416;123204;123803.38098309451;1236.6537369536545;1243.3348158735034;1274.4965738533228;1274.5029438518984;1285.1196930102722;17133.057681827122;17748.822511775234;18066.277348906424;18610.16254268588;18730.812691872907;57633.711831440574;58824.1176382346;61068.38931610627;61789.691051544454;62923;77702.6114869422;78319;78392;78767.60616196883;78839.60580197063;14590.124592524482;14975.251237437866;15003.099814011195;15021.173835439156;15039.172845493165;23012.884935575214;23042.769572304063;23092.538149237258;23532.529349413257;23636.881815590812;17395.304187832346;17410.216540255464;17410.47768566945;17437.128143593025;17733.822661773218;15596.766048509508;16214.432494862624;16653.3338666452;16957.321707131578;17001.74497382565;17059.744103838206;17060.74408883843;17158.39945601898;17231.82768172302;17249.137543123044;14709.632259193606;14912.403503859725;15034.323455444313;15056.774148387563;15064.096154230781;17066.232019559397;18668;18923.71614425757;18925.148368323735;18950.336738214097 05:12:05 INFO - PID 11253 | |3;mootools.html;1294.1587967820917;1328.681116532032;1334.8932085433166;1349.0219590796673;1351.797230415438;11971.820422693667;13649.385777640005;14284.071535350207;14324;14335.068220565681;11995.880041199585;12088;13839.377228024738;14422.639434014154;14435.206063666494;2592.3778293209634;2649.7880169586483;2679.2765953192625;2684.6912605050375;2685.261553072901;2574.18913042392;2616.2151354593643;2670.0921686626543;2680.195941217627;2711.905083322084;2637.3142982824506;2693.420914503391;2695.5282825505556;2696.083331667233;2699.9325016874636;2530.4180038591135;2576.0983655720443;2585.31489155374;2647.669041369829;2656.986715066412;2531.6076008218756;2541.440883005736;2573.794096472278;2574.292069680834;2575.0472325239593;13587.660308492268;13759.38082786277;13764.587062388144;13768.931155344259;13786.793198102036;7508.249175082503;7777.844443111163;7782.766517004499;7787.649555770004;7812.296893279632;4863.8297659582095;5006.874828129289;5041.218611115283;5114.641975061747;5123.974380128076;1825.6987597046605;1832.7067669173002;1834.4588346437833;1867.8225568570963;1868.8691791574595;20590.691139632916;20966.05652745615;22552.54894902093;22810.54378912429;22843.200487983006;6353.777617783356;6450.193725784277;6627.138471998705;6642.335766423415;6667.133272674521;15617.843821561866;15621.453249136226;15625.531234062997;15629.140397278032;15643.608909777118;7494.6627401767055;7599.278068583476;7644.579548124907;7647.120581133129;7651.808704782314;6943.548669336477;7016.614086225204;7056.823579410453;7059.399951004222;7089.680964356617;5003.574696150795;5106.4893510648635;5113.207452844815;5163.715995620202;5210.062188806051;1314.901382396305;1343.1135450602555;1346.8585798491213;1350.6758377989213;1353.7360214758226;878.0780180810124;883.969061082859;913.9588718507683;918.3617385916857;935.335911502827;7162.424266661326;7301.671424785791;7329.633518324063;7334.559926404433;7470.916717075994;705.055225997156;723.479095051562;730.5945200413821;733.5122143774437;737.2406421385981;4401.933970990438;4945.282933974553;4975.900481990412;5238.423773384925;5238.842834714965;19336.903315483614;19791.10940007703;19972.700409493867;20038.799612003986;20061.799382006284;18885.15016824246;19540.51148721265;19627;19644.70532942007;20124.39626811198;9363.531823408939;10508.527116279785;10724.946375268073;10745.570177192982;10776.946115269373;6971.6862741175755;8266.462679925786;8414.410991230556;8440.15598440151;8476.11000844927;15489.767653485433;16263;16711.16444177762;17088.231029603947;17173.828261717223;16022.359105636111;16709.415170468976;17400.129993500526;17472.82527174712;17641.911790441478;11110.222284440011;11202.943985280348;11488.885111149117;11538.13463990221;11542.884571154182;13378.063535552417;13498.46006159782;13520.391582379014;13523.120997135155;13531;10490.160787137163;10826.296290741077;10832.133429325477;10892.509837057192;11007.394593297446;10605.840912386475;10697.090747286567;10803.945980270048;10950.835737463785;11316.773664526829;9258.861117083385;9502.477363744783;9615.471149086867;9616.9038309616;9617.519124043909;6869.244383117953;6913.723451061901;7246.565206087441;7269.200387957426;7334.559926404433;6459.677016149268;6839;6989.825254368681;7099;7247.746328878464 05:12:05 INFO - PID 11253 | |4;prototype.html;482.7779221558083;503.11200730710294;506.99614762769716;517.4230732733004;526.5603221310206;6020.825938941897;6064.909026364602;6143.723532441039;6163;6213.968930155349;5928.525717942565;6047.213862197908;6061.605995610283;6070.87858242836;6086.5002623491555;4887.853364399056;4932.80268789248;4937.827176048848;4948.2330238812865;4955.355803745526;4743.4859524452095;4820.577929510785;4853.4711565856815;4891.584215341701;4952.158133117361;4864.221724524077;4864.246041863499;4869.269609558559;4889.413270407556;4899.3744628974655;4825.1555977703765;4861.465238823726;4896.1186986342445;4911.68074075184;4942.456329803718;4373.037931655031;4374.825006999748;4398.868033958986;4409.4488188976375;4431.911361772779;5914.2015827863115;5939.970300148515;5943.374541529706;5985.4912332451795;6012.18835457212;5618.550515958714;5636.182753500761;5640.774369025234;5653.293338332708;5654.748519601246;6219.657918814463;6267.373262673742;6322.52581056418;6324.9051264231075;6366.140571022899;4743.193657078305;4749.26386410107;4801.159797035505;4807;4839.249916262949;6681.53229273951;6725.461963042945;6756.4932630052945;6757.358050985198;6773.254941956381;4804.5195480451675;4891.5353041461;4912;4917.213245880642;4925.802967881316;4952.455229924705;4989.226669866177;5004.924926126111;5011.0206468445485;5014;5553.861153471195;5590.720463976785;5605.8598535036135;5615.129654903497;5636.746346414421;6327.651979141099;6391.392817682313;6425.871482570323;6486.481081513468;6515.641639709766;1637.7543368494582;1676.8993860368416;1693.3565245206742;1712.2791594447501;1724.3102758896541;1030.8041472120274;1194.3550482739224;1206.0652993929775;1230.9569165079358;1235.610782603495;5527;5595.272614560081;5650.29371328584;5692.203091567184;5699.772009119589;6512.153420055362;6538;6542.443892269115;6567.540272180901;6637.568558043712;5658.179563963285;5709.172170035322;5724.313082430135;5731.398203188605;5791.3339965903615;3522.8062456565135;3534.3991521441417;3550.840212190458;3552.0054384772307;3553.733469989761;6290.276618188876;6336.461400780893;6377.5216858735785;6385.776497822554;6464.450521705708;6577.572457790228;6664.766733164413;6770.1537307836525;6806.455483561403;6829.6585170742255;6194.690265486798;6334.746610135728;6370.8088757337355;6405.583637063669;6454.741810327534;6481.578697384655;6523.3150519194805;6550;6556.63938483388;6618.6690665467495;6441.838954026;6523.64119973406;6566.573172743756;6583.967080164569;6600.372964568358;6262.279837818709;6369.5668474594695;6376.139221205263;6382.872342553216;6395.456386207225;4870.196417591058;4906.313116163668;4906.828261010847;4911.459739428731;4912.6561140719805;6607.438367738604;6609.702563384755;6640.867182656223;6643.335666433318;6676.132102826601;6295.401936815995;6306.274778400542;6350.301466838551;6392.169018027813;6394.616323020447;6271.216097987752;6320.62076275425;6354.872902541831;6365.395287447685;6447.516436267392;6331.778387756406;6334.651803907629;6362.554621176659;6367.745290188526;6387.616742995435;6366.331535188739;6455.903161452676;6491.675416229075;6510.381513756186;6537.1501704778075;5757.942420575908;6208.782692605737;6288.151099601679;6303.527235457267;6313.936860631335 05:12:05 INFO - PID 11253 | |5;yui.html;918.1461241045834;920.861870719392;924.607042007147;926.6478738079529;946.356477595235;18181.545461363457;19057.90471047643;19064.142113604885;19173.808261917395;21308;20040.29858954937;21525.892370538164;21567.460813479633;21616.243431479863;21710.782892171075;1034.2811745836646;1066.5893630952062;1072.801531716631;1076.601657386768;1078.444601030466;1033.1424917318607;1069.5561342043043;1070.9303895246824;1072.3083611070854;1072.9409882456462;1110.2394859521214;1128.2609890521721;1128.841962125303;1130.7003644034296;1133.0086174597227;1107.2304748200004;1125.1448898836902;1130.6325444230658;1134.1437214902696;1135.432283858071;828.8549503836865;828.9005319361715;829.3779665251062;829.5561874397168;829.6930135849714;19389.80610193908;19533.80466195334;19672.409827705193;19726.506837329038;20275.08762105694;20501.077451514717;20727.27454539099;21000.474988125265;21002.264920727703;21101.261455848973;15933.521994340188;16485.83514164855;16664.083475408846;16681;16708.832911670972;3404.5403870477417;3416.5046068319953;3431.0736101252523;3442.896713098611;3447.1554469154967;115014.42492787483;119473.40263298714;121476;122697;122816;16680;17291.654166916844;17424.82575174232;17436.564085897953;17449.563760905825;29463;30896.53655195174;31115.533267001014;31575.84212078925;31595.684043159734;8518.659253629909;8637.438566493283;8639.265662418766;8662.133786621413;8665.653373865101;3953.9011524711536;4056.8174432150035;4063.329550624114;4064.146529228895;4064.248114098901;5237;5275.551578115903;5358.196270559447;5373.596980226499;5379.704116273564;1035.0787798859021;1049.9055085042382;1065.9680209593726;1073.1146803886825;1078.3960981850032;636.8471566823929;672.8923372260513;691.0705101638289;691.7129391302553;702.3292755418563;11186.776264474665;12002.879971200351;12092.818607720892;12373.814392784116;12654.746905061847;661.6658587413325;683.064202043204;687.5118665747275;700.1528150937423;716.3552802477811;5383.434739352311;5399.487048730364;5511.3937466878615;5528.281323427928;5656.32124145097;102260;104642;105574;109103.45448272707;112307.43846280716;85339.5733021331;85791.5710421444;88570;90698.54650726705;91817.54091229501;79629.57445752046;79989.60005199937;82634;82831.5858420704;83161.58419207986;12136.453859576517;12520.248785072561;12521.749565008467;12732.809007865075;13170.275634839792;34881.825590871886;37460.625393745715;37984.050398740255;38070;38128;67123;67577.66211168913;68385.3161468379;68473;68785.65607171932;18125.36561220351;18661.16024778861;18696.25214991385;18796.342128025455;19245.615087698447;21008.579828403654;21079.683804742635;21173.89413052925;21358.57282854303;21678.6748198774;17561.648767024843;17709.911450442665;17842;17882.374116906365;18043.90978045154;17580;17709;17744.733828992834;17755.289788408318;17975.64048718992;18537.721934170728;18553.16510757046;18704.971226582667;18857.717134242725;19163.32928347501;12274.815877761663;12442.377881105727;12565.811512827499;12829.166104203197;12988.415521301375;12548.18436801605;12637;12825.166364186298;12965.870341296466;13183.53857614979 05:12:05 INFO - PID 11253 | __end_tp_report 05:12:05 INFO - PID 11253 | __start_cc_report 05:12:05 INFO - PID 11253 | _x_x_mozilla_cycle_collect,389 05:12:05 INFO - PID 11253 | __end_cc_report 05:12:05 INFO - PID 11253 | __startTimestamp1500725525901__endTimestamp 05:12:05 INFO - PID 11253 | 05:12:05 INFO - PID 11253 | ------- Summary: start ------- 05:12:05 INFO - PID 11253 | Number of tests: 6 05:12:05 INFO - PID 11253 | 05:12:05 INFO - PID 11253 | [#0] dojo.html Cycles:165 Average:6068.43 Median:6335.37 stddev:716.80 (11.3%) stddev-sans-first:681.29 05:12:05 INFO - PID 11253 | Values: 3143.8 3163.3 3166.3 3186.5 3196.9 6032.3 6138.3 6151.9 6168.4 6206.3 5961.6 6127.6 6128.9 6135.2 6157.4 5604.9 5613.6 5631.5 5654.0 5721.7 5710.3 5730.5 5742.6 5761.0 5779.9 5394.6 5568.3 5594.2 5641.6 5682.2 5488.9 5492.1 5558.2 5584.7 5628.0 5486.4 5509.2 5613.8 5615.4 5617.8 5922.0 5966.7 6009.6 6047.1 6065.9 6578.8 6588.5 6605.2 6611.6 6617.4 6564.5 6614.2 6614.5 6689.6 6719.4 6066.2 6080.8 6146.8 6201.7 6223.8 6791.9 6868.0 6881.5 6884.2 6893.1 6443.6 6471.5 6495.8 6548.3 6557.8 6426.2 6474.8 6526.2 6570.8 6655.9 6578.4 6605.7 6622.1 6636.9 6661.8 6503.4 6567.8 6656.1 6656.5 6670.1 5183.1 5277.6 5326.1 5344.0 5351.0 4511.5 4525.9 4546.5 4572.1 4618.2 5636.9 5715.0 5715.8 5716.1 5717.9 6445.5 6507.4 6521.2 6598.0 6621.1 5651.5 5707.8 5784.3 5806.2 5842.7 5757.1 5779.1 5787.8 5797.4 5808.8 6218.9 6321.8 6386.3 6423.0 6437.2 6495.0 6591.1 6674.0 6683.7 6703.3 6365.1 6438.5 6439.0 6454.4 6458.0 6447.4 6462.2 6525.1 6529.7 6545.6 6487.8 6545.1 6565.0 6597.7 6694.3 6400.4 6437.7 6488.4 6499.2 6504.9 6407.3 6422.5 6489.4 6508.6 6523.5 6259.1 6271.9 6333.9 6335.4 6421.6 6428.3 6446.9 6548.1 6570.6 6584.3 6268.6 6284.6 6362.9 6370.6 6387.3 05:12:05 INFO - PID 11253 | 05:12:05 INFO - PID 11253 | [#1] ext.html Cycles:180 Average:37560.00 Median:35172.98 stddev:54522.17 (155.0%) stddev-sans-first:54605.22 05:12:05 INFO - PID 11253 | Values: 792.7 849.6 881.4 882.8 1161.8 28701.4 30325.7 40713.2 41437.6 41581.8 41133.6 41525.6 41640.6 41747.6 41823.1 7129.5 7423.0 7524.5 7541.5 7733.3 7561.4 7678.8 7679.7 7680.5 7682.0 7635.9 7642.7 7657.9 7691.0 7698.6 7605.6 7692.0 7694.0 7695.8 7697.3 7570.3 7626.7 7643.2 7647.0 7649.9 37726.8 37768.0 37802.4 37901.4 37924.4 3625.1 3630.2 3648.9 3650.3 3663.7 30564.0 30812.8 30876.7 30897.2 30906.0 4904.7 4909.5 4922.2 4940.9 4968.1 195784.0 198900.0 199115.0 199406.0 200350.0 48303.3 48558.3 48636.8 48723.3 48738.5 50614.5 50708.5 51030.5 51036.0 51362.0 15258.1 15492.5 15587.5 15618.8 15641.1 11768.5 11936.1 12656.6 13438.8 13633.1 14139.6 14344.4 14385.6 14400.1 14449.4 5586.1 5668.0 5679.9 5737.5 5747.7 957.9 962.1 985.9 1016.9 1021.2 21591.5 21832.5 21900.8 22240.8 22301.4 1073.5 1074.8 1104.8 1107.2 1116.4 11596.7 11667.2 11760.9 11787.6 11838.0 230516.0 232205.0 232434.0 232446.0 232532.0 50452.2 50669.2 50688.7 50720.7 50907.2 1412.9 1465.0 1467.9 1469.5 1476.5 22003.1 22055.4 22309.2 22534.3 22590.7 35703.6 35819.6 35837.0 35894.8 35896.5 197891.0 198342.0 198620.0 198686.0 198818.0 32165.8 32701.5 34524.5 34561.5 34642.3 42609.6 44972.3 45075.3 45126.0 45183.1 31709.4 32415.5 33148.5 33270.2 33425.0 31338.8 32749.2 32762.0 33001.2 33180.5 34514.0 36376.6 36452.8 36567.6 36644.8 29562.9 30955.2 31747.2 32204.4 32369.0 23113.0 23439.2 23698.9 23743.0 23887.5 05:12:05 INFO - PID 11253 | 05:12:05 INFO - PID 11253 | [#2] jquery.html Cycles:180 Average:35362.07 Median:12701.57 stddev:82963.11 (653.2%) stddev-sans-first:83154.68 05:12:05 INFO - PID 11253 | Values: 554.7 560.7 567.4 574.3 595.4 21669.0 22708.1 22728.1 22790.2 24088.0 26032.0 26575.5 26606.5 26638.7 26649.9 6547.2 6718.6 6722.2 6729.7 6731.8 5739.0 6065.5 6334.9 6337.5 6346.5 6294.2 6305.5 6305.8 6324.1 6325.3 6313.0 6321.6 6329.3 6329.5 6330.0 5905.6 5908.3 5917.7 5918.9 5923.2 28633.6 29092.0 29404.6 29772.7 29940.4 1930.9 1984.2 1985.5 1988.1 1988.8 18911.5 19697.4 19704.8 19726.1 19760.8 2245.1 2310.6 2367.8 2367.9 2377.5 135925.0 138944.4 139788.3 140844.3 144798.0 14714.7 14740.3 14850.0 15131.2 15221.2 23403.6 23618.6 24207.3 24239.2 24256.4 10128.1 10132.3 10252.4 10302.5 10412.1 9364.6 9381.5 9489.9 9513.3 9608.5 9130.9 9354.9 9372.2 9489.6 9544.3 2661.3 2718.1 2719.6 2729.1 2747.5 934.9 942.1 971.3 974.8 982.6 19678.3 19915.2 22779.8 24279.9 24643.4 1001.9 1010.2 1019.7 1020.3 1023.2 10677.5 10842.8 10985.7 11180.4 11405.6 472833.0 480355.0 495875.0 497770.0 503562.0 118981.0 119422.4 122118.4 123204.0 123803.4 1236.7 1243.3 1274.5 1274.5 1285.1 17133.1 17748.8 18066.3 18610.2 18730.8 57633.7 58824.1 61068.4 61789.7 62923.0 77702.6 78319.0 78392.0 78767.6 78839.6 14590.1 14975.3 15003.1 15021.2 15039.2 23012.9 23042.8 23092.5 23532.5 23636.9 17395.3 17410.2 17410.5 17437.1 17733.8 15596.8 16214.4 16653.3 16957.3 17001.7 17059.7 17060.7 17158.4 17231.8 17249.1 14709.6 14912.4 15034.3 15056.8 15064.1 17066.2 18668.0 18923.7 18925.1 18950.3 05:12:05 INFO - PID 11253 | 05:12:05 INFO - PID 11253 | [#3] mootools.html Cycles:180 Average:8630.61 Median:2575.57 stddev:5881.88 (228.4%) stddev-sans-first:5872.55 05:12:05 INFO - PID 11253 | Values: 1294.2 1328.7 1334.9 1349.0 1351.8 11971.8 13649.4 14284.1 14324.0 14335.1 11995.9 12088.0 13839.4 14422.6 14435.2 2592.4 2649.8 2679.3 2684.7 2685.3 2574.2 2616.2 2670.1 2680.2 2711.9 2637.3 2693.4 2695.5 2696.1 2699.9 2530.4 2576.1 2585.3 2647.7 2657.0 2531.6 2541.4 2573.8 2574.3 2575.0 13587.7 13759.4 13764.6 13768.9 13786.8 7508.2 7777.8 7782.8 7787.6 7812.3 4863.8 5006.9 5041.2 5114.6 5124.0 1825.7 1832.7 1834.5 1867.8 1868.9 20590.7 20966.1 22552.5 22810.5 22843.2 6353.8 6450.2 6627.1 6642.3 6667.1 15617.8 15621.5 15625.5 15629.1 15643.6 7494.7 7599.3 7644.6 7647.1 7651.8 6943.5 7016.6 7056.8 7059.4 7089.7 5003.6 5106.5 5113.2 5163.7 5210.1 1314.9 1343.1 1346.9 1350.7 1353.7 878.1 884.0 914.0 918.4 935.3 7162.4 7301.7 7329.6 7334.6 7470.9 705.1 723.5 730.6 733.5 737.2 4401.9 4945.3 4975.9 5238.4 5238.8 19336.9 19791.1 19972.7 20038.8 20061.8 18885.2 19540.5 19627.0 19644.7 20124.4 9363.5 10508.5 10724.9 10745.6 10776.9 6971.7 8266.5 8414.4 8440.2 8476.1 15489.8 16263.0 16711.2 17088.2 17173.8 16022.4 16709.4 17400.1 17472.8 17641.9 11110.2 11202.9 11488.9 11538.1 11542.9 13378.1 13498.5 13520.4 13523.1 13531.0 10490.2 10826.3 10832.1 10892.5 11007.4 10605.8 10697.1 10803.9 10950.8 11316.8 9258.9 9502.5 9615.5 9616.9 9617.5 6869.2 6913.7 7246.6 7269.2 7334.6 6459.7 6839.0 6989.8 7099.0 7247.7 05:12:05 INFO - PID 11253 | 05:12:05 INFO - PID 11253 | [#4] prototype.html Cycles:180 Average:5400.61 Median:5998.84 stddev:1512.15 (25.2%) stddev-sans-first:1470.65 05:12:05 INFO - PID 11253 | Values: 482.8 503.1 507.0 517.4 526.6 6020.8 6064.9 6143.7 6163.0 6214.0 5928.5 6047.2 6061.6 6070.9 6086.5 4887.9 4932.8 4937.8 4948.2 4955.4 4743.5 4820.6 4853.5 4891.6 4952.2 4864.2 4864.2 4869.3 4889.4 4899.4 4825.2 4861.5 4896.1 4911.7 4942.5 4373.0 4374.8 4398.9 4409.4 4431.9 5914.2 5940.0 5943.4 5985.5 6012.2 5618.6 5636.2 5640.8 5653.3 5654.7 6219.7 6267.4 6322.5 6324.9 6366.1 4743.2 4749.3 4801.2 4807.0 4839.2 6681.5 6725.5 6756.5 6757.4 6773.3 4804.5 4891.5 4912.0 4917.2 4925.8 4952.5 4989.2 5004.9 5011.0 5014.0 5553.9 5590.7 5605.9 5615.1 5636.7 6327.7 6391.4 6425.9 6486.5 6515.6 1637.8 1676.9 1693.4 1712.3 1724.3 1030.8 1194.4 1206.1 1231.0 1235.6 5527.0 5595.3 5650.3 5692.2 5699.8 6512.2 6538.0 6542.4 6567.5 6637.6 5658.2 5709.2 5724.3 5731.4 5791.3 3522.8 3534.4 3550.8 3552.0 3553.7 6290.3 6336.5 6377.5 6385.8 6464.5 6577.6 6664.8 6770.2 6806.5 6829.7 6194.7 6334.7 6370.8 6405.6 6454.7 6481.6 6523.3 6550.0 6556.6 6618.7 6441.8 6523.6 6566.6 6584.0 6600.4 6262.3 6369.6 6376.1 6382.9 6395.5 4870.2 4906.3 4906.8 4911.5 4912.7 6607.4 6609.7 6640.9 6643.3 6676.1 6295.4 6306.3 6350.3 6392.2 6394.6 6271.2 6320.6 6354.9 6365.4 6447.5 6331.8 6334.7 6362.6 6367.7 6387.6 6366.3 6455.9 6491.7 6510.4 6537.2 5757.9 6208.8 6288.2 6303.5 6313.9 05:12:05 INFO - PID 11253 | 05:12:05 INFO - PID 11253 | [#5] yui.html Cycles:180 Average:23009.91 Median:19603.11 stddev:30417.85 (155.2%) stddev-sans-first:30457.95 05:12:05 INFO - PID 11253 | Values: 918.1 920.9 924.6 926.6 946.4 18181.5 19057.9 19064.1 19173.8 21308.0 20040.3 21525.9 21567.5 21616.2 21710.8 1034.3 1066.6 1072.8 1076.6 1078.4 1033.1 1069.6 1070.9 1072.3 1072.9 1110.2 1128.3 1128.8 1130.7 1133.0 1107.2 1125.1 1130.6 1134.1 1135.4 828.9 828.9 829.4 829.6 829.7 19389.8 19533.8 19672.4 19726.5 20275.1 20501.1 20727.3 21000.5 21002.3 21101.3 15933.5 16485.8 16664.1 16681.0 16708.8 3404.5 3416.5 3431.1 3442.9 3447.2 115014.4 119473.4 121476.0 122697.0 122816.0 16680.0 17291.7 17424.8 17436.6 17449.6 29463.0 30896.5 31115.5 31575.8 31595.7 8518.7 8637.4 8639.3 8662.1 8665.7 3953.9 4056.8 4063.3 4064.1 4064.2 5237.0 5275.6 5358.2 5373.6 5379.7 1035.1 1049.9 1066.0 1073.1 1078.4 636.8 672.9 691.1 691.7 702.3 11186.8 12002.9 12092.8 12373.8 12654.7 661.7 683.1 687.5 700.2 716.4 5383.4 5399.5 5511.4 5528.3 5656.3 102260.0 104642.0 105574.0 109103.5 112307.4 85339.6 85791.6 88570.0 90698.5 91817.5 79629.6 79989.6 82634.0 82831.6 83161.6 12136.5 12520.2 12521.7 12732.8 13170.3 34881.8 37460.6 37984.1 38070.0 38128.0 67123.0 67577.7 68385.3 68473.0 68785.7 18125.4 18661.2 18696.3 18796.3 19245.6 21008.6 21079.7 21173.9 21358.6 21678.7 17561.6 17709.9 17842.0 17882.4 18043.9 17580.0 17709.0 17744.7 17755.3 17975.6 18537.7 18553.2 18705.0 18857.7 19163.3 12274.8 12442.4 12565.8 12829.2 12988.4 12548.2 12637.0 12825.2 12965.9 13183.5 05:12:05 INFO - PID 11253 | -------- Summary: end -------- 05:12:05 INFO - PID 11253 | 05:12:06 INFO - TEST-INFO | 11253: exit 0 05:12:06 INFO - TEST-OK | dromaeo_css | took 1113212ms 05:12:06 INFO - TEST-START | kraken 05:12:06 INFO - Initialising browser for kraken test... 05:12:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35880/getInfo.html -profile /tmp/tmpFLasID/profile 05:12:06 INFO - TEST-INFO | started process 11626 (/builds/slave/test/build/application/firefox/firefox http://localhost:35880/getInfo.html) 05:12:12 INFO - TEST-INFO | 11626: exit 0 05:12:13 INFO - Browser initialized. 05:12:13 INFO - Running cycle 1/1 for kraken test... 05:12:13 INFO - TEST-INFO | started process 11859 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFLasID/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:24 INFO - PID 11859 | RSS: Main: 176988160 05:12:24 INFO - PID 11859 | 05:12:27 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35880/tests/kraken/driver.html?testName=audio-beat-detection) 05:12:28 INFO - PID 11859 | RSS: Main: 182054912 05:12:28 INFO - PID 11859 | 05:12:30 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35880/tests/kraken/driver.html?testName=audio-dft) 05:12:31 INFO - PID 11859 | RSS: Main: 182161408 05:12:31 INFO - PID 11859 | 05:12:34 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35880/tests/kraken/driver.html?testName=audio-fft) 05:12:35 INFO - PID 11859 | RSS: Main: 177016832 05:12:35 INFO - PID 11859 | 05:12:37 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35880/tests/kraken/driver.html?testName=audio-oscillator) 05:12:37 INFO - PID 11859 | RSS: Main: 177729536 05:12:37 INFO - PID 11859 | 05:12:40 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35880/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:12:40 INFO - PID 11859 | RSS: Main: 177745920 05:12:40 INFO - PID 11859 | 05:12:43 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35880/tests/kraken/driver.html?testName=imaging-darkroom) 05:12:44 INFO - PID 11859 | RSS: Main: 180948992 05:12:44 INFO - PID 11859 | 05:12:47 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35880/tests/kraken/driver.html?testName=imaging-desaturate) 05:12:48 INFO - PID 11859 | RSS: Main: 179965952 05:12:48 INFO - PID 11859 | 05:12:51 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35880/tests/kraken/driver.html?testName=json-parse-financial) 05:12:51 INFO - PID 11859 | RSS: Main: 180178944 05:12:51 INFO - PID 11859 | 05:12:53 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35880/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:12:54 INFO - PID 11859 | RSS: Main: 180477952 05:12:54 INFO - PID 11859 | 05:12:55 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35880/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:12:56 INFO - PID 11859 | RSS: Main: 180199424 05:12:56 INFO - PID 11859 | 05:12:58 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35880/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:12:59 INFO - PID 11859 | RSS: Main: 180408320 05:12:59 INFO - PID 11859 | 05:13:02 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:13:02 INFO - PID 11859 | RSS: Main: 180953088 05:13:02 INFO - PID 11859 | 05:13:06 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:13:06 INFO - PID 11859 | RSS: Main: 180908032 05:13:06 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | Cycle 1(1): loaded http://localhost:35880/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35880/tests/kraken/driver.html?testName=ai-astar) 05:13:08 INFO - PID 11859 | RSS: Main: 182063104 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | __start_tp_report 05:13:08 INFO - PID 11859 | _x_x_mozilla_page_load 05:13:08 INFO - PID 11859 | _x_x_mozilla_page_load_details 05:13:08 INFO - PID 11859 | |i|pagename|runs| 05:13:08 INFO - PID 11859 | |0;ai-astar;107;109;97;111;114;112;111;109;113;111 05:13:08 INFO - PID 11859 | |1;audio-beat-detection;143;120;150;177;123;154;150;128;175;123 05:13:08 INFO - PID 11859 | |2;audio-dft;164;163;164;165;163;163;168;167;163;166 05:13:08 INFO - PID 11859 | |3;audio-fft;74;77;75;163;84;76;75;76;153;75 05:13:08 INFO - PID 11859 | |4;audio-oscillator;82;81;141;82;82;83;132;83;81;129 05:13:08 INFO - PID 11859 | |5;imaging-gaussian-blur;113;115;114;114;114;114;114;114;114;114 05:13:08 INFO - PID 11859 | |6;imaging-darkroom;150;152;152;150;149;149;150;150;150;152 05:13:08 INFO - PID 11859 | |7;imaging-desaturate;94;94;94;95;94;94;93;94;95;94 05:13:08 INFO - PID 11859 | |8;json-parse-financial;54;67;54;55;54;56;56;54;54;54 05:13:08 INFO - PID 11859 | |9;json-stringify-tinderbox;54;54;54;54;53;54;54;57;55;54 05:13:08 INFO - PID 11859 | |10;stanford-crypto-aes;79;77;78;78;78;89;79;79;79;79 05:13:08 INFO - PID 11859 | |11;stanford-crypto-ccm;133;131;125;131;138;130;126;127;128;189 05:13:08 INFO - PID 11859 | |12;stanford-crypto-pbkdf2;177;185;178;190;183;184;190;190;181;178 05:13:08 INFO - PID 11859 | |13;stanford-crypto-sha256-iterative;72;69;75;69;69;67;70;76;69;72 05:13:08 INFO - PID 11859 | __end_tp_report 05:13:08 INFO - PID 11859 | __start_cc_report 05:13:08 INFO - PID 11859 | _x_x_mozilla_cycle_collect,987 05:13:08 INFO - PID 11859 | __end_cc_report 05:13:08 INFO - PID 11859 | __startTimestamp1500725588727__endTimestamp 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | ------- Summary: start ------- 05:13:08 INFO - PID 11859 | Number of tests: 14 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#0] ai-astar Cycles:10 Average:109.40 Median:111.50 stddev:4.81 (4.3%) stddev-sans-first:5.02 05:13:08 INFO - PID 11859 | Values: 107.0 109.0 97.0 111.0 114.0 112.0 111.0 109.0 113.0 111.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#1] audio-beat-detection Cycles:10 Average:144.30 Median:150.00 stddev:20.91 (13.9%) stddev-sans-first:22.18 05:13:08 INFO - PID 11859 | Values: 143.0 120.0 150.0 177.0 123.0 154.0 150.0 128.0 175.0 123.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:1.84 (1.1%) stddev-sans-first:1.94 05:13:08 INFO - PID 11859 | Values: 164.0 163.0 164.0 165.0 163.0 163.0 168.0 167.0 163.0 166.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#3] audio-fft Cycles:10 Average:92.80 Median:75.50 stddev:34.56 (45.8%) stddev-sans-first:35.98 05:13:08 INFO - PID 11859 | Values: 74.0 77.0 75.0 163.0 84.0 76.0 75.0 76.0 153.0 75.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:82.00 stddev:25.30 (30.9%) stddev-sans-first:26.20 05:13:08 INFO - PID 11859 | Values: 82.0 81.0 141.0 82.0 82.0 83.0 132.0 83.0 81.0 129.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 05:13:08 INFO - PID 11859 | Values: 113.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:1.17 (0.8%) stddev-sans-first:1.24 05:13:08 INFO - PID 11859 | Values: 150.0 152.0 152.0 150.0 149.0 149.0 150.0 150.0 150.0 152.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:13:08 INFO - PID 11859 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 93.0 94.0 95.0 94.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:54.50 stddev:4.02 (7.4%) stddev-sans-first:4.21 05:13:08 INFO - PID 11859 | Values: 54.0 67.0 54.0 55.0 54.0 56.0 56.0 54.0 54.0 54.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:1.06 (2.0%) stddev-sans-first:1.12 05:13:08 INFO - PID 11859 | Values: 54.0 54.0 54.0 54.0 53.0 54.0 54.0 57.0 55.0 54.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.00 stddev:3.41 (4.3%) stddev-sans-first:3.61 05:13:08 INFO - PID 11859 | Values: 79.0 77.0 78.0 78.0 78.0 89.0 79.0 79.0 79.0 79.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:131.00 stddev:19.07 (14.6%) stddev-sans-first:20.20 05:13:08 INFO - PID 11859 | Values: 133.0 131.0 125.0 131.0 138.0 130.0 126.0 127.0 128.0 189.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:184.50 stddev:5.15 (2.8%) stddev-sans-first:4.87 05:13:08 INFO - PID 11859 | Values: 177.0 185.0 178.0 190.0 183.0 184.0 190.0 190.0 181.0 178.0 05:13:08 INFO - PID 11859 | 05:13:08 INFO - PID 11859 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:2.90 (4.1%) stddev-sans-first:3.04 05:13:08 INFO - PID 11859 | Values: 72.0 69.0 75.0 69.0 69.0 67.0 70.0 76.0 69.0 72.0 05:13:08 INFO - PID 11859 | -------- Summary: end -------- 05:13:08 INFO - PID 11859 | 05:13:09 INFO - PID 11859 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 05:13:09 INFO - TEST-INFO | 11859: exit 0 05:13:09 INFO - TEST-OK | kraken | took 62780ms 05:13:09 INFO - SUITE-END | took 1175s 05:13:09 INFO - Completed test suite (00:19:36) 05:13:09 INFO - javascript benchmark 05:13:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8390.274556837809, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.7956532825365, 3163.288260141467, 3166.2717574957774, 3186.458302088644, 3196.9360612787746, 6032.276126864783, 6138.324784273726, 6151.907721384177, 6168.4448399644025, 6206.348333424988, 5961.61249518781, 6127.632342059468, 6128.908066379008, 6135.171751813504, 6157.353477884813, 5604.915926261109, 5613.550915926737, 5631.549476041907, 5653.971730141344, 5721.656700597957, 5710.2862142232225, 5730.455606717355, 5742.626729262605, 5761.020626493485, 5779.913301300484, 5394.595405344576, 5568.331800183963, 5594.160875868612, 5641.576881733866, 5682.17608446775, 5488.890222195574, 5492.093804522249, 5558.194061861048, 5584.664920104807, 5628.043232650419, 5486.423925487846, 5509.173623956399, 5613.80351687693, 5615.354234263031, 5617.8033768817895, 5922.0, 5966.67183304918, 6009.57932944694, 6047.123167140784, 6065.939340606582, 6578.80263592093, 6588.538802283794, 6605.174353205849, 6611.636360000198, 6617.437517810992, 6564.474842012628, 6614.206295244553, 6614.536982411233, 6689.632070236135, 6719.428848547879, 6066.211392518989, 6080.787172448943, 6146.78486252979, 6201.658908760016, 6223.813285601439, 6791.932080679228, 6868.004139399859, 6881.518293719391, 6884.173899132136, 6893.138357705287, 6443.6455994920725, 6471.546991710629, 6495.772647957298, 6548.27968923418, 6557.836054098686, 6426.196725409324, 6474.773382931575, 6526.151600291932, 6570.77002304917, 6655.86688266232, 6578.375054369827, 6605.669716514155, 6622.072909792633, 6636.900446493307, 6661.833454163588, 6503.414692677682, 6567.802965911031, 6656.068150458939, 6656.500762442836, 6670.099536562599, 5183.092958732283, 5277.63056586043, 5326.147816349366, 5344.0, 5351.0, 4511.458624965026, 4525.909481810411, 4546.4544254689645, 4572.0627271409285, 4618.168729628632, 5636.887262254732, 5714.9714251429305, 5715.799947001835, 5716.114002329646, 5717.913596416667, 6445.51658625605, 6507.381798729113, 6521.184851893513, 6598.043283723833, 6621.139251897319, 5651.463111004448, 5707.771689132472, 5784.305883294031, 5806.158107074535, 5842.737076831553, 5757.050086735641, 5779.133130030529, 5787.797427090116, 5797.449242321973, 5808.796692115756, 6218.875622487615, 6321.810345689637, 6386.2975072741965, 6423.03654451836, 6437.163168788027, 6494.967525162344, 6591.14315139048, 6673.9666301668185, 6683.699233534599, 6703.29615390377, 6365.108884756045, 6438.517111216771, 6438.967805160944, 6454.419102280817, 6457.967710161419, 6447.387498187664, 6462.159919210472, 6525.119108920235, 6529.7388104475285, 6545.607263564201, 6487.837804054936, 6545.050967609765, 6564.9671751640935, 6597.670116494252, 6694.330566943267, 6400.39196276353, 6437.738328736942, 6488.416042556192, 6499.2200935887995, 6504.902426463512, 6407.295197528175, 6422.518311126591, 6489.415952564292, 6508.60948343101, 6523.510736694672, 6259.092431597302, 6271.905921411091, 6333.904991425225, 6335.366463353628, 6421.614703117828, 6428.260750013808, 6446.871797435524, 6548.116004339353, 6570.605763654196, 6584.308647592125, 6268.623882567061, 6284.622922624657, 6362.936370636419, 6370.617762934239, 6387.329330420239], "value": 6015.33443600334, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.6750032486682, 849.6473963305227, 881.4050515901766, 882.8234353129371, 1161.767646470706, 28701.425971480585, 30325.696743032564, 40713.1857362853, 41437.58562414375, 41581.79209103958, 41133.58866411335, 41525.58474415255, 41640.58359416405, 41747.58252417475, 41823.11795969181, 7129.465290103237, 7423.0, 7524.548527088392, 7541.472096953215, 7733.304002639761, 7561.357284630813, 7678.846423071535, 7679.654415551286, 7680.500767450126, 7681.9615901920415, 7635.885461718079, 7642.694292228304, 7657.885131723028, 7690.961545192266, 7698.576578288192, 7605.581693006882, 7691.961540192319, 7693.9615301923695, 7695.769126926201, 7697.268759467842, 7570.280823321776, 7626.694932202705, 7643.197464266227, 7647.044119485065, 7649.885251721229, 37726.811365942995, 37768.0, 37802.43296350529, 37901.43147852785, 37924.43113353302, 3625.0574850538787, 3630.1832087780303, 3648.890533284006, 3650.251698401821, 3663.6519530644546, 30564.0, 30812.845935770176, 30876.69123308783, 30897.227569310722, 30906.0, 4904.681195722266, 4909.533594308535, 4922.187839006559, 4940.851774446773, 4968.105740966625, 195784.0, 198900.0, 199115.0, 199406.0, 200350.0, 48303.27545086826, 48558.27162592564, 48636.7568162164, 48723.26915096276, 48738.512614874104, 50614.493855061715, 50708.46457677102, 51030.48969510257, 51036.0, 51362.0, 15258.084514928918, 15492.457763978207, 15587.532374028571, 15618.76571851423, 15641.13973731433, 11768.470418831173, 11936.10479214045, 12656.620301390973, 13438.798418023738, 13633.113847599874, 14139.575812725634, 14344.426222950966, 14385.64035899111, 14400.063995840237, 14449.422023118957, 5586.1062230043, 5668.0, 5679.8864022720145, 5737.512311453574, 5747.6838773867, 957.8706874571843, 962.138885697297, 985.9161971232382, 1016.9237307201842, 1021.1830535571513, 21591.460213494473, 21832.45418864541, 21900.780992190194, 22240.777592224193, 22301.438899276895, 1073.511552243743, 1074.8441475985937, 1104.8011357955484, 1107.2470719910539, 1116.3692513729716, 11596.710082248012, 11667.183297169286, 11760.94119529414, 11787.587434439753, 11838.0, 230516.0, 232205.0, 232434.0, 232446.0, 232532.0, 50452.24321635178, 50669.239961400606, 50688.74655626698, 50720.74639626852, 50907.23639145416, 1412.8516505766952, 1465.0, 1467.882569394446, 1469.4563011685532, 1476.468471350313, 22003.11987520545, 22055.448613784785, 22309.219177328716, 22534.314383933423, 22590.66114008324, 35703.64296357003, 35819.64180358267, 35837.0, 35894.8205258972, 35896.46155307725, 197891.0, 198342.0, 198620.0, 198686.0, 198818.0, 32165.839170803996, 32701.509477357384, 34524.48213276853, 34561.48157777585, 34642.307153857284, 42609.573904260564, 44972.325415119456, 45075.32387014263, 45126.0, 45183.09633807371, 31709.36581268408, 32415.51376729398, 33148.50277245795, 33270.16824579308, 33425.0, 31338.843305783324, 32749.181270468427, 32762.0, 33001.17497062593, 33180.50229246612, 34514.0, 36376.63623363733, 36452.81773591115, 36567.63432365642, 36644.81677591595, 29562.88324427406, 30955.226119346295, 31747.20631984219, 32204.355912882078, 32369.0, 23113.0, 23439.179628712915, 23698.881505592362, 23743.0, 23887.52224955526], "value": 16987.93457194473, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.6616563896025, 560.683213984099, 567.4297331182163, 574.2706762411734, 595.3629616310546, 21669.0, 22708.091676332926, 22728.090876364946, 22790.202342918, 24088.0, 26032.0, 26575.468490630177, 26606.467870642577, 26638.73361266387, 26649.86675066622, 6547.181602299713, 6718.596884186964, 6722.226943901441, 6729.7308107675635, 6731.831704207385, 5738.971305143468, 6065.4844338231305, 6334.873302533946, 6337.493000559944, 6346.524010699193, 6294.213223347082, 6305.495560355183, 6305.810825675214, 6324.083007963865, 6325.33583973683, 6312.968435157841, 6321.620702757827, 6329.272133704637, 6329.525285603599, 6329.968350158243, 5905.645661260338, 5908.320543137508, 5917.704114794243, 5918.852028699317, 5923.200367950358, 28633.57049644257, 29092.0, 29404.558931616044, 29772.70227297721, 29940.401191976038, 1930.8648394612383, 1984.2261518007988, 1985.4738494299022, 1988.125224901039, 1988.830949369291, 18911.527211819677, 19697.40907772769, 19704.802951970585, 19726.11232494541, 19760.80239197604, 2245.124401483423, 2310.607196776552, 2367.7513861044686, 2367.8816059197143, 2377.5126099149634, 135925.0, 138944.442222311, 139788.30105849507, 140844.29577852148, 144798.0, 14714.705705885823, 14740.262986850614, 14850.0, 15131.167785771888, 15221.162836043903, 23403.648945265835, 23618.64572031421, 24207.273781786575, 24239.151629692875, 24256.393590160387, 10128.088472037405, 10132.290739648153, 10252.38485690861, 10302.536385862504, 10412.073766353249, 9364.578593963288, 9381.484018379055, 9489.90510094904, 9513.286503512265, 9608.519574021271, 9130.908690913138, 9354.859677104849, 9372.156505914363, 9489.634768006794, 9544.331896767299, 2661.334666333417, 2718.143784707811, 2719.619253304539, 2729.1169093325543, 2747.5466548019754, 934.9065093490733, 942.1097063275139, 971.300663522277, 974.7611835100446, 982.6413359123868, 19678.311259105863, 19915.203391864165, 22779.772202277763, 24279.878600606884, 24643.383915402257, 1001.9398836069713, 1010.1918465227789, 1019.6686077024997, 1020.3061917895902, 1023.1661196125134, 10677.519511621995, 10842.837357439645, 10985.670429887115, 11180.440977951233, 11405.600803971822, 472833.0, 480355.0, 495875.0, 497770.0, 503562.0, 118981.0, 119422.40288798501, 122118.38940805416, 123204.0, 123803.38098309451, 1236.6537369536545, 1243.3348158735034, 1274.4965738533228, 1274.5029438518984, 1285.1196930102722, 17133.057681827122, 17748.822511775234, 18066.277348906424, 18610.16254268588, 18730.812691872907, 57633.711831440574, 58824.1176382346, 61068.38931610627, 61789.691051544454, 62923.0, 77702.6114869422, 78319.0, 78392.0, 78767.60616196883, 78839.60580197063, 14590.124592524482, 14975.251237437866, 15003.099814011195, 15021.173835439156, 15039.172845493165, 23012.884935575214, 23042.769572304063, 23092.538149237258, 23532.529349413257, 23636.881815590812, 17395.304187832346, 17410.216540255464, 17410.47768566945, 17437.128143593025, 17733.822661773218, 15596.766048509508, 16214.432494862624, 16653.3338666452, 16957.321707131578, 17001.74497382565, 17059.744103838206, 17060.74408883843, 17158.39945601898, 17231.82768172302, 17249.137543123044, 14709.632259193606, 14912.403503859725, 15034.323455444313, 15056.774148387563, 15064.096154230781, 17066.232019559397, 18668.0, 18923.71614425757, 18925.148368323735, 18950.336738214097], "value": 12043.818602959976, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.1587967820917, 1328.681116532032, 1334.8932085433166, 1349.0219590796673, 1351.797230415438, 11971.820422693667, 13649.385777640005, 14284.071535350207, 14324.0, 14335.068220565681, 11995.880041199585, 12088.0, 13839.377228024738, 14422.639434014154, 14435.206063666494, 2592.3778293209634, 2649.7880169586483, 2679.2765953192625, 2684.6912605050375, 2685.261553072901, 2574.18913042392, 2616.2151354593643, 2670.0921686626543, 2680.195941217627, 2711.905083322084, 2637.3142982824506, 2693.420914503391, 2695.5282825505556, 2696.083331667233, 2699.9325016874636, 2530.4180038591135, 2576.0983655720443, 2585.31489155374, 2647.669041369829, 2656.986715066412, 2531.6076008218756, 2541.440883005736, 2573.794096472278, 2574.292069680834, 2575.0472325239593, 13587.660308492268, 13759.38082786277, 13764.587062388144, 13768.931155344259, 13786.793198102036, 7508.249175082503, 7777.844443111163, 7782.766517004499, 7787.649555770004, 7812.296893279632, 4863.8297659582095, 5006.874828129289, 5041.218611115283, 5114.641975061747, 5123.974380128076, 1825.6987597046605, 1832.7067669173002, 1834.4588346437833, 1867.8225568570963, 1868.8691791574595, 20590.691139632916, 20966.05652745615, 22552.54894902093, 22810.54378912429, 22843.200487983006, 6353.777617783356, 6450.193725784277, 6627.138471998705, 6642.335766423415, 6667.133272674521, 15617.843821561866, 15621.453249136226, 15625.531234062997, 15629.140397278032, 15643.608909777118, 7494.6627401767055, 7599.278068583476, 7644.579548124907, 7647.120581133129, 7651.808704782314, 6943.548669336477, 7016.614086225204, 7056.823579410453, 7059.399951004222, 7089.680964356617, 5003.574696150795, 5106.4893510648635, 5113.207452844815, 5163.715995620202, 5210.062188806051, 1314.901382396305, 1343.1135450602555, 1346.8585798491213, 1350.6758377989213, 1353.7360214758226, 878.0780180810124, 883.969061082859, 913.9588718507683, 918.3617385916857, 935.335911502827, 7162.424266661326, 7301.671424785791, 7329.633518324063, 7334.559926404433, 7470.916717075994, 705.055225997156, 723.479095051562, 730.5945200413821, 733.5122143774437, 737.2406421385981, 4401.933970990438, 4945.282933974553, 4975.900481990412, 5238.423773384925, 5238.842834714965, 19336.903315483614, 19791.10940007703, 19972.700409493867, 20038.799612003986, 20061.799382006284, 18885.15016824246, 19540.51148721265, 19627.0, 19644.70532942007, 20124.39626811198, 9363.531823408939, 10508.527116279785, 10724.946375268073, 10745.570177192982, 10776.946115269373, 6971.6862741175755, 8266.462679925786, 8414.410991230556, 8440.15598440151, 8476.11000844927, 15489.767653485433, 16263.0, 16711.16444177762, 17088.231029603947, 17173.828261717223, 16022.359105636111, 16709.415170468976, 17400.129993500526, 17472.82527174712, 17641.911790441478, 11110.222284440011, 11202.943985280348, 11488.885111149117, 11538.13463990221, 11542.884571154182, 13378.063535552417, 13498.46006159782, 13520.391582379014, 13523.120997135155, 13531.0, 10490.160787137163, 10826.296290741077, 10832.133429325477, 10892.509837057192, 11007.394593297446, 10605.840912386475, 10697.090747286567, 10803.945980270048, 10950.835737463785, 11316.773664526829, 9258.861117083385, 9502.477363744783, 9615.471149086867, 9616.9038309616, 9617.519124043909, 6869.244383117953, 6913.723451061901, 7246.565206087441, 7269.200387957426, 7334.559926404433, 6459.677016149268, 6839.0, 6989.825254368681, 7099.0, 7247.746328878464], "value": 6258.2693192730785, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.7779221558083, 503.11200730710294, 506.99614762769716, 517.4230732733004, 526.5603221310206, 6020.825938941897, 6064.909026364602, 6143.723532441039, 6163.0, 6213.968930155349, 5928.525717942565, 6047.213862197908, 6061.605995610283, 6070.87858242836, 6086.5002623491555, 4887.853364399056, 4932.80268789248, 4937.827176048848, 4948.2330238812865, 4955.355803745526, 4743.4859524452095, 4820.577929510785, 4853.4711565856815, 4891.584215341701, 4952.158133117361, 4864.221724524077, 4864.246041863499, 4869.269609558559, 4889.413270407556, 4899.3744628974655, 4825.1555977703765, 4861.465238823726, 4896.1186986342445, 4911.68074075184, 4942.456329803718, 4373.037931655031, 4374.825006999748, 4398.868033958986, 4409.4488188976375, 4431.911361772779, 5914.2015827863115, 5939.970300148515, 5943.374541529706, 5985.4912332451795, 6012.18835457212, 5618.550515958714, 5636.182753500761, 5640.774369025234, 5653.293338332708, 5654.748519601246, 6219.657918814463, 6267.373262673742, 6322.52581056418, 6324.9051264231075, 6366.140571022899, 4743.193657078305, 4749.26386410107, 4801.159797035505, 4807.0, 4839.249916262949, 6681.53229273951, 6725.461963042945, 6756.4932630052945, 6757.358050985198, 6773.254941956381, 4804.5195480451675, 4891.5353041461, 4912.0, 4917.213245880642, 4925.802967881316, 4952.455229924705, 4989.226669866177, 5004.924926126111, 5011.0206468445485, 5014.0, 5553.861153471195, 5590.720463976785, 5605.8598535036135, 5615.129654903497, 5636.746346414421, 6327.651979141099, 6391.392817682313, 6425.871482570323, 6486.481081513468, 6515.641639709766, 1637.7543368494582, 1676.8993860368416, 1693.3565245206742, 1712.2791594447501, 1724.3102758896541, 1030.8041472120274, 1194.3550482739224, 1206.0652993929775, 1230.9569165079358, 1235.610782603495, 5527.0, 5595.272614560081, 5650.29371328584, 5692.203091567184, 5699.772009119589, 6512.153420055362, 6538.0, 6542.443892269115, 6567.540272180901, 6637.568558043712, 5658.179563963285, 5709.172170035322, 5724.313082430135, 5731.398203188605, 5791.3339965903615, 3522.8062456565135, 3534.3991521441417, 3550.840212190458, 3552.0054384772307, 3553.733469989761, 6290.276618188876, 6336.461400780893, 6377.5216858735785, 6385.776497822554, 6464.450521705708, 6577.572457790228, 6664.766733164413, 6770.1537307836525, 6806.455483561403, 6829.6585170742255, 6194.690265486798, 6334.746610135728, 6370.8088757337355, 6405.583637063669, 6454.741810327534, 6481.578697384655, 6523.3150519194805, 6550.0, 6556.63938483388, 6618.6690665467495, 6441.838954026, 6523.64119973406, 6566.573172743756, 6583.967080164569, 6600.372964568358, 6262.279837818709, 6369.5668474594695, 6376.139221205263, 6382.872342553216, 6395.456386207225, 4870.196417591058, 4906.313116163668, 4906.828261010847, 4911.459739428731, 4912.6561140719805, 6607.438367738604, 6609.702563384755, 6640.867182656223, 6643.335666433318, 6676.132102826601, 6295.401936815995, 6306.274778400542, 6350.301466838551, 6392.169018027813, 6394.616323020447, 6271.216097987752, 6320.62076275425, 6354.872902541831, 6365.395287447685, 6447.516436267392, 6331.778387756406, 6334.651803907629, 6362.554621176659, 6367.745290188526, 6387.616742995435, 6366.331535188739, 6455.903161452676, 6491.675416229075, 6510.381513756186, 6537.1501704778075, 5757.942420575908, 6208.782692605737, 6288.151099601679, 6303.527235457267, 6313.936860631335], "value": 4954.165376312878, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [918.1461241045834, 920.861870719392, 924.607042007147, 926.6478738079529, 946.356477595235, 18181.545461363457, 19057.90471047643, 19064.142113604885, 19173.808261917395, 21308.0, 20040.29858954937, 21525.892370538164, 21567.460813479633, 21616.243431479863, 21710.782892171075, 1034.2811745836646, 1066.5893630952062, 1072.801531716631, 1076.601657386768, 1078.444601030466, 1033.1424917318607, 1069.5561342043043, 1070.9303895246824, 1072.3083611070854, 1072.9409882456462, 1110.2394859521214, 1128.2609890521721, 1128.841962125303, 1130.7003644034296, 1133.0086174597227, 1107.2304748200004, 1125.1448898836902, 1130.6325444230658, 1134.1437214902696, 1135.432283858071, 828.8549503836865, 828.9005319361715, 829.3779665251062, 829.5561874397168, 829.6930135849714, 19389.80610193908, 19533.80466195334, 19672.409827705193, 19726.506837329038, 20275.08762105694, 20501.077451514717, 20727.27454539099, 21000.474988125265, 21002.264920727703, 21101.261455848973, 15933.521994340188, 16485.83514164855, 16664.083475408846, 16681.0, 16708.832911670972, 3404.5403870477417, 3416.5046068319953, 3431.0736101252523, 3442.896713098611, 3447.1554469154967, 115014.42492787483, 119473.40263298714, 121476.0, 122697.0, 122816.0, 16680.0, 17291.654166916844, 17424.82575174232, 17436.564085897953, 17449.563760905825, 29463.0, 30896.53655195174, 31115.533267001014, 31575.84212078925, 31595.684043159734, 8518.659253629909, 8637.438566493283, 8639.265662418766, 8662.133786621413, 8665.653373865101, 3953.9011524711536, 4056.8174432150035, 4063.329550624114, 4064.146529228895, 4064.248114098901, 5237.0, 5275.551578115903, 5358.196270559447, 5373.596980226499, 5379.704116273564, 1035.0787798859021, 1049.9055085042382, 1065.9680209593726, 1073.1146803886825, 1078.3960981850032, 636.8471566823929, 672.8923372260513, 691.0705101638289, 691.7129391302553, 702.3292755418563, 11186.776264474665, 12002.879971200351, 12092.818607720892, 12373.814392784116, 12654.746905061847, 661.6658587413325, 683.064202043204, 687.5118665747275, 700.1528150937423, 716.3552802477811, 5383.434739352311, 5399.487048730364, 5511.3937466878615, 5528.281323427928, 5656.32124145097, 102260.0, 104642.0, 105574.0, 109103.45448272707, 112307.43846280716, 85339.5733021331, 85791.5710421444, 88570.0, 90698.54650726705, 91817.54091229501, 79629.57445752046, 79989.60005199937, 82634.0, 82831.5858420704, 83161.58419207986, 12136.453859576517, 12520.248785072561, 12521.749565008467, 12732.809007865075, 13170.275634839792, 34881.825590871886, 37460.625393745715, 37984.050398740255, 38070.0, 38128.0, 67123.0, 67577.66211168913, 68385.3161468379, 68473.0, 68785.65607171932, 18125.36561220351, 18661.16024778861, 18696.25214991385, 18796.342128025455, 19245.615087698447, 21008.579828403654, 21079.683804742635, 21173.89413052925, 21358.57282854303, 21678.6748198774, 17561.648767024843, 17709.911450442665, 17842.0, 17882.374116906365, 18043.90978045154, 17580.0, 17709.0, 17744.733828992834, 17755.289788408318, 17975.64048718992, 18537.721934170728, 18553.16510757046, 18704.971226582667, 18857.717134242725, 19163.32928347501, 12274.815877761663, 12442.377881105727, 12565.811512827499, 12829.166104203197, 12988.415521301375, 12548.18436801605, 12637.0, 12825.166364186298, 12965.870341296466, 13183.53857614979], "value": 9141.972584810968, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 109.0, 97.0, 111.0, 114.0, 112.0, 111.0, 109.0, 113.0, 111.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 120.0, 150.0, 177.0, 123.0, 154.0, 150.0, 128.0, 175.0, 123.0], "value": 144.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 165.0, 163.0, 163.0, 168.0, 167.0, 163.0, 166.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 163.0, 84.0, 76.0, 75.0, 76.0, 153.0, 75.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 141.0, 82.0, 82.0, 83.0, 132.0, 83.0, 81.0, 129.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 152.0, 150.0, 149.0, 149.0, 150.0, 150.0, 150.0, 152.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 67.0, 54.0, 55.0, 54.0, 56.0, 56.0, 54.0, 54.0, 54.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 53.0, 54.0, 54.0, 57.0, 55.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 77.0, 78.0, 78.0, 78.0, 89.0, 79.0, 79.0, 79.0, 79.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 125.0, 131.0, 138.0, 130.0, 126.0, 127.0, 128.0, 189.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 185.0, 178.0, 190.0, 183.0, 184.0, 190.0, 190.0, 181.0, 178.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 75.0, 69.0, 69.0, 67.0, 70.0, 76.0, 69.0, 72.0], "value": 70.8, "unit": "score"}]}]} 05:13:09 INFO - Return code: 0 05:13:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:13:09 INFO - # TBPL SUCCESS # 05:13:09 INFO - Running post-action listener: _package_coverage_data 05:13:09 INFO - Running post-action listener: _resource_record_post_action 05:13:09 INFO - [mozharness: 2017-07-22 12:13:09.990975Z] Finished run-tests step (success) 05:13:09 INFO - Running post-run listener: _resource_record_post_run 05:13:10 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 208896; Write bytes: 444583936; Read time: 220; Write time: 359804 05:13:10 INFO - TinderboxPrint: CPU usage
13.1% 05:13:10 INFO - TinderboxPrint: I/O read bytes / time
208,896 / 220 05:13:10 INFO - TinderboxPrint: I/O write bytes / time
444,583,936 / 359,804 05:13:10 INFO - TinderboxPrint: CPU idle
8,274.4 (86.8%) 05:13:10 INFO - TinderboxPrint: CPU user
1,203.5 (12.6%) 05:13:10 INFO - TinderboxPrint: Swap in / out
0 / 0 05:13:10 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116125696; Read time: 40; Write time: 99880 05:13:10 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 05:13:10 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 200704; Write bytes: 328458240; Read time: 172; Write time: 259924 05:13:10 INFO - Running post-run listener: _upload_blobber_files 05:13:10 INFO - Blob upload gear active. 05:13:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:13:10 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 05:13:10 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'] 05:13:10 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 05:13:11 INFO - (blobuploader) - INFO - Open directory for files ... 05:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:13:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:11 INFO - (blobuploader) - INFO - Done attempting. 05:13:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:13:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:13:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:13 INFO - (blobuploader) - INFO - Done attempting. 05:13:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:13:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:13:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:20 INFO - (blobuploader) - INFO - Done attempting. 05:13:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:13:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:13:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:13:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:13:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:13:21 INFO - (blobuploader) - INFO - Done attempting. 05:13:21 INFO - (blobuploader) - INFO - Iteration through files over. 05:13:21 INFO - Return code: 0 05:13:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:13:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:13:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cdd221ff85d57e21aad451d44d9f21090cf0d036c3fd076e2ede16d33ff55f31167b387833b342268403982f9559d2c4bc410197dc03054352b4ed9a08600f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0004c64a9b738cc16a872d4f6cb26bca4164aaef5dcb980e8be630cc87296da17e2455e1b245b4e49f8bd3aff2a7fd76ce48b251c171c96b69a519e1302e030", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ad460b81ac8f481f52a8883eff9189cc2654fa6a012ff7094892976e8e90698bce9d4ac460bff3a50ae02be9c51625fae1e24f78493ed1340b5132b5bd77b0a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef010ef6ea3474d27d0e7f0fd050b3307f7cdcab2f0fb49bc860bb45d2a35402fd70cfadcdb53d0ccefeed20291639d76426675a09975417f91b77474ea7a123"} 05:13:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:13:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:13:21 INFO - Contents: 05:13:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cdd221ff85d57e21aad451d44d9f21090cf0d036c3fd076e2ede16d33ff55f31167b387833b342268403982f9559d2c4bc410197dc03054352b4ed9a08600f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0004c64a9b738cc16a872d4f6cb26bca4164aaef5dcb980e8be630cc87296da17e2455e1b245b4e49f8bd3aff2a7fd76ce48b251c171c96b69a519e1302e030", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ad460b81ac8f481f52a8883eff9189cc2654fa6a012ff7094892976e8e90698bce9d4ac460bff3a50ae02be9c51625fae1e24f78493ed1340b5132b5bd77b0a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef010ef6ea3474d27d0e7f0fd050b3307f7cdcab2f0fb49bc860bb45d2a35402fd70cfadcdb53d0ccefeed20291639d76426675a09975417f91b77474ea7a123"} 05:13:21 INFO - Running post-run listener: copy_logs_to_upload_dir 05:13:21 INFO - Copying logs to upload dir... 05:13:21 INFO - mkdir: /builds/slave/test/build/upload/logs 05:13:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.346308 ========= master_lag: -0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-07-22 05:13:21.035422) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 05:13:21.043324) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cdd221ff85d57e21aad451d44d9f21090cf0d036c3fd076e2ede16d33ff55f31167b387833b342268403982f9559d2c4bc410197dc03054352b4ed9a08600f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0004c64a9b738cc16a872d4f6cb26bca4164aaef5dcb980e8be630cc87296da17e2455e1b245b4e49f8bd3aff2a7fd76ce48b251c171c96b69a519e1302e030", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ad460b81ac8f481f52a8883eff9189cc2654fa6a012ff7094892976e8e90698bce9d4ac460bff3a50ae02be9c51625fae1e24f78493ed1340b5132b5bd77b0a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef010ef6ea3474d27d0e7f0fd050b3307f7cdcab2f0fb49bc860bb45d2a35402fd70cfadcdb53d0ccefeed20291639d76426675a09975417f91b77474ea7a123"} build_url:https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011152 build_url: 'https://queue.taskcluster.net/v1/task/XkiOXKQhR4m2VKusltKq-Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1cdd221ff85d57e21aad451d44d9f21090cf0d036c3fd076e2ede16d33ff55f31167b387833b342268403982f9559d2c4bc410197dc03054352b4ed9a08600f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d0004c64a9b738cc16a872d4f6cb26bca4164aaef5dcb980e8be630cc87296da17e2455e1b245b4e49f8bd3aff2a7fd76ce48b251c171c96b69a519e1302e030", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1ad460b81ac8f481f52a8883eff9189cc2654fa6a012ff7094892976e8e90698bce9d4ac460bff3a50ae02be9c51625fae1e24f78493ed1340b5132b5bd77b0a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef010ef6ea3474d27d0e7f0fd050b3307f7cdcab2f0fb49bc860bb45d2a35402fd70cfadcdb53d0ccefeed20291639d76426675a09975417f91b77474ea7a123"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-22 05:13:21.067063) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 05:13:21.067342) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1500723483.878954-1413442047 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004438 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-22 05:13:21.151607) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 05:13:21.151895) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-22 05:13:21.155191) ========= ========= Total master_lag: 0.21 =========