builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1501148929.97 results: success (0) revision: e5693cea1ec944ca077c7a46c5f127c828a90f1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:49.972907) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:49.973454) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:49.973733) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:50.028869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:50.029182) ========= 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=52faae308a556c440401f8e5000001e8-1501148601.213691-514426598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-27 02:48:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.7M=0s 2017-07-27 02:48:50 (37.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.247664 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:50.318153) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:50.318465) ========= 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=52faae308a556c440401f8e5000001e8-1501148601.213691-514426598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017151 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:50.367799) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:50.368138) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e5693cea1ec944ca077c7a46c5f127c828a90f1b --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 e5693cea1ec944ca077c7a46c5f127c828a90f1b --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=52faae308a556c440401f8e5000001e8-1501148601.213691-514426598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-27 02:48:50,372 truncating revision to first 12 chars 2017-07-27 02:48:50,372 Setting DEBUG logging. 2017-07-27 02:48:50,372 attempt 1/10 2017-07-27 02:48:50,372 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e5693cea1ec9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-27 02:48:50,759 unpacking tar archive at: mozilla-central-e5693cea1ec9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.694175 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:51.074699) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:51.075017) ========= script_repo_revision: e5693cea1ec944ca077c7a46c5f127c828a90f1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:51.075384) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:51.075650) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-27 02:48:51.082973) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-07-27 02:48:51.083253) ========= /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=52faae308a556c440401f8e5000001e8-1501148601.213691-514426598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:48:51 INFO - MultiFileLogger online at 20170727 02:48:51 in /builds/slave/test 02:48:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:48:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:48:51 INFO - {'append_to_log': False, 02:48:51 INFO - 'base_work_dir': '/builds/slave/test', 02:48:51 INFO - 'blob_upload_branch': 'Firefox', 02:48:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:48:51 INFO - 'branch': 'Firefox', 02:48:51 INFO - 'buildbot_json_path': 'buildprops.json', 02:48:51 INFO - 'code_coverage': False, 02:48:51 INFO - 'config_files': ('talos/linux_config.py',), 02:48:51 INFO - 'default_actions': ('clobber', 02:48:51 INFO - 'read-buildbot-config', 02:48:51 INFO - 'download-and-extract', 02:48:51 INFO - 'populate-webroot', 02:48:51 INFO - 'create-virtualenv', 02:48:51 INFO - 'install', 02:48:51 INFO - 'setup-mitmproxy', 02:48:51 INFO - 'run-tests'), 02:48:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:48:51 INFO - 'disable_ccov_upload': False, 02:48:51 INFO - 'download_minidump_stackwalk': True, 02:48:51 INFO - 'download_symbols': 'ondemand', 02:48:51 INFO - 'enable_stylo': False, 02:48:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:48:51 INFO - 'tooltool.py': '/tools/tooltool.py', 02:48:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:48:51 INFO - '/tools/misc-python/virtualenv.py')}, 02:48:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:48:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:48:51 INFO - 'gecko_profile': False, 02:48:51 INFO - 'gecko_profile_interval': 0, 02:48:51 INFO - 'installer_path': 'installer.exe', 02:48:51 INFO - 'log_level': 'info', 02:48:51 INFO - 'log_name': 'talos', 02:48:51 INFO - 'log_to_console': True, 02:48:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:48:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:48:51 INFO - 'opt_config_files': (), 02:48:51 INFO - 'pip_index': False, 02:48:51 INFO - 'suite': 'dromaeojs-e10s', 02:48:51 INFO - 'system_bits': '32', 02:48:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:48:51 INFO - 'title': 'talos-linux64-ix-056', 02:48:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:48:51 INFO - 'use_talos_json': True, 02:48:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:48:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:48:51 INFO - 'work_dir': 'build'} 02:48:51 INFO - [mozharness: 2017-07-27 09:48:51.321950Z] Running clobber step. 02:48:51 INFO - Running pre-action listener: _resource_record_pre_action 02:48:51 INFO - Running main action method: clobber 02:48:51 INFO - rmtree: /builds/slave/test/build 02:48:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:48:52 INFO - Running post-action listener: _resource_record_post_action 02:48:52 INFO - [mozharness: 2017-07-27 09:48:52.304751Z] Finished clobber step (success) 02:48:52 INFO - [mozharness: 2017-07-27 09:48:52.304854Z] Running read-buildbot-config step. 02:48:52 INFO - Running pre-action listener: _resource_record_pre_action 02:48:52 INFO - Running main action method: read_buildbot_config 02:48:52 INFO - Using buildbot properties: 02:48:52 INFO - { 02:48:52 INFO - "project": "", 02:48:52 INFO - "product": "firefox", 02:48:52 INFO - "who": "cbook@mozilla.com", 02:48:52 INFO - "installer_path": "public/build/target.tar.bz2", 02:48:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:48:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 02:48:52 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:48:52 INFO - "stage_platform": "linux64-stylo", 02:48:52 INFO - "basedir": "/builds/slave/test", 02:48:52 INFO - "buildnumber": 238, 02:48:52 INFO - "platform": "ubuntu64_hw_stylo", 02:48:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:48:52 INFO - "slavebuilddir": "test", 02:48:52 INFO - "taskId": "IMPz4kpdRw6u2ntByXrScw", 02:48:52 INFO - "branch": "mozilla-central", 02:48:52 INFO - "script_repo_revision": "production", 02:48:52 INFO - "revision": "e5693cea1ec944ca077c7a46c5f127c828a90f1b", 02:48:52 INFO - "slavename": "talos-linux64-ix-056", 02:48:52 INFO - "repo_path": "mozilla-central" 02:48:52 INFO - } 02:48:52 INFO - Finding installer, test and symbols from parent task. 02:48:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IMPz4kpdRw6u2ntByXrScw'}, attempt #1 02:48:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IMPz4kpdRw6u2ntByXrScw'}, attempt #1 02:48:53 INFO - Task dependencies: Nxl8AhfPQiqKvJ1nVywyHg 02:48:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg'}, attempt #1 02:48:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.tar.bz2 02:48:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/test_packages.json 02:48:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.crashreporter-symbols.zip 02:48:53 INFO - Running post-action listener: _resource_record_post_action 02:48:53 INFO - [mozharness: 2017-07-27 09:48:53.650989Z] Finished read-buildbot-config step (success) 02:48:53 INFO - [mozharness: 2017-07-27 09:48:53.651212Z] Running download-and-extract step. 02:48:53 INFO - Running pre-action listener: _resource_record_pre_action 02:48:53 INFO - Running main action method: download_and_extract 02:48:53 INFO - mkdir: /builds/slave/test/build/tests 02:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:48:53 INFO - trying https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.test_packages.json 02:48:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:48:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:48:54 INFO - Downloaded 989 bytes. 02:48:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:48:54 INFO - Using the following test package requirements: 02:48:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:48:54 INFO - u'common': [u'target.common.tests.zip'], 02:48:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:48:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:48:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:48:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:48:54 INFO - u'mozbase': [u'target.common.tests.zip'], 02:48:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:48:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:48:54 INFO - u'web-platform': [u'target.common.tests.zip', 02:48:54 INFO - u'target.web-platform.tests.tar.gz'], 02:48:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:48:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:48:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.common.tests.zip 02:48:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:48:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.common.tests.zip into memory 02:48:55 INFO - Content-Length response header: 72558855 02:48:55 INFO - Bytes received: 72558855 02:49:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:49:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.common.tests.zip 02:49:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:49:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.common.tests.zip into memory 02:49:08 INFO - Content-Length response header: 72558855 02:49:08 INFO - Bytes received: 72558855 02:49:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.talos.tests.zip 02:49:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:49:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.talos.tests.zip into memory 02:49:22 INFO - Content-Length response header: 14496465 02:49:22 INFO - Bytes received: 14496465 02:49:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:23 INFO - trying https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.tar.bz2 02:49:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:49:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:49:24 INFO - Downloaded 62207033 bytes. 02:49:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.tar.bz2 02:49:24 INFO - mkdir: /builds/slave/test/properties 02:49:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:49:24 INFO - Writing to file /builds/slave/test/properties/build_url 02:49:24 INFO - Contents: 02:49:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.tar.bz2 02:49:24 INFO - Running post-action listener: _resource_record_post_action 02:49:24 INFO - Running post-action listener: set_extra_try_arguments 02:49:24 INFO - [mozharness: 2017-07-27 09:49:24.315529Z] Finished download-and-extract step (success) 02:49:24 INFO - [mozharness: 2017-07-27 09:49:24.315755Z] Running populate-webroot step. 02:49:24 INFO - Running pre-action listener: _resource_record_pre_action 02:49:24 INFO - Running main action method: populate_webroot 02:49:24 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:49:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:49:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:49:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:49:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:49:24 INFO - 'tests': ['damp', 'tps']}, 02:49:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:49:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:49:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:49:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:49:24 INFO - 'other-e10s': {'tests': ['a11yr', 02:49:24 INFO - 'ts_paint', 02:49:24 INFO - 'tpaint', 02:49:24 INFO - 'sessionrestore', 02:49:24 INFO - 'sessionrestore_many_windows', 02:49:24 INFO - 'sessionrestore_no_auto_restore', 02:49:24 INFO - 'tabpaint']}, 02:49:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:49:24 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:49:24 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:49:24 INFO - 'talos_options': ['--mitmproxy', 02:49:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:49:24 INFO - '--firstNonBlankPaint'], 02:49:24 INFO - 'tests': ['quantum_pageload_google', 02:49:24 INFO - 'quantum_pageload_youtube', 02:49:24 INFO - 'quantum_pageload_amazon', 02:49:24 INFO - 'quantum_pageload_facebook']}, 02:49:24 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:49:24 INFO - 'talos_options': ['--stylo', 02:49:24 INFO - '--mitmproxy', 02:49:24 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:49:24 INFO - '--firstNonBlankPaint'], 02:49:24 INFO - 'tests': ['quantum_pageload_google', 02:49:24 INFO - 'quantum_pageload_youtube', 02:49:24 INFO - 'quantum_pageload_amazon', 02:49:24 INFO - 'quantum_pageload_facebook']}, 02:49:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:49:24 INFO - 'tsvgr_opacity', 02:49:24 INFO - 'tart', 02:49:24 INFO - 'tscrollx', 02:49:24 INFO - 'cart', 02:49:24 INFO - 'tsvg_static']}, 02:49:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:49:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:49:24 INFO - 'talos_options': ['--xperf_path', 02:49:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:49:24 INFO - 'tests': ['tp5n']}}} 02:49:24 INFO - Running post-action listener: _resource_record_post_action 02:49:24 INFO - [mozharness: 2017-07-27 09:49:24.326485Z] Finished populate-webroot step (success) 02:49:24 INFO - [mozharness: 2017-07-27 09:49:24.326576Z] Running create-virtualenv step. 02:49:24 INFO - Running pre-action listener: _resource_record_pre_action 02:49:24 INFO - Running main action method: create_virtualenv 02:49:24 INFO - Creating virtualenv /builds/slave/test/build/venv 02:49:24 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 02:49:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:49:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:49:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:49:24 INFO - Using real prefix '/usr' 02:49:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:49:25 INFO - Installing distribute.............................................................................................................................................................................................done. 02:49:27 INFO - Installing pip.................done. 02:49:27 INFO - Return code: 0 02:49:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:49:27 INFO - Reading from file tmpfile_stdout 02:49:27 INFO - Output received: 02:49:27 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) 02:49:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:49:27 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')]} 02:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:27 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')]} 02:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:27 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ceb0>, '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 0x186ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e240>, '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': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', '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 02:49:27 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 02:49:27 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 02:49:27 INFO - Using env: {'DISPLAY': ':0', 02:49:27 INFO - 'HOME': '/home/cltbld', 02:49:27 INFO - 'LANG': 'en_US.UTF-8', 02:49:27 INFO - 'LANGUAGE': 'en_US:en', 02:49:27 INFO - 'LOGNAME': 'cltbld', 02:49:27 INFO - 'MAIL': '/var/mail/cltbld', 02:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:27 INFO - 'MOZ_NO_REMOTE': '1', 02:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:27 INFO - 'NO_EM_RESTART': '1', 02:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:27 INFO - 'PWD': '/builds/slave/test', 02:49:27 INFO - 'SHELL': '/bin/bash', 02:49:27 INFO - 'SHLVL': '1', 02:49:27 INFO - 'TERM': 'linux', 02:49:27 INFO - 'TMOUT': '86400', 02:49:27 INFO - 'USER': 'cltbld', 02:49:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', 02:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:27 INFO - '_': '/tools/buildbot/bin/python'} 02:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:27 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 02:49:27 INFO - Cleaning up... 02:49:27 INFO - Return code: 0 02:49:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:49:27 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')]} 02:49:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:27 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')]} 02:49:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:27 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ceb0>, '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 0x186ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e240>, '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': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', '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 02:49:27 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 02:49:27 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 02:49:27 INFO - Using env: {'DISPLAY': ':0', 02:49:27 INFO - 'HOME': '/home/cltbld', 02:49:27 INFO - 'LANG': 'en_US.UTF-8', 02:49:27 INFO - 'LANGUAGE': 'en_US:en', 02:49:27 INFO - 'LOGNAME': 'cltbld', 02:49:27 INFO - 'MAIL': '/var/mail/cltbld', 02:49:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:27 INFO - 'MOZ_NO_REMOTE': '1', 02:49:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:27 INFO - 'NO_EM_RESTART': '1', 02:49:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:27 INFO - 'PWD': '/builds/slave/test', 02:49:27 INFO - 'SHELL': '/bin/bash', 02:49:27 INFO - 'SHLVL': '1', 02:49:27 INFO - 'TERM': 'linux', 02:49:27 INFO - 'TMOUT': '86400', 02:49:27 INFO - 'USER': 'cltbld', 02:49:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', 02:49:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:27 INFO - '_': '/tools/buildbot/bin/python'} 02:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:27 INFO - Downloading/unpacking psutil>=3.1.1 02:49:27 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 02:49:27 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 02:49:27 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 02:49:27 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 02:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:49:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:49:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:49:29 INFO - Installing collected packages: psutil 02:49:29 INFO - Running setup.py install for psutil 02:49:29 INFO - building 'psutil._psutil_linux' extension 02:49:29 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 02:49:30 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 02:49:30 INFO - building 'psutil._psutil_posix' extension 02:49:30 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 02:49:30 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 02:49:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:49:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:49:30 INFO - Successfully installed psutil 02:49:30 INFO - Cleaning up... 02:49:30 INFO - Return code: 0 02:49:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ceb0>, '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 0x186ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e240>, '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': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', '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 02:49:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:49:30 INFO - Using env: {'DISPLAY': ':0', 02:49:30 INFO - 'HOME': '/home/cltbld', 02:49:30 INFO - 'LANG': 'en_US.UTF-8', 02:49:30 INFO - 'LANGUAGE': 'en_US:en', 02:49:30 INFO - 'LOGNAME': 'cltbld', 02:49:30 INFO - 'MAIL': '/var/mail/cltbld', 02:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:30 INFO - 'MOZ_NO_REMOTE': '1', 02:49:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:30 INFO - 'NO_EM_RESTART': '1', 02:49:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:30 INFO - 'PWD': '/builds/slave/test', 02:49:30 INFO - 'SHELL': '/bin/bash', 02:49:30 INFO - 'SHLVL': '1', 02:49:30 INFO - 'TERM': 'linux', 02:49:30 INFO - 'TMOUT': '86400', 02:49:30 INFO - 'USER': 'cltbld', 02:49:30 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', 02:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:30 INFO - '_': '/tools/buildbot/bin/python'} 02:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:49:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:49:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:49:32 INFO - Installing collected packages: mozsystemmonitor 02:49:32 INFO - Running setup.py install for mozsystemmonitor 02:49:32 INFO - Successfully installed mozsystemmonitor 02:49:32 INFO - Cleaning up... 02:49:32 INFO - Return code: 0 02:49:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ceb0>, '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 0x186ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e240>, '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': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', '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 02:49:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:49:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:49:32 INFO - Using env: {'DISPLAY': ':0', 02:49:32 INFO - 'HOME': '/home/cltbld', 02:49:32 INFO - 'LANG': 'en_US.UTF-8', 02:49:32 INFO - 'LANGUAGE': 'en_US:en', 02:49:32 INFO - 'LOGNAME': 'cltbld', 02:49:32 INFO - 'MAIL': '/var/mail/cltbld', 02:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:32 INFO - 'MOZ_NO_REMOTE': '1', 02:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:32 INFO - 'NO_EM_RESTART': '1', 02:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:32 INFO - 'PWD': '/builds/slave/test', 02:49:32 INFO - 'SHELL': '/bin/bash', 02:49:32 INFO - 'SHLVL': '1', 02:49:32 INFO - 'TERM': 'linux', 02:49:32 INFO - 'TMOUT': '86400', 02:49:32 INFO - 'USER': 'cltbld', 02:49:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', 02:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:32 INFO - '_': '/tools/buildbot/bin/python'} 02:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:32 INFO - Downloading/unpacking jsonschema==2.5.1 02:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:49:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:33 INFO - Downloading functools32-3.2.3-2.tar.gz 02:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:49:33 INFO - warning: no files found matching '*.txt' 02:49:33 INFO - no previously-included directories found matching 'build' 02:49:33 INFO - no previously-included directories found matching 'dist' 02:49:33 INFO - no previously-included directories found matching '.git*' 02:49:33 INFO - Installing collected packages: jsonschema, functools32 02:49:33 INFO - Running setup.py install for functools32 02:49:33 INFO - warning: no files found matching '*.txt' 02:49:33 INFO - no previously-included directories found matching 'build' 02:49:33 INFO - no previously-included directories found matching 'dist' 02:49:33 INFO - no previously-included directories found matching '.git*' 02:49:33 INFO - Successfully installed jsonschema functools32 02:49:33 INFO - Cleaning up... 02:49:33 INFO - Return code: 0 02:49:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:49: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')]} 02:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49: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')]} 02:49:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:33 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ceb0>, '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 0x186ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e240>, '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': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', '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 02:49:33 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 02:49:33 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 02:49:33 INFO - Using env: {'DISPLAY': ':0', 02:49:33 INFO - 'HOME': '/home/cltbld', 02:49:33 INFO - 'LANG': 'en_US.UTF-8', 02:49:33 INFO - 'LANGUAGE': 'en_US:en', 02:49:33 INFO - 'LOGNAME': 'cltbld', 02:49:33 INFO - 'MAIL': '/var/mail/cltbld', 02:49:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:33 INFO - 'MOZ_NO_REMOTE': '1', 02:49:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:33 INFO - 'NO_EM_RESTART': '1', 02:49:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:33 INFO - 'PWD': '/builds/slave/test', 02:49:33 INFO - 'SHELL': '/bin/bash', 02:49:33 INFO - 'SHLVL': '1', 02:49:33 INFO - 'TERM': 'linux', 02:49:33 INFO - 'TMOUT': '86400', 02:49:33 INFO - 'USER': 'cltbld', 02:49:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', 02:49:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:33 INFO - '_': '/tools/buildbot/bin/python'} 02:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:49:34 INFO - Cleaning up... 02:49:34 INFO - Return code: 0 02:49:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:34 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ceb0>, '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 0x186ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e240>, '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': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', '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 02:49:34 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 02:49:34 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 02:49:34 INFO - Using env: {'DISPLAY': ':0', 02:49:34 INFO - 'HOME': '/home/cltbld', 02:49:34 INFO - 'LANG': 'en_US.UTF-8', 02:49:34 INFO - 'LANGUAGE': 'en_US:en', 02:49:34 INFO - 'LOGNAME': 'cltbld', 02:49:34 INFO - 'MAIL': '/var/mail/cltbld', 02:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:34 INFO - 'MOZ_NO_REMOTE': '1', 02:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:34 INFO - 'NO_EM_RESTART': '1', 02:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:34 INFO - 'PWD': '/builds/slave/test', 02:49:34 INFO - 'SHELL': '/bin/bash', 02:49:34 INFO - 'SHLVL': '1', 02:49:34 INFO - 'TERM': 'linux', 02:49:34 INFO - 'TMOUT': '86400', 02:49:34 INFO - 'USER': 'cltbld', 02:49:34 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', 02:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:34 INFO - '_': '/tools/buildbot/bin/python'} 02:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:34 INFO - Downloading/unpacking blobuploader==1.2.4 02:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:35 INFO - Downloading blobuploader-1.2.4.tar.gz 02:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:49:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:49:35 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 02:49:35 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 02:49:35 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 02:49:35 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 02:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:49:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:49:35 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 02:49:35 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 02:49:35 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 02:49:35 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 02:49:35 INFO - Downloading docopt-0.6.1.tar.gz 02:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:49:36 INFO - Installing collected packages: blobuploader, requests, docopt 02:49:36 INFO - Running setup.py install for blobuploader 02:49:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:49:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:49:36 INFO - Running setup.py install for requests 02:49:36 INFO - Running setup.py install for docopt 02:49:36 INFO - Successfully installed blobuploader requests docopt 02:49:36 INFO - Cleaning up... 02:49:36 INFO - Return code: 0 02:49:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:36 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ceb0>, '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 0x186ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e240>, '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': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', '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 02:49:36 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 02:49:36 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 02:49:36 INFO - Using env: {'DISPLAY': ':0', 02:49:36 INFO - 'HOME': '/home/cltbld', 02:49:36 INFO - 'LANG': 'en_US.UTF-8', 02:49:36 INFO - 'LANGUAGE': 'en_US:en', 02:49:36 INFO - 'LOGNAME': 'cltbld', 02:49:36 INFO - 'MAIL': '/var/mail/cltbld', 02:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:36 INFO - 'MOZ_NO_REMOTE': '1', 02:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:36 INFO - 'NO_EM_RESTART': '1', 02:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:36 INFO - 'PWD': '/builds/slave/test', 02:49:36 INFO - 'SHELL': '/bin/bash', 02:49:36 INFO - 'SHLVL': '1', 02:49:36 INFO - 'TERM': 'linux', 02:49:36 INFO - 'TMOUT': '86400', 02:49:36 INFO - 'USER': 'cltbld', 02:49:36 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', 02:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:36 INFO - '_': '/tools/buildbot/bin/python'} 02:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:49:36 INFO - Running setup.py (path:/tmp/pip-QYmOAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:49:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:49:36 INFO - Running setup.py (path:/tmp/pip-hraEZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:49:37 INFO - Running setup.py (path:/tmp/pip-fCWTh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:49:37 INFO - Running setup.py (path:/tmp/pip-51Sido-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:49:37 INFO - Running setup.py (path:/tmp/pip-s3KH8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:49:37 INFO - Running setup.py (path:/tmp/pip-DYBS5q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:49:37 INFO - Running setup.py (path:/tmp/pip-ELmwts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:49:37 INFO - Running setup.py (path:/tmp/pip-26_ejI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:49:37 INFO - Running setup.py (path:/tmp/pip-NO8t7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:49:37 INFO - Running setup.py (path:/tmp/pip-4UmV5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:49:37 INFO - Running setup.py (path:/tmp/pip-R74hit-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:49:37 INFO - Running setup.py (path:/tmp/pip-gGjeIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:49:37 INFO - Running setup.py (path:/tmp/pip-CkGJT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:49:37 INFO - Running setup.py (path:/tmp/pip-po2hIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:49:37 INFO - Running setup.py (path:/tmp/pip-D_cbSY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:49:37 INFO - Running setup.py (path:/tmp/pip-GhEnl3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:49:38 INFO - Running setup.py (path:/tmp/pip-iTE7Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:49:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:49:38 INFO - Running setup.py install for manifestparser 02:49:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:49:38 INFO - Running setup.py install for mozcrash 02:49:38 INFO - Running setup.py install for mozdebug 02:49:38 INFO - Running setup.py install for mozdevice 02:49:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:49:38 INFO - Running setup.py install for mozfile 02:49:38 INFO - Running setup.py install for mozhttpd 02:49:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:49:38 INFO - Running setup.py install for mozinfo 02:49:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:49:38 INFO - Running setup.py install for mozInstall 02:49:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:49:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:49:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:49:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:49:38 INFO - Running setup.py install for mozleak 02:49:38 INFO - Running setup.py install for mozlog 02:49:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:49:39 INFO - Running setup.py install for moznetwork 02:49:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:49:39 INFO - Running setup.py install for mozprocess 02:49:39 INFO - Running setup.py install for mozprofile 02:49:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:49:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:49:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:49:39 INFO - Running setup.py install for mozrunner 02:49:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:49:39 INFO - Running setup.py install for mozscreenshot 02:49:39 INFO - Running setup.py install for moztest 02:49:39 INFO - Running setup.py install for mozversion 02:49:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:49:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:49:39 INFO - Cleaning up... 02:49:39 INFO - Return code: 0 02:49:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:49:39 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')]} 02:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:39 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')]} 02:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:39 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ceb0>, '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 0x186ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e240>, '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': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', '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 02:49:39 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 02:49:39 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 02:49:39 INFO - Using env: {'DISPLAY': ':0', 02:49:39 INFO - 'HOME': '/home/cltbld', 02:49:39 INFO - 'LANG': 'en_US.UTF-8', 02:49:39 INFO - 'LANGUAGE': 'en_US:en', 02:49:39 INFO - 'LOGNAME': 'cltbld', 02:49:39 INFO - 'MAIL': '/var/mail/cltbld', 02:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:39 INFO - 'MOZ_NO_REMOTE': '1', 02:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:39 INFO - 'NO_EM_RESTART': '1', 02:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:39 INFO - 'PWD': '/builds/slave/test', 02:49:39 INFO - 'SHELL': '/bin/bash', 02:49:39 INFO - 'SHLVL': '1', 02:49:39 INFO - 'TERM': 'linux', 02:49:39 INFO - 'TMOUT': '86400', 02:49:39 INFO - 'USER': 'cltbld', 02:49:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', 02:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:39 INFO - '_': '/tools/buildbot/bin/python'} 02:49:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:49:40 INFO - Running setup.py (path:/tmp/pip-rfReIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:49:40 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)) 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:49:40 INFO - Running setup.py (path:/tmp/pip-HiOiY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:49:40 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)) 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:49:40 INFO - Running setup.py (path:/tmp/pip-OfPRfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:49:40 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)) 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:49:40 INFO - Running setup.py (path:/tmp/pip-KvOdcB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:49:40 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)) 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:49:40 INFO - Running setup.py (path:/tmp/pip-Q66BFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:49:40 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)) 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:49:40 INFO - Running setup.py (path:/tmp/pip-oblqlR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:49:40 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)) 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:49:40 INFO - Running setup.py (path:/tmp/pip-Ug6VWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:49:40 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)) 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:49:40 INFO - Running setup.py (path:/tmp/pip-43oUUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:49:40 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)) 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:49:40 INFO - Running setup.py (path:/tmp/pip-cMafT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:49:40 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)) 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:49:40 INFO - Running setup.py (path:/tmp/pip-Z788xc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:49:40 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)) 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:49:40 INFO - Running setup.py (path:/tmp/pip-2WoISZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:49:40 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)) 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:49:40 INFO - Running setup.py (path:/tmp/pip-1Ww60_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:49:40 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)) 02:49:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:49:40 INFO - Running setup.py (path:/tmp/pip-J0qzlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:49:41 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)) 02:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:49:41 INFO - Running setup.py (path:/tmp/pip-2yynzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:49:41 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)) 02:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:49:41 INFO - Running setup.py (path:/tmp/pip-7kuecL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:49:41 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)) 02:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:49:41 INFO - Running setup.py (path:/tmp/pip-52zgmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:49:41 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)) 02:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:49:41 INFO - Running setup.py (path:/tmp/pip-3MfzwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:49:41 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)) 02:49:41 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)) 02:49:41 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)) 02:49:41 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)) 02:49:41 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)) 02:49:41 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)) 02:49:41 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)) 02:49:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:49:42 INFO - Downloading blessings-1.6.tar.gz 02:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:49:42 INFO - Installing collected packages: blessings 02:49:42 INFO - Running setup.py install for blessings 02:49:42 INFO - Successfully installed blessings 02:49:42 INFO - Cleaning up... 02:49:42 INFO - Return code: 0 02:49:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:49:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:49:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:49:42 INFO - Reading from file tmpfile_stdout 02:49:42 INFO - Current package versions: 02:49:42 INFO - argparse == 1.2.1 02:49:42 INFO - blessings == 1.6 02:49:42 INFO - blobuploader == 1.2.4 02:49:42 INFO - docopt == 0.6.1 02:49:42 INFO - functools32 == 3.2.3-2 02:49:42 INFO - jsonschema == 2.5.1 02:49:42 INFO - manifestparser == 1.1 02:49:42 INFO - mozInstall == 1.13 02:49:42 INFO - mozcrash == 1.0 02:49:42 INFO - mozdebug == 0.1 02:49:42 INFO - mozdevice == 0.51 02:49:42 INFO - mozfile == 1.2 02:49:42 INFO - mozhttpd == 0.7 02:49:42 INFO - mozinfo == 0.10 02:49:42 INFO - mozleak == 0.1 02:49:42 INFO - mozlog == 3.5 02:49:42 INFO - moznetwork == 0.27 02:49:42 INFO - mozprocess == 0.25 02:49:42 INFO - mozprofile == 0.28 02:49:42 INFO - mozrunner == 6.13 02:49:42 INFO - mozscreenshot == 0.1 02:49:42 INFO - mozsystemmonitor == 0.3 02:49:42 INFO - moztest == 0.8 02:49:42 INFO - mozversion == 1.4 02:49:42 INFO - psutil == 3.1.1 02:49:42 INFO - requests == 1.2.3 02:49:42 INFO - wsgiref == 0.1.2 02:49:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:49:42 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')]} 02:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:42 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')]} 02:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:42 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ceb0>, '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 0x186ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e240>, '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': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', '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 02:49:42 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 02:49:42 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 02:49:42 INFO - Using env: {'DISPLAY': ':0', 02:49:42 INFO - 'HOME': '/home/cltbld', 02:49:42 INFO - 'LANG': 'en_US.UTF-8', 02:49:42 INFO - 'LANGUAGE': 'en_US:en', 02:49:42 INFO - 'LOGNAME': 'cltbld', 02:49:42 INFO - 'MAIL': '/var/mail/cltbld', 02:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:42 INFO - 'MOZ_NO_REMOTE': '1', 02:49:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:42 INFO - 'NO_EM_RESTART': '1', 02:49:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:42 INFO - 'PWD': '/builds/slave/test', 02:49:42 INFO - 'SHELL': '/bin/bash', 02:49:42 INFO - 'SHLVL': '1', 02:49:42 INFO - 'TERM': 'linux', 02:49:42 INFO - 'TMOUT': '86400', 02:49:42 INFO - 'USER': 'cltbld', 02:49:42 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', 02:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:42 INFO - '_': '/tools/buildbot/bin/python'} 02:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:43 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)) 02:49:43 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)) 02:49:43 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)) 02:49:43 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)) 02:49:43 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)) 02:49:43 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)) 02:49:43 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)) 02:49:43 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)) 02:49:43 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)) 02:49:43 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:49:43 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 02:49:43 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 02:49:43 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 02:49:43 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 02:49:44 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:49:44 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 02:49:44 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 02:49:44 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 02:49:44 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 02:49:44 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 02:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:49:44 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)) 02:49:44 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)) 02:49:44 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)) 02:49:44 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)) 02:49:44 INFO - Installing collected packages: marionette-driver, simplejson 02:49:44 INFO - Running setup.py install for marionette-driver 02:49:44 INFO - Running setup.py install for simplejson 02:49:44 INFO - building 'simplejson._speedups' extension 02:49:44 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 02:49:45 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 02:49:45 INFO - Successfully installed marionette-driver simplejson 02:49:45 INFO - Cleaning up... 02:49:45 INFO - Return code: 0 02:49:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:49:45 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')]} 02:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:49:45 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')]} 02:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:49:45 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 0x15001f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16cca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x186fd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x186ceb0>, '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 0x186ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e240>, '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': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', '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 02:49:45 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 02:49:45 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 02:49:45 INFO - Using env: {'DISPLAY': ':0', 02:49:45 INFO - 'HOME': '/home/cltbld', 02:49:45 INFO - 'LANG': 'en_US.UTF-8', 02:49:45 INFO - 'LANGUAGE': 'en_US:en', 02:49:45 INFO - 'LOGNAME': 'cltbld', 02:49:45 INFO - 'MAIL': '/var/mail/cltbld', 02:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:49:45 INFO - 'MOZ_NO_REMOTE': '1', 02:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:49:45 INFO - 'NO_EM_RESTART': '1', 02:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:49:45 INFO - 'PWD': '/builds/slave/test', 02:49:45 INFO - 'SHELL': '/bin/bash', 02:49:45 INFO - 'SHLVL': '1', 02:49:45 INFO - 'TERM': 'linux', 02:49:45 INFO - 'TMOUT': '86400', 02:49:45 INFO - 'USER': 'cltbld', 02:49:45 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', 02:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:49:45 INFO - '_': '/tools/buildbot/bin/python'} 02:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:49:45 INFO - Cleaning up... 02:49:45 INFO - Return code: 0 02:49:45 INFO - Running post-action listener: _resource_record_post_action 02:49:45 INFO - Running post-action listener: _start_resource_monitoring 02:49:45 INFO - Starting resource monitoring. 02:49:45 INFO - [mozharness: 2017-07-27 09:49:45.970255Z] Finished create-virtualenv step (success) 02:49:45 INFO - [mozharness: 2017-07-27 09:49:45.971259Z] Running install step. 02:49:45 INFO - Running pre-action listener: _resource_record_pre_action 02:49:45 INFO - Running main action method: install 02:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:49:46 INFO - Reading from file tmpfile_stdout 02:49:46 INFO - Detecting whether we're running mozinstall >=1.0... 02:49:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:49:46 INFO - Reading from file tmpfile_stdout 02:49:46 INFO - Output received: 02:49:46 INFO - Usage: mozinstall [options] installer 02:49:46 INFO - Options: 02:49:46 INFO - -h, --help show this help message and exit 02:49:46 INFO - -d DEST, --destination=DEST 02:49:46 INFO - Directory to install application into. [default: 02:49:46 INFO - "/builds/slave/test"] 02:49:46 INFO - --app=APP Application being installed. [default: firefox] 02:49:46 INFO - mkdir: /builds/slave/test/build/application 02:49:46 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'] 02:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:50:04 INFO - Reading from file tmpfile_stdout 02:50:04 INFO - Output received: 02:50:04 INFO - /builds/slave/test/build/application/firefox/firefox 02:50:04 INFO - Running post-action listener: _resource_record_post_action 02:50:04 INFO - [mozharness: 2017-07-27 09:50:04.398548Z] Finished install step (success) 02:50:04 INFO - [mozharness: 2017-07-27 09:50:04.398802Z] Running setup-mitmproxy step. 02:50:04 INFO - Running pre-action listener: _resource_record_pre_action 02:50:04 INFO - Running main action method: setup_mitmproxy 02:50:04 INFO - Skipping: mitmproxy is not required 02:50:04 INFO - Running post-action listener: _resource_record_post_action 02:50:04 INFO - [mozharness: 2017-07-27 09:50:04.400276Z] Finished setup-mitmproxy step (success) 02:50:04 INFO - [mozharness: 2017-07-27 09:50:04.400503Z] Running run-tests step. 02:50:04 INFO - Running pre-action listener: _resource_record_pre_action 02:50:04 INFO - Running pre-action listener: _set_gcov_prefix 02:50:04 INFO - Running main action method: run_tests 02:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:50:04 INFO - Python 2.7.3 02:50:04 INFO - Return code: 0 02:50:04 INFO - grabbing minidump binary from tooltool 02:50: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')]} 02:50:04 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 0x186ceb0>, '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 0x186ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x186e240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:50:04 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 02:50:04 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 02:50:04 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 02:50:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:50:04 INFO - Return code: 0 02:50:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:50:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:50:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:50:04 INFO - ENV: RUST_BACKTRACE is now 1 02:50:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:50:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:50:04 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/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 02:50:04 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/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 02:50:04 INFO - Using env: {'DISPLAY': ':0', 02:50:04 INFO - 'HOME': '/home/cltbld', 02:50:04 INFO - 'LANG': 'en_US.UTF-8', 02:50:04 INFO - 'LANGUAGE': 'en_US:en', 02:50:04 INFO - 'LOGNAME': 'cltbld', 02:50:04 INFO - 'MAIL': '/var/mail/cltbld', 02:50:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:50:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:50:04 INFO - 'MOZ_NO_REMOTE': '1', 02:50:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:50:04 INFO - 'NO_EM_RESTART': '1', 02:50:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:50:04 INFO - 'PWD': '/builds/slave/test', 02:50:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:50:04 INFO - 'RUST_BACKTRACE': '1', 02:50:04 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:50:04 INFO - 'SHELL': '/bin/bash', 02:50:04 INFO - 'SHLVL': '1', 02:50:04 INFO - 'STYLO_FORCE_ENABLED': '1', 02:50:04 INFO - 'TERM': 'linux', 02:50:04 INFO - 'TMOUT': '86400', 02:50:04 INFO - 'USER': 'cltbld', 02:50:04 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1501148601.213691-514426598', 02:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:50:04 INFO - '_': '/tools/buildbot/bin/python'} 02:50:04 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/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 02:50:04 INFO - mozversion application_buildid: 20170727085754 02:50:04 INFO - mozversion application_changeset: e5693cea1ec944ca077c7a46c5f127c828a90f1b 02:50:04 INFO - mozversion application_display_name: Nightly 02:50:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:50:04 INFO - mozversion application_name: Firefox 02:50:04 INFO - mozversion application_remotingname: firefox 02:50:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:50:04 INFO - mozversion application_vendor: Mozilla 02:50:04 INFO - mozversion application_version: 56.0a1 02:50:04 INFO - mozversion platform_buildid: 20170727085754 02:50:04 INFO - mozversion platform_changeset: e5693cea1ec944ca077c7a46c5f127c828a90f1b 02:50:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:50:04 INFO - mozversion platform_version: 56.0a1 02:50:04 INFO - using testdate: 1501149004 02:50:04 INFO - actual date: 1501149004 02:50:04 INFO - starting webserver on 'localhost:36777' 02:50:04 INFO - SUITE-START | Running 2 tests 02:50:04 INFO - TEST-START | dromaeo_css 02:50:04 INFO - Initialising browser for dromaeo_css test... 02:50:04 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36777/getInfo.html -profile /tmp/tmpuqv7oN/profile 02:50:04 INFO - TEST-INFO | started process 3351 (/builds/slave/test/build/application/firefox/firefox http://localhost:36777/getInfo.html) 02:50:14 INFO - TEST-INFO | 3351: exit 0 02:50:14 INFO - Browser initialized. 02:50:14 INFO - Running cycle 1/1 for dromaeo_css test... 02:50:14 INFO - TEST-INFO | started process 3577 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuqv7oN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:50:15 INFO - PID 3577 | 02:50:15 INFO - PID 3577 | (/builds/slave/test/build/application/firefox/firefox:3631): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 02:50:15 INFO - PID 3577 | 02:50:26 INFO - PID 3577 | RSS: Main: 174202880 02:50:26 INFO - PID 3577 | 02:53:25 INFO - PID 3577 | Cycle 1(1): loaded http://localhost:36777/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36777/tests/dromaeo/cssquery-ext.html) 02:53:27 INFO - PID 3577 | RSS: Main: 173199360 02:53:27 INFO - PID 3577 | 02:56:29 INFO - PID 3577 | Cycle 1(1): loaded http://localhost:36777/tests/dromaeo/cssquery-ext.html (next: http://localhost:36777/tests/dromaeo/cssquery-jquery.html) 02:56:29 INFO - PID 3577 | RSS: Main: 171261952 02:56:29 INFO - PID 3577 | 02:59:31 INFO - PID 3577 | Cycle 1(1): loaded http://localhost:36777/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36777/tests/dromaeo/cssquery-mootools.html) 02:59:32 INFO - PID 3577 | RSS: Main: 173076480 02:59:32 INFO - PID 3577 | 03:02:34 INFO - PID 3577 | Cycle 1(1): loaded http://localhost:36777/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36777/tests/dromaeo/cssquery-prototype.html) 03:02:34 INFO - PID 3577 | RSS: Main: 173481984 03:02:34 INFO - PID 3577 | 03:05:38 INFO - PID 3577 | Cycle 1(1): loaded http://localhost:36777/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36777/tests/dromaeo/cssquery-yui.html) 03:05:39 INFO - PID 3577 | RSS: Main: 174981120 03:05:39 INFO - PID 3577 | 03:08:41 INFO - PID 3577 | Cycle 1(1): loaded http://localhost:36777/tests/dromaeo/cssquery-yui.html (next: http://localhost:36777/tests/dromaeo/cssquery-dojo.html) 03:08:41 INFO - PID 3577 | RSS: Main: 177504256 03:08:41 INFO - PID 3577 | 03:08:41 INFO - PID 3577 | __start_tp_report 03:08:41 INFO - PID 3577 | _x_x_mozilla_page_load 03:08:41 INFO - PID 3577 | _x_x_mozilla_page_load_details 03:08:41 INFO - PID 3577 | |i|pagename|runs| 03:08:41 INFO - PID 3577 | |0;dojo.html;3090.119315994942;3116.984415077926;3130.4834702274125;3137.1843320736602;3163.066895265896;6020.127081573175;6095.9085613715715;6117.021276595746;6120.173776540166;6142.04798256271;6110.20567326247;6136.325004249529;6143.508519318455;6151.692415379235;6156.1381406602995;5645.745941432635;5667.886642267152;5669.603127781057;5708.257926469553;5710.2862142232225;5644.8024319148835;5688.345840228365;5713.685747283897;5722.742476588543;5725.828225153252;5649.576281778863;5715.199872017921;5734.311882574076;5739.253896993406;5760.991826430379;5597.048501754712;5659.773609055633;5684.459976302244;5709.029464990961;5761.8559536011935;5506.614536982413;5556.972215138939;5579.609427340088;5587.776488940478;5644.294463192101;6032.487238584726;6034.577579569432;6045.637261764308;6097.054956481752;6175.166352542395;6410.358964103599;6559.737610495575;6582.572132811352;6652.301508341603;6708.932910670879;6574.901376479356;6604.339566043357;6626.304238054983;6675.098861653663;6683.565568238049;6083.482903953125;6139.570230083896;6187.814365569086;6188.504919606421;6214.471769899609;6817.147856517935;6822.692978815965;6899;6903.240643529208;6907.412869906014;6480;6555.311692272338;6558.934410655832;6567.047778072153;6567.244766851778;6644.933550664528;6689.1972963244725;6694.732210711517;6729.49528785343;6748.392644661906;6454.741810327534;6483.222013358427;6535.803925882231;6580;6603.372679595431;6652.96673516639;6669.266380698119;6688.665566721645;6688.86622267552;6690.632015239208;5358.490943360374;5360.758765855546;5371.167469042305;5375.408705042442;5382.730863456812;4566.70316429431;4582.266837306015;4596.97701511497;4636.235021221461;4677.18149323867;4971.7135996309935;5766.048601980626;5853.853653658693;5866.325372582122;5873.882522349529;6532.379423954717;6618.602883826986;6695.096162018162;6701.899471507932;6714.899276510856;5721.942780572224;5722.656640601577;5778.624389414675;5780.88438231233;5786.797462088806;5775.104858746901;5782.045962416239;5793.246877905845;5820.24336836217;5837.620554663933;6433.710483028181;6436.485081193493;6457.2574153971955;6463.903041454382;6483.189601299838;6503.674816259263;6562;6568.146141001639;6590.505712071518;6674.532782705164;6356.396142366468;6450.645214513247;6458.192725909262;6484.740610375532;6547.083408322934;6369.299377068426;6399.456046236122;6502.772402965874;6514.869702606016;6559.376859198369;6582.637954912526;6644.46844252449;6680.098186744727;6688.765893193715;6693.765718199839;6446.5165112615805;6469.126667899962;6518.641474718936;6526.412622863965;6527.379898909596;6477.578957367756;6481.0926470295135;6510.283868774526;6526.771562995463;6587.934120658923;6361.554691171574;6364.968175159094;6393.78518081563;6441.5490915635455;6448.484121270381;6357.841053973688;6461.903071453838;6462.450691691259;6552.57408268461;6559.245686746085;6297.023961286008;6299.748010079546;6302.464290535356;6313.779017734358;6335.366463353628 03:08:41 INFO - PID 3577 | |1;ext.html;709.2127738210586;746.1307576673175;766.3754040457027;769.0809482668212;1183.2249876331007;31018.844905775466;40421;41616.58383416165;41681.79159104208;42041.57958420415;42461.57538424615;42503.78748106263;42718;42841.785791071;42891.35662965058;7718;7781.494202876823;7797.415193860455;7844.568548729818;7879.093904201004;7686.884696729554;7788.727394541193;7797.220277972186;7806.60966951653;7817.8827317590285;7702.768916932473;7782.105057918327;7801.453898227126;7835.804104897366;7849;7735.110462296823;7762.37900967924;7783.221677832228;7814.062312522534;7831.060272767248;7481.7007319707145;7718.035245594301;7777.611119444062;7791.4935529190425;7801.921980780176;39461.210775784326;39716.801415993024;39755.80122099371;39785.40321895174;39998;3446.7070299024363;3494.8951531454095;3518.0501264658656;3524.9118772030647;3527.4708793680898;31101.53347699786;31303.843480782678;31462.842685786654;31571.21071973196;31754.364912701618;4732.952670473285;4780.760961951889;4784.832530861403;4786.736729479877;4821.686590371614;176052;176121;176319;177223.99999999872;177330;48316.516834831906;48446.27330590044;48459;48516;48573;50006.74996625067;50057.499425005284;50337.47637665401;50380;50578.74710626497;16358.263878125514;16372.85390022687;16373.09947952874;16419.6716065678;16538.50384488467;13502.122362046435;13604.183748975092;13615.910727141805;13624.863751362558;13650.317484125753;13766.24285664278;14327.856721432861;14389.856101438852;14485.637859053608;14615.269236538343;4979.327790748275;6040.939590604038;6096.116063170815;6136.325004249529;6284;949.4398305000083;965.5172413793103;972.5557547042636;986.3785814936545;994.6419289055934;21605.45986350354;21699.34901952944;22020.449488762588;22129.114835406726;22285;1034.0538407357185;1037.2998226197287;1055.894410558938;1063.686212567279;1074.9301295415773;15296.541103766906;15502.767458488132;15518.844811551966;15818.525444236691;16262.593435164215;234648;234822;235675;236066;237077;57019.144712829344;57071.42928570744;57579.424205758245;57596.40816163199;57600.71199643975;1405.9578212653637;1446.7468193066172;1450.2676148545129;1455.0396738152767;1459.6204986703533;26125.73874261233;27090.32274193161;27294.181174564794;27434.45131097407;27463.17610471689;52388.73805630948;52596.73701631468;52840.73579632077;52875;52913.206301904735;196962;197192;197332;197349;197778;36158;36210.8189459051;36285.63714362928;36438;36613;43151.568484314754;44723.77638111789;44998.325025123995;45160.54839451564;45634.77182614199;30439.39121217519;32664.183395415304;32677.509837352933;33030.834845825615;33739.662603373654;33015;33280.667193327754;33414.498782517796;33542.49686254659;34102;37562.436563451025;37921.81039094897;38167;38339.80830095831;38426.807865960494;32327.35345293128;32989.67010329962;33099.83450082831;33350.33299334048;33446.498302525;23417.180398685963;24852.254432366335;25040.248792536255;25348.873255633604;25551.105711300017 03:08:41 INFO - PID 3577 | |2;jquery.html;506.53904946498693;568.4599630351167;576.3861487515793;579.4697851465907;602.1509671363377;21659.891700541513;21963;22929.312120636387;22942.541149177006;22962.540749185006;26101.216963491126;26669.466610667823;26734.866325668343;26773.33066673334;26775;6441.903371449432;6574.474042076647;6581.111549940744;6583.14419125513;6607.9008814867575;5933.080372542263;6382.074599183115;6497.480201583886;6529.51028672849;6554.508411869105;6495.7076931538195;6504.219493660744;6513.348665133472;6516.250631177404;6517.543771935966;6417.165768450118;6481.513886458534;6511.967440162793;6521.608703477783;6544.70548825304;6002.78990235344;6022.6687532185715;6024.277086749575;6032.245969253843;6032.939670603326;27803.16590502288;29041;29870.103896883127;29881.25296867574;29948.85025574858;1818;1884.7549818523505;1886.0946745562069;1889.5748456597294;1889.8582606304444;18452.261909523604;18815.62368752631;18882.622347553108;19095.52261193481;19227.134778934982;2271.1483193802324;2320.7679232076657;2358.5282943411216;2363.0902102690416;2372.205311220743;122141;130281;130661.34669326592;130706;130725;14218.217998010003;14943.178125203218;15020.624484387978;15244.161571113473;15503.147326896904;22725.886370568373;23008.539829203655;23019.539609208055;23022.194223202107;23032.4241893954;9496.335256531976;9669.758256043655;9698;9735.853962190573;9867.506624668738;7499.400047996147;8792.648294068293;8849.247813935888;8914.064023277591;8944.642214311485;7744.667675451181;8814.5592720365;8839.51382673959;9034.277257819358;9045.32160087996;2642.828216165943;2651.6324268179305;2671.9465610687676;2701.2031450722084;2710.105665130502;880.1418616848649;891.9643214271357;901.8692289617969;916.2532535983286;934.1592566690033;18198.63602727938;18420.35528756487;23102.42243943915;24251;24315.392115196908;982.6069572171189;997.6432052408718;1014.6398028699853;1024.6106479537877;1024.7540590258434;10683.412412317397;10842.40366779819;11102.44487775608;13138;13619.319034048258;497906;504584;511515;516482;516879;116521;120127.39936300262;127672.36163819121;132125;133531;1249.9062570307262;1251.561953316332;1302.9348532573522;1303.1529505821102;1305.7845455499737;20735.792642073386;20844.58310833805;21117.26089586857;21138.57722845565;21651.891740541196;58793.70603146957;59699.40300597112;61659.38340616536;62318.376816233074;63122;71174;72837.6358118206;73917;74197;76441;16947.66104677924;17615.911920440314;19465;20827.479313017295;21527.354179374644;18702.6259474807;19899.60200796005;24339.26982190537;24419;24681.62977555374;19214.519637008627;19713.70429443588;19758.901205494454;19958.600827983068;20283.087261073582;16558.337666493688;16841.74737378916;16869.493915182564;16916.238769255167;17612.559686007953;20289.898550507154;20769.376918692462;20901.1639534423;21136.154553817676;21173.576528469654;21297.36107916765;21384.679229811252;21995.340139795833;22375.552488949805;22383;19148.521286967938;19610.80389196147;19881.204751809764;19965.301214457424;20136.993150342718 03:08:41 INFO - PID 3577 | |3;mootools.html;1329.7938819482981;1353.0461024977392;1387.8820300274476;1398.811160493333;1402.1096603656674;13085.869141308583;13589.932050339747;13596.592102236924;13625.523106691267;13636.113652612597;13698.863011369884;14552.417903283857;14577.34401951912;14578.416863325454;14604;2549.0823303610687;2607.7783388411913;2620.109162884619;2625.5405304071805;2635.973640263592;2431.987840060797;2511.7739403453684;2620.5414052540823;2651.151631477928;2651.9337016574545;2520.1683444463283;2592.6111083337555;2598.8960441582312;2603.3361492819304;2607.413332000304;2270.012544543129;2300.723913130418;2314.8032417244553;2315.988420057906;2317.084751523147;2430.489597184576;2456.091246238885;2463.2487091437106;2463.3964678653665;2482.565551028563;13485.258310793;13544.796828047587;13554.796678049837;13564.321783910864;13598.660033499144;7003.544769590011;7230.313120253568;7363;7493.700251989969;7578.12851522071;4839.080574690833;4875.756212189376;4877.609791216694;4958.355413796184;4995.050940321364;1587.190532828266;1673.9246733897003;1774.5120091974682;1856.0997916010858;1878.971815422756;22154;22154.33536993909;22223;22225.55548889013;22232.444188895246;6069.817905462844;6330;6379.649119298483;6499.805005849832;6553.5084868634085;15296.235188240544;15304.846951530564;15327.233638318039;15337.463188788563;15379.461718839786;7157;7215.242399547972;7252.093488313961;7317.926820731831;7329.340359367682;6644.202695676549;6661.16735408074;6702.36327548882;6710.597364158166;6774.559653622498;4935.679180853305;5069.112905241568;5120.231965205175;5129.563987061141;5136.691798492103;1495.5662857771342;1508.8491150884824;1516.499555146799;1519.7036577867432;1532.5478983699613;794.4359504751691;799.8240387114942;809.2393150438569;813.60540138033;842.2756429470651;6154.1999540059505;6162.445379915829;6231.532635052389;6367.904481432783;6372.203474565679;655.5738769799668;659.7855696898528;687.9621620810904;696.6342670098239;708.1077841919218;3503.7197024238;3729.328720830222;3944.1717239379477;4323.373110898902;4454.910901781946;18021.2791488339;18526.444206673823;18694.34569790051;18703.15835787393;18708.906455467637;17767.200475978352;18091.276348946158;18224.271029158685;18394.17226224823;18540;9391.62433502666;9834.655787047419;9848.655297064712;10144.28989970695;10203.132733717717;7451.180370159386;7715.189905059888;7750.806229844299;7761.650725717469;7830.2169783021245;15479.613009674847;15654.765178522104;16033.679326413174;16383.180840957666;16771.413000544922;16768.16159192011;16979.405720799714;17029.063401513034;17292.913535432242;17303.480895573153;9732.659356922473;10087.04173103554;10320.174386049248;10330;10374.066334029974;12729.154272630602;12746.362681866056;12767.87232127704;12784.169029013085;12863.22820630765;10049.447280399356;10379.532921018723;10410.115140213167;10546.419946902994;10665.466726663792;9458.527073646428;9483.762905927131;9640.75898102525;9755.170810480904;9776.902230977883;8390.538520381439;8408.705695300636;8472.237498625153;8493.532855692749;8522.573871306535;6331.715072821642;6360.4911607072245;6619.4373478252965;6642.43539299165;6644.568103073285;6269.7178626962805;6605.174353205849;6670.099536562502;6707.195136583641;6748.527603067738 03:08:41 INFO - PID 3577 | |4;prototype.html;496.73306298892527;500.4676337731081;521.8747500599856;527.4672580693499;528.5322489596708;6236.937630623693;6284.465820405271;6293.590916590419;6312.463440607542;6348.968255158724;6009.369016253296;6022.969885150579;6127.325994140652;6130.386961303868;6193.225846769154;5065.7467126643705;5110.156824124015;5113.872153196163;5168.8449346519665;5181.274621552967;4946.629002824802;5086.872828179288;5088.465711100337;5183.2743415921805;5212.713300768456;5062;5075.137226671456;5115.079285728568;5130.589552835764;5177.637565370425;5115.590752739772;5156.716380599066;5168.198929165986;5210.34272521017;5228.5555727763185;4762.666613337068;4788.281757736333;4819.975900120512;4845.200541910581;4866.537678920497;6064.181335519693;6072.817815465543;6101.237345331833;6106.969465152646;6120.96939515304;5945.621751299472;5976.193213916109;5980.760769569212;6014.458698717136;6066.484348830355;6393.360663933616;6405.903911441332;6431.292557818636;6474.9963755617955;6555.180602424697;5164.173732202867;5188.273641690166;5205.453427390107;5240.737963101829;5245.842624721265;6844.28135045818;6869.7595584154315;6949.235584085746;6991.440684745208;7030.191527974297;5412.323459567554;5417.404085550586;5433.809816656398;5454.263674403905;5484.808031718871;5470.261514695465;5477.7261136943;5508.20131080991;5558.305211848519;5594.300712410949;6019;6019.789307374221;6040.244969378828;6055;6060.636361818217;6582.934170658232;6643.073508682524;6650;6650.401463868275;6753.696083676246;1786.11587264305;1870.662476329431;1882.2000649723814;1901.610169915164;1938.952965398669;1375.2229990055587;1398.2172729769422;1400.6288333591606;1406.2336026865178;1410.0411720030272;5576.275084239023;5588.3573389060775;5645.23789288449;5695.09550129437;5718.628289161191;6443.420092191725;6451.580647257913;6492.902606460907;6520.608763474207;6607.339266073451;5655.465334166146;5697.857553561194;5709.1177998960275;5720.456556627114;5799.2460980073165;3464.7921124732597;3500.2474467989505;3550.928981420357;3553.662402071799;3570.803605801706;6401.743930242738;6462.838429039311;6495.382938620824;6524.692344574108;6529.575577587441;6754.446477310246;6790.932090679129;6797.116374871334;6845.486588505882;6912.792616221522;6382.680865956777;6457.612543247514;6521.34786521363;6539.444147247537;6540.50946179029;6617.900731488935;6701.597904125573;6701.8324541884895;6712.966435167793;6754.932450675627;6544.3782840630065;6706.497012724163;6718.958561422987;6731.528792984444;6738.59568425896;6494.6752662367635;6524.575902566318;6525.445337146396;6525.575837570543;6588.769393071219;4908.607311415007;4972.5276098770555;4973.254011898244;4989.052080104769;5002.52476014778;6660.200775906922;6753.966230168818;6762.526623136333;6791.694373753292;6805.625690586867;6237.563370564017;6286.308506064238;6393.29673735898;6426.485881129405;6506.674666266762;6463.741450341934;6507.186601674791;6531.510136739858;6547.70535325902;6549.443297319591;6363.072986426296;6453.451456626051;6454.483196448925;6478.250872264368;6487.481001519962;6350.301466838737;6495.935040649533;6558.901616475661;6560.737570497317;6573.605583664996;6253.96873015632;6283.486605357711;6315.273743519554;6317.526185536195;6393.4885209184085 03:08:41 INFO - PID 3577 | |5;yui.html;886.7561420609336;912.7489940266425;916.8028873792133;918.9540522973849;926.6941909169975;17971.191296391662;18579.25682972683;18832.717509237373;18930.905345473253;21149.365519034414;20095.899520502415;21384.57230855382;21415.14339426421;21456;21524.461888452795;1016.1413605503337;1048.051513380388;1048.7063622185801;1048.8688913885765;1048.9318194317384;1004.1113614451227;1041.8958104189558;1042.4943902207424;1043.5929987304958;1045.728110691222;1075.172117469548;1081.3565928272665;1086.3101930274292;1089.319175515303;1091.0725882999466;1071.132382769955;1076.1068313299982;1077.3266708307308;1078.067471637036;1079.034264333425;788.5032429569392;792.5720111139977;797.3740613618281;797.4258533855615;798.317438590003;18460.16929238174;19085.61828763431;19156.61686766271;19200.13599388031;19628.70556941647;20049.599008019904;20136.49658758528;20339.89830050855;20633;20754.273600424065;14997.250137493082;15299.311530981133;15383.230838458032;15468.767968480483;15489.845101549066;3401.1667141550233;3490.5287786148797;3504.351694936445;3505.7195424366246;3512.8067956262394;120158.39920800428;120963.39518302352;125056;127405.36297318454;127548;15173;15533.533993980198;15538.45615403478;15563.766543501857;15593.142377169364;27376.45247095087;29069.41861162765;29205;29230;29498.852505737334;8272.090070092285;8701.521416322037;8789.472631642122;8808.20726134651;8825.646974120964;4054.0472988847596;4137.296659567881;4140.565240649748;4148.605882441163;4149.626533611929;4846.07924494352;4899.951000490021;4988.201887697951;5006.048850718352;5022.146235140035;1033.01347213411;1052.1845569683555;1053.7787064716342;1063.744701271689;1068.5191663751343;626.1953389893964;638.4126603524768;662.4071456046908;667.4160109903834;678.1489231015045;10841.241113122005;13669.179849209078;13850.930745346208;14021.649458763408;14169.716605667829;644.7163248170883;658.8451713847242;667.813012356541;677.6476232359146;681.9727210911607;5181.896362072813;5442.564594832404;5473.9452605474235;5569.303837020372;5636.323641163087;101283.49358253162;102028;102421;103138.48430757798;107198;84069;87468.56265718758;87678.56160719156;87697;88339.55830220936;74687;74734.25265747381;80341.59829200816;80915;81221;11824.23142495735;12689;12830.486780528674;12857.164284321489;12921.612351629467;33953;34807.30385392329;35439.645603543635;35598.466023009154;37226.255474890895;44106.33840492331;60947.390526095944;63833.36166638274;68832.6558367205;69142.65428672824;18086;18165;18209.81790182134;18242.99663518519;18570.164342604345;19680.80319196847;19742.70385944241;19779.208831646574;19844.404667859988;20182.79817201809;18097.36659216921;18612.813871861108;18990.620187596447;19079;19504.122314496166;19062;19352.70970935409;19385.903070484557;19401.80598194;20099.39701808948;17283.222254998305;18029;18203.726944095586;18209.635807284045;18819.71770423472;11584.652460426201;12132.211406258564;12202.450889709808;12227.572034978733;12598.118131731058;12974.80537791915;13039.478420863059;13237.80143297832;13556.457741690221;14127.081739686888 03:08:41 INFO - PID 3577 | __end_tp_report 03:08:41 INFO - PID 3577 | __start_cc_report 03:08:41 INFO - PID 3577 | _x_x_mozilla_cycle_collect,368 03:08:41 INFO - PID 3577 | __end_cc_report 03:08:41 INFO - PID 3577 | __startTimestamp1501150121448__endTimestamp 03:08:41 INFO - PID 3577 | 03:08:41 INFO - PID 3577 | ------- Summary: start ------- 03:08:41 INFO - PID 3577 | Number of tests: 6 03:08:41 INFO - PID 3577 | 03:08:41 INFO - PID 3577 | [#0] dojo.html Cycles:165 Average:6096.71 Median:6361.55 stddev:722.92 (11.4%) stddev-sans-first:685.59 03:08:41 INFO - PID 3577 | Values: 3090.1 3117.0 3130.5 3137.2 3163.1 6020.1 6095.9 6117.0 6120.2 6142.0 6110.2 6136.3 6143.5 6151.7 6156.1 5645.7 5667.9 5669.6 5708.3 5710.3 5644.8 5688.3 5713.7 5722.7 5725.8 5649.6 5715.2 5734.3 5739.3 5761.0 5597.0 5659.8 5684.5 5709.0 5761.9 5506.6 5557.0 5579.6 5587.8 5644.3 6032.5 6034.6 6045.6 6097.1 6175.2 6410.4 6559.7 6582.6 6652.3 6708.9 6574.9 6604.3 6626.3 6675.1 6683.6 6083.5 6139.6 6187.8 6188.5 6214.5 6817.1 6822.7 6899.0 6903.2 6907.4 6480.0 6555.3 6558.9 6567.0 6567.2 6644.9 6689.2 6694.7 6729.5 6748.4 6454.7 6483.2 6535.8 6580.0 6603.4 6653.0 6669.3 6688.7 6688.9 6690.6 5358.5 5360.8 5371.2 5375.4 5382.7 4566.7 4582.3 4597.0 4636.2 4677.2 4971.7 5766.0 5853.9 5866.3 5873.9 6532.4 6618.6 6695.1 6701.9 6714.9 5721.9 5722.7 5778.6 5780.9 5786.8 5775.1 5782.0 5793.2 5820.2 5837.6 6433.7 6436.5 6457.3 6463.9 6483.2 6503.7 6562.0 6568.1 6590.5 6674.5 6356.4 6450.6 6458.2 6484.7 6547.1 6369.3 6399.5 6502.8 6514.9 6559.4 6582.6 6644.5 6680.1 6688.8 6693.8 6446.5 6469.1 6518.6 6526.4 6527.4 6477.6 6481.1 6510.3 6526.8 6587.9 6361.6 6365.0 6393.8 6441.5 6448.5 6357.8 6461.9 6462.5 6552.6 6559.2 6297.0 6299.7 6302.5 6313.8 6335.4 03:08:41 INFO - PID 3577 | 03:08:41 INFO - PID 3577 | [#1] ext.html Cycles:180 Average:38363.26 Median:36525.50 stddev:53047.73 (145.2%) stddev-sans-first:53121.19 03:08:41 INFO - PID 3577 | Values: 709.2 746.1 766.4 769.1 1183.2 31018.8 40421.0 41616.6 41681.8 42041.6 42461.6 42503.8 42718.0 42841.8 42891.4 7718.0 7781.5 7797.4 7844.6 7879.1 7686.9 7788.7 7797.2 7806.6 7817.9 7702.8 7782.1 7801.5 7835.8 7849.0 7735.1 7762.4 7783.2 7814.1 7831.1 7481.7 7718.0 7777.6 7791.5 7801.9 39461.2 39716.8 39755.8 39785.4 39998.0 3446.7 3494.9 3518.1 3524.9 3527.5 31101.5 31303.8 31462.8 31571.2 31754.4 4733.0 4780.8 4784.8 4786.7 4821.7 176052.0 176121.0 176319.0 177224.0 177330.0 48316.5 48446.3 48459.0 48516.0 48573.0 50006.7 50057.5 50337.5 50380.0 50578.7 16358.3 16372.9 16373.1 16419.7 16538.5 13502.1 13604.2 13615.9 13624.9 13650.3 13766.2 14327.9 14389.9 14485.6 14615.3 4979.3 6040.9 6096.1 6136.3 6284.0 949.4 965.5 972.6 986.4 994.6 21605.5 21699.3 22020.4 22129.1 22285.0 1034.1 1037.3 1055.9 1063.7 1074.9 15296.5 15502.8 15518.8 15818.5 16262.6 234648.0 234822.0 235675.0 236066.0 237077.0 57019.1 57071.4 57579.4 57596.4 57600.7 1406.0 1446.7 1450.3 1455.0 1459.6 26125.7 27090.3 27294.2 27434.5 27463.2 52388.7 52596.7 52840.7 52875.0 52913.2 196962.0 197192.0 197332.0 197349.0 197778.0 36158.0 36210.8 36285.6 36438.0 36613.0 43151.6 44723.8 44998.3 45160.5 45634.8 30439.4 32664.2 32677.5 33030.8 33739.7 33015.0 33280.7 33414.5 33542.5 34102.0 37562.4 37921.8 38167.0 38339.8 38426.8 32327.4 32989.7 33099.8 33350.3 33446.5 23417.2 24852.3 25040.2 25348.9 25551.1 03:08:41 INFO - PID 3577 | 03:08:41 INFO - PID 3577 | [#2] jquery.html Cycles:180 Average:36100.35 Median:2360.81 stddev:85548.58 (3623.7%) stddev-sans-first:85746.82 03:08:41 INFO - PID 3577 | Values: 506.5 568.5 576.4 579.5 602.2 21659.9 21963.0 22929.3 22942.5 22962.5 26101.2 26669.5 26734.9 26773.3 26775.0 6441.9 6574.5 6581.1 6583.1 6607.9 5933.1 6382.1 6497.5 6529.5 6554.5 6495.7 6504.2 6513.3 6516.3 6517.5 6417.2 6481.5 6512.0 6521.6 6544.7 6002.8 6022.7 6024.3 6032.2 6032.9 27803.2 29041.0 29870.1 29881.3 29948.9 1818.0 1884.8 1886.1 1889.6 1889.9 18452.3 18815.6 18882.6 19095.5 19227.1 2271.1 2320.8 2358.5 2363.1 2372.2 122141.0 130281.0 130661.3 130706.0 130725.0 14218.2 14943.2 15020.6 15244.2 15503.1 22725.9 23008.5 23019.5 23022.2 23032.4 9496.3 9669.8 9698.0 9735.9 9867.5 7499.4 8792.6 8849.2 8914.1 8944.6 7744.7 8814.6 8839.5 9034.3 9045.3 2642.8 2651.6 2671.9 2701.2 2710.1 880.1 892.0 901.9 916.3 934.2 18198.6 18420.4 23102.4 24251.0 24315.4 982.6 997.6 1014.6 1024.6 1024.8 10683.4 10842.4 11102.4 13138.0 13619.3 497906.0 504584.0 511515.0 516482.0 516879.0 116521.0 120127.4 127672.4 132125.0 133531.0 1249.9 1251.6 1302.9 1303.2 1305.8 20735.8 20844.6 21117.3 21138.6 21651.9 58793.7 59699.4 61659.4 62318.4 63122.0 71174.0 72837.6 73917.0 74197.0 76441.0 16947.7 17615.9 19465.0 20827.5 21527.4 18702.6 19899.6 24339.3 24419.0 24681.6 19214.5 19713.7 19758.9 19958.6 20283.1 16558.3 16841.7 16869.5 16916.2 17612.6 20289.9 20769.4 20901.2 21136.2 21173.6 21297.4 21384.7 21995.3 22375.6 22383.0 19148.5 19610.8 19881.2 19965.3 20137.0 03:08:41 INFO - PID 3577 | 03:08:41 INFO - PID 3577 | [#3] mootools.html Cycles:180 Average:8265.48 Median:2595.75 stddev:5755.95 (221.7%) stddev-sans-first:5748.51 03:08:41 INFO - PID 3577 | Values: 1329.8 1353.0 1387.9 1398.8 1402.1 13085.9 13589.9 13596.6 13625.5 13636.1 13698.9 14552.4 14577.3 14578.4 14604.0 2549.1 2607.8 2620.1 2625.5 2636.0 2432.0 2511.8 2620.5 2651.2 2651.9 2520.2 2592.6 2598.9 2603.3 2607.4 2270.0 2300.7 2314.8 2316.0 2317.1 2430.5 2456.1 2463.2 2463.4 2482.6 13485.3 13544.8 13554.8 13564.3 13598.7 7003.5 7230.3 7363.0 7493.7 7578.1 4839.1 4875.8 4877.6 4958.4 4995.1 1587.2 1673.9 1774.5 1856.1 1879.0 22154.0 22154.3 22223.0 22225.6 22232.4 6069.8 6330.0 6379.6 6499.8 6553.5 15296.2 15304.8 15327.2 15337.5 15379.5 7157.0 7215.2 7252.1 7317.9 7329.3 6644.2 6661.2 6702.4 6710.6 6774.6 4935.7 5069.1 5120.2 5129.6 5136.7 1495.6 1508.8 1516.5 1519.7 1532.5 794.4 799.8 809.2 813.6 842.3 6154.2 6162.4 6231.5 6367.9 6372.2 655.6 659.8 688.0 696.6 708.1 3503.7 3729.3 3944.2 4323.4 4454.9 18021.3 18526.4 18694.3 18703.2 18708.9 17767.2 18091.3 18224.3 18394.2 18540.0 9391.6 9834.7 9848.7 10144.3 10203.1 7451.2 7715.2 7750.8 7761.7 7830.2 15479.6 15654.8 16033.7 16383.2 16771.4 16768.2 16979.4 17029.1 17292.9 17303.5 9732.7 10087.0 10320.2 10330.0 10374.1 12729.2 12746.4 12767.9 12784.2 12863.2 10049.4 10379.5 10410.1 10546.4 10665.5 9458.5 9483.8 9640.8 9755.2 9776.9 8390.5 8408.7 8472.2 8493.5 8522.6 6331.7 6360.5 6619.4 6642.4 6644.6 6269.7 6605.2 6670.1 6707.2 6748.5 03:08:41 INFO - PID 3577 | 03:08:41 INFO - PID 3577 | [#4] prototype.html Cycles:180 Average:5579.04 Median:6113.97 stddev:1501.94 (24.6%) stddev-sans-first:1456.91 03:08:41 INFO - PID 3577 | Values: 496.7 500.5 521.9 527.5 528.5 6236.9 6284.5 6293.6 6312.5 6349.0 6009.4 6023.0 6127.3 6130.4 6193.2 5065.7 5110.2 5113.9 5168.8 5181.3 4946.6 5086.9 5088.5 5183.3 5212.7 5062.0 5075.1 5115.1 5130.6 5177.6 5115.6 5156.7 5168.2 5210.3 5228.6 4762.7 4788.3 4820.0 4845.2 4866.5 6064.2 6072.8 6101.2 6107.0 6121.0 5945.6 5976.2 5980.8 6014.5 6066.5 6393.4 6405.9 6431.3 6475.0 6555.2 5164.2 5188.3 5205.5 5240.7 5245.8 6844.3 6869.8 6949.2 6991.4 7030.2 5412.3 5417.4 5433.8 5454.3 5484.8 5470.3 5477.7 5508.2 5558.3 5594.3 6019.0 6019.8 6040.2 6055.0 6060.6 6582.9 6643.1 6650.0 6650.4 6753.7 1786.1 1870.7 1882.2 1901.6 1939.0 1375.2 1398.2 1400.6 1406.2 1410.0 5576.3 5588.4 5645.2 5695.1 5718.6 6443.4 6451.6 6492.9 6520.6 6607.3 5655.5 5697.9 5709.1 5720.5 5799.2 3464.8 3500.2 3550.9 3553.7 3570.8 6401.7 6462.8 6495.4 6524.7 6529.6 6754.4 6790.9 6797.1 6845.5 6912.8 6382.7 6457.6 6521.3 6539.4 6540.5 6617.9 6701.6 6701.8 6713.0 6754.9 6544.4 6706.5 6719.0 6731.5 6738.6 6494.7 6524.6 6525.4 6525.6 6588.8 4908.6 4972.5 4973.3 4989.1 5002.5 6660.2 6754.0 6762.5 6791.7 6805.6 6237.6 6286.3 6393.3 6426.5 6506.7 6463.7 6507.2 6531.5 6547.7 6549.4 6363.1 6453.5 6454.5 6478.3 6487.5 6350.3 6495.9 6558.9 6560.7 6573.6 6254.0 6283.5 6315.3 6317.5 6393.5 03:08:41 INFO - PID 3577 | 03:08:41 INFO - PID 3577 | [#5] yui.html Cycles:180 Average:22503.03 Median:19452.96 stddev:30006.36 (154.3%) stddev-sans-first:30046.63 03:08:41 INFO - PID 3577 | Values: 886.8 912.7 916.8 919.0 926.7 17971.2 18579.3 18832.7 18930.9 21149.4 20095.9 21384.6 21415.1 21456.0 21524.5 1016.1 1048.1 1048.7 1048.9 1048.9 1004.1 1041.9 1042.5 1043.6 1045.7 1075.2 1081.4 1086.3 1089.3 1091.1 1071.1 1076.1 1077.3 1078.1 1079.0 788.5 792.6 797.4 797.4 798.3 18460.2 19085.6 19156.6 19200.1 19628.7 20049.6 20136.5 20339.9 20633.0 20754.3 14997.3 15299.3 15383.2 15468.8 15489.8 3401.2 3490.5 3504.4 3505.7 3512.8 120158.4 120963.4 125056.0 127405.4 127548.0 15173.0 15533.5 15538.5 15563.8 15593.1 27376.5 29069.4 29205.0 29230.0 29498.9 8272.1 8701.5 8789.5 8808.2 8825.6 4054.0 4137.3 4140.6 4148.6 4149.6 4846.1 4900.0 4988.2 5006.0 5022.1 1033.0 1052.2 1053.8 1063.7 1068.5 626.2 638.4 662.4 667.4 678.1 10841.2 13669.2 13850.9 14021.6 14169.7 644.7 658.8 667.8 677.6 682.0 5181.9 5442.6 5473.9 5569.3 5636.3 101283.5 102028.0 102421.0 103138.5 107198.0 84069.0 87468.6 87678.6 87697.0 88339.6 74687.0 74734.3 80341.6 80915.0 81221.0 11824.2 12689.0 12830.5 12857.2 12921.6 33953.0 34807.3 35439.6 35598.5 37226.3 44106.3 60947.4 63833.4 68832.7 69142.7 18086.0 18165.0 18209.8 18243.0 18570.2 19680.8 19742.7 19779.2 19844.4 20182.8 18097.4 18612.8 18990.6 19079.0 19504.1 19062.0 19352.7 19385.9 19401.8 20099.4 17283.2 18029.0 18203.7 18209.6 18819.7 11584.7 12132.2 12202.5 12227.6 12598.1 12974.8 13039.5 13237.8 13556.5 14127.1 03:08:41 INFO - PID 3577 | -------- Summary: end -------- 03:08:41 INFO - PID 3577 | 03:08:42 INFO - TEST-INFO | 3577: exit 0 03:08:42 INFO - TEST-OK | dromaeo_css | took 1117262ms 03:08:42 INFO - TEST-START | kraken 03:08:42 INFO - Initialising browser for kraken test... 03:08:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36777/getInfo.html -profile /tmp/tmpS6aSif/profile 03:08:42 INFO - TEST-INFO | started process 3948 (/builds/slave/test/build/application/firefox/firefox http://localhost:36777/getInfo.html) 03:08:48 INFO - TEST-INFO | 3948: exit 0 03:08:48 INFO - Browser initialized. 03:08:48 INFO - Running cycle 1/1 for kraken test... 03:08:48 INFO - TEST-INFO | started process 4172 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpS6aSif/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:08:49 INFO - PID 4172 | 03:08:49 INFO - PID 4172 | (/builds/slave/test/build/application/firefox/firefox:4227): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:08:49 INFO - PID 4172 | 03:09:00 INFO - PID 4172 | RSS: Main: 173707264 03:09:00 INFO - PID 4172 | 03:09:02 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36777/tests/kraken/driver.html?testName=audio-beat-detection) 03:09:03 INFO - PID 4172 | RSS: Main: 178802688 03:09:03 INFO - PID 4172 | 03:09:06 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36777/tests/kraken/driver.html?testName=audio-dft) 03:09:07 INFO - PID 4172 | RSS: Main: 179240960 03:09:07 INFO - PID 4172 | 03:09:10 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36777/tests/kraken/driver.html?testName=audio-fft) 03:09:10 INFO - PID 4172 | RSS: Main: 173948928 03:09:10 INFO - PID 4172 | 03:09:13 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36777/tests/kraken/driver.html?testName=audio-oscillator) 03:09:13 INFO - PID 4172 | RSS: Main: 174661632 03:09:13 INFO - PID 4172 | 03:09:15 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36777/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:09:16 INFO - PID 4172 | RSS: Main: 174964736 03:09:16 INFO - PID 4172 | 03:09:19 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36777/tests/kraken/driver.html?testName=imaging-darkroom) 03:09:20 INFO - PID 4172 | RSS: Main: 177479680 03:09:20 INFO - PID 4172 | 03:09:23 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36777/tests/kraken/driver.html?testName=imaging-desaturate) 03:09:24 INFO - PID 4172 | RSS: Main: 176398336 03:09:24 INFO - PID 4172 | 03:09:27 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36777/tests/kraken/driver.html?testName=json-parse-financial) 03:09:28 INFO - PID 4172 | RSS: Main: 177094656 03:09:28 INFO - PID 4172 | 03:09:29 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36777/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:09:30 INFO - PID 4172 | RSS: Main: 177065984 03:09:30 INFO - PID 4172 | 03:09:32 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:09:32 INFO - PID 4172 | RSS: Main: 174432256 03:09:32 INFO - PID 4172 | 03:09:35 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:09:35 INFO - PID 4172 | RSS: Main: 174620672 03:09:35 INFO - PID 4172 | 03:09:38 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:09:39 INFO - PID 4172 | RSS: Main: 175046656 03:09:39 INFO - PID 4172 | 03:09:42 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:09:43 INFO - PID 4172 | RSS: Main: 174882816 03:09:43 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | Cycle 1(1): loaded http://localhost:36777/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36777/tests/kraken/driver.html?testName=ai-astar) 03:09:45 INFO - PID 4172 | RSS: Main: 176857088 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | __start_tp_report 03:09:45 INFO - PID 4172 | _x_x_mozilla_page_load 03:09:45 INFO - PID 4172 | _x_x_mozilla_page_load_details 03:09:45 INFO - PID 4172 | |i|pagename|runs| 03:09:45 INFO - PID 4172 | |0;ai-astar;102;111;105;110;110;121;115;103;114;112 03:09:45 INFO - PID 4172 | |1;audio-beat-detection;143;118;152;169;118;149;149;119;176;121 03:09:45 INFO - PID 4172 | |2;audio-dft;164;170;163;163;168;170;167;166;166;166 03:09:45 INFO - PID 4172 | |3;audio-fft;76;78;77;191;76;75;77;85;165;83 03:09:45 INFO - PID 4172 | |4;audio-oscillator;84;83;147;80;79;81;134;79;79;128 03:09:45 INFO - PID 4172 | |5;imaging-gaussian-blur;115;125;118;115;116;120;114;121;115;124 03:09:45 INFO - PID 4172 | |6;imaging-darkroom;152;153;151;151;152;152;151;159;151;152 03:09:45 INFO - PID 4172 | |7;imaging-desaturate;95;95;94;94;94;100;95;96;94;94 03:09:45 INFO - PID 4172 | |8;json-parse-financial;57;61;55;57;55;64;57;57;62;56 03:09:45 INFO - PID 4172 | |9;json-stringify-tinderbox;53;54;60;54;54;54;56;59;54;58 03:09:45 INFO - PID 4172 | |10;stanford-crypto-aes;85;92;90;82;92;87;91;88;84;93 03:09:45 INFO - PID 4172 | |11;stanford-crypto-ccm;134;127;133;131;141;131;135;126;136;171 03:09:45 INFO - PID 4172 | |12;stanford-crypto-pbkdf2;173;182;185;182;190;178;186;180;179;176 03:09:45 INFO - PID 4172 | |13;stanford-crypto-sha256-iterative;70;76;73;77;71;70;75;79;72;69 03:09:45 INFO - PID 4172 | __end_tp_report 03:09:45 INFO - PID 4172 | __start_cc_report 03:09:45 INFO - PID 4172 | _x_x_mozilla_cycle_collect,985 03:09:45 INFO - PID 4172 | __end_cc_report 03:09:45 INFO - PID 4172 | __startTimestamp1501150185311__endTimestamp 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | ------- Summary: start ------- 03:09:45 INFO - PID 4172 | Number of tests: 14 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:5.81 (5.2%) stddev-sans-first:5.33 03:09:45 INFO - PID 4172 | Values: 102.0 111.0 105.0 110.0 110.0 121.0 115.0 103.0 114.0 112.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:149.00 stddev:21.61 (14.5%) stddev-sans-first:22.91 03:09:45 INFO - PID 4172 | Values: 143.0 118.0 152.0 169.0 118.0 149.0 149.0 119.0 176.0 121.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#2] audio-dft Cycles:10 Average:166.30 Median:166.50 stddev:2.54 (1.5%) stddev-sans-first:2.55 03:09:45 INFO - PID 4172 | Values: 164.0 170.0 163.0 163.0 168.0 170.0 167.0 166.0 166.0 166.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#3] audio-fft Cycles:10 Average:98.30 Median:77.00 stddev:42.57 (55.3%) stddev-sans-first:44.38 03:09:45 INFO - PID 4172 | Values: 76.0 78.0 77.0 191.0 76.0 75.0 77.0 85.0 165.0 83.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#4] audio-oscillator Cycles:10 Average:97.40 Median:79.50 stddev:27.31 (34.3%) stddev-sans-first:28.53 03:09:45 INFO - PID 4172 | Values: 84.0 83.0 147.0 80.0 79.0 81.0 134.0 79.0 79.0 128.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:119.00 stddev:4.00 (3.4%) stddev-sans-first:4.06 03:09:45 INFO - PID 4172 | Values: 115.0 125.0 118.0 115.0 116.0 120.0 114.0 121.0 115.0 124.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#6] imaging-darkroom Cycles:10 Average:152.40 Median:152.00 stddev:2.41 (1.6%) stddev-sans-first:2.55 03:09:45 INFO - PID 4172 | Values: 152.0 153.0 151.0 151.0 152.0 152.0 151.0 159.0 151.0 152.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:94.50 stddev:1.85 (2.0%) stddev-sans-first:1.96 03:09:45 INFO - PID 4172 | Values: 95.0 95.0 94.0 94.0 94.0 100.0 95.0 96.0 94.0 94.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:57.00 stddev:3.11 (5.5%) stddev-sans-first:3.27 03:09:45 INFO - PID 4172 | Values: 57.0 61.0 55.0 57.0 55.0 64.0 57.0 57.0 62.0 56.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:55.00 stddev:2.50 (4.6%) stddev-sans-first:2.47 03:09:45 INFO - PID 4172 | Values: 53.0 54.0 60.0 54.0 54.0 54.0 56.0 59.0 54.0 58.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:90.50 stddev:3.81 (4.2%) stddev-sans-first:3.83 03:09:45 INFO - PID 4172 | Values: 85.0 92.0 90.0 82.0 92.0 87.0 91.0 88.0 84.0 93.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#11] stanford-crypto-ccm Cycles:10 Average:136.50 Median:134.50 stddev:12.88 (9.6%) stddev-sans-first:13.63 03:09:45 INFO - PID 4172 | Values: 134.0 127.0 133.0 131.0 141.0 131.0 135.0 126.0 136.0 171.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.10 Median:182.00 stddev:5.02 (2.8%) stddev-sans-first:4.39 03:09:45 INFO - PID 4172 | Values: 173.0 182.0 185.0 182.0 190.0 178.0 186.0 180.0 179.0 176.0 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:74.00 stddev:3.39 (4.6%) stddev-sans-first:3.40 03:09:45 INFO - PID 4172 | Values: 70.0 76.0 73.0 77.0 71.0 70.0 75.0 79.0 72.0 69.0 03:09:45 INFO - PID 4172 | -------- Summary: end -------- 03:09:45 INFO - PID 4172 | 03:09:45 INFO - PID 4172 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:09:45 INFO - TEST-INFO | 4172: exit 0 03:09:45 INFO - TEST-OK | kraken | took 63856ms 03:09:45 INFO - SUITE-END | took 1181s 03:09:46 INFO - Completed test suite (00:19:41) 03:09:46 INFO - javascript benchmark 03:09:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8438.204321329544, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3090.119315994942, 3116.984415077926, 3130.4834702274125, 3137.1843320736602, 3163.066895265896, 6020.127081573175, 6095.9085613715715, 6117.021276595746, 6120.173776540166, 6142.04798256271, 6110.20567326247, 6136.325004249529, 6143.508519318455, 6151.692415379235, 6156.1381406602995, 5645.745941432635, 5667.886642267152, 5669.603127781057, 5708.257926469553, 5710.2862142232225, 5644.8024319148835, 5688.345840228365, 5713.685747283897, 5722.742476588543, 5725.828225153252, 5649.576281778863, 5715.199872017921, 5734.311882574076, 5739.253896993406, 5760.991826430379, 5597.048501754712, 5659.773609055633, 5684.459976302244, 5709.029464990961, 5761.8559536011935, 5506.614536982413, 5556.972215138939, 5579.609427340088, 5587.776488940478, 5644.294463192101, 6032.487238584726, 6034.577579569432, 6045.637261764308, 6097.054956481752, 6175.166352542395, 6410.358964103599, 6559.737610495575, 6582.572132811352, 6652.301508341603, 6708.932910670879, 6574.901376479356, 6604.339566043357, 6626.304238054983, 6675.098861653663, 6683.565568238049, 6083.482903953125, 6139.570230083896, 6187.814365569086, 6188.504919606421, 6214.471769899609, 6817.147856517935, 6822.692978815965, 6899.0, 6903.240643529208, 6907.412869906014, 6480.0, 6555.311692272338, 6558.934410655832, 6567.047778072153, 6567.244766851778, 6644.933550664528, 6689.1972963244725, 6694.732210711517, 6729.49528785343, 6748.392644661906, 6454.741810327534, 6483.222013358427, 6535.803925882231, 6580.0, 6603.372679595431, 6652.96673516639, 6669.266380698119, 6688.665566721645, 6688.86622267552, 6690.632015239208, 5358.490943360374, 5360.758765855546, 5371.167469042305, 5375.408705042442, 5382.730863456812, 4566.70316429431, 4582.266837306015, 4596.97701511497, 4636.235021221461, 4677.18149323867, 4971.7135996309935, 5766.048601980626, 5853.853653658693, 5866.325372582122, 5873.882522349529, 6532.379423954717, 6618.602883826986, 6695.096162018162, 6701.899471507932, 6714.899276510856, 5721.942780572224, 5722.656640601577, 5778.624389414675, 5780.88438231233, 5786.797462088806, 5775.104858746901, 5782.045962416239, 5793.246877905845, 5820.24336836217, 5837.620554663933, 6433.710483028181, 6436.485081193493, 6457.2574153971955, 6463.903041454382, 6483.189601299838, 6503.674816259263, 6562.0, 6568.146141001639, 6590.505712071518, 6674.532782705164, 6356.396142366468, 6450.645214513247, 6458.192725909262, 6484.740610375532, 6547.083408322934, 6369.299377068426, 6399.456046236122, 6502.772402965874, 6514.869702606016, 6559.376859198369, 6582.637954912526, 6644.46844252449, 6680.098186744727, 6688.765893193715, 6693.765718199839, 6446.5165112615805, 6469.126667899962, 6518.641474718936, 6526.412622863965, 6527.379898909596, 6477.578957367756, 6481.0926470295135, 6510.283868774526, 6526.771562995463, 6587.934120658923, 6361.554691171574, 6364.968175159094, 6393.78518081563, 6441.5490915635455, 6448.484121270381, 6357.841053973688, 6461.903071453838, 6462.450691691259, 6552.57408268461, 6559.245686746085, 6297.023961286008, 6299.748010079546, 6302.464290535356, 6313.779017734358, 6335.366463353628], "value": 6042.578220106205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.2127738210586, 746.1307576673175, 766.3754040457027, 769.0809482668212, 1183.2249876331007, 31018.844905775466, 40421.0, 41616.58383416165, 41681.79159104208, 42041.57958420415, 42461.57538424615, 42503.78748106263, 42718.0, 42841.785791071, 42891.35662965058, 7718.0, 7781.494202876823, 7797.415193860455, 7844.568548729818, 7879.093904201004, 7686.884696729554, 7788.727394541193, 7797.220277972186, 7806.60966951653, 7817.8827317590285, 7702.768916932473, 7782.105057918327, 7801.453898227126, 7835.804104897366, 7849.0, 7735.110462296823, 7762.37900967924, 7783.221677832228, 7814.062312522534, 7831.060272767248, 7481.7007319707145, 7718.035245594301, 7777.611119444062, 7791.4935529190425, 7801.921980780176, 39461.210775784326, 39716.801415993024, 39755.80122099371, 39785.40321895174, 39998.0, 3446.7070299024363, 3494.8951531454095, 3518.0501264658656, 3524.9118772030647, 3527.4708793680898, 31101.53347699786, 31303.843480782678, 31462.842685786654, 31571.21071973196, 31754.364912701618, 4732.952670473285, 4780.760961951889, 4784.832530861403, 4786.736729479877, 4821.686590371614, 176052.0, 176121.0, 176319.0, 177223.99999999872, 177330.0, 48316.516834831906, 48446.27330590044, 48459.0, 48516.0, 48573.0, 50006.74996625067, 50057.499425005284, 50337.47637665401, 50380.0, 50578.74710626497, 16358.263878125514, 16372.85390022687, 16373.09947952874, 16419.6716065678, 16538.50384488467, 13502.122362046435, 13604.183748975092, 13615.910727141805, 13624.863751362558, 13650.317484125753, 13766.24285664278, 14327.856721432861, 14389.856101438852, 14485.637859053608, 14615.269236538343, 4979.327790748275, 6040.939590604038, 6096.116063170815, 6136.325004249529, 6284.0, 949.4398305000083, 965.5172413793103, 972.5557547042636, 986.3785814936545, 994.6419289055934, 21605.45986350354, 21699.34901952944, 22020.449488762588, 22129.114835406726, 22285.0, 1034.0538407357185, 1037.2998226197287, 1055.894410558938, 1063.686212567279, 1074.9301295415773, 15296.541103766906, 15502.767458488132, 15518.844811551966, 15818.525444236691, 16262.593435164215, 234648.0, 234822.0, 235675.0, 236066.0, 237077.0, 57019.144712829344, 57071.42928570744, 57579.424205758245, 57596.40816163199, 57600.71199643975, 1405.9578212653637, 1446.7468193066172, 1450.2676148545129, 1455.0396738152767, 1459.6204986703533, 26125.73874261233, 27090.32274193161, 27294.181174564794, 27434.45131097407, 27463.17610471689, 52388.73805630948, 52596.73701631468, 52840.73579632077, 52875.0, 52913.206301904735, 196962.0, 197192.0, 197332.0, 197349.0, 197778.0, 36158.0, 36210.8189459051, 36285.63714362928, 36438.0, 36613.0, 43151.568484314754, 44723.77638111789, 44998.325025123995, 45160.54839451564, 45634.77182614199, 30439.39121217519, 32664.183395415304, 32677.509837352933, 33030.834845825615, 33739.662603373654, 33015.0, 33280.667193327754, 33414.498782517796, 33542.49686254659, 34102.0, 37562.436563451025, 37921.81039094897, 38167.0, 38339.80830095831, 38426.807865960494, 32327.35345293128, 32989.67010329962, 33099.83450082831, 33350.33299334048, 33446.498302525, 23417.180398685963, 24852.254432366335, 25040.248792536255, 25348.873255633604, 25551.105711300017], "value": 17627.79683166455, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [506.53904946498693, 568.4599630351167, 576.3861487515793, 579.4697851465907, 602.1509671363377, 21659.891700541513, 21963.0, 22929.312120636387, 22942.541149177006, 22962.540749185006, 26101.216963491126, 26669.466610667823, 26734.866325668343, 26773.33066673334, 26775.0, 6441.903371449432, 6574.474042076647, 6581.111549940744, 6583.14419125513, 6607.9008814867575, 5933.080372542263, 6382.074599183115, 6497.480201583886, 6529.51028672849, 6554.508411869105, 6495.7076931538195, 6504.219493660744, 6513.348665133472, 6516.250631177404, 6517.543771935966, 6417.165768450118, 6481.513886458534, 6511.967440162793, 6521.608703477783, 6544.70548825304, 6002.78990235344, 6022.6687532185715, 6024.277086749575, 6032.245969253843, 6032.939670603326, 27803.16590502288, 29041.0, 29870.103896883127, 29881.25296867574, 29948.85025574858, 1818.0, 1884.7549818523505, 1886.0946745562069, 1889.5748456597294, 1889.8582606304444, 18452.261909523604, 18815.62368752631, 18882.622347553108, 19095.52261193481, 19227.134778934982, 2271.1483193802324, 2320.7679232076657, 2358.5282943411216, 2363.0902102690416, 2372.205311220743, 122141.0, 130281.0, 130661.34669326592, 130706.0, 130725.0, 14218.217998010003, 14943.178125203218, 15020.624484387978, 15244.161571113473, 15503.147326896904, 22725.886370568373, 23008.539829203655, 23019.539609208055, 23022.194223202107, 23032.4241893954, 9496.335256531976, 9669.758256043655, 9698.0, 9735.853962190573, 9867.506624668738, 7499.400047996147, 8792.648294068293, 8849.247813935888, 8914.064023277591, 8944.642214311485, 7744.667675451181, 8814.5592720365, 8839.51382673959, 9034.277257819358, 9045.32160087996, 2642.828216165943, 2651.6324268179305, 2671.9465610687676, 2701.2031450722084, 2710.105665130502, 880.1418616848649, 891.9643214271357, 901.8692289617969, 916.2532535983286, 934.1592566690033, 18198.63602727938, 18420.35528756487, 23102.42243943915, 24251.0, 24315.392115196908, 982.6069572171189, 997.6432052408718, 1014.6398028699853, 1024.6106479537877, 1024.7540590258434, 10683.412412317397, 10842.40366779819, 11102.44487775608, 13138.0, 13619.319034048258, 497906.0, 504584.0, 511515.0, 516482.0, 516879.0, 116521.0, 120127.39936300262, 127672.36163819121, 132125.0, 133531.0, 1249.9062570307262, 1251.561953316332, 1302.9348532573522, 1303.1529505821102, 1305.7845455499737, 20735.792642073386, 20844.58310833805, 21117.26089586857, 21138.57722845565, 21651.891740541196, 58793.70603146957, 59699.40300597112, 61659.38340616536, 62318.376816233074, 63122.0, 71174.0, 72837.6358118206, 73917.0, 74197.0, 76441.0, 16947.66104677924, 17615.911920440314, 19465.0, 20827.479313017295, 21527.354179374644, 18702.6259474807, 19899.60200796005, 24339.26982190537, 24419.0, 24681.62977555374, 19214.519637008627, 19713.70429443588, 19758.901205494454, 19958.600827983068, 20283.087261073582, 16558.337666493688, 16841.74737378916, 16869.493915182564, 16916.238769255167, 17612.559686007953, 20289.898550507154, 20769.376918692462, 20901.1639534423, 21136.154553817676, 21173.576528469654, 21297.36107916765, 21384.679229811252, 21995.340139795833, 22375.552488949805, 22383.0, 19148.521286967938, 19610.80389196147, 19881.204751809764, 19965.301214457424, 20136.993150342718], "value": 12318.266983839023, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1329.7938819482981, 1353.0461024977392, 1387.8820300274476, 1398.811160493333, 1402.1096603656674, 13085.869141308583, 13589.932050339747, 13596.592102236924, 13625.523106691267, 13636.113652612597, 13698.863011369884, 14552.417903283857, 14577.34401951912, 14578.416863325454, 14604.0, 2549.0823303610687, 2607.7783388411913, 2620.109162884619, 2625.5405304071805, 2635.973640263592, 2431.987840060797, 2511.7739403453684, 2620.5414052540823, 2651.151631477928, 2651.9337016574545, 2520.1683444463283, 2592.6111083337555, 2598.8960441582312, 2603.3361492819304, 2607.413332000304, 2270.012544543129, 2300.723913130418, 2314.8032417244553, 2315.988420057906, 2317.084751523147, 2430.489597184576, 2456.091246238885, 2463.2487091437106, 2463.3964678653665, 2482.565551028563, 13485.258310793, 13544.796828047587, 13554.796678049837, 13564.321783910864, 13598.660033499144, 7003.544769590011, 7230.313120253568, 7363.0, 7493.700251989969, 7578.12851522071, 4839.080574690833, 4875.756212189376, 4877.609791216694, 4958.355413796184, 4995.050940321364, 1587.190532828266, 1673.9246733897003, 1774.5120091974682, 1856.0997916010858, 1878.971815422756, 22154.0, 22154.33536993909, 22223.0, 22225.55548889013, 22232.444188895246, 6069.817905462844, 6330.0, 6379.649119298483, 6499.805005849832, 6553.5084868634085, 15296.235188240544, 15304.846951530564, 15327.233638318039, 15337.463188788563, 15379.461718839786, 7157.0, 7215.242399547972, 7252.093488313961, 7317.926820731831, 7329.340359367682, 6644.202695676549, 6661.16735408074, 6702.36327548882, 6710.597364158166, 6774.559653622498, 4935.679180853305, 5069.112905241568, 5120.231965205175, 5129.563987061141, 5136.691798492103, 1495.5662857771342, 1508.8491150884824, 1516.499555146799, 1519.7036577867432, 1532.5478983699613, 794.4359504751691, 799.8240387114942, 809.2393150438569, 813.60540138033, 842.2756429470651, 6154.1999540059505, 6162.445379915829, 6231.532635052389, 6367.904481432783, 6372.203474565679, 655.5738769799668, 659.7855696898528, 687.9621620810904, 696.6342670098239, 708.1077841919218, 3503.7197024238, 3729.328720830222, 3944.1717239379477, 4323.373110898902, 4454.910901781946, 18021.2791488339, 18526.444206673823, 18694.34569790051, 18703.15835787393, 18708.906455467637, 17767.200475978352, 18091.276348946158, 18224.271029158685, 18394.17226224823, 18540.0, 9391.62433502666, 9834.655787047419, 9848.655297064712, 10144.28989970695, 10203.132733717717, 7451.180370159386, 7715.189905059888, 7750.806229844299, 7761.650725717469, 7830.2169783021245, 15479.613009674847, 15654.765178522104, 16033.679326413174, 16383.180840957666, 16771.413000544922, 16768.16159192011, 16979.405720799714, 17029.063401513034, 17292.913535432242, 17303.480895573153, 9732.659356922473, 10087.04173103554, 10320.174386049248, 10330.0, 10374.066334029974, 12729.154272630602, 12746.362681866056, 12767.87232127704, 12784.169029013085, 12863.22820630765, 10049.447280399356, 10379.532921018723, 10410.115140213167, 10546.419946902994, 10665.466726663792, 9458.527073646428, 9483.762905927131, 9640.75898102525, 9755.170810480904, 9776.902230977883, 8390.538520381439, 8408.705695300636, 8472.237498625153, 8493.532855692749, 8522.573871306535, 6331.715072821642, 6360.4911607072245, 6619.4373478252965, 6642.43539299165, 6644.568103073285, 6269.7178626962805, 6605.174353205849, 6670.099536562502, 6707.195136583641, 6748.527603067738], "value": 5966.358651060153, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.73306298892527, 500.4676337731081, 521.8747500599856, 527.4672580693499, 528.5322489596708, 6236.937630623693, 6284.465820405271, 6293.590916590419, 6312.463440607542, 6348.968255158724, 6009.369016253296, 6022.969885150579, 6127.325994140652, 6130.386961303868, 6193.225846769154, 5065.7467126643705, 5110.156824124015, 5113.872153196163, 5168.8449346519665, 5181.274621552967, 4946.629002824802, 5086.872828179288, 5088.465711100337, 5183.2743415921805, 5212.713300768456, 5062.0, 5075.137226671456, 5115.079285728568, 5130.589552835764, 5177.637565370425, 5115.590752739772, 5156.716380599066, 5168.198929165986, 5210.34272521017, 5228.5555727763185, 4762.666613337068, 4788.281757736333, 4819.975900120512, 4845.200541910581, 4866.537678920497, 6064.181335519693, 6072.817815465543, 6101.237345331833, 6106.969465152646, 6120.96939515304, 5945.621751299472, 5976.193213916109, 5980.760769569212, 6014.458698717136, 6066.484348830355, 6393.360663933616, 6405.903911441332, 6431.292557818636, 6474.9963755617955, 6555.180602424697, 5164.173732202867, 5188.273641690166, 5205.453427390107, 5240.737963101829, 5245.842624721265, 6844.28135045818, 6869.7595584154315, 6949.235584085746, 6991.440684745208, 7030.191527974297, 5412.323459567554, 5417.404085550586, 5433.809816656398, 5454.263674403905, 5484.808031718871, 5470.261514695465, 5477.7261136943, 5508.20131080991, 5558.305211848519, 5594.300712410949, 6019.0, 6019.789307374221, 6040.244969378828, 6055.0, 6060.636361818217, 6582.934170658232, 6643.073508682524, 6650.0, 6650.401463868275, 6753.696083676246, 1786.11587264305, 1870.662476329431, 1882.2000649723814, 1901.610169915164, 1938.952965398669, 1375.2229990055587, 1398.2172729769422, 1400.6288333591606, 1406.2336026865178, 1410.0411720030272, 5576.275084239023, 5588.3573389060775, 5645.23789288449, 5695.09550129437, 5718.628289161191, 6443.420092191725, 6451.580647257913, 6492.902606460907, 6520.608763474207, 6607.339266073451, 5655.465334166146, 5697.857553561194, 5709.1177998960275, 5720.456556627114, 5799.2460980073165, 3464.7921124732597, 3500.2474467989505, 3550.928981420357, 3553.662402071799, 3570.803605801706, 6401.743930242738, 6462.838429039311, 6495.382938620824, 6524.692344574108, 6529.575577587441, 6754.446477310246, 6790.932090679129, 6797.116374871334, 6845.486588505882, 6912.792616221522, 6382.680865956777, 6457.612543247514, 6521.34786521363, 6539.444147247537, 6540.50946179029, 6617.900731488935, 6701.597904125573, 6701.8324541884895, 6712.966435167793, 6754.932450675627, 6544.3782840630065, 6706.497012724163, 6718.958561422987, 6731.528792984444, 6738.59568425896, 6494.6752662367635, 6524.575902566318, 6525.445337146396, 6525.575837570543, 6588.769393071219, 4908.607311415007, 4972.5276098770555, 4973.254011898244, 4989.052080104769, 5002.52476014778, 6660.200775906922, 6753.966230168818, 6762.526623136333, 6791.694373753292, 6805.625690586867, 6237.563370564017, 6286.308506064238, 6393.29673735898, 6426.485881129405, 6506.674666266762, 6463.741450341934, 6507.186601674791, 6531.510136739858, 6547.70535325902, 6549.443297319591, 6363.072986426296, 6453.451456626051, 6454.483196448925, 6478.250872264368, 6487.481001519962, 6350.301466838737, 6495.935040649533, 6558.901616475661, 6560.737570497317, 6573.605583664996, 6253.96873015632, 6283.486605357711, 6315.273743519554, 6317.526185536195, 6393.4885209184085], "value": 5145.563817221077, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [886.7561420609336, 912.7489940266425, 916.8028873792133, 918.9540522973849, 926.6941909169975, 17971.191296391662, 18579.25682972683, 18832.717509237373, 18930.905345473253, 21149.365519034414, 20095.899520502415, 21384.57230855382, 21415.14339426421, 21456.0, 21524.461888452795, 1016.1413605503337, 1048.051513380388, 1048.7063622185801, 1048.8688913885765, 1048.9318194317384, 1004.1113614451227, 1041.8958104189558, 1042.4943902207424, 1043.5929987304958, 1045.728110691222, 1075.172117469548, 1081.3565928272665, 1086.3101930274292, 1089.319175515303, 1091.0725882999466, 1071.132382769955, 1076.1068313299982, 1077.3266708307308, 1078.067471637036, 1079.034264333425, 788.5032429569392, 792.5720111139977, 797.3740613618281, 797.4258533855615, 798.317438590003, 18460.16929238174, 19085.61828763431, 19156.61686766271, 19200.13599388031, 19628.70556941647, 20049.599008019904, 20136.49658758528, 20339.89830050855, 20633.0, 20754.273600424065, 14997.250137493082, 15299.311530981133, 15383.230838458032, 15468.767968480483, 15489.845101549066, 3401.1667141550233, 3490.5287786148797, 3504.351694936445, 3505.7195424366246, 3512.8067956262394, 120158.39920800428, 120963.39518302352, 125056.0, 127405.36297318454, 127548.0, 15173.0, 15533.533993980198, 15538.45615403478, 15563.766543501857, 15593.142377169364, 27376.45247095087, 29069.41861162765, 29205.0, 29230.0, 29498.852505737334, 8272.090070092285, 8701.521416322037, 8789.472631642122, 8808.20726134651, 8825.646974120964, 4054.0472988847596, 4137.296659567881, 4140.565240649748, 4148.605882441163, 4149.626533611929, 4846.07924494352, 4899.951000490021, 4988.201887697951, 5006.048850718352, 5022.146235140035, 1033.01347213411, 1052.1845569683555, 1053.7787064716342, 1063.744701271689, 1068.5191663751343, 626.1953389893964, 638.4126603524768, 662.4071456046908, 667.4160109903834, 678.1489231015045, 10841.241113122005, 13669.179849209078, 13850.930745346208, 14021.649458763408, 14169.716605667829, 644.7163248170883, 658.8451713847242, 667.813012356541, 677.6476232359146, 681.9727210911607, 5181.896362072813, 5442.564594832404, 5473.9452605474235, 5569.303837020372, 5636.323641163087, 101283.49358253162, 102028.0, 102421.0, 103138.48430757798, 107198.0, 84069.0, 87468.56265718758, 87678.56160719156, 87697.0, 88339.55830220936, 74687.0, 74734.25265747381, 80341.59829200816, 80915.0, 81221.0, 11824.23142495735, 12689.0, 12830.486780528674, 12857.164284321489, 12921.612351629467, 33953.0, 34807.30385392329, 35439.645603543635, 35598.466023009154, 37226.255474890895, 44106.33840492331, 60947.390526095944, 63833.36166638274, 68832.6558367205, 69142.65428672824, 18086.0, 18165.0, 18209.81790182134, 18242.99663518519, 18570.164342604345, 19680.80319196847, 19742.70385944241, 19779.208831646574, 19844.404667859988, 20182.79817201809, 18097.36659216921, 18612.813871861108, 18990.620187596447, 19079.0, 19504.122314496166, 19062.0, 19352.70970935409, 19385.903070484557, 19401.80598194, 20099.39701808948, 17283.222254998305, 18029.0, 18203.726944095586, 18209.635807284045, 18819.71770423472, 11584.652460426201, 12132.211406258564, 12202.450889709808, 12227.572034978733, 12598.118131731058, 12974.80537791915, 13039.478420863059, 13237.80143297832, 13556.457741690221, 14127.081739686888], "value": 8961.059434660025, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 105.0, 110.0, 110.0, 121.0, 115.0, 103.0, 114.0, 112.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 118.0, 152.0, 169.0, 118.0, 149.0, 149.0, 119.0, 176.0, 121.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 170.0, 163.0, 163.0, 168.0, 170.0, 167.0, 166.0, 166.0, 166.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 191.0, 76.0, 75.0, 77.0, 85.0, 165.0, 83.0], "value": 98.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 147.0, 80.0, 79.0, 81.0, 134.0, 79.0, 79.0, 128.0], "value": 97.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 125.0, 118.0, 115.0, 116.0, 120.0, 114.0, 121.0, 115.0, 124.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 151.0, 151.0, 152.0, 152.0, 151.0, 159.0, 151.0, 152.0], "value": 152.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 94.0, 100.0, 95.0, 96.0, 94.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 61.0, 55.0, 57.0, 55.0, 64.0, 57.0, 57.0, 62.0, 56.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 60.0, 54.0, 54.0, 54.0, 56.0, 59.0, 54.0, 58.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 92.0, 90.0, 82.0, 92.0, 87.0, 91.0, 88.0, 84.0, 93.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 127.0, 133.0, 131.0, 141.0, 131.0, 135.0, 126.0, 136.0, 171.0], "value": 136.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 182.0, 185.0, 182.0, 190.0, 178.0, 186.0, 180.0, 179.0, 176.0], "value": 181.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 73.0, 77.0, 71.0, 70.0, 75.0, 79.0, 72.0, 69.0], "value": 73.2, "unit": "score"}]}]} 03:09:46 INFO - Return code: 0 03:09:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:09:46 INFO - # TBPL SUCCESS # 03:09:46 INFO - Running post-action listener: _package_coverage_data 03:09:46 INFO - Running post-action listener: _resource_record_post_action 03:09:46 INFO - [mozharness: 2017-07-27 10:09:46.597692Z] Finished run-tests step (success) 03:09:46 INFO - Running post-run listener: _resource_record_post_run 03:09:46 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 5275648; Write bytes: 442449920; Read time: 2032; Write time: 422004 03:09:46 INFO - TinderboxPrint: CPU usage
13.2% 03:09:46 INFO - TinderboxPrint: I/O read bytes / time
5,275,648 / 2,032 03:09:46 INFO - TinderboxPrint: I/O write bytes / time
442,449,920 / 422,004 03:09:46 INFO - TinderboxPrint: CPU idle
8,300.4 (86.8%) 03:09:46 INFO - TinderboxPrint: CPU user
1,206.4 (12.6%) 03:09:46 INFO - TinderboxPrint: Swap in / out
0 / 0 03:09:46 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119394304; Read time: 0; Write time: 130780 03:09:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:09:46 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 2908160; Write bytes: 322740224; Read time: 1576; Write time: 291156 03:09:47 INFO - Running post-run listener: _upload_blobber_files 03:09:47 INFO - Blob upload gear active. 03:09:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:09:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:09:47 INFO - (blobuploader) - INFO - Open directory for files ... 03:09:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:09:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:09:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:48 INFO - (blobuploader) - INFO - Done attempting. 03:09:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:09:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:09:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:51 INFO - (blobuploader) - INFO - Done attempting. 03:09:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:09:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:09:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:52 INFO - (blobuploader) - INFO - Done attempting. 03:09:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:09:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:09:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:09:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:09:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:09:53 INFO - (blobuploader) - INFO - Done attempting. 03:09:53 INFO - (blobuploader) - INFO - Iteration through files over. 03:09:53 INFO - Return code: 0 03:09:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:09:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:09:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4098a40ef02a1e4f91dc7e622daf8b2b158eb09d2e9073f4ea641d263cb880d96a35d792abb110aa9b62cd93bf202016b84991ec251445eaeef921afee7ff721", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d3684497c7dd37bd14063070f61ce4e6204ad324d97348a165da8cdc227e7ad3fefda3d3897427511180d03d7713c4dab257a8c38b7556a065f3fd329ca175", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2830d0f4c69170f33e916d64bc056a953e701445b8af2d5790bfae3f1d3416b5de841db48d4dd585b59e6b338abc042893dc27621da4a3758fafcf2ccf0bf68d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8049cdeae270a30a14bf6e9febd3218604d2860199e72d0b7b39bd58ccd6cccd5667f5a98fa29c283c2be9f828d76804c70de7bb64cb2a0e9416501543a1e8f1"} 03:09:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:09:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:09:53 INFO - Contents: 03:09:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4098a40ef02a1e4f91dc7e622daf8b2b158eb09d2e9073f4ea641d263cb880d96a35d792abb110aa9b62cd93bf202016b84991ec251445eaeef921afee7ff721", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d3684497c7dd37bd14063070f61ce4e6204ad324d97348a165da8cdc227e7ad3fefda3d3897427511180d03d7713c4dab257a8c38b7556a065f3fd329ca175", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2830d0f4c69170f33e916d64bc056a953e701445b8af2d5790bfae3f1d3416b5de841db48d4dd585b59e6b338abc042893dc27621da4a3758fafcf2ccf0bf68d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8049cdeae270a30a14bf6e9febd3218604d2860199e72d0b7b39bd58ccd6cccd5667f5a98fa29c283c2be9f828d76804c70de7bb64cb2a0e9416501543a1e8f1"} 03:09:53 INFO - Running post-run listener: copy_logs_to_upload_dir 03:09:53 INFO - Copying logs to upload dir... 03:09:53 INFO - mkdir: /builds/slave/test/build/upload/logs 03:09:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.297053 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-07-27 03:09:53.369923) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 03:09:53.373218) ========= 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=52faae308a556c440401f8e5000001e8-1501148601.213691-514426598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4098a40ef02a1e4f91dc7e622daf8b2b158eb09d2e9073f4ea641d263cb880d96a35d792abb110aa9b62cd93bf202016b84991ec251445eaeef921afee7ff721", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d3684497c7dd37bd14063070f61ce4e6204ad324d97348a165da8cdc227e7ad3fefda3d3897427511180d03d7713c4dab257a8c38b7556a065f3fd329ca175", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2830d0f4c69170f33e916d64bc056a953e701445b8af2d5790bfae3f1d3416b5de841db48d4dd585b59e6b338abc042893dc27621da4a3758fafcf2ccf0bf68d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8049cdeae270a30a14bf6e9febd3218604d2860199e72d0b7b39bd58ccd6cccd5667f5a98fa29c283c2be9f828d76804c70de7bb64cb2a0e9416501543a1e8f1"} build_url:https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011105 build_url: 'https://queue.taskcluster.net/v1/task/Nxl8AhfPQiqKvJ1nVywyHg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4098a40ef02a1e4f91dc7e622daf8b2b158eb09d2e9073f4ea641d263cb880d96a35d792abb110aa9b62cd93bf202016b84991ec251445eaeef921afee7ff721", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d3684497c7dd37bd14063070f61ce4e6204ad324d97348a165da8cdc227e7ad3fefda3d3897427511180d03d7713c4dab257a8c38b7556a065f3fd329ca175", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2830d0f4c69170f33e916d64bc056a953e701445b8af2d5790bfae3f1d3416b5de841db48d4dd585b59e6b338abc042893dc27621da4a3758fafcf2ccf0bf68d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8049cdeae270a30a14bf6e9febd3218604d2860199e72d0b7b39bd58ccd6cccd5667f5a98fa29c283c2be9f828d76804c70de7bb64cb2a0e9416501543a1e8f1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-27 03:09:53.397494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 03:09:53.397835) ========= 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=52faae308a556c440401f8e5000001e8-1501148601.213691-514426598 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-27 03:09:53.479784) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 03:09:53.480111) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-27 03:09:53.480389) ========= ========= Total master_lag: 0.17 =========