builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-070 starttime: 1502879324.14 results: success (0) revision: 6ebc251bd288c268b020815025b05854ccde5c08 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:44.145236) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:44.145690) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:44.145958) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:44.161392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:44.161652) ========= 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=2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-16 03:28:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-08-16 03:28:44 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144100 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:44.320955) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:44.321257) ========= 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=2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019530 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:44.370098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:44.370393) ========= 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=2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-16 03:28:44,440 truncating revision to first 12 chars 2017-08-16 03:28:44,440 Setting DEBUG logging. 2017-08-16 03:28:44,440 attempt 1/10 2017-08-16 03:28:44,440 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:28:44,855 unpacking tar archive at: mozilla-central-6ebc251bd288/testing/mozharness/ program finished with exit code 0 elapsedTime=0.707551 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:45.095561) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:45.098884) ========= script_repo_revision: 6ebc251bd288c268b020815025b05854ccde5c08 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:45.099237) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:45.099512) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-16 03:28:45.109743) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-16 03:28:45.110000) ========= /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=2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:28:45 INFO - MultiFileLogger online at 20170816 03:28:45 in /builds/slave/test 03:28:45 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:28:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:28:45 INFO - {'append_to_log': False, 03:28:45 INFO - 'base_work_dir': '/builds/slave/test', 03:28:45 INFO - 'blob_upload_branch': 'Firefox', 03:28:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:28:45 INFO - 'branch': 'Firefox', 03:28:45 INFO - 'buildbot_json_path': 'buildprops.json', 03:28:45 INFO - 'code_coverage': False, 03:28:45 INFO - 'config_files': ('talos/linux_config.py',), 03:28:45 INFO - 'default_actions': ('clobber', 03:28:45 INFO - 'read-buildbot-config', 03:28:45 INFO - 'download-and-extract', 03:28:45 INFO - 'populate-webroot', 03:28:45 INFO - 'create-virtualenv', 03:28:45 INFO - 'install', 03:28:45 INFO - 'setup-mitmproxy', 03:28:45 INFO - 'run-tests'), 03:28:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:28:45 INFO - 'disable_ccov_upload': False, 03:28:45 INFO - 'download_minidump_stackwalk': True, 03:28:45 INFO - 'download_symbols': 'ondemand', 03:28:45 INFO - 'enable_stylo': False, 03:28:45 INFO - 'enable_webrender': False, 03:28:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:28:45 INFO - 'tooltool.py': '/tools/tooltool.py', 03:28:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:28:45 INFO - '/tools/misc-python/virtualenv.py')}, 03:28:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:28:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:28:45 INFO - 'gecko_profile': False, 03:28:45 INFO - 'gecko_profile_interval': 0, 03:28:45 INFO - 'installer_path': 'installer.exe', 03:28:45 INFO - 'log_level': 'info', 03:28:45 INFO - 'log_name': 'talos', 03:28:45 INFO - 'log_to_console': True, 03:28:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:28:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:28:45 INFO - 'opt_config_files': (), 03:28:45 INFO - 'pip_index': False, 03:28:45 INFO - 'suite': 'dromaeojs-e10s', 03:28:45 INFO - 'system_bits': '32', 03:28:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:28:45 INFO - 'title': 'talos-linux64-ix-070', 03:28:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:28:45 INFO - 'use_talos_json': True, 03:28:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:28:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:28:45 INFO - 'work_dir': 'build'} 03:28:45 INFO - [mozharness: 2017-08-16 10:28:45.278037Z] Running clobber step. 03:28:45 INFO - Running pre-action listener: _resource_record_pre_action 03:28:45 INFO - Running main action method: clobber 03:28:45 INFO - rmtree: /builds/slave/test/build 03:28:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:28:46 INFO - Running post-action listener: _resource_record_post_action 03:28:46 INFO - [mozharness: 2017-08-16 10:28:46.441648Z] Finished clobber step (success) 03:28:46 INFO - [mozharness: 2017-08-16 10:28:46.441751Z] Running read-buildbot-config step. 03:28:46 INFO - Running pre-action listener: _resource_record_pre_action 03:28:46 INFO - Running main action method: read_buildbot_config 03:28:46 INFO - Using buildbot properties: 03:28:46 INFO - { 03:28:46 INFO - "project": "", 03:28:46 INFO - "product": "firefox", 03:28:46 INFO - "who": "cbook@mozilla.com", 03:28:46 INFO - "installer_path": "public/build/target.tar.bz2", 03:28:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 03:28:46 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:28:46 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 03:28:46 INFO - "stage_platform": "linux64-stylosequential", 03:28:46 INFO - "basedir": "/builds/slave/test", 03:28:46 INFO - "buildnumber": 38, 03:28:46 INFO - "platform": "ubuntu64_hw_styloseq", 03:28:46 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:28:46 INFO - "slavebuilddir": "test", 03:28:46 INFO - "taskId": "Iy2ytLfVR52V6CCIoTqgVQ", 03:28:46 INFO - "branch": "mozilla-central", 03:28:46 INFO - "script_repo_revision": "production", 03:28:46 INFO - "revision": "6ebc251bd288c268b020815025b05854ccde5c08", 03:28:46 INFO - "slavename": "talos-linux64-ix-070", 03:28:46 INFO - "repo_path": "mozilla-central" 03:28:46 INFO - } 03:28:46 INFO - Finding installer, test and symbols from parent task. 03:28:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iy2ytLfVR52V6CCIoTqgVQ'}, attempt #1 03:28:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iy2ytLfVR52V6CCIoTqgVQ'}, attempt #1 03:28:47 INFO - Task dependencies: Ik1VZCnkRAKLMf_kMSI2Ig 03:28:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig'}, attempt #1 03:28:47 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 03:28:47 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.test_packages.json 03:28:47 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.crashreporter-symbols.zip 03:28:47 INFO - Running post-action listener: _resource_record_post_action 03:28:47 INFO - [mozharness: 2017-08-16 10:28:47.847800Z] Finished read-buildbot-config step (success) 03:28:47 INFO - [mozharness: 2017-08-16 10:28:47.848021Z] Running download-and-extract step. 03:28:47 INFO - Running pre-action listener: _resource_record_pre_action 03:28:47 INFO - Running main action method: download_and_extract 03:28:47 INFO - mkdir: /builds/slave/test/build/tests 03:28:47 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:28:47 INFO - trying https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.test_packages.json 03:28:47 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:28:47 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:28:48 INFO - Downloaded 989 bytes. 03:28:48 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:28:48 INFO - Using the following test package requirements: 03:28:48 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:28:48 INFO - u'common': [u'target.common.tests.zip'], 03:28:48 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:28:48 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:28:48 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:28:48 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:28:48 INFO - u'mozbase': [u'target.common.tests.zip'], 03:28:48 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:28:48 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:28:48 INFO - u'web-platform': [u'target.common.tests.zip', 03:28:48 INFO - u'target.web-platform.tests.tar.gz'], 03:28:48 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:28:48 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:28:48 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:28:48 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:28:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.common.tests.zip into memory 03:28:49 INFO - Content-Length response header: 54003804 03:28:49 INFO - Bytes received: 54003804 03:29:00 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:29:00 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:29:00 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:29:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.common.tests.zip into memory 03:29:01 INFO - Content-Length response header: 54003804 03:29:01 INFO - Bytes received: 54003804 03:29:13 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:29:13 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:29:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.talos.tests.zip into memory 03:29:14 INFO - Content-Length response header: 14496050 03:29:14 INFO - Bytes received: 14496050 03:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:14 INFO - trying https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 03:29:14 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:29:14 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:29:16 INFO - Downloaded 61804821 bytes. 03:29:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 03:29:16 INFO - mkdir: /builds/slave/test/properties 03:29:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:29:16 INFO - Writing to file /builds/slave/test/properties/build_url 03:29:16 INFO - Contents: 03:29:16 INFO - build_url:https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 03:29:16 INFO - Running post-action listener: _resource_record_post_action 03:29:16 INFO - Running post-action listener: set_extra_try_arguments 03:29:16 INFO - [mozharness: 2017-08-16 10:29:16.053863Z] Finished download-and-extract step (success) 03:29:16 INFO - [mozharness: 2017-08-16 10:29:16.053961Z] Running populate-webroot step. 03:29:16 INFO - Running pre-action listener: _resource_record_pre_action 03:29:16 INFO - Running main action method: populate_webroot 03:29:16 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:29:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:29:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:29:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:29:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:29:16 INFO - 'tests': ['damp', 'tps']}, 03:29:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:29:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:29:16 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:29:16 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:29:16 INFO - 'other-e10s': {'tests': ['a11yr', 03:29:16 INFO - 'ts_paint', 03:29:16 INFO - 'tpaint', 03:29:16 INFO - 'sessionrestore', 03:29:16 INFO - 'sessionrestore_many_windows', 03:29:16 INFO - 'sessionrestore_no_auto_restore', 03:29:16 INFO - 'tabpaint']}, 03:29:16 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:29:16 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:29:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:29:16 INFO - 'tsvgr_opacity', 03:29:16 INFO - 'tart', 03:29:16 INFO - 'tscrollx', 03:29:16 INFO - 'tsvg_static']}, 03:29:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:29:16 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:16 INFO - 'talos_options': ['--mitmproxy', 03:29:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:16 INFO - '--firstNonBlankPaint'], 03:29:16 INFO - 'tests': ['tp6_google', 03:29:16 INFO - 'tp6_youtube', 03:29:16 INFO - 'tp6_amazon', 03:29:16 INFO - 'tp6_facebook']}, 03:29:16 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:16 INFO - 'talos_options': ['--stylo', 03:29:16 INFO - '--mitmproxy', 03:29:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:16 INFO - '--firstNonBlankPaint'], 03:29:16 INFO - 'tests': ['tp6_google', 03:29:16 INFO - 'tp6_youtube', 03:29:16 INFO - 'tp6_amazon', 03:29:16 INFO - 'tp6_facebook']}, 03:29:16 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:29:16 INFO - 'talos_options': ['--stylo', 03:29:16 INFO - '--stylo-threads=1', 03:29:16 INFO - '--mitmproxy', 03:29:16 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:29:16 INFO - '--firstNonBlankPaint'], 03:29:16 INFO - 'tests': ['tp6_google', 03:29:16 INFO - 'tp6_youtube', 03:29:16 INFO - 'tp6_amazon', 03:29:16 INFO - 'tp6_facebook']}, 03:29:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:29:16 INFO - 'talos_options': ['--xperf_path', 03:29:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:29:16 INFO - 'tests': ['tp5n']}}} 03:29:16 INFO - Running post-action listener: _resource_record_post_action 03:29:16 INFO - [mozharness: 2017-08-16 10:29:16.062362Z] Finished populate-webroot step (success) 03:29:16 INFO - [mozharness: 2017-08-16 10:29:16.062451Z] Running create-virtualenv step. 03:29:16 INFO - Running pre-action listener: _resource_record_pre_action 03:29:16 INFO - Running main action method: create_virtualenv 03:29:16 INFO - Creating virtualenv /builds/slave/test/build/venv 03:29:16 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:29:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:29:16 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:29:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:29:16 INFO - Using real prefix '/usr' 03:29:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:29:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:29:18 INFO - Installing pip.................done. 03:29:18 INFO - Return code: 0 03:29:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:29:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:29:18 INFO - Reading from file tmpfile_stdout 03:29:18 INFO - Output received: 03:29:18 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:29:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:29:18 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:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:18 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:29:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:18 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 0xd011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa60b0>, '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 0xfa6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa7440>, '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': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', '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:29:18 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:29:18 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:29:18 INFO - Using env: {'DISPLAY': ':0', 03:29:18 INFO - 'HOME': '/home/cltbld', 03:29:18 INFO - 'LANG': 'en_US.UTF-8', 03:29:18 INFO - 'LANGUAGE': 'en_US:en', 03:29:18 INFO - 'LOGNAME': 'cltbld', 03:29:18 INFO - 'MAIL': '/var/mail/cltbld', 03:29:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:18 INFO - 'MOZ_NO_REMOTE': '1', 03:29:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:18 INFO - 'NO_EM_RESTART': '1', 03:29:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:18 INFO - 'PWD': '/builds/slave/test', 03:29:18 INFO - 'SHELL': '/bin/bash', 03:29:18 INFO - 'SHLVL': '1', 03:29:18 INFO - 'TERM': 'linux', 03:29:18 INFO - 'TMOUT': '86400', 03:29:18 INFO - 'USER': 'cltbld', 03:29:18 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', 03:29:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:18 INFO - '_': '/tools/buildbot/bin/python'} 03:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:19 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:29:19 INFO - Cleaning up... 03:29:19 INFO - Return code: 0 03:29:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:29:19 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:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:19 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:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:19 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 0xd011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa60b0>, '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 0xfa6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa7440>, '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': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', '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:29:19 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:29:19 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:29:19 INFO - Using env: {'DISPLAY': ':0', 03:29:19 INFO - 'HOME': '/home/cltbld', 03:29:19 INFO - 'LANG': 'en_US.UTF-8', 03:29:19 INFO - 'LANGUAGE': 'en_US:en', 03:29:19 INFO - 'LOGNAME': 'cltbld', 03:29:19 INFO - 'MAIL': '/var/mail/cltbld', 03:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:19 INFO - 'MOZ_NO_REMOTE': '1', 03:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:19 INFO - 'NO_EM_RESTART': '1', 03:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:19 INFO - 'PWD': '/builds/slave/test', 03:29:19 INFO - 'SHELL': '/bin/bash', 03:29:19 INFO - 'SHLVL': '1', 03:29:19 INFO - 'TERM': 'linux', 03:29:19 INFO - 'TMOUT': '86400', 03:29:19 INFO - 'USER': 'cltbld', 03:29:19 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', 03:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:19 INFO - '_': '/tools/buildbot/bin/python'} 03:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:19 INFO - Downloading/unpacking psutil>=3.1.1 03:29:19 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:29:19 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:29:19 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:29:19 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:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:29:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:20 INFO - Installing collected packages: psutil 03:29:20 INFO - Running setup.py install for psutil 03:29:20 INFO - building 'psutil._psutil_linux' extension 03:29:20 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:29:20 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:29:20 INFO - building 'psutil._psutil_posix' extension 03:29:20 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:29:20 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:29:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:29:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:29:21 INFO - Successfully installed psutil 03:29:21 INFO - Cleaning up... 03:29:21 INFO - Return code: 0 03:29:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:29:21 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:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:21 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:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:21 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 0xd011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa60b0>, '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 0xfa6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa7440>, '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': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', '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:29:21 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:29:21 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:29:21 INFO - Using env: {'DISPLAY': ':0', 03:29:21 INFO - 'HOME': '/home/cltbld', 03:29:21 INFO - 'LANG': 'en_US.UTF-8', 03:29:21 INFO - 'LANGUAGE': 'en_US:en', 03:29:21 INFO - 'LOGNAME': 'cltbld', 03:29:21 INFO - 'MAIL': '/var/mail/cltbld', 03:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:21 INFO - 'MOZ_NO_REMOTE': '1', 03:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:21 INFO - 'NO_EM_RESTART': '1', 03:29:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:21 INFO - 'PWD': '/builds/slave/test', 03:29:21 INFO - 'SHELL': '/bin/bash', 03:29:21 INFO - 'SHLVL': '1', 03:29:21 INFO - 'TERM': 'linux', 03:29:21 INFO - 'TMOUT': '86400', 03:29:21 INFO - 'USER': 'cltbld', 03:29:21 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', 03:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:21 INFO - '_': '/tools/buildbot/bin/python'} 03:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:29:21 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:29:21 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:29:21 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:29:21 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:29:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:29:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:29:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:29:22 INFO - Installing collected packages: mozsystemmonitor 03:29:22 INFO - Running setup.py install for mozsystemmonitor 03:29:22 INFO - Successfully installed mozsystemmonitor 03:29:22 INFO - Cleaning up... 03:29:22 INFO - Return code: 0 03:29:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:29:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:22 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 0xd011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa60b0>, '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 0xfa6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa7440>, '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': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', '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:29:22 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:29:22 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:29:22 INFO - Using env: {'DISPLAY': ':0', 03:29:22 INFO - 'HOME': '/home/cltbld', 03:29:22 INFO - 'LANG': 'en_US.UTF-8', 03:29:22 INFO - 'LANGUAGE': 'en_US:en', 03:29:22 INFO - 'LOGNAME': 'cltbld', 03:29:22 INFO - 'MAIL': '/var/mail/cltbld', 03:29:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:22 INFO - 'MOZ_NO_REMOTE': '1', 03:29:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:22 INFO - 'NO_EM_RESTART': '1', 03:29:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:22 INFO - 'PWD': '/builds/slave/test', 03:29:22 INFO - 'SHELL': '/bin/bash', 03:29:22 INFO - 'SHLVL': '1', 03:29:22 INFO - 'TERM': 'linux', 03:29:22 INFO - 'TMOUT': '86400', 03:29:22 INFO - 'USER': 'cltbld', 03:29:22 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', 03:29:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:22 INFO - '_': '/tools/buildbot/bin/python'} 03:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:22 INFO - Downloading/unpacking jsonschema==2.5.1 03:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:29:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:23 INFO - Downloading functools32-3.2.3-2.tar.gz 03:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:29:24 INFO - warning: no files found matching '*.txt' 03:29:24 INFO - no previously-included directories found matching 'build' 03:29:24 INFO - no previously-included directories found matching 'dist' 03:29:24 INFO - no previously-included directories found matching '.git*' 03:29:24 INFO - Installing collected packages: jsonschema, functools32 03:29:24 INFO - Running setup.py install for functools32 03:29:24 INFO - warning: no files found matching '*.txt' 03:29:24 INFO - no previously-included directories found matching 'build' 03:29:24 INFO - no previously-included directories found matching 'dist' 03:29:24 INFO - no previously-included directories found matching '.git*' 03:29:24 INFO - Successfully installed jsonschema functools32 03:29:24 INFO - Cleaning up... 03:29:24 INFO - Return code: 0 03:29:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:29:24 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:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:24 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:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:24 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 0xd011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa60b0>, '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 0xfa6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa7440>, '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': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', '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:29:24 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:29:24 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:29:24 INFO - Using env: {'DISPLAY': ':0', 03:29:24 INFO - 'HOME': '/home/cltbld', 03:29:24 INFO - 'LANG': 'en_US.UTF-8', 03:29:24 INFO - 'LANGUAGE': 'en_US:en', 03:29:24 INFO - 'LOGNAME': 'cltbld', 03:29:24 INFO - 'MAIL': '/var/mail/cltbld', 03:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:24 INFO - 'MOZ_NO_REMOTE': '1', 03:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:24 INFO - 'NO_EM_RESTART': '1', 03:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:24 INFO - 'PWD': '/builds/slave/test', 03:29:24 INFO - 'SHELL': '/bin/bash', 03:29:24 INFO - 'SHLVL': '1', 03:29:24 INFO - 'TERM': 'linux', 03:29:24 INFO - 'TMOUT': '86400', 03:29:24 INFO - 'USER': 'cltbld', 03:29:24 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', 03:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:24 INFO - '_': '/tools/buildbot/bin/python'} 03:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:29:24 INFO - Cleaning up... 03:29:24 INFO - Return code: 0 03:29:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:29:24 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:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:24 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:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:24 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 0xd011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa60b0>, '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 0xfa6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa7440>, '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': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', '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:29:24 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:29:24 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:29:24 INFO - Using env: {'DISPLAY': ':0', 03:29:24 INFO - 'HOME': '/home/cltbld', 03:29:24 INFO - 'LANG': 'en_US.UTF-8', 03:29:24 INFO - 'LANGUAGE': 'en_US:en', 03:29:24 INFO - 'LOGNAME': 'cltbld', 03:29:24 INFO - 'MAIL': '/var/mail/cltbld', 03:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:24 INFO - 'MOZ_NO_REMOTE': '1', 03:29:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:24 INFO - 'NO_EM_RESTART': '1', 03:29:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:24 INFO - 'PWD': '/builds/slave/test', 03:29:24 INFO - 'SHELL': '/bin/bash', 03:29:24 INFO - 'SHLVL': '1', 03:29:24 INFO - 'TERM': 'linux', 03:29:24 INFO - 'TMOUT': '86400', 03:29:24 INFO - 'USER': 'cltbld', 03:29:24 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', 03:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:24 INFO - '_': '/tools/buildbot/bin/python'} 03:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:24 INFO - Downloading/unpacking blobuploader==1.2.4 03:29:24 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:29:24 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:29:24 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:29:24 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:29:25 INFO - Downloading blobuploader-1.2.4.tar.gz 03:29:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:29:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:29:25 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:29:25 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:29:25 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:29:25 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:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:29:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:26 INFO - Downloading docopt-0.6.1.tar.gz 03:29:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:29:26 INFO - Installing collected packages: blobuploader, requests, docopt 03:29:26 INFO - Running setup.py install for blobuploader 03:29:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:29:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:29:26 INFO - Running setup.py install for requests 03:29:26 INFO - Running setup.py install for docopt 03:29:26 INFO - Successfully installed blobuploader requests docopt 03:29:26 INFO - Cleaning up... 03:29:26 INFO - Return code: 0 03:29:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:26 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 0xd011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa60b0>, '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 0xfa6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa7440>, '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': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', '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:29:26 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:29:26 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:29:26 INFO - Using env: {'DISPLAY': ':0', 03:29:26 INFO - 'HOME': '/home/cltbld', 03:29:26 INFO - 'LANG': 'en_US.UTF-8', 03:29:26 INFO - 'LANGUAGE': 'en_US:en', 03:29:26 INFO - 'LOGNAME': 'cltbld', 03:29:26 INFO - 'MAIL': '/var/mail/cltbld', 03:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:27 INFO - 'MOZ_NO_REMOTE': '1', 03:29:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:27 INFO - 'NO_EM_RESTART': '1', 03:29:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:27 INFO - 'PWD': '/builds/slave/test', 03:29:27 INFO - 'SHELL': '/bin/bash', 03:29:27 INFO - 'SHLVL': '1', 03:29:27 INFO - 'TERM': 'linux', 03:29:27 INFO - 'TMOUT': '86400', 03:29:27 INFO - 'USER': 'cltbld', 03:29:27 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', 03:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:27 INFO - '_': '/tools/buildbot/bin/python'} 03:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:27 INFO - Running setup.py (path:/tmp/pip-uzu2ED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:27 INFO - Running setup.py (path:/tmp/pip-DgxxZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:27 INFO - Running setup.py (path:/tmp/pip-J7NrGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:27 INFO - Running setup.py (path:/tmp/pip-tjrE35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:27 INFO - Running setup.py (path:/tmp/pip-5mRFis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:27 INFO - Running setup.py (path:/tmp/pip-OyRtg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:27 INFO - Running setup.py (path:/tmp/pip-KdIuYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:27 INFO - Running setup.py (path:/tmp/pip-MT6akn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:27 INFO - Running setup.py (path:/tmp/pip-YgPkA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:27 INFO - Running setup.py (path:/tmp/pip-xXhHVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:27 INFO - Running setup.py (path:/tmp/pip-Zvk1Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:28 INFO - Running setup.py (path:/tmp/pip-6z56f3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:28 INFO - Running setup.py (path:/tmp/pip-AraLF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:28 INFO - Running setup.py (path:/tmp/pip-5IS2XI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:28 INFO - Running setup.py (path:/tmp/pip-kRgJgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:28 INFO - Running setup.py (path:/tmp/pip-7t3Ybx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:28 INFO - Running setup.py (path:/tmp/pip-EDXBMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:29:28 INFO - Running setup.py install for manifestparser 03:29:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:29:28 INFO - Running setup.py install for mozcrash 03:29:28 INFO - Running setup.py install for mozdebug 03:29:28 INFO - Running setup.py install for mozdevice 03:29:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:29:28 INFO - Running setup.py install for mozfile 03:29:28 INFO - Running setup.py install for mozhttpd 03:29:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Running setup.py install for mozinfo 03:29:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Running setup.py install for mozInstall 03:29:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Running setup.py install for mozleak 03:29:29 INFO - Running setup.py install for mozlog 03:29:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Running setup.py install for moznetwork 03:29:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Running setup.py install for mozprocess 03:29:29 INFO - Running setup.py install for mozprofile 03:29:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Running setup.py install for mozrunner 03:29:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:29:29 INFO - Running setup.py install for mozscreenshot 03:29:29 INFO - Running setup.py install for moztest 03:29:30 INFO - Running setup.py install for mozversion 03:29:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:29:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:29:30 INFO - Cleaning up... 03:29:30 INFO - Return code: 0 03:29:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:30 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 0xd011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa60b0>, '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 0xfa6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa7440>, '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': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', '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:29:30 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:29:30 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:29:30 INFO - Using env: {'DISPLAY': ':0', 03:29:30 INFO - 'HOME': '/home/cltbld', 03:29:30 INFO - 'LANG': 'en_US.UTF-8', 03:29:30 INFO - 'LANGUAGE': 'en_US:en', 03:29:30 INFO - 'LOGNAME': 'cltbld', 03:29:30 INFO - 'MAIL': '/var/mail/cltbld', 03:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:30 INFO - 'MOZ_NO_REMOTE': '1', 03:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:30 INFO - 'NO_EM_RESTART': '1', 03:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:30 INFO - 'PWD': '/builds/slave/test', 03:29:30 INFO - 'SHELL': '/bin/bash', 03:29:30 INFO - 'SHLVL': '1', 03:29:30 INFO - 'TERM': 'linux', 03:29:30 INFO - 'TMOUT': '86400', 03:29:30 INFO - 'USER': 'cltbld', 03:29:30 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', 03:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:30 INFO - '_': '/tools/buildbot/bin/python'} 03:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:29:30 INFO - Running setup.py (path:/tmp/pip-ThWy0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:29:30 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:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:29:30 INFO - Running setup.py (path:/tmp/pip-7B2Kg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:29:30 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:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:29:30 INFO - Running setup.py (path:/tmp/pip-iAuB5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:29:30 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:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:29:30 INFO - Running setup.py (path:/tmp/pip-XRiIx2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:29:30 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:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:29:30 INFO - Running setup.py (path:/tmp/pip-IwpTAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:29:30 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:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:29:30 INFO - Running setup.py (path:/tmp/pip-K44hk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:29:30 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:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:29:30 INFO - Running setup.py (path:/tmp/pip-JWsXK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:29:30 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:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:29:30 INFO - Running setup.py (path:/tmp/pip-p4E1XP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:29:30 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:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:29:30 INFO - Running setup.py (path:/tmp/pip-uvjd99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:29:31 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:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:29:31 INFO - Running setup.py (path:/tmp/pip-lE2YoV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:29:31 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:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:29:31 INFO - Running setup.py (path:/tmp/pip-7ND9Cn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:29:31 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:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:29:31 INFO - Running setup.py (path:/tmp/pip-67dNpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:29:31 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:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:29:31 INFO - Running setup.py (path:/tmp/pip-M5DUD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:29:31 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:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:29:31 INFO - Running setup.py (path:/tmp/pip-Bwd_HN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:29:31 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:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:31 INFO - Running setup.py (path:/tmp/pip-Iegvbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:29:31 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:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:29:31 INFO - Running setup.py (path:/tmp/pip-McW1sN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:29:31 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:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:29:31 INFO - Running setup.py (path:/tmp/pip-r1umd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:29:31 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:29:31 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:29:31 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:29:31 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:29:31 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:29:31 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:29:31 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:29:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:29:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:29:32 INFO - Downloading blessings-1.6.tar.gz 03:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:29:32 INFO - Installing collected packages: blessings 03:29:32 INFO - Running setup.py install for blessings 03:29:32 INFO - Successfully installed blessings 03:29:32 INFO - Cleaning up... 03:29:32 INFO - Return code: 0 03:29:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:29:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:33 INFO - Reading from file tmpfile_stdout 03:29:33 INFO - Current package versions: 03:29:33 INFO - argparse == 1.2.1 03:29:33 INFO - blessings == 1.6 03:29:33 INFO - blobuploader == 1.2.4 03:29:33 INFO - docopt == 0.6.1 03:29:33 INFO - functools32 == 3.2.3-2 03:29:33 INFO - jsonschema == 2.5.1 03:29:33 INFO - manifestparser == 1.1 03:29:33 INFO - mozInstall == 1.13 03:29:33 INFO - mozcrash == 1.0 03:29:33 INFO - mozdebug == 0.1 03:29:33 INFO - mozdevice == 0.51 03:29:33 INFO - mozfile == 1.2 03:29:33 INFO - mozhttpd == 0.7 03:29:33 INFO - mozinfo == 0.10 03:29:33 INFO - mozleak == 0.1 03:29:33 INFO - mozlog == 3.5 03:29:33 INFO - moznetwork == 0.27 03:29:33 INFO - mozprocess == 0.25 03:29:33 INFO - mozprofile == 0.28 03:29:33 INFO - mozrunner == 6.13 03:29:33 INFO - mozscreenshot == 0.1 03:29:33 INFO - mozsystemmonitor == 0.3 03:29:33 INFO - moztest == 0.8 03:29:33 INFO - mozversion == 1.4 03:29:33 INFO - psutil == 3.1.1 03:29:33 INFO - requests == 1.2.3 03:29:33 INFO - wsgiref == 0.1.2 03:29:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:29: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:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29:33 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 0xd011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa60b0>, '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 0xfa6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa7440>, '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': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', '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:29:33 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:29:33 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:29:33 INFO - Using env: {'DISPLAY': ':0', 03:29:33 INFO - 'HOME': '/home/cltbld', 03:29:33 INFO - 'LANG': 'en_US.UTF-8', 03:29:33 INFO - 'LANGUAGE': 'en_US:en', 03:29:33 INFO - 'LOGNAME': 'cltbld', 03:29:33 INFO - 'MAIL': '/var/mail/cltbld', 03:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:33 INFO - 'MOZ_NO_REMOTE': '1', 03:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:33 INFO - 'NO_EM_RESTART': '1', 03:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:33 INFO - 'PWD': '/builds/slave/test', 03:29:33 INFO - 'SHELL': '/bin/bash', 03:29:33 INFO - 'SHLVL': '1', 03:29:33 INFO - 'TERM': 'linux', 03:29:33 INFO - 'TMOUT': '86400', 03:29:33 INFO - 'USER': 'cltbld', 03:29:33 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', 03:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:33 INFO - '_': '/tools/buildbot/bin/python'} 03:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:33 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:29:33 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:29:33 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:29:33 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:29:33 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:29:33 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:29:33 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:29:33 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:29:33 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:29:33 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:29: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:29: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:29: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:29: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:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:29:34 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:29:34 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:29:34 INFO - Installing collected packages: simplejson 03:29:34 INFO - Running setup.py install for simplejson 03:29:34 INFO - building 'simplejson._speedups' extension 03:29:34 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:29:35 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:29:35 INFO - Successfully installed simplejson 03:29:35 INFO - Cleaning up... 03:29:35 INFO - Return code: 0 03:29:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:29: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:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:29: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:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:29: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe05a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa8ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfa60b0>, '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 0xfa6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa7440>, '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': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', '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:29: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', 'jsonschema'] in /builds/slave/test/build 03:29: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 jsonschema 03:29:35 INFO - Using env: {'DISPLAY': ':0', 03:29:35 INFO - 'HOME': '/home/cltbld', 03:29:35 INFO - 'LANG': 'en_US.UTF-8', 03:29:35 INFO - 'LANGUAGE': 'en_US:en', 03:29:35 INFO - 'LOGNAME': 'cltbld', 03:29:35 INFO - 'MAIL': '/var/mail/cltbld', 03:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:35 INFO - 'MOZ_NO_REMOTE': '1', 03:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:35 INFO - 'NO_EM_RESTART': '1', 03:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:35 INFO - 'PWD': '/builds/slave/test', 03:29:35 INFO - 'SHELL': '/bin/bash', 03:29:35 INFO - 'SHLVL': '1', 03:29:35 INFO - 'TERM': 'linux', 03:29:35 INFO - 'TMOUT': '86400', 03:29:35 INFO - 'USER': 'cltbld', 03:29:35 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', 03:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:35 INFO - '_': '/tools/buildbot/bin/python'} 03:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:29:35 INFO - Cleaning up... 03:29:35 INFO - Return code: 0 03:29:35 INFO - Running post-action listener: _resource_record_post_action 03:29:35 INFO - Running post-action listener: _start_resource_monitoring 03:29:35 INFO - Starting resource monitoring. 03:29:35 INFO - [mozharness: 2017-08-16 10:29:35.913208Z] Finished create-virtualenv step (success) 03:29:35 INFO - [mozharness: 2017-08-16 10:29:35.913836Z] Running install step. 03:29:35 INFO - Running pre-action listener: _resource_record_pre_action 03:29:35 INFO - Running main action method: install 03:29:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:29:36 INFO - Reading from file tmpfile_stdout 03:29:36 INFO - Detecting whether we're running mozinstall >=1.0... 03:29:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:29:36 INFO - Reading from file tmpfile_stdout 03:29:36 INFO - Output received: 03:29:36 INFO - Usage: mozinstall [options] installer 03:29:36 INFO - Options: 03:29:36 INFO - -h, --help show this help message and exit 03:29:36 INFO - -d DEST, --destination=DEST 03:29:36 INFO - Directory to install application into. [default: 03:29:36 INFO - "/builds/slave/test"] 03:29:36 INFO - --app=APP Application being installed. [default: firefox] 03:29:36 INFO - mkdir: /builds/slave/test/build/application 03:29:36 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:29:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:29:54 INFO - Reading from file tmpfile_stdout 03:29:54 INFO - Output received: 03:29:54 INFO - /builds/slave/test/build/application/firefox/firefox 03:29:54 INFO - Running post-action listener: _resource_record_post_action 03:29:54 INFO - [mozharness: 2017-08-16 10:29:54.215610Z] Finished install step (success) 03:29:54 INFO - [mozharness: 2017-08-16 10:29:54.215862Z] Running setup-mitmproxy step. 03:29:54 INFO - Running pre-action listener: _resource_record_pre_action 03:29:54 INFO - Running main action method: setup_mitmproxy 03:29:54 INFO - Skipping: mitmproxy is not required 03:29:54 INFO - Running post-action listener: _resource_record_post_action 03:29:54 INFO - [mozharness: 2017-08-16 10:29:54.216996Z] Finished setup-mitmproxy step (success) 03:29:54 INFO - [mozharness: 2017-08-16 10:29:54.217216Z] Running run-tests step. 03:29:54 INFO - Running pre-action listener: _resource_record_pre_action 03:29:54 INFO - Running pre-action listener: _set_gcov_prefix 03:29:54 INFO - Running main action method: run_tests 03:29:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:29:54 INFO - Python 2.7.3 03:29:54 INFO - Return code: 0 03:29:54 INFO - grabbing minidump binary from tooltool 03:29:54 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:29:54 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 0xfa60b0>, '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 0xfa6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfa7440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:29:54 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:29:54 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:29:54 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:29:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:29:54 INFO - Return code: 0 03:29:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:29:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:29:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:29:54 INFO - ENV: RUST_BACKTRACE is now full 03:29:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:29:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:29:54 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-070', '--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:29:54 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-070 --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:29:54 INFO - Using env: {'DISPLAY': ':0', 03:29:54 INFO - 'HOME': '/home/cltbld', 03:29:54 INFO - 'LANG': 'en_US.UTF-8', 03:29:54 INFO - 'LANGUAGE': 'en_US:en', 03:29:54 INFO - 'LOGNAME': 'cltbld', 03:29:54 INFO - 'MAIL': '/var/mail/cltbld', 03:29:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:29:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:29:54 INFO - 'MOZ_NO_REMOTE': '1', 03:29:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:29:54 INFO - 'NO_EM_RESTART': '1', 03:29:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:29:54 INFO - 'PWD': '/builds/slave/test', 03:29:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:29:54 INFO - 'RUST_BACKTRACE': 'full', 03:29:54 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:29:54 INFO - 'SHELL': '/bin/bash', 03:29:54 INFO - 'SHLVL': '1', 03:29:54 INFO - 'STYLO_FORCE_ENABLED': '1', 03:29:54 INFO - 'TERM': 'linux', 03:29:54 INFO - 'TMOUT': '86400', 03:29:54 INFO - 'USER': 'cltbld', 03:29:54 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601', 03:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:29:54 INFO - '_': '/tools/buildbot/bin/python'} 03:29:54 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-070', '--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:29:54 INFO - mozversion application_buildid: 20170816092342 03:29:54 INFO - mozversion application_changeset: 6ebc251bd288c268b020815025b05854ccde5c08 03:29:54 INFO - mozversion application_display_name: Nightly 03:29:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:29:54 INFO - mozversion application_name: Firefox 03:29:54 INFO - mozversion application_remotingname: firefox 03:29:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:29:54 INFO - mozversion application_vendor: Mozilla 03:29:54 INFO - mozversion application_version: 57.0a1 03:29:54 INFO - mozversion platform_buildid: 20170816092342 03:29:54 INFO - mozversion platform_changeset: 6ebc251bd288c268b020815025b05854ccde5c08 03:29:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:29:54 INFO - mozversion platform_version: 57.0a1 03:29:54 INFO - using testdate: 1502879394 03:29:54 INFO - actual date: 1502879394 03:29:54 INFO - starting webserver on 'localhost:51900' 03:29:54 INFO - SUITE-START | Running 2 tests 03:29:54 INFO - TEST-START | dromaeo_css 03:29:54 INFO - Initialising browser for dromaeo_css test... 03:29:54 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51900/getInfo.html -profile /tmp/tmpvKKm3L/profile 03:29:54 INFO - TEST-INFO | started process 13877 (/builds/slave/test/build/application/firefox/firefox http://localhost:51900/getInfo.html) 03:30:00 INFO - TEST-INFO | 13877: exit 0 03:30:00 INFO - Browser initialized. 03:30:00 INFO - Running cycle 1/1 for dromaeo_css test... 03:30:00 INFO - TEST-INFO | started process 14111 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvKKm3L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:30:01 INFO - PID 14111 | 03:30:01 INFO - PID 14111 | (/builds/slave/test/build/application/firefox/firefox:14166): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:30:01 INFO - PID 14111 | 03:30:12 INFO - PID 14111 | RSS: Main: 167825408 03:30:12 INFO - PID 14111 | 03:33:10 INFO - PID 14111 | Cycle 1(1): loaded http://localhost:51900/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51900/tests/dromaeo/cssquery-ext.html) 03:33:12 INFO - PID 14111 | RSS: Main: 175435776 03:33:12 INFO - PID 14111 | 03:36:13 INFO - PID 14111 | Cycle 1(1): loaded http://localhost:51900/tests/dromaeo/cssquery-ext.html (next: http://localhost:51900/tests/dromaeo/cssquery-jquery.html) 03:36:14 INFO - PID 14111 | RSS: Main: 172621824 03:36:14 INFO - PID 14111 | 03:39:16 INFO - PID 14111 | Cycle 1(1): loaded http://localhost:51900/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51900/tests/dromaeo/cssquery-mootools.html) 03:39:16 INFO - PID 14111 | RSS: Main: 174764032 03:39:16 INFO - PID 14111 | 03:42:18 INFO - PID 14111 | Cycle 1(1): loaded http://localhost:51900/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51900/tests/dromaeo/cssquery-prototype.html) 03:42:19 INFO - PID 14111 | RSS: Main: 173297664 03:42:19 INFO - PID 14111 | 03:45:22 INFO - PID 14111 | Cycle 1(1): loaded http://localhost:51900/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51900/tests/dromaeo/cssquery-yui.html) 03:45:23 INFO - PID 14111 | RSS: Main: 176476160 03:45:23 INFO - PID 14111 | 03:48:25 INFO - PID 14111 | Cycle 1(1): loaded http://localhost:51900/tests/dromaeo/cssquery-yui.html (next: http://localhost:51900/tests/dromaeo/cssquery-dojo.html) 03:48:25 INFO - PID 14111 | RSS: Main: 176971776 03:48:25 INFO - PID 14111 | 03:48:25 INFO - PID 14111 | __start_tp_report 03:48:25 INFO - PID 14111 | _x_x_mozilla_page_load 03:48:25 INFO - PID 14111 | _x_x_mozilla_page_load_details 03:48:25 INFO - PID 14111 | |i|pagename|runs| 03:48:25 INFO - PID 14111 | |0;dojo.html;3083.2446050717576;3116.8909088181913;3146.0719087869074;3152.9910428662824;3153.590033295671;6058.697065146742;6156.692165391729;6160.9999999999945;6247.750089996394;6294.842628934279;6197.938020619792;6216.316205217422;6236.84407889803;6293.496520278378;6303.338149494306;5594.328680558338;5622.128570071645;5699.373068962411;5716.199732037498;5719.714014299289;5571.303587051619;5642.915356269659;5675.063614503622;5692.459216374438;5705.25831641886;5615.2700148980775;5646.040173170571;5707.71461426927;5721.713914304268;5727.914081288784;5471.042567550663;5608.5793565482345;5619.381867994517;5693.572982026365;5697.914531282034;5468.28912241406;5477.643953143033;5483.287172667528;5494.780208791683;5508.91736623951;6020.548458865559;6073.726682299307;6101.938980610226;6134.17188679527;6148.446639802394;6629.403353698142;6704.631245281507;6707.463402927754;6717.1267735194115;6728.865422691568;6688.264290927994;6718.225216515966;6719.798406047827;6779.220389655204;6805.421539169177;6050.909236361458;6137.171481849982;6173.536984726164;6208.906866397007;6307.936920630781;6667.699953502104;6741.460683145337;6789.966050169717;6801.047853300542;6814.557053791487;6441.32366101562;6450.387213214737;6528.183977002875;6534.215894092739;6537.477001839841;6531.412172904462;6566.277709451956;6628.9393697008245;6636.900446493307;6654.534182607171;6403;6458.54790164684;6534.836629084216;6570.868582628416;6666.96666516674;6702.329767023259;6705.597664140069;6712.530122891449;6713.0937323461685;6715.630640314829;5413.648112872651;5426.62013659048;5479.726013699299;5482.698451585121;5490;4585.656075794329;4645.0477652081245;4657.650676199299;4679.134360143385;4679.321498382716;5673.858153546112;5762.654240745569;5783.884322313615;5794.739236734357;5836.649801011953;6664.466842652673;6684.331566843374;6713.060171575983;6716.1604799400075;6722.697478613474;5641.661500309994;5808.796692115756;5813.6221145625395;5822.1266809978;5822.82531524055;5857;5870;5921.644701317935;5924.466797988115;5940.495057920039;6304.401081897304;6396.0725694774;6404.7117879695525;6465.353464653591;6479.643619600873;6679.732810687712;6707.5975441473665;6716.126903502513;6743.460523158037;6792.320767923168;6463.224413070461;6470.838229044123;6478.6760661967655;6525.804225873231;6563.146790917151;6542.741352146592;6556.147700798866;6621.404073633396;6631.834204144742;6648.700808463727;6562;6659.800205993828;6661.866762664623;6677.532572719863;6781.423578995643;6289.874202516015;6317.810465686037;6326.620402775849;6423.42189202974;6435.581687190318;6501.902471463027;6510.609363438209;6512.869742605027;6534.281229064704;6535.2811190768025;6376.266729326187;6462.579932304385;6466.4503517201565;6467.062275970052;6475.870482590416;6481.870362592627;6503.219613646393;6543.770968016097;6615.867682646416;6620.205575330991;6155.169052178077;6206.658633775005;6250.4687101595055;6315.368463153648;6361.777337793155 03:48:25 INFO - PID 14111 | |1;ext.html;805.9032916050074;808.9878651820223;836.322578711244;862.504060165405;869.1916517638598;41623.167536649285;42421.3636795448;42439;42460.787696061474;42483.57516424831;37929.431058534145;38054;38360.42459363112;38419.80790096053;38633;6732.057511948331;6752.122224110859;6820.624865632388;6863.656817159147;6866.553674011173;6729.394354508093;6798.52410331277;6804.659767011654;6805.421539169177;6808.183018037842;7533.7363192288285;7705.845883082363;7726.343260822809;7727.150013498511;7739.496932699385;7585.431092668072;7607.505512141693;7616.885746713804;7676.577788221645;7677.155512893577;7311.122665280147;7460.6642701078035;7644.197359277251;7656.808579785495;7689.461737678364;40887.1822563547;40891.7955410224;41339.793301033606;41341.1731765363;41363.7931810339;3542.8405721742324;3550.343186510504;3555.839987200582;3577.4276115821604;3589.74871758977;32372.6762732372;32383.514247286308;32389.352212955844;32437.6756232437;32445;5006.699598024094;5025.974870125662;5040.747962601892;5057.216131499624;5070.670406423571;196395;196685;197529;198295;198674;49986.25020624621;50019.74990125099;50275.497245027815;50279.24581131286;50504.494955050715;52666.73666631642;53034.73482632562;53050.73474632602;53086.73456632692;53138.46861531412;16761.161941902858;17045.31818727237;17109.315627374766;17145.22846471912;17184.570385740208;14053.648658783408;14057.297135143406;14058.43766249359;14100.647483812987;14153.504627337994;15180.316885740169;15197;15208.467703630542;15216.174059112976;15308.693826123637;5836.562257830679;5895.941040589625;5929.466348028698;5939.227900372924;6165.075238714139;993.9552720127612;1010.0858722855827;1019.607451131305;1021.9489025548693;1022.9488525573692;23282.65076023861;23386.883065584905;23480.64779028316;23502.64746028811;23666;1116.0848104554188;1117.2067831839486;1120.7534342444649;1128.5598616539555;1136.4204255829586;12202.572909948109;12284.631461056182;12322.445489952974;12343.753124937452;12556.246625202517;239106;240754;240802;241150;243116;55038.724806375714;55264.723676382164;56002.71998639981;59258.70370648119;59273;1467.7431449496296;1471.5217554294898;1491.4183468447313;1493.37278343094;1498.4980031689506;26939.191824245303;27097.864510677322;27330.863345683938;27571.31071723223;27713.86143069272;38335.23329533338;38645;38764.2247155061;38802.80598596989;38883;199368;199890;200035;200143;200208;33595.32809343848;33660;33773.493397599545;33915.32169356648;33970;41862;43082.353764692925;43603.90990225143;43717.78141109274;43790;32217.076238197402;32734.50898236481;33243.50134747932;33294;33531.66468335286;32136.517952230268;32441.351172975938;32753.836230818695;33047.33905321928;33257.50113748344;34522.65477345194;34975.475367868996;35305;35543.119457901375;35808.28383432369;31522.527162093047;32003.83998079995;32214.19464513406;32441.188970274987;32733.836330819147;22899.31302060941;23476.53046939086;23844;23845;23847.642285365386 03:48:25 INFO - PID 14111 | |2;jquery.html;575.1688809670028;576.2767726503238;581.9447152520512;583.6235628019928;591.2815928646694;21170.89414552927;22049.448763780892;22135.225267115675;22145.557088858255;22413.32760017198;26605.600915986226;26849.463010739775;27134.18597442075;27134.728652713467;27151.592726109076;6414.839629009265;6581.210254769434;6582.440492558138;6586.5718728282745;6587.143671322721;5954.106883967396;6460.612363258219;6461.19235095613;6476.805695829133;6481.935180648204;6428.421442070213;6429.32492088331;6439.678016099199;6440.3237660045725;6443.516736244777;6422.421982021617;6423.518236132262;6424.5502814802985;6424.550281480321;6432.324605916405;5882.499987501067;5979.730912108922;5979.880402391927;5987.161797348374;6008.158857759917;28548.571771423445;29210.70789292101;29599.260018499495;30086;30102.54846177309;1868.4207895552422;1908.1699460734626;1909.980900191008;1910.9713354299697;1911.9617607647908;19272.807271927242;19536.902315488333;19690.31083912056;19779.802201978084;19836.30572929955;2384.7376788553247;2400.291913885408;2431.3556907419547;2432.0758111917535;2490.638857365672;143936;147352.99999999892;147846;147914;148173;14918.925405372904;15512.379504819906;15575.454859079879;15584.610384740472;15968.920155399148;23761.16835910735;23775.405614859767;23819.880900595384;23833.40416489567;24088.75911240865;10189.235807314333;10419.166466682647;10581.41802200871;10584.841227381596;10692.839607405895;7916.208379162153;9774.853377199348;9778.511074446249;9785.706428807147;9920.950395248123;8141;9533.427994320224;9778.706638800848;9779.897322075787;9794.559244834;2737.7536021758137;2760.2259728972253;2765.419261955012;2792.3577577157366;2871.4687782760257;957.8802649668792;972.4214092614883;977.4282045003753;989.218517371283;999.7200783780553;19835.504112397306;20000.799991999895;20056.799432005784;20078.37805414486;20125;1037.5590374090982;1040.9011143941314;1041.833306670929;1044.2637940252105;1047.7904419116055;10816.134709223243;11153.38656373891;11355.37545435009;13635.590932272047;14109.153450792985;466862;541767;545506;553819;557095;128923.35538322249;130599.34700326438;130613;131851;131905.34047329702;1252.931088790107;1319.182107093608;1340.3566288181728;1344.8991325650616;1357.9796303055462;20896.537242392886;21528;21864.45338866541;22115.66826497636;22300.888495557418;60855.69572152111;61525.69237153786;62513.687431562554;63227.6838615804;63392.68303658452;75994;77071.2292877064;77226.6138669303;77863;78923.21076789159;16417.17914104266;17228.655426891644;20308.898455507628;20823.687644685644;21365;23908.163214288114;24177.63733543963;24179;24222.152224672052;24562.631560526963;18855.528611784815;18967.810321896606;18987.810121898605;19010.1445434953;19055.14251858642;16815.41146059882;17219.397321094202;17350.21924013397;17622.29510819553;17837.375691850724;18834.905825470785;19044.333448329242;19071.90464047671;19085.427437176906;19206.61586768285;20552.17791288332;20573.691394629393;20613.03254401048;20732.170713171305;20771.896140519202;18711.812881871007;18736.906315468335;18813.153408096943;18896.338628147947;18954.715679265097 03:48:25 INFO - PID 14111 | |3;mootools.html;1358.9184648921066;1396.4204854985182;1425.5723283015093;1428.3286855178062;1430.2705620133736;14074.718505629895;14603.415863365466;14664.340104695288;14668.193249371307;14723.337449814771;13937.581872543815;14341.78487322691;15059.096454212755;15073.924630376832;15105.924470377633;2709.9593506097426;2755.655543057118;2756.8897244110212;2759.1446651537985;2759.986200068997;2484.900603975848;2610.216934919526;2641.3000554852883;2686.6775986881603;2691.286808995618;2705.8105932584726;2732.945341093177;2735.6990731019573;2736.315921019745;2740.260129764962;2651.549236629768;2667.9066232681957;2669.4394177222807;2670.305720512661;2679.062328185139;2584.470183612355;2630.7500787425165;2639.762421382085;2645.2196602002455;2649.894004239828;14154.43382264708;14283.714325713532;14285.142891426547;14286.142831430148;14305.713885722227;6996.160460744743;7292.16140143885;7303.050603421574;7319.34125928669;7325.7802265932105;4833.154198015333;4873.220284754422;4943.604511639096;4992.87517812054;5006.849794506171;1886.9150888210063;1897.108359071248;1903.6192761447628;1927.6048410076041;1931.951701207467;23208.883955580284;23446.296611101694;23480.178193763306;23489;23501.88249058761;6235.469985051231;6343.732977516583;6548.017797330439;6598.37315455031;6666.766663166863;16367.345306187857;16384.590385240463;16392.098434586213;16393.18034098314;16396.672066558604;7078.398336141486;7224.747133850396;7239.457040721967;7308.780736577911;7309.415246780245;6311.179546658905;6705.1283333166375;6724.831879202961;6733.427658648971;6739.764108256188;5170.638055336166;5247.344081989751;5279.498447647467;5303.496167864047;5404.081306177959;1302.3423171298434;1384.1003347823794;1458.3874772595536;1460.9196494192709;1481.4222453243244;860.2945584620676;888.7822483491457;903.3811838890381;914.9313801464916;925.8287216864901;8929.873814828476;8986.415882967716;9118.179363857285;9126.771830704152;9127.817443651222;996.3722854601555;1010.7220514358463;1013.9188864890791;1020.5560581147076;1021.3616489693941;5252.448492908266;5367.973160134175;5437.32033495813;5450.91823622646;5506.559475242051;18790.154443050094;19365.709514357295;19621.901890490455;19622;19864.304749333704;19696.803031969783;20069;20186.293479728138;20438.69341959872;20468.79531204669;10601.416922069206;10647.828738838722;10977.28647637917;11304.660860174208;11328.2070255083;7790.220977902164;7862.174471680391;8039.356851451987;8203.343732501506;8309.83380332378;17324.220410081827;17457.30170793154;17600.29598816033;17608.38370657021;17823.376181834094;17452.214650340513;17653.969793473916;17730.556736081184;18123.54691132732;18475.076246187367;11426.143039272254;11768.646940591796;11780.705482362666;11782.11634127461;11808.763824723286;13224.346956630421;13395.665108372368;13456;13467.595972120853;13520.729585408433;10869.456527173768;10989;11108.555657773923;11250.7749845001;11379.943100284776;10486.47567621631;10701.19741019411;10843.512041958289;10901.400422976496;11006.614768483385;9689;9694.079062489052;9853.802923941337;9862.211023118276;9869.407835529892;7032.789016329519;7060;7088.574685518885;7090.373075138791;7224.024756657994;7597.430192735456;7615.504992175491;7724;7754.302112809874;7765.61171941412 03:48:25 INFO - PID 14111 | |4;prototype.html;492.95001646492966;504.94193167785716;510.5354127743753;511.94624564420735;525.5454032262095;6260.812175634733;6324.367563243679;6328.59513384913;6394.232692076951;6463.806085817421;6158.846028849281;6162.815115546541;6193.380661933805;6235.657038862861;6252.3122456529745;4858.659893807435;4971.353724015873;5052.722100284483;5064.164412871872;5090.541851233388;4955.578775804043;4991.875203119915;5018.272350509174;5020.7740651670765;5040.521150490716;4995.750212489361;5008.2738002989545;5010.774515146809;5034.09386310464;5050.116229659813;4979;4994.800207991658;5021.096202683516;5038.949610503884;5039.622028347889;4513.842015529473;4517.018767613359;4536.795844186987;4540.636749060067;4544.386507821468;6046.486048685867;6111.113888486189;6174.84562885927;6180.258368995749;6198.876022479525;5753.913691294634;5758.740856661419;5773.653580785166;5783.681897495636;5787.13193021046;6681.298463661343;6686.899696504556;6699.665016749192;6700.396964273239;6717.899231511531;4923.8276660316715;4924.827631032933;4940.2342636891335;4942.061008408391;4956.925646115311;6739.427148692367;6808;6928.54500554879;6991.23096459389;7057.400120989722;5030.421501527371;5067.974660126676;5075.543201111917;5076.923846142311;5089.295086146182;5110.872228194325;5168.3797944246935;5177.326947496801;5187.533122018961;5190.351206099238;5657.850016993599;5706.258186435737;5736.225609542742;5795.652260864362;5797.652140871562;6598.241202261705;6634.175601709569;6643.30245324234;6651.966740166365;6734.56225345351;1792.8386445219992;1807.1416077363147;1808.7286906964061;1811.791643960935;1813.6826055440245;1161.529580519874;1210.6368089573093;1234.962951111468;1239.6652903715947;1245.8380410546752;5831.504322132581;5852.502537284294;5859.326177489644;5914.378990206053;5916.408359164136;6587.011948207807;6690.698918548677;6781.796546103625;6840.589564626139;6874.518783685194;5742.397048309867;5843.824685259449;5854.882902342015;5871.500922421642;5887.793927212527;3631.455281707765;3634.036980200249;3640.1445660269815;3665.9816700916326;3697.3379166999716;6524.706388212542;6552.180977377828;6674.299198584175;6695.631740254333;6699.11937866722;6840.418564421981;6953.235144134142;7009.61447120403;7029.29707029293;7049.9647501762165;6544.70548825304;6655.73377064912;6682.5322227444585;6686.297938716365;6728.831779205461;6355.809325720235;6859.725610975505;6876.793696189123;6889.448844092361;6903.654817259016;6767.864642707217;6785.219699734594;6787.219469760843;6790;6795.218549866829;6688;6693.966530167513;6723.193216814014;6723.2604413515455;6756.223034351113;5067.947481270092;5075.5178258065425;5084.567811735896;5091.770870310771;5098.1588037973315;6655.401013908771;6806.693698783468;6812.965935170292;6876.621785801629;6928.060143159923;6439.356064393523;6526.412622863965;6537.8692426152165;6542.803715888531;6583.670816459062;6470;6475.255345635313;6556.623109147133;6612.305707900601;6663;6439.388258115471;6487.767324208386;6504.772332968323;6535.869282614226;6613.570117942319;6660.167479065117;6694.59832410057;6703.463722902254;6708.530402871947;6720.6975686093265;6430.260520040255;6447;6472.576033272672;6520.152380190545;6557.508186886098 03:48:25 INFO - PID 14111 | |5;yui.html;894.3515950935569;921.0191146429057;921.3918813583034;925.495604895332;937.3157594955683;17969.55076123096;18621.627567448642;18727;18739.531511712215;21914.89042554785;21710.457238569044;22229.77770222297;22299.777002229974;22344.776552234514;22355.888220558914;1028.115820394462;1054.1988089052338;1059.5496913811598;1062.909652679523;1063.457636605333;1009.2892547132614;1061.257120015988;1067.9199060070525;1070.3417398300028;1070.3577853288004;1105.171121658756;1118.546988469667;1121.0023079459288;1122.2705241592948;1123.2474242257706;1108.1245815805503;1111.2332490581555;1111.6109361723413;1112.288135593217;1113.9443027848615;812.8943237379162;813.3818298093432;813.5525460996488;813.7233340664144;814.1492140712969;19890.70163947542;20109;20275.695864562043;20349.593008139753;20604;21248.787512124836;21713.240036598643;21797.455063623376;21860.672089918666;22219.333419997427;16925;16928.83071169297;17081.316747330093;17139;17245.741313880302;3657.945130823013;3662.029562166028;3690.409534474471;3695.5195824542907;3695.7782533048103;130272;130540;132281.3385933074;133060;135469.3226533871;17016.404425845038;17134.57163570896;17595.73606395905;17597;17629.823701763074;30548.84725576358;31088.84455577753;31651.20871978173;31854.362912741617;31942.680573194437;7601.505902116345;7935.166807485131;8457.661693532313;8504.489730616182;8674.436161649473;4453.1761624099645;4501.324801279834;4505.279155335131;4510.774461276923;4517.638588912879;5194.220866869924;5251.632385733038;5334.973325133427;5343.572514198855;5354.625176237626;998.9500524973722;999.4153420249236;1021.3616489693941;1022.1873610479687;1022.4427686910651;682.4301708073814;698.8532408194336;703.4969996452561;707.3209718670134;711.0081436396301;11790.94104529472;12610.621681349574;12859.742805143846;12861.871381286255;13043.804342934864;679.0832376291967;683.5386114372778;683.6513378177166;687.3264201082967;689.5586824432368;5923.7926672566255;6162.198914141133;6173.228346456693;6173.660448675366;6232.657203853832;119198;119526;119568;121532.39233803951;126168.7383126157;100081.49959250157;101755.4912225449;104045;104569.47715261375;106522;88158;89713;91011;92136.07863921409;92668.53665731628;11081.556737730723;11087.959145942223;11141.786924144415;11159.609413670483;11276.94361528187;40441;40666;41351.1729765409;42238.57761422469;42959.355609665254;52362.73818630882;53289.73355133199;53579.73210133924;54223.72888135692;55779.44220557905;16484.83515164881;16623.667526649642;16644.334226631283;16683.49949501517;16694.58263543421;16691.83308166903;16894.155292235584;16920.15399230009;16934.40729574459;17014.829851701325;16866.072366019496;17055.147242638068;17163.65672686514;17182.22679979429;17231.483055508354;15889.364425422853;15909.840901590836;15913.761293580837;15921.840781592498;16088.597785054999;16295.67408651844;16349.427770027993;16395.42616008434;16404.507864764077;16419.343226270816;11325.943370283425;11396.316221026766;11747.412629368326;11766.352850593299;11858.288502689866;11816.291022538675;11829.645110646694;11882.346470944181;12123;15127.243637818285 03:48:25 INFO - PID 14111 | __end_tp_report 03:48:25 INFO - PID 14111 | __start_cc_report 03:48:25 INFO - PID 14111 | _x_x_mozilla_cycle_collect,351 03:48:25 INFO - PID 14111 | __end_cc_report 03:48:25 INFO - PID 14111 | __startTimestamp1502880505682__endTimestamp 03:48:25 INFO - PID 14111 | 03:48:25 INFO - PID 14111 | ------- Summary: start ------- 03:48:25 INFO - PID 14111 | Number of tests: 6 03:48:25 INFO - PID 14111 | 03:48:25 INFO - PID 14111 | [#0] dojo.html Cycles:165 Average:6115.18 Median:6326.62 stddev:724.48 (11.5%) stddev-sans-first:686.55 03:48:25 INFO - PID 14111 | Values: 3083.2 3116.9 3146.1 3153.0 3153.6 6058.7 6156.7 6161.0 6247.8 6294.8 6197.9 6216.3 6236.8 6293.5 6303.3 5594.3 5622.1 5699.4 5716.2 5719.7 5571.3 5642.9 5675.1 5692.5 5705.3 5615.3 5646.0 5707.7 5721.7 5727.9 5471.0 5608.6 5619.4 5693.6 5697.9 5468.3 5477.6 5483.3 5494.8 5508.9 6020.5 6073.7 6101.9 6134.2 6148.4 6629.4 6704.6 6707.5 6717.1 6728.9 6688.3 6718.2 6719.8 6779.2 6805.4 6050.9 6137.2 6173.5 6208.9 6307.9 6667.7 6741.5 6790.0 6801.0 6814.6 6441.3 6450.4 6528.2 6534.2 6537.5 6531.4 6566.3 6628.9 6636.9 6654.5 6403.0 6458.5 6534.8 6570.9 6667.0 6702.3 6705.6 6712.5 6713.1 6715.6 5413.6 5426.6 5479.7 5482.7 5490.0 4585.7 4645.0 4657.7 4679.1 4679.3 5673.9 5762.7 5783.9 5794.7 5836.6 6664.5 6684.3 6713.1 6716.2 6722.7 5641.7 5808.8 5813.6 5822.1 5822.8 5857.0 5870.0 5921.6 5924.5 5940.5 6304.4 6396.1 6404.7 6465.4 6479.6 6679.7 6707.6 6716.1 6743.5 6792.3 6463.2 6470.8 6478.7 6525.8 6563.1 6542.7 6556.1 6621.4 6631.8 6648.7 6562.0 6659.8 6661.9 6677.5 6781.4 6289.9 6317.8 6326.6 6423.4 6435.6 6501.9 6510.6 6512.9 6534.3 6535.3 6376.3 6462.6 6466.5 6467.1 6475.9 6481.9 6503.2 6543.8 6615.9 6620.2 6155.2 6206.7 6250.5 6315.4 6361.8 03:48:25 INFO - PID 14111 | 03:48:25 INFO - PID 14111 | [#1] ext.html Cycles:180 Average:38614.58 Median:35140.24 stddev:55424.94 (157.7%) stddev-sans-first:55507.71 03:48:25 INFO - PID 14111 | Values: 805.9 809.0 836.3 862.5 869.2 41623.2 42421.4 42439.0 42460.8 42483.6 37929.4 38054.0 38360.4 38419.8 38633.0 6732.1 6752.1 6820.6 6863.7 6866.6 6729.4 6798.5 6804.7 6805.4 6808.2 7533.7 7705.8 7726.3 7727.2 7739.5 7585.4 7607.5 7616.9 7676.6 7677.2 7311.1 7460.7 7644.2 7656.8 7689.5 40887.2 40891.8 41339.8 41341.2 41363.8 3542.8 3550.3 3555.8 3577.4 3589.7 32372.7 32383.5 32389.4 32437.7 32445.0 5006.7 5026.0 5040.7 5057.2 5070.7 196395.0 196685.0 197529.0 198295.0 198674.0 49986.3 50019.7 50275.5 50279.2 50504.5 52666.7 53034.7 53050.7 53086.7 53138.5 16761.2 17045.3 17109.3 17145.2 17184.6 14053.6 14057.3 14058.4 14100.6 14153.5 15180.3 15197.0 15208.5 15216.2 15308.7 5836.6 5895.9 5929.5 5939.2 6165.1 994.0 1010.1 1019.6 1021.9 1022.9 23282.7 23386.9 23480.6 23502.6 23666.0 1116.1 1117.2 1120.8 1128.6 1136.4 12202.6 12284.6 12322.4 12343.8 12556.2 239106.0 240754.0 240802.0 241150.0 243116.0 55038.7 55264.7 56002.7 59258.7 59273.0 1467.7 1471.5 1491.4 1493.4 1498.5 26939.2 27097.9 27330.9 27571.3 27713.9 38335.2 38645.0 38764.2 38802.8 38883.0 199368.0 199890.0 200035.0 200143.0 200208.0 33595.3 33660.0 33773.5 33915.3 33970.0 41862.0 43082.4 43603.9 43717.8 43790.0 32217.1 32734.5 33243.5 33294.0 33531.7 32136.5 32441.4 32753.8 33047.3 33257.5 34522.7 34975.5 35305.0 35543.1 35808.3 31522.5 32003.8 32214.2 32441.2 32733.8 22899.3 23476.5 23844.0 23845.0 23847.6 03:48:25 INFO - PID 14111 | 03:48:25 INFO - PID 14111 | [#2] jquery.html Cycles:180 Average:37566.92 Median:23768.29 stddev:90096.56 (379.1%) stddev-sans-first:90306.49 03:48:25 INFO - PID 14111 | Values: 575.2 576.3 581.9 583.6 591.3 21170.9 22049.4 22135.2 22145.6 22413.3 26605.6 26849.5 27134.2 27134.7 27151.6 6414.8 6581.2 6582.4 6586.6 6587.1 5954.1 6460.6 6461.2 6476.8 6481.9 6428.4 6429.3 6439.7 6440.3 6443.5 6422.4 6423.5 6424.6 6424.6 6432.3 5882.5 5979.7 5979.9 5987.2 6008.2 28548.6 29210.7 29599.3 30086.0 30102.5 1868.4 1908.2 1910.0 1911.0 1912.0 19272.8 19536.9 19690.3 19779.8 19836.3 2384.7 2400.3 2431.4 2432.1 2490.6 143936.0 147353.0 147846.0 147914.0 148173.0 14918.9 15512.4 15575.5 15584.6 15968.9 23761.2 23775.4 23819.9 23833.4 24088.8 10189.2 10419.2 10581.4 10584.8 10692.8 7916.2 9774.9 9778.5 9785.7 9921.0 8141.0 9533.4 9778.7 9779.9 9794.6 2737.8 2760.2 2765.4 2792.4 2871.5 957.9 972.4 977.4 989.2 999.7 19835.5 20000.8 20056.8 20078.4 20125.0 1037.6 1040.9 1041.8 1044.3 1047.8 10816.1 11153.4 11355.4 13635.6 14109.2 466862.0 541767.0 545506.0 553819.0 557095.0 128923.4 130599.3 130613.0 131851.0 131905.3 1252.9 1319.2 1340.4 1344.9 1358.0 20896.5 21528.0 21864.5 22115.7 22300.9 60855.7 61525.7 62513.7 63227.7 63392.7 75994.0 77071.2 77226.6 77863.0 78923.2 16417.2 17228.7 20308.9 20823.7 21365.0 23908.2 24177.6 24179.0 24222.2 24562.6 18855.5 18967.8 18987.8 19010.1 19055.1 16815.4 17219.4 17350.2 17622.3 17837.4 18834.9 19044.3 19071.9 19085.4 19206.6 20552.2 20573.7 20613.0 20732.2 20771.9 18711.8 18736.9 18813.2 18896.3 18954.7 03:48:25 INFO - PID 14111 | 03:48:25 INFO - PID 14111 | [#3] mootools.html Cycles:180 Average:8926.34 Median:2597.34 stddev:6123.00 (235.7%) stddev-sans-first:6113.78 03:48:25 INFO - PID 14111 | Values: 1358.9 1396.4 1425.6 1428.3 1430.3 14074.7 14603.4 14664.3 14668.2 14723.3 13937.6 14341.8 15059.1 15073.9 15105.9 2710.0 2755.7 2756.9 2759.1 2760.0 2484.9 2610.2 2641.3 2686.7 2691.3 2705.8 2732.9 2735.7 2736.3 2740.3 2651.5 2667.9 2669.4 2670.3 2679.1 2584.5 2630.8 2639.8 2645.2 2649.9 14154.4 14283.7 14285.1 14286.1 14305.7 6996.2 7292.2 7303.1 7319.3 7325.8 4833.2 4873.2 4943.6 4992.9 5006.8 1886.9 1897.1 1903.6 1927.6 1932.0 23208.9 23446.3 23480.2 23489.0 23501.9 6235.5 6343.7 6548.0 6598.4 6666.8 16367.3 16384.6 16392.1 16393.2 16396.7 7078.4 7224.7 7239.5 7308.8 7309.4 6311.2 6705.1 6724.8 6733.4 6739.8 5170.6 5247.3 5279.5 5303.5 5404.1 1302.3 1384.1 1458.4 1460.9 1481.4 860.3 888.8 903.4 914.9 925.8 8929.9 8986.4 9118.2 9126.8 9127.8 996.4 1010.7 1013.9 1020.6 1021.4 5252.4 5368.0 5437.3 5450.9 5506.6 18790.2 19365.7 19621.9 19622.0 19864.3 19696.8 20069.0 20186.3 20438.7 20468.8 10601.4 10647.8 10977.3 11304.7 11328.2 7790.2 7862.2 8039.4 8203.3 8309.8 17324.2 17457.3 17600.3 17608.4 17823.4 17452.2 17654.0 17730.6 18123.5 18475.1 11426.1 11768.6 11780.7 11782.1 11808.8 13224.3 13395.7 13456.0 13467.6 13520.7 10869.5 10989.0 11108.6 11250.8 11379.9 10486.5 10701.2 10843.5 10901.4 11006.6 9689.0 9694.1 9853.8 9862.2 9869.4 7032.8 7060.0 7088.6 7090.4 7224.0 7597.4 7615.5 7724.0 7754.3 7765.6 03:48:25 INFO - PID 14111 | 03:48:25 INFO - PID 14111 | [#4] prototype.html Cycles:180 Average:5585.98 Median:6186.82 stddev:1568.45 (25.4%) stddev-sans-first:1525.56 03:48:25 INFO - PID 14111 | Values: 493.0 504.9 510.5 511.9 525.5 6260.8 6324.4 6328.6 6394.2 6463.8 6158.8 6162.8 6193.4 6235.7 6252.3 4858.7 4971.4 5052.7 5064.2 5090.5 4955.6 4991.9 5018.3 5020.8 5040.5 4995.8 5008.3 5010.8 5034.1 5050.1 4979.0 4994.8 5021.1 5038.9 5039.6 4513.8 4517.0 4536.8 4540.6 4544.4 6046.5 6111.1 6174.8 6180.3 6198.9 5753.9 5758.7 5773.7 5783.7 5787.1 6681.3 6686.9 6699.7 6700.4 6717.9 4923.8 4924.8 4940.2 4942.1 4956.9 6739.4 6808.0 6928.5 6991.2 7057.4 5030.4 5068.0 5075.5 5076.9 5089.3 5110.9 5168.4 5177.3 5187.5 5190.4 5657.9 5706.3 5736.2 5795.7 5797.7 6598.2 6634.2 6643.3 6652.0 6734.6 1792.8 1807.1 1808.7 1811.8 1813.7 1161.5 1210.6 1235.0 1239.7 1245.8 5831.5 5852.5 5859.3 5914.4 5916.4 6587.0 6690.7 6781.8 6840.6 6874.5 5742.4 5843.8 5854.9 5871.5 5887.8 3631.5 3634.0 3640.1 3666.0 3697.3 6524.7 6552.2 6674.3 6695.6 6699.1 6840.4 6953.2 7009.6 7029.3 7050.0 6544.7 6655.7 6682.5 6686.3 6728.8 6355.8 6859.7 6876.8 6889.4 6903.7 6767.9 6785.2 6787.2 6790.0 6795.2 6688.0 6694.0 6723.2 6723.3 6756.2 5067.9 5075.5 5084.6 5091.8 5098.2 6655.4 6806.7 6813.0 6876.6 6928.1 6439.4 6526.4 6537.9 6542.8 6583.7 6470.0 6475.3 6556.6 6612.3 6663.0 6439.4 6487.8 6504.8 6535.9 6613.6 6660.2 6694.6 6703.5 6708.5 6720.7 6430.3 6447.0 6472.6 6520.2 6557.5 03:48:25 INFO - PID 14111 | 03:48:25 INFO - PID 14111 | [#5] yui.html Cycles:180 Average:23875.27 Median:17596.37 stddev:33719.45 (191.6%) stddev-sans-first:33769.89 03:48:25 INFO - PID 14111 | Values: 894.4 921.0 921.4 925.5 937.3 17969.6 18621.6 18727.0 18739.5 21914.9 21710.5 22229.8 22299.8 22344.8 22355.9 1028.1 1054.2 1059.5 1062.9 1063.5 1009.3 1061.3 1067.9 1070.3 1070.4 1105.2 1118.5 1121.0 1122.3 1123.2 1108.1 1111.2 1111.6 1112.3 1113.9 812.9 813.4 813.6 813.7 814.1 19890.7 20109.0 20275.7 20349.6 20604.0 21248.8 21713.2 21797.5 21860.7 22219.3 16925.0 16928.8 17081.3 17139.0 17245.7 3657.9 3662.0 3690.4 3695.5 3695.8 130272.0 130540.0 132281.3 133060.0 135469.3 17016.4 17134.6 17595.7 17597.0 17629.8 30548.8 31088.8 31651.2 31854.4 31942.7 7601.5 7935.2 8457.7 8504.5 8674.4 4453.2 4501.3 4505.3 4510.8 4517.6 5194.2 5251.6 5335.0 5343.6 5354.6 999.0 999.4 1021.4 1022.2 1022.4 682.4 698.9 703.5 707.3 711.0 11790.9 12610.6 12859.7 12861.9 13043.8 679.1 683.5 683.7 687.3 689.6 5923.8 6162.2 6173.2 6173.7 6232.7 119198.0 119526.0 119568.0 121532.4 126168.7 100081.5 101755.5 104045.0 104569.5 106522.0 88158.0 89713.0 91011.0 92136.1 92668.5 11081.6 11088.0 11141.8 11159.6 11276.9 40441.0 40666.0 41351.2 42238.6 42959.4 52362.7 53289.7 53579.7 54223.7 55779.4 16484.8 16623.7 16644.3 16683.5 16694.6 16691.8 16894.2 16920.2 16934.4 17014.8 16866.1 17055.1 17163.7 17182.2 17231.5 15889.4 15909.8 15913.8 15921.8 16088.6 16295.7 16349.4 16395.4 16404.5 16419.3 11325.9 11396.3 11747.4 11766.4 11858.3 11816.3 11829.6 11882.3 12123.0 15127.2 03:48:25 INFO - PID 14111 | -------- Summary: end -------- 03:48:25 INFO - PID 14111 | 03:48:26 INFO - TEST-INFO | 14111: exit 0 03:48:26 INFO - TEST-OK | dromaeo_css | took 1111800ms 03:48:26 INFO - TEST-START | kraken 03:48:26 INFO - Initialising browser for kraken test... 03:48:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51900/getInfo.html -profile /tmp/tmpFMcXw5/profile 03:48:26 INFO - TEST-INFO | started process 14486 (/builds/slave/test/build/application/firefox/firefox http://localhost:51900/getInfo.html) 03:48:32 INFO - TEST-INFO | 14486: exit 0 03:48:32 INFO - Browser initialized. 03:48:32 INFO - Running cycle 1/1 for kraken test... 03:48:32 INFO - TEST-INFO | started process 14720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFMcXw5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:48:33 INFO - PID 14720 | 03:48:33 INFO - PID 14720 | (/builds/slave/test/build/application/firefox/firefox:14773): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 03:48:33 INFO - PID 14720 | 03:48:43 INFO - PID 14720 | RSS: Main: 168398848 03:48:43 INFO - PID 14720 | 03:48:46 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51900/tests/kraken/driver.html?testName=audio-beat-detection) 03:48:47 INFO - PID 14720 | RSS: Main: 174125056 03:48:47 INFO - PID 14720 | 03:48:50 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51900/tests/kraken/driver.html?testName=audio-dft) 03:48:50 INFO - PID 14720 | RSS: Main: 177975296 03:48:50 INFO - PID 14720 | 03:48:53 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51900/tests/kraken/driver.html?testName=audio-fft) 03:48:54 INFO - PID 14720 | RSS: Main: 172199936 03:48:54 INFO - PID 14720 | 03:48:56 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51900/tests/kraken/driver.html?testName=audio-oscillator) 03:48:57 INFO - PID 14720 | RSS: Main: 172478464 03:48:57 INFO - PID 14720 | 03:48:59 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51900/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:49:00 INFO - PID 14720 | RSS: Main: 172761088 03:49:00 INFO - PID 14720 | 03:49:03 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51900/tests/kraken/driver.html?testName=imaging-darkroom) 03:49:04 INFO - PID 14720 | RSS: Main: 174252032 03:49:04 INFO - PID 14720 | 03:49:07 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51900/tests/kraken/driver.html?testName=imaging-desaturate) 03:49:08 INFO - PID 14720 | RSS: Main: 173535232 03:49:08 INFO - PID 14720 | 03:49:11 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51900/tests/kraken/driver.html?testName=json-parse-financial) 03:49:11 INFO - PID 14720 | RSS: Main: 174358528 03:49:11 INFO - PID 14720 | 03:49:13 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51900/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:49:14 INFO - PID 14720 | RSS: Main: 174186496 03:49:14 INFO - PID 14720 | 03:49:15 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51900/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:49:16 INFO - PID 14720 | RSS: Main: 174407680 03:49:16 INFO - PID 14720 | 03:49:18 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51900/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:49:19 INFO - PID 14720 | RSS: Main: 174002176 03:49:19 INFO - PID 14720 | 03:49:22 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51900/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:49:22 INFO - PID 14720 | RSS: Main: 174796800 03:49:22 INFO - PID 14720 | 03:49:26 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51900/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:49:26 INFO - PID 14720 | RSS: Main: 174690304 03:49:26 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | Cycle 1(1): loaded http://localhost:51900/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51900/tests/kraken/driver.html?testName=ai-astar) 03:49:28 INFO - PID 14720 | RSS: Main: 176222208 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | __start_tp_report 03:49:28 INFO - PID 14720 | _x_x_mozilla_page_load 03:49:28 INFO - PID 14720 | _x_x_mozilla_page_load_details 03:49:28 INFO - PID 14720 | |i|pagename|runs| 03:49:28 INFO - PID 14720 | |0;ai-astar;97;108;99;110;111;114;108;99;112;111 03:49:28 INFO - PID 14720 | |1;audio-beat-detection;145;121;149;171;118;143;147;119;179;118 03:49:28 INFO - PID 14720 | |2;audio-dft;161;161;161;162;164;172;163;166;162;164 03:49:28 INFO - PID 14720 | |3;audio-fft;81;75;77;177;78;80;74;76;165;77 03:49:28 INFO - PID 14720 | |4;audio-oscillator;79;86;134;79;79;79;129;79;79;139 03:49:28 INFO - PID 14720 | |5;imaging-gaussian-blur;114;113;117;115;123;114;114;116;113;114 03:49:28 INFO - PID 14720 | |6;imaging-darkroom;152;152;151;153;154;151;150;152;153;151 03:49:28 INFO - PID 14720 | |7;imaging-desaturate;94;95;95;93;94;94;94;93;93;93 03:49:28 INFO - PID 14720 | |8;json-parse-financial;53;61;53;53;52;58;54;59;54;54 03:49:28 INFO - PID 14720 | |9;json-stringify-tinderbox;54;54;54;54;54;55;54;64;54;61 03:49:28 INFO - PID 14720 | |10;stanford-crypto-aes;79;78;81;79;84;77;77;78;77;78 03:49:28 INFO - PID 14720 | |11;stanford-crypto-ccm;134;131;125;122;131;121;126;120;126;167 03:49:28 INFO - PID 14720 | |12;stanford-crypto-pbkdf2;181;180;182;185;179;178;176;181;186;187 03:49:28 INFO - PID 14720 | |13;stanford-crypto-sha256-iterative;78;72;70;70;68;70;71;70;73;67 03:49:28 INFO - PID 14720 | __end_tp_report 03:49:28 INFO - PID 14720 | __start_cc_report 03:49:28 INFO - PID 14720 | _x_x_mozilla_cycle_collect,1020 03:49:28 INFO - PID 14720 | __end_cc_report 03:49:28 INFO - PID 14720 | __startTimestamp1502880568835__endTimestamp 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | ------- Summary: start ------- 03:49:28 INFO - PID 14720 | Number of tests: 14 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#0] ai-astar Cycles:10 Average:106.90 Median:113.00 stddev:6.19 (5.5%) stddev-sans-first:5.43 03:49:28 INFO - PID 14720 | Values: 97.0 108.0 99.0 110.0 111.0 114.0 108.0 99.0 112.0 111.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:146.00 stddev:22.13 (15.2%) stddev-sans-first:23.42 03:49:28 INFO - PID 14720 | Values: 145.0 121.0 149.0 171.0 118.0 143.0 147.0 119.0 179.0 118.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:3.37 (2.1%) stddev-sans-first:3.44 03:49:28 INFO - PID 14720 | Values: 161.0 161.0 161.0 162.0 164.0 172.0 163.0 166.0 162.0 164.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#3] audio-fft Cycles:10 Average:96.00 Median:77.00 stddev:39.68 (51.5%) stddev-sans-first:41.72 03:49:28 INFO - PID 14720 | Values: 81.0 75.0 77.0 177.0 78.0 80.0 74.0 76.0 165.0 77.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:79.00 stddev:26.28 (33.3%) stddev-sans-first:27.13 03:49:28 INFO - PID 14720 | Values: 79.0 86.0 134.0 79.0 79.0 79.0 129.0 79.0 79.0 139.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#5] imaging-gaussian-blur Cycles:10 Average:115.30 Median:114.50 stddev:2.98 (2.6%) stddev-sans-first:3.13 03:49:28 INFO - PID 14720 | Values: 114.0 113.0 117.0 115.0 123.0 114.0 114.0 116.0 113.0 114.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:152.00 stddev:1.20 (0.8%) stddev-sans-first:1.27 03:49:28 INFO - PID 14720 | Values: 152.0 152.0 151.0 153.0 154.0 151.0 150.0 152.0 153.0 151.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 03:49:28 INFO - PID 14720 | Values: 94.0 95.0 95.0 93.0 94.0 94.0 94.0 93.0 93.0 93.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:54.00 stddev:3.07 (5.7%) stddev-sans-first:3.16 03:49:28 INFO - PID 14720 | Values: 53.0 61.0 53.0 53.0 52.0 58.0 54.0 59.0 54.0 54.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:54.00 stddev:3.61 (6.7%) stddev-sans-first:3.77 03:49:28 INFO - PID 14720 | Values: 54.0 54.0 54.0 54.0 54.0 55.0 54.0 64.0 54.0 61.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#10] stanford-crypto-aes Cycles:10 Average:78.80 Median:78.50 stddev:2.20 (2.8%) stddev-sans-first:2.33 03:49:28 INFO - PID 14720 | Values: 79.0 78.0 81.0 79.0 84.0 77.0 77.0 78.0 77.0 78.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:128.50 stddev:13.70 (10.7%) stddev-sans-first:14.46 03:49:28 INFO - PID 14720 | Values: 134.0 131.0 125.0 122.0 131.0 121.0 126.0 120.0 126.0 167.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.50 Median:181.50 stddev:3.57 (2.0%) stddev-sans-first:3.78 03:49:28 INFO - PID 14720 | Values: 181.0 180.0 182.0 185.0 179.0 178.0 176.0 181.0 186.0 187.0 03:49:28 INFO - PID 14720 | 03:49:28 INFO - PID 14720 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:70.50 stddev:3.03 (4.3%) stddev-sans-first:1.83 03:49:28 INFO - PID 14720 | Values: 78.0 72.0 70.0 70.0 68.0 70.0 71.0 70.0 73.0 67.0 03:49:28 INFO - PID 14720 | -------- Summary: end -------- 03:49:28 INFO - PID 14720 | 03:49:29 INFO - PID 14720 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 03:49:29 INFO - TEST-INFO | 14720: exit 0 03:49:29 INFO - TEST-OK | kraken | took 63165ms 03:49:29 INFO - SUITE-END | took 1174s 03:49:29 INFO - Completed test suite (00:19:35) 03:49:29 INFO - javascript benchmark 03:49:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8587.77255292807, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3083.2446050717576, 3116.8909088181913, 3146.0719087869074, 3152.9910428662824, 3153.590033295671, 6058.697065146742, 6156.692165391729, 6160.9999999999945, 6247.750089996394, 6294.842628934279, 6197.938020619792, 6216.316205217422, 6236.84407889803, 6293.496520278378, 6303.338149494306, 5594.328680558338, 5622.128570071645, 5699.373068962411, 5716.199732037498, 5719.714014299289, 5571.303587051619, 5642.915356269659, 5675.063614503622, 5692.459216374438, 5705.25831641886, 5615.2700148980775, 5646.040173170571, 5707.71461426927, 5721.713914304268, 5727.914081288784, 5471.042567550663, 5608.5793565482345, 5619.381867994517, 5693.572982026365, 5697.914531282034, 5468.28912241406, 5477.643953143033, 5483.287172667528, 5494.780208791683, 5508.91736623951, 6020.548458865559, 6073.726682299307, 6101.938980610226, 6134.17188679527, 6148.446639802394, 6629.403353698142, 6704.631245281507, 6707.463402927754, 6717.1267735194115, 6728.865422691568, 6688.264290927994, 6718.225216515966, 6719.798406047827, 6779.220389655204, 6805.421539169177, 6050.909236361458, 6137.171481849982, 6173.536984726164, 6208.906866397007, 6307.936920630781, 6667.699953502104, 6741.460683145337, 6789.966050169717, 6801.047853300542, 6814.557053791487, 6441.32366101562, 6450.387213214737, 6528.183977002875, 6534.215894092739, 6537.477001839841, 6531.412172904462, 6566.277709451956, 6628.9393697008245, 6636.900446493307, 6654.534182607171, 6403.0, 6458.54790164684, 6534.836629084216, 6570.868582628416, 6666.96666516674, 6702.329767023259, 6705.597664140069, 6712.530122891449, 6713.0937323461685, 6715.630640314829, 5413.648112872651, 5426.62013659048, 5479.726013699299, 5482.698451585121, 5490.0, 4585.656075794329, 4645.0477652081245, 4657.650676199299, 4679.134360143385, 4679.321498382716, 5673.858153546112, 5762.654240745569, 5783.884322313615, 5794.739236734357, 5836.649801011953, 6664.466842652673, 6684.331566843374, 6713.060171575983, 6716.1604799400075, 6722.697478613474, 5641.661500309994, 5808.796692115756, 5813.6221145625395, 5822.1266809978, 5822.82531524055, 5857.0, 5870.0, 5921.644701317935, 5924.466797988115, 5940.495057920039, 6304.401081897304, 6396.0725694774, 6404.7117879695525, 6465.353464653591, 6479.643619600873, 6679.732810687712, 6707.5975441473665, 6716.126903502513, 6743.460523158037, 6792.320767923168, 6463.224413070461, 6470.838229044123, 6478.6760661967655, 6525.804225873231, 6563.146790917151, 6542.741352146592, 6556.147700798866, 6621.404073633396, 6631.834204144742, 6648.700808463727, 6562.0, 6659.800205993828, 6661.866762664623, 6677.532572719863, 6781.423578995643, 6289.874202516015, 6317.810465686037, 6326.620402775849, 6423.42189202974, 6435.581687190318, 6501.902471463027, 6510.609363438209, 6512.869742605027, 6534.281229064704, 6535.2811190768025, 6376.266729326187, 6462.579932304385, 6466.4503517201565, 6467.062275970052, 6475.870482590416, 6481.870362592627, 6503.219613646393, 6543.770968016097, 6615.867682646416, 6620.205575330991, 6155.169052178077, 6206.658633775005, 6250.4687101595055, 6315.368463153648, 6361.777337793155], "value": 6060.655878826564, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [805.9032916050074, 808.9878651820223, 836.322578711244, 862.504060165405, 869.1916517638598, 41623.167536649285, 42421.3636795448, 42439.0, 42460.787696061474, 42483.57516424831, 37929.431058534145, 38054.0, 38360.42459363112, 38419.80790096053, 38633.0, 6732.057511948331, 6752.122224110859, 6820.624865632388, 6863.656817159147, 6866.553674011173, 6729.394354508093, 6798.52410331277, 6804.659767011654, 6805.421539169177, 6808.183018037842, 7533.7363192288285, 7705.845883082363, 7726.343260822809, 7727.150013498511, 7739.496932699385, 7585.431092668072, 7607.505512141693, 7616.885746713804, 7676.577788221645, 7677.155512893577, 7311.122665280147, 7460.6642701078035, 7644.197359277251, 7656.808579785495, 7689.461737678364, 40887.1822563547, 40891.7955410224, 41339.793301033606, 41341.1731765363, 41363.7931810339, 3542.8405721742324, 3550.343186510504, 3555.839987200582, 3577.4276115821604, 3589.74871758977, 32372.6762732372, 32383.514247286308, 32389.352212955844, 32437.6756232437, 32445.0, 5006.699598024094, 5025.974870125662, 5040.747962601892, 5057.216131499624, 5070.670406423571, 196395.0, 196685.0, 197529.0, 198295.0, 198674.0, 49986.25020624621, 50019.74990125099, 50275.497245027815, 50279.24581131286, 50504.494955050715, 52666.73666631642, 53034.73482632562, 53050.73474632602, 53086.73456632692, 53138.46861531412, 16761.161941902858, 17045.31818727237, 17109.315627374766, 17145.22846471912, 17184.570385740208, 14053.648658783408, 14057.297135143406, 14058.43766249359, 14100.647483812987, 14153.504627337994, 15180.316885740169, 15197.0, 15208.467703630542, 15216.174059112976, 15308.693826123637, 5836.562257830679, 5895.941040589625, 5929.466348028698, 5939.227900372924, 6165.075238714139, 993.9552720127612, 1010.0858722855827, 1019.607451131305, 1021.9489025548693, 1022.9488525573692, 23282.65076023861, 23386.883065584905, 23480.64779028316, 23502.64746028811, 23666.0, 1116.0848104554188, 1117.2067831839486, 1120.7534342444649, 1128.5598616539555, 1136.4204255829586, 12202.572909948109, 12284.631461056182, 12322.445489952974, 12343.753124937452, 12556.246625202517, 239106.0, 240754.0, 240802.0, 241150.0, 243116.0, 55038.724806375714, 55264.723676382164, 56002.71998639981, 59258.70370648119, 59273.0, 1467.7431449496296, 1471.5217554294898, 1491.4183468447313, 1493.37278343094, 1498.4980031689506, 26939.191824245303, 27097.864510677322, 27330.863345683938, 27571.31071723223, 27713.86143069272, 38335.23329533338, 38645.0, 38764.2247155061, 38802.80598596989, 38883.0, 199368.0, 199890.0, 200035.0, 200143.0, 200208.0, 33595.32809343848, 33660.0, 33773.493397599545, 33915.32169356648, 33970.0, 41862.0, 43082.353764692925, 43603.90990225143, 43717.78141109274, 43790.0, 32217.076238197402, 32734.50898236481, 33243.50134747932, 33294.0, 33531.66468335286, 32136.517952230268, 32441.351172975938, 32753.836230818695, 33047.33905321928, 33257.50113748344, 34522.65477345194, 34975.475367868996, 35305.0, 35543.119457901375, 35808.28383432369, 31522.527162093047, 32003.83998079995, 32214.19464513406, 32441.188970274987, 32733.836330819147, 22899.31302060941, 23476.53046939086, 23844.0, 23845.0, 23847.642285365386], "value": 17400.186871492762, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.1688809670028, 576.2767726503238, 581.9447152520512, 583.6235628019928, 591.2815928646694, 21170.89414552927, 22049.448763780892, 22135.225267115675, 22145.557088858255, 22413.32760017198, 26605.600915986226, 26849.463010739775, 27134.18597442075, 27134.728652713467, 27151.592726109076, 6414.839629009265, 6581.210254769434, 6582.440492558138, 6586.5718728282745, 6587.143671322721, 5954.106883967396, 6460.612363258219, 6461.19235095613, 6476.805695829133, 6481.935180648204, 6428.421442070213, 6429.32492088331, 6439.678016099199, 6440.3237660045725, 6443.516736244777, 6422.421982021617, 6423.518236132262, 6424.5502814802985, 6424.550281480321, 6432.324605916405, 5882.499987501067, 5979.730912108922, 5979.880402391927, 5987.161797348374, 6008.158857759917, 28548.571771423445, 29210.70789292101, 29599.260018499495, 30086.0, 30102.54846177309, 1868.4207895552422, 1908.1699460734626, 1909.980900191008, 1910.9713354299697, 1911.9617607647908, 19272.807271927242, 19536.902315488333, 19690.31083912056, 19779.802201978084, 19836.30572929955, 2384.7376788553247, 2400.291913885408, 2431.3556907419547, 2432.0758111917535, 2490.638857365672, 143936.0, 147352.99999999892, 147846.0, 147914.0, 148173.0, 14918.925405372904, 15512.379504819906, 15575.454859079879, 15584.610384740472, 15968.920155399148, 23761.16835910735, 23775.405614859767, 23819.880900595384, 23833.40416489567, 24088.75911240865, 10189.235807314333, 10419.166466682647, 10581.41802200871, 10584.841227381596, 10692.839607405895, 7916.208379162153, 9774.853377199348, 9778.511074446249, 9785.706428807147, 9920.950395248123, 8141.0, 9533.427994320224, 9778.706638800848, 9779.897322075787, 9794.559244834, 2737.7536021758137, 2760.2259728972253, 2765.419261955012, 2792.3577577157366, 2871.4687782760257, 957.8802649668792, 972.4214092614883, 977.4282045003753, 989.218517371283, 999.7200783780553, 19835.504112397306, 20000.799991999895, 20056.799432005784, 20078.37805414486, 20125.0, 1037.5590374090982, 1040.9011143941314, 1041.833306670929, 1044.2637940252105, 1047.7904419116055, 10816.134709223243, 11153.38656373891, 11355.37545435009, 13635.590932272047, 14109.153450792985, 466862.0, 541767.0, 545506.0, 553819.0, 557095.0, 128923.35538322249, 130599.34700326438, 130613.0, 131851.0, 131905.34047329702, 1252.931088790107, 1319.182107093608, 1340.3566288181728, 1344.8991325650616, 1357.9796303055462, 20896.537242392886, 21528.0, 21864.45338866541, 22115.66826497636, 22300.888495557418, 60855.69572152111, 61525.69237153786, 62513.687431562554, 63227.6838615804, 63392.68303658452, 75994.0, 77071.2292877064, 77226.6138669303, 77863.0, 78923.21076789159, 16417.17914104266, 17228.655426891644, 20308.898455507628, 20823.687644685644, 21365.0, 23908.163214288114, 24177.63733543963, 24179.0, 24222.152224672052, 24562.631560526963, 18855.528611784815, 18967.810321896606, 18987.810121898605, 19010.1445434953, 19055.14251858642, 16815.41146059882, 17219.397321094202, 17350.21924013397, 17622.29510819553, 17837.375691850724, 18834.905825470785, 19044.333448329242, 19071.90464047671, 19085.427437176906, 19206.61586768285, 20552.17791288332, 20573.691394629393, 20613.03254401048, 20732.170713171305, 20771.896140519202, 18711.812881871007, 18736.906315468335, 18813.153408096943, 18896.338628147947, 18954.715679265097], "value": 12562.913561936826, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1358.9184648921066, 1396.4204854985182, 1425.5723283015093, 1428.3286855178062, 1430.2705620133736, 14074.718505629895, 14603.415863365466, 14664.340104695288, 14668.193249371307, 14723.337449814771, 13937.581872543815, 14341.78487322691, 15059.096454212755, 15073.924630376832, 15105.924470377633, 2709.9593506097426, 2755.655543057118, 2756.8897244110212, 2759.1446651537985, 2759.986200068997, 2484.900603975848, 2610.216934919526, 2641.3000554852883, 2686.6775986881603, 2691.286808995618, 2705.8105932584726, 2732.945341093177, 2735.6990731019573, 2736.315921019745, 2740.260129764962, 2651.549236629768, 2667.9066232681957, 2669.4394177222807, 2670.305720512661, 2679.062328185139, 2584.470183612355, 2630.7500787425165, 2639.762421382085, 2645.2196602002455, 2649.894004239828, 14154.43382264708, 14283.714325713532, 14285.142891426547, 14286.142831430148, 14305.713885722227, 6996.160460744743, 7292.16140143885, 7303.050603421574, 7319.34125928669, 7325.7802265932105, 4833.154198015333, 4873.220284754422, 4943.604511639096, 4992.87517812054, 5006.849794506171, 1886.9150888210063, 1897.108359071248, 1903.6192761447628, 1927.6048410076041, 1931.951701207467, 23208.883955580284, 23446.296611101694, 23480.178193763306, 23489.0, 23501.88249058761, 6235.469985051231, 6343.732977516583, 6548.017797330439, 6598.37315455031, 6666.766663166863, 16367.345306187857, 16384.590385240463, 16392.098434586213, 16393.18034098314, 16396.672066558604, 7078.398336141486, 7224.747133850396, 7239.457040721967, 7308.780736577911, 7309.415246780245, 6311.179546658905, 6705.1283333166375, 6724.831879202961, 6733.427658648971, 6739.764108256188, 5170.638055336166, 5247.344081989751, 5279.498447647467, 5303.496167864047, 5404.081306177959, 1302.3423171298434, 1384.1003347823794, 1458.3874772595536, 1460.9196494192709, 1481.4222453243244, 860.2945584620676, 888.7822483491457, 903.3811838890381, 914.9313801464916, 925.8287216864901, 8929.873814828476, 8986.415882967716, 9118.179363857285, 9126.771830704152, 9127.817443651222, 996.3722854601555, 1010.7220514358463, 1013.9188864890791, 1020.5560581147076, 1021.3616489693941, 5252.448492908266, 5367.973160134175, 5437.32033495813, 5450.91823622646, 5506.559475242051, 18790.154443050094, 19365.709514357295, 19621.901890490455, 19622.0, 19864.304749333704, 19696.803031969783, 20069.0, 20186.293479728138, 20438.69341959872, 20468.79531204669, 10601.416922069206, 10647.828738838722, 10977.28647637917, 11304.660860174208, 11328.2070255083, 7790.220977902164, 7862.174471680391, 8039.356851451987, 8203.343732501506, 8309.83380332378, 17324.220410081827, 17457.30170793154, 17600.29598816033, 17608.38370657021, 17823.376181834094, 17452.214650340513, 17653.969793473916, 17730.556736081184, 18123.54691132732, 18475.076246187367, 11426.143039272254, 11768.646940591796, 11780.705482362666, 11782.11634127461, 11808.763824723286, 13224.346956630421, 13395.665108372368, 13456.0, 13467.595972120853, 13520.729585408433, 10869.456527173768, 10989.0, 11108.555657773923, 11250.7749845001, 11379.943100284776, 10486.47567621631, 10701.19741019411, 10843.512041958289, 10901.400422976496, 11006.614768483385, 9689.0, 9694.079062489052, 9853.802923941337, 9862.211023118276, 9869.407835529892, 7032.789016329519, 7060.0, 7088.574685518885, 7090.373075138791, 7224.024756657994, 7597.430192735456, 7615.504992175491, 7724.0, 7754.302112809874, 7765.61171941412], "value": 6493.141518598379, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [492.95001646492966, 504.94193167785716, 510.5354127743753, 511.94624564420735, 525.5454032262095, 6260.812175634733, 6324.367563243679, 6328.59513384913, 6394.232692076951, 6463.806085817421, 6158.846028849281, 6162.815115546541, 6193.380661933805, 6235.657038862861, 6252.3122456529745, 4858.659893807435, 4971.353724015873, 5052.722100284483, 5064.164412871872, 5090.541851233388, 4955.578775804043, 4991.875203119915, 5018.272350509174, 5020.7740651670765, 5040.521150490716, 4995.750212489361, 5008.2738002989545, 5010.774515146809, 5034.09386310464, 5050.116229659813, 4979.0, 4994.800207991658, 5021.096202683516, 5038.949610503884, 5039.622028347889, 4513.842015529473, 4517.018767613359, 4536.795844186987, 4540.636749060067, 4544.386507821468, 6046.486048685867, 6111.113888486189, 6174.84562885927, 6180.258368995749, 6198.876022479525, 5753.913691294634, 5758.740856661419, 5773.653580785166, 5783.681897495636, 5787.13193021046, 6681.298463661343, 6686.899696504556, 6699.665016749192, 6700.396964273239, 6717.899231511531, 4923.8276660316715, 4924.827631032933, 4940.2342636891335, 4942.061008408391, 4956.925646115311, 6739.427148692367, 6808.0, 6928.54500554879, 6991.23096459389, 7057.400120989722, 5030.421501527371, 5067.974660126676, 5075.543201111917, 5076.923846142311, 5089.295086146182, 5110.872228194325, 5168.3797944246935, 5177.326947496801, 5187.533122018961, 5190.351206099238, 5657.850016993599, 5706.258186435737, 5736.225609542742, 5795.652260864362, 5797.652140871562, 6598.241202261705, 6634.175601709569, 6643.30245324234, 6651.966740166365, 6734.56225345351, 1792.8386445219992, 1807.1416077363147, 1808.7286906964061, 1811.791643960935, 1813.6826055440245, 1161.529580519874, 1210.6368089573093, 1234.962951111468, 1239.6652903715947, 1245.8380410546752, 5831.504322132581, 5852.502537284294, 5859.326177489644, 5914.378990206053, 5916.408359164136, 6587.011948207807, 6690.698918548677, 6781.796546103625, 6840.589564626139, 6874.518783685194, 5742.397048309867, 5843.824685259449, 5854.882902342015, 5871.500922421642, 5887.793927212527, 3631.455281707765, 3634.036980200249, 3640.1445660269815, 3665.9816700916326, 3697.3379166999716, 6524.706388212542, 6552.180977377828, 6674.299198584175, 6695.631740254333, 6699.11937866722, 6840.418564421981, 6953.235144134142, 7009.61447120403, 7029.29707029293, 7049.9647501762165, 6544.70548825304, 6655.73377064912, 6682.5322227444585, 6686.297938716365, 6728.831779205461, 6355.809325720235, 6859.725610975505, 6876.793696189123, 6889.448844092361, 6903.654817259016, 6767.864642707217, 6785.219699734594, 6787.219469760843, 6790.0, 6795.218549866829, 6688.0, 6693.966530167513, 6723.193216814014, 6723.2604413515455, 6756.223034351113, 5067.947481270092, 5075.5178258065425, 5084.567811735896, 5091.770870310771, 5098.1588037973315, 6655.401013908771, 6806.693698783468, 6812.965935170292, 6876.621785801629, 6928.060143159923, 6439.356064393523, 6526.412622863965, 6537.8692426152165, 6542.803715888531, 6583.670816459062, 6470.0, 6475.255345635313, 6556.623109147133, 6612.305707900601, 6663.0, 6439.388258115471, 6487.767324208386, 6504.772332968323, 6535.869282614226, 6613.570117942319, 6660.167479065117, 6694.59832410057, 6703.463722902254, 6708.530402871947, 6720.6975686093265, 6430.260520040255, 6447.0, 6472.576033272672, 6520.152380190545, 6557.508186886098], "value": 5121.7520501566305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [894.3515950935569, 921.0191146429057, 921.3918813583034, 925.495604895332, 937.3157594955683, 17969.55076123096, 18621.627567448642, 18727.0, 18739.531511712215, 21914.89042554785, 21710.457238569044, 22229.77770222297, 22299.777002229974, 22344.776552234514, 22355.888220558914, 1028.115820394462, 1054.1988089052338, 1059.5496913811598, 1062.909652679523, 1063.457636605333, 1009.2892547132614, 1061.257120015988, 1067.9199060070525, 1070.3417398300028, 1070.3577853288004, 1105.171121658756, 1118.546988469667, 1121.0023079459288, 1122.2705241592948, 1123.2474242257706, 1108.1245815805503, 1111.2332490581555, 1111.6109361723413, 1112.288135593217, 1113.9443027848615, 812.8943237379162, 813.3818298093432, 813.5525460996488, 813.7233340664144, 814.1492140712969, 19890.70163947542, 20109.0, 20275.695864562043, 20349.593008139753, 20604.0, 21248.787512124836, 21713.240036598643, 21797.455063623376, 21860.672089918666, 22219.333419997427, 16925.0, 16928.83071169297, 17081.316747330093, 17139.0, 17245.741313880302, 3657.945130823013, 3662.029562166028, 3690.409534474471, 3695.5195824542907, 3695.7782533048103, 130272.0, 130540.0, 132281.3385933074, 133060.0, 135469.3226533871, 17016.404425845038, 17134.57163570896, 17595.73606395905, 17597.0, 17629.823701763074, 30548.84725576358, 31088.84455577753, 31651.20871978173, 31854.362912741617, 31942.680573194437, 7601.505902116345, 7935.166807485131, 8457.661693532313, 8504.489730616182, 8674.436161649473, 4453.1761624099645, 4501.324801279834, 4505.279155335131, 4510.774461276923, 4517.638588912879, 5194.220866869924, 5251.632385733038, 5334.973325133427, 5343.572514198855, 5354.625176237626, 998.9500524973722, 999.4153420249236, 1021.3616489693941, 1022.1873610479687, 1022.4427686910651, 682.4301708073814, 698.8532408194336, 703.4969996452561, 707.3209718670134, 711.0081436396301, 11790.94104529472, 12610.621681349574, 12859.742805143846, 12861.871381286255, 13043.804342934864, 679.0832376291967, 683.5386114372778, 683.6513378177166, 687.3264201082967, 689.5586824432368, 5923.7926672566255, 6162.198914141133, 6173.228346456693, 6173.660448675366, 6232.657203853832, 119198.0, 119526.0, 119568.0, 121532.39233803951, 126168.7383126157, 100081.49959250157, 101755.4912225449, 104045.0, 104569.47715261375, 106522.0, 88158.0, 89713.0, 91011.0, 92136.07863921409, 92668.53665731628, 11081.556737730723, 11087.959145942223, 11141.786924144415, 11159.609413670483, 11276.94361528187, 40441.0, 40666.0, 41351.1729765409, 42238.57761422469, 42959.355609665254, 52362.73818630882, 53289.73355133199, 53579.73210133924, 54223.72888135692, 55779.44220557905, 16484.83515164881, 16623.667526649642, 16644.334226631283, 16683.49949501517, 16694.58263543421, 16691.83308166903, 16894.155292235584, 16920.15399230009, 16934.40729574459, 17014.829851701325, 16866.072366019496, 17055.147242638068, 17163.65672686514, 17182.22679979429, 17231.483055508354, 15889.364425422853, 15909.840901590836, 15913.761293580837, 15921.840781592498, 16088.597785054999, 16295.67408651844, 16349.427770027993, 16395.42616008434, 16404.507864764077, 16419.343226270816, 11325.943370283425, 11396.316221026766, 11747.412629368326, 11766.352850593299, 11858.288502689866, 11816.291022538675, 11829.645110646694, 11882.346470944181, 12123.0, 15127.243637818285], "value": 9103.716741286895, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 108.0, 99.0, 110.0, 111.0, 114.0, 108.0, 99.0, 112.0, 111.0], "value": 106.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 121.0, 149.0, 171.0, 118.0, 143.0, 147.0, 119.0, 179.0, 118.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 162.0, 164.0, 172.0, 163.0, 166.0, 162.0, 164.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 75.0, 77.0, 177.0, 78.0, 80.0, 74.0, 76.0, 165.0, 77.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 86.0, 134.0, 79.0, 79.0, 79.0, 129.0, 79.0, 79.0, 139.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 117.0, 115.0, 123.0, 114.0, 114.0, 116.0, 113.0, 114.0], "value": 115.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 151.0, 153.0, 154.0, 151.0, 150.0, 152.0, 153.0, 151.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 93.0, 94.0, 94.0, 94.0, 93.0, 93.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 61.0, 53.0, 53.0, 52.0, 58.0, 54.0, 59.0, 54.0, 54.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 64.0, 54.0, 61.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 81.0, 79.0, 84.0, 77.0, 77.0, 78.0, 77.0, 78.0], "value": 78.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 131.0, 125.0, 122.0, 131.0, 121.0, 126.0, 120.0, 126.0, 167.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 180.0, 182.0, 185.0, 179.0, 178.0, 176.0, 181.0, 186.0, 187.0], "value": 181.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 72.0, 70.0, 70.0, 68.0, 70.0, 71.0, 70.0, 73.0, 67.0], "value": 70.9, "unit": "score"}]}]} 03:49:30 INFO - Return code: 0 03:49:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:49:30 INFO - # TBPL SUCCESS # 03:49:30 INFO - Running post-action listener: _package_coverage_data 03:49:30 INFO - Running post-action listener: _resource_record_post_action 03:49:30 INFO - [mozharness: 2017-08-16 10:49:30.095037Z] Finished run-tests step (success) 03:49:30 INFO - Running post-run listener: _resource_record_post_run 03:49:30 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 438272; Write bytes: 444362752; Read time: 344; Write time: 276072 03:49:30 INFO - TinderboxPrint: CPU usage
13.1% 03:49:30 INFO - TinderboxPrint: I/O read bytes / time
438,272 / 344 03:49:30 INFO - TinderboxPrint: I/O write bytes / time
444,362,752 / 276,072 03:49:30 INFO - TinderboxPrint: CPU idle
8,267.8 (86.8%) 03:49:30 INFO - TinderboxPrint: CPU user
1,200.9 (12.6%) 03:49:30 INFO - TinderboxPrint: Swap in / out
0 / 0 03:49:30 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 49152; Write bytes: 120098816; Read time: 176; Write time: 87600 03:49:30 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 03:49:30 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 385024; Write bytes: 324263936; Read time: 152; Write time: 188472 03:49:30 INFO - Running post-run listener: _upload_blobber_files 03:49:30 INFO - Blob upload gear active. 03:49:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:49:30 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:49:30 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:49:30 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:49:31 INFO - (blobuploader) - INFO - Open directory for files ... 03:49:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:49:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:49:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:31 INFO - (blobuploader) - INFO - Done attempting. 03:49:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:49:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:49:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:32 INFO - (blobuploader) - INFO - Done attempting. 03:49:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:49:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:49:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:33 INFO - (blobuploader) - INFO - Done attempting. 03:49:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:49:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:49:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:49:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:49:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:49:40 INFO - (blobuploader) - INFO - Done attempting. 03:49:40 INFO - (blobuploader) - INFO - Iteration through files over. 03:49:40 INFO - Return code: 0 03:49:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:49:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:49:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a5ca1d2cf7e9d6ab72032d5807bb8d2a04fa0761f1a6e252de47619263b0dbcdaf030b2b6aab562a4385408f7d5fb036653f960a130adf9ee688dd0aabfe0a9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab346ad8cc57c46df245e7029e0fcfbb72809fb13b0144c73c2b751290eb6e82d0ff4b560a4c9ac422bf0da6216ffb1e416942d044b4be49e09d02d6f3e91d02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd04eaf19658a4361ae62dfcd058284d0569bc2afa0a73946fb0a65fad802c15c92af41068c10f673ba67595bbe5231e8e5d3a945cdf024cb09b74040e2a706f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86eff88e0c8ad6e75761254e04f170806fecc763e3c162702932bf928866b73b57e39dbbe1ae95fddf207af437eb86d2b7645ec7a35c81a90f4ef88e49784bfe"} 03:49:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:49:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:49:40 INFO - Contents: 03:49:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a5ca1d2cf7e9d6ab72032d5807bb8d2a04fa0761f1a6e252de47619263b0dbcdaf030b2b6aab562a4385408f7d5fb036653f960a130adf9ee688dd0aabfe0a9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab346ad8cc57c46df245e7029e0fcfbb72809fb13b0144c73c2b751290eb6e82d0ff4b560a4c9ac422bf0da6216ffb1e416942d044b4be49e09d02d6f3e91d02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd04eaf19658a4361ae62dfcd058284d0569bc2afa0a73946fb0a65fad802c15c92af41068c10f673ba67595bbe5231e8e5d3a945cdf024cb09b74040e2a706f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86eff88e0c8ad6e75761254e04f170806fecc763e3c162702932bf928866b73b57e39dbbe1ae95fddf207af437eb86d2b7645ec7a35c81a90f4ef88e49784bfe"} 03:49:40 INFO - Running post-run listener: copy_logs_to_upload_dir 03:49:40 INFO - Copying logs to upload dir... 03:49:40 INFO - mkdir: /builds/slave/test/build/upload/logs 03:49:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.306851 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-08-16 03:49:40.518766) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:49:40.522983) ========= 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=2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a5ca1d2cf7e9d6ab72032d5807bb8d2a04fa0761f1a6e252de47619263b0dbcdaf030b2b6aab562a4385408f7d5fb036653f960a130adf9ee688dd0aabfe0a9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab346ad8cc57c46df245e7029e0fcfbb72809fb13b0144c73c2b751290eb6e82d0ff4b560a4c9ac422bf0da6216ffb1e416942d044b4be49e09d02d6f3e91d02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd04eaf19658a4361ae62dfcd058284d0569bc2afa0a73946fb0a65fad802c15c92af41068c10f673ba67595bbe5231e8e5d3a945cdf024cb09b74040e2a706f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86eff88e0c8ad6e75761254e04f170806fecc763e3c162702932bf928866b73b57e39dbbe1ae95fddf207af437eb86d2b7645ec7a35c81a90f4ef88e49784bfe"} build_url:https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011515 build_url: 'https://queue.taskcluster.net/v1/task/Ik1VZCnkRAKLMf_kMSI2Ig/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a5ca1d2cf7e9d6ab72032d5807bb8d2a04fa0761f1a6e252de47619263b0dbcdaf030b2b6aab562a4385408f7d5fb036653f960a130adf9ee688dd0aabfe0a9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab346ad8cc57c46df245e7029e0fcfbb72809fb13b0144c73c2b751290eb6e82d0ff4b560a4c9ac422bf0da6216ffb1e416942d044b4be49e09d02d6f3e91d02", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fd04eaf19658a4361ae62dfcd058284d0569bc2afa0a73946fb0a65fad802c15c92af41068c10f673ba67595bbe5231e8e5d3a945cdf024cb09b74040e2a706f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/86eff88e0c8ad6e75761254e04f170806fecc763e3c162702932bf928866b73b57e39dbbe1ae95fddf207af437eb86d2b7645ec7a35c81a90f4ef88e49784bfe"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-16 03:49:40.549607) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:49:40.549901) ========= 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=2432103b8b3de4003b23cad4000001c2-1502879323.253455-1478861601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-16 03:49:40.632360) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:49:40.635683) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-16 03:49:40.635967) ========= ========= Total master_lag: 0.26 =========