builder: mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s slave: talos-linux64-ix-056 starttime: 1502879753.64 results: success (0) revision: 6ebc251bd288c268b020815025b05854ccde5c08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:53.637736) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:53.638240) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:53.638532) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:53.654518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:53.654881) ========= 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-1502879753.581678-261821074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 03:35:54-- 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% 226M=0s 2017-08-16 03:35:54 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124370 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:53.794595) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:53.794927) ========= 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-1502879753.581678-261821074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016908 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:53.844783) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:53.845129) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6ebc251bd288c268b020815025b05854ccde5c08 --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 6ebc251bd288c268b020815025b05854ccde5c08 --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-1502879753.581678-261821074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 03:35:54,492 truncating revision to first 12 chars 2017-08-16 03:35:54,492 Setting DEBUG logging. 2017-08-16 03:35:54,493 attempt 1/10 2017-08-16 03:35:54,493 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6ebc251bd288?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-16 03:35:55,166 unpacking tar archive at: mozilla-central-6ebc251bd288/testing/mozharness/ program finished with exit code 0 elapsedTime=0.984011 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:54.843182) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:54.843503) ========= script_repo_revision: 6ebc251bd288c268b020815025b05854ccde5c08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:54.843887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:54.844153) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:35:54.854075) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-16 03:35:54.854362) ========= /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-1502879753.581678-261821074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:35:55 INFO - MultiFileLogger online at 20170816 03:35:55 in /builds/slave/test 03:35:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:35:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:35:55 INFO - {'append_to_log': False, 03:35:55 INFO - 'base_work_dir': '/builds/slave/test', 03:35:55 INFO - 'blob_upload_branch': 'Firefox', 03:35:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:35:55 INFO - 'branch': 'Firefox', 03:35:55 INFO - 'buildbot_json_path': 'buildprops.json', 03:35:55 INFO - 'code_coverage': False, 03:35:55 INFO - 'config_files': ('talos/linux_config.py',), 03:35:55 INFO - 'default_actions': ('clobber', 03:35:55 INFO - 'read-buildbot-config', 03:35:55 INFO - 'download-and-extract', 03:35:55 INFO - 'populate-webroot', 03:35:55 INFO - 'create-virtualenv', 03:35:55 INFO - 'install', 03:35:55 INFO - 'setup-mitmproxy', 03:35:55 INFO - 'run-tests'), 03:35:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:35:55 INFO - 'disable_ccov_upload': False, 03:35:55 INFO - 'download_minidump_stackwalk': True, 03:35:55 INFO - 'download_symbols': 'ondemand', 03:35:55 INFO - 'enable_stylo': False, 03:35:55 INFO - 'enable_webrender': False, 03:35:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:35:55 INFO - 'tooltool.py': '/tools/tooltool.py', 03:35:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:35:55 INFO - '/tools/misc-python/virtualenv.py')}, 03:35:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:35:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:35:55 INFO - 'gecko_profile': False, 03:35:55 INFO - 'gecko_profile_interval': 0, 03:35:55 INFO - 'installer_path': 'installer.exe', 03:35:55 INFO - 'log_level': 'info', 03:35:55 INFO - 'log_name': 'talos', 03:35:55 INFO - 'log_to_console': True, 03:35:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:35:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:35:55 INFO - 'opt_config_files': (), 03:35:55 INFO - 'pip_index': False, 03:35:55 INFO - 'suite': 'dromaeojs-e10s', 03:35:55 INFO - 'system_bits': '32', 03:35:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:35:55 INFO - 'title': 'talos-linux64-ix-056', 03:35:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:35:55 INFO - 'use_talos_json': True, 03:35:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:35:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:35:55 INFO - 'work_dir': 'build'} 03:35:55 INFO - [mozharness: 2017-08-16 10:35:55.602252Z] Running clobber step. 03:35:55 INFO - Running pre-action listener: _resource_record_pre_action 03:35:55 INFO - Running main action method: clobber 03:35:55 INFO - rmtree: /builds/slave/test/build 03:35:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:35:57 INFO - Running post-action listener: _resource_record_post_action 03:35:57 INFO - [mozharness: 2017-08-16 10:35:57.308518Z] Finished clobber step (success) 03:35:57 INFO - [mozharness: 2017-08-16 10:35:57.308621Z] Running read-buildbot-config step. 03:35:57 INFO - Running pre-action listener: _resource_record_pre_action 03:35:57 INFO - Running main action method: read_buildbot_config 03:35:57 INFO - Using buildbot properties: 03:35:57 INFO - { 03:35:57 INFO - "project": "", 03:35:57 INFO - "product": "firefox", 03:35:57 INFO - "who": "cbook@mozilla.com", 03:35:57 INFO - "installer_path": "public/build/target.tar.bz2", 03:35:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_qr_test-dromaeojs-e10s", 03:35:57 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:35:57 INFO - "buildername": "Ubuntu HW 12.04 x64 qr mozilla-central talos dromaeojs-e10s", 03:35:57 INFO - "stage_platform": "linux64-qr", 03:35:57 INFO - "basedir": "/builds/slave/test", 03:35:57 INFO - "buildnumber": 1, 03:35:57 INFO - "platform": "ubuntu64_hw_qr", 03:35:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:35:57 INFO - "slavebuilddir": "test", 03:35:57 INFO - "taskId": "Dl3xsenOS_qF94UpOoD80w", 03:35:57 INFO - "branch": "mozilla-central", 03:35:57 INFO - "script_repo_revision": "production", 03:35:57 INFO - "revision": "6ebc251bd288c268b020815025b05854ccde5c08", 03:35:57 INFO - "slavename": "talos-linux64-ix-056", 03:35:57 INFO - "repo_path": "mozilla-central" 03:35:57 INFO - } 03:35:57 INFO - Finding installer, test and symbols from parent task. 03:35:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dl3xsenOS_qF94UpOoD80w'}, attempt #1 03:35:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dl3xsenOS_qF94UpOoD80w'}, attempt #1 03:35:58 INFO - Task dependencies: Ik1VZCnkRAKLMf_kMSI2Ig 03:35:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig'}, attempt #1 03:35:58 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 03:35:58 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.test_packages.json 03:35:58 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.crashreporter-symbols.zip 03:35:58 INFO - Running post-action listener: _resource_record_post_action 03:35:58 INFO - [mozharness: 2017-08-16 10:35:58.683316Z] Finished read-buildbot-config step (success) 03:35:58 INFO - [mozharness: 2017-08-16 10:35:58.683578Z] Running download-and-extract step. 03:35:58 INFO - Running pre-action listener: _resource_record_pre_action 03:35:58 INFO - Running main action method: download_and_extract 03:35:58 INFO - mkdir: /builds/slave/test/build/tests 03:35:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:35:58 INFO - trying https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.test_packages.json 03:35:58 INFO - Downloading https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:35:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:35:59 INFO - Downloaded 989 bytes. 03:35:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:35:59 INFO - Using the following test package requirements: 03:35:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:35:59 INFO - u'common': [u'target.common.tests.zip'], 03:35:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:35:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:35:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:35:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:35:59 INFO - u'mozbase': [u'target.common.tests.zip'], 03:35:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:35:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:35:59 INFO - u'web-platform': [u'target.common.tests.zip', 03:35:59 INFO - u'target.web-platform.tests.tar.gz'], 03:35:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:35:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:35:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.common.tests.zip 03:35:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:35:59 INFO - Fetch https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.common.tests.zip into memory 03:36:00 INFO - Content-Length response header: 54003804 03:36:00 INFO - Bytes received: 54003804 03:36:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:36:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.common.tests.zip 03:36:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:36:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.common.tests.zip into memory 03:36:12 INFO - Content-Length response header: 54003804 03:36:12 INFO - Bytes received: 54003804 03:36:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.talos.tests.zip 03:36:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:36:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.talos.tests.zip into memory 03:36:25 INFO - Content-Length response header: 14496050 03:36:25 INFO - Bytes received: 14496050 03:36:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:25 INFO - trying https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 03:36:25 INFO - Downloading https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:36:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:36:26 INFO - Downloaded 61804821 bytes. 03:36:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 03:36:26 INFO - mkdir: /builds/slave/test/properties 03:36:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:36:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:36:26 INFO - Contents: 03:36:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 03:36:26 INFO - Running post-action listener: _resource_record_post_action 03:36:26 INFO - Running post-action listener: set_extra_try_arguments 03:36:26 INFO - [mozharness: 2017-08-16 10:36:26.418138Z] Finished download-and-extract step (success) 03:36:26 INFO - [mozharness: 2017-08-16 10:36:26.418237Z] Running populate-webroot step. 03:36:26 INFO - Running pre-action listener: _resource_record_pre_action 03:36:26 INFO - Running main action method: populate_webroot 03:36:26 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:36:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:36:26 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:36:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:36:26 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:36:26 INFO - 'tests': ['damp', 'tps']}, 03:36:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:36:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:36:26 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:36:26 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:36:26 INFO - 'other-e10s': {'tests': ['a11yr', 03:36:26 INFO - 'ts_paint', 03:36:26 INFO - 'tpaint', 03:36:26 INFO - 'sessionrestore', 03:36:26 INFO - 'sessionrestore_many_windows', 03:36:26 INFO - 'sessionrestore_no_auto_restore', 03:36:26 INFO - 'tabpaint']}, 03:36:26 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:36:26 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:36:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:36:26 INFO - 'tsvgr_opacity', 03:36:26 INFO - 'tart', 03:36:26 INFO - 'tscrollx', 03:36:26 INFO - 'tsvg_static']}, 03:36:26 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:36:26 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:36:26 INFO - 'talos_options': ['--mitmproxy', 03:36:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:36:26 INFO - '--firstNonBlankPaint'], 03:36:26 INFO - 'tests': ['tp6_google', 03:36:26 INFO - 'tp6_youtube', 03:36:26 INFO - 'tp6_amazon', 03:36:26 INFO - 'tp6_facebook']}, 03:36:26 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:36:26 INFO - 'talos_options': ['--stylo', 03:36:26 INFO - '--mitmproxy', 03:36:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:36:26 INFO - '--firstNonBlankPaint'], 03:36:26 INFO - 'tests': ['tp6_google', 03:36:26 INFO - 'tp6_youtube', 03:36:26 INFO - 'tp6_amazon', 03:36:26 INFO - 'tp6_facebook']}, 03:36:26 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:36:26 INFO - 'talos_options': ['--stylo', 03:36:26 INFO - '--stylo-threads=1', 03:36:26 INFO - '--mitmproxy', 03:36:26 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:36:26 INFO - '--firstNonBlankPaint'], 03:36:26 INFO - 'tests': ['tp6_google', 03:36:26 INFO - 'tp6_youtube', 03:36:26 INFO - 'tp6_amazon', 03:36:26 INFO - 'tp6_facebook']}, 03:36:26 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:36:26 INFO - 'talos_options': ['--xperf_path', 03:36:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:36:26 INFO - 'tests': ['tp5n']}}} 03:36:26 INFO - Running post-action listener: _resource_record_post_action 03:36:26 INFO - [mozharness: 2017-08-16 10:36:26.426765Z] Finished populate-webroot step (success) 03:36:26 INFO - [mozharness: 2017-08-16 10:36:26.426858Z] Running create-virtualenv step. 03:36:26 INFO - Running pre-action listener: _resource_record_pre_action 03:36:26 INFO - Running main action method: create_virtualenv 03:36:26 INFO - Creating virtualenv /builds/slave/test/build/venv 03:36:26 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:36:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:36:26 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:36:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:36:26 INFO - Using real prefix '/usr' 03:36:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:36:27 INFO - Installing distribute.............................................................................................................................................................................................done. 03:36:29 INFO - Installing pip.................done. 03:36:29 INFO - Return code: 0 03:36:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:36:29 INFO - Reading from file tmpfile_stdout 03:36:29 INFO - Output received: 03:36:29 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:36:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:29 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e0b0>, '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 0x246efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f440>, '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-1502879753.581678-261821074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:36:29 INFO - Using env: {'DISPLAY': ':0', 03:36:29 INFO - 'HOME': '/home/cltbld', 03:36:29 INFO - 'LANG': 'en_US.UTF-8', 03:36:29 INFO - 'LANGUAGE': 'en_US:en', 03:36:29 INFO - 'LOGNAME': 'cltbld', 03:36:29 INFO - 'MAIL': '/var/mail/cltbld', 03:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:29 INFO - 'MOZ_NO_REMOTE': '1', 03:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:29 INFO - 'NO_EM_RESTART': '1', 03:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:29 INFO - 'PWD': '/builds/slave/test', 03:36:29 INFO - 'SHELL': '/bin/bash', 03:36:29 INFO - 'SHLVL': '1', 03:36:29 INFO - 'TERM': 'linux', 03:36:29 INFO - 'TMOUT': '86400', 03:36:29 INFO - 'USER': 'cltbld', 03:36:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502879753.581678-261821074', 03:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:29 INFO - '_': '/tools/buildbot/bin/python'} 03:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:29 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:36:29 INFO - Cleaning up... 03:36:29 INFO - Return code: 0 03:36:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:29 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e0b0>, '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 0x246efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f440>, '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-1502879753.581678-261821074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:36:29 INFO - Using env: {'DISPLAY': ':0', 03:36:29 INFO - 'HOME': '/home/cltbld', 03:36:29 INFO - 'LANG': 'en_US.UTF-8', 03:36:29 INFO - 'LANGUAGE': 'en_US:en', 03:36:29 INFO - 'LOGNAME': 'cltbld', 03:36:29 INFO - 'MAIL': '/var/mail/cltbld', 03:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:29 INFO - 'MOZ_NO_REMOTE': '1', 03:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:29 INFO - 'NO_EM_RESTART': '1', 03:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:29 INFO - 'PWD': '/builds/slave/test', 03:36:29 INFO - 'SHELL': '/bin/bash', 03:36:29 INFO - 'SHLVL': '1', 03:36:29 INFO - 'TERM': 'linux', 03:36:29 INFO - 'TMOUT': '86400', 03:36:29 INFO - 'USER': 'cltbld', 03:36:29 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502879753.581678-261821074', 03:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:29 INFO - '_': '/tools/buildbot/bin/python'} 03:36:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:30 INFO - Downloading/unpacking psutil>=3.1.1 03:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:36:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:31 INFO - Installing collected packages: psutil 03:36:31 INFO - Running setup.py install for psutil 03:36:31 INFO - building 'psutil._psutil_linux' extension 03:36:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:36:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:36:31 INFO - building 'psutil._psutil_posix' extension 03:36:31 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:36:31 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:36:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:36:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:36:31 INFO - Successfully installed psutil 03:36:31 INFO - Cleaning up... 03:36:31 INFO - Return code: 0 03:36:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:31 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e0b0>, '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 0x246efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f440>, '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-1502879753.581678-261821074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:36:31 INFO - Using env: {'DISPLAY': ':0', 03:36:31 INFO - 'HOME': '/home/cltbld', 03:36:31 INFO - 'LANG': 'en_US.UTF-8', 03:36:31 INFO - 'LANGUAGE': 'en_US:en', 03:36:31 INFO - 'LOGNAME': 'cltbld', 03:36:31 INFO - 'MAIL': '/var/mail/cltbld', 03:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:31 INFO - 'MOZ_NO_REMOTE': '1', 03:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:31 INFO - 'NO_EM_RESTART': '1', 03:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:31 INFO - 'PWD': '/builds/slave/test', 03:36:31 INFO - 'SHELL': '/bin/bash', 03:36:31 INFO - 'SHLVL': '1', 03:36:31 INFO - 'TERM': 'linux', 03:36:31 INFO - 'TMOUT': '86400', 03:36:31 INFO - 'USER': 'cltbld', 03:36:31 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502879753.581678-261821074', 03:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:31 INFO - '_': '/tools/buildbot/bin/python'} 03:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:36:33 INFO - Installing collected packages: mozsystemmonitor 03:36:33 INFO - Running setup.py install for mozsystemmonitor 03:36:33 INFO - Successfully installed mozsystemmonitor 03:36:33 INFO - Cleaning up... 03:36:33 INFO - Return code: 0 03:36:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:36: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')]} 03:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36: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')]} 03:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36: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', '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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e0b0>, '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 0x246efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f440>, '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-1502879753.581678-261821074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:36: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 jsonschema==2.5.1 03:36:33 INFO - Using env: {'DISPLAY': ':0', 03:36:33 INFO - 'HOME': '/home/cltbld', 03:36:33 INFO - 'LANG': 'en_US.UTF-8', 03:36:33 INFO - 'LANGUAGE': 'en_US:en', 03:36:33 INFO - 'LOGNAME': 'cltbld', 03:36:33 INFO - 'MAIL': '/var/mail/cltbld', 03:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:33 INFO - 'MOZ_NO_REMOTE': '1', 03:36:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:33 INFO - 'NO_EM_RESTART': '1', 03:36:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:33 INFO - 'PWD': '/builds/slave/test', 03:36:33 INFO - 'SHELL': '/bin/bash', 03:36:33 INFO - 'SHLVL': '1', 03:36:33 INFO - 'TERM': 'linux', 03:36:33 INFO - 'TMOUT': '86400', 03:36:33 INFO - 'USER': 'cltbld', 03:36:33 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502879753.581678-261821074', 03:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:33 INFO - '_': '/tools/buildbot/bin/python'} 03:36:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:33 INFO - Downloading/unpacking jsonschema==2.5.1 03:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:36:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:34 INFO - Downloading functools32-3.2.3-2.tar.gz 03:36:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:36:34 INFO - warning: no files found matching '*.txt' 03:36:34 INFO - no previously-included directories found matching 'build' 03:36:34 INFO - no previously-included directories found matching 'dist' 03:36:34 INFO - no previously-included directories found matching '.git*' 03:36:34 INFO - Installing collected packages: jsonschema, functools32 03:36:34 INFO - Running setup.py install for functools32 03:36:34 INFO - warning: no files found matching '*.txt' 03:36:34 INFO - no previously-included directories found matching 'build' 03:36:34 INFO - no previously-included directories found matching 'dist' 03:36:34 INFO - no previously-included directories found matching '.git*' 03:36:34 INFO - Successfully installed jsonschema functools32 03:36:34 INFO - Cleaning up... 03:36:35 INFO - Return code: 0 03:36:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:35 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e0b0>, '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 0x246efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f440>, '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-1502879753.581678-261821074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:36:35 INFO - Using env: {'DISPLAY': ':0', 03:36:35 INFO - 'HOME': '/home/cltbld', 03:36:35 INFO - 'LANG': 'en_US.UTF-8', 03:36:35 INFO - 'LANGUAGE': 'en_US:en', 03:36:35 INFO - 'LOGNAME': 'cltbld', 03:36:35 INFO - 'MAIL': '/var/mail/cltbld', 03:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:35 INFO - 'MOZ_NO_REMOTE': '1', 03:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:35 INFO - 'NO_EM_RESTART': '1', 03:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:35 INFO - 'PWD': '/builds/slave/test', 03:36:35 INFO - 'SHELL': '/bin/bash', 03:36:35 INFO - 'SHLVL': '1', 03:36:35 INFO - 'TERM': 'linux', 03:36:35 INFO - 'TMOUT': '86400', 03:36:35 INFO - 'USER': 'cltbld', 03:36:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502879753.581678-261821074', 03:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:35 INFO - '_': '/tools/buildbot/bin/python'} 03:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:36:35 INFO - Cleaning up... 03:36:35 INFO - Return code: 0 03:36:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:35 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e0b0>, '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 0x246efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f440>, '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-1502879753.581678-261821074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:36:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:36:35 INFO - Using env: {'DISPLAY': ':0', 03:36:35 INFO - 'HOME': '/home/cltbld', 03:36:35 INFO - 'LANG': 'en_US.UTF-8', 03:36:35 INFO - 'LANGUAGE': 'en_US:en', 03:36:35 INFO - 'LOGNAME': 'cltbld', 03:36:35 INFO - 'MAIL': '/var/mail/cltbld', 03:36:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:35 INFO - 'MOZ_NO_REMOTE': '1', 03:36:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:35 INFO - 'NO_EM_RESTART': '1', 03:36:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:35 INFO - 'PWD': '/builds/slave/test', 03:36:35 INFO - 'SHELL': '/bin/bash', 03:36:35 INFO - 'SHLVL': '1', 03:36:35 INFO - 'TERM': 'linux', 03:36:35 INFO - 'TMOUT': '86400', 03:36:35 INFO - 'USER': 'cltbld', 03:36:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502879753.581678-261821074', 03:36:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:35 INFO - '_': '/tools/buildbot/bin/python'} 03:36:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:35 INFO - Downloading/unpacking blobuploader==1.2.4 03:36: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 03:36: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 03:36: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 03:36: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 03:36:36 INFO - Downloading blobuploader-1.2.4.tar.gz 03:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:36:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:36:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:37 INFO - Downloading docopt-0.6.1.tar.gz 03:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:36:37 INFO - Installing collected packages: blobuploader, requests, docopt 03:36:37 INFO - Running setup.py install for blobuploader 03:36:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:36:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:36:37 INFO - Running setup.py install for requests 03:36:37 INFO - Running setup.py install for docopt 03:36:37 INFO - Successfully installed blobuploader requests docopt 03:36:37 INFO - Cleaning up... 03:36:37 INFO - Return code: 0 03:36:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:37 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e0b0>, '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 0x246efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f440>, '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-1502879753.581678-261821074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:37 INFO - Using env: {'DISPLAY': ':0', 03:36:37 INFO - 'HOME': '/home/cltbld', 03:36:37 INFO - 'LANG': 'en_US.UTF-8', 03:36:37 INFO - 'LANGUAGE': 'en_US:en', 03:36:37 INFO - 'LOGNAME': 'cltbld', 03:36:37 INFO - 'MAIL': '/var/mail/cltbld', 03:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:37 INFO - 'MOZ_NO_REMOTE': '1', 03:36:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:37 INFO - 'NO_EM_RESTART': '1', 03:36:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:37 INFO - 'PWD': '/builds/slave/test', 03:36:37 INFO - 'SHELL': '/bin/bash', 03:36:37 INFO - 'SHLVL': '1', 03:36:37 INFO - 'TERM': 'linux', 03:36:37 INFO - 'TMOUT': '86400', 03:36:37 INFO - 'USER': 'cltbld', 03:36:37 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502879753.581678-261821074', 03:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:37 INFO - '_': '/tools/buildbot/bin/python'} 03:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:37 INFO - Running setup.py (path:/tmp/pip-mrd6gh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:38 INFO - Running setup.py (path:/tmp/pip-LTO7Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:38 INFO - Running setup.py (path:/tmp/pip-ukhkO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:38 INFO - Running setup.py (path:/tmp/pip-VcktZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:38 INFO - Running setup.py (path:/tmp/pip-4YAfZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:38 INFO - Running setup.py (path:/tmp/pip-exv76T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:38 INFO - Running setup.py (path:/tmp/pip-oYTvdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:38 INFO - Running setup.py (path:/tmp/pip-b_j_a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:38 INFO - Running setup.py (path:/tmp/pip-xCTja7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:38 INFO - Running setup.py (path:/tmp/pip-clnajJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:38 INFO - Running setup.py (path:/tmp/pip-vYDDfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:38 INFO - Running setup.py (path:/tmp/pip-UiyaVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:38 INFO - Running setup.py (path:/tmp/pip-Oez6Qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:38 INFO - Running setup.py (path:/tmp/pip-KBqRx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:38 INFO - Running setup.py (path:/tmp/pip-5Kpy1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:39 INFO - Running setup.py (path:/tmp/pip-GbKpdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:39 INFO - Running setup.py (path:/tmp/pip-jHiF0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:36:39 INFO - Running setup.py install for manifestparser 03:36:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:36:39 INFO - Running setup.py install for mozcrash 03:36:39 INFO - Running setup.py install for mozdebug 03:36:39 INFO - Running setup.py install for mozdevice 03:36:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:36:39 INFO - Running setup.py install for mozfile 03:36:39 INFO - Running setup.py install for mozhttpd 03:36:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:36:39 INFO - Running setup.py install for mozinfo 03:36:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:36:39 INFO - Running setup.py install for mozInstall 03:36:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:36:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:36:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:36:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:36:39 INFO - Running setup.py install for mozleak 03:36:40 INFO - Running setup.py install for mozlog 03:36:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:36:40 INFO - Running setup.py install for moznetwork 03:36:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:36:40 INFO - Running setup.py install for mozprocess 03:36:40 INFO - Running setup.py install for mozprofile 03:36:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:36:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:36:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:36:40 INFO - Running setup.py install for mozrunner 03:36:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:36:40 INFO - Running setup.py install for mozscreenshot 03:36:40 INFO - Running setup.py install for moztest 03:36:40 INFO - Running setup.py install for mozversion 03:36:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:36:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:36:40 INFO - Cleaning up... 03:36:40 INFO - Return code: 0 03:36:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:40 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e0b0>, '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 0x246efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f440>, '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-1502879753.581678-261821074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:36:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:40 INFO - Using env: {'DISPLAY': ':0', 03:36:40 INFO - 'HOME': '/home/cltbld', 03:36:40 INFO - 'LANG': 'en_US.UTF-8', 03:36:40 INFO - 'LANGUAGE': 'en_US:en', 03:36:40 INFO - 'LOGNAME': 'cltbld', 03:36:40 INFO - 'MAIL': '/var/mail/cltbld', 03:36:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:40 INFO - 'MOZ_NO_REMOTE': '1', 03:36:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:40 INFO - 'NO_EM_RESTART': '1', 03:36:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:40 INFO - 'PWD': '/builds/slave/test', 03:36:40 INFO - 'SHELL': '/bin/bash', 03:36:40 INFO - 'SHLVL': '1', 03:36:40 INFO - 'TERM': 'linux', 03:36:40 INFO - 'TMOUT': '86400', 03:36:40 INFO - 'USER': 'cltbld', 03:36:40 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502879753.581678-261821074', 03:36:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:40 INFO - '_': '/tools/buildbot/bin/python'} 03:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:36:41 INFO - Running setup.py (path:/tmp/pip-RZnVNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:36:41 INFO - Running setup.py (path:/tmp/pip-L6QsiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:36:41 INFO - Running setup.py (path:/tmp/pip-IqGUup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:36:41 INFO - Running setup.py (path:/tmp/pip-sCiLwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:36:41 INFO - Running setup.py (path:/tmp/pip-QtMNx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:36:41 INFO - Running setup.py (path:/tmp/pip-iwr7q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:36:41 INFO - Running setup.py (path:/tmp/pip-rt6FMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:36:41 INFO - Running setup.py (path:/tmp/pip-zr38rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:36:41 INFO - Running setup.py (path:/tmp/pip-oGY9lD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:36:41 INFO - Running setup.py (path:/tmp/pip-fDYtWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:36:41 INFO - Running setup.py (path:/tmp/pip-h2xY6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:36:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:36:41 INFO - Running setup.py (path:/tmp/pip-4Vye4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:36:42 INFO - Running setup.py (path:/tmp/pip-IH5Fhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:36:42 INFO - Running setup.py (path:/tmp/pip-ypqKhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:42 INFO - Running setup.py (path:/tmp/pip-8lA8jK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:36:42 INFO - Running setup.py (path:/tmp/pip-oLACsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:36:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:36:42 INFO - Running setup.py (path:/tmp/pip-KG4NrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:36:42 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:36:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:36:43 INFO - Downloading blessings-1.6.tar.gz 03:36:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:36:43 INFO - Installing collected packages: blessings 03:36:43 INFO - Running setup.py install for blessings 03:36:43 INFO - Successfully installed blessings 03:36:43 INFO - Cleaning up... 03:36:43 INFO - Return code: 0 03:36:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:36:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:43 INFO - Reading from file tmpfile_stdout 03:36:43 INFO - Current package versions: 03:36:43 INFO - argparse == 1.2.1 03:36:43 INFO - blessings == 1.6 03:36:43 INFO - blobuploader == 1.2.4 03:36:43 INFO - docopt == 0.6.1 03:36:43 INFO - functools32 == 3.2.3-2 03:36:43 INFO - jsonschema == 2.5.1 03:36:43 INFO - manifestparser == 1.1 03:36:43 INFO - mozInstall == 1.13 03:36:43 INFO - mozcrash == 1.0 03:36:43 INFO - mozdebug == 0.1 03:36:43 INFO - mozdevice == 0.51 03:36:43 INFO - mozfile == 1.2 03:36:43 INFO - mozhttpd == 0.7 03:36:43 INFO - mozinfo == 0.10 03:36:43 INFO - mozleak == 0.1 03:36:43 INFO - mozlog == 3.5 03:36:43 INFO - moznetwork == 0.27 03:36:43 INFO - mozprocess == 0.25 03:36:43 INFO - mozprofile == 0.28 03:36:43 INFO - mozrunner == 6.13 03:36:43 INFO - mozscreenshot == 0.1 03:36:43 INFO - mozsystemmonitor == 0.3 03:36:43 INFO - moztest == 0.8 03:36:43 INFO - mozversion == 1.4 03:36:43 INFO - psutil == 3.1.1 03:36:43 INFO - requests == 1.2.3 03:36:43 INFO - wsgiref == 0.1.2 03:36:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:43 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e0b0>, '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 0x246efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f440>, '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-1502879753.581678-261821074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:36:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:36:43 INFO - Using env: {'DISPLAY': ':0', 03:36:43 INFO - 'HOME': '/home/cltbld', 03:36:43 INFO - 'LANG': 'en_US.UTF-8', 03:36:43 INFO - 'LANGUAGE': 'en_US:en', 03:36:43 INFO - 'LOGNAME': 'cltbld', 03:36:43 INFO - 'MAIL': '/var/mail/cltbld', 03:36:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:44 INFO - 'MOZ_NO_REMOTE': '1', 03:36:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:44 INFO - 'NO_EM_RESTART': '1', 03:36:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:44 INFO - 'PWD': '/builds/slave/test', 03:36:44 INFO - 'SHELL': '/bin/bash', 03:36:44 INFO - 'SHLVL': '1', 03:36:44 INFO - 'TERM': 'linux', 03:36:44 INFO - 'TMOUT': '86400', 03:36:44 INFO - 'USER': 'cltbld', 03:36:44 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502879753.581678-261821074', 03:36:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:44 INFO - '_': '/tools/buildbot/bin/python'} 03:36:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:36:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:36:44 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:36: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 03:36: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 03:36: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 03:36: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 03:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:36:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:36:45 INFO - Installing collected packages: simplejson 03:36:45 INFO - Running setup.py install for simplejson 03:36:45 INFO - building 'simplejson._speedups' extension 03:36:45 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:36:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:36:46 INFO - Successfully installed simplejson 03:36:46 INFO - Cleaning up... 03:36:46 INFO - Return code: 0 03:36:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:36:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:36:46 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 0x21c91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cda80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2470ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246e0b0>, '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 0x246efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f440>, '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-1502879753.581678-261821074', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:36:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:36:46 INFO - Using env: {'DISPLAY': ':0', 03:36:46 INFO - 'HOME': '/home/cltbld', 03:36:46 INFO - 'LANG': 'en_US.UTF-8', 03:36:46 INFO - 'LANGUAGE': 'en_US:en', 03:36:46 INFO - 'LOGNAME': 'cltbld', 03:36:46 INFO - 'MAIL': '/var/mail/cltbld', 03:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:36:46 INFO - 'MOZ_NO_REMOTE': '1', 03:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:36:46 INFO - 'NO_EM_RESTART': '1', 03:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:36:46 INFO - 'PWD': '/builds/slave/test', 03:36:46 INFO - 'SHELL': '/bin/bash', 03:36:46 INFO - 'SHLVL': '1', 03:36:46 INFO - 'TERM': 'linux', 03:36:46 INFO - 'TMOUT': '86400', 03:36:46 INFO - 'USER': 'cltbld', 03:36:46 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502879753.581678-261821074', 03:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:36:46 INFO - '_': '/tools/buildbot/bin/python'} 03:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:36:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:36:46 INFO - Cleaning up... 03:36:46 INFO - Return code: 0 03:36:46 INFO - Running post-action listener: _resource_record_post_action 03:36:46 INFO - Running post-action listener: _start_resource_monitoring 03:36:46 INFO - Starting resource monitoring. 03:36:46 INFO - [mozharness: 2017-08-16 10:36:46.708728Z] Finished create-virtualenv step (success) 03:36:46 INFO - [mozharness: 2017-08-16 10:36:46.709318Z] Running install step. 03:36:46 INFO - Running pre-action listener: _resource_record_pre_action 03:36:46 INFO - Running main action method: install 03:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:36:46 INFO - Reading from file tmpfile_stdout 03:36:46 INFO - Detecting whether we're running mozinstall >=1.0... 03:36:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:36:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:36:47 INFO - Reading from file tmpfile_stdout 03:36:47 INFO - Output received: 03:36:47 INFO - Usage: mozinstall [options] installer 03:36:47 INFO - Options: 03:36:47 INFO - -h, --help show this help message and exit 03:36:47 INFO - -d DEST, --destination=DEST 03:36:47 INFO - Directory to install application into. [default: 03:36:47 INFO - "/builds/slave/test"] 03:36:47 INFO - --app=APP Application being installed. [default: firefox] 03:36:47 INFO - mkdir: /builds/slave/test/build/application 03:36:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:36:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:37:05 INFO - Reading from file tmpfile_stdout 03:37:05 INFO - Output received: 03:37:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:37:05 INFO - Running post-action listener: _resource_record_post_action 03:37:05 INFO - [mozharness: 2017-08-16 10:37:05.013233Z] Finished install step (success) 03:37:05 INFO - [mozharness: 2017-08-16 10:37:05.013517Z] Running setup-mitmproxy step. 03:37:05 INFO - Running pre-action listener: _resource_record_pre_action 03:37:05 INFO - Running main action method: setup_mitmproxy 03:37:05 INFO - Skipping: mitmproxy is not required 03:37:05 INFO - Running post-action listener: _resource_record_post_action 03:37:05 INFO - [mozharness: 2017-08-16 10:37:05.014688Z] Finished setup-mitmproxy step (success) 03:37:05 INFO - [mozharness: 2017-08-16 10:37:05.014912Z] Running run-tests step. 03:37:05 INFO - Running pre-action listener: _resource_record_pre_action 03:37:05 INFO - Running pre-action listener: _set_gcov_prefix 03:37:05 INFO - Running main action method: run_tests 03:37:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:37:05 INFO - Python 2.7.3 03:37:05 INFO - Return code: 0 03:37:05 INFO - grabbing minidump binary from tooltool 03:37:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:37:05 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 0x246e0b0>, '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 0x246efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x246f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:37:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:37:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:37:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:37:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:37:05 INFO - Return code: 0 03:37:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:37:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:37:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:37:05 INFO - ENV: RUST_BACKTRACE is now full 03:37:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:37:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:37:05 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/Ik1VZCnkRAKLMf_kMSI2Ig/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 03:37:05 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/Ik1VZCnkRAKLMf_kMSI2Ig/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 03:37:05 INFO - Using env: {'DISPLAY': ':0', 03:37:05 INFO - 'HOME': '/home/cltbld', 03:37:05 INFO - 'LANG': 'en_US.UTF-8', 03:37:05 INFO - 'LANGUAGE': 'en_US:en', 03:37:05 INFO - 'LOGNAME': 'cltbld', 03:37:05 INFO - 'MAIL': '/var/mail/cltbld', 03:37:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:37:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:37:05 INFO - 'MOZ_ACCELERATED': '1', 03:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:37:05 INFO - 'MOZ_NO_REMOTE': '1', 03:37:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:37:05 INFO - 'MOZ_WEBRENDER': '1', 03:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:37:05 INFO - 'NO_EM_RESTART': '1', 03:37:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:37:05 INFO - 'PWD': '/builds/slave/test', 03:37:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:37:05 INFO - 'RUST_BACKTRACE': 'full', 03:37:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:37:05 INFO - 'SHELL': '/bin/bash', 03:37:05 INFO - 'SHLVL': '1', 03:37:05 INFO - 'TERM': 'linux', 03:37:05 INFO - 'TMOUT': '86400', 03:37:05 INFO - 'USER': 'cltbld', 03:37:05 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1502879753.581678-261821074', 03:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:37:05 INFO - '_': '/tools/buildbot/bin/python'} 03:37:05 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/Ik1VZCnkRAKLMf_kMSI2Ig/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 03:37:05 INFO - mozversion application_buildid: 20170816092342 03:37:05 INFO - mozversion application_changeset: 6ebc251bd288c268b020815025b05854ccde5c08 03:37:05 INFO - mozversion application_display_name: Nightly 03:37:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:37:05 INFO - mozversion application_name: Firefox 03:37:05 INFO - mozversion application_remotingname: firefox 03:37:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:37:05 INFO - mozversion application_vendor: Mozilla 03:37:05 INFO - mozversion application_version: 57.0a1 03:37:05 INFO - mozversion platform_buildid: 20170816092342 03:37:05 INFO - mozversion platform_changeset: 6ebc251bd288c268b020815025b05854ccde5c08 03:37:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:37:05 INFO - mozversion platform_version: 57.0a1 03:37:05 INFO - using testdate: 1502879825 03:37:05 INFO - actual date: 1502879825 03:37:05 INFO - starting webserver on 'localhost:34008' 03:37:05 INFO - SUITE-START | Running 2 tests 03:37:05 INFO - TEST-START | dromaeo_css 03:37:05 INFO - Initialising browser for dromaeo_css test... 03:37:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34008/getInfo.html -profile /tmp/tmpWEAxiR/profile 03:37:05 INFO - TEST-INFO | started process 26324 (/builds/slave/test/build/application/firefox/firefox http://localhost:34008/getInfo.html) 03:37:12 INFO - TEST-INFO | 26324: exit 0 03:37:12 INFO - Browser initialized. 03:37:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:37:12 INFO - TEST-INFO | started process 26544 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWEAxiR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:13 INFO - PID 26544 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:37:13 INFO - PID 26544 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:37:13 INFO - PID 26544 | 03:37:13 INFO - PID 26544 | (/builds/slave/test/build/application/firefox/firefox:26602): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:37:13 INFO - PID 26544 | 03:37:24 INFO - PID 26544 | RSS: Main: 195047424 03:37:24 INFO - PID 26544 | 03:37:27 INFO - PID 26544 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:40:22 INFO - PID 26544 | Cycle 1(1): loaded http://localhost:34008/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34008/tests/dromaeo/cssquery-ext.html) 03:40:24 INFO - PID 26544 | RSS: Main: 225153024 03:40:24 INFO - PID 26544 | 03:43:27 INFO - PID 26544 | Cycle 1(1): loaded http://localhost:34008/tests/dromaeo/cssquery-ext.html (next: http://localhost:34008/tests/dromaeo/cssquery-jquery.html) 03:43:27 INFO - PID 26544 | RSS: Main: 225316864 03:43:27 INFO - PID 26544 | 03:46:29 INFO - PID 26544 | Cycle 1(1): loaded http://localhost:34008/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34008/tests/dromaeo/cssquery-mootools.html) 03:46:30 INFO - PID 26544 | RSS: Main: 278421504 03:46:30 INFO - PID 26544 | 03:49:32 INFO - PID 26544 | Cycle 1(1): loaded http://localhost:34008/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34008/tests/dromaeo/cssquery-prototype.html) 03:49:33 INFO - PID 26544 | RSS: Main: 276459520 03:49:33 INFO - PID 26544 | 03:52:37 INFO - PID 26544 | Cycle 1(1): loaded http://localhost:34008/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34008/tests/dromaeo/cssquery-yui.html) 03:52:38 INFO - PID 26544 | RSS: Main: 279601152 03:52:38 INFO - PID 26544 | 03:55:40 INFO - PID 26544 | Cycle 1(1): loaded http://localhost:34008/tests/dromaeo/cssquery-yui.html (next: http://localhost:34008/tests/dromaeo/cssquery-dojo.html) 03:55:40 INFO - PID 26544 | RSS: Main: 280330240 03:55:40 INFO - PID 26544 | 03:55:40 INFO - PID 26544 | __start_tp_report 03:55:40 INFO - PID 26544 | _x_x_mozilla_page_load 03:55:40 INFO - PID 26544 | _x_x_mozilla_page_load_details 03:55:40 INFO - PID 26544 | |i|pagename|runs| 03:55:40 INFO - PID 26544 | |0;dojo.html;3100;3112.1908303840996;3117.6258848938132;3134.4828103362947;3173.9365212695743;5957.40425957404;6090.238720159986;6099.5120390368775;6111.633302001872;6122.112293717409;5974.940250597493;6062.211912451375;6069.271687397508;6087.7260523276445;6096.725647345869;5468.207109969052;5514.200440936062;5525.198846167304;5542.39033706292;5571.275734154554;5539.529140023103;5574.136008918604;5574.414686457924;5582.106862901936;5602.8599285018;5550.944490555084;5568.86077848055;5594.552435805126;5599.384067752544;5635.070213414781;5593.944060559383;5595.21666966625;5610.4670056344585;5640.407757185478;5699.344575373802;5444.537214336786;5564.248826408464;5575.637583557056;5623.156526521014;5631.774729010835;5828.358880523139;5953.464188223037;5976.133460648181;6007.219061521974;6072.666003369813;5890.97054514729;6359.96820015897;6402.711877965503;6444.645544495051;6542.084108224853;6489.740410383579;6581.506387020945;6638.103855979478;6657.633830139341;6662.067310576524;6000.849978750479;6092.51259899207;6110;6150.723217455181;6198.101275315054;6621.602703837785;6679.398854103057;6680.699368528428;6705.966470167618;6722.899156512656;6431;6440.935590644033;6486.935130648633;6493.577917435352;6503.382178693017;6427.260865000585;6445.613263204223;6505.154329937172;6508.576942498722;6619;6277.52918531112;6383.138276332728;6407.647579383085;6503.219613646393;6503.967480162663;6473.449756770728;6509.804705858832;6511.576747511492;6518.869622607522;6545.476361891037;5308.150695888639;5323.733813309319;5331.626786124934;5355.946440535623;5380.112281473513;4515.096980603892;4564.726116433025;4568.291914753218;4581.954180458153;4619.145458090264;5570.554355651539;5685.6304340218585;5700.25896633435;5705;5746.138079288056;6331.746730130743;6358.968205159037;6395.328490508429;6400.679966001681;6410.647414392253;5542.307211598551;5556.583256255797;5566.749496272678;5572.331320241597;5581.553475721932;5461.180822876521;5529.944700552943;5531.3362396512675;5554.277943867352;5644.6613203207935;6193.504519638418;6194.783182588588;6208.751649933952;6209.379062093845;6214;5777.566682498914;6328.683565821782;6364;6370.458511026614;6690.264070952288;6412.166418365583;6421.614703117828;6483.7730679425995;6486.416222539994;6535.052417399355;6251.156093927261;6378.968105159444;6443.7744678936015;6451.387118223761;6532.5753826001155;6419.165508483868;6430.3891130342545;6469.191351081115;6471.482281417381;6510.18622672166;5349.384820745664;6242.375762423721;6322.083297921684;6340.365963403623;6432;6249;6365.246739661394;6398.872022559616;6442.2591401989375;6498.642574658439;6237.781677641261;6272.059191121369;6299.4645455135;6319.431251187415;6394.136791533084;6232.563720539519;6247.281562620356;6264.718087686157;6345.90481142774;6376.426121649074;6117.235345581802;6158.907616385847;6166.383361663798;6181.876362472635;6188.659623720739 03:55:40 INFO - PID 26544 | |1;ext.html;767.3745897093868;846.4286606540586;876.259560671233;877.8770972063908;1131.6039386214832;30216.244593885163;30695.846520767365;30764.69235307646;40774.796126019406;41633.37549936753;42206;42387.788061059655;42608.360874586826;42717.572824271745;42847.57152428475;7336.156342020682;7379.262073792618;7536.585487798169;7580.279873412017;7606.923930760677;7388.704451821921;7490.176080631126;7491.66287517063;7499.512531685423;7499.587522686277;7351;7458.4033277337685;7477.364424023937;7480.588567628778;7505.662245198979;7403;7459.776206713807;7471.066116735381;7484.850302993964;7500;7353.669084891193;7363.963180184119;7365.484416090876;7367.300106489874;7425.962870185668;37340.626593733985;37402.251954960746;37608;37762.24475510502;37813.81093094517;3577.5528058992627;3578.4095624221973;3589.5513060867393;3613.9999999999736;3616.3309787689363;30993.535096973563;31167;31175;31194.376112477625;31206.843965780252;4751.239801631722;4963.776630051656;4995.650304478688;5014.974925125388;5022.899542009176;176604;177111;179235;180075;180126;46821.76589117101;46844;47112.5288747115;48486;49130.75434622804;51094.97810043778;51489.74255128775;51591.48408515867;51811.74094129581;51904.22143667848;16807.243674034697;16888.493345199662;16897.831021689624;17050.658986820195;17081.82918170827;11371.601993930173;11603.477843497063;11614.477348519167;13549.390277437538;13720.382582783799;14269.857301426853;14338.426462941574;14419.78370324446;14525.78211326831;14593.41626334956;5548.223248745179;5699.74351154199;5702.087665973424;5751;5773.740181691834;975.5707887944196;985.522021819417;1003.0420947994647;1006.8691070160978;1024.5799222318813;21997.890010550163;22872.31383058511;22978;22980.310590682308;23108.53782924332;1093.3494570730402;1095.46322302073;1099.6316234061678;1111.4776055254017;1116.2242241642143;12073.637790866289;12159.331236782062;12223.755524889453;12321.93839030817;12390.504379824886;242957;244775;245033;245902;246427;52654;52811.73594132005;52815;52862.20706689403;53079.203811942854;1414.2151106135987;1442.935067921946;1471.2790732540977;1473.1676602719429;1477.5124209011;22119.115235391047;22123.778762212172;22364.664530032387;22588;22725.545489090455;36417.08957275983;36807.26385472329;36870;36878.63121368859;36908;196105;196528;197090;198047;198088;30990.845045774626;31863.681363187;31865.522017169296;33851.66148338485;35282.82358588191;42484.362734559625;42594.57405425906;42640.57359426366;42870.35694464523;42947.35578966381;31608.36783264368;31754.682453176098;31956.201094971882;32053.67946320507;32299;33708.32583348369;34805.825970869984;35041.64958350384;35320.47019294661;35836.462453062704;37745.43381849329;38212.235755284186;38407.231855363294;39279.60720392874;39351;33641.23867823776;33664.83167584244;33728.83135584307;34186.82906585451;34490.13774655654;24155.275341739776;24462.63306050375;24477.632835507124;25136.37159071038;25157.49685006253 03:55:40 INFO - PID 26544 | |2;jquery.html;548.391285672903;556.6687820746657;559.8376470823462;564.8531381840722;571.985700357491;16255.431059912906;21077.36767896962;21924.1230350786;22055.448613784665;22183.889080554614;19076;22130;24314.75685243147;24357.26928192157;24526;6248.125262463259;6445.452136568398;6458.806235812933;6472.676366181696;6475.7733479328235;6334.954732469137;6397.136386587821;6442.935570644304;6446.452051575622;6465.062565927938;5664.376918538957;6210.441060304572;6260.092286618437;6301.464375528086;6312.905306420407;6188.288346840126;6192.59748116371;6193.597416167935;6233.470155036782;6250.437460628543;5749.310082790092;5774.566907481955;5826.82519524415;5827.271591051119;5830.533557315404;27481.17556473309;27680.584791227946;27830.443391132267;27898.721012789814;29837.70162298371;1878.5867109235946;1938.0116140768168;1944.8444124470009;1948.4739120437403;1959.3534133735834;20212.191512339636;20546;20552.486187845276;20600.484987875272;20602.896985515126;2411.5418070566534;2443.3402981195154;2498.8750562471987;2533.366658335416;2541.1741184115053;142736;143174;144026.2798686;146542.26728866287;147335.26332368376;19852.404427867186;20827.79172208289;21577.67633485499;21700.589955778185;21973.340799776033;41001.58998410037;41174.79412602918;41404.585954140675;41429;41440.37839432411;10523.158147348193;10634.787304254027;10817.675469735763;10942.726431839268;10977.615783447542;8798.956005219932;8815.823683526294;8843.823123537493;8969.058248883774;9033.728988130366;8643.56782160902;11067.833982490269;11235.775284494264;11362;11499.540018399337;2700.486907487571;2729.890804367843;2758.917232483029;2785.415062836827;2877.8992735254164;947.4173383369179;968.2544440780559;979.1591807402039;995.323180237431;1003.1122456625793;18793.624127517374;18974.343591897145;19211.423657290303;19259.61480770405;19695.11371988264;1023.2428003277521;1038.2161468091695;1040.6513817870946;1041.068243921686;1043.2592859069994;10770.192235582363;10810.567802070882;10909.23635345534;10910.181736369645;10911.672649820519;473659;484320;488201;499069;506104;116096;118797;119008;120221;121216;1237.8514578250488;1239.1635645938954;1255.811628255769;1256.780063488904;1263.2546797389584;16801.243944022794;16821.91589042047;17025.31898724037;17283.395081172097;17420.216090275713;56623;56765.43234567767;57448.42551574598;58048.41951580599;58654.413455864895;69185.3081469199;70576;70846.2288442793;71248.64375678089;74465.25534744583;13884;14261.928690356483;14763.778543321643;14921.85078149248;14942.701145977237;22654;22807.543849123256;22930;22989.88505057464;23034.654480182475;17559.561010974827;17883.821161788215;17910.820891790914;18021.2791488339;18152.546186345447;16455.25951332169;16625.251863665922;16717.080560569284;16928.15359232058;17037;18902.621947561245;19111.52221194481;19137.617247655246;19180.808191917902;19189.136488858316;13844.653883652989;14284.07153535017;14303.928480357532;14336.283185840875;14419.927900360432;17936.372226971995;18009.189586468903;18110.5472363192;18124.909375453037;18168.818311816714 03:55:40 INFO - PID 26544 | |3;mootools.html;1322.900782441317;1350.6150747037098;1358.4090920449605;1363.44098919443;1374.670079180997;13971.16173029619;14116.364763585638;14515.709685806278;14603.415863365479;14639.268036598154;14667.706645867076;14910.776338354906;14954.551363459086;14956.476523321686;14992.850071499282;2651.164883061834;2679.196241127654;2698.136596289188;2698.5277576424146;2701.3786829029336;2572.585078206988;2649.7350264973543;2683.6377089093016;2688.6504754381904;2694.7709444697125;2573.5496288149593;2589.9223023309332;2595.9740402596017;2656.561667324889;2659.494696007762;2590.7538783815603;2611.837732209168;2618.48939456806;2626.566616508274;2627.5927231279184;2520.4329025969196;2525.4191535946834;2536.1630661881536;2541.263033720219;2554.961675574868;13687.520936767165;13946.58160255194;13971.463139054697;13993.720125597532;14038.578842634737;7365.447591430664;7654.540727556308;7665.501742386727;7718.151003389623;7743.496672716312;4940;4963.7766300516205;5132.563732082777;5177.559907407875;5182.4299327073995;1849.861260405475;1858.8977606231651;1880.6708825955402;1916.6933290673564;1948.3180886689686;23698.170564030177;23756.881215593985;23777.405564860845;23849;24138;6181.227346581677;6346.873062538723;6394.200724909387;6583.407493325528;6611.768588099393;16026.19869006545;16035.919820400823;16050.117243551484;16052.75920861188;16061.839381606034;7343.596102214323;7408.888866666896;7479.065116860393;7496.700131994659;7499.6250187490405;5734.655920644775;5975.37258587842;6597.274299827015;6873.931260687429;6892.551984121016;4923.286123512143;5152.793888244429;5175.534201921845;5180.8963820723375;5247.921281180786;1388.7153133607587;1391.1027387335112;1397.9650508737363;1406.1422532255317;1412.9788053179211;818.1695578987333;826.5247482697473;845.3490812074791;848.2238751542393;853.1212850763724;6837.726490940307;6866.038754574363;6871.4502839772695;6884.623075384943;6925;684.1892357556312;689.334791925794;694.90966174397;696.1124566178163;705.5766540076016;4100.528439229527;4102.364133559303;4105.404716316118;4170.16596680665;4408.911821763547;19068.14193361302;19591;19981.100850461764;20022.49943751418;20055.59888802245;20037.699434508493;20525.486862828548;20536.589268214553;20547.589048218953;20620;10389.324693895023;10389.480525973671;10563.47182640865;10625.5218515167;10632.681019569425;8472.19514146155;8524.616392262238;8564.785880353042;8725.301975842045;8906.554672266231;16853.831461685226;16990.57523561921;17021.74467383015;17476.30094796245;17513.299468021138;17194.398196063077;17715.64568708593;17922.731159032362;17941;18037.639247215244;10051.69844904654;10099.192064634959;11394.601188958346;11753.294802311888;11791.29252244868;11096.22326437174;12422.192557484097;12449.439775209956;13613.659658508617;13712.451501939811;11585.131115166565;11710.297382157098;11784.116191285517;11868.76262474763;12045.698857528632;11326.660200194008;11387.715307117389;11503.53985840557;11603.941980290045;11682.24065435744;9548.85676714836;9728.902710973083;9781.413115212825;9820.263480239153;9826.312158148861;6883.552569082994;6946.201186863374;6959.652017399211;6970.989206565121;6985.755498557526;6856.108705868205;6921.7231310747;6927.411170050602;6951.339622735832;7011.26381729911 03:55:40 INFO - PID 26544 | |4;prototype.html;474.9192637251667;485.6880101161054;504.3569448952585;515.9613029022823;520.9817656382025;6042.697865106744;6062.939370606293;6083.178770865938;6138.785142520012;6156.56904016719;5890.911636325448;5976.432238937294;5989.3112292086425;6016.60892042017;6027.3972602739705;4856.368672072644;4868.515102893616;4875.41495020598;4882.365292511978;4887.633427492952;4757.952420475803;4851.175300198957;4911.508849115078;4953.702777833323;4961.851144465653;4738.6446016548725;4804.471508134103;4907.11671899058;4916.721652370392;4916.926246106311;4873.269009648563;4894.5105489451125;4903.705777653352;4915.57448339981;4929.580985616227;4380.364847097153;4417.624501917341;4426.18115648606;4432.955670443286;4433;5917.674527900964;5928.466438020556;5951.166836642873;5988.670623115727;6023.578349515536;5634.521065709419;5643.463870932296;5680.841280313496;5716.542676585863;5727.742251598688;6473.158489396348;6482.12491313676;6511.316311787289;6529.5429319947625;6553.3446655334565;4791.688540244873;4841.394825646794;4858.149823780859;4859;4893.021395720834;6777.898331525031;6830.453563714891;6831.897521537131;6882.380585747257;6921.377076063179;4941.6293777966075;4971.552560269593;4983.875403114878;4987.404030710138;5008.348914641073;4961;4982.327385802942;5020.472850350734;5021.297018417425;5058.215976523645;5620.57845661577;5621.831345059655;5624.85937851557;5625.803096891671;5657.830265092054;6422.871542569216;6451.580647258007;6543.869122617521;6544.3782840630065;6556.082148499118;1665.1341302522621;1673.723835567142;1713.306111025037;1728.1532049295754;1746.1792957310045;1134.7673726886135;1137.6302701622005;1214.6052532926833;1215.5198696514826;1235.6725467751053;5785.971070144707;5788.507976822018;5791.652500849962;5801.3038435388025;5820.24336836217;6418.593027614645;6461.998390249519;6532.444742196872;6598.967005164944;6614.552615532188;5545.528630066489;5704.317226418217;5736.368999410061;5759.712014399263;5790.536757059425;3445.2610174911006;3500.807455589916;3536.3634545782006;3540.6636369544854;3551.3785087609567;6410;6417.839554011093;6436.967815160894;6486.254080780676;6514.794762968866;6788.981652752127;6791.3548212919695;6825.965870170618;6856.382925536725;6880.174379074543;6509.576877502947;6563.245226798979;6564.901526477107;6586.308437614078;6602.679464107197;6587.505937054836;6628.767993120217;6635.270120286668;6712.362325579063;6722.193336799615;6542.967285163544;6549.60702357841;6631.469482441296;6633.2040155181685;6641.734330626721;6459.515536334699;6525.445337146396;6555.3772391622715;6575;6604.14146160996;4919.752963044373;4920.720612640811;4969.0807200668;4969.428515720739;4982.975085124551;6610.851907725862;6641.369069938348;6651.800445986628;6661.933380666325;6698.2631910488835;6370.968145159244;6385.361463853577;6463.64449955257;6472.126262954441;6490.144336491929;6476.449501792212;6520.771772987922;6525;6529.575577587441;6530.608163510205;6136;6389.2652344980925;6396.968015159894;6422.165118534561;6428.292887782247;6183.659898705434;6301.6534090625455;6434;6463.64449955257;6469.191351081115;6172.833337497082;6243.125962365363;6275.748970041147;6336.303006669171;6358.904616430665 03:55:40 INFO - PID 26544 | |5;yui.html;888.8355654203968;897.5377680494546;908.5911339897048;911.2482202183196;922.7739203895047;22162.77837221627;24171.75828241717;24266.514669706594;24282.27153185403;24300.635490467655;21345;22073.668894966588;22080;22080.337589872288;22087.889560552216;1026.4046852825343;1031.762694580247;1033.519413472735;1040.4433628009017;1040.9791804163913;763.0042794153627;781.5232708048086;781.9061712594469;997.2548040928375;1063.2450959818539;1075.714935542082;1076.5101878645237;1079.4548752879784;1082.626493859617;1083.7019819549607;1084.0677017764756;1094.529352378477;1096.5668560918393;1097.6652121103061;1098.741795678015;795.3637090327773;795.7533164718956;800.3957012455617;801.1307731111751;809.6073404398862;19985.00074996259;20374.898125509277;20630.17479300826;21237.469063273387;21266.574668506542;21730;22025.779742202532;22221.333359999066;22248.6662700058;22615;16813.327466901308;17032;17161.05614191219;17390;17554.91222543892;3491.3191927574135;3508.298340331944;3518.9296214075575;3538.044727923472;3541.0793193769546;135154;135823;138169;139043.60956390508;139352;16693.749593756103;16847.663046738995;17007.23467443968;17008.57478563021;17080.65838683244;31541.369172616418;31620.209494762814;32111.197220069684;32148.19629509234;32183.35633287368;8350.290225330915;8446.028706698808;8574.528400937883;8592.613332400057;8606.698765543177;4201.684873634428;4305.892352691145;4333.934990975138;4334.284843000933;4349.739015659071;5267.078261304257;5270;5360.678359298455;5384.676919384771;5391.083515802323;981.5681100315838;987.6691308411763;996.1482932092956;999.1107913956585;1009.3741880034279;637.0635166305524;650.391883588846;663.9070530125787;664.6344510519292;665.7936039827572;11422.578470297367;11664.533418663328;11775.646730598095;11965.22226055321;12162.817557736642;682.0996284903879;708.8653155900363;712.3339677401646;712.9073220481304;722.8337482379083;5493.697846618395;5748.856278592985;6007.789727359522;6063;6158.815235542941;105333;107903;108797.45601271943;109444;111267.44366278117;94799;97958.51020744993;98343.50828245956;98507;100890;87102.56448717717;89109.55445222733;89235;89639;90618.54690726635;10689.732756681145;10811.027007569357;10910.127189824954;10935.562577497129;10954.28797128216;38975.22049558936;40053.39919901262;40373;40437.79781101076;40969.38545921754;50569;50916.23625645693;51064;51930.22104668509;52477.7376113117;16764.413245536347;19497.317593884145;19992.800071999674;20099.899500502404;20105.798942010977;20727.27454539084;21305.46736331542;22075.006624702248;22328.553428931005;23035.539289213786;19379.903100484407;19480.220791168762;19716.40850774479;19843.900780496006;19939.800601993793;19359.3224237151;19934.601307974048;20460.693089603967;20547.869867156853;20552.075156617688;18810.341638042602;19104.426867194008;19226.32707855218;19294.614107717487;19373.51566210856;13133.408996594984;13260.469581217028;13685.247311397969;13854.341066730414;14545.92727036358;14248.857511424752;14304.141751494944;14399.064060836012;14919.850801491846;15084.396624134912 03:55:40 INFO - PID 26544 | __end_tp_report 03:55:40 INFO - PID 26544 | __start_cc_report 03:55:40 INFO - PID 26544 | _x_x_mozilla_cycle_collect,383 03:55:40 INFO - PID 26544 | __end_cc_report 03:55:40 INFO - PID 26544 | __startTimestamp1502880940492__endTimestamp 03:55:40 INFO - PID 26544 | 03:55:40 INFO - PID 26544 | ------- Summary: start ------- 03:55:40 INFO - PID 26544 | Number of tests: 6 03:55:40 INFO - PID 26544 | 03:55:40 INFO - PID 26544 | [#0] dojo.html Cycles:165 Average:5968.39 Median:6193.50 stddev:689.67 (11.1%) stddev-sans-first:654.04 03:55:40 INFO - PID 26544 | Values: 3100.0 3112.2 3117.6 3134.5 3173.9 5957.4 6090.2 6099.5 6111.6 6122.1 5974.9 6062.2 6069.3 6087.7 6096.7 5468.2 5514.2 5525.2 5542.4 5571.3 5539.5 5574.1 5574.4 5582.1 5602.9 5550.9 5568.9 5594.6 5599.4 5635.1 5593.9 5595.2 5610.5 5640.4 5699.3 5444.5 5564.2 5575.6 5623.2 5631.8 5828.4 5953.5 5976.1 6007.2 6072.7 5891.0 6360.0 6402.7 6444.6 6542.1 6489.7 6581.5 6638.1 6657.6 6662.1 6000.8 6092.5 6110.0 6150.7 6198.1 6621.6 6679.4 6680.7 6706.0 6722.9 6431.0 6440.9 6486.9 6493.6 6503.4 6427.3 6445.6 6505.2 6508.6 6619.0 6277.5 6383.1 6407.6 6503.2 6504.0 6473.4 6509.8 6511.6 6518.9 6545.5 5308.2 5323.7 5331.6 5355.9 5380.1 4515.1 4564.7 4568.3 4582.0 4619.1 5570.6 5685.6 5700.3 5705.0 5746.1 6331.7 6359.0 6395.3 6400.7 6410.6 5542.3 5556.6 5566.7 5572.3 5581.6 5461.2 5529.9 5531.3 5554.3 5644.7 6193.5 6194.8 6208.8 6209.4 6214.0 5777.6 6328.7 6364.0 6370.5 6690.3 6412.2 6421.6 6483.8 6486.4 6535.1 6251.2 6379.0 6443.8 6451.4 6532.6 6419.2 6430.4 6469.2 6471.5 6510.2 5349.4 6242.4 6322.1 6340.4 6432.0 6249.0 6365.2 6398.9 6442.3 6498.6 6237.8 6272.1 6299.5 6319.4 6394.1 6232.6 6247.3 6264.7 6345.9 6376.4 6117.2 6158.9 6166.4 6181.9 6188.7 03:55:40 INFO - PID 26544 | 03:55:40 INFO - PID 26544 | [#1] ext.html Cycles:180 Average:37568.94 Median:19449.01 stddev:54180.33 (278.6%) stddev-sans-first:54261.85 03:55:40 INFO - PID 26544 | Values: 767.4 846.4 876.3 877.9 1131.6 30216.2 30695.8 30764.7 40774.8 41633.4 42206.0 42387.8 42608.4 42717.6 42847.6 7336.2 7379.3 7536.6 7580.3 7606.9 7388.7 7490.2 7491.7 7499.5 7499.6 7351.0 7458.4 7477.4 7480.6 7505.7 7403.0 7459.8 7471.1 7484.9 7500.0 7353.7 7364.0 7365.5 7367.3 7426.0 37340.6 37402.3 37608.0 37762.2 37813.8 3577.6 3578.4 3589.6 3614.0 3616.3 30993.5 31167.0 31175.0 31194.4 31206.8 4751.2 4963.8 4995.7 5015.0 5022.9 176604.0 177111.0 179235.0 180075.0 180126.0 46821.8 46844.0 47112.5 48486.0 49130.8 51095.0 51489.7 51591.5 51811.7 51904.2 16807.2 16888.5 16897.8 17050.7 17081.8 11371.6 11603.5 11614.5 13549.4 13720.4 14269.9 14338.4 14419.8 14525.8 14593.4 5548.2 5699.7 5702.1 5751.0 5773.7 975.6 985.5 1003.0 1006.9 1024.6 21997.9 22872.3 22978.0 22980.3 23108.5 1093.3 1095.5 1099.6 1111.5 1116.2 12073.6 12159.3 12223.8 12321.9 12390.5 242957.0 244775.0 245033.0 245902.0 246427.0 52654.0 52811.7 52815.0 52862.2 53079.2 1414.2 1442.9 1471.3 1473.2 1477.5 22119.1 22123.8 22364.7 22588.0 22725.5 36417.1 36807.3 36870.0 36878.6 36908.0 196105.0 196528.0 197090.0 198047.0 198088.0 30990.8 31863.7 31865.5 33851.7 35282.8 42484.4 42594.6 42640.6 42870.4 42947.4 31608.4 31754.7 31956.2 32053.7 32299.0 33708.3 34805.8 35041.6 35320.5 35836.5 37745.4 38212.2 38407.2 39279.6 39351.0 33641.2 33664.8 33728.8 34186.8 34490.1 24155.3 24462.6 24477.6 25136.4 25157.5 03:55:40 INFO - PID 26544 | 03:55:40 INFO - PID 26544 | [#2] jquery.html Cycles:180 Average:35573.80 Median:21639.13 stddev:82950.09 (383.3%) stddev-sans-first:83141.10 03:55:40 INFO - PID 26544 | Values: 548.4 556.7 559.8 564.9 572.0 16255.4 21077.4 21924.1 22055.4 22183.9 19076.0 22130.0 24314.8 24357.3 24526.0 6248.1 6445.5 6458.8 6472.7 6475.8 6335.0 6397.1 6442.9 6446.5 6465.1 5664.4 6210.4 6260.1 6301.5 6312.9 6188.3 6192.6 6193.6 6233.5 6250.4 5749.3 5774.6 5826.8 5827.3 5830.5 27481.2 27680.6 27830.4 27898.7 29837.7 1878.6 1938.0 1944.8 1948.5 1959.4 20212.2 20546.0 20552.5 20600.5 20602.9 2411.5 2443.3 2498.9 2533.4 2541.2 142736.0 143174.0 144026.3 146542.3 147335.3 19852.4 20827.8 21577.7 21700.6 21973.3 41001.6 41174.8 41404.6 41429.0 41440.4 10523.2 10634.8 10817.7 10942.7 10977.6 8799.0 8815.8 8843.8 8969.1 9033.7 8643.6 11067.8 11235.8 11362.0 11499.5 2700.5 2729.9 2758.9 2785.4 2877.9 947.4 968.3 979.2 995.3 1003.1 18793.6 18974.3 19211.4 19259.6 19695.1 1023.2 1038.2 1040.7 1041.1 1043.3 10770.2 10810.6 10909.2 10910.2 10911.7 473659.0 484320.0 488201.0 499069.0 506104.0 116096.0 118797.0 119008.0 120221.0 121216.0 1237.9 1239.2 1255.8 1256.8 1263.3 16801.2 16821.9 17025.3 17283.4 17420.2 56623.0 56765.4 57448.4 58048.4 58654.4 69185.3 70576.0 70846.2 71248.6 74465.3 13884.0 14261.9 14763.8 14921.9 14942.7 22654.0 22807.5 22930.0 22989.9 23034.7 17559.6 17883.8 17910.8 18021.3 18152.5 16455.3 16625.3 16717.1 16928.2 17037.0 18902.6 19111.5 19137.6 19180.8 19189.1 13844.7 14284.1 14303.9 14336.3 14419.9 17936.4 18009.2 18110.5 18124.9 18168.8 03:55:40 INFO - PID 26544 | 03:55:40 INFO - PID 26544 | [#3] mootools.html Cycles:180 Average:8790.03 Median:2573.07 stddev:6193.62 (240.7%) stddev-sans-first:6185.58 03:55:40 INFO - PID 26544 | Values: 1322.9 1350.6 1358.4 1363.4 1374.7 13971.2 14116.4 14515.7 14603.4 14639.3 14667.7 14910.8 14954.6 14956.5 14992.9 2651.2 2679.2 2698.1 2698.5 2701.4 2572.6 2649.7 2683.6 2688.7 2694.8 2573.5 2589.9 2596.0 2656.6 2659.5 2590.8 2611.8 2618.5 2626.6 2627.6 2520.4 2525.4 2536.2 2541.3 2555.0 13687.5 13946.6 13971.5 13993.7 14038.6 7365.4 7654.5 7665.5 7718.2 7743.5 4940.0 4963.8 5132.6 5177.6 5182.4 1849.9 1858.9 1880.7 1916.7 1948.3 23698.2 23756.9 23777.4 23849.0 24138.0 6181.2 6346.9 6394.2 6583.4 6611.8 16026.2 16035.9 16050.1 16052.8 16061.8 7343.6 7408.9 7479.1 7496.7 7499.6 5734.7 5975.4 6597.3 6873.9 6892.6 4923.3 5152.8 5175.5 5180.9 5247.9 1388.7 1391.1 1398.0 1406.1 1413.0 818.2 826.5 845.3 848.2 853.1 6837.7 6866.0 6871.5 6884.6 6925.0 684.2 689.3 694.9 696.1 705.6 4100.5 4102.4 4105.4 4170.2 4408.9 19068.1 19591.0 19981.1 20022.5 20055.6 20037.7 20525.5 20536.6 20547.6 20620.0 10389.3 10389.5 10563.5 10625.5 10632.7 8472.2 8524.6 8564.8 8725.3 8906.6 16853.8 16990.6 17021.7 17476.3 17513.3 17194.4 17715.6 17922.7 17941.0 18037.6 10051.7 10099.2 11394.6 11753.3 11791.3 11096.2 12422.2 12449.4 13613.7 13712.5 11585.1 11710.3 11784.1 11868.8 12045.7 11326.7 11387.7 11503.5 11603.9 11682.2 9548.9 9728.9 9781.4 9820.3 9826.3 6883.6 6946.2 6959.7 6971.0 6985.8 6856.1 6921.7 6927.4 6951.3 7011.3 03:55:40 INFO - PID 26544 | 03:55:40 INFO - PID 26544 | [#4] prototype.html Cycles:180 Average:5448.18 Median:5988.99 stddev:1536.61 (25.7%) stddev-sans-first:1494.89 03:55:40 INFO - PID 26544 | Values: 474.9 485.7 504.4 516.0 521.0 6042.7 6062.9 6083.2 6138.8 6156.6 5890.9 5976.4 5989.3 6016.6 6027.4 4856.4 4868.5 4875.4 4882.4 4887.6 4758.0 4851.2 4911.5 4953.7 4961.9 4738.6 4804.5 4907.1 4916.7 4916.9 4873.3 4894.5 4903.7 4915.6 4929.6 4380.4 4417.6 4426.2 4433.0 4433.0 5917.7 5928.5 5951.2 5988.7 6023.6 5634.5 5643.5 5680.8 5716.5 5727.7 6473.2 6482.1 6511.3 6529.5 6553.3 4791.7 4841.4 4858.1 4859.0 4893.0 6777.9 6830.5 6831.9 6882.4 6921.4 4941.6 4971.6 4983.9 4987.4 5008.3 4961.0 4982.3 5020.5 5021.3 5058.2 5620.6 5621.8 5624.9 5625.8 5657.8 6422.9 6451.6 6543.9 6544.4 6556.1 1665.1 1673.7 1713.3 1728.2 1746.2 1134.8 1137.6 1214.6 1215.5 1235.7 5786.0 5788.5 5791.7 5801.3 5820.2 6418.6 6462.0 6532.4 6599.0 6614.6 5545.5 5704.3 5736.4 5759.7 5790.5 3445.3 3500.8 3536.4 3540.7 3551.4 6410.0 6417.8 6437.0 6486.3 6514.8 6789.0 6791.4 6826.0 6856.4 6880.2 6509.6 6563.2 6564.9 6586.3 6602.7 6587.5 6628.8 6635.3 6712.4 6722.2 6543.0 6549.6 6631.5 6633.2 6641.7 6459.5 6525.4 6555.4 6575.0 6604.1 4919.8 4920.7 4969.1 4969.4 4983.0 6610.9 6641.4 6651.8 6661.9 6698.3 6371.0 6385.4 6463.6 6472.1 6490.1 6476.4 6520.8 6525.0 6529.6 6530.6 6136.0 6389.3 6397.0 6422.2 6428.3 6183.7 6301.7 6434.0 6463.6 6469.2 6172.8 6243.1 6275.7 6336.3 6358.9 03:55:40 INFO - PID 26544 | 03:55:40 INFO - PID 26544 | [#5] yui.html Cycles:180 Average:24066.18 Median:22080.17 stddev:32621.19 (147.7%) stddev-sans-first:32666.27 03:55:40 INFO - PID 26544 | Values: 888.8 897.5 908.6 911.2 922.8 22162.8 24171.8 24266.5 24282.3 24300.6 21345.0 22073.7 22080.0 22080.3 22087.9 1026.4 1031.8 1033.5 1040.4 1041.0 763.0 781.5 781.9 997.3 1063.2 1075.7 1076.5 1079.5 1082.6 1083.7 1084.1 1094.5 1096.6 1097.7 1098.7 795.4 795.8 800.4 801.1 809.6 19985.0 20374.9 20630.2 21237.5 21266.6 21730.0 22025.8 22221.3 22248.7 22615.0 16813.3 17032.0 17161.1 17390.0 17554.9 3491.3 3508.3 3518.9 3538.0 3541.1 135154.0 135823.0 138169.0 139043.6 139352.0 16693.7 16847.7 17007.2 17008.6 17080.7 31541.4 31620.2 32111.2 32148.2 32183.4 8350.3 8446.0 8574.5 8592.6 8606.7 4201.7 4305.9 4333.9 4334.3 4349.7 5267.1 5270.0 5360.7 5384.7 5391.1 981.6 987.7 996.1 999.1 1009.4 637.1 650.4 663.9 664.6 665.8 11422.6 11664.5 11775.6 11965.2 12162.8 682.1 708.9 712.3 712.9 722.8 5493.7 5748.9 6007.8 6063.0 6158.8 105333.0 107903.0 108797.5 109444.0 111267.4 94799.0 97958.5 98343.5 98507.0 100890.0 87102.6 89109.6 89235.0 89639.0 90618.5 10689.7 10811.0 10910.1 10935.6 10954.3 38975.2 40053.4 40373.0 40437.8 40969.4 50569.0 50916.2 51064.0 51930.2 52477.7 16764.4 19497.3 19992.8 20099.9 20105.8 20727.3 21305.5 22075.0 22328.6 23035.5 19379.9 19480.2 19716.4 19843.9 19939.8 19359.3 19934.6 20460.7 20547.9 20552.1 18810.3 19104.4 19226.3 19294.6 19373.5 13133.4 13260.5 13685.2 13854.3 14545.9 14248.9 14304.1 14399.1 14919.9 15084.4 03:55:40 INFO - PID 26544 | -------- Summary: end -------- 03:55:40 INFO - PID 26544 | 03:55:41 INFO - TEST-INFO | 26544: exit 0 03:55:41 INFO - TEST-OK | dromaeo_css | took 1116112ms 03:55:41 INFO - TEST-START | kraken 03:55:41 INFO - Initialising browser for kraken test... 03:55:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34008/getInfo.html -profile /tmp/tmpEQ1MPQ/profile 03:55:41 INFO - TEST-INFO | started process 26925 (/builds/slave/test/build/application/firefox/firefox http://localhost:34008/getInfo.html) 03:55:48 INFO - TEST-INFO | 26925: exit 0 03:55:48 INFO - Browser initialized. 03:55:48 INFO - Running cycle 1/1 for kraken test... 03:55:48 INFO - TEST-INFO | started process 27150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEQ1MPQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:55:49 INFO - PID 27150 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:55:49 INFO - PID 27150 | WebRender - OpenGL version new 3.2.0 NVIDIA 361.42 03:55:49 INFO - PID 27150 | 03:55:49 INFO - PID 27150 | (/builds/slave/test/build/application/firefox/firefox:27209): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:55:49 INFO - PID 27150 | 03:55:59 INFO - PID 27150 | RSS: Main: 198737920 03:55:59 INFO - PID 27150 | 03:56:02 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34008/tests/kraken/driver.html?testName=audio-beat-detection) 03:56:03 INFO - PID 27150 | RSS: Main: 208175104 03:56:03 INFO - PID 27150 | 03:56:06 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34008/tests/kraken/driver.html?testName=audio-dft) 03:56:06 INFO - PID 27150 | RSS: Main: 209195008 03:56:06 INFO - PID 27150 | 03:56:09 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34008/tests/kraken/driver.html?testName=audio-fft) 03:56:10 INFO - PID 27150 | RSS: Main: 205254656 03:56:10 INFO - PID 27150 | 03:56:12 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34008/tests/kraken/driver.html?testName=audio-oscillator) 03:56:13 INFO - PID 27150 | RSS: Main: 204357632 03:56:13 INFO - PID 27150 | 03:56:15 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34008/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:56:16 INFO - PID 27150 | RSS: Main: 205725696 03:56:16 INFO - PID 27150 | 03:56:19 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34008/tests/kraken/driver.html?testName=imaging-darkroom) 03:56:20 INFO - PID 27150 | RSS: Main: 208330752 03:56:20 INFO - PID 27150 | 03:56:23 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34008/tests/kraken/driver.html?testName=imaging-desaturate) 03:56:24 INFO - PID 27150 | RSS: Main: 208269312 03:56:24 INFO - PID 27150 | 03:56:27 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34008/tests/kraken/driver.html?testName=json-parse-financial) 03:56:27 INFO - PID 27150 | RSS: Main: 208875520 03:56:27 INFO - PID 27150 | 03:56:29 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34008/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:56:30 INFO - PID 27150 | RSS: Main: 207822848 03:56:30 INFO - PID 27150 | 03:56:32 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:56:32 INFO - PID 27150 | RSS: Main: 206319616 03:56:32 INFO - PID 27150 | 03:56:34 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:56:35 INFO - PID 27150 | RSS: Main: 218648576 03:56:35 INFO - PID 27150 | 03:56:38 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:56:39 INFO - PID 27150 | RSS: Main: 218787840 03:56:39 INFO - PID 27150 | 03:56:42 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:56:42 INFO - PID 27150 | RSS: Main: 219291648 03:56:42 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | Cycle 1(1): loaded http://localhost:34008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34008/tests/kraken/driver.html?testName=ai-astar) 03:56:44 INFO - PID 27150 | RSS: Main: 220647424 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | __start_tp_report 03:56:44 INFO - PID 27150 | _x_x_mozilla_page_load 03:56:44 INFO - PID 27150 | _x_x_mozilla_page_load_details 03:56:44 INFO - PID 27150 | |i|pagename|runs| 03:56:44 INFO - PID 27150 | |0;ai-astar;107;108;116;115;113;119;115;101;113;119 03:56:44 INFO - PID 27150 | |1;audio-beat-detection;152;128;151;180;121;162;143;123;179;119 03:56:44 INFO - PID 27150 | |2;audio-dft;164;172;169;167;167;166;173;166;179;173 03:56:44 INFO - PID 27150 | |3;audio-fft;82;79;81;191;82;85;79;90;104;83 03:56:44 INFO - PID 27150 | |4;audio-oscillator;83;78;132;85;84;83;136;83;85;130 03:56:44 INFO - PID 27150 | |5;imaging-gaussian-blur;115;115;126;119;117;116;123;116;121;125 03:56:44 INFO - PID 27150 | |6;imaging-darkroom;157;159;159;152;152;156;151;154;156;153 03:56:44 INFO - PID 27150 | |7;imaging-desaturate;96;99;95;101;105;96;96;100;101;99 03:56:44 INFO - PID 27150 | |8;json-parse-financial;60;58;54;54;55;55;53;55;54;55 03:56:44 INFO - PID 27150 | |9;json-stringify-tinderbox;58;54;54;55;62;61;57;66;61;60 03:56:44 INFO - PID 27150 | |10;stanford-crypto-aes;79;80;78;86;82;81;87;84;76;77 03:56:44 INFO - PID 27150 | |11;stanford-crypto-ccm;125;129;127;132;135;126;125;118;126;180 03:56:44 INFO - PID 27150 | |12;stanford-crypto-pbkdf2;181;188;179;176;184;185;186;186;181;175 03:56:44 INFO - PID 27150 | |13;stanford-crypto-sha256-iterative;71;69;69;70;69;68;83;68;67;75 03:56:44 INFO - PID 27150 | __end_tp_report 03:56:44 INFO - PID 27150 | __start_cc_report 03:56:44 INFO - PID 27150 | _x_x_mozilla_cycle_collect,983 03:56:44 INFO - PID 27150 | __end_cc_report 03:56:44 INFO - PID 27150 | __startTimestamp1502881004885__endTimestamp 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | ------- Summary: start ------- 03:56:44 INFO - PID 27150 | Number of tests: 14 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#0] ai-astar Cycles:10 Average:112.60 Median:115.00 stddev:5.70 (5.0%) stddev-sans-first:5.67 03:56:44 INFO - PID 27150 | Values: 107.0 108.0 116.0 115.0 113.0 119.0 115.0 101.0 113.0 119.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:151.50 stddev:23.04 (15.2%) stddev-sans-first:24.33 03:56:44 INFO - PID 27150 | Values: 152.0 128.0 151.0 180.0 121.0 162.0 143.0 123.0 179.0 119.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#2] audio-dft Cycles:10 Average:169.60 Median:170.50 stddev:4.58 (2.7%) stddev-sans-first:4.38 03:56:44 INFO - PID 27150 | Values: 164.0 172.0 169.0 167.0 167.0 166.0 173.0 166.0 179.0 173.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#3] audio-fft Cycles:10 Average:95.60 Median:82.00 stddev:34.33 (41.9%) stddev-sans-first:36.06 03:56:44 INFO - PID 27150 | Values: 82.0 79.0 81.0 191.0 82.0 85.0 79.0 90.0 104.0 83.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:83.00 stddev:24.11 (29.1%) stddev-sans-first:24.97 03:56:44 INFO - PID 27150 | Values: 83.0 78.0 132.0 85.0 84.0 83.0 136.0 83.0 85.0 130.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#5] imaging-gaussian-blur Cycles:10 Average:119.30 Median:120.00 stddev:4.19 (3.5%) stddev-sans-first:4.15 03:56:44 INFO - PID 27150 | Values: 115.0 115.0 126.0 119.0 117.0 116.0 123.0 116.0 121.0 125.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#6] imaging-darkroom Cycles:10 Average:154.90 Median:156.00 stddev:2.92 (1.9%) stddev-sans-first:3.00 03:56:44 INFO - PID 27150 | Values: 157.0 159.0 159.0 152.0 152.0 156.0 151.0 154.0 156.0 153.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#7] imaging-desaturate Cycles:10 Average:98.80 Median:96.00 stddev:3.12 (3.2%) stddev-sans-first:3.14 03:56:44 INFO - PID 27150 | Values: 96.0 99.0 95.0 101.0 105.0 96.0 96.0 100.0 101.0 99.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:2.11 (3.8%) stddev-sans-first:1.39 03:56:44 INFO - PID 27150 | Values: 60.0 58.0 54.0 54.0 55.0 55.0 53.0 55.0 54.0 55.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:60.50 stddev:3.91 (6.5%) stddev-sans-first:4.14 03:56:44 INFO - PID 27150 | Values: 58.0 54.0 54.0 55.0 62.0 61.0 57.0 66.0 61.0 60.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.50 stddev:3.74 (4.6%) stddev-sans-first:3.90 03:56:44 INFO - PID 27150 | Values: 79.0 80.0 78.0 86.0 82.0 81.0 87.0 84.0 76.0 77.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:128.00 stddev:17.36 (13.6%) stddev-sans-first:18.21 03:56:44 INFO - PID 27150 | Values: 125.0 129.0 127.0 132.0 135.0 126.0 125.0 118.0 126.0 180.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.10 Median:184.50 stddev:4.43 (2.4%) stddev-sans-first:4.68 03:56:44 INFO - PID 27150 | Values: 181.0 188.0 179.0 176.0 184.0 185.0 186.0 186.0 181.0 175.0 03:56:44 INFO - PID 27150 | 03:56:44 INFO - PID 27150 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:69.50 stddev:4.79 (6.9%) stddev-sans-first:5.09 03:56:44 INFO - PID 27150 | Values: 71.0 69.0 69.0 70.0 69.0 68.0 83.0 68.0 67.0 75.0 03:56:44 INFO - PID 27150 | -------- Summary: end -------- 03:56:44 INFO - PID 27150 | 03:56:45 INFO - PID 27150 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:56:45 INFO - TEST-INFO | 27150: exit 0 03:56:45 INFO - TEST-OK | kraken | took 64304ms 03:56:45 INFO - SUITE-END | took 1180s 03:56:46 INFO - Completed test suite (00:19:40) 03:56:46 INFO - javascript benchmark 03:56:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8430.797531940661, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3100.0, 3112.1908303840996, 3117.6258848938132, 3134.4828103362947, 3173.9365212695743, 5957.40425957404, 6090.238720159986, 6099.5120390368775, 6111.633302001872, 6122.112293717409, 5974.940250597493, 6062.211912451375, 6069.271687397508, 6087.7260523276445, 6096.725647345869, 5468.207109969052, 5514.200440936062, 5525.198846167304, 5542.39033706292, 5571.275734154554, 5539.529140023103, 5574.136008918604, 5574.414686457924, 5582.106862901936, 5602.8599285018, 5550.944490555084, 5568.86077848055, 5594.552435805126, 5599.384067752544, 5635.070213414781, 5593.944060559383, 5595.21666966625, 5610.4670056344585, 5640.407757185478, 5699.344575373802, 5444.537214336786, 5564.248826408464, 5575.637583557056, 5623.156526521014, 5631.774729010835, 5828.358880523139, 5953.464188223037, 5976.133460648181, 6007.219061521974, 6072.666003369813, 5890.97054514729, 6359.96820015897, 6402.711877965503, 6444.645544495051, 6542.084108224853, 6489.740410383579, 6581.506387020945, 6638.103855979478, 6657.633830139341, 6662.067310576524, 6000.849978750479, 6092.51259899207, 6110.0, 6150.723217455181, 6198.101275315054, 6621.602703837785, 6679.398854103057, 6680.699368528428, 6705.966470167618, 6722.899156512656, 6431.0, 6440.935590644033, 6486.935130648633, 6493.577917435352, 6503.382178693017, 6427.260865000585, 6445.613263204223, 6505.154329937172, 6508.576942498722, 6619.0, 6277.52918531112, 6383.138276332728, 6407.647579383085, 6503.219613646393, 6503.967480162663, 6473.449756770728, 6509.804705858832, 6511.576747511492, 6518.869622607522, 6545.476361891037, 5308.150695888639, 5323.733813309319, 5331.626786124934, 5355.946440535623, 5380.112281473513, 4515.096980603892, 4564.726116433025, 4568.291914753218, 4581.954180458153, 4619.145458090264, 5570.554355651539, 5685.6304340218585, 5700.25896633435, 5705.0, 5746.138079288056, 6331.746730130743, 6358.968205159037, 6395.328490508429, 6400.679966001681, 6410.647414392253, 5542.307211598551, 5556.583256255797, 5566.749496272678, 5572.331320241597, 5581.553475721932, 5461.180822876521, 5529.944700552943, 5531.3362396512675, 5554.277943867352, 5644.6613203207935, 6193.504519638418, 6194.783182588588, 6208.751649933952, 6209.379062093845, 6214.0, 5777.566682498914, 6328.683565821782, 6364.0, 6370.458511026614, 6690.264070952288, 6412.166418365583, 6421.614703117828, 6483.7730679425995, 6486.416222539994, 6535.052417399355, 6251.156093927261, 6378.968105159444, 6443.7744678936015, 6451.387118223761, 6532.5753826001155, 6419.165508483868, 6430.3891130342545, 6469.191351081115, 6471.482281417381, 6510.18622672166, 5349.384820745664, 6242.375762423721, 6322.083297921684, 6340.365963403623, 6432.0, 6249.0, 6365.246739661394, 6398.872022559616, 6442.2591401989375, 6498.642574658439, 6237.781677641261, 6272.059191121369, 6299.4645455135, 6319.431251187415, 6394.136791533084, 6232.563720539519, 6247.281562620356, 6264.718087686157, 6345.90481142774, 6376.426121649074, 6117.235345581802, 6158.907616385847, 6166.383361663798, 6181.876362472635, 6188.659623720739], "value": 5918.976649922024, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.3745897093868, 846.4286606540586, 876.259560671233, 877.8770972063908, 1131.6039386214832, 30216.244593885163, 30695.846520767365, 30764.69235307646, 40774.796126019406, 41633.37549936753, 42206.0, 42387.788061059655, 42608.360874586826, 42717.572824271745, 42847.57152428475, 7336.156342020682, 7379.262073792618, 7536.585487798169, 7580.279873412017, 7606.923930760677, 7388.704451821921, 7490.176080631126, 7491.66287517063, 7499.512531685423, 7499.587522686277, 7351.0, 7458.4033277337685, 7477.364424023937, 7480.588567628778, 7505.662245198979, 7403.0, 7459.776206713807, 7471.066116735381, 7484.850302993964, 7500.0, 7353.669084891193, 7363.963180184119, 7365.484416090876, 7367.300106489874, 7425.962870185668, 37340.626593733985, 37402.251954960746, 37608.0, 37762.24475510502, 37813.81093094517, 3577.5528058992627, 3578.4095624221973, 3589.5513060867393, 3613.9999999999736, 3616.3309787689363, 30993.535096973563, 31167.0, 31175.0, 31194.376112477625, 31206.843965780252, 4751.239801631722, 4963.776630051656, 4995.650304478688, 5014.974925125388, 5022.899542009176, 176604.0, 177111.0, 179235.0, 180075.0, 180126.0, 46821.76589117101, 46844.0, 47112.5288747115, 48486.0, 49130.75434622804, 51094.97810043778, 51489.74255128775, 51591.48408515867, 51811.74094129581, 51904.22143667848, 16807.243674034697, 16888.493345199662, 16897.831021689624, 17050.658986820195, 17081.82918170827, 11371.601993930173, 11603.477843497063, 11614.477348519167, 13549.390277437538, 13720.382582783799, 14269.857301426853, 14338.426462941574, 14419.78370324446, 14525.78211326831, 14593.41626334956, 5548.223248745179, 5699.74351154199, 5702.087665973424, 5751.0, 5773.740181691834, 975.5707887944196, 985.522021819417, 1003.0420947994647, 1006.8691070160978, 1024.5799222318813, 21997.890010550163, 22872.31383058511, 22978.0, 22980.310590682308, 23108.53782924332, 1093.3494570730402, 1095.46322302073, 1099.6316234061678, 1111.4776055254017, 1116.2242241642143, 12073.637790866289, 12159.331236782062, 12223.755524889453, 12321.93839030817, 12390.504379824886, 242957.0, 244775.0, 245033.0, 245902.0, 246427.0, 52654.0, 52811.73594132005, 52815.0, 52862.20706689403, 53079.203811942854, 1414.2151106135987, 1442.935067921946, 1471.2790732540977, 1473.1676602719429, 1477.5124209011, 22119.115235391047, 22123.778762212172, 22364.664530032387, 22588.0, 22725.545489090455, 36417.08957275983, 36807.26385472329, 36870.0, 36878.63121368859, 36908.0, 196105.0, 196528.0, 197090.0, 198047.0, 198088.0, 30990.845045774626, 31863.681363187, 31865.522017169296, 33851.66148338485, 35282.82358588191, 42484.362734559625, 42594.57405425906, 42640.57359426366, 42870.35694464523, 42947.35578966381, 31608.36783264368, 31754.682453176098, 31956.201094971882, 32053.67946320507, 32299.0, 33708.32583348369, 34805.825970869984, 35041.64958350384, 35320.47019294661, 35836.462453062704, 37745.43381849329, 38212.235755284186, 38407.231855363294, 39279.60720392874, 39351.0, 33641.23867823776, 33664.83167584244, 33728.83135584307, 34186.82906585451, 34490.13774655654, 24155.275341739776, 24462.63306050375, 24477.632835507124, 25136.37159071038, 25157.49685006253], "value": 17071.46696849053, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.391285672903, 556.6687820746657, 559.8376470823462, 564.8531381840722, 571.985700357491, 16255.431059912906, 21077.36767896962, 21924.1230350786, 22055.448613784665, 22183.889080554614, 19076.0, 22130.0, 24314.75685243147, 24357.26928192157, 24526.0, 6248.125262463259, 6445.452136568398, 6458.806235812933, 6472.676366181696, 6475.7733479328235, 6334.954732469137, 6397.136386587821, 6442.935570644304, 6446.452051575622, 6465.062565927938, 5664.376918538957, 6210.441060304572, 6260.092286618437, 6301.464375528086, 6312.905306420407, 6188.288346840126, 6192.59748116371, 6193.597416167935, 6233.470155036782, 6250.437460628543, 5749.310082790092, 5774.566907481955, 5826.82519524415, 5827.271591051119, 5830.533557315404, 27481.17556473309, 27680.584791227946, 27830.443391132267, 27898.721012789814, 29837.70162298371, 1878.5867109235946, 1938.0116140768168, 1944.8444124470009, 1948.4739120437403, 1959.3534133735834, 20212.191512339636, 20546.0, 20552.486187845276, 20600.484987875272, 20602.896985515126, 2411.5418070566534, 2443.3402981195154, 2498.8750562471987, 2533.366658335416, 2541.1741184115053, 142736.0, 143174.0, 144026.2798686, 146542.26728866287, 147335.26332368376, 19852.404427867186, 20827.79172208289, 21577.67633485499, 21700.589955778185, 21973.340799776033, 41001.58998410037, 41174.79412602918, 41404.585954140675, 41429.0, 41440.37839432411, 10523.158147348193, 10634.787304254027, 10817.675469735763, 10942.726431839268, 10977.615783447542, 8798.956005219932, 8815.823683526294, 8843.823123537493, 8969.058248883774, 9033.728988130366, 8643.56782160902, 11067.833982490269, 11235.775284494264, 11362.0, 11499.540018399337, 2700.486907487571, 2729.890804367843, 2758.917232483029, 2785.415062836827, 2877.8992735254164, 947.4173383369179, 968.2544440780559, 979.1591807402039, 995.323180237431, 1003.1122456625793, 18793.624127517374, 18974.343591897145, 19211.423657290303, 19259.61480770405, 19695.11371988264, 1023.2428003277521, 1038.2161468091695, 1040.6513817870946, 1041.068243921686, 1043.2592859069994, 10770.192235582363, 10810.567802070882, 10909.23635345534, 10910.181736369645, 10911.672649820519, 473659.0, 484320.0, 488201.0, 499069.0, 506104.0, 116096.0, 118797.0, 119008.0, 120221.0, 121216.0, 1237.8514578250488, 1239.1635645938954, 1255.811628255769, 1256.780063488904, 1263.2546797389584, 16801.243944022794, 16821.91589042047, 17025.31898724037, 17283.395081172097, 17420.216090275713, 56623.0, 56765.43234567767, 57448.42551574598, 58048.41951580599, 58654.413455864895, 69185.3081469199, 70576.0, 70846.2288442793, 71248.64375678089, 74465.25534744583, 13884.0, 14261.928690356483, 14763.778543321643, 14921.85078149248, 14942.701145977237, 22654.0, 22807.543849123256, 22930.0, 22989.88505057464, 23034.654480182475, 17559.561010974827, 17883.821161788215, 17910.820891790914, 18021.2791488339, 18152.546186345447, 16455.25951332169, 16625.251863665922, 16717.080560569284, 16928.15359232058, 17037.0, 18902.621947561245, 19111.52221194481, 19137.617247655246, 19180.808191917902, 19189.136488858316, 13844.653883652989, 14284.07153535017, 14303.928480357532, 14336.283185840875, 14419.927900360432, 17936.372226971995, 18009.189586468903, 18110.5472363192, 18124.909375453037, 18168.818311816714], "value": 12203.158390827011, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.900782441317, 1350.6150747037098, 1358.4090920449605, 1363.44098919443, 1374.670079180997, 13971.16173029619, 14116.364763585638, 14515.709685806278, 14603.415863365479, 14639.268036598154, 14667.706645867076, 14910.776338354906, 14954.551363459086, 14956.476523321686, 14992.850071499282, 2651.164883061834, 2679.196241127654, 2698.136596289188, 2698.5277576424146, 2701.3786829029336, 2572.585078206988, 2649.7350264973543, 2683.6377089093016, 2688.6504754381904, 2694.7709444697125, 2573.5496288149593, 2589.9223023309332, 2595.9740402596017, 2656.561667324889, 2659.494696007762, 2590.7538783815603, 2611.837732209168, 2618.48939456806, 2626.566616508274, 2627.5927231279184, 2520.4329025969196, 2525.4191535946834, 2536.1630661881536, 2541.263033720219, 2554.961675574868, 13687.520936767165, 13946.58160255194, 13971.463139054697, 13993.720125597532, 14038.578842634737, 7365.447591430664, 7654.540727556308, 7665.501742386727, 7718.151003389623, 7743.496672716312, 4940.0, 4963.7766300516205, 5132.563732082777, 5177.559907407875, 5182.4299327073995, 1849.861260405475, 1858.8977606231651, 1880.6708825955402, 1916.6933290673564, 1948.3180886689686, 23698.170564030177, 23756.881215593985, 23777.405564860845, 23849.0, 24138.0, 6181.227346581677, 6346.873062538723, 6394.200724909387, 6583.407493325528, 6611.768588099393, 16026.19869006545, 16035.919820400823, 16050.117243551484, 16052.75920861188, 16061.839381606034, 7343.596102214323, 7408.888866666896, 7479.065116860393, 7496.700131994659, 7499.6250187490405, 5734.655920644775, 5975.37258587842, 6597.274299827015, 6873.931260687429, 6892.551984121016, 4923.286123512143, 5152.793888244429, 5175.534201921845, 5180.8963820723375, 5247.921281180786, 1388.7153133607587, 1391.1027387335112, 1397.9650508737363, 1406.1422532255317, 1412.9788053179211, 818.1695578987333, 826.5247482697473, 845.3490812074791, 848.2238751542393, 853.1212850763724, 6837.726490940307, 6866.038754574363, 6871.4502839772695, 6884.623075384943, 6925.0, 684.1892357556312, 689.334791925794, 694.90966174397, 696.1124566178163, 705.5766540076016, 4100.528439229527, 4102.364133559303, 4105.404716316118, 4170.16596680665, 4408.911821763547, 19068.14193361302, 19591.0, 19981.100850461764, 20022.49943751418, 20055.59888802245, 20037.699434508493, 20525.486862828548, 20536.589268214553, 20547.589048218953, 20620.0, 10389.324693895023, 10389.480525973671, 10563.47182640865, 10625.5218515167, 10632.681019569425, 8472.19514146155, 8524.616392262238, 8564.785880353042, 8725.301975842045, 8906.554672266231, 16853.831461685226, 16990.57523561921, 17021.74467383015, 17476.30094796245, 17513.299468021138, 17194.398196063077, 17715.64568708593, 17922.731159032362, 17941.0, 18037.639247215244, 10051.69844904654, 10099.192064634959, 11394.601188958346, 11753.294802311888, 11791.29252244868, 11096.22326437174, 12422.192557484097, 12449.439775209956, 13613.659658508617, 13712.451501939811, 11585.131115166565, 11710.297382157098, 11784.116191285517, 11868.76262474763, 12045.698857528632, 11326.660200194008, 11387.715307117389, 11503.53985840557, 11603.941980290045, 11682.24065435744, 9548.85676714836, 9728.902710973083, 9781.413115212825, 9820.263480239153, 9826.312158148861, 6883.552569082994, 6946.201186863374, 6959.652017399211, 6970.989206565121, 6985.755498557526, 6856.108705868205, 6921.7231310747, 6927.411170050602, 6951.339622735832, 7011.26381729911], "value": 6274.130802838286, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.9192637251667, 485.6880101161054, 504.3569448952585, 515.9613029022823, 520.9817656382025, 6042.697865106744, 6062.939370606293, 6083.178770865938, 6138.785142520012, 6156.56904016719, 5890.911636325448, 5976.432238937294, 5989.3112292086425, 6016.60892042017, 6027.3972602739705, 4856.368672072644, 4868.515102893616, 4875.41495020598, 4882.365292511978, 4887.633427492952, 4757.952420475803, 4851.175300198957, 4911.508849115078, 4953.702777833323, 4961.851144465653, 4738.6446016548725, 4804.471508134103, 4907.11671899058, 4916.721652370392, 4916.926246106311, 4873.269009648563, 4894.5105489451125, 4903.705777653352, 4915.57448339981, 4929.580985616227, 4380.364847097153, 4417.624501917341, 4426.18115648606, 4432.955670443286, 4433.0, 5917.674527900964, 5928.466438020556, 5951.166836642873, 5988.670623115727, 6023.578349515536, 5634.521065709419, 5643.463870932296, 5680.841280313496, 5716.542676585863, 5727.742251598688, 6473.158489396348, 6482.12491313676, 6511.316311787289, 6529.5429319947625, 6553.3446655334565, 4791.688540244873, 4841.394825646794, 4858.149823780859, 4859.0, 4893.021395720834, 6777.898331525031, 6830.453563714891, 6831.897521537131, 6882.380585747257, 6921.377076063179, 4941.6293777966075, 4971.552560269593, 4983.875403114878, 4987.404030710138, 5008.348914641073, 4961.0, 4982.327385802942, 5020.472850350734, 5021.297018417425, 5058.215976523645, 5620.57845661577, 5621.831345059655, 5624.85937851557, 5625.803096891671, 5657.830265092054, 6422.871542569216, 6451.580647258007, 6543.869122617521, 6544.3782840630065, 6556.082148499118, 1665.1341302522621, 1673.723835567142, 1713.306111025037, 1728.1532049295754, 1746.1792957310045, 1134.7673726886135, 1137.6302701622005, 1214.6052532926833, 1215.5198696514826, 1235.6725467751053, 5785.971070144707, 5788.507976822018, 5791.652500849962, 5801.3038435388025, 5820.24336836217, 6418.593027614645, 6461.998390249519, 6532.444742196872, 6598.967005164944, 6614.552615532188, 5545.528630066489, 5704.317226418217, 5736.368999410061, 5759.712014399263, 5790.536757059425, 3445.2610174911006, 3500.807455589916, 3536.3634545782006, 3540.6636369544854, 3551.3785087609567, 6410.0, 6417.839554011093, 6436.967815160894, 6486.254080780676, 6514.794762968866, 6788.981652752127, 6791.3548212919695, 6825.965870170618, 6856.382925536725, 6880.174379074543, 6509.576877502947, 6563.245226798979, 6564.901526477107, 6586.308437614078, 6602.679464107197, 6587.505937054836, 6628.767993120217, 6635.270120286668, 6712.362325579063, 6722.193336799615, 6542.967285163544, 6549.60702357841, 6631.469482441296, 6633.2040155181685, 6641.734330626721, 6459.515536334699, 6525.445337146396, 6555.3772391622715, 6575.0, 6604.14146160996, 4919.752963044373, 4920.720612640811, 4969.0807200668, 4969.428515720739, 4982.975085124551, 6610.851907725862, 6641.369069938348, 6651.800445986628, 6661.933380666325, 6698.2631910488835, 6370.968145159244, 6385.361463853577, 6463.64449955257, 6472.126262954441, 6490.144336491929, 6476.449501792212, 6520.771772987922, 6525.0, 6529.575577587441, 6530.608163510205, 6136.0, 6389.2652344980925, 6396.968015159894, 6422.165118534561, 6428.292887782247, 6183.659898705434, 6301.6534090625455, 6434.0, 6463.64449955257, 6469.191351081115, 6172.833337497082, 6243.125962365363, 6275.748970041147, 6336.303006669171, 6358.904616430665], "value": 4992.1375907444035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [888.8355654203968, 897.5377680494546, 908.5911339897048, 911.2482202183196, 922.7739203895047, 22162.77837221627, 24171.75828241717, 24266.514669706594, 24282.27153185403, 24300.635490467655, 21345.0, 22073.668894966588, 22080.0, 22080.337589872288, 22087.889560552216, 1026.4046852825343, 1031.762694580247, 1033.519413472735, 1040.4433628009017, 1040.9791804163913, 763.0042794153627, 781.5232708048086, 781.9061712594469, 997.2548040928375, 1063.2450959818539, 1075.714935542082, 1076.5101878645237, 1079.4548752879784, 1082.626493859617, 1083.7019819549607, 1084.0677017764756, 1094.529352378477, 1096.5668560918393, 1097.6652121103061, 1098.741795678015, 795.3637090327773, 795.7533164718956, 800.3957012455617, 801.1307731111751, 809.6073404398862, 19985.00074996259, 20374.898125509277, 20630.17479300826, 21237.469063273387, 21266.574668506542, 21730.0, 22025.779742202532, 22221.333359999066, 22248.6662700058, 22615.0, 16813.327466901308, 17032.0, 17161.05614191219, 17390.0, 17554.91222543892, 3491.3191927574135, 3508.298340331944, 3518.9296214075575, 3538.044727923472, 3541.0793193769546, 135154.0, 135823.0, 138169.0, 139043.60956390508, 139352.0, 16693.749593756103, 16847.663046738995, 17007.23467443968, 17008.57478563021, 17080.65838683244, 31541.369172616418, 31620.209494762814, 32111.197220069684, 32148.19629509234, 32183.35633287368, 8350.290225330915, 8446.028706698808, 8574.528400937883, 8592.613332400057, 8606.698765543177, 4201.684873634428, 4305.892352691145, 4333.934990975138, 4334.284843000933, 4349.739015659071, 5267.078261304257, 5270.0, 5360.678359298455, 5384.676919384771, 5391.083515802323, 981.5681100315838, 987.6691308411763, 996.1482932092956, 999.1107913956585, 1009.3741880034279, 637.0635166305524, 650.391883588846, 663.9070530125787, 664.6344510519292, 665.7936039827572, 11422.578470297367, 11664.533418663328, 11775.646730598095, 11965.22226055321, 12162.817557736642, 682.0996284903879, 708.8653155900363, 712.3339677401646, 712.9073220481304, 722.8337482379083, 5493.697846618395, 5748.856278592985, 6007.789727359522, 6063.0, 6158.815235542941, 105333.0, 107903.0, 108797.45601271943, 109444.0, 111267.44366278117, 94799.0, 97958.51020744993, 98343.50828245956, 98507.0, 100890.0, 87102.56448717717, 89109.55445222733, 89235.0, 89639.0, 90618.54690726635, 10689.732756681145, 10811.027007569357, 10910.127189824954, 10935.562577497129, 10954.28797128216, 38975.22049558936, 40053.39919901262, 40373.0, 40437.79781101076, 40969.38545921754, 50569.0, 50916.23625645693, 51064.0, 51930.22104668509, 52477.7376113117, 16764.413245536347, 19497.317593884145, 19992.800071999674, 20099.899500502404, 20105.798942010977, 20727.27454539084, 21305.46736331542, 22075.006624702248, 22328.553428931005, 23035.539289213786, 19379.903100484407, 19480.220791168762, 19716.40850774479, 19843.900780496006, 19939.800601993793, 19359.3224237151, 19934.601307974048, 20460.693089603967, 20547.869867156853, 20552.075156617688, 18810.341638042602, 19104.426867194008, 19226.32707855218, 19294.614107717487, 19373.51566210856, 13133.408996594984, 13260.469581217028, 13685.247311397969, 13854.341066730414, 14545.92727036358, 14248.857511424752, 14304.141751494944, 14399.064060836012, 14919.850801491846, 15084.396624134912], "value": 9297.236542216608, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1574.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 108.0, 116.0, 115.0, 113.0, 119.0, 115.0, 101.0, 113.0, 119.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 128.0, 151.0, 180.0, 121.0, 162.0, 143.0, 123.0, 179.0, 119.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 172.0, 169.0, 167.0, 167.0, 166.0, 173.0, 166.0, 179.0, 173.0], "value": 169.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 81.0, 191.0, 82.0, 85.0, 79.0, 90.0, 104.0, 83.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 132.0, 85.0, 84.0, 83.0, 136.0, 83.0, 85.0, 130.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 126.0, 119.0, 117.0, 116.0, 123.0, 116.0, 121.0, 125.0], "value": 119.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 159.0, 159.0, 152.0, 152.0, 156.0, 151.0, 154.0, 156.0, 153.0], "value": 154.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 99.0, 95.0, 101.0, 105.0, 96.0, 96.0, 100.0, 101.0, 99.0], "value": 98.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 58.0, 54.0, 54.0, 55.0, 55.0, 53.0, 55.0, 54.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 54.0, 55.0, 62.0, 61.0, 57.0, 66.0, 61.0, 60.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 78.0, 86.0, 82.0, 81.0, 87.0, 84.0, 76.0, 77.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 129.0, 127.0, 132.0, 135.0, 126.0, 125.0, 118.0, 126.0, 180.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 188.0, 179.0, 176.0, 184.0, 185.0, 186.0, 186.0, 181.0, 175.0], "value": 182.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 70.0, 69.0, 68.0, 83.0, 68.0, 67.0, 75.0], "value": 70.9, "unit": "score"}]}]} 03:56:46 INFO - Return code: 0 03:56:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:56:46 INFO - # TBPL SUCCESS # 03:56:46 INFO - Running post-action listener: _package_coverage_data 03:56:46 INFO - Running post-action listener: _resource_record_post_action 03:56:46 INFO - [mozharness: 2017-08-16 10:56:46.164507Z] Finished run-tests step (success) 03:56:46 INFO - Running post-run listener: _resource_record_post_run 03:56:46 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 6619136; Write bytes: 440860672; Read time: 548; Write time: 449832 03:56:46 INFO - TinderboxPrint: CPU usage
13.3% 03:56:46 INFO - TinderboxPrint: I/O read bytes / time
6,619,136 / 548 03:56:46 INFO - TinderboxPrint: I/O write bytes / time
440,860,672 / 449,832 03:56:46 INFO - TinderboxPrint: CPU idle
8,280.9 (86.7%) 03:56:46 INFO - TinderboxPrint: CPU user
1,210.0 (12.7%) 03:56:46 INFO - TinderboxPrint: Swap in / out
0 / 0 03:56:46 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 109023232; Read time: 36; Write time: 172460 03:56: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:56:46 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 6610944; Write bytes: 331837440; Read time: 500; Write time: 277372 03:56:46 INFO - Running post-run listener: _upload_blobber_files 03:56:46 INFO - Blob upload gear active. 03:56:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:56:46 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:56:46 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:56:46 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:56:47 INFO - (blobuploader) - INFO - Open directory for files ... 03:56:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:56:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:56:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:48 INFO - (blobuploader) - INFO - Done attempting. 03:56:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:56:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:56:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:54 INFO - (blobuploader) - INFO - Done attempting. 03:56:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:56:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:56:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:55 INFO - (blobuploader) - INFO - Done attempting. 03:56:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:56:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:56:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:56:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:56:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:56:56 INFO - (blobuploader) - INFO - Done attempting. 03:56:56 INFO - (blobuploader) - INFO - Iteration through files over. 03:56:56 INFO - Return code: 0 03:56:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:56:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:56:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa3e12e374f1b0c3190182adc7790e75858e9949c8fc937fd9909559d478cde87f9e5c8c08d7b446a43e0ef89b710009e8c255170c7262c6edfb160652e0f36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fe1e790a50e858076e523512b2fd6b4c3f72755faf6e84bfd175c97a6be9c34743eca6bc3304c7fdb13432b08646470e9dae1e0144786486537c79c390e9b3e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3e4ed4c20078c334b31aecebc4249404c2ddd9093b2bb9e6111f35953f31782e6af0471275d9e453d235e8e4b5636912381b379762ff94ce6caadbee1628b65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0325cc06a99ca218daf061b6f6b7a457fcd26c4d7e076c6d984bd11893e3cd086adea7fe919bb6ac7f340111fb1c12b8a059d65a92175b21fa049160dac48b55"} 03:56:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:56:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:56:56 INFO - Contents: 03:56:56 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa3e12e374f1b0c3190182adc7790e75858e9949c8fc937fd9909559d478cde87f9e5c8c08d7b446a43e0ef89b710009e8c255170c7262c6edfb160652e0f36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fe1e790a50e858076e523512b2fd6b4c3f72755faf6e84bfd175c97a6be9c34743eca6bc3304c7fdb13432b08646470e9dae1e0144786486537c79c390e9b3e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3e4ed4c20078c334b31aecebc4249404c2ddd9093b2bb9e6111f35953f31782e6af0471275d9e453d235e8e4b5636912381b379762ff94ce6caadbee1628b65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0325cc06a99ca218daf061b6f6b7a457fcd26c4d7e076c6d984bd11893e3cd086adea7fe919bb6ac7f340111fb1c12b8a059d65a92175b21fa049160dac48b55"} 03:56:56 INFO - Running post-run listener: copy_logs_to_upload_dir 03:56:56 INFO - Copying logs to upload dir... 03:56:56 INFO - mkdir: /builds/slave/test/build/upload/logs 03:56:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.990613 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-08-16 03:56:55.828126) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:56:55.831328) ========= 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-1502879753.581678-261821074 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/2aa3e12e374f1b0c3190182adc7790e75858e9949c8fc937fd9909559d478cde87f9e5c8c08d7b446a43e0ef89b710009e8c255170c7262c6edfb160652e0f36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fe1e790a50e858076e523512b2fd6b4c3f72755faf6e84bfd175c97a6be9c34743eca6bc3304c7fdb13432b08646470e9dae1e0144786486537c79c390e9b3e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3e4ed4c20078c334b31aecebc4249404c2ddd9093b2bb9e6111f35953f31782e6af0471275d9e453d235e8e4b5636912381b379762ff94ce6caadbee1628b65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0325cc06a99ca218daf061b6f6b7a457fcd26c4d7e076c6d984bd11893e3cd086adea7fe919bb6ac7f340111fb1c12b8a059d65a92175b21fa049160dac48b55"} build_url:https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011500 build_url: 'https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2aa3e12e374f1b0c3190182adc7790e75858e9949c8fc937fd9909559d478cde87f9e5c8c08d7b446a43e0ef89b710009e8c255170c7262c6edfb160652e0f36", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fe1e790a50e858076e523512b2fd6b4c3f72755faf6e84bfd175c97a6be9c34743eca6bc3304c7fdb13432b08646470e9dae1e0144786486537c79c390e9b3e", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3e4ed4c20078c334b31aecebc4249404c2ddd9093b2bb9e6111f35953f31782e6af0471275d9e453d235e8e4b5636912381b379762ff94ce6caadbee1628b65", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0325cc06a99ca218daf061b6f6b7a457fcd26c4d7e076c6d984bd11893e3cd086adea7fe919bb6ac7f340111fb1c12b8a059d65a92175b21fa049160dac48b55"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:56:55.858131) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:56:55.858465) ========= 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-1502879753.581678-261821074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004575 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:56:55.941169) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:56:55.941546) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:56:55.941901) ========= ========= Total master_lag: 0.14 =========